builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1499960768.17 results: success (0) revision: d4e6f45db73333f693ac0cf53cab1f8ab4798373 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-13 08:46:08.175161) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-13 08:46:08.175616) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-13 08:46:08.175913) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-13 08:46:08.231495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-13 08:46:08.231781) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-13 08:46:08-- 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% 109M=0s 2017-07-13 08:46:08 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-13 08:46:08.404551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-13 08:46:08.404886) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013849 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-13 08:46:08.465603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-13 08:46:08.466094) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d4e6f45db73333f693ac0cf53cab1f8ab4798373 --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 d4e6f45db73333f693ac0cf53cab1f8ab4798373 --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=5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-13 08:46:08,897 truncating revision to first 12 chars 2017-07-13 08:46:08,897 Setting DEBUG logging. 2017-07-13 08:46:08,897 attempt 1/10 2017-07-13 08:46:08,898 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d4e6f45db733?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-13 08:46:09,604 unpacking tar archive at: mozilla-central-d4e6f45db733/testing/mozharness/ program finished with exit code 0 elapsedTime=1.071444 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-13 08:46:09.550996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-13 08:46:09.551341) ========= script_repo_revision: d4e6f45db73333f693ac0cf53cab1f8ab4798373 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-13 08:46:09.551751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-13 08:46:09.552024) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-13 08:46:09.564191) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-07-13 08:46:09.564578) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:46:10 INFO - MultiFileLogger online at 20170713 08:46:10 in /builds/slave/test 08:46:10 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 08:46:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:46:10 INFO - {'append_to_log': False, 08:46:10 INFO - 'base_work_dir': '/builds/slave/test', 08:46:10 INFO - 'blob_upload_branch': 'Firefox', 08:46:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:46:10 INFO - 'branch': 'Firefox', 08:46:10 INFO - 'buildbot_json_path': 'buildprops.json', 08:46:10 INFO - 'code_coverage': False, 08:46:10 INFO - 'config_files': ('talos/linux_config.py',), 08:46:10 INFO - 'default_actions': ('clobber', 08:46:10 INFO - 'read-buildbot-config', 08:46:10 INFO - 'download-and-extract', 08:46:10 INFO - 'populate-webroot', 08:46:10 INFO - 'create-virtualenv', 08:46:10 INFO - 'install', 08:46:10 INFO - 'setup-mitmproxy', 08:46:10 INFO - 'run-tests'), 08:46:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:46:10 INFO - 'disable_ccov_upload': False, 08:46:10 INFO - 'download_minidump_stackwalk': True, 08:46:10 INFO - 'download_symbols': 'ondemand', 08:46:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:46:10 INFO - 'tooltool.py': '/tools/tooltool.py', 08:46:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:46:10 INFO - '/tools/misc-python/virtualenv.py')}, 08:46:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:46:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:46:10 INFO - 'gecko_profile': False, 08:46:10 INFO - 'gecko_profile_interval': 0, 08:46:10 INFO - 'installer_path': 'installer.exe', 08:46:10 INFO - 'log_level': 'info', 08:46:10 INFO - 'log_name': 'talos', 08:46:10 INFO - 'log_to_console': True, 08:46:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:46:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:46:10 INFO - 'opt_config_files': (), 08:46:10 INFO - 'pip_index': False, 08:46:10 INFO - 'suite': 'dromaeojs-e10s', 08:46:10 INFO - 'system_bits': '32', 08:46:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:46:10 INFO - 'title': 'talos-linux64-ix-051', 08:46:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:46:10 INFO - 'use_talos_json': True, 08:46:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:46:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:46:10 INFO - 'work_dir': 'build'} 08:46:10 INFO - [mozharness: 2017-07-13 15:46:10.101613Z] Running clobber step. 08:46:10 INFO - Running pre-action listener: _resource_record_pre_action 08:46:10 INFO - Running main action method: clobber 08:46:10 INFO - rmtree: /builds/slave/test/build 08:46:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:46:11 INFO - Running post-action listener: _resource_record_post_action 08:46:11 INFO - [mozharness: 2017-07-13 15:46:11.648806Z] Finished clobber step (success) 08:46:11 INFO - [mozharness: 2017-07-13 15:46:11.648908Z] Running read-buildbot-config step. 08:46:11 INFO - Running pre-action listener: _resource_record_pre_action 08:46:11 INFO - Running main action method: read_buildbot_config 08:46:11 INFO - Using buildbot properties: 08:46:11 INFO - { 08:46:11 INFO - "project": "", 08:46:11 INFO - "product": "firefox", 08:46:11 INFO - "who": "cbook@mozilla.com", 08:46:11 INFO - "installer_path": "public/build/target.tar.bz2", 08:46:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:46:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:46:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 08:46:11 INFO - "stage_platform": "linux64-pgo", 08:46:11 INFO - "basedir": "/builds/slave/test", 08:46:11 INFO - "buildnumber": 63, 08:46:11 INFO - "platform": "ubuntu64_hw", 08:46:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:46:11 INFO - "slavebuilddir": "test", 08:46:11 INFO - "taskId": "fly2fXRFQhak3hFLpxjPkA", 08:46:11 INFO - "branch": "mozilla-central", 08:46:11 INFO - "script_repo_revision": "production", 08:46:11 INFO - "revision": "d4e6f45db73333f693ac0cf53cab1f8ab4798373", 08:46:11 INFO - "slavename": "talos-linux64-ix-051", 08:46:11 INFO - "repo_path": "mozilla-central" 08:46:11 INFO - } 08:46:11 INFO - Finding installer, test and symbols from parent task. 08:46:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fly2fXRFQhak3hFLpxjPkA'}, attempt #1 08:46:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fly2fXRFQhak3hFLpxjPkA'}, attempt #1 08:46:12 INFO - Task dependencies: BZBrh4qkTlqR0eH5lzVl3g 08:46:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g'}, attempt #1 08:46:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.tar.bz2 08:46:12 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/test_packages.json 08:46:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.crashreporter-symbols.zip 08:46:12 INFO - Running post-action listener: _resource_record_post_action 08:46:12 INFO - [mozharness: 2017-07-13 15:46:12.989512Z] Finished read-buildbot-config step (success) 08:46:12 INFO - [mozharness: 2017-07-13 15:46:12.989733Z] Running download-and-extract step. 08:46:12 INFO - Running pre-action listener: _resource_record_pre_action 08:46:12 INFO - Running main action method: download_and_extract 08:46:12 INFO - mkdir: /builds/slave/test/build/tests 08:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:12 INFO - trying https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.test_packages.json 08:46:12 INFO - Downloading https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:46:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:46:13 INFO - Downloaded 989 bytes. 08:46:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:46:13 INFO - Using the following test package requirements: 08:46:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:46:13 INFO - u'common': [u'target.common.tests.zip'], 08:46:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:46:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:46:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:46:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:46:13 INFO - u'mozbase': [u'target.common.tests.zip'], 08:46:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:46:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:46:13 INFO - u'web-platform': [u'target.common.tests.zip', 08:46:13 INFO - u'target.web-platform.tests.tar.gz'], 08:46:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:46:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:46:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.common.tests.zip 08:46:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:46:13 INFO - Fetch https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.common.tests.zip into memory 08:46:16 INFO - Content-Length response header: 68020337 08:46:16 INFO - Bytes received: 68020337 08:46:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:46:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.common.tests.zip 08:46:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:46:27 INFO - Fetch https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.common.tests.zip into memory 08:46:29 INFO - Content-Length response header: 68020337 08:46:29 INFO - Bytes received: 68020337 08:46:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.talos.tests.zip 08:46:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:46:41 INFO - Fetch https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.talos.tests.zip into memory 08:46:42 INFO - Content-Length response header: 14474433 08:46:42 INFO - Bytes received: 14474433 08:46: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')]} 08:46:42 INFO - trying https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.tar.bz2 08:46:42 INFO - Downloading https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:46:45 INFO - Downloaded 63013280 bytes. 08:46:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.tar.bz2 08:46:45 INFO - mkdir: /builds/slave/test/properties 08:46:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:45 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:45 INFO - Contents: 08:46:45 INFO - build_url:https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.tar.bz2 08:46:45 INFO - Running post-action listener: _resource_record_post_action 08:46:45 INFO - Running post-action listener: set_extra_try_arguments 08:46:45 INFO - [mozharness: 2017-07-13 15:46:45.212310Z] Finished download-and-extract step (success) 08:46:45 INFO - [mozharness: 2017-07-13 15:46:45.212408Z] Running populate-webroot step. 08:46:45 INFO - Running pre-action listener: _resource_record_pre_action 08:46:45 INFO - Running main action method: populate_webroot 08:46:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:46:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:46:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:46:45 INFO - '--tppagecycles', 08:46:45 INFO - '7'], 08:46:45 INFO - 'tests': ['tsvgm']}}, 08:46:45 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:46:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:46:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:46:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:46:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:46:45 INFO - 'talos_options': ['--disable-e10s'], 08:46:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:46:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:46:45 INFO - 'talos_options': ['--disable-e10s'], 08:46:45 INFO - 'tests': ['damp', 'tps']}, 08:46:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:46:45 INFO - 'tests': ['damp', 'tps']}, 08:46:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:46:45 INFO - 'tests': ['dromaeo_dom']}, 08:46:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:46:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:46:45 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:46:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:46:45 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:46:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:46:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:46:45 INFO - 'tests': ['a11yr', 08:46:45 INFO - 'ts_paint', 08:46:45 INFO - 'tpaint', 08:46:45 INFO - 'sessionrestore', 08:46:45 INFO - 'sessionrestore_no_auto_restore', 08:46:45 INFO - 'tabpaint']}, 08:46:45 INFO - 'other-e10s': {'tests': ['a11yr', 08:46:45 INFO - 'ts_paint', 08:46:45 INFO - 'tpaint', 08:46:45 INFO - 'sessionrestore', 08:46:45 INFO - 'sessionrestore_many_windows', 08:46:45 INFO - 'sessionrestore_no_auto_restore', 08:46:45 INFO - 'tabpaint']}, 08:46:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:46:45 INFO - 'ts_paint', 08:46:45 INFO - 'tpaint', 08:46:45 INFO - 'sessionrestore', 08:46:45 INFO - 'sessionrestore_many_windows', 08:46:45 INFO - 'sessionrestore_no_auto_restore', 08:46:45 INFO - 'tabpaint']}, 08:46:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:46:45 INFO - 'ts_paint', 08:46:45 INFO - 'tpaint', 08:46:45 INFO - 'sessionrestore', 08:46:45 INFO - 'sessionrestore_many_windows', 08:46:45 INFO - 'sessionrestore_no_auto_restore', 08:46:45 INFO - 'tabpaint']}, 08:46:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:46:45 INFO - 'tests': ['a11yr', 08:46:45 INFO - 'ts_paint', 08:46:45 INFO - 'tpaint', 08:46:45 INFO - 'sessionrestore', 08:46:45 INFO - 'sessionrestore_no_auto_restore', 08:46:45 INFO - 'tabpaint']}, 08:46:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:46:45 INFO - 'tests': ['a11yr', 08:46:45 INFO - 'ts_paint', 08:46:45 INFO - 'tpaint', 08:46:45 INFO - 'sessionrestore', 08:46:45 INFO - 'sessionrestore_no_auto_restore', 08:46:45 INFO - 'tabpaint']}, 08:46:45 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 08:46:45 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:46:45 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:46:45 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:46:45 INFO - 'talos_options': ['--mitmproxy', 08:46:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:46:45 INFO - '--firstNonBlankPaint'], 08:46:45 INFO - 'tests': ['quantum_pageload_google', 08:46:45 INFO - 'quantum_pageload_youtube', 08:46:45 INFO - 'quantum_pageload_amazon', 08:46:45 INFO - 'quantum_pageload_facebook']}, 08:46:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:46:45 INFO - 'tests': ['tsvgx', 08:46:45 INFO - 'tsvgr_opacity', 08:46:45 INFO - 'tart', 08:46:45 INFO - 'tscrollx', 08:46:45 INFO - 'cart', 08:46:45 INFO - 'tsvg_static']}, 08:46:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:46:45 INFO - 'tsvgr_opacity', 08:46:45 INFO - 'tart', 08:46:45 INFO - 'tscrollx', 08:46:45 INFO - 'cart', 08:46:45 INFO - 'tsvg_static']}, 08:46:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:46:45 INFO - 'talos_options': ['--disable-e10s'], 08:46:45 INFO - 'tests': ['tp5o']}, 08:46:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:46:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:46:45 INFO - 'talos_options': ['--disable-e10s', 08:46:45 INFO - '--xperf_path', 08:46:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:45 INFO - 'tests': ['tp5n']}, 08:46:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:46:45 INFO - 'talos_options': ['--xperf_path', 08:46:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:45 INFO - 'tests': ['tp5n']}}, 08:46:45 INFO - 'talos.zip': {'path': '', 08:46:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:46:45 INFO - Running post-action listener: _resource_record_post_action 08:46:45 INFO - [mozharness: 2017-07-13 15:46:45.227687Z] Finished populate-webroot step (success) 08:46:45 INFO - [mozharness: 2017-07-13 15:46:45.227777Z] Running create-virtualenv step. 08:46:45 INFO - Running pre-action listener: _resource_record_pre_action 08:46:45 INFO - Running main action method: create_virtualenv 08:46:45 INFO - Creating virtualenv /builds/slave/test/build/venv 08:46:45 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 08:46:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:46:45 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:46:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:46:45 INFO - Using real prefix '/usr' 08:46:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:46:45 INFO - Installing distribute.............................................................................................................................................................................................done. 08:46:47 INFO - Installing pip.................done. 08:46:47 INFO - Return code: 0 08:46:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:46:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:46:48 INFO - Reading from file tmpfile_stdout 08:46:48 INFO - Output received: 08:46:48 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) 08:46:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:46:48 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')]} 08:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:48 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')]} 08:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:48 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 0x25831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f62a0>, '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 0x28f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f14d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', '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 08:46:48 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 08:46:48 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 08:46:48 INFO - Using env: {'DISPLAY': ':0', 08:46:48 INFO - 'HOME': '/home/cltbld', 08:46:48 INFO - 'LANG': 'en_US.UTF-8', 08:46:48 INFO - 'LANGUAGE': 'en_US:en', 08:46:48 INFO - 'LOGNAME': 'cltbld', 08:46:48 INFO - 'MAIL': '/var/mail/cltbld', 08:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:48 INFO - 'MOZ_NO_REMOTE': '1', 08:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:48 INFO - 'NO_EM_RESTART': '1', 08:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:48 INFO - 'PWD': '/builds/slave/test', 08:46:48 INFO - 'SHELL': '/bin/bash', 08:46:48 INFO - 'SHLVL': '1', 08:46:48 INFO - 'TERM': 'linux', 08:46:48 INFO - 'TMOUT': '86400', 08:46:48 INFO - 'USER': 'cltbld', 08:46:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', 08:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:48 INFO - '_': '/tools/buildbot/bin/python'} 08:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:48 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 08:46:48 INFO - Cleaning up... 08:46:48 INFO - Return code: 0 08:46:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:46:48 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')]} 08:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:48 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')]} 08:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:48 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 0x25831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f62a0>, '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 0x28f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f14d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', '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 08:46:48 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 08:46:48 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 08:46:48 INFO - Using env: {'DISPLAY': ':0', 08:46:48 INFO - 'HOME': '/home/cltbld', 08:46:48 INFO - 'LANG': 'en_US.UTF-8', 08:46:48 INFO - 'LANGUAGE': 'en_US:en', 08:46:48 INFO - 'LOGNAME': 'cltbld', 08:46:48 INFO - 'MAIL': '/var/mail/cltbld', 08:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:48 INFO - 'MOZ_NO_REMOTE': '1', 08:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:48 INFO - 'NO_EM_RESTART': '1', 08:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:48 INFO - 'PWD': '/builds/slave/test', 08:46:48 INFO - 'SHELL': '/bin/bash', 08:46:48 INFO - 'SHLVL': '1', 08:46:48 INFO - 'TERM': 'linux', 08:46:48 INFO - 'TMOUT': '86400', 08:46:48 INFO - 'USER': 'cltbld', 08:46:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', 08:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:48 INFO - '_': '/tools/buildbot/bin/python'} 08:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:48 INFO - Downloading/unpacking psutil>=3.1.1 08:46:48 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 08:46:48 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 08:46:48 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 08:46:48 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 08:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:46:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:49 INFO - Installing collected packages: psutil 08:46:49 INFO - Running setup.py install for psutil 08:46:49 INFO - building 'psutil._psutil_linux' extension 08:46:49 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 08:46:49 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 08:46:49 INFO - building 'psutil._psutil_posix' extension 08:46:49 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 08:46:50 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 08:46:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:50 INFO - Successfully installed psutil 08:46:50 INFO - Cleaning up... 08:46:50 INFO - Return code: 0 08:46:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46: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')]} 08:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f62a0>, '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 0x28f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f14d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', '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 08:46: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:46: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 mozsystemmonitor==0.3 08:46:50 INFO - Using env: {'DISPLAY': ':0', 08:46:50 INFO - 'HOME': '/home/cltbld', 08:46:50 INFO - 'LANG': 'en_US.UTF-8', 08:46:50 INFO - 'LANGUAGE': 'en_US:en', 08:46:50 INFO - 'LOGNAME': 'cltbld', 08:46:50 INFO - 'MAIL': '/var/mail/cltbld', 08:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:50 INFO - 'MOZ_NO_REMOTE': '1', 08:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:50 INFO - 'NO_EM_RESTART': '1', 08:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:50 INFO - 'PWD': '/builds/slave/test', 08:46:50 INFO - 'SHELL': '/bin/bash', 08:46:50 INFO - 'SHLVL': '1', 08:46:50 INFO - 'TERM': 'linux', 08:46:50 INFO - 'TMOUT': '86400', 08:46:50 INFO - 'USER': 'cltbld', 08:46:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', 08:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:50 INFO - '_': '/tools/buildbot/bin/python'} 08:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:46: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 08:46: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 08:46: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 08:46: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 08:46:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:46:51 INFO - Installing collected packages: mozsystemmonitor 08:46:51 INFO - Running setup.py install for mozsystemmonitor 08:46:51 INFO - Successfully installed mozsystemmonitor 08:46:51 INFO - Cleaning up... 08:46:51 INFO - Return code: 0 08:46:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:51 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 0x25831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f62a0>, '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 0x28f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f14d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', '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 08:46:51 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 08:46:51 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 08:46:51 INFO - Using env: {'DISPLAY': ':0', 08:46:51 INFO - 'HOME': '/home/cltbld', 08:46:51 INFO - 'LANG': 'en_US.UTF-8', 08:46:51 INFO - 'LANGUAGE': 'en_US:en', 08:46:51 INFO - 'LOGNAME': 'cltbld', 08:46:51 INFO - 'MAIL': '/var/mail/cltbld', 08:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:51 INFO - 'MOZ_NO_REMOTE': '1', 08:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:51 INFO - 'NO_EM_RESTART': '1', 08:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:51 INFO - 'PWD': '/builds/slave/test', 08:46:51 INFO - 'SHELL': '/bin/bash', 08:46:51 INFO - 'SHLVL': '1', 08:46:51 INFO - 'TERM': 'linux', 08:46:51 INFO - 'TMOUT': '86400', 08:46:51 INFO - 'USER': 'cltbld', 08:46:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', 08:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:51 INFO - '_': '/tools/buildbot/bin/python'} 08:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:51 INFO - Downloading/unpacking jsonschema==2.5.1 08:46: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 08:46: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 08:46: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 08:46: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 08:46:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:46:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:46: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 08:46: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 08:46: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 08:46: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 08:46:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:46:53 INFO - warning: no files found matching '*.txt' 08:46:53 INFO - no previously-included directories found matching 'build' 08:46:53 INFO - no previously-included directories found matching 'dist' 08:46:53 INFO - no previously-included directories found matching '.git*' 08:46:53 INFO - Installing collected packages: jsonschema, functools32 08:46:53 INFO - Running setup.py install for functools32 08:46:53 INFO - warning: no files found matching '*.txt' 08:46:53 INFO - no previously-included directories found matching 'build' 08:46:53 INFO - no previously-included directories found matching 'dist' 08:46:53 INFO - no previously-included directories found matching '.git*' 08:46:53 INFO - Successfully installed jsonschema functools32 08:46:53 INFO - Cleaning up... 08:46:53 INFO - Return code: 0 08:46:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:46:53 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')]} 08:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:53 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')]} 08:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:53 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 0x25831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f62a0>, '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 0x28f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f14d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', '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 08:46:53 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 08:46:53 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 08:46:53 INFO - Using env: {'DISPLAY': ':0', 08:46:53 INFO - 'HOME': '/home/cltbld', 08:46:53 INFO - 'LANG': 'en_US.UTF-8', 08:46:53 INFO - 'LANGUAGE': 'en_US:en', 08:46:53 INFO - 'LOGNAME': 'cltbld', 08:46:53 INFO - 'MAIL': '/var/mail/cltbld', 08:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:53 INFO - 'MOZ_NO_REMOTE': '1', 08:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:53 INFO - 'NO_EM_RESTART': '1', 08:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:53 INFO - 'PWD': '/builds/slave/test', 08:46:53 INFO - 'SHELL': '/bin/bash', 08:46:53 INFO - 'SHLVL': '1', 08:46:53 INFO - 'TERM': 'linux', 08:46:53 INFO - 'TMOUT': '86400', 08:46:53 INFO - 'USER': 'cltbld', 08:46:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', 08:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:53 INFO - '_': '/tools/buildbot/bin/python'} 08:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:46:53 INFO - Cleaning up... 08:46:53 INFO - Return code: 0 08:46:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:46:53 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')]} 08:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:53 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')]} 08:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:53 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 0x25831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f62a0>, '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 0x28f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f14d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', '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 08:46:53 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 08:46:53 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 08:46:53 INFO - Using env: {'DISPLAY': ':0', 08:46:53 INFO - 'HOME': '/home/cltbld', 08:46:53 INFO - 'LANG': 'en_US.UTF-8', 08:46:53 INFO - 'LANGUAGE': 'en_US:en', 08:46:53 INFO - 'LOGNAME': 'cltbld', 08:46:53 INFO - 'MAIL': '/var/mail/cltbld', 08:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:53 INFO - 'MOZ_NO_REMOTE': '1', 08:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:53 INFO - 'NO_EM_RESTART': '1', 08:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:53 INFO - 'PWD': '/builds/slave/test', 08:46:53 INFO - 'SHELL': '/bin/bash', 08:46:53 INFO - 'SHLVL': '1', 08:46:53 INFO - 'TERM': 'linux', 08:46:53 INFO - 'TMOUT': '86400', 08:46:53 INFO - 'USER': 'cltbld', 08:46:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', 08:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:53 INFO - '_': '/tools/buildbot/bin/python'} 08:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:53 INFO - Downloading/unpacking blobuploader==1.2.4 08:46: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 08:46: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 08:46: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 08:46: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 08:46:54 INFO - Downloading blobuploader-1.2.4.tar.gz 08:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:46:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:46: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 08:46: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 08:46: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 08:46: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 08:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:46:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:46:55 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 08:46:55 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 08:46:55 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 08:46:55 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 08:46:55 INFO - Downloading docopt-0.6.1.tar.gz 08:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:46:55 INFO - Installing collected packages: blobuploader, requests, docopt 08:46:55 INFO - Running setup.py install for blobuploader 08:46:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:46:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:46:55 INFO - Running setup.py install for requests 08:46:55 INFO - Running setup.py install for docopt 08:46:56 INFO - Successfully installed blobuploader requests docopt 08:46:56 INFO - Cleaning up... 08:46:56 INFO - Return code: 0 08:46:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:56 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 0x25831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f62a0>, '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 0x28f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f14d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', '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 08:46:56 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 08:46:56 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 08:46:56 INFO - Using env: {'DISPLAY': ':0', 08:46:56 INFO - 'HOME': '/home/cltbld', 08:46:56 INFO - 'LANG': 'en_US.UTF-8', 08:46:56 INFO - 'LANGUAGE': 'en_US:en', 08:46:56 INFO - 'LOGNAME': 'cltbld', 08:46:56 INFO - 'MAIL': '/var/mail/cltbld', 08:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:56 INFO - 'MOZ_NO_REMOTE': '1', 08:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:56 INFO - 'NO_EM_RESTART': '1', 08:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:56 INFO - 'PWD': '/builds/slave/test', 08:46:56 INFO - 'SHELL': '/bin/bash', 08:46:56 INFO - 'SHLVL': '1', 08:46:56 INFO - 'TERM': 'linux', 08:46:56 INFO - 'TMOUT': '86400', 08:46:56 INFO - 'USER': 'cltbld', 08:46:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', 08:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:56 INFO - '_': '/tools/buildbot/bin/python'} 08:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:56 INFO - Running setup.py (path:/tmp/pip-LLAhqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:56 INFO - Running setup.py (path:/tmp/pip-QE6UcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:56 INFO - Running setup.py (path:/tmp/pip-T4dDKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:56 INFO - Running setup.py (path:/tmp/pip-QLEnxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:56 INFO - Running setup.py (path:/tmp/pip-BBFil3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:56 INFO - Running setup.py (path:/tmp/pip-9uHHl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:56 INFO - Running setup.py (path:/tmp/pip-9dRiZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:56 INFO - Running setup.py (path:/tmp/pip-P1E7dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:56 INFO - Running setup.py (path:/tmp/pip-nWJdOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:56 INFO - Running setup.py (path:/tmp/pip-s4pVc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:57 INFO - Running setup.py (path:/tmp/pip-kyQVjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:57 INFO - Running setup.py (path:/tmp/pip-SELI9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:57 INFO - Running setup.py (path:/tmp/pip-rUHldj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:57 INFO - Running setup.py (path:/tmp/pip-44phCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:57 INFO - Running setup.py (path:/tmp/pip-v7i4jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:57 INFO - Running setup.py (path:/tmp/pip-ncHHvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:57 INFO - Running setup.py (path:/tmp/pip-09ipzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:46:57 INFO - Running setup.py install for manifestparser 08:46:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:46:57 INFO - Running setup.py install for mozcrash 08:46:57 INFO - Running setup.py install for mozdebug 08:46:57 INFO - Running setup.py install for mozdevice 08:46:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:46:57 INFO - Running setup.py install for mozfile 08:46:58 INFO - Running setup.py install for mozhttpd 08:46:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozinfo 08:46:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozInstall 08:46:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozleak 08:46:58 INFO - Running setup.py install for mozlog 08:46:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for moznetwork 08:46:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozprocess 08:46:58 INFO - Running setup.py install for mozprofile 08:46:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozrunner 08:46:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozscreenshot 08:46:59 INFO - Running setup.py install for moztest 08:46:59 INFO - Running setup.py install for mozversion 08:46:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:46:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:46:59 INFO - Cleaning up... 08:46:59 INFO - Return code: 0 08:46:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:59 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 0x25831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f62a0>, '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 0x28f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f14d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', '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 08:46:59 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 08:46:59 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 08:46:59 INFO - Using env: {'DISPLAY': ':0', 08:46:59 INFO - 'HOME': '/home/cltbld', 08:46:59 INFO - 'LANG': 'en_US.UTF-8', 08:46:59 INFO - 'LANGUAGE': 'en_US:en', 08:46:59 INFO - 'LOGNAME': 'cltbld', 08:46:59 INFO - 'MAIL': '/var/mail/cltbld', 08:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:59 INFO - 'MOZ_NO_REMOTE': '1', 08:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:59 INFO - 'NO_EM_RESTART': '1', 08:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:59 INFO - 'PWD': '/builds/slave/test', 08:46:59 INFO - 'SHELL': '/bin/bash', 08:46:59 INFO - 'SHLVL': '1', 08:46:59 INFO - 'TERM': 'linux', 08:46:59 INFO - 'TMOUT': '86400', 08:46:59 INFO - 'USER': 'cltbld', 08:46:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', 08:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:59 INFO - '_': '/tools/buildbot/bin/python'} 08:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:59 INFO - Running setup.py (path:/tmp/pip-JdztMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:59 INFO - Running setup.py (path:/tmp/pip-p64oOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:59 INFO - Running setup.py (path:/tmp/pip-VppkZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:59 INFO - Running setup.py (path:/tmp/pip-FdUkBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:59 INFO - Running setup.py (path:/tmp/pip-LFTHMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:59 INFO - Running setup.py (path:/tmp/pip-fJcrXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:59 INFO - Running setup.py (path:/tmp/pip-G8yISk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46: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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:59 INFO - Running setup.py (path:/tmp/pip-KEDwye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:00 INFO - Running setup.py (path:/tmp/pip-6qQSQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:00 INFO - Running setup.py (path:/tmp/pip-JMIG5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:00 INFO - Running setup.py (path:/tmp/pip-rouVi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:00 INFO - Running setup.py (path:/tmp/pip-sUmP14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:00 INFO - Running setup.py (path:/tmp/pip-uOQ5DO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:00 INFO - Running setup.py (path:/tmp/pip-p0WZvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:00 INFO - Running setup.py (path:/tmp/pip-2BYZfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:00 INFO - Running setup.py (path:/tmp/pip-f_VcLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:00 INFO - Running setup.py (path:/tmp/pip-Zw33ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:00 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)) 08:47:00 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)) 08:47:00 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)) 08:47:00 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)) 08:47:00 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)) 08:47:00 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)) 08:47:00 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)) 08:47:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:00 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 08:47:00 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 08:47:00 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 08:47:00 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 08:47:01 INFO - Downloading blessings-1.6.tar.gz 08:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:47:01 INFO - Installing collected packages: blessings 08:47:01 INFO - Running setup.py install for blessings 08:47:02 INFO - Successfully installed blessings 08:47:02 INFO - Cleaning up... 08:47:02 INFO - Return code: 0 08:47:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:02 INFO - Reading from file tmpfile_stdout 08:47:02 INFO - Current package versions: 08:47:02 INFO - argparse == 1.2.1 08:47:02 INFO - blessings == 1.6 08:47:02 INFO - blobuploader == 1.2.4 08:47:02 INFO - docopt == 0.6.1 08:47:02 INFO - functools32 == 3.2.3-2 08:47:02 INFO - jsonschema == 2.5.1 08:47:02 INFO - manifestparser == 1.1 08:47:02 INFO - mozInstall == 1.13 08:47:02 INFO - mozcrash == 1.0 08:47:02 INFO - mozdebug == 0.1 08:47:02 INFO - mozdevice == 0.51 08:47:02 INFO - mozfile == 1.2 08:47:02 INFO - mozhttpd == 0.7 08:47:02 INFO - mozinfo == 0.10 08:47:02 INFO - mozleak == 0.1 08:47:02 INFO - mozlog == 3.5 08:47:02 INFO - moznetwork == 0.27 08:47:02 INFO - mozprocess == 0.25 08:47:02 INFO - mozprofile == 0.28 08:47:02 INFO - mozrunner == 6.13 08:47:02 INFO - mozscreenshot == 0.1 08:47:02 INFO - mozsystemmonitor == 0.3 08:47:02 INFO - moztest == 0.8 08:47:02 INFO - mozversion == 1.4 08:47:02 INFO - psutil == 3.1.1 08:47:02 INFO - requests == 1.2.3 08:47:02 INFO - wsgiref == 0.1.2 08:47:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:02 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 0x25831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f62a0>, '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 0x28f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f14d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', '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 08:47:02 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 08:47:02 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 08:47:02 INFO - Using env: {'DISPLAY': ':0', 08:47:02 INFO - 'HOME': '/home/cltbld', 08:47:02 INFO - 'LANG': 'en_US.UTF-8', 08:47:02 INFO - 'LANGUAGE': 'en_US:en', 08:47:02 INFO - 'LOGNAME': 'cltbld', 08:47:02 INFO - 'MAIL': '/var/mail/cltbld', 08:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:02 INFO - 'MOZ_NO_REMOTE': '1', 08:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:02 INFO - 'NO_EM_RESTART': '1', 08:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:02 INFO - 'PWD': '/builds/slave/test', 08:47:02 INFO - 'SHELL': '/bin/bash', 08:47:02 INFO - 'SHLVL': '1', 08:47:02 INFO - 'TERM': 'linux', 08:47:02 INFO - 'TMOUT': '86400', 08:47:02 INFO - 'USER': 'cltbld', 08:47:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', 08:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:02 INFO - '_': '/tools/buildbot/bin/python'} 08:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:02 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)) 08:47:02 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)) 08:47:02 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)) 08:47:02 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)) 08:47:02 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)) 08:47:02 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)) 08:47:02 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)) 08:47:02 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)) 08:47:02 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)) 08:47:02 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:47: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 08:47: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 08:47: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 08:47: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 08:47:03 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:47:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:47:03 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)) 08:47:03 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)) 08:47:03 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)) 08:47:03 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)) 08:47:03 INFO - Installing collected packages: marionette-driver, simplejson 08:47:03 INFO - Running setup.py install for marionette-driver 08:47:04 INFO - Running setup.py install for simplejson 08:47:04 INFO - building 'simplejson._speedups' extension 08:47:04 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 08:47:04 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 08:47:05 INFO - Successfully installed marionette-driver simplejson 08:47:05 INFO - Cleaning up... 08:47:05 INFO - Return code: 0 08:47:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:05 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 0x25831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f62a0>, '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 0x28f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f14d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', '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 08:47:05 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 08:47:05 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 08:47:05 INFO - Using env: {'DISPLAY': ':0', 08:47:05 INFO - 'HOME': '/home/cltbld', 08:47:05 INFO - 'LANG': 'en_US.UTF-8', 08:47:05 INFO - 'LANGUAGE': 'en_US:en', 08:47:05 INFO - 'LOGNAME': 'cltbld', 08:47:05 INFO - 'MAIL': '/var/mail/cltbld', 08:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:05 INFO - 'MOZ_NO_REMOTE': '1', 08:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:05 INFO - 'NO_EM_RESTART': '1', 08:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:05 INFO - 'PWD': '/builds/slave/test', 08:47:05 INFO - 'SHELL': '/bin/bash', 08:47:05 INFO - 'SHLVL': '1', 08:47:05 INFO - 'TERM': 'linux', 08:47:05 INFO - 'TMOUT': '86400', 08:47:05 INFO - 'USER': 'cltbld', 08:47:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', 08:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:05 INFO - '_': '/tools/buildbot/bin/python'} 08:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:47:05 INFO - Cleaning up... 08:47:05 INFO - Return code: 0 08:47:05 INFO - Running post-action listener: _resource_record_post_action 08:47:05 INFO - Running post-action listener: _start_resource_monitoring 08:47:05 INFO - Starting resource monitoring. 08:47:05 INFO - [mozharness: 2017-07-13 15:47:05.340782Z] Finished create-virtualenv step (success) 08:47:05 INFO - [mozharness: 2017-07-13 15:47:05.341296Z] Running install step. 08:47:05 INFO - Running pre-action listener: _resource_record_pre_action 08:47:05 INFO - Running main action method: install 08:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:05 INFO - Reading from file tmpfile_stdout 08:47:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:47:05 INFO - Reading from file tmpfile_stdout 08:47:05 INFO - Output received: 08:47:05 INFO - Usage: mozinstall [options] installer 08:47:05 INFO - Options: 08:47:05 INFO - -h, --help show this help message and exit 08:47:05 INFO - -d DEST, --destination=DEST 08:47:05 INFO - Directory to install application into. [default: 08:47:05 INFO - "/builds/slave/test"] 08:47:05 INFO - --app=APP Application being installed. [default: firefox] 08:47:05 INFO - mkdir: /builds/slave/test/build/application 08:47:05 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'] 08:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:47:23 INFO - Reading from file tmpfile_stdout 08:47:23 INFO - Output received: 08:47:23 INFO - /builds/slave/test/build/application/firefox/firefox 08:47:23 INFO - Running post-action listener: _resource_record_post_action 08:47:23 INFO - [mozharness: 2017-07-13 15:47:23.725319Z] Finished install step (success) 08:47:23 INFO - [mozharness: 2017-07-13 15:47:23.725572Z] Running setup-mitmproxy step. 08:47:23 INFO - Running pre-action listener: _resource_record_pre_action 08:47:23 INFO - Running main action method: setup_mitmproxy 08:47:23 INFO - Skipping: mitmproxy is not required 08:47:23 INFO - Running post-action listener: _resource_record_post_action 08:47:23 INFO - [mozharness: 2017-07-13 15:47:23.726699Z] Finished setup-mitmproxy step (success) 08:47:23 INFO - [mozharness: 2017-07-13 15:47:23.726934Z] Running run-tests step. 08:47:23 INFO - Running pre-action listener: _resource_record_pre_action 08:47:23 INFO - Running pre-action listener: _set_gcov_prefix 08:47:23 INFO - Running main action method: run_tests 08:47:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:23 INFO - Python 2.7.3 08:47:23 INFO - Return code: 0 08:47:23 INFO - grabbing minidump binary from tooltool 08:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:23 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 0x28f62a0>, '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 0x28f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f14d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:23 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 08:47:23 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 08:47:23 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 08:47:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:23 INFO - Return code: 0 08:47:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:47:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:23 INFO - ENV: RUST_BACKTRACE is now 1 08:47:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:47:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:23 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/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 08:47:23 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/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 08:47:23 INFO - Using env: {'DISPLAY': ':0', 08:47:23 INFO - 'HOME': '/home/cltbld', 08:47:23 INFO - 'LANG': 'en_US.UTF-8', 08:47:23 INFO - 'LANGUAGE': 'en_US:en', 08:47:23 INFO - 'LOGNAME': 'cltbld', 08:47:23 INFO - 'MAIL': '/var/mail/cltbld', 08:47:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:23 INFO - 'MOZ_NO_REMOTE': '1', 08:47:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:23 INFO - 'NO_EM_RESTART': '1', 08:47:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:23 INFO - 'PWD': '/builds/slave/test', 08:47:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:23 INFO - 'RUST_BACKTRACE': '1', 08:47:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:47:23 INFO - 'SHELL': '/bin/bash', 08:47:23 INFO - 'SHLVL': '1', 08:47:23 INFO - 'TERM': 'linux', 08:47:23 INFO - 'TMOUT': '86400', 08:47:23 INFO - 'USER': 'cltbld', 08:47:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424', 08:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:23 INFO - '_': '/tools/buildbot/bin/python'} 08:47:23 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/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 08:47:24 INFO - mozversion application_buildid: 20170713143541 08:47:24 INFO - mozversion application_changeset: d4e6f45db73333f693ac0cf53cab1f8ab4798373 08:47:24 INFO - mozversion application_display_name: Nightly 08:47:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:24 INFO - mozversion application_name: Firefox 08:47:24 INFO - mozversion application_remotingname: firefox 08:47:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:47:24 INFO - mozversion application_vendor: Mozilla 08:47:24 INFO - mozversion application_version: 56.0a1 08:47:24 INFO - mozversion platform_buildid: 20170713143541 08:47:24 INFO - mozversion platform_changeset: d4e6f45db73333f693ac0cf53cab1f8ab4798373 08:47:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:47:24 INFO - mozversion platform_version: 56.0a1 08:47:24 INFO - using testdate: 1499960844 08:47:24 INFO - actual date: 1499960844 08:47:24 INFO - starting webserver on 'localhost:56996' 08:47:24 INFO - SUITE-START | Running 2 tests 08:47:24 INFO - TEST-START | dromaeo_css 08:47:24 INFO - Initialising browser for dromaeo_css test... 08:47:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56996/getInfo.html -profile /tmp/tmpuGx_eF/profile 08:47:24 INFO - TEST-INFO | started process 32408 (/builds/slave/test/build/application/firefox/firefox http://localhost:56996/getInfo.html) 08:47:29 INFO - TEST-INFO | 32408: exit 0 08:47:29 INFO - Browser initialized. 08:47:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:47:29 INFO - TEST-INFO | started process 32614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuGx_eF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:41 INFO - PID 32614 | RSS: Main: 164184064 08:47:41 INFO - PID 32614 | 08:50:37 INFO - PID 32614 | Cycle 1(1): loaded http://localhost:56996/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56996/tests/dromaeo/cssquery-ext.html) 08:50:39 INFO - PID 32614 | RSS: Main: 170172416 08:50:39 INFO - PID 32614 | 08:53:41 INFO - PID 32614 | Cycle 1(1): loaded http://localhost:56996/tests/dromaeo/cssquery-ext.html (next: http://localhost:56996/tests/dromaeo/cssquery-jquery.html) 08:53:41 INFO - PID 32614 | RSS: Main: 168345600 08:53:41 INFO - PID 32614 | 08:56:43 INFO - PID 32614 | Cycle 1(1): loaded http://localhost:56996/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56996/tests/dromaeo/cssquery-mootools.html) 08:56:43 INFO - PID 32614 | RSS: Main: 170508288 08:56:43 INFO - PID 32614 | 08:59:45 INFO - PID 32614 | Cycle 1(1): loaded http://localhost:56996/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56996/tests/dromaeo/cssquery-prototype.html) 08:59:46 INFO - PID 32614 | RSS: Main: 168972288 08:59:46 INFO - PID 32614 | 09:02:49 INFO - PID 32614 | Cycle 1(1): loaded http://localhost:56996/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56996/tests/dromaeo/cssquery-yui.html) 09:02:49 INFO - PID 32614 | RSS: Main: 168153088 09:02:49 INFO - PID 32614 | 09:05:51 INFO - PID 32614 | Cycle 1(1): loaded http://localhost:56996/tests/dromaeo/cssquery-yui.html (next: http://localhost:56996/tests/dromaeo/cssquery-dojo.html) 09:05:51 INFO - PID 32614 | RSS: Main: 171507712 09:05:51 INFO - PID 32614 | 09:05:51 INFO - PID 32614 | __start_tp_report 09:05:51 INFO - PID 32614 | _x_x_mozilla_page_load 09:05:51 INFO - PID 32614 | _x_x_mozilla_page_load_details 09:05:51 INFO - PID 32614 | |i|pagename|runs| 09:05:51 INFO - PID 32614 | |0;dojo.html;3297.637259901412;3361.5293858859754;3367.461206207006;3369.6461871503493;3381.951595005548;6078.726457309421;6141.1095391168255;6172;6193.225846769154;6243.594166379182;6032.577719559622;6070.696465176746;6097.451229389354;6117.2965109012475;6122.265328160627;5318.9202161967605;5336.493033161843;5337.492938170887;5380.784768609251;5382.838514844561;5410.215518749779;5458.754356053987;5470.753816078286;5470.972645136789;5481.095619222823;5460.34475862897;5473.480019398171;5475.863103422406;5478;5480.835574932758;5453.890922181554;5458.099413596752;5465.289512363387;5468.863278418052;5469.972650136764;5364.409914909357;5385.407605163429;5438.211459338374;5458.727063646802;5526.778928842841;5994.790182343597;6097.603655762361;6124.877502449926;6140.631562106288;6140.969295153541;6478.481721462272;6608.603483790988;6669;6694.732210711566;6694.93305066948;6603.768868089642;6613.966930165367;6630.403263706289;6643.6346000969925;6646.966765166143;6128.96935515324;6149.569530132892;6155.199824022893;6238.532110091716;6248.87502249957;6776.9322306777285;6782.683189225772;6784.626845523445;6868.244493105754;6878.209005964378;6527.967360163168;6534.117894084333;6548.27968923418;6592.274849766522;6597.901031484532;6495.870082598416;6573.046908198285;6593.307702691149;6595.736170553124;6615.801525954229;6433.646149461731;6533.673316334164;6534.444572211415;6562.606243625398;6571.769988050395;5776.624519406309;6585.209774826955;6638.634875081821;6715.56348837324;6729.05793188954;4995.875103122451;5009.173486374781;5063.088644044034;5076.0863044652315;5079.6698214615935;4437.06821567468;4495.325701144789;4507.121111383249;4513.593776560126;4516.977415112903;6107.144999700045;6160.353162917919;6210.099535567318;6221;6247.406496382836;6582.045603387578;6589.703463344161;6592.406683398517;6592.439642630334;6602.537822352389;6170.629762214281;6181.134641150243;6181.320054793969;6185.072239164071;6193.442590166816;5613.214150019001;5622.353429355595;5649.237352957298;5651.265335506358;5686.346070201897;6905.896411553831;6928.16861976566;6949.548279361826;6988;6999.300069993062;6654.600723956578;6656.267810540837;6656.567323123982;6744.325567443217;6783.93216067833;6744.325567443217;6881.967704844314;6921.7231310747;6946.930530694628;6957.826054348682;6479.643619600967;6481.546291759531;6495.545311828127;6515.6742162892615;6529.085927970183;5791.6007405379505;6668.099806526251;6680.866382672417;6737.629430381376;6738.494612903954;6437.935620643921;6441.806745797634;6453.903191452038;6512.120863683342;6519.576227545194;6338.58799178052;6457.67711614408;6506.41442270198;6543.967280163759;6546.083548303146;6364.363563643598;6374.362563743589;6374.713137908712;6384.170057892445;6385.648789316632;6357.364263573606;6395.968020159869;6406.903896441464;6420.293767685457;6424.807255782334;5343.7862485500145;6252.3122456530655;6253.218347706536;6368.115449575847;6423.486121110206 09:05:51 INFO - PID 32614 | |1;ext.html;808.7614153824621;840.9075001749802;864.2610567964391;891.0599317719802;894.727108231989;41378.58621413785;42035.73892783218;42088.78955605225;42202.57797422029;42379.364309535384;38657;38742.418863716994;38747.22505549887;38763.224735505275;38827.61172388275;6561.868762624745;6668.599884006975;6670.866582668344;6687.598744075347;6691.3308669133185;6645.501587380942;6713.664316784141;6733.192016957972;6737.225219099817;6738.393544580987;6705.631190284533;6723.394894459498;6739.191297044362;6747.8650426991435;6749.223839258499;6673.199216094075;6692.196936367618;6709.630970296607;6717.261101278856;6747.5276730628875;6032.9698351508405;6059.454649081604;6081.087836824468;6084.391560843925;6095.359987201368;34578.30843383118;34678.133046673785;34770.13074673128;34770.82614586936;35104.12239694002;3312.950305745416;3347.598288205407;3355.9328813423595;3369.4608862582113;3371.0729549373873;27084;30991.22521936947;31564.210894727585;31608;31611.05166844998;4622.6301895848255;4762.476127625993;4795.688280261772;4874.8537543873745;4927.1870141426625;198622.00688996608;199366;200740;206908;207839;49699.254511182364;50197.24704129441;50352.24471632928;50531.24203136956;50851.7457412718;52861.41415757533;52865.47134528605;52868.20697689538;52873.7356313216;52964.470355295955;16805.41181058657;16940.57648558796;17016.914915425343;17038.57403564921;17073.7438938416;14035.298235088205;14050.156990580597;14072.226027568377;14082.71834563303;14091.647708807363;14740.926295368668;14843.183624900734;14878.479253226302;14922.328495217742;15009.849901500846;5830.854228644318;5958.165856780054;5961.552883533753;5972.40275972408;6190.350013248544;1046.842973553973;1077.6012875236213;1078.7464945737745;1087.9020888119949;1110.622388387952;23741.406464838517;23825.642615360783;23960.88019559926;24079.157229496883;24517;1179.8643156036994;1203.2479700187382;1208.383724300613;1208.64949164743;1211.5093387178206;12792.872071279355;12807.487700491876;12849.357532123357;12935.353232338346;12936.288504132175;271492;272533;275171;275734;276543;51965.22052169221;51989.7400512995;52011;52288.73855630773;52570.47429525732;1466.3254902744643;1526.7099251142247;1527.0608575726071;1536.7387544117528;1560.6020464781634;23141.53716925686;23502.412439689146;23508.05967761339;23656.881715591313;23705;37260;37656;37694.8115259422;37695.623043769214;37723.81138094292;227886;228861;229185;229289;229344;34942.301153977285;36066.45900311445;37060.62939370572;38620.420693689055;38908;46633.53366466292;47452.28821567748;47511.52488475071;47704.52295477001;48726;34761.304773903874;35360.82319588386;35560;35781.46327805033;35853;33465.66534334723;34217.48673769945;34359.4846077304;34881.65118348886;34927.65072349244;39975;40094;40327.79836100918;40551.797241013606;40617.796911015255;33412.1646958828;33612.495812562345;33866.66133338635;34024.1493962643;34103.65896341104;24645;25305.114320998677;25730.35674108162;25767.355816104748;26273.605895911194 09:05:51 INFO - PID 32614 | |2;jquery.html;576.194237064191;581.741125199286;586.8415527807491;588.5850475414833;597.8624916269258;22422.439439014033;22985.655215171766;23185.072597096096;23321.183758568455;23334.183303584377;24826;26071.47857042858;27823.443531129415;27838.443231135367;28016;5224.1902505111575;5293.364796224459;5329.173978033411;5333.866653333678;5345.037893179227;6145.108959200913;6151.630902145863;6163.907541386883;6182.319944806068;6182.505399568024;4096.32410652242;5743.167240750089;6128.20333356663;6158.599691020092;6169.568130230886;6113.480354169901;6132.325444201112;6154.599951003215;6192.721327540272;6208.441240288395;5765.855853603652;5785.4214578541805;5802.042662960606;5802.535797136219;5819.592628516006;29902.551461728093;30853.8457307712;31045.689543104505;31089.689103108907;31315.53026704601;2162.6647869580083;2210.160139147114;2230.431240033781;2242.618754811686;2246.4945387287894;19064.61870762577;19680.50798730029;19711.310104146287;19730.408087757245;19762;2342.543204075206;2401.11158871217;2431.1004928176512;2438.8536687798787;2439.195065628356;140734;144321.2783936084;144589;144851.27574362166;146874;15061.623459413384;15297.694046119015;15897.364105435885;15902.522924312058;16355.672886542203;24608.261752147464;24812.14660314087;24821.1312604058;24843.87578062098;24865.129720459696;10723.94638026805;10733;10831.512581933832;10904.236703430684;11034.944825275823;9923.65267215644;9971.501424928725;10119.13987311072;10140.188784897191;10187;9693.51532423376;9742.464164471023;9802.950985245028;9816.312858099864;9834.459104749165;2689.031948498539;2718.993972230248;2758.668959724846;2819.915402537927;2827.180117765866;1034.6844212515255;1062.7290041039485;1066.6053560182781;1075.1022895882027;1086.3264775838873;21520.81635510062;21959.231426899983;21964.231251906105;22010.669839952414;22147.667784983238;1122.4331712485143;1132.224426268009;1141.1270378160714;1150.5972909481782;1156.9595064172713;11656.242344247597;11984.940075299743;12241.387930603434;12241.816372754416;12266.957308628867;581347;599926;605388;636661;638413;124181.37909310576;127155.36422318015;127917;129108;129710;1258.754542864151;1281;1315.7434300311538;1316.4799904037852;1323.602919124278;17967;19111.522211944255;19112.713309300092;19175.041247937268;19503;57073.42926570847;60497.69751151216;60720.696396517735;61391;64243;76961;77940;78794.60602697179;78948.60525697334;79224.60387698024;15129.924350378178;15267.541973740805;15736.291866866248;15742.842571574138;15901.96637218577;24983.125590604242;25197.370065748502;25419.61870571906;25472.872635636704;25812.483750325264;17599;19030.524236893634;19196;19207.423777286705;19219.32732354361;17276.65446691034;17620.735688964418;17636.470905872844;17772.48933840638;18385;20662.793372066688;21471.8926405367;21535.784642154005;21595.784042159376;21712.240071597418;15029.849701502844;15104.848951510345;15436.30536625877;15486;15515.301811418287;20819.479513012295;20881.89559052195;20936.47658808481;20947.266845660328;21198.682019769407 09:05:51 INFO - PID 32614 | |3;mootools.html;1406.2617126008845;1472.6539263273132;1474.9336279867405;1480.6076389756715;1481.7777333399995;14657.413703451863;15272.847271527282;15315.310811013504;15400.229988500558;15402.152881591523;14555.199464029474;15017.098974061564;15635.921820390911;15703.685926281467;15809.841901580981;2724.972750272502;2796.5525515917457;2812.268810109376;2813.6342275504157;2814.9014784482547;2684.141074856047;2773.9306517337027;2774.680911695151;2776.7500924916753;2780.8748606312765;2679.490896729625;2687;2753.105240796739;2759.4205216904475;2792.9301767455872;2729.3858881751644;2761.130243973142;2761.3786897948003;2763.0605594098;2766.0457142285877;2669.853158076305;2683.5840444731098;2688.435428559985;2690.3005218643293;2694.90567830125;14557;14901.701965960729;14918.403263869432;14929.776053359208;14949;8062.475939063942;8289.875651865166;8332.750017499484;8354.707585234488;8355.623996920152;5311.2298716686255;5325.094733895247;5391.757370918318;5410.674384775716;5431.185322201662;1933.5069557262948;1984.474114359696;2001.5996800639784;2300.2064287820676;2441.59713647248;26836.329091772666;27449.86275068612;27468.450630987267;27489.862550687118;27516.449671006467;7559.470837041465;7588.392928565701;7664.6934122635585;7736.806579835436;7749.341305988942;20611.896940515202;20624.27815026467;20699;20739.79260207409;20744.896275518528;8113.391495637851;8463.957680211559;8568.228859402683;8650.610722517502;8677.783055423664;7319.4144468443465;7592.468527203043;7609.543427394374;7624.046994125734;7624.27569380919;5484.238662439091;5554.750036248379;5594.24477695514;5631.436856314336;5648.209250704905;1592.562045437514;1600.5598460423478;1613.4514265149905;1628.4056319443318;1631.5023917704978;919.2599957034518;919.3564504846634;939.9671011514564;943.7593413679605;953.2659851914126;9221.90778092224;9491.430514169171;9615.375000624937;9653.758656033515;9668.033196680275;1028.3624153025023;1047.6228557719214;1068.8022715797601;1072.3057569040898;1082.5994382078682;5543.417941116125;5753.59724819267;5806.4193580641595;5826.359100498942;5839.0949402842625;20342.898285508476;21418.57162856734;21820.672689909665;21848.781512184993;21868.562628747655;20356.898215509125;21389.395795315413;21590.244341447975;21637;21639.891800540896;11386.544538218379;12133.817992730115;12196.329201893803;12239.510419583296;12357.505699772088;7821.256980586835;8601.741947741577;8668;8672.523011234443;8719.258862996716;18571.628567428845;18699.813001869807;19085.904570477058;19149.80850191536;19499.805001950368;18906.243750249836;19104.904475477535;19896.104675289356;20148.697769533177;20427.897860510602;12135.08986825974;12546.686332841751;12734.474776500387;12769.8084528734;12785.36073196355;14010.64973375633;14251.928740356232;14308.928455357656;14399.92800036035;14450.277486125442;11316.321020738782;11353.943230283796;11413.97274245322;11478.655640330804;11529.308241505536;10766.461676915966;11024.779504410028;11035.668929932115;11130.220884538005;11498.54005839757;10622.575096996343;10843.783124337628;10847.728806779895;10868.347899126078;10910.509027093958;7580.772576822704;7694.307512323918;7763;7850.685972561262;7864.2922137007945;7497.2877576630135;7648.80877978055;7673.34776544;7740.729074482591;7766.068071831416 09:05:51 INFO - PID 32614 | |4;prototype.html;494.9356583644126;515.9871003224919;524.2686452398904;535.6973310079802;535.7214248590733;6031.427014433632;6108.755649774009;6126.846828829282;6141.170941922839;6211.472024877885;5849.502792262663;6002.3097343805475;6003.358522250207;6052.273727152737;6080.023992202541;4737.478877323491;4804.927926081103;4819.734914579697;4838.274258861164;4847.684900481458;4792.993471371016;4822.421309442854;4841.709497430148;4846.684965477232;4875.146849301375;4611.308303754447;4760.880977975544;4775.976120119394;4783.162946484351;4826.638002149835;4736.668433209677;4738.289256611519;4768.9284660729945;4774.904501909977;4785.497522760095;4310.892227694301;4319.308910574325;4328.7402755834755;4347.891302717458;4352.521222665504;5968.1644569760265;5977.491913187384;5980.880382392371;6018.759249630053;6046.3651316612;5699.886002279931;5725.541956643458;5737.254156959611;5755.3381361143165;5757.366689664133;6524.608523488606;6568.423578341211;6571.835704107388;6610.900836487456;6624.73501059957;4911.803527858881;4929.137400954819;4942.728149951751;4944.283078953532;4963.305137280783;6828.624425656587;6862.691178896962;6886.829239029377;6916.432272021021;6922.550034247758;5050.823221187241;5089.770960306795;5096.694198348111;5111.309973153577;5130.640855140105;5093.490650934951;5136.897262054738;5163.457836927144;5170.095233334151;5179.559737422286;5677.545796336283;5683.090705487185;5687.744051517691;5722.513586345124;5787.88424231513;6534.8366290843105;6555.672216389162;6599.307072757388;6632.9336706633285;6684.4959884026675;1793.5516120969758;1809.5476130967259;1812.2479171143827;1818.8908665480114;1821.1895706410521;1156.6240971684235;1162.424599823076;1238.7027113492877;1262.1480500662017;1276.431987765454;6028.3971602839365;6078.787242446581;6123.540734444934;6160.8767824643255;6193.938060619426;6646.202455705346;6676.26561078281;6677.866442671119;6713.832154196087;6717.219936716774;6079.878402432015;6144.907826382608;6184.752609895644;6269.247690277105;6278.937210627927;3513.262214934892;3548.1307079765625;3552.4848896909803;3557.128503516655;3569.1434055826417;6880.139982502187;6904.240533541307;6936.410405115622;6939.375456208965;6952;6802.741492823744;6819.5908245505425;6856.417204537571;6878.759243426456;6930.757423490154;6858.5199036067;6918.827029324307;6948;6963.338482844223;7013.6142512161305;6599.241087274832;6623.6688165592495;6627.834304142242;6699.263081060982;6751.594904305757;6440.227172739301;6483.189601299838;6621.172353455818;6624.735010599522;6638.751199232592;6832.385085342343;6839.93160068393;6989.1129395062035;7002.229754727078;7012.2286548478605;5373.35519737634;5448.891022179455;5452.209429632601;5455.18172274162;5469.316335458067;6629.602223866584;6722.798316050526;6724.865502690017;6763.729450822108;6764.594124352555;6471.417572418505;6512.902306465312;6561.671916404256;6598.1422415085735;6616.106825578485;6513.934860651333;6526.151600291932;6527.184101987252;6529.412352888263;6600.1089852869245;6389.584676995981;6493.415592596689;6507.934920650733;6509.446697030806;6614.140161779131;6063.605865618721;6510.688705509476;6546.083548303337;6546.803595892131;6620.536562440583;6292.4651404629285;6357.4596159326975;6367.458766004941;6393.29673735898;6426.839329016812 09:05:51 INFO - PID 32614 | |5;yui.html;934.967276145335;938.643315540095;951.3103000324761;957.6648173139403;964.0504103458095;16944.91527542362;17722;17737.290508379665;17841.553961150978;17847.64304713908;19095.52261193471;20915.37253882382;21013.36959891202;21075.68386474204;21144.048517816696;1042.6350777227947;1066.077842666092;1067.3382502848244;1069.8823129455754;1071.3946620159625;1081.086481922774;1085.8588383510173;1086.0497065068066;1086.4187659602114;1091.6397588795678;1010.0455069958891;1112.227002233448;1123.1183520936067;1141.4064686363085;1141.8116010858198;1104.4312179227704;1109.6005438042298;1113.1595645287837;1114.5876025870439;1116.6929094499037;801.6953557648114;803.3533005930224;805.7864665863551;809.4253080312926;811.0348685064813;18696.439106826816;18837.24651013958;18856.30293273612;19123.23507059716;19588.314408995615;19932.80067199324;20146.395608131632;20319.898400507904;20704.171833126657;20707.689384659243;15353.769693454607;15527;15794.289256983348;15820.446284379992;15835.287412066486;3431.5367425397503;3434.295969326282;3442.9483557746403;3457.4122399191947;3467.826608669556;116050.41974790157;116732.41633791776;119392.40303798426;122888;123295;15371.538853834403;15571.844281557265;15618;15620.843791562167;15644.452444164628;28921.276968075967;30179.698203017688;30249.697503025127;30348.696513034585;30544.389112217632;8474.74575762728;8535.402521823413;8602.139786021473;8807;8898.42160259581;4186.937195942063;4306.418633484503;4326.6754993375625;4331.610155085994;4333.544977777351;5375.838724838261;5380.7309634518115;5448.700321482277;5477.643953143033;5529.060059789846;950.0784239288017;985.0937137833067;990.8662330585279;1109.5506319940437;1125.8254970479588;714.4534431160166;719.9424046076301;736.7642354446525;740.2523451314104;759.1421693486325;11324.773504529863;11483.655490335137;11635.564215943374;11641.88358116425;12084.879151208552;708.2032713197652;736.7053178728552;737.1927739125649;741.6365980669433;745.4409193105171;5327.549327309481;5546.694931778791;5573.888522229614;5631.7184140793615;5652.85867853307;110705;112637.43681281542;116422;116454;116888.41555792166;101831;105725;105896.94103059024;109990.45004775086;111043;84901.57549212337;88154.99999999872;93272.53363733138;93470;97267.51366243266;12397.194182378116;12591;12914.547990820276;12946;12974.870251297367;39830;43425.56574434342;43876.12247755091;45880.31179532243;46317.305240422094;54928.72535637296;73611.63194183995;73938;79239;79296;15097.169655669044;16009.839901600835;16048.919755401148;16181.838181618034;16234.594135146715;19090.904545477184;19130.426087217405;19310.13104410333;19331.710024349366;19544.80455195487;17319.7402038967;17966.730499042787;18141.365052223107;18460.07699614987;18776.7183492245;17249.39627113045;18134.365297214536;18344.633107338046;18366.72449913279;18647.90676046611;15754.842451575338;15960.840391596399;16189.67620647557;16260.593485162966;16290.918545407198;11579.594714184963;12062.336571488653;12532.937335313265;12862.485500579873;12992.220466771645;13661.590152295446;13678.794818077937;13701.109427887155;13787.310634468437;14422.206778626856 09:05:51 INFO - PID 32614 | __end_tp_report 09:05:51 INFO - PID 32614 | __start_cc_report 09:05:51 INFO - PID 32614 | _x_x_mozilla_cycle_collect,329 09:05:51 INFO - PID 32614 | __end_cc_report 09:05:51 INFO - PID 32614 | __startTimestamp1499961951488__endTimestamp 09:05:51 INFO - PID 32614 | 09:05:51 INFO - PID 32614 | ------- Summary: start ------- 09:05:51 INFO - PID 32614 | Number of tests: 6 09:05:51 INFO - PID 32614 | 09:05:51 INFO - PID 32614 | [#0] dojo.html Cycles:165 Average:6087.05 Median:6364.36 stddev:755.69 (11.9%) stddev-sans-first:725.63 09:05:51 INFO - PID 32614 | Values: 3297.6 3361.5 3367.5 3369.6 3382.0 6078.7 6141.1 6172.0 6193.2 6243.6 6032.6 6070.7 6097.5 6117.3 6122.3 5318.9 5336.5 5337.5 5380.8 5382.8 5410.2 5458.8 5470.8 5471.0 5481.1 5460.3 5473.5 5475.9 5478.0 5480.8 5453.9 5458.1 5465.3 5468.9 5470.0 5364.4 5385.4 5438.2 5458.7 5526.8 5994.8 6097.6 6124.9 6140.6 6141.0 6478.5 6608.6 6669.0 6694.7 6694.9 6603.8 6614.0 6630.4 6643.6 6647.0 6129.0 6149.6 6155.2 6238.5 6248.9 6776.9 6782.7 6784.6 6868.2 6878.2 6528.0 6534.1 6548.3 6592.3 6597.9 6495.9 6573.0 6593.3 6595.7 6615.8 6433.6 6533.7 6534.4 6562.6 6571.8 5776.6 6585.2 6638.6 6715.6 6729.1 4995.9 5009.2 5063.1 5076.1 5079.7 4437.1 4495.3 4507.1 4513.6 4517.0 6107.1 6160.4 6210.1 6221.0 6247.4 6582.0 6589.7 6592.4 6592.4 6602.5 6170.6 6181.1 6181.3 6185.1 6193.4 5613.2 5622.4 5649.2 5651.3 5686.3 6905.9 6928.2 6949.5 6988.0 6999.3 6654.6 6656.3 6656.6 6744.3 6783.9 6744.3 6882.0 6921.7 6946.9 6957.8 6479.6 6481.5 6495.5 6515.7 6529.1 5791.6 6668.1 6680.9 6737.6 6738.5 6437.9 6441.8 6453.9 6512.1 6519.6 6338.6 6457.7 6506.4 6544.0 6546.1 6364.4 6374.4 6374.7 6384.2 6385.6 6357.4 6396.0 6406.9 6420.3 6424.8 5343.8 6252.3 6253.2 6368.1 6423.5 09:05:51 INFO - PID 32614 | 09:05:51 INFO - PID 32614 | [#1] ext.html Cycles:180 Average:40478.16 Median:35023.21 stddev:61734.59 (176.3%) stddev-sans-first:61835.91 09:05:51 INFO - PID 32614 | Values: 808.8 840.9 864.3 891.1 894.7 41378.6 42035.7 42088.8 42202.6 42379.4 38657.0 38742.4 38747.2 38763.2 38827.6 6561.9 6668.6 6670.9 6687.6 6691.3 6645.5 6713.7 6733.2 6737.2 6738.4 6705.6 6723.4 6739.2 6747.9 6749.2 6673.2 6692.2 6709.6 6717.3 6747.5 6033.0 6059.5 6081.1 6084.4 6095.4 34578.3 34678.1 34770.1 34770.8 35104.1 3313.0 3347.6 3355.9 3369.5 3371.1 27084.0 30991.2 31564.2 31608.0 31611.1 4622.6 4762.5 4795.7 4874.9 4927.2 198622.0 199366.0 200740.0 206908.0 207839.0 49699.3 50197.2 50352.2 50531.2 50851.7 52861.4 52865.5 52868.2 52873.7 52964.5 16805.4 16940.6 17016.9 17038.6 17073.7 14035.3 14050.2 14072.2 14082.7 14091.6 14740.9 14843.2 14878.5 14922.3 15009.8 5830.9 5958.2 5961.6 5972.4 6190.4 1046.8 1077.6 1078.7 1087.9 1110.6 23741.4 23825.6 23960.9 24079.2 24517.0 1179.9 1203.2 1208.4 1208.6 1211.5 12792.9 12807.5 12849.4 12935.4 12936.3 271492.0 272533.0 275171.0 275734.0 276543.0 51965.2 51989.7 52011.0 52288.7 52570.5 1466.3 1526.7 1527.1 1536.7 1560.6 23141.5 23502.4 23508.1 23656.9 23705.0 37260.0 37656.0 37694.8 37695.6 37723.8 227886.0 228861.0 229185.0 229289.0 229344.0 34942.3 36066.5 37060.6 38620.4 38908.0 46633.5 47452.3 47511.5 47704.5 48726.0 34761.3 35360.8 35560.0 35781.5 35853.0 33465.7 34217.5 34359.5 34881.7 34927.7 39975.0 40094.0 40327.8 40551.8 40617.8 33412.2 33612.5 33866.7 34024.1 34103.7 24645.0 25305.1 25730.4 25767.4 26273.6 09:05:51 INFO - PID 32614 | 09:05:51 INFO - PID 32614 | [#2] jquery.html Cycles:180 Average:39547.33 Median:2236.52 stddev:102174.72 (4568.5%) stddev-sans-first:102419.45 09:05:51 INFO - PID 32614 | Values: 576.2 581.7 586.8 588.6 597.9 22422.4 22985.7 23185.1 23321.2 23334.2 24826.0 26071.5 27823.4 27838.4 28016.0 5224.2 5293.4 5329.2 5333.9 5345.0 6145.1 6151.6 6163.9 6182.3 6182.5 4096.3 5743.2 6128.2 6158.6 6169.6 6113.5 6132.3 6154.6 6192.7 6208.4 5765.9 5785.4 5802.0 5802.5 5819.6 29902.6 30853.8 31045.7 31089.7 31315.5 2162.7 2210.2 2230.4 2242.6 2246.5 19064.6 19680.5 19711.3 19730.4 19762.0 2342.5 2401.1 2431.1 2438.9 2439.2 140734.0 144321.3 144589.0 144851.3 146874.0 15061.6 15297.7 15897.4 15902.5 16355.7 24608.3 24812.1 24821.1 24843.9 24865.1 10723.9 10733.0 10831.5 10904.2 11034.9 9923.7 9971.5 10119.1 10140.2 10187.0 9693.5 9742.5 9803.0 9816.3 9834.5 2689.0 2719.0 2758.7 2819.9 2827.2 1034.7 1062.7 1066.6 1075.1 1086.3 21520.8 21959.2 21964.2 22010.7 22147.7 1122.4 1132.2 1141.1 1150.6 1157.0 11656.2 11984.9 12241.4 12241.8 12267.0 581347.0 599926.0 605388.0 636661.0 638413.0 124181.4 127155.4 127917.0 129108.0 129710.0 1258.8 1281.0 1315.7 1316.5 1323.6 17967.0 19111.5 19112.7 19175.0 19503.0 57073.4 60497.7 60720.7 61391.0 64243.0 76961.0 77940.0 78794.6 78948.6 79224.6 15129.9 15267.5 15736.3 15742.8 15902.0 24983.1 25197.4 25419.6 25472.9 25812.5 17599.0 19030.5 19196.0 19207.4 19219.3 17276.7 17620.7 17636.5 17772.5 18385.0 20662.8 21471.9 21535.8 21595.8 21712.2 15029.8 15104.8 15436.3 15486.0 15515.3 20819.5 20881.9 20936.5 20947.3 21198.7 09:05:51 INFO - PID 32614 | 09:05:51 INFO - PID 32614 | [#3] mootools.html Cycles:180 Average:9729.51 Median:2674.67 stddev:6851.70 (256.2%) stddev-sans-first:6842.38 09:05:51 INFO - PID 32614 | Values: 1406.3 1472.7 1474.9 1480.6 1481.8 14657.4 15272.8 15315.3 15400.2 15402.2 14555.2 15017.1 15635.9 15703.7 15809.8 2725.0 2796.6 2812.3 2813.6 2814.9 2684.1 2773.9 2774.7 2776.8 2780.9 2679.5 2687.0 2753.1 2759.4 2792.9 2729.4 2761.1 2761.4 2763.1 2766.0 2669.9 2683.6 2688.4 2690.3 2694.9 14557.0 14901.7 14918.4 14929.8 14949.0 8062.5 8289.9 8332.8 8354.7 8355.6 5311.2 5325.1 5391.8 5410.7 5431.2 1933.5 1984.5 2001.6 2300.2 2441.6 26836.3 27449.9 27468.5 27489.9 27516.4 7559.5 7588.4 7664.7 7736.8 7749.3 20611.9 20624.3 20699.0 20739.8 20744.9 8113.4 8464.0 8568.2 8650.6 8677.8 7319.4 7592.5 7609.5 7624.0 7624.3 5484.2 5554.8 5594.2 5631.4 5648.2 1592.6 1600.6 1613.5 1628.4 1631.5 919.3 919.4 940.0 943.8 953.3 9221.9 9491.4 9615.4 9653.8 9668.0 1028.4 1047.6 1068.8 1072.3 1082.6 5543.4 5753.6 5806.4 5826.4 5839.1 20342.9 21418.6 21820.7 21848.8 21868.6 20356.9 21389.4 21590.2 21637.0 21639.9 11386.5 12133.8 12196.3 12239.5 12357.5 7821.3 8601.7 8668.0 8672.5 8719.3 18571.6 18699.8 19085.9 19149.8 19499.8 18906.2 19104.9 19896.1 20148.7 20427.9 12135.1 12546.7 12734.5 12769.8 12785.4 14010.6 14251.9 14308.9 14399.9 14450.3 11316.3 11353.9 11414.0 11478.7 11529.3 10766.5 11024.8 11035.7 11130.2 11498.5 10622.6 10843.8 10847.7 10868.3 10910.5 7580.8 7694.3 7763.0 7850.7 7864.3 7497.3 7648.8 7673.3 7740.7 7766.1 09:05:51 INFO - PID 32614 | 09:05:51 INFO - PID 32614 | [#4] prototype.html Cycles:180 Average:5551.57 Median:6116.15 stddev:1576.01 (25.8%) stddev-sans-first:1534.05 09:05:51 INFO - PID 32614 | Values: 494.9 516.0 524.3 535.7 535.7 6031.4 6108.8 6126.8 6141.2 6211.5 5849.5 6002.3 6003.4 6052.3 6080.0 4737.5 4804.9 4819.7 4838.3 4847.7 4793.0 4822.4 4841.7 4846.7 4875.1 4611.3 4760.9 4776.0 4783.2 4826.6 4736.7 4738.3 4768.9 4774.9 4785.5 4310.9 4319.3 4328.7 4347.9 4352.5 5968.2 5977.5 5980.9 6018.8 6046.4 5699.9 5725.5 5737.3 5755.3 5757.4 6524.6 6568.4 6571.8 6610.9 6624.7 4911.8 4929.1 4942.7 4944.3 4963.3 6828.6 6862.7 6886.8 6916.4 6922.6 5050.8 5089.8 5096.7 5111.3 5130.6 5093.5 5136.9 5163.5 5170.1 5179.6 5677.5 5683.1 5687.7 5722.5 5787.9 6534.8 6555.7 6599.3 6632.9 6684.5 1793.6 1809.5 1812.2 1818.9 1821.2 1156.6 1162.4 1238.7 1262.1 1276.4 6028.4 6078.8 6123.5 6160.9 6193.9 6646.2 6676.3 6677.9 6713.8 6717.2 6079.9 6144.9 6184.8 6269.2 6278.9 3513.3 3548.1 3552.5 3557.1 3569.1 6880.1 6904.2 6936.4 6939.4 6952.0 6802.7 6819.6 6856.4 6878.8 6930.8 6858.5 6918.8 6948.0 6963.3 7013.6 6599.2 6623.7 6627.8 6699.3 6751.6 6440.2 6483.2 6621.2 6624.7 6638.8 6832.4 6839.9 6989.1 7002.2 7012.2 5373.4 5448.9 5452.2 5455.2 5469.3 6629.6 6722.8 6724.9 6763.7 6764.6 6471.4 6512.9 6561.7 6598.1 6616.1 6513.9 6526.2 6527.2 6529.4 6600.1 6389.6 6493.4 6507.9 6509.4 6614.1 6063.6 6510.7 6546.1 6546.8 6620.5 6292.5 6357.5 6367.5 6393.3 6426.8 09:05:51 INFO - PID 32614 | 09:05:51 INFO - PID 32614 | [#5] yui.html Cycles:180 Average:23940.15 Median:18672.17 stddev:33067.34 (177.1%) stddev-sans-first:33114.98 09:05:51 INFO - PID 32614 | Values: 935.0 938.6 951.3 957.7 964.1 16944.9 17722.0 17737.3 17841.6 17847.6 19095.5 20915.4 21013.4 21075.7 21144.0 1042.6 1066.1 1067.3 1069.9 1071.4 1081.1 1085.9 1086.0 1086.4 1091.6 1010.0 1112.2 1123.1 1141.4 1141.8 1104.4 1109.6 1113.2 1114.6 1116.7 801.7 803.4 805.8 809.4 811.0 18696.4 18837.2 18856.3 19123.2 19588.3 19932.8 20146.4 20319.9 20704.2 20707.7 15353.8 15527.0 15794.3 15820.4 15835.3 3431.5 3434.3 3442.9 3457.4 3467.8 116050.4 116732.4 119392.4 122888.0 123295.0 15371.5 15571.8 15618.0 15620.8 15644.5 28921.3 30179.7 30249.7 30348.7 30544.4 8474.7 8535.4 8602.1 8807.0 8898.4 4186.9 4306.4 4326.7 4331.6 4333.5 5375.8 5380.7 5448.7 5477.6 5529.1 950.1 985.1 990.9 1109.6 1125.8 714.5 719.9 736.8 740.3 759.1 11324.8 11483.7 11635.6 11641.9 12084.9 708.2 736.7 737.2 741.6 745.4 5327.5 5546.7 5573.9 5631.7 5652.9 110705.0 112637.4 116422.0 116454.0 116888.4 101831.0 105725.0 105896.9 109990.5 111043.0 84901.6 88155.0 93272.5 93470.0 97267.5 12397.2 12591.0 12914.5 12946.0 12974.9 39830.0 43425.6 43876.1 45880.3 46317.3 54928.7 73611.6 73938.0 79239.0 79296.0 15097.2 16009.8 16048.9 16181.8 16234.6 19090.9 19130.4 19310.1 19331.7 19544.8 17319.7 17966.7 18141.4 18460.1 18776.7 17249.4 18134.4 18344.6 18366.7 18647.9 15754.8 15960.8 16189.7 16260.6 16290.9 11579.6 12062.3 12532.9 12862.5 12992.2 13661.6 13678.8 13701.1 13787.3 14422.2 09:05:51 INFO - PID 32614 | -------- Summary: end -------- 09:05:51 INFO - PID 32614 | 09:05:51 INFO - TEST-INFO | 32614: exit 0 09:05:51 INFO - TEST-OK | dromaeo_css | took 1107874ms 09:05:51 INFO - TEST-START | kraken 09:05:51 INFO - Initialising browser for kraken test... 09:05:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56996/getInfo.html -profile /tmp/tmpMAlfya/profile 09:05:51 INFO - TEST-INFO | started process 558 (/builds/slave/test/build/application/firefox/firefox http://localhost:56996/getInfo.html) 09:05:57 INFO - TEST-INFO | 558: exit 0 09:05:57 INFO - Browser initialized. 09:05:57 INFO - Running cycle 1/1 for kraken test... 09:05:57 INFO - TEST-INFO | started process 769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMAlfya/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:09 INFO - PID 769 | RSS: Main: 160456704 09:06:09 INFO - PID 769 | 09:06:11 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56996/tests/kraken/driver.html?testName=audio-beat-detection) 09:06:12 INFO - PID 769 | RSS: Main: 166526976 09:06:12 INFO - PID 769 | 09:06:14 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56996/tests/kraken/driver.html?testName=audio-dft) 09:06:15 INFO - PID 769 | RSS: Main: 166748160 09:06:15 INFO - PID 769 | 09:06:18 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56996/tests/kraken/driver.html?testName=audio-fft) 09:06:19 INFO - PID 769 | RSS: Main: 160600064 09:06:19 INFO - PID 769 | 09:06:21 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56996/tests/kraken/driver.html?testName=audio-oscillator) 09:06:21 INFO - PID 769 | RSS: Main: 161947648 09:06:21 INFO - PID 769 | 09:06:23 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56996/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:06:24 INFO - PID 769 | RSS: Main: 161755136 09:06:24 INFO - PID 769 | 09:06:27 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56996/tests/kraken/driver.html?testName=imaging-darkroom) 09:06:27 INFO - PID 769 | RSS: Main: 161665024 09:06:27 INFO - PID 769 | 09:06:31 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56996/tests/kraken/driver.html?testName=imaging-desaturate) 09:06:31 INFO - PID 769 | RSS: Main: 165240832 09:06:31 INFO - PID 769 | 09:06:34 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56996/tests/kraken/driver.html?testName=json-parse-financial) 09:06:35 INFO - PID 769 | RSS: Main: 166649856 09:06:35 INFO - PID 769 | 09:06:36 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56996/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:06:37 INFO - PID 769 | RSS: Main: 166584320 09:06:37 INFO - PID 769 | 09:06:38 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56996/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:06:39 INFO - PID 769 | RSS: Main: 166531072 09:06:39 INFO - PID 769 | 09:06:41 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56996/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:06:42 INFO - PID 769 | RSS: Main: 166907904 09:06:42 INFO - PID 769 | 09:06:44 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:06:45 INFO - PID 769 | RSS: Main: 166375424 09:06:45 INFO - PID 769 | 09:06:48 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:06:48 INFO - PID 769 | RSS: Main: 166559744 09:06:48 INFO - PID 769 | 09:06:50 INFO - PID 769 | Cycle 1(1): loaded http://localhost:56996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56996/tests/kraken/driver.html?testName=ai-astar) 09:06:50 INFO - PID 769 | RSS: Main: 168189952 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | __start_tp_report 09:06:50 INFO - PID 769 | _x_x_mozilla_page_load 09:06:50 INFO - PID 769 | _x_x_mozilla_page_load_details 09:06:50 INFO - PID 769 | |i|pagename|runs| 09:06:50 INFO - PID 769 | |0;ai-astar;98;106;107;106;109;107;107;108;109;109 09:06:50 INFO - PID 769 | |1;audio-beat-detection;147;118;152;166;117;142;152;117;167;116 09:06:50 INFO - PID 769 | |2;audio-dft;161;162;162;162;165;170;162;161;163;164 09:06:50 INFO - PID 769 | |3;audio-fft;74;74;73;74;79;74;75;156;76;74 09:06:50 INFO - PID 769 | |4;audio-oscillator;79;80;145;79;80;80;122;81;82;130 09:06:50 INFO - PID 769 | |5;imaging-gaussian-blur;114;114;114;114;113;114;114;114;114;113 09:06:50 INFO - PID 769 | |6;imaging-darkroom;147;147;147;148;148;147;148;148;147;149 09:06:50 INFO - PID 769 | |7;imaging-desaturate;93;94;94;95;94;93;94;94;94;95 09:06:50 INFO - PID 769 | |8;json-parse-financial;46;48;46;47;47;48;50;51;47;54 09:06:50 INFO - PID 769 | |9;json-stringify-tinderbox;54;55;53;55;54;54;53;53;54;54 09:06:50 INFO - PID 769 | |10;stanford-crypto-aes;74;85;75;80;74;76;75;73;74;77 09:06:50 INFO - PID 769 | |11;stanford-crypto-ccm;127;144;119;120;128;127;119;120;119;145 09:06:50 INFO - PID 769 | |12;stanford-crypto-pbkdf2;172;169;173;178;176;171;179;179;171;171 09:06:50 INFO - PID 769 | |13;stanford-crypto-sha256-iterative;63;66;64;65;61;65;62;62;62;61 09:06:50 INFO - PID 769 | __end_tp_report 09:06:50 INFO - PID 769 | __start_cc_report 09:06:50 INFO - PID 769 | _x_x_mozilla_cycle_collect,829 09:06:50 INFO - PID 769 | __end_cc_report 09:06:50 INFO - PID 769 | __startTimestamp1499962010808__endTimestamp 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | ------- Summary: start ------- 09:06:50 INFO - PID 769 | Number of tests: 14 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#0] ai-astar Cycles:10 Average:106.60 Median:108.50 stddev:3.24 (3.0%) stddev-sans-first:1.24 09:06:50 INFO - PID 769 | Values: 98.0 106.0 107.0 106.0 109.0 107.0 107.0 108.0 109.0 109.0 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:149.50 stddev:20.71 (13.9%) stddev-sans-first:21.78 09:06:50 INFO - PID 769 | Values: 147.0 118.0 152.0 166.0 117.0 142.0 152.0 117.0 167.0 116.0 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:2.70 (1.7%) stddev-sans-first:2.74 09:06:50 INFO - PID 769 | Values: 161.0 162.0 162.0 162.0 165.0 170.0 162.0 161.0 163.0 164.0 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#3] audio-fft Cycles:10 Average:82.90 Median:74.00 stddev:25.74 (34.8%) stddev-sans-first:27.10 09:06:50 INFO - PID 769 | Values: 74.0 74.0 73.0 74.0 79.0 74.0 75.0 156.0 76.0 74.0 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:80.00 stddev:25.82 (32.3%) stddev-sans-first:26.66 09:06:50 INFO - PID 769 | Values: 79.0 80.0 145.0 79.0 80.0 80.0 122.0 81.0 82.0 130.0 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:06:50 INFO - PID 769 | Values: 114.0 114.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 113.0 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 09:06:50 INFO - PID 769 | Values: 147.0 147.0 147.0 148.0 148.0 147.0 148.0 148.0 147.0 149.0 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 09:06:50 INFO - PID 769 | Values: 93.0 94.0 94.0 95.0 94.0 93.0 94.0 94.0 94.0 95.0 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#8] json-parse-financial Cycles:10 Average:48.40 Median:48.00 stddev:2.55 (5.3%) stddev-sans-first:2.55 09:06:50 INFO - PID 769 | Values: 46.0 48.0 46.0 47.0 47.0 48.0 50.0 51.0 47.0 54.0 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#9] json-stringify-tinderbox Cycles:10 Average:53.90 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 09:06:50 INFO - PID 769 | Values: 54.0 55.0 53.0 55.0 54.0 54.0 53.0 53.0 54.0 54.0 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.50 stddev:3.65 (4.8%) stddev-sans-first:3.78 09:06:50 INFO - PID 769 | Values: 74.0 85.0 75.0 80.0 74.0 76.0 75.0 73.0 74.0 77.0 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:127.00 stddev:10.02 (7.9%) stddev-sans-first:10.63 09:06:50 INFO - PID 769 | Values: 127.0 144.0 119.0 120.0 128.0 127.0 119.0 120.0 119.0 145.0 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.50 stddev:3.75 (2.2%) stddev-sans-first:3.92 09:06:50 INFO - PID 769 | Values: 172.0 169.0 173.0 178.0 176.0 171.0 179.0 179.0 171.0 171.0 09:06:50 INFO - PID 769 | 09:06:50 INFO - PID 769 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.79 (2.8%) stddev-sans-first:1.90 09:06:50 INFO - PID 769 | Values: 63.0 66.0 64.0 65.0 61.0 65.0 62.0 62.0 62.0 61.0 09:06:50 INFO - PID 769 | -------- Summary: end -------- 09:06:50 INFO - PID 769 | 09:06:51 INFO - PID 769 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:06:51 INFO - TEST-INFO | 769: exit 0 09:06:51 INFO - TEST-OK | kraken | took 59529ms 09:06:51 INFO - SUITE-END | took 1167s 09:06:51 INFO - Completed test suite (00:19:27) 09:06:51 INFO - javascript benchmark 09:06:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8685.63404315322, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3297.637259901412, 3361.5293858859754, 3367.461206207006, 3369.6461871503493, 3381.951595005548, 6078.726457309421, 6141.1095391168255, 6172.0, 6193.225846769154, 6243.594166379182, 6032.577719559622, 6070.696465176746, 6097.451229389354, 6117.2965109012475, 6122.265328160627, 5318.9202161967605, 5336.493033161843, 5337.492938170887, 5380.784768609251, 5382.838514844561, 5410.215518749779, 5458.754356053987, 5470.753816078286, 5470.972645136789, 5481.095619222823, 5460.34475862897, 5473.480019398171, 5475.863103422406, 5478.0, 5480.835574932758, 5453.890922181554, 5458.099413596752, 5465.289512363387, 5468.863278418052, 5469.972650136764, 5364.409914909357, 5385.407605163429, 5438.211459338374, 5458.727063646802, 5526.778928842841, 5994.790182343597, 6097.603655762361, 6124.877502449926, 6140.631562106288, 6140.969295153541, 6478.481721462272, 6608.603483790988, 6669.0, 6694.732210711566, 6694.93305066948, 6603.768868089642, 6613.966930165367, 6630.403263706289, 6643.6346000969925, 6646.966765166143, 6128.96935515324, 6149.569530132892, 6155.199824022893, 6238.532110091716, 6248.87502249957, 6776.9322306777285, 6782.683189225772, 6784.626845523445, 6868.244493105754, 6878.209005964378, 6527.967360163168, 6534.117894084333, 6548.27968923418, 6592.274849766522, 6597.901031484532, 6495.870082598416, 6573.046908198285, 6593.307702691149, 6595.736170553124, 6615.801525954229, 6433.646149461731, 6533.673316334164, 6534.444572211415, 6562.606243625398, 6571.769988050395, 5776.624519406309, 6585.209774826955, 6638.634875081821, 6715.56348837324, 6729.05793188954, 4995.875103122451, 5009.173486374781, 5063.088644044034, 5076.0863044652315, 5079.6698214615935, 4437.06821567468, 4495.325701144789, 4507.121111383249, 4513.593776560126, 4516.977415112903, 6107.144999700045, 6160.353162917919, 6210.099535567318, 6221.0, 6247.406496382836, 6582.045603387578, 6589.703463344161, 6592.406683398517, 6592.439642630334, 6602.537822352389, 6170.629762214281, 6181.134641150243, 6181.320054793969, 6185.072239164071, 6193.442590166816, 5613.214150019001, 5622.353429355595, 5649.237352957298, 5651.265335506358, 5686.346070201897, 6905.896411553831, 6928.16861976566, 6949.548279361826, 6988.0, 6999.300069993062, 6654.600723956578, 6656.267810540837, 6656.567323123982, 6744.325567443217, 6783.93216067833, 6744.325567443217, 6881.967704844314, 6921.7231310747, 6946.930530694628, 6957.826054348682, 6479.643619600967, 6481.546291759531, 6495.545311828127, 6515.6742162892615, 6529.085927970183, 5791.6007405379505, 6668.099806526251, 6680.866382672417, 6737.629430381376, 6738.494612903954, 6437.935620643921, 6441.806745797634, 6453.903191452038, 6512.120863683342, 6519.576227545194, 6338.58799178052, 6457.67711614408, 6506.41442270198, 6543.967280163759, 6546.083548303146, 6364.363563643598, 6374.362563743589, 6374.713137908712, 6384.170057892445, 6385.648789316632, 6357.364263573606, 6395.968020159869, 6406.903896441464, 6420.293767685457, 6424.807255782334, 5343.7862485500145, 6252.3122456530655, 6253.218347706536, 6368.115449575847, 6423.486121110206], "value": 6031.931822129073, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.7614153824621, 840.9075001749802, 864.2610567964391, 891.0599317719802, 894.727108231989, 41378.58621413785, 42035.73892783218, 42088.78955605225, 42202.57797422029, 42379.364309535384, 38657.0, 38742.418863716994, 38747.22505549887, 38763.224735505275, 38827.61172388275, 6561.868762624745, 6668.599884006975, 6670.866582668344, 6687.598744075347, 6691.3308669133185, 6645.501587380942, 6713.664316784141, 6733.192016957972, 6737.225219099817, 6738.393544580987, 6705.631190284533, 6723.394894459498, 6739.191297044362, 6747.8650426991435, 6749.223839258499, 6673.199216094075, 6692.196936367618, 6709.630970296607, 6717.261101278856, 6747.5276730628875, 6032.9698351508405, 6059.454649081604, 6081.087836824468, 6084.391560843925, 6095.359987201368, 34578.30843383118, 34678.133046673785, 34770.13074673128, 34770.82614586936, 35104.12239694002, 3312.950305745416, 3347.598288205407, 3355.9328813423595, 3369.4608862582113, 3371.0729549373873, 27084.0, 30991.22521936947, 31564.210894727585, 31608.0, 31611.05166844998, 4622.6301895848255, 4762.476127625993, 4795.688280261772, 4874.8537543873745, 4927.1870141426625, 198622.00688996608, 199366.0, 200740.0, 206908.0, 207839.0, 49699.254511182364, 50197.24704129441, 50352.24471632928, 50531.24203136956, 50851.7457412718, 52861.41415757533, 52865.47134528605, 52868.20697689538, 52873.7356313216, 52964.470355295955, 16805.41181058657, 16940.57648558796, 17016.914915425343, 17038.57403564921, 17073.7438938416, 14035.298235088205, 14050.156990580597, 14072.226027568377, 14082.71834563303, 14091.647708807363, 14740.926295368668, 14843.183624900734, 14878.479253226302, 14922.328495217742, 15009.849901500846, 5830.854228644318, 5958.165856780054, 5961.552883533753, 5972.40275972408, 6190.350013248544, 1046.842973553973, 1077.6012875236213, 1078.7464945737745, 1087.9020888119949, 1110.622388387952, 23741.406464838517, 23825.642615360783, 23960.88019559926, 24079.157229496883, 24517.0, 1179.8643156036994, 1203.2479700187382, 1208.383724300613, 1208.64949164743, 1211.5093387178206, 12792.872071279355, 12807.487700491876, 12849.357532123357, 12935.353232338346, 12936.288504132175, 271492.0, 272533.0, 275171.0, 275734.0, 276543.0, 51965.22052169221, 51989.7400512995, 52011.0, 52288.73855630773, 52570.47429525732, 1466.3254902744643, 1526.7099251142247, 1527.0608575726071, 1536.7387544117528, 1560.6020464781634, 23141.53716925686, 23502.412439689146, 23508.05967761339, 23656.881715591313, 23705.0, 37260.0, 37656.0, 37694.8115259422, 37695.623043769214, 37723.81138094292, 227886.0, 228861.0, 229185.0, 229289.0, 229344.0, 34942.301153977285, 36066.45900311445, 37060.62939370572, 38620.420693689055, 38908.0, 46633.53366466292, 47452.28821567748, 47511.52488475071, 47704.52295477001, 48726.0, 34761.304773903874, 35360.82319588386, 35560.0, 35781.46327805033, 35853.0, 33465.66534334723, 34217.48673769945, 34359.4846077304, 34881.65118348886, 34927.65072349244, 39975.0, 40094.0, 40327.79836100918, 40551.797241013606, 40617.796911015255, 33412.1646958828, 33612.495812562345, 33866.66133338635, 34024.1493962643, 34103.65896341104, 24645.0, 25305.114320998677, 25730.35674108162, 25767.355816104748, 26273.605895911194], "value": 17390.529738053683, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.194237064191, 581.741125199286, 586.8415527807491, 588.5850475414833, 597.8624916269258, 22422.439439014033, 22985.655215171766, 23185.072597096096, 23321.183758568455, 23334.183303584377, 24826.0, 26071.47857042858, 27823.443531129415, 27838.443231135367, 28016.0, 5224.1902505111575, 5293.364796224459, 5329.173978033411, 5333.866653333678, 5345.037893179227, 6145.108959200913, 6151.630902145863, 6163.907541386883, 6182.319944806068, 6182.505399568024, 4096.32410652242, 5743.167240750089, 6128.20333356663, 6158.599691020092, 6169.568130230886, 6113.480354169901, 6132.325444201112, 6154.599951003215, 6192.721327540272, 6208.441240288395, 5765.855853603652, 5785.4214578541805, 5802.042662960606, 5802.535797136219, 5819.592628516006, 29902.551461728093, 30853.8457307712, 31045.689543104505, 31089.689103108907, 31315.53026704601, 2162.6647869580083, 2210.160139147114, 2230.431240033781, 2242.618754811686, 2246.4945387287894, 19064.61870762577, 19680.50798730029, 19711.310104146287, 19730.408087757245, 19762.0, 2342.543204075206, 2401.11158871217, 2431.1004928176512, 2438.8536687798787, 2439.195065628356, 140734.0, 144321.2783936084, 144589.0, 144851.27574362166, 146874.0, 15061.623459413384, 15297.694046119015, 15897.364105435885, 15902.522924312058, 16355.672886542203, 24608.261752147464, 24812.14660314087, 24821.1312604058, 24843.87578062098, 24865.129720459696, 10723.94638026805, 10733.0, 10831.512581933832, 10904.236703430684, 11034.944825275823, 9923.65267215644, 9971.501424928725, 10119.13987311072, 10140.188784897191, 10187.0, 9693.51532423376, 9742.464164471023, 9802.950985245028, 9816.312858099864, 9834.459104749165, 2689.031948498539, 2718.993972230248, 2758.668959724846, 2819.915402537927, 2827.180117765866, 1034.6844212515255, 1062.7290041039485, 1066.6053560182781, 1075.1022895882027, 1086.3264775838873, 21520.81635510062, 21959.231426899983, 21964.231251906105, 22010.669839952414, 22147.667784983238, 1122.4331712485143, 1132.224426268009, 1141.1270378160714, 1150.5972909481782, 1156.9595064172713, 11656.242344247597, 11984.940075299743, 12241.387930603434, 12241.816372754416, 12266.957308628867, 581347.0, 599926.0, 605388.0, 636661.0, 638413.0, 124181.37909310576, 127155.36422318015, 127917.0, 129108.0, 129710.0, 1258.754542864151, 1281.0, 1315.7434300311538, 1316.4799904037852, 1323.602919124278, 17967.0, 19111.522211944255, 19112.713309300092, 19175.041247937268, 19503.0, 57073.42926570847, 60497.69751151216, 60720.696396517735, 61391.0, 64243.0, 76961.0, 77940.0, 78794.60602697179, 78948.60525697334, 79224.60387698024, 15129.924350378178, 15267.541973740805, 15736.291866866248, 15742.842571574138, 15901.96637218577, 24983.125590604242, 25197.370065748502, 25419.61870571906, 25472.872635636704, 25812.483750325264, 17599.0, 19030.524236893634, 19196.0, 19207.423777286705, 19219.32732354361, 17276.65446691034, 17620.735688964418, 17636.470905872844, 17772.48933840638, 18385.0, 20662.793372066688, 21471.8926405367, 21535.784642154005, 21595.784042159376, 21712.240071597418, 15029.849701502844, 15104.848951510345, 15436.30536625877, 15486.0, 15515.301811418287, 20819.479513012295, 20881.89559052195, 20936.47658808481, 20947.266845660328, 21198.682019769407], "value": 12540.061681897598, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.2617126008845, 1472.6539263273132, 1474.9336279867405, 1480.6076389756715, 1481.7777333399995, 14657.413703451863, 15272.847271527282, 15315.310811013504, 15400.229988500558, 15402.152881591523, 14555.199464029474, 15017.098974061564, 15635.921820390911, 15703.685926281467, 15809.841901580981, 2724.972750272502, 2796.5525515917457, 2812.268810109376, 2813.6342275504157, 2814.9014784482547, 2684.141074856047, 2773.9306517337027, 2774.680911695151, 2776.7500924916753, 2780.8748606312765, 2679.490896729625, 2687.0, 2753.105240796739, 2759.4205216904475, 2792.9301767455872, 2729.3858881751644, 2761.130243973142, 2761.3786897948003, 2763.0605594098, 2766.0457142285877, 2669.853158076305, 2683.5840444731098, 2688.435428559985, 2690.3005218643293, 2694.90567830125, 14557.0, 14901.701965960729, 14918.403263869432, 14929.776053359208, 14949.0, 8062.475939063942, 8289.875651865166, 8332.750017499484, 8354.707585234488, 8355.623996920152, 5311.2298716686255, 5325.094733895247, 5391.757370918318, 5410.674384775716, 5431.185322201662, 1933.5069557262948, 1984.474114359696, 2001.5996800639784, 2300.2064287820676, 2441.59713647248, 26836.329091772666, 27449.86275068612, 27468.450630987267, 27489.862550687118, 27516.449671006467, 7559.470837041465, 7588.392928565701, 7664.6934122635585, 7736.806579835436, 7749.341305988942, 20611.896940515202, 20624.27815026467, 20699.0, 20739.79260207409, 20744.896275518528, 8113.391495637851, 8463.957680211559, 8568.228859402683, 8650.610722517502, 8677.783055423664, 7319.4144468443465, 7592.468527203043, 7609.543427394374, 7624.046994125734, 7624.27569380919, 5484.238662439091, 5554.750036248379, 5594.24477695514, 5631.436856314336, 5648.209250704905, 1592.562045437514, 1600.5598460423478, 1613.4514265149905, 1628.4056319443318, 1631.5023917704978, 919.2599957034518, 919.3564504846634, 939.9671011514564, 943.7593413679605, 953.2659851914126, 9221.90778092224, 9491.430514169171, 9615.375000624937, 9653.758656033515, 9668.033196680275, 1028.3624153025023, 1047.6228557719214, 1068.8022715797601, 1072.3057569040898, 1082.5994382078682, 5543.417941116125, 5753.59724819267, 5806.4193580641595, 5826.359100498942, 5839.0949402842625, 20342.898285508476, 21418.57162856734, 21820.672689909665, 21848.781512184993, 21868.562628747655, 20356.898215509125, 21389.395795315413, 21590.244341447975, 21637.0, 21639.891800540896, 11386.544538218379, 12133.817992730115, 12196.329201893803, 12239.510419583296, 12357.505699772088, 7821.256980586835, 8601.741947741577, 8668.0, 8672.523011234443, 8719.258862996716, 18571.628567428845, 18699.813001869807, 19085.904570477058, 19149.80850191536, 19499.805001950368, 18906.243750249836, 19104.904475477535, 19896.104675289356, 20148.697769533177, 20427.897860510602, 12135.08986825974, 12546.686332841751, 12734.474776500387, 12769.8084528734, 12785.36073196355, 14010.64973375633, 14251.928740356232, 14308.928455357656, 14399.92800036035, 14450.277486125442, 11316.321020738782, 11353.943230283796, 11413.97274245322, 11478.655640330804, 11529.308241505536, 10766.461676915966, 11024.779504410028, 11035.668929932115, 11130.220884538005, 11498.54005839757, 10622.575096996343, 10843.783124337628, 10847.728806779895, 10868.347899126078, 10910.509027093958, 7580.772576822704, 7694.307512323918, 7763.0, 7850.685972561262, 7864.2922137007945, 7497.2877576630135, 7648.80877978055, 7673.34776544, 7740.729074482591, 7766.068071831416], "value": 6998.525456350926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.9356583644126, 515.9871003224919, 524.2686452398904, 535.6973310079802, 535.7214248590733, 6031.427014433632, 6108.755649774009, 6126.846828829282, 6141.170941922839, 6211.472024877885, 5849.502792262663, 6002.3097343805475, 6003.358522250207, 6052.273727152737, 6080.023992202541, 4737.478877323491, 4804.927926081103, 4819.734914579697, 4838.274258861164, 4847.684900481458, 4792.993471371016, 4822.421309442854, 4841.709497430148, 4846.684965477232, 4875.146849301375, 4611.308303754447, 4760.880977975544, 4775.976120119394, 4783.162946484351, 4826.638002149835, 4736.668433209677, 4738.289256611519, 4768.9284660729945, 4774.904501909977, 4785.497522760095, 4310.892227694301, 4319.308910574325, 4328.7402755834755, 4347.891302717458, 4352.521222665504, 5968.1644569760265, 5977.491913187384, 5980.880382392371, 6018.759249630053, 6046.3651316612, 5699.886002279931, 5725.541956643458, 5737.254156959611, 5755.3381361143165, 5757.366689664133, 6524.608523488606, 6568.423578341211, 6571.835704107388, 6610.900836487456, 6624.73501059957, 4911.803527858881, 4929.137400954819, 4942.728149951751, 4944.283078953532, 4963.305137280783, 6828.624425656587, 6862.691178896962, 6886.829239029377, 6916.432272021021, 6922.550034247758, 5050.823221187241, 5089.770960306795, 5096.694198348111, 5111.309973153577, 5130.640855140105, 5093.490650934951, 5136.897262054738, 5163.457836927144, 5170.095233334151, 5179.559737422286, 5677.545796336283, 5683.090705487185, 5687.744051517691, 5722.513586345124, 5787.88424231513, 6534.8366290843105, 6555.672216389162, 6599.307072757388, 6632.9336706633285, 6684.4959884026675, 1793.5516120969758, 1809.5476130967259, 1812.2479171143827, 1818.8908665480114, 1821.1895706410521, 1156.6240971684235, 1162.424599823076, 1238.7027113492877, 1262.1480500662017, 1276.431987765454, 6028.3971602839365, 6078.787242446581, 6123.540734444934, 6160.8767824643255, 6193.938060619426, 6646.202455705346, 6676.26561078281, 6677.866442671119, 6713.832154196087, 6717.219936716774, 6079.878402432015, 6144.907826382608, 6184.752609895644, 6269.247690277105, 6278.937210627927, 3513.262214934892, 3548.1307079765625, 3552.4848896909803, 3557.128503516655, 3569.1434055826417, 6880.139982502187, 6904.240533541307, 6936.410405115622, 6939.375456208965, 6952.0, 6802.741492823744, 6819.5908245505425, 6856.417204537571, 6878.759243426456, 6930.757423490154, 6858.5199036067, 6918.827029324307, 6948.0, 6963.338482844223, 7013.6142512161305, 6599.241087274832, 6623.6688165592495, 6627.834304142242, 6699.263081060982, 6751.594904305757, 6440.227172739301, 6483.189601299838, 6621.172353455818, 6624.735010599522, 6638.751199232592, 6832.385085342343, 6839.93160068393, 6989.1129395062035, 7002.229754727078, 7012.2286548478605, 5373.35519737634, 5448.891022179455, 5452.209429632601, 5455.18172274162, 5469.316335458067, 6629.602223866584, 6722.798316050526, 6724.865502690017, 6763.729450822108, 6764.594124352555, 6471.417572418505, 6512.902306465312, 6561.671916404256, 6598.1422415085735, 6616.106825578485, 6513.934860651333, 6526.151600291932, 6527.184101987252, 6529.412352888263, 6600.1089852869245, 6389.584676995981, 6493.415592596689, 6507.934920650733, 6509.446697030806, 6614.140161779131, 6063.605865618721, 6510.688705509476, 6546.083548303337, 6546.803595892131, 6620.536562440583, 6292.4651404629285, 6357.4596159326975, 6367.458766004941, 6393.29673735898, 6426.839329016812], "value": 5089.803908765298, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [934.967276145335, 938.643315540095, 951.3103000324761, 957.6648173139403, 964.0504103458095, 16944.91527542362, 17722.0, 17737.290508379665, 17841.553961150978, 17847.64304713908, 19095.52261193471, 20915.37253882382, 21013.36959891202, 21075.68386474204, 21144.048517816696, 1042.6350777227947, 1066.077842666092, 1067.3382502848244, 1069.8823129455754, 1071.3946620159625, 1081.086481922774, 1085.8588383510173, 1086.0497065068066, 1086.4187659602114, 1091.6397588795678, 1010.0455069958891, 1112.227002233448, 1123.1183520936067, 1141.4064686363085, 1141.8116010858198, 1104.4312179227704, 1109.6005438042298, 1113.1595645287837, 1114.5876025870439, 1116.6929094499037, 801.6953557648114, 803.3533005930224, 805.7864665863551, 809.4253080312926, 811.0348685064813, 18696.439106826816, 18837.24651013958, 18856.30293273612, 19123.23507059716, 19588.314408995615, 19932.80067199324, 20146.395608131632, 20319.898400507904, 20704.171833126657, 20707.689384659243, 15353.769693454607, 15527.0, 15794.289256983348, 15820.446284379992, 15835.287412066486, 3431.5367425397503, 3434.295969326282, 3442.9483557746403, 3457.4122399191947, 3467.826608669556, 116050.41974790157, 116732.41633791776, 119392.40303798426, 122888.0, 123295.0, 15371.538853834403, 15571.844281557265, 15618.0, 15620.843791562167, 15644.452444164628, 28921.276968075967, 30179.698203017688, 30249.697503025127, 30348.696513034585, 30544.389112217632, 8474.74575762728, 8535.402521823413, 8602.139786021473, 8807.0, 8898.42160259581, 4186.937195942063, 4306.418633484503, 4326.6754993375625, 4331.610155085994, 4333.544977777351, 5375.838724838261, 5380.7309634518115, 5448.700321482277, 5477.643953143033, 5529.060059789846, 950.0784239288017, 985.0937137833067, 990.8662330585279, 1109.5506319940437, 1125.8254970479588, 714.4534431160166, 719.9424046076301, 736.7642354446525, 740.2523451314104, 759.1421693486325, 11324.773504529863, 11483.655490335137, 11635.564215943374, 11641.88358116425, 12084.879151208552, 708.2032713197652, 736.7053178728552, 737.1927739125649, 741.6365980669433, 745.4409193105171, 5327.549327309481, 5546.694931778791, 5573.888522229614, 5631.7184140793615, 5652.85867853307, 110705.0, 112637.43681281542, 116422.0, 116454.0, 116888.41555792166, 101831.0, 105725.0, 105896.94103059024, 109990.45004775086, 111043.0, 84901.57549212337, 88154.99999999872, 93272.53363733138, 93470.0, 97267.51366243266, 12397.194182378116, 12591.0, 12914.547990820276, 12946.0, 12974.870251297367, 39830.0, 43425.56574434342, 43876.12247755091, 45880.31179532243, 46317.305240422094, 54928.72535637296, 73611.63194183995, 73938.0, 79239.0, 79296.0, 15097.169655669044, 16009.839901600835, 16048.919755401148, 16181.838181618034, 16234.594135146715, 19090.904545477184, 19130.426087217405, 19310.13104410333, 19331.710024349366, 19544.80455195487, 17319.7402038967, 17966.730499042787, 18141.365052223107, 18460.07699614987, 18776.7183492245, 17249.39627113045, 18134.365297214536, 18344.633107338046, 18366.72449913279, 18647.90676046611, 15754.842451575338, 15960.840391596399, 16189.67620647557, 16260.593485162966, 16290.918545407198, 11579.594714184963, 12062.336571488653, 12532.937335313265, 12862.485500579873, 12992.220466771645, 13661.590152295446, 13678.794818077937, 13701.109427887155, 13787.310634468437, 14422.206778626856], "value": 9162.337498121944, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1485.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 107.0, 106.0, 109.0, 107.0, 107.0, 108.0, 109.0, 109.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 152.0, 166.0, 117.0, 142.0, 152.0, 117.0, 167.0, 116.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 165.0, 170.0, 162.0, 161.0, 163.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 74.0, 79.0, 74.0, 75.0, 156.0, 76.0, 74.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 145.0, 79.0, 80.0, 80.0, 122.0, 81.0, 82.0, 130.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 149.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 95.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 48.0, 46.0, 47.0, 47.0, 48.0, 50.0, 51.0, 47.0, 54.0], "value": 48.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 55.0, 54.0, 54.0, 53.0, 53.0, 54.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 85.0, 75.0, 80.0, 74.0, 76.0, 75.0, 73.0, 74.0, 77.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 144.0, 119.0, 120.0, 128.0, 127.0, 119.0, 120.0, 119.0, 145.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 173.0, 178.0, 176.0, 171.0, 179.0, 179.0, 171.0, 171.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 65.0, 61.0, 65.0, 62.0, 62.0, 62.0, 61.0], "value": 63.1, "unit": "score"}]}]} 09:06:52 INFO - Return code: 0 09:06:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:06:52 INFO - # TBPL SUCCESS # 09:06:52 INFO - Running post-action listener: _package_coverage_data 09:06:52 INFO - Running post-action listener: _resource_record_post_action 09:06:52 INFO - [mozharness: 2017-07-13 16:06:52.091227Z] Finished run-tests step (success) 09:06:52 INFO - Running post-run listener: _resource_record_post_run 09:06:52 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 431005696; Read time: 180; Write time: 306644 09:06:52 INFO - TinderboxPrint: CPU usage
13.0% 09:06:52 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 180 09:06:52 INFO - TinderboxPrint: I/O write bytes / time
431,005,696 / 306,644 09:06:52 INFO - TinderboxPrint: CPU idle
8,224.4 (87.0%) 09:06:52 INFO - TinderboxPrint: CPU user
1,186.0 (12.5%) 09:06:52 INFO - TinderboxPrint: Swap in / out
0 / 0 09:06:52 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107728896; Read time: 0; Write time: 63808 09:06:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:06:52 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320172032; Read time: 164; Write time: 242524 09:06:52 INFO - Running post-run listener: _upload_blobber_files 09:06:52 INFO - Blob upload gear active. 09:06:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:06:52 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 09:06:52 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'] 09:06:52 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 09:06:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:06:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:06:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:06:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:54 INFO - (blobuploader) - INFO - Done attempting. 09:06:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:06:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:06:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:54 INFO - (blobuploader) - INFO - Done attempting. 09:06:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:06:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:06:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:59 INFO - (blobuploader) - INFO - Done attempting. 09:06:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:06:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:06:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:59 INFO - (blobuploader) - INFO - Done attempting. 09:06:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:06:59 INFO - Return code: 0 09:06:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:06:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:06:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8ac4e775edb3be686fcea3b9c9dd8a1a25ffff191ab8727b9ab5b2d038df96dad0731fcb803ad94a1be163279fa7c9bc21eeea4561d882655de1a53b39ffb91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f422d983cf0525d00b6c05431f8282f7539cf15b84f2332854cdb2110b6ed63cec67df9126f7fe0ffae8fcda0fb868f8ec1ffba2b322328d3e966f72ef7cc18d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b50c02d40442a93e5ae347f9c9ac7df299bad9d6675ef8ade53b78715c493451a1a0d58c6b063f0d913ce9969997d6d02b4e2e2f50adf2fa13996d4ceac35f4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d44ff163a8feef02917d4ad1ce1a517205332434880d32e290c4208a77a2cb96e711bb374e8a9bcd0c3a8c049d0ed5d1732ab79a8c8238a4dc5046628e8b0700"} 09:06:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:06:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:06:59 INFO - Contents: 09:06:59 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8ac4e775edb3be686fcea3b9c9dd8a1a25ffff191ab8727b9ab5b2d038df96dad0731fcb803ad94a1be163279fa7c9bc21eeea4561d882655de1a53b39ffb91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f422d983cf0525d00b6c05431f8282f7539cf15b84f2332854cdb2110b6ed63cec67df9126f7fe0ffae8fcda0fb868f8ec1ffba2b322328d3e966f72ef7cc18d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b50c02d40442a93e5ae347f9c9ac7df299bad9d6675ef8ade53b78715c493451a1a0d58c6b063f0d913ce9969997d6d02b4e2e2f50adf2fa13996d4ceac35f4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d44ff163a8feef02917d4ad1ce1a517205332434880d32e290c4208a77a2cb96e711bb374e8a9bcd0c3a8c049d0ed5d1732ab79a8c8238a4dc5046628e8b0700"} 09:06:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:06:59 INFO - Copying logs to upload dir... 09:06:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:06:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.975274 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-07-13 09:06:59.547735) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-13 09:06:59.551085) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424 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/a8ac4e775edb3be686fcea3b9c9dd8a1a25ffff191ab8727b9ab5b2d038df96dad0731fcb803ad94a1be163279fa7c9bc21eeea4561d882655de1a53b39ffb91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f422d983cf0525d00b6c05431f8282f7539cf15b84f2332854cdb2110b6ed63cec67df9126f7fe0ffae8fcda0fb868f8ec1ffba2b322328d3e966f72ef7cc18d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b50c02d40442a93e5ae347f9c9ac7df299bad9d6675ef8ade53b78715c493451a1a0d58c6b063f0d913ce9969997d6d02b4e2e2f50adf2fa13996d4ceac35f4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d44ff163a8feef02917d4ad1ce1a517205332434880d32e290c4208a77a2cb96e711bb374e8a9bcd0c3a8c049d0ed5d1732ab79a8c8238a4dc5046628e8b0700"} build_url:https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011141 build_url: 'https://queue.taskcluster.net/v1/task/BZBrh4qkTlqR0eH5lzVl3g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8ac4e775edb3be686fcea3b9c9dd8a1a25ffff191ab8727b9ab5b2d038df96dad0731fcb803ad94a1be163279fa7c9bc21eeea4561d882655de1a53b39ffb91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f422d983cf0525d00b6c05431f8282f7539cf15b84f2332854cdb2110b6ed63cec67df9126f7fe0ffae8fcda0fb868f8ec1ffba2b322328d3e966f72ef7cc18d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b50c02d40442a93e5ae347f9c9ac7df299bad9d6675ef8ade53b78715c493451a1a0d58c6b063f0d913ce9969997d6d02b4e2e2f50adf2fa13996d4ceac35f4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d44ff163a8feef02917d4ad1ce1a517205332434880d32e290c4208a77a2cb96e711bb374e8a9bcd0c3a8c049d0ed5d1732ab79a8c8238a4dc5046628e8b0700"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-13 09:06:59.575913) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-13 09:06:59.576197) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1499960605.696696-1930240424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-13 09:06:59.659619) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-13 09:06:59.659937) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-13 09:06:59.660219) ========= ========= Total master_lag: 0.18 =========