builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1497277714.25 results: success (0) revision: 9eb9e6b53887119997909f0b5e773138b76d8c7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:34.254720) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:34.255131) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:34.255396) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:34.271255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:34.271528) ========= 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=5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-12 07:28:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.6M=0s 2017-06-12 07:28:34 (83.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145030 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:34.426782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:34.427054) ========= 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=5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018953 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:34.480168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:34.483512) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9eb9e6b53887119997909f0b5e773138b76d8c7e --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 9eb9e6b53887119997909f0b5e773138b76d8c7e --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=5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-12 07:28:34,535 truncating revision to first 12 chars 2017-06-12 07:28:34,536 Setting DEBUG logging. 2017-06-12 07:28:34,536 attempt 1/10 2017-06-12 07:28:34,536 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9eb9e6b53887?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-12 07:28:34,838 unpacking tar archive at: mozilla-central-9eb9e6b53887/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637052 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:35.132835) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:35.133153) ========= script_repo_revision: 9eb9e6b53887119997909f0b5e773138b76d8c7e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:35.136578) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:35.136850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-12 07:28:35.145180) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2017-06-12 07:28:35.145450) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:28:35 INFO - MultiFileLogger online at 20170612 07:28:35 in /builds/slave/test 07:28:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:28:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:28:35 INFO - {'append_to_log': False, 07:28:35 INFO - 'base_work_dir': '/builds/slave/test', 07:28:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:28:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:28:35 INFO - 'branch': 'Firefox-Non-PGO', 07:28:35 INFO - 'buildbot_json_path': 'buildprops.json', 07:28:35 INFO - 'config_files': ('talos/linux_config.py',), 07:28:35 INFO - 'default_actions': ('clobber', 07:28:35 INFO - 'read-buildbot-config', 07:28:35 INFO - 'download-and-extract', 07:28:35 INFO - 'populate-webroot', 07:28:35 INFO - 'create-virtualenv', 07:28:35 INFO - 'install', 07:28:35 INFO - 'setup-mitmproxy', 07:28:35 INFO - 'run-tests'), 07:28:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:28:35 INFO - 'download_minidump_stackwalk': True, 07:28:35 INFO - 'download_symbols': 'ondemand', 07:28:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:28:35 INFO - 'tooltool.py': '/tools/tooltool.py', 07:28:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:28:35 INFO - '/tools/misc-python/virtualenv.py')}, 07:28:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:28:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:28:35 INFO - 'gecko_profile': False, 07:28:35 INFO - 'gecko_profile_interval': 0, 07:28:35 INFO - 'installer_path': 'installer.exe', 07:28:35 INFO - 'log_level': 'info', 07:28:35 INFO - 'log_name': 'talos', 07:28:35 INFO - 'log_to_console': True, 07:28:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:28:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:28:35 INFO - 'opt_config_files': (), 07:28:35 INFO - 'pip_index': False, 07:28:35 INFO - 'suite': 'dromaeojs-e10s', 07:28:35 INFO - 'system_bits': '32', 07:28:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:28:35 INFO - 'title': 'talos-linux64-ix-039', 07:28:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:28:35 INFO - 'use_talos_json': True, 07:28:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:28:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:28:35 INFO - 'work_dir': 'build'} 07:28:35 INFO - [mozharness: 2017-06-12 14:28:35.303105Z] Running clobber step. 07:28:35 INFO - Running pre-action listener: _resource_record_pre_action 07:28:35 INFO - Running main action method: clobber 07:28:35 INFO - rmtree: /builds/slave/test/build 07:28:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:28:36 INFO - Running post-action listener: _resource_record_post_action 07:28:36 INFO - [mozharness: 2017-06-12 14:28:36.321644Z] Finished clobber step (success) 07:28:36 INFO - [mozharness: 2017-06-12 14:28:36.321744Z] Running read-buildbot-config step. 07:28:36 INFO - Running pre-action listener: _resource_record_pre_action 07:28:36 INFO - Running main action method: read_buildbot_config 07:28:36 INFO - Using buildbot properties: 07:28:36 INFO - { 07:28:36 INFO - "project": "", 07:28:36 INFO - "product": "firefox", 07:28:36 INFO - "who": "bhearsum@mozilla.com", 07:28:36 INFO - "installer_path": "public/build/target.tar.bz2", 07:28:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:28:36 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:28:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:28:36 INFO - "stage_platform": "linux64", 07:28:36 INFO - "basedir": "/builds/slave/test", 07:28:36 INFO - "buildnumber": 909, 07:28:36 INFO - "platform": "ubuntu64_hw", 07:28:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:28:36 INFO - "slavebuilddir": "test", 07:28:36 INFO - "taskId": "VuulE7OiRkqZWVvo8fWvCQ", 07:28:36 INFO - "branch": "mozilla-central", 07:28:36 INFO - "script_repo_revision": "production", 07:28:36 INFO - "revision": "9eb9e6b53887119997909f0b5e773138b76d8c7e", 07:28:36 INFO - "slavename": "talos-linux64-ix-039", 07:28:36 INFO - "repo_path": "mozilla-central" 07:28:36 INFO - } 07:28:36 INFO - Finding installer, test and symbols from parent task. 07:28:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VuulE7OiRkqZWVvo8fWvCQ'}, attempt #1 07:28:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VuulE7OiRkqZWVvo8fWvCQ'}, attempt #1 07:28:37 INFO - Task dependencies: ImDVj0dHQBCqFYt22hQxZg 07:28:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg'}, attempt #1 07:28:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.tar.bz2 07:28:37 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/test_packages.json 07:28:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.crashreporter-symbols.zip 07:28:37 INFO - Running post-action listener: _resource_record_post_action 07:28:37 INFO - [mozharness: 2017-06-12 14:28:37.722644Z] Finished read-buildbot-config step (success) 07:28:37 INFO - [mozharness: 2017-06-12 14:28:37.722870Z] Running download-and-extract step. 07:28:37 INFO - Running pre-action listener: _resource_record_pre_action 07:28:37 INFO - Running main action method: download_and_extract 07:28:37 INFO - mkdir: /builds/slave/test/build/tests 07:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:37 INFO - trying https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.test_packages.json 07:28:37 INFO - Downloading https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:28:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:28:38 INFO - Downloaded 989 bytes. 07:28:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:28:38 INFO - Using the following test package requirements: 07:28:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:28:38 INFO - u'common': [u'target.common.tests.zip'], 07:28:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:28:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:28:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:28:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:28:38 INFO - u'mozbase': [u'target.common.tests.zip'], 07:28:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:28:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:28:38 INFO - u'web-platform': [u'target.common.tests.zip', 07:28:38 INFO - u'target.web-platform.tests.tar.gz'], 07:28:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:28:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:28:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.common.tests.zip 07:28:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:28:38 INFO - Fetch https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.common.tests.zip into memory 07:28:39 INFO - Content-Length response header: 67876919 07:28:39 INFO - Bytes received: 67876919 07:28:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:28:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.common.tests.zip 07:28:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:28:50 INFO - Fetch https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.common.tests.zip into memory 07:28:52 INFO - Content-Length response header: 67876919 07:28:52 INFO - Bytes received: 67876919 07:29:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.talos.tests.zip 07:29:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:29:03 INFO - Fetch https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.talos.tests.zip into memory 07:29:04 INFO - Content-Length response header: 14450010 07:29:04 INFO - Bytes received: 14450010 07:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:04 INFO - trying https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.tar.bz2 07:29:04 INFO - Downloading https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:29:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:29:06 INFO - Downloaded 59279280 bytes. 07:29:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.tar.bz2 07:29:06 INFO - mkdir: /builds/slave/test/properties 07:29:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:29:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:29:06 INFO - Contents: 07:29:06 INFO - build_url:https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.tar.bz2 07:29:06 INFO - Running post-action listener: _resource_record_post_action 07:29:06 INFO - Running post-action listener: set_extra_try_arguments 07:29:06 INFO - [mozharness: 2017-06-12 14:29:06.103479Z] Finished download-and-extract step (success) 07:29:06 INFO - [mozharness: 2017-06-12 14:29:06.103576Z] Running populate-webroot step. 07:29:06 INFO - Running pre-action listener: _resource_record_pre_action 07:29:06 INFO - Running main action method: populate_webroot 07:29:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:29:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:29:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:29:06 INFO - '--tppagecycles', 07:29:06 INFO - '7'], 07:29:06 INFO - 'tests': ['tsvgm']}}, 07:29:06 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:29:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:29:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:29:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:29:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:29:06 INFO - 'talos_options': ['--disable-e10s'], 07:29:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:29:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:29:06 INFO - 'talos_options': ['--disable-e10s'], 07:29:06 INFO - 'tests': ['damp', 'tps']}, 07:29:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:29:06 INFO - 'tests': ['damp', 'tps']}, 07:29:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:29:06 INFO - 'tests': ['dromaeo_dom']}, 07:29:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:29:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:29:06 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:29:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:29:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:29:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:29:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:29:06 INFO - 'tests': ['a11yr', 07:29:06 INFO - 'ts_paint', 07:29:06 INFO - 'tpaint', 07:29:06 INFO - 'sessionrestore', 07:29:06 INFO - 'sessionrestore_no_auto_restore', 07:29:06 INFO - 'tabpaint']}, 07:29:06 INFO - 'other-e10s': {'tests': ['a11yr', 07:29:06 INFO - 'ts_paint', 07:29:06 INFO - 'tpaint', 07:29:06 INFO - 'sessionrestore', 07:29:06 INFO - 'sessionrestore_no_auto_restore', 07:29:06 INFO - 'tabpaint']}, 07:29:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:29:06 INFO - 'ts_paint', 07:29:06 INFO - 'tpaint', 07:29:06 INFO - 'sessionrestore', 07:29:06 INFO - 'sessionrestore_no_auto_restore', 07:29:06 INFO - 'tabpaint']}, 07:29:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:29:06 INFO - 'ts_paint', 07:29:06 INFO - 'tpaint', 07:29:06 INFO - 'sessionrestore', 07:29:06 INFO - 'sessionrestore_no_auto_restore', 07:29:06 INFO - 'tabpaint']}, 07:29:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:29:06 INFO - 'tests': ['a11yr', 07:29:06 INFO - 'ts_paint', 07:29:06 INFO - 'tpaint', 07:29:06 INFO - 'sessionrestore', 07:29:06 INFO - 'sessionrestore_no_auto_restore', 07:29:06 INFO - 'tabpaint']}, 07:29:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:29:06 INFO - 'tests': ['a11yr', 07:29:06 INFO - 'ts_paint', 07:29:06 INFO - 'tpaint', 07:29:06 INFO - 'sessionrestore', 07:29:06 INFO - 'sessionrestore_no_auto_restore', 07:29:06 INFO - 'tabpaint']}, 07:29:06 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 07:29:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 07:29:06 INFO - 'bloom_basic_ref']}, 07:29:06 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:29:06 INFO - 'talos_options': ['--mitmproxy', 07:29:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:29:06 INFO - '--firstNonBlankPaint'], 07:29:06 INFO - 'tests': ['quantum_pageload_google', 07:29:06 INFO - 'quantum_pageload_youtube', 07:29:06 INFO - 'quantum_pageload_amazon', 07:29:06 INFO - 'quantum_pageload_facebook']}, 07:29:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:29:06 INFO - 'tests': ['tsvgx', 07:29:06 INFO - 'tsvgr_opacity', 07:29:06 INFO - 'tart', 07:29:06 INFO - 'tscrollx', 07:29:06 INFO - 'cart', 07:29:06 INFO - 'tsvg_static']}, 07:29:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:29:06 INFO - 'tsvgr_opacity', 07:29:06 INFO - 'tart', 07:29:06 INFO - 'tscrollx', 07:29:06 INFO - 'cart', 07:29:06 INFO - 'tsvg_static']}, 07:29:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:29:06 INFO - 'talos_options': ['--disable-e10s'], 07:29:06 INFO - 'tests': ['tp5o']}, 07:29:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:29:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:29:06 INFO - 'talos_options': ['--disable-e10s', 07:29:06 INFO - '--xperf_path', 07:29:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:06 INFO - 'tests': ['tp5n']}, 07:29:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:29:06 INFO - 'talos_options': ['--xperf_path', 07:29:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:06 INFO - 'tests': ['tp5n']}}, 07:29:06 INFO - 'talos.zip': {'path': '', 07:29:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:29:06 INFO - Running post-action listener: _resource_record_post_action 07:29:06 INFO - [mozharness: 2017-06-12 14:29:06.118308Z] Finished populate-webroot step (success) 07:29:06 INFO - [mozharness: 2017-06-12 14:29:06.118397Z] Running create-virtualenv step. 07:29:06 INFO - Running pre-action listener: _resource_record_pre_action 07:29:06 INFO - Running main action method: create_virtualenv 07:29:06 INFO - Creating virtualenv /builds/slave/test/build/venv 07:29:06 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 07:29:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:29:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:29:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:29:06 INFO - Using real prefix '/usr' 07:29:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:29:06 INFO - Installing distribute.............................................................................................................................................................................................done. 07:29:08 INFO - Installing pip.................done. 07:29:08 INFO - Return code: 0 07:29:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:29:08 INFO - Reading from file tmpfile_stdout 07:29:08 INFO - Output received: 07:29:08 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) 07:29:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:29:08 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')]} 07:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:08 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')]} 07:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:08 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 0xb0c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe88140>, '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 0xe88a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe88ed0>, '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': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', '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 07:29:08 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 07:29:08 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 07:29:08 INFO - Using env: {'DISPLAY': ':0', 07:29:08 INFO - 'HOME': '/home/cltbld', 07:29:08 INFO - 'LANG': 'en_US.UTF-8', 07:29:08 INFO - 'LANGUAGE': 'en_US:en', 07:29:08 INFO - 'LOGNAME': 'cltbld', 07:29:08 INFO - 'MAIL': '/var/mail/cltbld', 07:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:08 INFO - 'MOZ_NO_REMOTE': '1', 07:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:08 INFO - 'NO_EM_RESTART': '1', 07:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:08 INFO - 'PWD': '/builds/slave/test', 07:29:08 INFO - 'SHELL': '/bin/bash', 07:29:08 INFO - 'SHLVL': '1', 07:29:08 INFO - 'TERM': 'linux', 07:29:08 INFO - 'TMOUT': '86400', 07:29:08 INFO - 'USER': 'cltbld', 07:29:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', 07:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:08 INFO - '_': '/tools/buildbot/bin/python'} 07:29:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:09 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 07:29:09 INFO - Cleaning up... 07:29:09 INFO - Return code: 0 07:29:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:29:09 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')]} 07:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:09 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')]} 07:29:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:09 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 0xb0c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe88140>, '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 0xe88a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe88ed0>, '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': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', '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 07:29:09 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 07:29:09 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 07:29:09 INFO - Using env: {'DISPLAY': ':0', 07:29:09 INFO - 'HOME': '/home/cltbld', 07:29:09 INFO - 'LANG': 'en_US.UTF-8', 07:29:09 INFO - 'LANGUAGE': 'en_US:en', 07:29:09 INFO - 'LOGNAME': 'cltbld', 07:29:09 INFO - 'MAIL': '/var/mail/cltbld', 07:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:09 INFO - 'MOZ_NO_REMOTE': '1', 07:29:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:09 INFO - 'NO_EM_RESTART': '1', 07:29:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:09 INFO - 'PWD': '/builds/slave/test', 07:29:09 INFO - 'SHELL': '/bin/bash', 07:29:09 INFO - 'SHLVL': '1', 07:29:09 INFO - 'TERM': 'linux', 07:29:09 INFO - 'TMOUT': '86400', 07:29:09 INFO - 'USER': 'cltbld', 07:29:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', 07:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:09 INFO - '_': '/tools/buildbot/bin/python'} 07:29:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:09 INFO - Downloading/unpacking psutil>=3.1.1 07:29:09 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 07:29:09 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 07:29:09 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 07:29:09 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 07:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:29:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:10 INFO - Installing collected packages: psutil 07:29:10 INFO - Running setup.py install for psutil 07:29:10 INFO - building 'psutil._psutil_linux' extension 07:29:10 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 07:29:10 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 07:29:10 INFO - building 'psutil._psutil_posix' extension 07:29:10 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 07:29:10 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 07:29:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:10 INFO - Successfully installed psutil 07:29:10 INFO - Cleaning up... 07:29:11 INFO - Return code: 0 07:29:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:29:11 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')]} 07:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:11 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')]} 07:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:11 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 0xb0c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe88140>, '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 0xe88a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe88ed0>, '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': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', '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 07:29:11 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 07:29:11 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 07:29:11 INFO - Using env: {'DISPLAY': ':0', 07:29:11 INFO - 'HOME': '/home/cltbld', 07:29:11 INFO - 'LANG': 'en_US.UTF-8', 07:29:11 INFO - 'LANGUAGE': 'en_US:en', 07:29:11 INFO - 'LOGNAME': 'cltbld', 07:29:11 INFO - 'MAIL': '/var/mail/cltbld', 07:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:11 INFO - 'MOZ_NO_REMOTE': '1', 07:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:11 INFO - 'NO_EM_RESTART': '1', 07:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:11 INFO - 'PWD': '/builds/slave/test', 07:29:11 INFO - 'SHELL': '/bin/bash', 07:29:11 INFO - 'SHLVL': '1', 07:29:11 INFO - 'TERM': 'linux', 07:29:11 INFO - 'TMOUT': '86400', 07:29:11 INFO - 'USER': 'cltbld', 07:29:11 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', 07:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:11 INFO - '_': '/tools/buildbot/bin/python'} 07:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:29:11 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 07:29:11 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 07:29:11 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 07:29:11 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 07:29:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:29:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:29:12 INFO - Installing collected packages: mozsystemmonitor 07:29:12 INFO - Running setup.py install for mozsystemmonitor 07:29:12 INFO - Successfully installed mozsystemmonitor 07:29:12 INFO - Cleaning up... 07:29:12 INFO - Return code: 0 07:29:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29: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')]} 07:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb0c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe88140>, '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 0xe88a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe88ed0>, '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': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', '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 07:29:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:29:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:29:12 INFO - Using env: {'DISPLAY': ':0', 07:29:12 INFO - 'HOME': '/home/cltbld', 07:29:12 INFO - 'LANG': 'en_US.UTF-8', 07:29:12 INFO - 'LANGUAGE': 'en_US:en', 07:29:12 INFO - 'LOGNAME': 'cltbld', 07:29:12 INFO - 'MAIL': '/var/mail/cltbld', 07:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:12 INFO - 'MOZ_NO_REMOTE': '1', 07:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:12 INFO - 'NO_EM_RESTART': '1', 07:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:12 INFO - 'PWD': '/builds/slave/test', 07:29:12 INFO - 'SHELL': '/bin/bash', 07:29:12 INFO - 'SHLVL': '1', 07:29:12 INFO - 'TERM': 'linux', 07:29:12 INFO - 'TMOUT': '86400', 07:29:12 INFO - 'USER': 'cltbld', 07:29:12 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', 07:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:12 INFO - '_': '/tools/buildbot/bin/python'} 07:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:12 INFO - Downloading/unpacking jsonschema==2.5.1 07:29:12 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 07:29:12 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 07:29:12 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 07:29:12 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 07:29:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:29:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:29:13 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 07:29:13 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 07:29:13 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 07:29:13 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 07:29:13 INFO - Downloading functools32-3.2.3-2.tar.gz 07:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:29:13 INFO - warning: no files found matching '*.txt' 07:29:14 INFO - no previously-included directories found matching 'build' 07:29:14 INFO - no previously-included directories found matching 'dist' 07:29:14 INFO - no previously-included directories found matching '.git*' 07:29:14 INFO - Installing collected packages: jsonschema, functools32 07:29:14 INFO - Running setup.py install for functools32 07:29:14 INFO - warning: no files found matching '*.txt' 07:29:14 INFO - no previously-included directories found matching 'build' 07:29:14 INFO - no previously-included directories found matching 'dist' 07:29:14 INFO - no previously-included directories found matching '.git*' 07:29:14 INFO - Successfully installed jsonschema functools32 07:29:14 INFO - Cleaning up... 07:29:14 INFO - Return code: 0 07:29:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:29:14 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')]} 07:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:14 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')]} 07:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:14 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 0xb0c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe88140>, '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 0xe88a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe88ed0>, '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': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', '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 07:29:14 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 07:29:14 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 07:29:14 INFO - Using env: {'DISPLAY': ':0', 07:29:14 INFO - 'HOME': '/home/cltbld', 07:29:14 INFO - 'LANG': 'en_US.UTF-8', 07:29:14 INFO - 'LANGUAGE': 'en_US:en', 07:29:14 INFO - 'LOGNAME': 'cltbld', 07:29:14 INFO - 'MAIL': '/var/mail/cltbld', 07:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:14 INFO - 'MOZ_NO_REMOTE': '1', 07:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:14 INFO - 'NO_EM_RESTART': '1', 07:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:14 INFO - 'PWD': '/builds/slave/test', 07:29:14 INFO - 'SHELL': '/bin/bash', 07:29:14 INFO - 'SHLVL': '1', 07:29:14 INFO - 'TERM': 'linux', 07:29:14 INFO - 'TMOUT': '86400', 07:29:14 INFO - 'USER': 'cltbld', 07:29:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', 07:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:14 INFO - '_': '/tools/buildbot/bin/python'} 07:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:29:14 INFO - Cleaning up... 07:29:14 INFO - Return code: 0 07:29:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:29:14 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')]} 07:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:14 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')]} 07:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:14 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 0xb0c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe88140>, '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 0xe88a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe88ed0>, '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': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', '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 07:29:14 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 07:29:14 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 07:29:14 INFO - Using env: {'DISPLAY': ':0', 07:29:14 INFO - 'HOME': '/home/cltbld', 07:29:14 INFO - 'LANG': 'en_US.UTF-8', 07:29:14 INFO - 'LANGUAGE': 'en_US:en', 07:29:14 INFO - 'LOGNAME': 'cltbld', 07:29:14 INFO - 'MAIL': '/var/mail/cltbld', 07:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:14 INFO - 'MOZ_NO_REMOTE': '1', 07:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:14 INFO - 'NO_EM_RESTART': '1', 07:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:14 INFO - 'PWD': '/builds/slave/test', 07:29:14 INFO - 'SHELL': '/bin/bash', 07:29:14 INFO - 'SHLVL': '1', 07:29:14 INFO - 'TERM': 'linux', 07:29:14 INFO - 'TMOUT': '86400', 07:29:14 INFO - 'USER': 'cltbld', 07:29:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', 07:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:14 INFO - '_': '/tools/buildbot/bin/python'} 07:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:14 INFO - Downloading/unpacking blobuploader==1.2.4 07:29:14 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 07:29:14 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 07:29:14 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 07:29:14 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 07:29:15 INFO - Downloading blobuploader-1.2.4.tar.gz 07:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:29:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:29:15 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 07:29:15 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 07:29:15 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 07:29:15 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 07:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:29:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:29:16 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 07:29:16 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 07:29:16 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 07:29:16 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 07:29:16 INFO - Downloading docopt-0.6.1.tar.gz 07:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:29:16 INFO - Installing collected packages: blobuploader, requests, docopt 07:29:16 INFO - Running setup.py install for blobuploader 07:29:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:29:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:29:16 INFO - Running setup.py install for requests 07:29:16 INFO - Running setup.py install for docopt 07:29:16 INFO - Successfully installed blobuploader requests docopt 07:29:16 INFO - Cleaning up... 07:29:16 INFO - Return code: 0 07:29:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:16 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')]} 07:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:16 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')]} 07:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:16 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 0xb0c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe88140>, '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 0xe88a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe88ed0>, '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': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', '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 07:29:16 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 07:29:16 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 07:29:16 INFO - Using env: {'DISPLAY': ':0', 07:29:16 INFO - 'HOME': '/home/cltbld', 07:29:16 INFO - 'LANG': 'en_US.UTF-8', 07:29:16 INFO - 'LANGUAGE': 'en_US:en', 07:29:16 INFO - 'LOGNAME': 'cltbld', 07:29:16 INFO - 'MAIL': '/var/mail/cltbld', 07:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:16 INFO - 'MOZ_NO_REMOTE': '1', 07:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:16 INFO - 'NO_EM_RESTART': '1', 07:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:16 INFO - 'PWD': '/builds/slave/test', 07:29:16 INFO - 'SHELL': '/bin/bash', 07:29:16 INFO - 'SHLVL': '1', 07:29:16 INFO - 'TERM': 'linux', 07:29:16 INFO - 'TMOUT': '86400', 07:29:16 INFO - 'USER': 'cltbld', 07:29:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', 07:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:16 INFO - '_': '/tools/buildbot/bin/python'} 07:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:17 INFO - Running setup.py (path:/tmp/pip-VH6eqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:17 INFO - Running setup.py (path:/tmp/pip-MCGJDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:17 INFO - Running setup.py (path:/tmp/pip-jReRmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:17 INFO - Running setup.py (path:/tmp/pip-bm0j2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:17 INFO - Running setup.py (path:/tmp/pip-yc9lFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:17 INFO - Running setup.py (path:/tmp/pip-cCud4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:17 INFO - Running setup.py (path:/tmp/pip-XbTKP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:17 INFO - Running setup.py (path:/tmp/pip-KQP6KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:17 INFO - Running setup.py (path:/tmp/pip-hVufPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:17 INFO - Running setup.py (path:/tmp/pip-N4pQek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:17 INFO - Running setup.py (path:/tmp/pip-l5cQko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:17 INFO - Running setup.py (path:/tmp/pip-9OxHIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:17 INFO - Running setup.py (path:/tmp/pip-FbvOKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:18 INFO - Running setup.py (path:/tmp/pip-tP2SoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:18 INFO - Running setup.py (path:/tmp/pip-eNgq3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:18 INFO - Running setup.py (path:/tmp/pip-oIwBZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:18 INFO - Running setup.py (path:/tmp/pip-yUMuZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:29:18 INFO - Running setup.py install for manifestparser 07:29:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:29:18 INFO - Running setup.py install for mozcrash 07:29:18 INFO - Running setup.py install for mozdebug 07:29:18 INFO - Running setup.py install for mozdevice 07:29:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:29:18 INFO - Running setup.py install for mozfile 07:29:18 INFO - Running setup.py install for mozhttpd 07:29:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:29:18 INFO - Running setup.py install for mozinfo 07:29:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:29:19 INFO - Running setup.py install for mozInstall 07:29:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:29:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:29:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:29:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:29:19 INFO - Running setup.py install for mozleak 07:29:19 INFO - Running setup.py install for mozlog 07:29:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:29:19 INFO - Running setup.py install for moznetwork 07:29:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:29:19 INFO - Running setup.py install for mozprocess 07:29:19 INFO - Running setup.py install for mozprofile 07:29:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:29:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:29:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:29:19 INFO - Running setup.py install for mozrunner 07:29:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:29:19 INFO - Running setup.py install for mozscreenshot 07:29:19 INFO - Running setup.py install for moztest 07:29:19 INFO - Running setup.py install for mozversion 07:29:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:29:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:29:20 INFO - Cleaning up... 07:29:20 INFO - Return code: 0 07:29:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:20 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')]} 07:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:20 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')]} 07:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:20 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 0xb0c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe88140>, '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 0xe88a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe88ed0>, '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': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', '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 07:29:20 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 07:29:20 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 07:29:20 INFO - Using env: {'DISPLAY': ':0', 07:29:20 INFO - 'HOME': '/home/cltbld', 07:29:20 INFO - 'LANG': 'en_US.UTF-8', 07:29:20 INFO - 'LANGUAGE': 'en_US:en', 07:29:20 INFO - 'LOGNAME': 'cltbld', 07:29:20 INFO - 'MAIL': '/var/mail/cltbld', 07:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:20 INFO - 'MOZ_NO_REMOTE': '1', 07:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:20 INFO - 'NO_EM_RESTART': '1', 07:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:20 INFO - 'PWD': '/builds/slave/test', 07:29:20 INFO - 'SHELL': '/bin/bash', 07:29:20 INFO - 'SHLVL': '1', 07:29:20 INFO - 'TERM': 'linux', 07:29:20 INFO - 'TMOUT': '86400', 07:29:20 INFO - 'USER': 'cltbld', 07:29:20 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', 07:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:20 INFO - '_': '/tools/buildbot/bin/python'} 07:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:20 INFO - Running setup.py (path:/tmp/pip-qOCmX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:20 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)) 07:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:20 INFO - Running setup.py (path:/tmp/pip-neWl_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:20 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)) 07:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:20 INFO - Running setup.py (path:/tmp/pip-wug7sH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:20 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)) 07:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:20 INFO - Running setup.py (path:/tmp/pip-A1HNiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:20 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)) 07:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:20 INFO - Running setup.py (path:/tmp/pip-rPJMHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:20 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)) 07:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:20 INFO - Running setup.py (path:/tmp/pip-v4FZKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:20 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)) 07:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:20 INFO - Running setup.py (path:/tmp/pip-372Yxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:20 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)) 07:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:20 INFO - Running setup.py (path:/tmp/pip-EKY2Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:20 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)) 07:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:20 INFO - Running setup.py (path:/tmp/pip-Jg9dLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:20 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)) 07:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:20 INFO - Running setup.py (path:/tmp/pip-MAvgwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 07:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:21 INFO - Running setup.py (path:/tmp/pip-7zkgZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:21 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)) 07:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:21 INFO - Running setup.py (path:/tmp/pip-yDO0XQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:21 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)) 07:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:21 INFO - Running setup.py (path:/tmp/pip-NrvCOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:21 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)) 07:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:21 INFO - Running setup.py (path:/tmp/pip-qqxaO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:21 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)) 07:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:21 INFO - Running setup.py (path:/tmp/pip-KRhCqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:21 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)) 07:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:21 INFO - Running setup.py (path:/tmp/pip-WDfLP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:21 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)) 07:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:21 INFO - Running setup.py (path:/tmp/pip-05BJqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:21 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)) 07:29:21 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)) 07:29:21 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)) 07:29:21 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)) 07:29:21 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)) 07:29:21 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)) 07:29:21 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)) 07:29:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:29:21 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 07:29:21 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 07:29:21 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 07:29:21 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 07:29:22 INFO - Downloading blessings-1.6.tar.gz 07:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:29:22 INFO - Installing collected packages: blessings 07:29:22 INFO - Running setup.py install for blessings 07:29:22 INFO - Successfully installed blessings 07:29:22 INFO - Cleaning up... 07:29:22 INFO - Return code: 0 07:29:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:29:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:23 INFO - Reading from file tmpfile_stdout 07:29:23 INFO - Current package versions: 07:29:23 INFO - argparse == 1.2.1 07:29:23 INFO - blessings == 1.6 07:29:23 INFO - blobuploader == 1.2.4 07:29:23 INFO - docopt == 0.6.1 07:29:23 INFO - functools32 == 3.2.3-2 07:29:23 INFO - jsonschema == 2.5.1 07:29:23 INFO - manifestparser == 1.1 07:29:23 INFO - mozInstall == 1.13 07:29:23 INFO - mozcrash == 1.0 07:29:23 INFO - mozdebug == 0.1 07:29:23 INFO - mozdevice == 0.51 07:29:23 INFO - mozfile == 1.2 07:29:23 INFO - mozhttpd == 0.7 07:29:23 INFO - mozinfo == 0.10 07:29:23 INFO - mozleak == 0.1 07:29:23 INFO - mozlog == 3.4 07:29:23 INFO - moznetwork == 0.27 07:29:23 INFO - mozprocess == 0.25 07:29:23 INFO - mozprofile == 0.28 07:29:23 INFO - mozrunner == 6.13 07:29:23 INFO - mozscreenshot == 0.1 07:29:23 INFO - mozsystemmonitor == 0.3 07:29:23 INFO - moztest == 0.8 07:29:23 INFO - mozversion == 1.4 07:29:23 INFO - psutil == 3.1.1 07:29:23 INFO - requests == 1.2.3 07:29:23 INFO - wsgiref == 0.1.2 07:29:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29: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')]} 07:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:23 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 0xb0c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe88140>, '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 0xe88a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe88ed0>, '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': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', '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 07:29:23 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 07:29:23 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 07:29:23 INFO - Using env: {'DISPLAY': ':0', 07:29:23 INFO - 'HOME': '/home/cltbld', 07:29:23 INFO - 'LANG': 'en_US.UTF-8', 07:29:23 INFO - 'LANGUAGE': 'en_US:en', 07:29:23 INFO - 'LOGNAME': 'cltbld', 07:29:23 INFO - 'MAIL': '/var/mail/cltbld', 07:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:23 INFO - 'MOZ_NO_REMOTE': '1', 07:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:23 INFO - 'NO_EM_RESTART': '1', 07:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:23 INFO - 'PWD': '/builds/slave/test', 07:29:23 INFO - 'SHELL': '/bin/bash', 07:29:23 INFO - 'SHLVL': '1', 07:29:23 INFO - 'TERM': 'linux', 07:29:23 INFO - 'TMOUT': '86400', 07:29:23 INFO - 'USER': 'cltbld', 07:29:23 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', 07:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:23 INFO - '_': '/tools/buildbot/bin/python'} 07:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:23 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)) 07:29:23 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)) 07:29:23 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)) 07:29:23 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)) 07:29:23 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)) 07:29:23 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)) 07:29:23 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)) 07:29:23 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)) 07:29:23 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)) 07:29:23 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 07:29:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 07:29:24 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)) 07:29:24 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)) 07:29:24 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)) 07:29:24 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)) 07:29:24 INFO - Installing collected packages: marionette-driver 07:29:24 INFO - Running setup.py install for marionette-driver 07:29:24 INFO - Successfully installed marionette-driver 07:29:24 INFO - Cleaning up... 07:29:24 INFO - Return code: 0 07:29:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:29:24 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')]} 07:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:24 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')]} 07:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:24 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 0xb0c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe88140>, '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 0xe88a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe88ed0>, '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': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', '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 07:29:24 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 07:29:24 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 07:29:24 INFO - Using env: {'DISPLAY': ':0', 07:29:24 INFO - 'HOME': '/home/cltbld', 07:29:24 INFO - 'LANG': 'en_US.UTF-8', 07:29:24 INFO - 'LANGUAGE': 'en_US:en', 07:29:24 INFO - 'LOGNAME': 'cltbld', 07:29:24 INFO - 'MAIL': '/var/mail/cltbld', 07:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:24 INFO - 'MOZ_NO_REMOTE': '1', 07:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:24 INFO - 'NO_EM_RESTART': '1', 07:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:24 INFO - 'PWD': '/builds/slave/test', 07:29:24 INFO - 'SHELL': '/bin/bash', 07:29:24 INFO - 'SHLVL': '1', 07:29:24 INFO - 'TERM': 'linux', 07:29:24 INFO - 'TMOUT': '86400', 07:29:24 INFO - 'USER': 'cltbld', 07:29:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', 07:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:24 INFO - '_': '/tools/buildbot/bin/python'} 07:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:29:25 INFO - Cleaning up... 07:29:25 INFO - Return code: 0 07:29:25 INFO - Running post-action listener: _resource_record_post_action 07:29:25 INFO - Running post-action listener: _start_resource_monitoring 07:29:25 INFO - Starting resource monitoring. 07:29:25 INFO - [mozharness: 2017-06-12 14:29:25.059077Z] Finished create-virtualenv step (success) 07:29:25 INFO - [mozharness: 2017-06-12 14:29:25.059544Z] Running install step. 07:29:25 INFO - Running pre-action listener: _resource_record_pre_action 07:29:25 INFO - Running main action method: install 07:29:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:25 INFO - Reading from file tmpfile_stdout 07:29:25 INFO - Detecting whether we're running mozinstall >=1.0... 07:29:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:29:25 INFO - Reading from file tmpfile_stdout 07:29:25 INFO - Output received: 07:29:25 INFO - Usage: mozinstall [options] installer 07:29:25 INFO - Options: 07:29:25 INFO - -h, --help show this help message and exit 07:29:25 INFO - -d DEST, --destination=DEST 07:29:25 INFO - Directory to install application into. [default: 07:29:25 INFO - "/builds/slave/test"] 07:29:25 INFO - --app=APP Application being installed. [default: firefox] 07:29:25 INFO - mkdir: /builds/slave/test/build/application 07:29:25 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'] 07:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:29:42 INFO - Reading from file tmpfile_stdout 07:29:42 INFO - Output received: 07:29:42 INFO - /builds/slave/test/build/application/firefox/firefox 07:29:42 INFO - Running post-action listener: _resource_record_post_action 07:29:42 INFO - [mozharness: 2017-06-12 14:29:42.579507Z] Finished install step (success) 07:29:42 INFO - [mozharness: 2017-06-12 14:29:42.579784Z] Running setup-mitmproxy step. 07:29:42 INFO - Running pre-action listener: _resource_record_pre_action 07:29:42 INFO - Running main action method: setup_mitmproxy 07:29:42 INFO - Skipping: mitmproxy is not required 07:29:42 INFO - Running post-action listener: _resource_record_post_action 07:29:42 INFO - [mozharness: 2017-06-12 14:29:42.580908Z] Finished setup-mitmproxy step (success) 07:29:42 INFO - [mozharness: 2017-06-12 14:29:42.581137Z] Running run-tests step. 07:29:42 INFO - Running pre-action listener: _resource_record_pre_action 07:29:42 INFO - Running main action method: run_tests 07:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:29:42 INFO - Python 2.7.3 07:29:42 INFO - Return code: 0 07:29:42 INFO - grabbing minidump binary from tooltool 07:29: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')]} 07:29:42 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 0xe88140>, '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 0xe88a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe88ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:29:42 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 07:29:42 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 07:29:42 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 07:29:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:29:42 INFO - Return code: 0 07:29:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:29:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:29:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:29:42 INFO - ENV: RUST_BACKTRACE is now 1 07:29:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:29:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 07:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 07:29:42 INFO - Using env: {'DISPLAY': ':0', 07:29:42 INFO - 'HOME': '/home/cltbld', 07:29:42 INFO - 'LANG': 'en_US.UTF-8', 07:29:42 INFO - 'LANGUAGE': 'en_US:en', 07:29:42 INFO - 'LOGNAME': 'cltbld', 07:29:42 INFO - 'MAIL': '/var/mail/cltbld', 07:29:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:29:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:42 INFO - 'MOZ_NO_REMOTE': '1', 07:29:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:42 INFO - 'NO_EM_RESTART': '1', 07:29:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:42 INFO - 'PWD': '/builds/slave/test', 07:29:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:29:42 INFO - 'RUST_BACKTRACE': '1', 07:29:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:29:42 INFO - 'SHELL': '/bin/bash', 07:29:42 INFO - 'SHLVL': '1', 07:29:42 INFO - 'TERM': 'linux', 07:29:42 INFO - 'TMOUT': '86400', 07:29:42 INFO - 'USER': 'cltbld', 07:29:42 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512', 07:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:42 INFO - '_': '/tools/buildbot/bin/python'} 07:29:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 07:29:42 INFO - mozversion application_buildid: 20170612134742 07:29:42 INFO - mozversion application_changeset: 9eb9e6b53887119997909f0b5e773138b76d8c7e 07:29:42 INFO - mozversion application_display_name: Nightly 07:29:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:29:42 INFO - mozversion application_name: Firefox 07:29:42 INFO - mozversion application_remotingname: firefox 07:29:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:29:42 INFO - mozversion application_vendor: Mozilla 07:29:42 INFO - mozversion application_version: 56.0a1 07:29:42 INFO - mozversion platform_buildid: 20170612134742 07:29:42 INFO - mozversion platform_changeset: 9eb9e6b53887119997909f0b5e773138b76d8c7e 07:29:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:29:42 INFO - mozversion platform_version: 56.0a1 07:29:42 INFO - using testdate: 1497277782 07:29:42 INFO - actual date: 1497277782 07:29:42 INFO - starting webserver on 'localhost:54007' 07:29:42 INFO - SUITE-START | Running 2 tests 07:29:42 INFO - TEST-START | dromaeo_css 07:29:42 INFO - operating with platform_type : linux_ 07:29:42 INFO - Initialising browser for dromaeo_css test... 07:29:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54007/getInfo.html -profile /tmp/tmpwzVohX/profile 07:29:42 INFO - TEST-INFO | started process 12217 (/builds/slave/test/build/application/firefox/firefox http://localhost:54007/getInfo.html) 07:30:18 INFO - TEST-INFO | 12217: killed by SIGTERM 07:30:18 INFO - Browser initialized. 07:30:18 INFO - Running cycle 1/1 for dromaeo_css test... 07:30:18 INFO - TEST-INFO | started process 12429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwzVohX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:30 INFO - PID 12429 | RSS: Main: 184385536 07:30:30 INFO - PID 12429 | 07:33:32 INFO - PID 12429 | Cycle 1(1): loaded http://localhost:54007/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54007/tests/dromaeo/cssquery-ext.html) 07:33:34 INFO - PID 12429 | RSS: Main: 185229312 07:33:34 INFO - PID 12429 | 07:36:35 INFO - PID 12429 | Cycle 1(1): loaded http://localhost:54007/tests/dromaeo/cssquery-ext.html (next: http://localhost:54007/tests/dromaeo/cssquery-jquery.html) 07:36:36 INFO - PID 12429 | RSS: Main: 189669376 07:36:36 INFO - PID 12429 | 07:39:38 INFO - PID 12429 | Cycle 1(1): loaded http://localhost:54007/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54007/tests/dromaeo/cssquery-mootools.html) 07:39:38 INFO - PID 12429 | RSS: Main: 185319424 07:39:38 INFO - PID 12429 | 07:42:40 INFO - PID 12429 | Cycle 1(1): loaded http://localhost:54007/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54007/tests/dromaeo/cssquery-prototype.html) 07:42:41 INFO - PID 12429 | RSS: Main: 189050880 07:42:41 INFO - PID 12429 | 07:45:43 INFO - PID 12429 | Cycle 1(1): loaded http://localhost:54007/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54007/tests/dromaeo/cssquery-yui.html) 07:45:44 INFO - PID 12429 | RSS: Main: 189308928 07:45:44 INFO - PID 12429 | 07:48:46 INFO - PID 12429 | Cycle 1(1): loaded http://localhost:54007/tests/dromaeo/cssquery-yui.html (next: http://localhost:54007/tests/dromaeo/cssquery-dojo.html) 07:48:46 INFO - PID 12429 | RSS: Main: 188321792 07:48:46 INFO - PID 12429 | 07:48:46 INFO - PID 12429 | __start_tp_report 07:48:46 INFO - PID 12429 | _x_x_mozilla_page_load 07:48:46 INFO - PID 12429 | _x_x_mozilla_page_load_details 07:48:46 INFO - PID 12429 | |i|pagename|runs| 07:48:46 INFO - PID 12429 | |0;dojo.html;3010.623672040992;3054.3891221755653;3054.801437906537;3056.526238433042;3066.586010888531;5719.77120915164;5790.884182316357;5871.236739223906;5902.763889444428;6061.9696901515545;5902.291724992996;5941.376155503674;5953.285605727318;5982.940170598293;5983.730732117055;5407.026735187665;5434.2935418395555;5447.945520544803;5479.917801232985;5523.7790488380615;5445.918311225315;5490.231367608518;5504.366997795265;5507.091329930557;5525.171224316345;5265.684058956455;5278.9208161877605;5297.496737809902;5340.385855626575;5474.698891560963;5365.061114304981;5401.189821526802;5458.836234912959;5461.42655021221;5486.341639003305;5264.736763161826;5314.229436731691;5339.092354299778;5377.946220537784;5408.107662235766;5716.456936591017;5739.8565035874435;5744.454276843693;5749.8275051748515;5771.105478650816;6162.661053642048;6174.876502469971;6253.249610046778;6254.593451425689;6274.780382686584;6361;6362.586431881913;6405.807825765234;6429.903551446732;6439.388258115471;5884.617499862496;5968.641881487038;5971.820845374646;5972.880542389128;5990.400959904018;6563.671816409256;6568.7372505099265;6576.704048317837;6588.901166482507;6609.570377925419;6038.275406951194;6082;6115.96942015296;6126.540509461808;6144.446999770043;6101.674676856019;6121.84695382619;6144.4469997699525;6159.538034647419;6193.938060619426;6295.244570651551;6320.851258308445;6349.619022858643;6351;6380.9361906380345;6340.207474065742;6412;6415.647139407378;6424.71088801005;6424.743010279536;5214.243934629533;5215.400228973641;5222.556082732935;5235.607329450307;5236.581073514109;4451.221036318631;4458.598726114666;4459.175052615276;4461.330800379904;4481.708688935209;5433;5444.7822087116865;5504.036793561111;5505.504504594605;5512.944870551243;6207.099970504251;6283.874322513524;6285.717142728588;6306.2747784004505;6320.841978950563;5611.494965453129;5619.831405057855;5624.21261023457;5643.435656434323;5658.688772117573;5622.128570071645;5661.433856614306;5677.403872593401;5680.062789639664;5680.971595141998;6226.657533835501;6254.312025677172;6265.96867015662;6273.059041143682;6274.403931626488;6215.098810672517;6332.11350410952;6340;6348.079528468254;6404.231492220777;6185.597936134137;6226.62640241587;6230;6236.656983865931;6258.874822503433;6322.178116844781;6324.873502529832;6338.144350512806;6339.619622822645;6346.492280617632;6402.647854368054;6406.615603063831;6407.263164736115;6446.645434501147;6462.321456247214;5982.371850955761;6056.939430605814;6122.724477398617;6154.292256390393;6214.347493513297;6106.419890110433;6114.206128133811;6203.4416902479;6215.533834962486;6227.595206311576;6119.441623354662;6124.050772130327;6154.78458253959;6158.815235542941;6199.318075011835;6304.873902522016;6309.242890853127;6311.526635502264;6328.493720502441;6330.113784070142;5888.823335299948;6082.908756368746;6099.969500152471;6112.083187521907;6123.173371594778 07:48:46 INFO - PID 12429 | |1;ext.html;706.742039155708;771.5756334016289;783.4594130050261;784.2392878907461;1099.8350247462884;26944.730552694466;28263.293417664543;28329;35765;36656.816715916386;37901.81049094757;38625.227495450075;38690.8065459673;38731.80634096826;38781.80609096958;7127.501074924758;7305.707771689126;7309.524880882752;7315.378192853614;7339.816504587375;7201.243869393691;7260.056192694969;7283.635818209094;7289.343959043685;7304.3426091651745;7036.085308909835;7192.352688258055;7216.206217316091;7281.708731650728;7293.927060729377;7245.456590755714;7267;7333.6333183340885;7338.926610733878;7341.706331746724;7135.108111486064;7171.28287171284;7222.313880181375;7234.74678386254;7262.745803896891;35264.471032934525;35448.11379715502;35481.64518354835;35542;35613.10967225814;3465.2549701814232;3499.2826470573727;3506.4389697648508;3514.4728290756334;3533.876314328986;27428.588571171447;27588.724112758817;27630.585541216897;27682.723172768416;27776;3603.459481077833;3630.183208778004;3635.8545658173643;3692.723045771551;3743.3636281832155;144650.27674861663;144843.2757836204;145219;166911;168604;41359.7932010344;42121.78939105285;42299.57700422956;42313.57686423158;42499;43288.13423731508;43451.13097738028;43672.56327436749;43725.34411983823;43793.562064379585;14335.641608959859;14494.420223191166;14515.709685806225;14528.927355363367;14547;11867.703307417383;11911.285322880654;11918.821217681741;11943.223690460092;11945.522179112912;13141.685831416973;13163.73672526544;13223.471061157446;13291.136076155019;13442.865571344357;5318.813841515528;5322.893542129135;5390.51485366319;5409.5131438169965;5441.755121019563;962.5455089521691;965.1699538396973;970.5826494607387;994.080475560104;1035.2597892506894;21430.355840236403;21609.01367764112;21759.782402175777;22260.77739222587;22702;1057.5981127171626;1072.4369705904462;1096.5120521367915;1107.1087774341731;1124.3085502416118;11368.317900925971;11465.541378344773;11763.117766167572;11964.76070478603;12030.81953770694;201975;202512;203615;204202;204428;47474.28788568174;47815.282770758466;47914.76042619834;48190.5180948186;48266.5173348269;1400.5308221745624;1413.7384583852227;1423.0678905317034;1430.8569143085608;1454.2219912346843;24245.63631545493;27206.183814485597;27285.72714272832;27313.590296145176;27636.30909227205;34417.48373774345;34753.47869782006;34776.65223347734;34794.304113917075;34873.128171794895;174192;174449;175015;175783;176051;27631.171064868086;28212.153635390972;28275.575866362433;33053.834730826195;33087.172820679676;33635.49546756752;33810.15474613154;34681.65318346784;34969.65030349664;36063.27873442569;26675.19974400771;26738.064167754812;27355.31611709723;27661.861690691418;27696.584551231346;25981.350466238495;26638.255128461467;27452;27550.5867411993;27831.30421739473;28148.296292592848;28718.71281287244;28790.71209287964;29381.265468362606;29859.253518662208;24704.258872233862;25555.744442555337;25732.970681172545;26556.33609159709;27463.588046178924;19797.208111675372;21405.464863377918;21487;21695.566088678454;21821 07:48:46 INFO - PID 12429 | |2;jquery.html;472.09593628202;478.36855350936776;480.6875530904911;489.22702130633604;507.34552427368675;19960.5009874753;20632.277870274524;20645.690314645293;20712.689309660367;20721.79278207221;18623.44129676112;18735.3442629508;18846.43460696178;22191.334259972187;24270;6011.398860113975;6196.876062478747;6245.188125543673;6251.343608921066;6254.7498100075945;6184.226971628546;6223.408776166257;6228.128062071313;6228.19033525641;6234.50123990082;6175.536834737391;6184.938150618504;6185.505159587245;6187.81436556904;6191.164192833978;5746.396628354026;6024.006039003559;6059.3637668044885;6061.727222275008;6187.81436556904;5561.805336813232;5574.414686457904;5575.135853942605;5584;5608.887822243532;26235.475290494272;26647.333816654544;26673.866630666915;26698.599521007007;26699.19902402931;1901.5816520365636;1921.5868588253593;1925.7111433284979;1931.6136772645527;1940.7185958036148;16696.49910502687;17108.230129644195;17701.114944252866;17999.64000719978;18015.28854758796;2167.360628614547;2193.605151072806;2203.823694104468;2206.7682893296133;2207.569523942832;99994;104034.47982760037;104415;104588.47705761499;122014.38992805067;13187.406566704522;13384.130031547918;13474.709299419123;13544.93227533856;13911.4435422584;19948.50128746793;20072.799272007385;20079.29722459707;20111.899440502995;20165.798342016686;8722.34582406322;8906.287497000225;8988.59551320192;9119.81760364789;9367.391119577205;8498.362622803315;8531.74404767858;8549.059603443617;8557;8664.10115448051;8443.197896199852;8513.829723405497;8588.742337729878;8642.22220000203;8747.343949203836;2080.3342930262475;2097.168822090166;2106.7155933949025;2139.882306473159;2261.118163916074;940.2290122099812;940.9905900940903;956.8421210500189;988.4267125067444;995.382862625177;18838.905805470884;19113.52216194606;19304;19543.511412214524;19986.70019949702;973.6656489378041;981.4945303168873;1004.9949750251202;1013.9340942838692;1020.4234607446917;10219;10413.16694664425;10844.186685998582;10880.455977201267;10896.528968589297;388386;389386;437137;437422;442663;100650;101974.49012754888;105152;105254.19509037402;105260.47369763255;1070.1492313610697;1099.9670009899717;1125.6341688951125;1176.2824676947055;1223.2293654997295;18855.528611784266;20709.171633134505;20866.686999694713;21075.78924210738;21428;47928.28107578319;49132.263016055505;49294.01411971812;49826.50173498219;49915.50253492401;63034.36965630285;63582;64657.67671161614;64728.6763566198;64751.35248647642;11254.94372528132;11336.659900203007;11634.592789252674;11672.533098676298;11820.290782553075;16368.590785229988;16532.173391330143;16677.416290429777;17475.38836140729;18733.437996860117;14881;15528.456504022304;15627.687446251239;15757.054576725433;15806.841931580537;14006.719865602427;14126.152430854181;14217.715645687234;14579.854201457849;15116.244187790786;16145.112018838607;16191.919040404722;16455.67088658244;16509.504714858092;16545.66908661844;11281.830772538582;11354.148438866952;11472.541098355972;11477.885221148015;11530.711732206426;13836.446542138201;14831.555053348417;14855.48005819791;14909.10545367238;14934.55196344068 07:48:46 INFO - PID 12429 | |3;mootools.html;1286.196127420362;1344.1061693973509;1345.3407830163223;1346.1250187378203;1358.8165597644315;11658.358790266531;12073.75852482952;12147.817782733266;12151.39243037849;12161;11962.940185299061;12295.938520307409;12324.63026109216;12407.317597532132;12421.813672794915;2489.3527682802464;2545.618157276405;2547.2485616743106;2553.616957456378;2554.348641096527;2420;2505.110685706575;2506.636537702032;2519.395345117168;2519.937001574966;2085.645440275149;2432.404061005056;2466.2477944227003;2475.5296493666237;2476.3190122716305;2031.6850888112367;2058.6603210470253;2061.5979883922714;2315.166540045582;2420.322309753272;2467.703875534947;2475.9504809903883;2486.8880900359345;2487.9253622391357;2498.2879879234333;12119.878801212051;12268.938655306756;12271;12279.263244205376;12282.385880706019;6728.966355168192;7005.82485437863;7012.123484564429;7045.154581450259;7047.929520704779;4017.35722284436;4054.371572406252;4069.532003819569;4154.979225103855;4167.770772607505;1319.7558451686468;1373.0731756064617;1407.9577612671637;1409.9577012689635;1421.0549984260558;17660.205290761947;17671;17723.37968171121;17861.7320740189;17885.195166217552;5698.344690360579;5861.120831875168;5916.171735956969;6038.396160383926;6069.484093852072;13409.530666426823;13474.461021559027;13530;13530.188188708513;13540.255285959367;6678.065070890079;6867.278935711778;6878.243393226741;6886.48351373649;6887.20797108339;6198.6280823150755;6303.369663033752;6358.491320694333;6380.904286435707;6424.196975378078;4655.953440465552;4728.338032675429;4806.086843499724;4836.443808962014;4844.515548445198;1340;1375.4154484344115;1389.6178550898383;1395.9092658977133;1401.054288355356;822.153182222312;839.9370047246481;846.4159729786428;854.6111519258723;869.1786261982493;6426.35736426363;6803.0135630333325;6944.166699995932;7125.89311160333;7437.553746775211;908.1463424381061;910.3172620534599;943.9811203775886;962.2583124544457;971.7473456901115;4284.0071698864895;4304.440422745086;4520.824585607766;4582.816687332536;4704.717716936994;14962.850371496146;15665.216739162996;16017.919910400373;16133;16204.675906481805;15440.691186176213;15831.683366332609;15926.60183495422;16014.439494617633;16100.436484722979;8980.191782739454;9560.56977436017;9666.661666841626;9782.315237933277;9823.115919567274;6738.854454484473;6940.375366216863;7295.379892709179;7347.225034696251;7484.401247900264;13349.399277032362;14076.225807580682;14176;14306.928465357607;14358;13742.381592828548;14405;14560.199189044704;14571.417143314573;14585.197814120325;10122.139618132542;10224.897751022394;10333.276670632984;10356.17150627963;10356.948215259177;10651.627193048205;11392.601258955896;11486.885131148581;11536.942315288705;11563.710907227387;9223.492707900861;9401.200897923753;9594.904050959402;9831.606735730777;9946.751331216488;9404.811903762024;9502.429854208769;9558.713238602853;9584.089511496397;9711.125998660154;8243.299319557906;8326.29226515753;8343.624536895733;8377.874331884905;8399.832003360021;5863.941360586339;5995.550333724901;6006.669633170218;6089.117078023751;6323.083152942706;5878.588498805043;6045.335013148462;6089.847753806191;6096.603720758137;6251.4061164189325 07:48:46 INFO - PID 12429 | |4;prototype.html;442.4756663353926;442.8095918754936;443.9600435960763;462.52129046436926;476.27130490349754;6295.827939360919;6347.714352854121;6361.173047503824;6366.554341196118;6378.170837791081;5956.374580669021;6126.754929802813;6175.845603859906;6176.197094377724;6176.4749996250375;4934.876628084291;4944.357233559641;4959.156943319626;4968.130577149002;4968.87577810554;4873.1715608346485;4892.3884514435695;4894.751838281233;4961.479044700309;4977.576905962997;4802.855914322576;4827.710337379768;4834.7824347904425;4850.102730994778;4860.465348811628;4684.227102528079;4804.1352556539805;4833.347498087784;4857.247126695368;4876.2929375240565;4245.681573881971;4297.570242975708;4305.418768466248;4334.674899382528;4342.32693932441;6003.159557661931;6011.819645410645;6066.575339726177;6071.998120310143;6099.634021958696;5522.22688823565;5543.501084902337;5545.362283337387;5563.527100196488;5591.384947655754;6504.121943537609;6509.6419696916655;6512.837179070514;6536.705848236841;6543.247526534462;4690.882727931829;4691.366665500148;4701.224297990828;4702.670813043088;4739.00961596127;6861.656917154122;6868.278830722752;6913.446924246098;6923.723051077951;6962.443004559623;4816.638752093607;4817.855464336076;4835.8065677373215;4841.515848415201;4848.3454733610515;4834.274858771212;4864.805407783649;4877.097736918681;4895.657303988758;4900.387451568554;5565.16522521625;5579.13523403873;5607.943920560824;5608.691521966331;5624.072028115315;6593.142891424084;6608.50436217276;6633.9668301658185;6646.401823835878;6682.732690692318;1605.3177399605354;1706.3430579226838;1742.6863164630488;1744.2935611077535;1748.0647853398625;1170.7190274334098;1177.2400261608777;1182.1075088308273;1193.3198077095972;1194.6774370919977;5591.524720398812;5740.885182296414;5775.393583673737;5823.301203855564;5830.533557315404;6651.733930642817;6658.766943156967;6701.731930722716;6721.1598550181225;6747.561408508529;5715.657060576379;5764.550066221839;5801.6519008859605;5801.8549536261935;5832.795852145155;3556.822158892097;3604.116991337139;3604.585472670624;3613.385724426854;3616.4213725803747;6300.464460520815;6503.804885853432;6552.475801935833;6572.704228309737;6608.86782264352;6902.758403455855;6947.409470194989;6958.965205173941;6976.790696279119;6980.267071957372;6582.308857569982;6601.801945941629;6648.268690444047;6654.277321503503;6665;6737.427318677967;6757.628330441873;6758.797236082925;6771.864562708817;6849.931500684929;6758.763443279461;6763.5941843489545;6789.626570538668;6791.830204244933;6791.966040169767;6609.834754131185;6622.602643841192;6628.436582890316;6630.602163870183;6655.800325990228;4762.0713610987605;4780.641451891052;4804.735739534359;4817.110632707734;4822.276658501253;6728.7308507659145;6789.4568434524135;6795.864082718417;6832.760853370109;6848.00703897942;6563.737450501926;6614.206295244601;6626.734930602915;6642.903920853005;6646.2356828965285;6593.175853018372;6630.53586248958;6635.653646861314;6639.302873198245;6648.202215734143;6145.6927153641245;6507.674616269073;6537.8692426152165;6570.5729127606555;6570.605763654196;6463.676816159267;6524.3149469305035;6551.6069035858;6566.770163044271;6569.310222426577;6371.458426033839;6379.138816259746;6394.680265986775;6396.456301214449;6416.492124350867 07:48:46 INFO - PID 12429 | |5;yui.html;828.5898480252276;845.3279642684065;846.0608724316008;848.6393282854785;860.9225169734725;16632.168391580417;16892.83107168928;17075.231614577344;17076.48770536883;17089.230984605692;17150.399736009243;18272.451826445227;18301;18604.534886627807;18609.90695046523;994.7712026233988;1007.4308015970989;1011.8886922438562;1018.0786388318584;1018.3431686562163;1004.5429329655026;1009.808136454075;1013.6350913671073;1014.3001329082946;1014.7108074198854;955.6129767444196;1054.8945105489465;1057.820170571001;1059.809234337819;1061.1192710050639;1030.9948450257775;1040.3289878028668;1044.472541366605;1047.0838016735356;1047.2459828923163;757.0952711509748;761.7372006657749;763.0690557519872;763.4579448591506;764;15298.388064477407;17688.646227075515;17738.91130544339;17825;17835;16846.157692115346;16877.071761053136;16922.153892305458;17083.91458042702;17099.91450042754;15131.470398536;15199.848001520064;15239.61900952474;15250.847491525165;15402.152881591508;3449.292894956528;3501.38725723;3503.439449688063;3509.31568344173;3523.4714792781288;79235;81353.59323203405;82611.5869420655;90295.54852225762;95132.04867951301;15415.922920385327;15514.612134696723;15564.143972081418;15581.220938953007;15675.137867417401;25861.870690646425;26201.344966375993;26288;26961.191164265103;27136.864315678296;8123.79690507742;8149.062857771313;8190.262876341158;8194.836103277901;8212.17878212186;3793.393057110904;3860.536735591691;3923.725339226227;3971.62269584389;3972.2651309507833;4397.31841564558;4445.866624001285;4510.36854840316;4512.300593408027;4516.187086324493;769.6459628570808;849.1508491508491;859.4456575508887;862.8403745307138;863.317978796756;620.8199622109538;684.4729558240127;711.0933559711306;712.9394001509826;731.0824914732084;10642.468886446724;11937.820932686016;12178.147529673015;12221;12682.112252142446;681.1213534540387;700.2472342232121;702.7540360873755;706.9328413800681;728.6720975561019;4969.428515720739;5508.862278442991;5549.223108764776;5591.404288872645;5641.492265696107;84736;88741;90413.64379534312;93560.53219733857;94409;76432;76766.23233767702;77127;78870;80145.59927200327;60442.39557604455;61320.999999999105;64306.356936430035;64332;64414.677926610064;10826.296290741391;10836.620718274822;11166;11170.720731981766;11503.53985840557;26394;28262.43475130445;28304;28673;29861.55207671843;34164.82917585396;34977.825110874284;35805.283894321445;36108.63891361053;37378.6262137386;14917.552473425814;15416.922915385352;15458.84541154619;15527.223638817788;15539.84460155384;18696.06519674038;19027.429177124708;19273.710894336316;19329.323473678916;19348.8065119347;16131;16611.41860034893;16697.49907502777;16854.410095647083;17232.138393080546;15868.682626347178;17081.31674732997;17544.385946491813;17670.381536646157;17686.115694215496;15245.771313430529;15322.157281349633;15331.080135191924;15408.691826163638;15409.537713868602;9533.809323813624;9879.110880020833;9982;10430.582776688847;10646.20153488507;12335.69160770988;12682.556110536087;12783.105182637126;12894.790078501477;13011.284379358847 07:48:46 INFO - PID 12429 | __end_tp_report 07:48:46 INFO - PID 12429 | __start_cc_report 07:48:46 INFO - PID 12429 | _x_x_mozilla_cycle_collect,405 07:48:46 INFO - PID 12429 | __end_cc_report 07:48:46 INFO - PID 12429 | __startTimestamp1497278926495__endTimestamp 07:48:46 INFO - PID 12429 | 07:48:46 INFO - PID 12429 | ------- Summary: start ------- 07:48:46 INFO - PID 12429 | Number of tests: 6 07:48:46 INFO - PID 12429 | 07:48:46 INFO - PID 12429 | [#0] dojo.html Cycles:165 Average:5847.07 Median:6101.67 stddev:675.03 (11.1%) stddev-sans-first:639.38 07:48:46 INFO - PID 12429 | Values: 3010.6 3054.4 3054.8 3056.5 3066.6 5719.8 5790.9 5871.2 5902.8 6062.0 5902.3 5941.4 5953.3 5982.9 5983.7 5407.0 5434.3 5447.9 5479.9 5523.8 5445.9 5490.2 5504.4 5507.1 5525.2 5265.7 5278.9 5297.5 5340.4 5474.7 5365.1 5401.2 5458.8 5461.4 5486.3 5264.7 5314.2 5339.1 5377.9 5408.1 5716.5 5739.9 5744.5 5749.8 5771.1 6162.7 6174.9 6253.2 6254.6 6274.8 6361.0 6362.6 6405.8 6429.9 6439.4 5884.6 5968.6 5971.8 5972.9 5990.4 6563.7 6568.7 6576.7 6588.9 6609.6 6038.3 6082.0 6116.0 6126.5 6144.4 6101.7 6121.8 6144.4 6159.5 6193.9 6295.2 6320.9 6349.6 6351.0 6380.9 6340.2 6412.0 6415.6 6424.7 6424.7 5214.2 5215.4 5222.6 5235.6 5236.6 4451.2 4458.6 4459.2 4461.3 4481.7 5433.0 5444.8 5504.0 5505.5 5512.9 6207.1 6283.9 6285.7 6306.3 6320.8 5611.5 5619.8 5624.2 5643.4 5658.7 5622.1 5661.4 5677.4 5680.1 5681.0 6226.7 6254.3 6266.0 6273.1 6274.4 6215.1 6332.1 6340.0 6348.1 6404.2 6185.6 6226.6 6230.0 6236.7 6258.9 6322.2 6324.9 6338.1 6339.6 6346.5 6402.6 6406.6 6407.3 6446.6 6462.3 5982.4 6056.9 6122.7 6154.3 6214.3 6106.4 6114.2 6203.4 6215.5 6227.6 6119.4 6124.1 6154.8 6158.8 6199.3 6304.9 6309.2 6311.5 6328.5 6330.1 5888.8 6082.9 6100.0 6112.1 6123.2 07:48:46 INFO - PID 12429 | 07:48:46 INFO - PID 12429 | [#1] ext.html Cycles:180 Average:32836.11 Median:29085.99 stddev:46215.72 (158.9%) stddev-sans-first:46282.39 07:48:46 INFO - PID 12429 | Values: 706.7 771.6 783.5 784.2 1099.8 26944.7 28263.3 28329.0 35765.0 36656.8 37901.8 38625.2 38690.8 38731.8 38781.8 7127.5 7305.7 7309.5 7315.4 7339.8 7201.2 7260.1 7283.6 7289.3 7304.3 7036.1 7192.4 7216.2 7281.7 7293.9 7245.5 7267.0 7333.6 7338.9 7341.7 7135.1 7171.3 7222.3 7234.7 7262.7 35264.5 35448.1 35481.6 35542.0 35613.1 3465.3 3499.3 3506.4 3514.5 3533.9 27428.6 27588.7 27630.6 27682.7 27776.0 3603.5 3630.2 3635.9 3692.7 3743.4 144650.3 144843.3 145219.0 166911.0 168604.0 41359.8 42121.8 42299.6 42313.6 42499.0 43288.1 43451.1 43672.6 43725.3 43793.6 14335.6 14494.4 14515.7 14528.9 14547.0 11867.7 11911.3 11918.8 11943.2 11945.5 13141.7 13163.7 13223.5 13291.1 13442.9 5318.8 5322.9 5390.5 5409.5 5441.8 962.5 965.2 970.6 994.1 1035.3 21430.4 21609.0 21759.8 22260.8 22702.0 1057.6 1072.4 1096.5 1107.1 1124.3 11368.3 11465.5 11763.1 11964.8 12030.8 201975.0 202512.0 203615.0 204202.0 204428.0 47474.3 47815.3 47914.8 48190.5 48266.5 1400.5 1413.7 1423.1 1430.9 1454.2 24245.6 27206.2 27285.7 27313.6 27636.3 34417.5 34753.5 34776.7 34794.3 34873.1 174192.0 174449.0 175015.0 175783.0 176051.0 27631.2 28212.2 28275.6 33053.8 33087.2 33635.5 33810.2 34681.7 34969.7 36063.3 26675.2 26738.1 27355.3 27661.9 27696.6 25981.4 26638.3 27452.0 27550.6 27831.3 28148.3 28718.7 28790.7 29381.3 29859.3 24704.3 25555.7 25733.0 26556.3 27463.6 19797.2 21405.5 21487.0 21695.6 21821.0 07:48:46 INFO - PID 12429 | 07:48:46 INFO - PID 12429 | [#2] jquery.html Cycles:180 Average:29990.95 Median:20717.24 stddev:70486.26 (340.2%) stddev-sans-first:70649.15 07:48:46 INFO - PID 12429 | Values: 472.1 478.4 480.7 489.2 507.3 19960.5 20632.3 20645.7 20712.7 20721.8 18623.4 18735.3 18846.4 22191.3 24270.0 6011.4 6196.9 6245.2 6251.3 6254.7 6184.2 6223.4 6228.1 6228.2 6234.5 6175.5 6184.9 6185.5 6187.8 6191.2 5746.4 6024.0 6059.4 6061.7 6187.8 5561.8 5574.4 5575.1 5584.0 5608.9 26235.5 26647.3 26673.9 26698.6 26699.2 1901.6 1921.6 1925.7 1931.6 1940.7 16696.5 17108.2 17701.1 17999.6 18015.3 2167.4 2193.6 2203.8 2206.8 2207.6 99994.0 104034.5 104415.0 104588.5 122014.4 13187.4 13384.1 13474.7 13544.9 13911.4 19948.5 20072.8 20079.3 20111.9 20165.8 8722.3 8906.3 8988.6 9119.8 9367.4 8498.4 8531.7 8549.1 8557.0 8664.1 8443.2 8513.8 8588.7 8642.2 8747.3 2080.3 2097.2 2106.7 2139.9 2261.1 940.2 941.0 956.8 988.4 995.4 18838.9 19113.5 19304.0 19543.5 19986.7 973.7 981.5 1005.0 1013.9 1020.4 10219.0 10413.2 10844.2 10880.5 10896.5 388386.0 389386.0 437137.0 437422.0 442663.0 100650.0 101974.5 105152.0 105254.2 105260.5 1070.1 1100.0 1125.6 1176.3 1223.2 18855.5 20709.2 20866.7 21075.8 21428.0 47928.3 49132.3 49294.0 49826.5 49915.5 63034.4 63582.0 64657.7 64728.7 64751.4 11254.9 11336.7 11634.6 11672.5 11820.3 16368.6 16532.2 16677.4 17475.4 18733.4 14881.0 15528.5 15627.7 15757.1 15806.8 14006.7 14126.2 14217.7 14579.9 15116.2 16145.1 16191.9 16455.7 16509.5 16545.7 11281.8 11354.1 11472.5 11477.9 11530.7 13836.4 14831.6 14855.5 14909.1 14934.6 07:48:46 INFO - PID 12429 | 07:48:46 INFO - PID 12429 | [#3] mootools.html Cycles:180 Average:7504.86 Median:2532.78 stddev:4844.20 (191.3%) stddev-sans-first:4835.24 07:48:46 INFO - PID 12429 | Values: 1286.2 1344.1 1345.3 1346.1 1358.8 11658.4 12073.8 12147.8 12151.4 12161.0 11962.9 12295.9 12324.6 12407.3 12421.8 2489.4 2545.6 2547.2 2553.6 2554.3 2420.0 2505.1 2506.6 2519.4 2519.9 2085.6 2432.4 2466.2 2475.5 2476.3 2031.7 2058.7 2061.6 2315.2 2420.3 2467.7 2476.0 2486.9 2487.9 2498.3 12119.9 12268.9 12271.0 12279.3 12282.4 6729.0 7005.8 7012.1 7045.2 7047.9 4017.4 4054.4 4069.5 4155.0 4167.8 1319.8 1373.1 1408.0 1410.0 1421.1 17660.2 17671.0 17723.4 17861.7 17885.2 5698.3 5861.1 5916.2 6038.4 6069.5 13409.5 13474.5 13530.0 13530.2 13540.3 6678.1 6867.3 6878.2 6886.5 6887.2 6198.6 6303.4 6358.5 6380.9 6424.2 4656.0 4728.3 4806.1 4836.4 4844.5 1340.0 1375.4 1389.6 1395.9 1401.1 822.2 839.9 846.4 854.6 869.2 6426.4 6803.0 6944.2 7125.9 7437.6 908.1 910.3 944.0 962.3 971.7 4284.0 4304.4 4520.8 4582.8 4704.7 14962.9 15665.2 16017.9 16133.0 16204.7 15440.7 15831.7 15926.6 16014.4 16100.4 8980.2 9560.6 9666.7 9782.3 9823.1 6738.9 6940.4 7295.4 7347.2 7484.4 13349.4 14076.2 14176.0 14306.9 14358.0 13742.4 14405.0 14560.2 14571.4 14585.2 10122.1 10224.9 10333.3 10356.2 10356.9 10651.6 11392.6 11486.9 11536.9 11563.7 9223.5 9401.2 9594.9 9831.6 9946.8 9404.8 9502.4 9558.7 9584.1 9711.1 8243.3 8326.3 8343.6 8377.9 8399.8 5863.9 5995.6 6006.7 6089.1 6323.1 5878.6 6045.3 6089.8 6096.6 6251.4 07:48:46 INFO - PID 12429 | 07:48:46 INFO - PID 12429 | [#4] prototype.html Cycles:180 Average:5490.59 Median:6113.19 stddev:1588.74 (26.0%) stddev-sans-first:1547.35 07:48:46 INFO - PID 12429 | Values: 442.5 442.8 444.0 462.5 476.3 6295.8 6347.7 6361.2 6366.6 6378.2 5956.4 6126.8 6175.8 6176.2 6176.5 4934.9 4944.4 4959.2 4968.1 4968.9 4873.2 4892.4 4894.8 4961.5 4977.6 4802.9 4827.7 4834.8 4850.1 4860.5 4684.2 4804.1 4833.3 4857.2 4876.3 4245.7 4297.6 4305.4 4334.7 4342.3 6003.2 6011.8 6066.6 6072.0 6099.6 5522.2 5543.5 5545.4 5563.5 5591.4 6504.1 6509.6 6512.8 6536.7 6543.2 4690.9 4691.4 4701.2 4702.7 4739.0 6861.7 6868.3 6913.4 6923.7 6962.4 4816.6 4817.9 4835.8 4841.5 4848.3 4834.3 4864.8 4877.1 4895.7 4900.4 5565.2 5579.1 5607.9 5608.7 5624.1 6593.1 6608.5 6634.0 6646.4 6682.7 1605.3 1706.3 1742.7 1744.3 1748.1 1170.7 1177.2 1182.1 1193.3 1194.7 5591.5 5740.9 5775.4 5823.3 5830.5 6651.7 6658.8 6701.7 6721.2 6747.6 5715.7 5764.6 5801.7 5801.9 5832.8 3556.8 3604.1 3604.6 3613.4 3616.4 6300.5 6503.8 6552.5 6572.7 6608.9 6902.8 6947.4 6959.0 6976.8 6980.3 6582.3 6601.8 6648.3 6654.3 6665.0 6737.4 6757.6 6758.8 6771.9 6849.9 6758.8 6763.6 6789.6 6791.8 6792.0 6609.8 6622.6 6628.4 6630.6 6655.8 4762.1 4780.6 4804.7 4817.1 4822.3 6728.7 6789.5 6795.9 6832.8 6848.0 6563.7 6614.2 6626.7 6642.9 6646.2 6593.2 6630.5 6635.7 6639.3 6648.2 6145.7 6507.7 6537.9 6570.6 6570.6 6463.7 6524.3 6551.6 6566.8 6569.3 6371.5 6379.1 6394.7 6396.5 6416.5 07:48:46 INFO - PID 12429 | 07:48:46 INFO - PID 12429 | [#5] yui.html Cycles:180 Average:18628.58 Median:26031.61 stddev:23432.64 (90.0%) stddev-sans-first:23460.25 07:48:46 INFO - PID 12429 | Values: 828.6 845.3 846.1 848.6 860.9 16632.2 16892.8 17075.2 17076.5 17089.2 17150.4 18272.5 18301.0 18604.5 18609.9 994.8 1007.4 1011.9 1018.1 1018.3 1004.5 1009.8 1013.6 1014.3 1014.7 955.6 1054.9 1057.8 1059.8 1061.1 1031.0 1040.3 1044.5 1047.1 1047.2 757.1 761.7 763.1 763.5 764.0 15298.4 17688.6 17738.9 17825.0 17835.0 16846.2 16877.1 16922.2 17083.9 17099.9 15131.5 15199.8 15239.6 15250.8 15402.2 3449.3 3501.4 3503.4 3509.3 3523.5 79235.0 81353.6 82611.6 90295.5 95132.0 15415.9 15514.6 15564.1 15581.2 15675.1 25861.9 26201.3 26288.0 26961.2 27136.9 8123.8 8149.1 8190.3 8194.8 8212.2 3793.4 3860.5 3923.7 3971.6 3972.3 4397.3 4445.9 4510.4 4512.3 4516.2 769.6 849.2 859.4 862.8 863.3 620.8 684.5 711.1 712.9 731.1 10642.5 11937.8 12178.1 12221.0 12682.1 681.1 700.2 702.8 706.9 728.7 4969.4 5508.9 5549.2 5591.4 5641.5 84736.0 88741.0 90413.6 93560.5 94409.0 76432.0 76766.2 77127.0 78870.0 80145.6 60442.4 61321.0 64306.4 64332.0 64414.7 10826.3 10836.6 11166.0 11170.7 11503.5 26394.0 28262.4 28304.0 28673.0 29861.6 34164.8 34977.8 35805.3 36108.6 37378.6 14917.6 15416.9 15458.8 15527.2 15539.8 18696.1 19027.4 19273.7 19329.3 19348.8 16131.0 16611.4 16697.5 16854.4 17232.1 15868.7 17081.3 17544.4 17670.4 17686.1 15245.8 15322.2 15331.1 15408.7 15409.5 9533.8 9879.1 9982.0 10430.6 10646.2 12335.7 12682.6 12783.1 12894.8 13011.3 07:48:46 INFO - PID 12429 | -------- Summary: end -------- 07:48:46 INFO - PID 12429 | 07:48:47 INFO - TEST-INFO | 12429: exit 0 07:48:47 INFO - TEST-OK | dromaeo_css | took 1144569ms 07:48:47 INFO - TEST-START | kraken 07:48:47 INFO - operating with platform_type : linux_ 07:48:47 INFO - Initialising browser for kraken test... 07:48:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54007/getInfo.html -profile /tmp/tmpRQtrv7/profile 07:48:47 INFO - TEST-INFO | started process 12840 (/builds/slave/test/build/application/firefox/firefox http://localhost:54007/getInfo.html) 07:49:22 INFO - TEST-INFO | 12840: killed by SIGTERM 07:49:22 INFO - Browser initialized. 07:49:22 INFO - Running cycle 1/1 for kraken test... 07:49:22 INFO - TEST-INFO | started process 13047 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRQtrv7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:34 INFO - PID 13047 | RSS: Main: 184504320 07:49:34 INFO - PID 13047 | 07:49:37 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54007/tests/kraken/driver.html?testName=audio-beat-detection) 07:49:38 INFO - PID 13047 | RSS: Main: 187142144 07:49:38 INFO - PID 13047 | 07:49:40 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54007/tests/kraken/driver.html?testName=audio-dft) 07:49:41 INFO - PID 13047 | RSS: Main: 187531264 07:49:41 INFO - PID 13047 | 07:49:44 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54007/tests/kraken/driver.html?testName=audio-fft) 07:49:44 INFO - PID 13047 | RSS: Main: 183365632 07:49:44 INFO - PID 13047 | 07:49:46 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54007/tests/kraken/driver.html?testName=audio-oscillator) 07:49:47 INFO - PID 13047 | RSS: Main: 184975360 07:49:47 INFO - PID 13047 | 07:49:49 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54007/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:49:50 INFO - PID 13047 | RSS: Main: 184840192 07:49:50 INFO - PID 13047 | 07:49:53 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54007/tests/kraken/driver.html?testName=imaging-darkroom) 07:49:54 INFO - PID 13047 | RSS: Main: 185864192 07:49:54 INFO - PID 13047 | 07:49:57 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54007/tests/kraken/driver.html?testName=imaging-desaturate) 07:49:58 INFO - PID 13047 | RSS: Main: 187105280 07:49:58 INFO - PID 13047 | 07:50:01 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54007/tests/kraken/driver.html?testName=json-parse-financial) 07:50:01 INFO - PID 13047 | RSS: Main: 186593280 07:50:01 INFO - PID 13047 | 07:50:03 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54007/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:50:03 INFO - PID 13047 | RSS: Main: 186544128 07:50:03 INFO - PID 13047 | 07:50:05 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:50:06 INFO - PID 13047 | RSS: Main: 186118144 07:50:06 INFO - PID 13047 | 07:50:08 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:50:09 INFO - PID 13047 | RSS: Main: 186064896 07:50:09 INFO - PID 13047 | 07:50:11 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:50:12 INFO - PID 13047 | RSS: Main: 186130432 07:50:12 INFO - PID 13047 | 07:50:15 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:50:16 INFO - PID 13047 | RSS: Main: 186093568 07:50:16 INFO - PID 13047 | 07:50:17 INFO - PID 13047 | Cycle 1(1): loaded http://localhost:54007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54007/tests/kraken/driver.html?testName=ai-astar) 07:50:18 INFO - PID 13047 | RSS: Main: 187420672 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | __start_tp_report 07:50:18 INFO - PID 13047 | _x_x_mozilla_page_load 07:50:18 INFO - PID 13047 | _x_x_mozilla_page_load_details 07:50:18 INFO - PID 13047 | |i|pagename|runs| 07:50:18 INFO - PID 13047 | |0;ai-astar;105;110;111;108;143;110;111;113;110;112 07:50:18 INFO - PID 13047 | |1;audio-beat-detection;156;125;153;173;124;158;146;121;173;123 07:50:18 INFO - PID 13047 | |2;audio-dft;164;165;163;162;165;176;172;168;179;165 07:50:18 INFO - PID 13047 | |3;audio-fft;74;75;75;155;75;74;77;74;96;77 07:50:18 INFO - PID 13047 | |4;audio-oscillator;86;82;134;84;83;83;137;84;83;130 07:50:18 INFO - PID 13047 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;114;114;114 07:50:18 INFO - PID 13047 | |6;imaging-darkroom;151;152;150;152;151;152;151;151;151;153 07:50:18 INFO - PID 13047 | |7;imaging-desaturate;95;96;94;99;94;95;95;94;94;94 07:50:18 INFO - PID 13047 | |8;json-parse-financial;56;53;53;54;54;57;57;54;53;55 07:50:18 INFO - PID 13047 | |9;json-stringify-tinderbox;56;56;56;56;57;56;56;57;57;56 07:50:18 INFO - PID 13047 | |10;stanford-crypto-aes;81;78;78;79;78;78;87;78;87;79 07:50:18 INFO - PID 13047 | |11;stanford-crypto-ccm;137;131;129;130;137;133;130;132;138;151 07:50:18 INFO - PID 13047 | |12;stanford-crypto-pbkdf2;182;197;192;191;191;201;198;188;189;181 07:50:18 INFO - PID 13047 | |13;stanford-crypto-sha256-iterative;70;74;75;71;72;69;74;72;73;74 07:50:18 INFO - PID 13047 | __end_tp_report 07:50:18 INFO - PID 13047 | __start_cc_report 07:50:18 INFO - PID 13047 | _x_x_mozilla_cycle_collect,1012 07:50:18 INFO - PID 13047 | __end_cc_report 07:50:18 INFO - PID 13047 | __startTimestamp1497279018197__endTimestamp 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | ------- Summary: start ------- 07:50:18 INFO - PID 13047 | Number of tests: 14 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#0] ai-astar Cycles:10 Average:113.30 Median:111.00 stddev:10.67 (9.6%) stddev-sans-first:10.88 07:50:18 INFO - PID 13047 | Values: 105.0 110.0 111.0 108.0 143.0 110.0 111.0 113.0 110.0 112.0 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:154.50 stddev:20.61 (13.3%) stddev-sans-first:21.49 07:50:18 INFO - PID 13047 | Values: 156.0 125.0 153.0 173.0 124.0 158.0 146.0 121.0 173.0 123.0 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#2] audio-dft Cycles:10 Average:167.90 Median:166.50 stddev:5.82 (3.5%) stddev-sans-first:6.00 07:50:18 INFO - PID 13047 | Values: 164.0 165.0 163.0 162.0 165.0 176.0 172.0 168.0 179.0 165.0 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#3] audio-fft Cycles:10 Average:85.20 Median:75.00 stddev:25.41 (33.9%) stddev-sans-first:26.63 07:50:18 INFO - PID 13047 | Values: 74.0 75.0 75.0 155.0 75.0 74.0 77.0 74.0 96.0 77.0 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:83.00 stddev:24.28 (29.2%) stddev-sans-first:25.32 07:50:18 INFO - PID 13047 | Values: 86.0 82.0 134.0 84.0 83.0 83.0 137.0 84.0 83.0 130.0 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:50:18 INFO - PID 13047 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 07:50:18 INFO - PID 13047 | Values: 151.0 152.0 150.0 152.0 151.0 152.0 151.0 151.0 151.0 153.0 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.56 (1.6%) stddev-sans-first:1.66 07:50:18 INFO - PID 13047 | Values: 95.0 96.0 94.0 99.0 94.0 95.0 95.0 94.0 94.0 94.0 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:1.58 (2.9%) stddev-sans-first:1.59 07:50:18 INFO - PID 13047 | Values: 56.0 53.0 53.0 54.0 54.0 57.0 57.0 54.0 53.0 55.0 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 07:50:18 INFO - PID 13047 | Values: 56.0 56.0 56.0 56.0 57.0 56.0 56.0 57.0 57.0 56.0 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:79.00 stddev:3.65 (4.6%) stddev-sans-first:3.87 07:50:18 INFO - PID 13047 | Values: 81.0 78.0 78.0 79.0 78.0 78.0 87.0 78.0 87.0 79.0 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:135.00 stddev:6.56 (4.9%) stddev-sans-first:6.91 07:50:18 INFO - PID 13047 | Values: 137.0 131.0 129.0 130.0 137.0 133.0 130.0 132.0 138.0 151.0 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.00 Median:191.50 stddev:6.50 (3.4%) stddev-sans-first:6.02 07:50:18 INFO - PID 13047 | Values: 182.0 197.0 192.0 191.0 191.0 201.0 198.0 188.0 189.0 181.0 07:50:18 INFO - PID 13047 | 07:50:18 INFO - PID 13047 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.50 stddev:1.96 (2.7%) stddev-sans-first:1.87 07:50:18 INFO - PID 13047 | Values: 70.0 74.0 75.0 71.0 72.0 69.0 74.0 72.0 73.0 74.0 07:50:18 INFO - PID 13047 | -------- Summary: end -------- 07:50:18 INFO - PID 13047 | 07:50:19 INFO - TEST-INFO | 13047: exit 0 07:50:19 INFO - TEST-OK | kraken | took 91973ms 07:50:19 INFO - SUITE-END | took 1236s 07:50:19 INFO - Completed test suite (00:20:37) 07:50:19 INFO - javascript benchmark 07:50:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7746.16601728342, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3010.623672040992, 3054.3891221755653, 3054.801437906537, 3056.526238433042, 3066.586010888531, 5719.77120915164, 5790.884182316357, 5871.236739223906, 5902.763889444428, 6061.9696901515545, 5902.291724992996, 5941.376155503674, 5953.285605727318, 5982.940170598293, 5983.730732117055, 5407.026735187665, 5434.2935418395555, 5447.945520544803, 5479.917801232985, 5523.7790488380615, 5445.918311225315, 5490.231367608518, 5504.366997795265, 5507.091329930557, 5525.171224316345, 5265.684058956455, 5278.9208161877605, 5297.496737809902, 5340.385855626575, 5474.698891560963, 5365.061114304981, 5401.189821526802, 5458.836234912959, 5461.42655021221, 5486.341639003305, 5264.736763161826, 5314.229436731691, 5339.092354299778, 5377.946220537784, 5408.107662235766, 5716.456936591017, 5739.8565035874435, 5744.454276843693, 5749.8275051748515, 5771.105478650816, 6162.661053642048, 6174.876502469971, 6253.249610046778, 6254.593451425689, 6274.780382686584, 6361.0, 6362.586431881913, 6405.807825765234, 6429.903551446732, 6439.388258115471, 5884.617499862496, 5968.641881487038, 5971.820845374646, 5972.880542389128, 5990.400959904018, 6563.671816409256, 6568.7372505099265, 6576.704048317837, 6588.901166482507, 6609.570377925419, 6038.275406951194, 6082.0, 6115.96942015296, 6126.540509461808, 6144.446999770043, 6101.674676856019, 6121.84695382619, 6144.4469997699525, 6159.538034647419, 6193.938060619426, 6295.244570651551, 6320.851258308445, 6349.619022858643, 6351.0, 6380.9361906380345, 6340.207474065742, 6412.0, 6415.647139407378, 6424.71088801005, 6424.743010279536, 5214.243934629533, 5215.400228973641, 5222.556082732935, 5235.607329450307, 5236.581073514109, 4451.221036318631, 4458.598726114666, 4459.175052615276, 4461.330800379904, 4481.708688935209, 5433.0, 5444.7822087116865, 5504.036793561111, 5505.504504594605, 5512.944870551243, 6207.099970504251, 6283.874322513524, 6285.717142728588, 6306.2747784004505, 6320.841978950563, 5611.494965453129, 5619.831405057855, 5624.21261023457, 5643.435656434323, 5658.688772117573, 5622.128570071645, 5661.433856614306, 5677.403872593401, 5680.062789639664, 5680.971595141998, 6226.657533835501, 6254.312025677172, 6265.96867015662, 6273.059041143682, 6274.403931626488, 6215.098810672517, 6332.11350410952, 6340.0, 6348.079528468254, 6404.231492220777, 6185.597936134137, 6226.62640241587, 6230.0, 6236.656983865931, 6258.874822503433, 6322.178116844781, 6324.873502529832, 6338.144350512806, 6339.619622822645, 6346.492280617632, 6402.647854368054, 6406.615603063831, 6407.263164736115, 6446.645434501147, 6462.321456247214, 5982.371850955761, 6056.939430605814, 6122.724477398617, 6154.292256390393, 6214.347493513297, 6106.419890110433, 6114.206128133811, 6203.4416902479, 6215.533834962486, 6227.595206311576, 6119.441623354662, 6124.050772130327, 6154.78458253959, 6158.815235542941, 6199.318075011835, 6304.873902522016, 6309.242890853127, 6311.526635502264, 6328.493720502441, 6330.113784070142, 5888.823335299948, 6082.908756368746, 6099.969500152471, 6112.083187521907, 6123.173371594778], "value": 5797.732302420148, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.742039155708, 771.5756334016289, 783.4594130050261, 784.2392878907461, 1099.8350247462884, 26944.730552694466, 28263.293417664543, 28329.0, 35765.0, 36656.816715916386, 37901.81049094757, 38625.227495450075, 38690.8065459673, 38731.80634096826, 38781.80609096958, 7127.501074924758, 7305.707771689126, 7309.524880882752, 7315.378192853614, 7339.816504587375, 7201.243869393691, 7260.056192694969, 7283.635818209094, 7289.343959043685, 7304.3426091651745, 7036.085308909835, 7192.352688258055, 7216.206217316091, 7281.708731650728, 7293.927060729377, 7245.456590755714, 7267.0, 7333.6333183340885, 7338.926610733878, 7341.706331746724, 7135.108111486064, 7171.28287171284, 7222.313880181375, 7234.74678386254, 7262.745803896891, 35264.471032934525, 35448.11379715502, 35481.64518354835, 35542.0, 35613.10967225814, 3465.2549701814232, 3499.2826470573727, 3506.4389697648508, 3514.4728290756334, 3533.876314328986, 27428.588571171447, 27588.724112758817, 27630.585541216897, 27682.723172768416, 27776.0, 3603.459481077833, 3630.183208778004, 3635.8545658173643, 3692.723045771551, 3743.3636281832155, 144650.27674861663, 144843.2757836204, 145219.0, 166911.0, 168604.0, 41359.7932010344, 42121.78939105285, 42299.57700422956, 42313.57686423158, 42499.0, 43288.13423731508, 43451.13097738028, 43672.56327436749, 43725.34411983823, 43793.562064379585, 14335.641608959859, 14494.420223191166, 14515.709685806225, 14528.927355363367, 14547.0, 11867.703307417383, 11911.285322880654, 11918.821217681741, 11943.223690460092, 11945.522179112912, 13141.685831416973, 13163.73672526544, 13223.471061157446, 13291.136076155019, 13442.865571344357, 5318.813841515528, 5322.893542129135, 5390.51485366319, 5409.5131438169965, 5441.755121019563, 962.5455089521691, 965.1699538396973, 970.5826494607387, 994.080475560104, 1035.2597892506894, 21430.355840236403, 21609.01367764112, 21759.782402175777, 22260.77739222587, 22702.0, 1057.5981127171626, 1072.4369705904462, 1096.5120521367915, 1107.1087774341731, 1124.3085502416118, 11368.317900925971, 11465.541378344773, 11763.117766167572, 11964.76070478603, 12030.81953770694, 201975.0, 202512.0, 203615.0, 204202.0, 204428.0, 47474.28788568174, 47815.282770758466, 47914.76042619834, 48190.5180948186, 48266.5173348269, 1400.5308221745624, 1413.7384583852227, 1423.0678905317034, 1430.8569143085608, 1454.2219912346843, 24245.63631545493, 27206.183814485597, 27285.72714272832, 27313.590296145176, 27636.30909227205, 34417.48373774345, 34753.47869782006, 34776.65223347734, 34794.304113917075, 34873.128171794895, 174192.0, 174449.0, 175015.0, 175783.0, 176051.0, 27631.171064868086, 28212.153635390972, 28275.575866362433, 33053.834730826195, 33087.172820679676, 33635.49546756752, 33810.15474613154, 34681.65318346784, 34969.65030349664, 36063.27873442569, 26675.19974400771, 26738.064167754812, 27355.31611709723, 27661.861690691418, 27696.584551231346, 25981.350466238495, 26638.255128461467, 27452.0, 27550.5867411993, 27831.30421739473, 28148.296292592848, 28718.71281287244, 28790.71209287964, 29381.265468362606, 29859.253518662208, 24704.258872233862, 25555.744442555337, 25732.970681172545, 26556.33609159709, 27463.588046178924, 19797.208111675372, 21405.464863377918, 21487.0, 21695.566088678454, 21821.0], "value": 15476.672675245702, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.09593628202, 478.36855350936776, 480.6875530904911, 489.22702130633604, 507.34552427368675, 19960.5009874753, 20632.277870274524, 20645.690314645293, 20712.689309660367, 20721.79278207221, 18623.44129676112, 18735.3442629508, 18846.43460696178, 22191.334259972187, 24270.0, 6011.398860113975, 6196.876062478747, 6245.188125543673, 6251.343608921066, 6254.7498100075945, 6184.226971628546, 6223.408776166257, 6228.128062071313, 6228.19033525641, 6234.50123990082, 6175.536834737391, 6184.938150618504, 6185.505159587245, 6187.81436556904, 6191.164192833978, 5746.396628354026, 6024.006039003559, 6059.3637668044885, 6061.727222275008, 6187.81436556904, 5561.805336813232, 5574.414686457904, 5575.135853942605, 5584.0, 5608.887822243532, 26235.475290494272, 26647.333816654544, 26673.866630666915, 26698.599521007007, 26699.19902402931, 1901.5816520365636, 1921.5868588253593, 1925.7111433284979, 1931.6136772645527, 1940.7185958036148, 16696.49910502687, 17108.230129644195, 17701.114944252866, 17999.64000719978, 18015.28854758796, 2167.360628614547, 2193.605151072806, 2203.823694104468, 2206.7682893296133, 2207.569523942832, 99994.0, 104034.47982760037, 104415.0, 104588.47705761499, 122014.38992805067, 13187.406566704522, 13384.130031547918, 13474.709299419123, 13544.93227533856, 13911.4435422584, 19948.50128746793, 20072.799272007385, 20079.29722459707, 20111.899440502995, 20165.798342016686, 8722.34582406322, 8906.287497000225, 8988.59551320192, 9119.81760364789, 9367.391119577205, 8498.362622803315, 8531.74404767858, 8549.059603443617, 8557.0, 8664.10115448051, 8443.197896199852, 8513.829723405497, 8588.742337729878, 8642.22220000203, 8747.343949203836, 2080.3342930262475, 2097.168822090166, 2106.7155933949025, 2139.882306473159, 2261.118163916074, 940.2290122099812, 940.9905900940903, 956.8421210500189, 988.4267125067444, 995.382862625177, 18838.905805470884, 19113.52216194606, 19304.0, 19543.511412214524, 19986.70019949702, 973.6656489378041, 981.4945303168873, 1004.9949750251202, 1013.9340942838692, 1020.4234607446917, 10219.0, 10413.16694664425, 10844.186685998582, 10880.455977201267, 10896.528968589297, 388386.0, 389386.0, 437137.0, 437422.0, 442663.0, 100650.0, 101974.49012754888, 105152.0, 105254.19509037402, 105260.47369763255, 1070.1492313610697, 1099.9670009899717, 1125.6341688951125, 1176.2824676947055, 1223.2293654997295, 18855.528611784266, 20709.171633134505, 20866.686999694713, 21075.78924210738, 21428.0, 47928.28107578319, 49132.263016055505, 49294.01411971812, 49826.50173498219, 49915.50253492401, 63034.36965630285, 63582.0, 64657.67671161614, 64728.6763566198, 64751.35248647642, 11254.94372528132, 11336.659900203007, 11634.592789252674, 11672.533098676298, 11820.290782553075, 16368.590785229988, 16532.173391330143, 16677.416290429777, 17475.38836140729, 18733.437996860117, 14881.0, 15528.456504022304, 15627.687446251239, 15757.054576725433, 15806.841931580537, 14006.719865602427, 14126.152430854181, 14217.715645687234, 14579.854201457849, 15116.244187790786, 16145.112018838607, 16191.919040404722, 16455.67088658244, 16509.504714858092, 16545.66908661844, 11281.830772538582, 11354.148438866952, 11472.541098355972, 11477.885221148015, 11530.711732206426, 13836.446542138201, 14831.555053348417, 14855.48005819791, 14909.10545367238, 14934.55196344068], "value": 10670.01745995936, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.196127420362, 1344.1061693973509, 1345.3407830163223, 1346.1250187378203, 1358.8165597644315, 11658.358790266531, 12073.75852482952, 12147.817782733266, 12151.39243037849, 12161.0, 11962.940185299061, 12295.938520307409, 12324.63026109216, 12407.317597532132, 12421.813672794915, 2489.3527682802464, 2545.618157276405, 2547.2485616743106, 2553.616957456378, 2554.348641096527, 2420.0, 2505.110685706575, 2506.636537702032, 2519.395345117168, 2519.937001574966, 2085.645440275149, 2432.404061005056, 2466.2477944227003, 2475.5296493666237, 2476.3190122716305, 2031.6850888112367, 2058.6603210470253, 2061.5979883922714, 2315.166540045582, 2420.322309753272, 2467.703875534947, 2475.9504809903883, 2486.8880900359345, 2487.9253622391357, 2498.2879879234333, 12119.878801212051, 12268.938655306756, 12271.0, 12279.263244205376, 12282.385880706019, 6728.966355168192, 7005.82485437863, 7012.123484564429, 7045.154581450259, 7047.929520704779, 4017.35722284436, 4054.371572406252, 4069.532003819569, 4154.979225103855, 4167.770772607505, 1319.7558451686468, 1373.0731756064617, 1407.9577612671637, 1409.9577012689635, 1421.0549984260558, 17660.205290761947, 17671.0, 17723.37968171121, 17861.7320740189, 17885.195166217552, 5698.344690360579, 5861.120831875168, 5916.171735956969, 6038.396160383926, 6069.484093852072, 13409.530666426823, 13474.461021559027, 13530.0, 13530.188188708513, 13540.255285959367, 6678.065070890079, 6867.278935711778, 6878.243393226741, 6886.48351373649, 6887.20797108339, 6198.6280823150755, 6303.369663033752, 6358.491320694333, 6380.904286435707, 6424.196975378078, 4655.953440465552, 4728.338032675429, 4806.086843499724, 4836.443808962014, 4844.515548445198, 1340.0, 1375.4154484344115, 1389.6178550898383, 1395.9092658977133, 1401.054288355356, 822.153182222312, 839.9370047246481, 846.4159729786428, 854.6111519258723, 869.1786261982493, 6426.35736426363, 6803.0135630333325, 6944.166699995932, 7125.89311160333, 7437.553746775211, 908.1463424381061, 910.3172620534599, 943.9811203775886, 962.2583124544457, 971.7473456901115, 4284.0071698864895, 4304.440422745086, 4520.824585607766, 4582.816687332536, 4704.717716936994, 14962.850371496146, 15665.216739162996, 16017.919910400373, 16133.0, 16204.675906481805, 15440.691186176213, 15831.683366332609, 15926.60183495422, 16014.439494617633, 16100.436484722979, 8980.191782739454, 9560.56977436017, 9666.661666841626, 9782.315237933277, 9823.115919567274, 6738.854454484473, 6940.375366216863, 7295.379892709179, 7347.225034696251, 7484.401247900264, 13349.399277032362, 14076.225807580682, 14176.0, 14306.928465357607, 14358.0, 13742.381592828548, 14405.0, 14560.199189044704, 14571.417143314573, 14585.197814120325, 10122.139618132542, 10224.897751022394, 10333.276670632984, 10356.17150627963, 10356.948215259177, 10651.627193048205, 11392.601258955896, 11486.885131148581, 11536.942315288705, 11563.710907227387, 9223.492707900861, 9401.200897923753, 9594.904050959402, 9831.606735730777, 9946.751331216488, 9404.811903762024, 9502.429854208769, 9558.713238602853, 9584.089511496397, 9711.125998660154, 8243.299319557906, 8326.29226515753, 8343.624536895733, 8377.874331884905, 8399.832003360021, 5863.941360586339, 5995.550333724901, 6006.669633170218, 6089.117078023751, 6323.083152942706, 5878.588498805043, 6045.335013148462, 6089.847753806191, 6096.603720758137, 6251.4061164189325], "value": 5605.437925699887, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.4756663353926, 442.8095918754936, 443.9600435960763, 462.52129046436926, 476.27130490349754, 6295.827939360919, 6347.714352854121, 6361.173047503824, 6366.554341196118, 6378.170837791081, 5956.374580669021, 6126.754929802813, 6175.845603859906, 6176.197094377724, 6176.4749996250375, 4934.876628084291, 4944.357233559641, 4959.156943319626, 4968.130577149002, 4968.87577810554, 4873.1715608346485, 4892.3884514435695, 4894.751838281233, 4961.479044700309, 4977.576905962997, 4802.855914322576, 4827.710337379768, 4834.7824347904425, 4850.102730994778, 4860.465348811628, 4684.227102528079, 4804.1352556539805, 4833.347498087784, 4857.247126695368, 4876.2929375240565, 4245.681573881971, 4297.570242975708, 4305.418768466248, 4334.674899382528, 4342.32693932441, 6003.159557661931, 6011.819645410645, 6066.575339726177, 6071.998120310143, 6099.634021958696, 5522.22688823565, 5543.501084902337, 5545.362283337387, 5563.527100196488, 5591.384947655754, 6504.121943537609, 6509.6419696916655, 6512.837179070514, 6536.705848236841, 6543.247526534462, 4690.882727931829, 4691.366665500148, 4701.224297990828, 4702.670813043088, 4739.00961596127, 6861.656917154122, 6868.278830722752, 6913.446924246098, 6923.723051077951, 6962.443004559623, 4816.638752093607, 4817.855464336076, 4835.8065677373215, 4841.515848415201, 4848.3454733610515, 4834.274858771212, 4864.805407783649, 4877.097736918681, 4895.657303988758, 4900.387451568554, 5565.16522521625, 5579.13523403873, 5607.943920560824, 5608.691521966331, 5624.072028115315, 6593.142891424084, 6608.50436217276, 6633.9668301658185, 6646.401823835878, 6682.732690692318, 1605.3177399605354, 1706.3430579226838, 1742.6863164630488, 1744.2935611077535, 1748.0647853398625, 1170.7190274334098, 1177.2400261608777, 1182.1075088308273, 1193.3198077095972, 1194.6774370919977, 5591.524720398812, 5740.885182296414, 5775.393583673737, 5823.301203855564, 5830.533557315404, 6651.733930642817, 6658.766943156967, 6701.731930722716, 6721.1598550181225, 6747.561408508529, 5715.657060576379, 5764.550066221839, 5801.6519008859605, 5801.8549536261935, 5832.795852145155, 3556.822158892097, 3604.116991337139, 3604.585472670624, 3613.385724426854, 3616.4213725803747, 6300.464460520815, 6503.804885853432, 6552.475801935833, 6572.704228309737, 6608.86782264352, 6902.758403455855, 6947.409470194989, 6958.965205173941, 6976.790696279119, 6980.267071957372, 6582.308857569982, 6601.801945941629, 6648.268690444047, 6654.277321503503, 6665.0, 6737.427318677967, 6757.628330441873, 6758.797236082925, 6771.864562708817, 6849.931500684929, 6758.763443279461, 6763.5941843489545, 6789.626570538668, 6791.830204244933, 6791.966040169767, 6609.834754131185, 6622.602643841192, 6628.436582890316, 6630.602163870183, 6655.800325990228, 4762.0713610987605, 4780.641451891052, 4804.735739534359, 4817.110632707734, 4822.276658501253, 6728.7308507659145, 6789.4568434524135, 6795.864082718417, 6832.760853370109, 6848.00703897942, 6563.737450501926, 6614.206295244601, 6626.734930602915, 6642.903920853005, 6646.2356828965285, 6593.175853018372, 6630.53586248958, 6635.653646861314, 6639.302873198245, 6648.202215734143, 6145.6927153641245, 6507.674616269073, 6537.8692426152165, 6570.5729127606555, 6570.605763654196, 6463.676816159267, 6524.3149469305035, 6551.6069035858, 6566.770163044271, 6569.310222426577, 6371.458426033839, 6379.138816259746, 6394.680265986775, 6396.456301214449, 6416.492124350867], "value": 5007.760677066651, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [828.5898480252276, 845.3279642684065, 846.0608724316008, 848.6393282854785, 860.9225169734725, 16632.168391580417, 16892.83107168928, 17075.231614577344, 17076.48770536883, 17089.230984605692, 17150.399736009243, 18272.451826445227, 18301.0, 18604.534886627807, 18609.90695046523, 994.7712026233988, 1007.4308015970989, 1011.8886922438562, 1018.0786388318584, 1018.3431686562163, 1004.5429329655026, 1009.808136454075, 1013.6350913671073, 1014.3001329082946, 1014.7108074198854, 955.6129767444196, 1054.8945105489465, 1057.820170571001, 1059.809234337819, 1061.1192710050639, 1030.9948450257775, 1040.3289878028668, 1044.472541366605, 1047.0838016735356, 1047.2459828923163, 757.0952711509748, 761.7372006657749, 763.0690557519872, 763.4579448591506, 764.0, 15298.388064477407, 17688.646227075515, 17738.91130544339, 17825.0, 17835.0, 16846.157692115346, 16877.071761053136, 16922.153892305458, 17083.91458042702, 17099.91450042754, 15131.470398536, 15199.848001520064, 15239.61900952474, 15250.847491525165, 15402.152881591508, 3449.292894956528, 3501.38725723, 3503.439449688063, 3509.31568344173, 3523.4714792781288, 79235.0, 81353.59323203405, 82611.5869420655, 90295.54852225762, 95132.04867951301, 15415.922920385327, 15514.612134696723, 15564.143972081418, 15581.220938953007, 15675.137867417401, 25861.870690646425, 26201.344966375993, 26288.0, 26961.191164265103, 27136.864315678296, 8123.79690507742, 8149.062857771313, 8190.262876341158, 8194.836103277901, 8212.17878212186, 3793.393057110904, 3860.536735591691, 3923.725339226227, 3971.62269584389, 3972.2651309507833, 4397.31841564558, 4445.866624001285, 4510.36854840316, 4512.300593408027, 4516.187086324493, 769.6459628570808, 849.1508491508491, 859.4456575508887, 862.8403745307138, 863.317978796756, 620.8199622109538, 684.4729558240127, 711.0933559711306, 712.9394001509826, 731.0824914732084, 10642.468886446724, 11937.820932686016, 12178.147529673015, 12221.0, 12682.112252142446, 681.1213534540387, 700.2472342232121, 702.7540360873755, 706.9328413800681, 728.6720975561019, 4969.428515720739, 5508.862278442991, 5549.223108764776, 5591.404288872645, 5641.492265696107, 84736.0, 88741.0, 90413.64379534312, 93560.53219733857, 94409.0, 76432.0, 76766.23233767702, 77127.0, 78870.0, 80145.59927200327, 60442.39557604455, 61320.999999999105, 64306.356936430035, 64332.0, 64414.677926610064, 10826.296290741391, 10836.620718274822, 11166.0, 11170.720731981766, 11503.53985840557, 26394.0, 28262.43475130445, 28304.0, 28673.0, 29861.55207671843, 34164.82917585396, 34977.825110874284, 35805.283894321445, 36108.63891361053, 37378.6262137386, 14917.552473425814, 15416.922915385352, 15458.84541154619, 15527.223638817788, 15539.84460155384, 18696.06519674038, 19027.429177124708, 19273.710894336316, 19329.323473678916, 19348.8065119347, 16131.0, 16611.41860034893, 16697.49907502777, 16854.410095647083, 17232.138393080546, 15868.682626347178, 17081.31674732997, 17544.385946491813, 17670.381536646157, 17686.115694215496, 15245.771313430529, 15322.157281349633, 15331.080135191924, 15408.691826163638, 15409.537713868602, 9533.809323813624, 9879.110880020833, 9982.0, 10430.582776688847, 10646.20153488507, 12335.69160770988, 12682.556110536087, 12783.105182637126, 12894.790078501477, 13011.284379358847], "value": 8037.875982980251, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 111.0, 108.0, 143.0, 110.0, 111.0, 113.0, 110.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 153.0, 173.0, 124.0, 158.0, 146.0, 121.0, 173.0, 123.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 162.0, 165.0, 176.0, 172.0, 168.0, 179.0, 165.0], "value": 167.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 155.0, 75.0, 74.0, 77.0, 74.0, 96.0, 77.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 134.0, 84.0, 83.0, 83.0, 137.0, 84.0, 83.0, 130.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 150.0, 152.0, 151.0, 152.0, 151.0, 151.0, 151.0, 153.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 99.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 54.0, 54.0, 57.0, 57.0, 54.0, 53.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0, 57.0, 57.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 78.0, 79.0, 78.0, 78.0, 87.0, 78.0, 87.0, 79.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 129.0, 130.0, 137.0, 133.0, 130.0, 132.0, 138.0, 151.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 197.0, 192.0, 191.0, 191.0, 201.0, 198.0, 188.0, 189.0, 181.0], "value": 191.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 75.0, 71.0, 72.0, 69.0, 74.0, 72.0, 73.0, 74.0], "value": 72.4, "unit": "score"}]}]} 07:50:20 INFO - Return code: 0 07:50:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:50:20 INFO - # TBPL SUCCESS # 07:50:20 INFO - Running post-action listener: _resource_record_post_action 07:50:20 INFO - [mozharness: 2017-06-12 14:50:20.084801Z] Finished run-tests step (success) 07:50:20 INFO - Running post-run listener: _resource_record_post_run 07:50:20 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 491520; Write bytes: 440954880; Read time: 52; Write time: 577944 07:50:20 INFO - TinderboxPrint: CPU usage
12.6% 07:50:20 INFO - TinderboxPrint: I/O read bytes / time
491,520 / 52 07:50:20 INFO - TinderboxPrint: I/O write bytes / time
440,954,880 / 577,944 07:50:20 INFO - TinderboxPrint: CPU idle
8,742.4 (87.4%) 07:50:20 INFO - TinderboxPrint: CPU user
1,209.9 (12.1%) 07:50:20 INFO - TinderboxPrint: Swap in / out
0 / 0 07:50:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 117321728; Read time: 0; Write time: 148064 07:50:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:50:20 INFO - run-tests - Wall time: 1238s; CPU: 13.0%; Read bytes: 491520; Write bytes: 323633152; Read time: 52; Write time: 429880 07:50:20 INFO - Running post-run listener: _upload_blobber_files 07:50:20 INFO - Blob upload gear active. 07:50:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:50:20 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 07:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:50:21 INFO - (blobuploader) - INFO - Open directory for files ... 07:50:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:50:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:50:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:21 INFO - (blobuploader) - INFO - Done attempting. 07:50:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:50:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:50:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:25 INFO - (blobuploader) - INFO - Done attempting. 07:50:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:50:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:50:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:26 INFO - (blobuploader) - INFO - Done attempting. 07:50:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:50:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:50:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:27 INFO - (blobuploader) - INFO - Done attempting. 07:50:27 INFO - (blobuploader) - INFO - Iteration through files over. 07:50:27 INFO - Return code: 0 07:50:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:50:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:50:27 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8763db6cb47654900cda1fedd02713d125d2f87bb8778b869659a8961669e43e706c685166111b89aa9098b389601c7e8aaf5c04336a0a55aed54ec40bd4477a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b43c9da95d3d01842a332d7d99e23ff9ee77b95842794ffe4c7396a24553206cd07d2d9b639cab18c0c83a473ef860caabd6cac9c30c0dc46ed6e00426c322b1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e33cfa07578df1531af517cbcf6dc1990d37c9a5913f9f6bb20d04fe4858a7ac3debdb5f3d12c847201edd4e6dae6e7eb6f45af47ce5f964120cb5d43187b66d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f52cd7029235449fca41082e5529ce44ee25a0084d3f2e5eb27a6544d5413d258473120c66df5cc43ab1c009b61e40f8ea449a92c6493b2f40c078596ebce79"} 07:50:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:50:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:50:27 INFO - Contents: 07:50:27 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8763db6cb47654900cda1fedd02713d125d2f87bb8778b869659a8961669e43e706c685166111b89aa9098b389601c7e8aaf5c04336a0a55aed54ec40bd4477a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b43c9da95d3d01842a332d7d99e23ff9ee77b95842794ffe4c7396a24553206cd07d2d9b639cab18c0c83a473ef860caabd6cac9c30c0dc46ed6e00426c322b1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e33cfa07578df1531af517cbcf6dc1990d37c9a5913f9f6bb20d04fe4858a7ac3debdb5f3d12c847201edd4e6dae6e7eb6f45af47ce5f964120cb5d43187b66d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f52cd7029235449fca41082e5529ce44ee25a0084d3f2e5eb27a6544d5413d258473120c66df5cc43ab1c009b61e40f8ea449a92c6493b2f40c078596ebce79"} 07:50:27 INFO - Running post-run listener: copy_logs_to_upload_dir 07:50:27 INFO - Copying logs to upload dir... 07:50:27 INFO - mkdir: /builds/slave/test/build/upload/logs 07:50:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1312.673694 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2017-06-12 07:50:27.835355) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-12 07:50:27.839868) ========= 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=5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512 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-Non-PGO/sha512/8763db6cb47654900cda1fedd02713d125d2f87bb8778b869659a8961669e43e706c685166111b89aa9098b389601c7e8aaf5c04336a0a55aed54ec40bd4477a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b43c9da95d3d01842a332d7d99e23ff9ee77b95842794ffe4c7396a24553206cd07d2d9b639cab18c0c83a473ef860caabd6cac9c30c0dc46ed6e00426c322b1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e33cfa07578df1531af517cbcf6dc1990d37c9a5913f9f6bb20d04fe4858a7ac3debdb5f3d12c847201edd4e6dae6e7eb6f45af47ce5f964120cb5d43187b66d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f52cd7029235449fca41082e5529ce44ee25a0084d3f2e5eb27a6544d5413d258473120c66df5cc43ab1c009b61e40f8ea449a92c6493b2f40c078596ebce79"} build_url:https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/ImDVj0dHQBCqFYt22hQxZg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8763db6cb47654900cda1fedd02713d125d2f87bb8778b869659a8961669e43e706c685166111b89aa9098b389601c7e8aaf5c04336a0a55aed54ec40bd4477a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b43c9da95d3d01842a332d7d99e23ff9ee77b95842794ffe4c7396a24553206cd07d2d9b639cab18c0c83a473ef860caabd6cac9c30c0dc46ed6e00426c322b1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e33cfa07578df1531af517cbcf6dc1990d37c9a5913f9f6bb20d04fe4858a7ac3debdb5f3d12c847201edd4e6dae6e7eb6f45af47ce5f964120cb5d43187b66d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f52cd7029235449fca41082e5529ce44ee25a0084d3f2e5eb27a6544d5413d258473120c66df5cc43ab1c009b61e40f8ea449a92c6493b2f40c078596ebce79"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-12 07:50:27.866964) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 07:50:27.867288) ========= 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=5bd038846534b2fdfa68eeae000001e2-1497277709.555849-252308512 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 07:50:27.947091) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-12 07:50:27.947403) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-12 07:50:27.950707) ========= ========= Total master_lag: 0.16 =========