builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1469468954.33 results: success (0) buildid: 20160725073102 builduid: dd10f4575e464fb39a3841e84854d139 revision: e50eb5912d50b6e9cf6cb09f7137699218e68240 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 10:49:14.330741) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 10:49:14.331231) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 10:49:14.331507) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 10:49:14.346819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:49:14.347196) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 10:49:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.0M=0s 2016-07-25 10:49:15 (33.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081294 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:49:14.442361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:49:14.442700) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015114 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 10:49:14.492004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-25 10:49:14.492364) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e50eb5912d50b6e9cf6cb09f7137699218e68240 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e50eb5912d50b6e9cf6cb09f7137699218e68240 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 10:49:15,414 truncating revision to first 12 chars 2016-07-25 10:49:15,414 Setting DEBUG logging. 2016-07-25 10:49:15,414 attempt 1/10 2016-07-25 10:49:15,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e50eb5912d50?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 10:49:16,457 unpacking tar archive at: mozilla-inbound-e50eb5912d50/testing/mozharness/ program finished with exit code 0 elapsedTime=1.402286 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-25 10:49:15.908056) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 10:49:15.908392) ========= script_repo_revision: e50eb5912d50b6e9cf6cb09f7137699218e68240 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 10:49:15.908784) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 10:49:15.909048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 10:49:15.921241) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-25 10:49:15.921631) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:49:16 INFO - MultiFileLogger online at 20160725 10:49:16 in /builds/slave/test 10:49:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:49:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:49:16 INFO - {'append_to_log': False, 10:49:16 INFO - 'base_work_dir': '/builds/slave/test', 10:49:16 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:49:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:49:16 INFO - 'branch': 'Mozilla-Inbound', 10:49:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:49:16 INFO - 'config_files': ('talos/linux_config.py',), 10:49:16 INFO - 'default_actions': ('clobber', 10:49:16 INFO - 'read-buildbot-config', 10:49:16 INFO - 'download-and-extract', 10:49:16 INFO - 'populate-webroot', 10:49:16 INFO - 'create-virtualenv', 10:49:16 INFO - 'install', 10:49:16 INFO - 'run-tests'), 10:49:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:49:16 INFO - 'download_minidump_stackwalk': True, 10:49:16 INFO - 'download_symbols': 'ondemand', 10:49:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:49:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:49:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:49:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:49:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:49:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:49:16 INFO - 'installer_path': 'installer.exe', 10:49:16 INFO - 'log_level': 'info', 10:49:16 INFO - 'log_name': 'talos', 10:49:16 INFO - 'log_to_console': True, 10:49:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:49:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:49:16 INFO - 'opt_config_files': (), 10:49:16 INFO - 'pip_index': False, 10:49:16 INFO - 'sps_profile': False, 10:49:16 INFO - 'sps_profile_interval': 0, 10:49:16 INFO - 'suite': 'dromaeojs', 10:49:16 INFO - 'system_bits': '32', 10:49:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:49:16 INFO - 'title': 'talos-linux64-ix-041', 10:49:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:49:16 INFO - 'use_talos_json': True, 10:49:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:49:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:49:16 INFO - 'work_dir': 'build'} 10:49:16 INFO - [mozharness: 2016-07-25 17:49:16.932248Z] Running clobber step. 10:49:16 INFO - Running pre-action listener: _resource_record_pre_action 10:49:16 INFO - Running main action method: clobber 10:49:16 INFO - rmtree: /builds/slave/test/build 10:49:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:49:17 INFO - Running post-action listener: _resource_record_post_action 10:49:17 INFO - [mozharness: 2016-07-25 17:49:17.403548Z] Finished clobber step (success) 10:49:17 INFO - [mozharness: 2016-07-25 17:49:17.403650Z] Running read-buildbot-config step. 10:49:17 INFO - Running pre-action listener: _resource_record_pre_action 10:49:17 INFO - Running main action method: read_buildbot_config 10:49:17 INFO - Using buildbot properties: 10:49:17 INFO - { 10:49:17 INFO - "project": "", 10:49:17 INFO - "product": "firefox", 10:49:17 INFO - "script_repo_revision": "production", 10:49:17 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:49:17 INFO - "repository": "", 10:49:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:49:17 INFO - "buildid": "20160725073102", 10:49:17 INFO - "pgo_build": "True", 10:49:17 INFO - "basedir": "/builds/slave/test", 10:49:17 INFO - "buildnumber": 1284, 10:49:17 INFO - "slavename": "talos-linux64-ix-041", 10:49:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:49:17 INFO - "platform": "ubuntu64_hw", 10:49:17 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:49:17 INFO - "branch": "mozilla-inbound", 10:49:17 INFO - "repo_path": "integration/mozilla-inbound", 10:49:17 INFO - "revision": "e50eb5912d50b6e9cf6cb09f7137699218e68240", 10:49:17 INFO - "stage_platform": "linux64-pgo", 10:49:17 INFO - "builduid": "dd10f4575e464fb39a3841e84854d139", 10:49:17 INFO - "slavebuilddir": "test" 10:49:17 INFO - } 10:49:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:49:17 INFO - Running post-action listener: _resource_record_post_action 10:49:17 INFO - [mozharness: 2016-07-25 17:49:17.406417Z] Finished read-buildbot-config step (success) 10:49:17 INFO - [mozharness: 2016-07-25 17:49:17.406505Z] Running download-and-extract step. 10:49:17 INFO - Running pre-action listener: _resource_record_pre_action 10:49:17 INFO - Running main action method: download_and_extract 10:49:17 INFO - mkdir: /builds/slave/test/build/tests 10:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:17 INFO - https://queue.taskcluster.net/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:49:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:49:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:49:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:49:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:49:18 INFO - Downloaded 1361 bytes. 10:49:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:49:18 INFO - Using the following test package requirements: 10:49:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:49:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:49:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:49:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:18 INFO - u'jsshell-linux-x86_64.zip'], 10:49:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:49:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:49:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:49:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:49:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:49:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:49:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:18 INFO - https://queue.taskcluster.net/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:49:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:49:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:49:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:49:19 INFO - Downloaded 24311020 bytes. 10:49:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:49:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:49:20 INFO - Return code: 0 10:49:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:20 INFO - https://queue.taskcluster.net/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:49:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:49:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:49:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:49:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:49:21 INFO - Downloaded 24311020 bytes. 10:49:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:49:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:49:22 INFO - Return code: 0 10:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:22 INFO - https://queue.taskcluster.net/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:49:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:49:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:49:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:49:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:49:23 INFO - Downloaded 14403248 bytes. 10:49:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:49:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:49:24 INFO - Return code: 0 10:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:24 INFO - https://queue.taskcluster.net/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:49:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:49:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:49:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:49:25 INFO - Downloaded 60865558 bytes. 10:49:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:49:25 INFO - mkdir: /builds/slave/test/properties 10:49:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:49:25 INFO - Writing to file /builds/slave/test/properties/build_url 10:49:25 INFO - Contents: 10:49:25 INFO - build_url:https://queue.taskcluster.net/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:49:26 INFO - Running post-action listener: _resource_record_post_action 10:49:26 INFO - Running post-action listener: set_extra_try_arguments 10:49:26 INFO - [mozharness: 2016-07-25 17:49:26.438877Z] Finished download-and-extract step (success) 10:49:26 INFO - [mozharness: 2016-07-25 17:49:26.439112Z] Running populate-webroot step. 10:49:26 INFO - Running pre-action listener: _resource_record_pre_action 10:49:26 INFO - Running main action method: populate_webroot 10:49:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:49:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:49:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:49:26 INFO - '--tppagecycles', 10:49:26 INFO - '7'], 10:49:26 INFO - 'tests': ['tsvgm']}}, 10:49:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:49:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:49:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:49:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:49:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:49:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:49:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:26 INFO - 'talos_options': ['--disable-e10s'], 10:49:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:49:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:49:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:26 INFO - 'talos_options': ['--disable-e10s'], 10:49:26 INFO - 'tests': ['damp', 'tps']}, 10:49:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:26 INFO - 'tests': ['damp', 'tps']}, 10:49:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:49:26 INFO - 'tests': ['dromaeo_dom']}, 10:49:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:49:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:49:26 INFO - 'tests': ['basic_compositor_video']}, 10:49:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:49:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:49:26 INFO - 'tests': ['a11yr', 10:49:26 INFO - 'ts_paint', 10:49:26 INFO - 'tpaint', 10:49:26 INFO - 'sessionrestore', 10:49:26 INFO - 'sessionrestore_no_auto_restore', 10:49:26 INFO - 'tabpaint']}, 10:49:26 INFO - 'other-e10s': {'tests': ['a11yr', 10:49:26 INFO - 'ts_paint', 10:49:26 INFO - 'tpaint', 10:49:26 INFO - 'sessionrestore', 10:49:26 INFO - 'sessionrestore_no_auto_restore', 10:49:26 INFO - 'tabpaint']}, 10:49:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:49:26 INFO - 'ts_paint', 10:49:26 INFO - 'tpaint', 10:49:26 INFO - 'sessionrestore', 10:49:26 INFO - 'sessionrestore_no_auto_restore', 10:49:26 INFO - 'tabpaint']}, 10:49:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:49:26 INFO - 'ts_paint', 10:49:26 INFO - 'tpaint', 10:49:26 INFO - 'sessionrestore', 10:49:26 INFO - 'sessionrestore_no_auto_restore', 10:49:26 INFO - 'tabpaint']}, 10:49:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:49:26 INFO - 'tests': ['a11yr', 10:49:26 INFO - 'ts_paint', 10:49:26 INFO - 'tpaint', 10:49:26 INFO - 'sessionrestore', 10:49:26 INFO - 'sessionrestore_no_auto_restore', 10:49:26 INFO - 'tabpaint']}, 10:49:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:49:26 INFO - 'tests': ['a11yr', 10:49:26 INFO - 'ts_paint', 10:49:26 INFO - 'tpaint', 10:49:26 INFO - 'sessionrestore', 10:49:26 INFO - 'sessionrestore_no_auto_restore', 10:49:26 INFO - 'tabpaint']}, 10:49:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:49:26 INFO - 'tests': ['tsvgx', 10:49:26 INFO - 'tsvgr_opacity', 10:49:26 INFO - 'tart', 10:49:26 INFO - 'tscrollx', 10:49:26 INFO - 'cart']}, 10:49:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:49:26 INFO - 'tsvgr_opacity', 10:49:26 INFO - 'tart', 10:49:26 INFO - 'tscrollx', 10:49:26 INFO - 'cart']}, 10:49:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:26 INFO - 'talos_options': ['--disable-e10s'], 10:49:26 INFO - 'tests': ['tp5o']}, 10:49:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:26 INFO - 'tests': ['tp5o']}, 10:49:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:26 INFO - 'talos_options': ['--disable-e10s', 10:49:26 INFO - '--xperf_path', 10:49:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:49:26 INFO - 'tests': ['tp5n']}, 10:49:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:26 INFO - 'talos_options': ['--xperf_path', 10:49:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:49:26 INFO - 'tests': ['tp5n']}}, 10:49:26 INFO - 'talos.zip': {'path': '', 10:49:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:49:26 INFO - Running post-action listener: _resource_record_post_action 10:49:26 INFO - [mozharness: 2016-07-25 17:49:26.456204Z] Finished populate-webroot step (success) 10:49:26 INFO - [mozharness: 2016-07-25 17:49:26.456293Z] Running create-virtualenv step. 10:49:26 INFO - Running pre-action listener: _resource_record_pre_action 10:49:26 INFO - Running main action method: create_virtualenv 10:49:26 INFO - Creating virtualenv /builds/slave/test/build/venv 10:49:26 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 10:49:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:49:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:49:26 INFO - Using real prefix '/usr' 10:49:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:49:27 INFO - Installing distribute.............................................................................................................................................................................................done. 10:49:29 INFO - Installing pip.................done. 10:49:29 INFO - Return code: 0 10:49:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:29 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, '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 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:49:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:49:29 INFO - Using env: {'DISPLAY': ':0', 10:49:29 INFO - 'HOME': '/home/cltbld', 10:49:29 INFO - 'LANG': 'en_US.UTF-8', 10:49:29 INFO - 'LANGUAGE': 'en_US:en', 10:49:29 INFO - 'LOGNAME': 'cltbld', 10:49:29 INFO - 'MAIL': '/var/mail/cltbld', 10:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:29 INFO - 'MOZ_NO_REMOTE': '1', 10:49:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:29 INFO - 'NO_EM_RESTART': '1', 10:49:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:29 INFO - 'PWD': '/builds/slave/test', 10:49:29 INFO - 'SHELL': '/bin/bash', 10:49:29 INFO - 'SHLVL': '1', 10:49:29 INFO - 'TERM': 'linux', 10:49:29 INFO - 'TMOUT': '86400', 10:49:29 INFO - 'USER': 'cltbld', 10:49:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 10:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:29 INFO - '_': '/tools/buildbot/bin/python'} 10:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:29 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 10:49:29 INFO - Cleaning up... 10:49:29 INFO - Return code: 0 10:49:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:29 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, '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 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:49:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:49:29 INFO - Using env: {'DISPLAY': ':0', 10:49:29 INFO - 'HOME': '/home/cltbld', 10:49:29 INFO - 'LANG': 'en_US.UTF-8', 10:49:29 INFO - 'LANGUAGE': 'en_US:en', 10:49:29 INFO - 'LOGNAME': 'cltbld', 10:49:29 INFO - 'MAIL': '/var/mail/cltbld', 10:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:29 INFO - 'MOZ_NO_REMOTE': '1', 10:49:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:29 INFO - 'NO_EM_RESTART': '1', 10:49:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:29 INFO - 'PWD': '/builds/slave/test', 10:49:29 INFO - 'SHELL': '/bin/bash', 10:49:29 INFO - 'SHLVL': '1', 10:49:29 INFO - 'TERM': 'linux', 10:49:29 INFO - 'TMOUT': '86400', 10:49:29 INFO - 'USER': 'cltbld', 10:49:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 10:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:29 INFO - '_': '/tools/buildbot/bin/python'} 10:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:29 INFO - Downloading/unpacking psutil>=3.1.1 10:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:49:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:49:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:49:31 INFO - Installing collected packages: psutil 10:49:31 INFO - Running setup.py install for psutil 10:49:31 INFO - building 'psutil._psutil_linux' extension 10:49:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:49:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:49:31 INFO - building 'psutil._psutil_posix' extension 10:49:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:49:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:49:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:49:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:49:31 INFO - Successfully installed psutil 10:49:31 INFO - Cleaning up... 10:49:32 INFO - Return code: 0 10:49:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:32 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, '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 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:49:32 INFO - Using env: {'DISPLAY': ':0', 10:49:32 INFO - 'HOME': '/home/cltbld', 10:49:32 INFO - 'LANG': 'en_US.UTF-8', 10:49:32 INFO - 'LANGUAGE': 'en_US:en', 10:49:32 INFO - 'LOGNAME': 'cltbld', 10:49:32 INFO - 'MAIL': '/var/mail/cltbld', 10:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:32 INFO - 'MOZ_NO_REMOTE': '1', 10:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:32 INFO - 'NO_EM_RESTART': '1', 10:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:32 INFO - 'PWD': '/builds/slave/test', 10:49:32 INFO - 'SHELL': '/bin/bash', 10:49:32 INFO - 'SHLVL': '1', 10:49:32 INFO - 'TERM': 'linux', 10:49:32 INFO - 'TMOUT': '86400', 10:49:32 INFO - 'USER': 'cltbld', 10:49:32 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 10:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:32 INFO - '_': '/tools/buildbot/bin/python'} 10:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:49:34 INFO - Installing collected packages: mozsystemmonitor 10:49:34 INFO - Running setup.py install for mozsystemmonitor 10:49:34 INFO - Successfully installed mozsystemmonitor 10:49:34 INFO - Cleaning up... 10:49:34 INFO - Return code: 0 10:49:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:34 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, '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 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:49:34 INFO - Using env: {'DISPLAY': ':0', 10:49:34 INFO - 'HOME': '/home/cltbld', 10:49:34 INFO - 'LANG': 'en_US.UTF-8', 10:49:34 INFO - 'LANGUAGE': 'en_US:en', 10:49:34 INFO - 'LOGNAME': 'cltbld', 10:49:34 INFO - 'MAIL': '/var/mail/cltbld', 10:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:34 INFO - 'MOZ_NO_REMOTE': '1', 10:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:34 INFO - 'NO_EM_RESTART': '1', 10:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:34 INFO - 'PWD': '/builds/slave/test', 10:49:34 INFO - 'SHELL': '/bin/bash', 10:49:34 INFO - 'SHLVL': '1', 10:49:34 INFO - 'TERM': 'linux', 10:49:34 INFO - 'TMOUT': '86400', 10:49:34 INFO - 'USER': 'cltbld', 10:49:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 10:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:34 INFO - '_': '/tools/buildbot/bin/python'} 10:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:34 INFO - Downloading/unpacking jsonschema==2.5.1 10:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:49:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:36 INFO - Downloading functools32-3.2.3-2.tar.gz 10:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:49:36 INFO - warning: no files found matching '*.txt' 10:49:36 INFO - no previously-included directories found matching 'build' 10:49:36 INFO - no previously-included directories found matching 'dist' 10:49:36 INFO - no previously-included directories found matching '.git*' 10:49:36 INFO - Installing collected packages: jsonschema, functools32 10:49:36 INFO - Running setup.py install for functools32 10:49:36 INFO - warning: no files found matching '*.txt' 10:49:36 INFO - no previously-included directories found matching 'build' 10:49:36 INFO - no previously-included directories found matching 'dist' 10:49:36 INFO - no previously-included directories found matching '.git*' 10:49:36 INFO - Successfully installed jsonschema functools32 10:49:36 INFO - Cleaning up... 10:49:36 INFO - Return code: 0 10:49:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:36 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, '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 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:49:36 INFO - Using env: {'DISPLAY': ':0', 10:49:36 INFO - 'HOME': '/home/cltbld', 10:49:36 INFO - 'LANG': 'en_US.UTF-8', 10:49:36 INFO - 'LANGUAGE': 'en_US:en', 10:49:36 INFO - 'LOGNAME': 'cltbld', 10:49:36 INFO - 'MAIL': '/var/mail/cltbld', 10:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:36 INFO - 'MOZ_NO_REMOTE': '1', 10:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:36 INFO - 'NO_EM_RESTART': '1', 10:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:36 INFO - 'PWD': '/builds/slave/test', 10:49:36 INFO - 'SHELL': '/bin/bash', 10:49:36 INFO - 'SHLVL': '1', 10:49:36 INFO - 'TERM': 'linux', 10:49:36 INFO - 'TMOUT': '86400', 10:49:36 INFO - 'USER': 'cltbld', 10:49:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 10:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:36 INFO - '_': '/tools/buildbot/bin/python'} 10:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:49:37 INFO - Cleaning up... 10:49:37 INFO - Return code: 0 10:49:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:37 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, '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 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:49:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:49:37 INFO - Using env: {'DISPLAY': ':0', 10:49:37 INFO - 'HOME': '/home/cltbld', 10:49:37 INFO - 'LANG': 'en_US.UTF-8', 10:49:37 INFO - 'LANGUAGE': 'en_US:en', 10:49:37 INFO - 'LOGNAME': 'cltbld', 10:49:37 INFO - 'MAIL': '/var/mail/cltbld', 10:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:37 INFO - 'MOZ_NO_REMOTE': '1', 10:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:37 INFO - 'NO_EM_RESTART': '1', 10:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:37 INFO - 'PWD': '/builds/slave/test', 10:49:37 INFO - 'SHELL': '/bin/bash', 10:49:37 INFO - 'SHLVL': '1', 10:49:37 INFO - 'TERM': 'linux', 10:49:37 INFO - 'TMOUT': '86400', 10:49:37 INFO - 'USER': 'cltbld', 10:49:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 10:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:37 INFO - '_': '/tools/buildbot/bin/python'} 10:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:37 INFO - Downloading/unpacking blobuploader==1.2.4 10:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:39 INFO - Downloading blobuploader-1.2.4.tar.gz 10:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:49:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:49:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:39 INFO - Downloading docopt-0.6.1.tar.gz 10:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:49:39 INFO - Installing collected packages: blobuploader, requests, docopt 10:49:39 INFO - Running setup.py install for blobuploader 10:49:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:49:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:49:40 INFO - Running setup.py install for requests 10:49:40 INFO - Running setup.py install for docopt 10:49:40 INFO - Successfully installed blobuploader requests docopt 10:49:40 INFO - Cleaning up... 10:49:40 INFO - Return code: 0 10:49:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:40 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, '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 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:49:40 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:49:40 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:49:40 INFO - Using env: {'DISPLAY': ':0', 10:49:40 INFO - 'HOME': '/home/cltbld', 10:49:40 INFO - 'LANG': 'en_US.UTF-8', 10:49:40 INFO - 'LANGUAGE': 'en_US:en', 10:49:40 INFO - 'LOGNAME': 'cltbld', 10:49:40 INFO - 'MAIL': '/var/mail/cltbld', 10:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:40 INFO - 'MOZ_NO_REMOTE': '1', 10:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:40 INFO - 'NO_EM_RESTART': '1', 10:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:40 INFO - 'PWD': '/builds/slave/test', 10:49:40 INFO - 'SHELL': '/bin/bash', 10:49:40 INFO - 'SHLVL': '1', 10:49:40 INFO - 'TERM': 'linux', 10:49:40 INFO - 'TMOUT': '86400', 10:49:40 INFO - 'USER': 'cltbld', 10:49:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 10:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:40 INFO - '_': '/tools/buildbot/bin/python'} 10:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:49:40 INFO - Running setup.py (path:/tmp/pip-MVMTjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:49:40 INFO - Running setup.py (path:/tmp/pip-bD0OdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:49:40 INFO - Running setup.py (path:/tmp/pip-Ech8Ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:49:41 INFO - Running setup.py (path:/tmp/pip-yjsvHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:49:41 INFO - Running setup.py (path:/tmp/pip-IciIto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:49:41 INFO - Running setup.py (path:/tmp/pip-PO105Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:49:41 INFO - Running setup.py (path:/tmp/pip-tsoRlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:49:41 INFO - Running setup.py (path:/tmp/pip-j6sa3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:49:41 INFO - Running setup.py (path:/tmp/pip-cdVJYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:49:41 INFO - Running setup.py (path:/tmp/pip-LZIZt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:49:41 INFO - Running setup.py (path:/tmp/pip-_IkzNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:49:41 INFO - Running setup.py (path:/tmp/pip-Nii8zQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:49:41 INFO - Running setup.py (path:/tmp/pip-tWAXG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:49:41 INFO - Running setup.py (path:/tmp/pip-eb_QP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:49:41 INFO - Running setup.py (path:/tmp/pip-ShwbHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:49:41 INFO - Running setup.py (path:/tmp/pip-_6tIHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:49:41 INFO - Running setup.py (path:/tmp/pip-WF92Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:49:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:49:42 INFO - Running setup.py install for manifestparser 10:49:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:49:42 INFO - Running setup.py install for mozcrash 10:49:42 INFO - Running setup.py install for mozdebug 10:49:42 INFO - Running setup.py install for mozdevice 10:49:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:49:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:49:42 INFO - Running setup.py install for mozfile 10:49:42 INFO - Running setup.py install for mozhttpd 10:49:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:49:42 INFO - Running setup.py install for mozinfo 10:49:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:49:42 INFO - Running setup.py install for mozInstall 10:49:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:49:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:49:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:49:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:49:42 INFO - Running setup.py install for mozleak 10:49:42 INFO - Running setup.py install for mozlog 10:49:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:49:43 INFO - Running setup.py install for moznetwork 10:49:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:49:43 INFO - Running setup.py install for mozprocess 10:49:43 INFO - Running setup.py install for mozprofile 10:49:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:49:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:49:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:49:43 INFO - Running setup.py install for mozrunner 10:49:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:49:43 INFO - Running setup.py install for mozscreenshot 10:49:43 INFO - Running setup.py install for moztest 10:49:43 INFO - Running setup.py install for mozversion 10:49:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:49:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:49:43 INFO - Cleaning up... 10:49:43 INFO - Return code: 0 10:49:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, '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 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:49:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:49:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:49:43 INFO - Using env: {'DISPLAY': ':0', 10:49:43 INFO - 'HOME': '/home/cltbld', 10:49:43 INFO - 'LANG': 'en_US.UTF-8', 10:49:43 INFO - 'LANGUAGE': 'en_US:en', 10:49:43 INFO - 'LOGNAME': 'cltbld', 10:49:43 INFO - 'MAIL': '/var/mail/cltbld', 10:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:43 INFO - 'MOZ_NO_REMOTE': '1', 10:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:43 INFO - 'NO_EM_RESTART': '1', 10:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:43 INFO - 'PWD': '/builds/slave/test', 10:49:43 INFO - 'SHELL': '/bin/bash', 10:49:43 INFO - 'SHLVL': '1', 10:49:43 INFO - 'TERM': 'linux', 10:49:43 INFO - 'TMOUT': '86400', 10:49:43 INFO - 'USER': 'cltbld', 10:49:43 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 10:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:43 INFO - '_': '/tools/buildbot/bin/python'} 10:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:49:44 INFO - Running setup.py (path:/tmp/pip-33mows-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:49:44 INFO - Running setup.py (path:/tmp/pip-sLvvdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:49:44 INFO - Running setup.py (path:/tmp/pip-GflODF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:49:44 INFO - Running setup.py (path:/tmp/pip-zFmHYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:49:44 INFO - Running setup.py (path:/tmp/pip-JOJFvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:49:44 INFO - Running setup.py (path:/tmp/pip-3y6hz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:49:44 INFO - Running setup.py (path:/tmp/pip-qynLhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:49:44 INFO - Running setup.py (path:/tmp/pip-RVQK7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:49:44 INFO - Running setup.py (path:/tmp/pip-_7_jFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:49:44 INFO - Running setup.py (path:/tmp/pip-hN54nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:49:44 INFO - Running setup.py (path:/tmp/pip-G0NLGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:49:44 INFO - Running setup.py (path:/tmp/pip-PSO0kG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:49:44 INFO - Running setup.py (path:/tmp/pip-38DXVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:49:45 INFO - Running setup.py (path:/tmp/pip-l1SMhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:49:45 INFO - Running setup.py (path:/tmp/pip-Si6PHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:49:45 INFO - Running setup.py (path:/tmp/pip-AiPKkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:49:45 INFO - Running setup.py (path:/tmp/pip-CCWwii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:49:45 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:49:45 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:49:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:47 INFO - Downloading blessings-1.6.tar.gz 10:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:49:47 INFO - Installing collected packages: blessings 10:49:47 INFO - Running setup.py install for blessings 10:49:47 INFO - Successfully installed blessings 10:49:47 INFO - Cleaning up... 10:49:47 INFO - Return code: 0 10:49:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:49:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:49:47 INFO - Reading from file tmpfile_stdout 10:49:47 INFO - Current package versions: 10:49:47 INFO - argparse == 1.2.1 10:49:47 INFO - blessings == 1.6 10:49:47 INFO - blobuploader == 1.2.4 10:49:47 INFO - docopt == 0.6.1 10:49:47 INFO - functools32 == 3.2.3-2 10:49:47 INFO - jsonschema == 2.5.1 10:49:47 INFO - manifestparser == 1.1 10:49:47 INFO - mozInstall == 1.12 10:49:47 INFO - mozcrash == 0.17 10:49:47 INFO - mozdebug == 0.1 10:49:47 INFO - mozdevice == 0.48 10:49:47 INFO - mozfile == 1.2 10:49:47 INFO - mozhttpd == 0.7 10:49:47 INFO - mozinfo == 0.9 10:49:47 INFO - mozleak == 0.1 10:49:47 INFO - mozlog == 3.3 10:49:47 INFO - moznetwork == 0.27 10:49:47 INFO - mozprocess == 0.23 10:49:47 INFO - mozprofile == 0.28 10:49:47 INFO - mozrunner == 6.12 10:49:47 INFO - mozscreenshot == 0.1 10:49:47 INFO - mozsystemmonitor == 0.3 10:49:47 INFO - moztest == 0.7 10:49:47 INFO - mozversion == 1.4 10:49:47 INFO - psutil == 3.1.1 10:49:47 INFO - requests == 1.2.3 10:49:47 INFO - wsgiref == 0.1.2 10:49:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:47 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, '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 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:49:47 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:49:47 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:49:47 INFO - Using env: {'DISPLAY': ':0', 10:49:47 INFO - 'HOME': '/home/cltbld', 10:49:47 INFO - 'LANG': 'en_US.UTF-8', 10:49:47 INFO - 'LANGUAGE': 'en_US:en', 10:49:47 INFO - 'LOGNAME': 'cltbld', 10:49:47 INFO - 'MAIL': '/var/mail/cltbld', 10:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:47 INFO - 'MOZ_NO_REMOTE': '1', 10:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:47 INFO - 'NO_EM_RESTART': '1', 10:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:47 INFO - 'PWD': '/builds/slave/test', 10:49:47 INFO - 'SHELL': '/bin/bash', 10:49:47 INFO - 'SHLVL': '1', 10:49:47 INFO - 'TERM': 'linux', 10:49:47 INFO - 'TMOUT': '86400', 10:49:47 INFO - 'USER': 'cltbld', 10:49:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 10:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:47 INFO - '_': '/tools/buildbot/bin/python'} 10:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:49:47 INFO - Cleaning up... 10:49:47 INFO - Return code: 0 10:49:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1a4e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d3b0>, '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 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:49:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:49:47 INFO - Using env: {'DISPLAY': ':0', 10:49:47 INFO - 'HOME': '/home/cltbld', 10:49:47 INFO - 'LANG': 'en_US.UTF-8', 10:49:47 INFO - 'LANGUAGE': 'en_US:en', 10:49:47 INFO - 'LOGNAME': 'cltbld', 10:49:47 INFO - 'MAIL': '/var/mail/cltbld', 10:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:47 INFO - 'MOZ_NO_REMOTE': '1', 10:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:47 INFO - 'NO_EM_RESTART': '1', 10:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:47 INFO - 'PWD': '/builds/slave/test', 10:49:47 INFO - 'SHELL': '/bin/bash', 10:49:47 INFO - 'SHLVL': '1', 10:49:47 INFO - 'TERM': 'linux', 10:49:47 INFO - 'TMOUT': '86400', 10:49:47 INFO - 'USER': 'cltbld', 10:49:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 10:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:47 INFO - '_': '/tools/buildbot/bin/python'} 10:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:49:48 INFO - Cleaning up... 10:49:48 INFO - Return code: 0 10:49:48 INFO - Running post-action listener: _resource_record_post_action 10:49:48 INFO - Running post-action listener: _start_resource_monitoring 10:49:48 INFO - Starting resource monitoring. 10:49:48 INFO - [mozharness: 2016-07-25 17:49:48.130340Z] Finished create-virtualenv step (success) 10:49:48 INFO - [mozharness: 2016-07-25 17:49:48.130823Z] Running install step. 10:49:48 INFO - Running pre-action listener: _resource_record_pre_action 10:49:48 INFO - Running main action method: install 10:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:49:48 INFO - Reading from file tmpfile_stdout 10:49:48 INFO - Detecting whether we're running mozinstall >=1.0... 10:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:49:48 INFO - Reading from file tmpfile_stdout 10:49:48 INFO - Output received: 10:49:48 INFO - Usage: mozinstall [options] installer 10:49:48 INFO - Options: 10:49:48 INFO - -h, --help show this help message and exit 10:49:48 INFO - -d DEST, --destination=DEST 10:49:48 INFO - Directory to install application into. [default: 10:49:48 INFO - "/builds/slave/test"] 10:49:48 INFO - --app=APP Application being installed. [default: firefox] 10:49:48 INFO - mkdir: /builds/slave/test/build/application 10:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:50:05 INFO - Reading from file tmpfile_stdout 10:50:05 INFO - Output received: 10:50:05 INFO - /builds/slave/test/build/application/firefox/firefox 10:50:05 INFO - Running post-action listener: _resource_record_post_action 10:50:05 INFO - [mozharness: 2016-07-25 17:50:05.667612Z] Finished install step (success) 10:50:05 INFO - [mozharness: 2016-07-25 17:50:05.667891Z] Running run-tests step. 10:50:05 INFO - Running pre-action listener: _resource_record_pre_action 10:50:05 INFO - Running main action method: run_tests 10:50:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:50:05 INFO - Python 2.7.3 10:50:05 INFO - Return code: 0 10:50:05 INFO - grabbing minidump binary from tooltool 10:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:05 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 0x1d0d3b0>, '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 0x1d0e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:50:05 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 10:50:05 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 10:50:05 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 10:50:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:50:05 INFO - Return code: 0 10:50:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:50:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:50:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:50:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:50:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:50:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:50:05 INFO - Using env: {'DISPLAY': ':0', 10:50:05 INFO - 'HOME': '/home/cltbld', 10:50:05 INFO - 'LANG': 'en_US.UTF-8', 10:50:05 INFO - 'LANGUAGE': 'en_US:en', 10:50:05 INFO - 'LOGNAME': 'cltbld', 10:50:05 INFO - 'MAIL': '/var/mail/cltbld', 10:50:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:50:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:05 INFO - 'MOZ_NO_REMOTE': '1', 10:50:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:05 INFO - 'NO_EM_RESTART': '1', 10:50:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:05 INFO - 'PWD': '/builds/slave/test', 10:50:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:50:05 INFO - 'SHELL': '/bin/bash', 10:50:05 INFO - 'SHLVL': '1', 10:50:05 INFO - 'TERM': 'linux', 10:50:05 INFO - 'TMOUT': '86400', 10:50:05 INFO - 'USER': 'cltbld', 10:50:05 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609', 10:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:05 INFO - '_': '/tools/buildbot/bin/python'} 10:50:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:50:05 INFO - mozversion application_buildid: 20160725073102 10:50:05 INFO - mozversion application_changeset: e50eb5912d50b6e9cf6cb09f7137699218e68240 10:50:05 INFO - mozversion application_display_name: Nightly 10:50:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:50:05 INFO - mozversion application_name: Firefox 10:50:05 INFO - mozversion application_remotingname: firefox 10:50:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:50:05 INFO - mozversion application_vendor: Mozilla 10:50:05 INFO - mozversion application_version: 50.0a1 10:50:05 INFO - mozversion platform_buildid: 20160725073102 10:50:05 INFO - mozversion platform_changeset: e50eb5912d50b6e9cf6cb09f7137699218e68240 10:50:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:50:05 INFO - mozversion platform_version: 50.0a1 10:50:05 INFO - using testdate: 1469469005 10:50:05 INFO - actual date: 1469469005 10:50:05 INFO - starting webserver on 'localhost:37688' 10:50:05 INFO - SUITE-START | Running 2 tests 10:50:05 INFO - TEST-START | dromaeo_css 10:50:05 INFO - operating with platform_type : linux_ 10:50:05 INFO - Initialising browser for dromaeo_css test... 10:50:05 INFO - TEST-INFO | started process 5460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu8Btxi/profile http://localhost:37688/getInfo.html) 10:50:09 INFO - PROCESS | 5460 | JavaScript error: , line 0: uncaught exception: undefined 10:50:10 INFO - PROCESS | 5460 | __metrics Screen width/height:1600/1200 10:50:10 INFO - PROCESS | 5460 | colorDepth:24 10:50:10 INFO - PROCESS | 5460 | Browser inner width/height: 1024/697 10:50:10 INFO - PROCESS | 5460 | __metrics 10:50:11 INFO - PROCESS | 5460 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:50:11 INFO - PROCESS | 5460 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:50:12 INFO - TEST-INFO | 5460: exit 0 10:50:12 INFO - Browser initialized. 10:50:12 INFO - Running cycle 1/1 for dromaeo_css test... 10:50:12 INFO - TEST-INFO | started process 5541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu8Btxi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:50:23 INFO - PROCESS | 5541 | RSS: Main: 157179904 10:50:23 INFO - PROCESS | 5541 | 10:51:15 INFO - PROCESS | 5541 | 1469469075328 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:53:22 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:37688/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37688/tests/dromaeo/cssquery-ext.html) 10:53:24 INFO - PROCESS | 5541 | RSS: Main: 336113664 10:53:24 INFO - PROCESS | 5541 | 10:56:26 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:37688/tests/dromaeo/cssquery-ext.html (next: http://localhost:37688/tests/dromaeo/cssquery-jquery.html) 10:56:27 INFO - PROCESS | 5541 | RSS: Main: 248528896 10:56:27 INFO - PROCESS | 5541 | 10:59:29 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:37688/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37688/tests/dromaeo/cssquery-mootools.html) 10:59:30 INFO - PROCESS | 5541 | RSS: Main: 184111104 10:59:30 INFO - PROCESS | 5541 | 11:02:32 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:37688/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37688/tests/dromaeo/cssquery-prototype.html) 11:02:32 INFO - PROCESS | 5541 | RSS: Main: 225525760 11:02:32 INFO - PROCESS | 5541 | 11:05:35 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:37688/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37688/tests/dromaeo/cssquery-yui.html) 11:05:35 INFO - PROCESS | 5541 | RSS: Main: 188567552 11:05:35 INFO - PROCESS | 5541 | 11:08:38 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:37688/tests/dromaeo/cssquery-yui.html (next: http://localhost:37688/tests/dromaeo/cssquery-dojo.html) 11:08:38 INFO - PROCESS | 5541 | RSS: Main: 285843456 11:08:38 INFO - PROCESS | 5541 | 11:08:38 INFO - PROCESS | 5541 | __start_tp_report 11:08:38 INFO - PROCESS | 5541 | _x_x_mozilla_page_load 11:08:38 INFO - PROCESS | 5541 | _x_x_mozilla_page_load_details 11:08:38 INFO - PROCESS | 5541 | |i|pagename|runs| 11:08:38 INFO - PROCESS | 5541 | |0;dojo.html;3021.6978302169787;3048.5274782408733;3059.6634370219285;3069.309405383789;3090.582771325872;5175.844724658266;5216.478352164781;5229.477052294768;5293.947060529394;5311.362636483617;5294.629375943686;5299.125644268701;5332.413434522209;5354.839354819362;5384.111621582434;4783.497732738056;4826.61387089032;4877.926831097537;4886.828960986366;5020.196768517038;4918.385201849769;4940.703557786526;4968.70187788732;4979.875503112415;5000.349954505909;4692.97653511732;4727.78724957376;4760.6429517785955;4777.665563410563;4852.344933433977;4803.279508073782;4822.276658501218;4833.32333473314;4885.487023862479;4921.138800709861;4822.397200349957;4842.878928026792;4847.248676455155;4864.975675121602;4890.095332363524;5121.8463446096675;5185;5239.633225674204;5246.737663116867;5399.757010934478;5611.8877622447735;5629.240052592889;5648.4633959773755;5667.291588551431;5671.914921276184;5649.096144616841;5727.627704199213;5727.828165155052;5732.398098199671;5733;5189.766460509286;5253.658512196695;5305.65513241638;5305.681659100466;5376.46235376467;5804.854878628068;5829.15477255804;5859.44335288147;5861.062230043172;5862.032764593794;5617.41017193197;5657.066584013674;5660.943390566124;5663.235463212496;5672.177534257509;5516.531094856902;5562.916556251659;5602.943970560243;5608.158776183605;5667.064934285879;5594.1888426177975;5602.943970560324;5603.887922241533;5607.579431542651;5609.943900561024;5562.777488900399;5604.299462567179;5606.411326810708;5612.663240205601;5619.550435965113;4178.01816573105;4220.894477638022;4287.528371879091;4294.398784170218;4314.180305741899;3867.0719027433215;3876.205377897524;3884.1843212925037;3911.02224443889;3919.627635374635;5363.410024897258;5371.167469042305;5379.112446446293;5379.596530260246;5420.02439560875;5529.336479622471;5569.470900264469;5644.040513112698;5647.040003199384;5667.4615911488345;5351.117065684119;5359.946400535945;5364.463553644682;5369.087255166631;5372.328458942632;4883.560479556857;4883.658143929962;4894.779734911937;4925.482824303396;4938.703677779345;5621.381648018714;5784.652920824764;5839.474447299678;5863.560232982543;5872.236609240771;5682.488576028178;5685.687287199244;5686.857828554319;5700.25896633435;5734.197212390185;5859.062549992152;5866.266716660418;5869.442402971711;5876.3536011037895;5879.676617786063;5357.973210134081;5443.945560544344;5448.782048718165;5534.363548192009;5614.157876318585;5567.805126820542;5594.300712410949;5604.551635869202;5607.859803504945;5611.831645050655;5495.2856128703015;5497.835064948058;5498.092814685532;5502.064649009598;5505.064139096283;5442.6462279951675;5456.154296084113;5461.262729531462;5482.23248745168;5489.533389661764;5477.945220547903;5494.835154945358;5541.9168712470155;5546.58400619947;5550.250716153268;5563.471470210324;5570.415106413769;5614.2701448811395;5617.410171931889;5624.437556244507;5266.762995665281;5326.041312563776;5402.135658294654;5458.590605704509;5466.34403871538 11:08:38 INFO - PROCESS | 5541 | |1;ext.html;579.2643342954448;616.6331033035344;624.1199908129538;631.5074242091165;633.0946746152999;31314;42414.787926060366;43336.56663433365;43343.566564334345;43473.130537389276;46107.308390374084;46441.30338044924;46477.53522464774;46525.302120468135;46548;8965.372423930312;9164.495952722598;9171.495567743772;9172.908270917305;9174.17432431081;8954.507502087383;9046.547672616343;9047.140521650466;9049.773755656095;9050.32122590805;9070.365074444791;9110.407823491485;9116.407433516833;9119.863202051974;9121.49831759253;9024.954875225614;9048;9066.863997040049;9073.364864459458;9073.863892041625;8929.107089291085;8985.101489851028;8985.46087234768;8989.550522473915;8990.910090899073;43827.561724382664;44208;44319.335209971876;44334.778326108484;44366.77816610929;3392.3215356928713;3572.1962558424407;3572.8034958077296;3710.5361829771277;3907.902302442433;34287.14282142966;34547.654523454694;34804.12989675253;35676.64323356759;35800;4474.194644963905;4487.371767952489;4494.235979883428;4500.437445319335;4536.72779633223;381487;381618.09190954146;382104;383807;384163;53592.46407535953;59833.70083149557;61805.69097154486;62007.689961549906;62251.68874155691;58598;64834.35165648378;65009.67495162494;65223.347766522675;65236;17378.304867805145;17543.561410964572;17545;17551.473455796346;17557.64884702299;10697.197710171768;12379.814302785466;12948.870511294956;13011.739765204642;13099.869001309866;17794.288228470974;17801.643967120584;18119.18463669138;18527.629447410975;18554.628907421775;6529;6533.934660653427;6773.322667733286;6865.794026179223;6890.552114112566;968.4286271100085;1055.3245922609535;1090.8472813806075;1098.5825386353295;1120.38938778366;32521;33148.834255828566;33347.499787503206;33485.49771753426;33581.66418335834;1095.085603521053;1131.5926266544038;1145.0839328537138;1209.4738788626976;1210.3827048205303;16965.491035268962;17187;17270.22283997223;17478.388256410966;17530.824691753176;522620;525748;526172;527588;527836;58896.11655825166;58897.41102589005;58968;59046.40953590409;59058.704706476194;1247.1270110922392;1378.476179051974;1386.8197134372467;1387.2855479427901;1400.3628349101134;32216.19459513531;34270.314593708485;34328;34558.65441345655;34586.30827383488;51632.74183629058;52108.47891521036;52153.217701735266;52241.21638175355;52243.73878130585;419161.6586838892;420436;421216.62091963924;421240;422863;27972.58041129344;28039.71960280371;28523.144305670863;29729.85135074311;43651.34522982221;49264;49308.2603760951;49374.25938610852;49402.75298623484;49553.25670114879;41989;42083.7895810519;42631.786841065594;43053.56946430621;44493.77753111214;42854.35718464288;43097.56902431061;43352.56647433611;44387.55612443834;44446.333304999804;42038;42937.14125717531;42977;43236.567634323255;43507.56492435035;36124.4581331275;37878.62121378861;38115.85652430431;38807.6119238804;38938.80530597442;28407.28981775472;28836.279093022844;28913.277168070967;28990.42019159563;29120 11:08:38 INFO - PROCESS | 5541 | |2;jquery.html;348.99476507852404;362.5540585080351;378.1340729728921;381.6374444277936;392.55249016121627;14476.420943162275;18594.53513662159;18891;19486.415407537777;20777.480562985933;18811.341603043897;19008.239670413168;19451.221951121937;19613;19650.115744791485;5521.696306703129;5725.885482290351;5731.541476681877;5731.856703582402;5731.971340143315;5521.199426083215;5595.664260144384;5615.157726341061;5667.829965101033;5668.404817494165;5599.300087489064;5604.766951270714;5606.775728970836;5616.213730077792;5618.297712785902;5456.890862182734;5533.723313834292;5540.058190107691;5561.833145005657;5600.383957764642;4988;4990.900181996376;4993.076280888047;4996.800127994876;4999.4250661174065;23378;23472.64791028136;23513.647295290586;23687.881560592257;23820.285391438283;2430.4166999920067;2453.9263822085186;2478.8884500197532;2546.274311821122;2910.985445072782;13994.370253338624;14476.203808790513;14818.629534261621;14842.480513182094;14880.330385132587;1851.7129844873932;1914.7606549181353;1926.6628340040577;1934.4003358958769;2001.5596568754995;72663;75568;76522;86696;88837;10345.793084138426;10550.47247637615;10831.783364332668;10946;11110.777784444266;14806.481773138104;14828.481003164838;14832.480863169738;14837.92581037088;14848.62878428048;7677.577733224614;7825.882611760828;7905.367570594339;7916.445848790645;8178.959105204436;7346.853062938711;7672.884906726404;7676.232376762391;7895.249951254622;7919.524828510308;4511.436070491189;4518.096380723869;4564.748938808398;4590.747508886977;4632.4672662644225;1800.1539276540268;1861.8324350808493;1895.4408449507152;1903.8096190381127;1908.4656296237076;940.9341346105707;955.9952200238954;1002.871769259583;1018.6434747838198;1038.9740256493496;18837.905810471133;19390.903045484683;19822.90088549548;19894.104765285596;19918.402447926586;936.3164889630608;972.9610815567439;976.7362812040709;1012.2205901455837;1041.598984391015;10560.155187584975;10853.477555004332;11068.501917413736;11616.128790340757;12060.396980150957;514955;519045;542502;545546;553065;76458.59363286544;78029;101717;104963.4751826236;107795;967.8790151231096;969.2197780786394;1018.6383833739064;1020.3418794877263;1024.533837104116;16893.239804209086;16934.57663558421;17595.824041759417;17848.46454606364;17908.820911790714;42556;42611.57388426076;43214.78392608017;43286.35070473883;44738.3289250668;60012.69993650004;62346;62807.37192628015;63790;64104.679476602316;7857.803554911173;7865.646045927832;7928.960355198187;8005.199480051948;8117.715879944174;6390.105385245976;10538.315009524356;11681.415929203336;11838.171328006956;12931.5473958411;10631.734206644896;10726.141908647445;10952.45237738094;11085.22403431752;11088.944555277494;5555.194496798023;11659.125565582446;11676.416179191176;11914.761704765682;12029.278243305429;8301.501909885426;8360.163983601591;8401.831963360577;8428.915710842813;8797.780055498664;11873.940630297138;12551.937240314106;12950.287734174712;12951.676208094874;13048.347582620641;12391.62825115248;12448.385838973554;12520.31138287403;12603.18079324841;12971.5459958901 11:08:38 INFO - PROCESS | 5541 | |3;mootools.html;1449.9492517761878;1507.1710559192443;1620.5948512871782;1729.688656041912;1788.204249109146;7555.244475552442;7987.960060199705;7994.680212791482;8001;8012.879806802903;6956.791296261107;7490.6254687265555;7670.501417407864;7679.923200768005;7847.882281765778;2287.4738810073695;2308.5036717105904;2316.073570571776;2318.8840557972035;2318.93043208704;2270.7275126984787;2287.7025986621716;2311.2835021143414;2315.3632750993443;2316.3051084674617;2007.9498012549657;2230.4423894026495;2286.874221917794;2287.0280130944366;2303.332033710222;2278.8063014643776;2295.4605667668084;2299.678045073691;2318.0611852199886;2318.119114736398;2285.394370491821;2291.450051987528;2292.289390289016;2294.6443301288327;2294.8623082615095;7960.721374751914;7976.960115199445;8008.119106898294;8012.879806802903;8084;4648.418947631546;4796.616270698336;4818.566329030404;4827.468978412372;4862.149123903303;3146.7010633989735;3203.359328134359;3290.8190049547266;3322.90031299059;3340.448825943716;1078.4823284823328;1094.7263184203948;1096.3641088168843;1109.5617231193714;1118.245184500459;10367.792644147075;10450.947745261301;10564.524596393181;10574.365538067663;10576.312539684895;4150.377443383456;4247.5540068292385;4376.277914144131;4390.868273951786;4428.867133985921;9152.267818574632;9158.771030724285;9163.908360916439;9167.49578773174;9168.44989300644;4769.14155452015;4773.164696178155;4773.546513081321;4797.472278049412;4799.112164249625;4375.978120109379;4427.889302767392;4435.600795928317;4455.576720211575;4573.63410927125;3708.369577171887;3718.3121122592406;3830.4678128748724;3844.2695887781233;3848.826802793881;1100.9504572294265;1191.642507247822;1211.5275042733165;1212.1878341511033;1227.8096894981293;866.7833041739565;904.0462312260628;914.1041779056562;914.4787471141518;949.487276870496;5603.551715862721;5639.2668953035845;5642.915356269659;5673.943260567424;5882.470577647947;959.7264779537799;962.9566669499749;963.9036096390305;965.9178969787506;1004.9397036177853;3990.6607938324987;4071.491063617048;4076.0421300994244;4120.938185927213;4179.644730197967;9382.95308523453;9598.712038638712;9728.854067188999;9776.706698799047;9826.164775993977;9577.760555986157;9604.279679024101;9665.081817227352;9680.080392362714;9692.369995950241;7404.074490688664;7494.288042635941;7511.549307041595;7513.511621744569;7540.321371076519;5318.361796584435;5361.169018802092;5365.839024829262;5556.194351819045;5706.600537962303;8622.180892815173;8871.112888711077;8895.644174232959;8929.06244844308;8956.507392093237;8953.59708813118;9080.772980675272;9089.863652045093;9195.160967806332;9213.815723685355;6957.79126626202;7095.432365410651;7227.38567221771;7256.1655409628565;7290.161631412456;7633.5419874807685;7908.4464087513325;7913.3669306456495;7914.881276780968;7931.048274206902;6864.553804002923;6964.930350696631;7081.6459177039915;7138.892916606152;7283.126024877049;7020.684069217;7021.192562855133;7153.248908864494;7194.100737407824;7200.675969581486;6300.275468321019;6324.30432652417;6382.936170638234;6393.776217832354;6411.551191416556;4902.7058376497525;4908.533689299511;4965.726885021359;5017.3226614406585;5156.896862062813;4921.50784921505;4979.701217926936;5064.41759197697;5081.23781432788;5114.232865070269 11:08:38 INFO - PROCESS | 5541 | |4;prototype.html;316.33411668437935;320.5384246684774;325.30547281553874;325.87453830275336;329.62422837964715;5074.873128171797;5183.393148124075;5206.167013277876;5241.86895327617;5253.343332083489;5146.305248791412;5188.325517682696;5194.0781910693;5207.843764687056;5219.791208351661;4122.546519882811;4133.607307305816;4141.213169497801;4142;4153.813078411479;3952.170044290688;4050.9594904051023;4133.42132101506;4150.439690641755;4161.167766446708;4035.717499775002;4044.4924147028883;4046;4046.5548789633262;4052.777097259664;4030.8186131624147;4035.152617950205;4036.3541833306676;4047.6238079053114;4080.5307389649975;3580.6598373154507;3591.7844929304065;3606.9819650901577;3608.332458495187;3613.313470440608;5123.615728820316;5137.974310128463;5154.149565321717;5158.432572417031;5173.482651734834;4627.722336659811;4631.397918270637;4646.395968524071;4653.139169253699;4665.113628410625;5420.945790542083;5470.370907345627;5473.534749546293;5475.370332411784;5497.422770609109;3817.503724515795;3882.903232254579;3918.216356728637;3923.431102490123;3931.705122115824;5618.775248990036;5643.351014633328;5652.293463317085;5664.6034777566;5667.886642267173;3998.1803730235233;4011.6590089842107;4026.6376026157786;4033.51597808259;4037.9192416151513;3975.6620687241907;3976.8806935791395;4014.2573623879675;4031.5565287818317;4085.836566537365;4576.4737055239075;4585.10590434862;4597.402337696078;4630.745309008037;4645.256758918556;5492.148716948879;5505.697186654692;5509.190312940349;5521.503064724194;5552.972235138879;1324.9668758280927;1347.1512946843623;1373.4300265389752;1386.230641993683;1390.9930450347683;936.1434287626881;937.7093101138669;957.698325027614;959.2374062620233;962.31675510387;5306.151015837525;5319.893602127936;5325.535477743651;5329.9467005330225;5361.490658387447;5603.7478313475995;5626.099824028136;5635.154726791015;5638.351589567253;5648.604597678205;5191.636585439059;5277.577793776489;5292.518094933424;5335.092374655822;5354.9196762048605;2658.189252278035;2674.93312667181;2686.570148776186;2687.9462410751676;2696.379832638504;5094.949050509522;5128.71762072274;5137.691738495702;5181.35233095863;5209.244659524347;4831.879203019882;4954.22563364517;4998.775055122528;5020.096382651158;5036.614930894033;5115.590752739772;5124.8206312778875;5156.5616922562;5182.6372153949615;5204.412654140523;4967.925481117858;4979.800807967786;5023.572996295356;5060.924086138637;5070.340855688737;4757.666963312535;4874.926876096933;4935.728534930613;4946.282788995503;4970.824507413789;5085.949140508696;5132.46109158533;5156.458571849902;5161.793528258828;5186.8962620746615;3624.7100231981904;3689.741718079709;3694.833732481991;3712.9232522568154;3720.330340538729;4733.715977041388;4955.72743499111;4967.677100988424;5116.9744151279;5353.491418315254;5343.7060961647485;5503.9174412383045;5509.834704958857;5512.614117011771;5514.476124768141;5439.156930675752;5468.2891224142195;5519.199716041232;5521.613487055867;5552.3892371839875;5212.739363031909;5406.162044883049;5431.456854314537;5461.617686761889;5474.260974768515;5519.75805443772;5542.473465020817;5555.611107222456;5558.165805284166;5568.49883510486;5454.236406903116;5461.180822876441;5466.753996070107;5471.480209380103;5472.589555783253 11:08:38 INFO - PROCESS | 5541 | |5;yui.html;726.9200387957325;743.4498471131365;790.56518914597;790.6837265093961;792.5482474989259;15373.385064597416;16641.41755038574;16658.58353541159;16709.081000544982;16709.91645041776;15164.317605707742;15232.23838808058;15323;15340.6931861363;15368.231588420562;650.5413683353224;792.6987744657022;799.940004499662;812.46377390922;816.8652172391548;807.6769292283104;809.8501777171213;811.0632219786156;811.2739098506833;812.1391325195311;853.2065179383171;857.939944203906;858.2704701004159;858.5535521528801;858.5792961448876;680.1939701453794;832.8126171611369;842.3093063687778;843.2916350265745;854.0136142755097;618.77724019353;620.6927570852457;621.0776996160698;621.0994058614981;621.1242148570494;14630.122192668368;14727.190004549746;14732.48436304735;14738.11571305725;14751.18868462234;14305.57083287503;14310.284485775774;14354.856451435457;14527.491537796232;14565.49020784278;12803.679908002281;12899.742005159844;13012.544560940321;13058.412371443213;13133.934330328288;4417.690761646686;4438.05178057733;4521.706089104197;4531.977340113312;4541.795619197144;80493.59753201314;80527;80581.59709201417;80786.19213807845;80900;11500.597479088192;11594.88405115938;11798.351090689923;12138.211016283913;12174.026077913746;21915.452113696967;21984.230551930606;22177.778222217894;22255.666165007537;22414.215502457337;8268.793280168044;8368.539730314891;8485.109063548362;8533.104024077507;8770.649174033095;4719.5752382285755;4724.574788269004;4777.211760059551;4835.105505481497;4838.056578967138;3320.169957510622;3424.366492198951;3430.1767575782133;3430.7255419566377;3434.793912365266;568.1789813719219;571.6855729348924;572.4561666416921;573.9971300143557;588.3733823477983;583.9678817664984;707.1508006562801;713.3793599568305;737.6901701285473;788.755485799404;9262.44425334482;9704.223662107015;9822;9985.80028399428;10009.849852252222;665.6871270502855;740.4261697184725;744.2148533297424;760.9581473018926;764.9349805266614;4343;4814.566688998007;4850.345203397496;5283.353157520126;5532.280803495601;70874.29125708676;71622;71735.64132179305;109123.45438272758;126318;107159.46420268004;109037.45481272542;109757.45121274343;109886;113905.4304728471;58159.70920145372;85354.57322713347;90971.53140543457;94585;98296.50851745695;10292.897071029194;10812.459377031275;10869.67390978272;10897.881078596496;10974;53832.461675384315;53923.73038134784;54475.182872256155;54654.45345546653;57088;68428;69160;69831.65084174546;76681;83084.58457707673;12423.31671758062;12460.144693975813;12569.685757856127;12611.180273282207;12683;14437.494687685881;14577.562673119823;14726.1900595464;14738.484153054591;15265.923670381577;14216.431342746175;14667.119972801665;14786.778198327249;15162.469313573973;15170.924145379644;13145.868541314465;13308.920009778665;13608.455661773418;14299.35652895643;15311;13943.233122178377;14128.646783830487;14247.430102796186;14314.713705725619;14540.85459145395;11604.76790464169;11790.764184716087;11841.5855445059;12024.579139730417;12136.635900922987;11868.881311186778;12371.443285052374;12419.689507762017;12568.560100396442;12619 11:08:38 INFO - PROCESS | 5541 | __end_tp_report 11:08:38 INFO - PROCESS | 5541 | __start_cc_report 11:08:38 INFO - PROCESS | 5541 | _x_x_mozilla_cycle_collect,1646 11:08:38 INFO - PROCESS | 5541 | __end_cc_report 11:08:38 INFO - PROCESS | 5541 | __startTimestamp1469470118852__endTimestamp 11:08:38 INFO - PROCESS | 5541 | 11:08:38 INFO - PROCESS | 5541 | ------- Summary: start ------- 11:08:38 INFO - PROCESS | 5541 | Number of tests: 6 11:08:38 INFO - PROCESS | 5541 | 11:08:38 INFO - PROCESS | 5541 | [#0] dojo.html Cycles:165 Average:5256.05 Median:5456.15 stddev:589.30 (10.8%) stddev-sans-first:564.43 11:08:38 INFO - PROCESS | 5541 | Values: 3021.7 3048.5 3059.7 3069.3 3090.6 5175.8 5216.5 5229.5 5293.9 5311.4 5294.6 5299.1 5332.4 5354.8 5384.1 4783.5 4826.6 4877.9 4886.8 5020.2 4918.4 4940.7 4968.7 4979.9 5000.3 4693.0 4727.8 4760.6 4777.7 4852.3 4803.3 4822.3 4833.3 4885.5 4921.1 4822.4 4842.9 4847.2 4865.0 4890.1 5121.8 5185.0 5239.6 5246.7 5399.8 5611.9 5629.2 5648.5 5667.3 5671.9 5649.1 5727.6 5727.8 5732.4 5733.0 5189.8 5253.7 5305.7 5305.7 5376.5 5804.9 5829.2 5859.4 5861.1 5862.0 5617.4 5657.1 5660.9 5663.2 5672.2 5516.5 5562.9 5602.9 5608.2 5667.1 5594.2 5602.9 5603.9 5607.6 5609.9 5562.8 5604.3 5606.4 5612.7 5619.6 4178.0 4220.9 4287.5 4294.4 4314.2 3867.1 3876.2 3884.2 3911.0 3919.6 5363.4 5371.2 5379.1 5379.6 5420.0 5529.3 5569.5 5644.0 5647.0 5667.5 5351.1 5359.9 5364.5 5369.1 5372.3 4883.6 4883.7 4894.8 4925.5 4938.7 5621.4 5784.7 5839.5 5863.6 5872.2 5682.5 5685.7 5686.9 5700.3 5734.2 5859.1 5866.3 5869.4 5876.4 5879.7 5358.0 5443.9 5448.8 5534.4 5614.2 5567.8 5594.3 5604.6 5607.9 5611.8 5495.3 5497.8 5498.1 5502.1 5505.1 5442.6 5456.2 5461.3 5482.2 5489.5 5477.9 5494.8 5541.9 5546.6 5550.3 5563.5 5570.4 5614.3 5617.4 5624.4 5266.8 5326.0 5402.1 5458.6 5466.3 11:08:38 INFO - PROCESS | 5541 | 11:08:38 INFO - PROCESS | 5541 | [#1] ext.html Cycles:180 Average:61247.95 Median:43340.07 stddev:118336.56 (273.0%) stddev-sans-first:118580.86 11:08:38 INFO - PROCESS | 5541 | Values: 579.3 616.6 624.1 631.5 633.1 31314.0 42414.8 43336.6 43343.6 43473.1 46107.3 46441.3 46477.5 46525.3 46548.0 8965.4 9164.5 9171.5 9172.9 9174.2 8954.5 9046.5 9047.1 9049.8 9050.3 9070.4 9110.4 9116.4 9119.9 9121.5 9025.0 9048.0 9066.9 9073.4 9073.9 8929.1 8985.1 8985.5 8989.6 8990.9 43827.6 44208.0 44319.3 44334.8 44366.8 3392.3 3572.2 3572.8 3710.5 3907.9 34287.1 34547.7 34804.1 35676.6 35800.0 4474.2 4487.4 4494.2 4500.4 4536.7 381487.0 381618.1 382104.0 383807.0 384163.0 53592.5 59833.7 61805.7 62007.7 62251.7 58598.0 64834.4 65009.7 65223.3 65236.0 17378.3 17543.6 17545.0 17551.5 17557.6 10697.2 12379.8 12948.9 13011.7 13099.9 17794.3 17801.6 18119.2 18527.6 18554.6 6529.0 6533.9 6773.3 6865.8 6890.6 968.4 1055.3 1090.8 1098.6 1120.4 32521.0 33148.8 33347.5 33485.5 33581.7 1095.1 1131.6 1145.1 1209.5 1210.4 16965.5 17187.0 17270.2 17478.4 17530.8 522620.0 525748.0 526172.0 527588.0 527836.0 58896.1 58897.4 58968.0 59046.4 59058.7 1247.1 1378.5 1386.8 1387.3 1400.4 32216.2 34270.3 34328.0 34558.7 34586.3 51632.7 52108.5 52153.2 52241.2 52243.7 419161.7 420436.0 421216.6 421240.0 422863.0 27972.6 28039.7 28523.1 29729.9 43651.3 49264.0 49308.3 49374.3 49402.8 49553.3 41989.0 42083.8 42631.8 43053.6 44493.8 42854.4 43097.6 43352.6 44387.6 44446.3 42038.0 42937.1 42977.0 43236.6 43507.6 36124.5 37878.6 38115.9 38807.6 38938.8 28407.3 28836.3 28913.3 28990.4 29120.0 11:08:38 INFO - PROCESS | 5541 | 11:08:38 INFO - PROCESS | 5541 | [#2] jquery.html Cycles:180 Average:30435.13 Median:2466.41 stddev:88140.35 (3573.6%) stddev-sans-first:88358.65 11:08:38 INFO - PROCESS | 5541 | Values: 349.0 362.6 378.1 381.6 392.6 14476.4 18594.5 18891.0 19486.4 20777.5 18811.3 19008.2 19451.2 19613.0 19650.1 5521.7 5725.9 5731.5 5731.9 5732.0 5521.2 5595.7 5615.2 5667.8 5668.4 5599.3 5604.8 5606.8 5616.2 5618.3 5456.9 5533.7 5540.1 5561.8 5600.4 4988.0 4990.9 4993.1 4996.8 4999.4 23378.0 23472.6 23513.6 23687.9 23820.3 2430.4 2453.9 2478.9 2546.3 2911.0 13994.4 14476.2 14818.6 14842.5 14880.3 1851.7 1914.8 1926.7 1934.4 2001.6 72663.0 75568.0 76522.0 86696.0 88837.0 10345.8 10550.5 10831.8 10946.0 11110.8 14806.5 14828.5 14832.5 14837.9 14848.6 7677.6 7825.9 7905.4 7916.4 8179.0 7346.9 7672.9 7676.2 7895.2 7919.5 4511.4 4518.1 4564.7 4590.7 4632.5 1800.2 1861.8 1895.4 1903.8 1908.5 940.9 956.0 1002.9 1018.6 1039.0 18837.9 19390.9 19822.9 19894.1 19918.4 936.3 973.0 976.7 1012.2 1041.6 10560.2 10853.5 11068.5 11616.1 12060.4 514955.0 519045.0 542502.0 545546.0 553065.0 76458.6 78029.0 101717.0 104963.5 107795.0 967.9 969.2 1018.6 1020.3 1024.5 16893.2 16934.6 17595.8 17848.5 17908.8 42556.0 42611.6 43214.8 43286.4 44738.3 60012.7 62346.0 62807.4 63790.0 64104.7 7857.8 7865.6 7929.0 8005.2 8117.7 6390.1 10538.3 11681.4 11838.2 12931.5 10631.7 10726.1 10952.5 11085.2 11088.9 5555.2 11659.1 11676.4 11914.8 12029.3 8301.5 8360.2 8401.8 8428.9 8797.8 11873.9 12551.9 12950.3 12951.7 13048.3 12391.6 12448.4 12520.3 12603.2 12971.5 11:08:38 INFO - PROCESS | 5541 | 11:08:38 INFO - PROCESS | 5541 | [#3] mootools.html Cycles:180 Average:5314.54 Median:5237.63 stddev:2850.71 (54.4%) stddev-sans-first:2843.91 11:08:38 INFO - PROCESS | 5541 | Values: 1449.9 1507.2 1620.6 1729.7 1788.2 7555.2 7988.0 7994.7 8001.0 8012.9 6956.8 7490.6 7670.5 7679.9 7847.9 2287.5 2308.5 2316.1 2318.9 2318.9 2270.7 2287.7 2311.3 2315.4 2316.3 2007.9 2230.4 2286.9 2287.0 2303.3 2278.8 2295.5 2299.7 2318.1 2318.1 2285.4 2291.5 2292.3 2294.6 2294.9 7960.7 7977.0 8008.1 8012.9 8084.0 4648.4 4796.6 4818.6 4827.5 4862.1 3146.7 3203.4 3290.8 3322.9 3340.4 1078.5 1094.7 1096.4 1109.6 1118.2 10367.8 10450.9 10564.5 10574.4 10576.3 4150.4 4247.6 4376.3 4390.9 4428.9 9152.3 9158.8 9163.9 9167.5 9168.4 4769.1 4773.2 4773.5 4797.5 4799.1 4376.0 4427.9 4435.6 4455.6 4573.6 3708.4 3718.3 3830.5 3844.3 3848.8 1101.0 1191.6 1211.5 1212.2 1227.8 866.8 904.0 914.1 914.5 949.5 5603.6 5639.3 5642.9 5673.9 5882.5 959.7 963.0 963.9 965.9 1004.9 3990.7 4071.5 4076.0 4120.9 4179.6 9383.0 9598.7 9728.9 9776.7 9826.2 9577.8 9604.3 9665.1 9680.1 9692.4 7404.1 7494.3 7511.5 7513.5 7540.3 5318.4 5361.2 5365.8 5556.2 5706.6 8622.2 8871.1 8895.6 8929.1 8956.5 8953.6 9080.8 9089.9 9195.2 9213.8 6957.8 7095.4 7227.4 7256.2 7290.2 7633.5 7908.4 7913.4 7914.9 7931.0 6864.6 6964.9 7081.6 7138.9 7283.1 7020.7 7021.2 7153.2 7194.1 7200.7 6300.3 6324.3 6382.9 6393.8 6411.6 4902.7 4908.5 4965.7 5017.3 5156.9 4921.5 4979.7 5064.4 5081.2 5114.2 11:08:38 INFO - PROCESS | 5541 | 11:08:38 INFO - PROCESS | 5541 | [#4] prototype.html Cycles:180 Average:4479.99 Median:5105.27 stddev:1300.51 (25.5%) stddev-sans-first:1266.05 11:08:38 INFO - PROCESS | 5541 | Values: 316.3 320.5 325.3 325.9 329.6 5074.9 5183.4 5206.2 5241.9 5253.3 5146.3 5188.3 5194.1 5207.8 5219.8 4122.5 4133.6 4141.2 4142.0 4153.8 3952.2 4051.0 4133.4 4150.4 4161.2 4035.7 4044.5 4046.0 4046.6 4052.8 4030.8 4035.2 4036.4 4047.6 4080.5 3580.7 3591.8 3607.0 3608.3 3613.3 5123.6 5138.0 5154.1 5158.4 5173.5 4627.7 4631.4 4646.4 4653.1 4665.1 5420.9 5470.4 5473.5 5475.4 5497.4 3817.5 3882.9 3918.2 3923.4 3931.7 5618.8 5643.4 5652.3 5664.6 5667.9 3998.2 4011.7 4026.6 4033.5 4037.9 3975.7 3976.9 4014.3 4031.6 4085.8 4576.5 4585.1 4597.4 4630.7 4645.3 5492.1 5505.7 5509.2 5521.5 5553.0 1325.0 1347.2 1373.4 1386.2 1391.0 936.1 937.7 957.7 959.2 962.3 5306.2 5319.9 5325.5 5329.9 5361.5 5603.7 5626.1 5635.2 5638.4 5648.6 5191.6 5277.6 5292.5 5335.1 5354.9 2658.2 2674.9 2686.6 2687.9 2696.4 5094.9 5128.7 5137.7 5181.4 5209.2 4831.9 4954.2 4998.8 5020.1 5036.6 5115.6 5124.8 5156.6 5182.6 5204.4 4967.9 4979.8 5023.6 5060.9 5070.3 4757.7 4874.9 4935.7 4946.3 4970.8 5085.9 5132.5 5156.5 5161.8 5186.9 3624.7 3689.7 3694.8 3712.9 3720.3 4733.7 4955.7 4967.7 5117.0 5353.5 5343.7 5503.9 5509.8 5512.6 5514.5 5439.2 5468.3 5519.2 5521.6 5552.4 5212.7 5406.2 5431.5 5461.6 5474.3 5519.8 5542.5 5555.6 5558.2 5568.5 5454.2 5461.2 5466.8 5471.5 5472.6 11:08:38 INFO - PROCESS | 5541 | 11:08:38 INFO - PROCESS | 5541 | [#5] yui.html Cycles:180 Average:20830.05 Median:4479.88 stddev:29394.39 (656.1%) stddev-sans-first:29438.09 11:08:38 INFO - PROCESS | 5541 | Values: 726.9 743.4 790.6 790.7 792.5 15373.4 16641.4 16658.6 16709.1 16709.9 15164.3 15232.2 15323.0 15340.7 15368.2 650.5 792.7 799.9 812.5 816.9 807.7 809.9 811.1 811.3 812.1 853.2 857.9 858.3 858.6 858.6 680.2 832.8 842.3 843.3 854.0 618.8 620.7 621.1 621.1 621.1 14630.1 14727.2 14732.5 14738.1 14751.2 14305.6 14310.3 14354.9 14527.5 14565.5 12803.7 12899.7 13012.5 13058.4 13133.9 4417.7 4438.1 4521.7 4532.0 4541.8 80493.6 80527.0 80581.6 80786.2 80900.0 11500.6 11594.9 11798.4 12138.2 12174.0 21915.5 21984.2 22177.8 22255.7 22414.2 8268.8 8368.5 8485.1 8533.1 8770.6 4719.6 4724.6 4777.2 4835.1 4838.1 3320.2 3424.4 3430.2 3430.7 3434.8 568.2 571.7 572.5 574.0 588.4 584.0 707.2 713.4 737.7 788.8 9262.4 9704.2 9822.0 9985.8 10009.8 665.7 740.4 744.2 761.0 764.9 4343.0 4814.6 4850.3 5283.4 5532.3 70874.3 71622.0 71735.6 109123.5 126318.0 107159.5 109037.5 109757.5 109886.0 113905.4 58159.7 85354.6 90971.5 94585.0 98296.5 10292.9 10812.5 10869.7 10897.9 10974.0 53832.5 53923.7 54475.2 54654.5 57088.0 68428.0 69160.0 69831.7 76681.0 83084.6 12423.3 12460.1 12569.7 12611.2 12683.0 14437.5 14577.6 14726.2 14738.5 15265.9 14216.4 14667.1 14786.8 15162.5 15170.9 13145.9 13308.9 13608.5 14299.4 15311.0 13943.2 14128.6 14247.4 14314.7 14540.9 11604.8 11790.8 11841.6 12024.6 12136.6 11868.9 12371.4 12419.7 12568.6 12619.0 11:08:38 INFO - PROCESS | 5541 | -------- Summary: end -------- 11:08:38 INFO - PROCESS | 5541 | 11:08:39 INFO - TEST-INFO | 5541: exit 0 11:08:39 INFO - TEST-OK | dromaeo_css | took 1113706ms 11:08:39 INFO - TEST-START | kraken 11:08:39 INFO - operating with platform_type : linux_ 11:08:39 INFO - Initialising browser for kraken test... 11:08:39 INFO - TEST-INFO | started process 5732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu_cyA1/profile http://localhost:37688/getInfo.html) 11:08:42 INFO - PROCESS | 5732 | JavaScript error: , line 0: uncaught exception: undefined 11:08:43 INFO - PROCESS | 5732 | __metrics Screen width/height:1600/1200 11:08:43 INFO - PROCESS | 5732 | colorDepth:24 11:08:43 INFO - PROCESS | 5732 | Browser inner width/height: 1024/697 11:08:43 INFO - PROCESS | 5732 | __metrics 11:08:44 INFO - PROCESS | 5732 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:08:44 INFO - PROCESS | 5732 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:08:45 INFO - TEST-INFO | 5732: exit 0 11:08:45 INFO - Browser initialized. 11:08:45 INFO - Running cycle 1/1 for kraken test... 11:08:45 INFO - TEST-INFO | started process 5810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu_cyA1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:57 INFO - PROCESS | 5810 | RSS: Main: 157556736 11:08:57 INFO - PROCESS | 5810 | 11:08:59 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37688/tests/kraken/driver.html?testName=audio-beat-detection) 11:09:00 INFO - PROCESS | 5810 | RSS: Main: 213594112 11:09:00 INFO - PROCESS | 5810 | 11:09:03 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37688/tests/kraken/driver.html?testName=audio-dft) 11:09:03 INFO - PROCESS | 5810 | RSS: Main: 192200704 11:09:03 INFO - PROCESS | 5810 | 11:09:07 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37688/tests/kraken/driver.html?testName=audio-fft) 11:09:07 INFO - PROCESS | 5810 | RSS: Main: 270872576 11:09:07 INFO - PROCESS | 5810 | 11:09:09 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37688/tests/kraken/driver.html?testName=audio-oscillator) 11:09:10 INFO - PROCESS | 5810 | RSS: Main: 180187136 11:09:10 INFO - PROCESS | 5810 | 11:09:12 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37688/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:09:13 INFO - PROCESS | 5810 | RSS: Main: 185212928 11:09:13 INFO - PROCESS | 5810 | 11:09:16 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37688/tests/kraken/driver.html?testName=imaging-darkroom) 11:09:16 INFO - PROCESS | 5810 | RSS: Main: 220573696 11:09:16 INFO - PROCESS | 5810 | 11:09:20 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37688/tests/kraken/driver.html?testName=imaging-desaturate) 11:09:20 INFO - PROCESS | 5810 | RSS: Main: 221384704 11:09:20 INFO - PROCESS | 5810 | 11:09:23 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37688/tests/kraken/driver.html?testName=json-parse-financial) 11:09:24 INFO - PROCESS | 5810 | RSS: Main: 221110272 11:09:24 INFO - PROCESS | 5810 | 11:09:25 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37688/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:09:26 INFO - PROCESS | 5810 | RSS: Main: 185303040 11:09:26 INFO - PROCESS | 5810 | 11:09:27 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37688/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:09:28 INFO - PROCESS | 5810 | RSS: Main: 190439424 11:09:28 INFO - PROCESS | 5810 | 11:09:30 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37688/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:09:31 INFO - PROCESS | 5810 | RSS: Main: 195567616 11:09:31 INFO - PROCESS | 5810 | 11:09:33 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:09:34 INFO - PROCESS | 5810 | RSS: Main: 188514304 11:09:34 INFO - PROCESS | 5810 | 11:09:37 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:09:37 INFO - PROCESS | 5810 | RSS: Main: 193556480 11:09:37 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | Cycle 1(1): loaded http://localhost:37688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37688/tests/kraken/driver.html?testName=ai-astar) 11:09:39 INFO - PROCESS | 5810 | RSS: Main: 243703808 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | __start_tp_report 11:09:39 INFO - PROCESS | 5810 | _x_x_mozilla_page_load 11:09:39 INFO - PROCESS | 5810 | _x_x_mozilla_page_load_details 11:09:39 INFO - PROCESS | 5810 | |i|pagename|runs| 11:09:39 INFO - PROCESS | 5810 | |0;ai-astar;103;114;112;112;112;113;113;111;113;112 11:09:39 INFO - PROCESS | 5810 | |1;audio-beat-detection;141;121;118;184;120;117;144;122;156;122 11:09:39 INFO - PROCESS | 5810 | |2;audio-dft;160;161;161;160;160;161;160;161;159;160 11:09:39 INFO - PROCESS | 5810 | |3;audio-fft;74;76;75;110;77;77;76;76;102;75 11:09:39 INFO - PROCESS | 5810 | |4;audio-oscillator;85;84;117;83;84;85;116;85;84;128 11:09:39 INFO - PROCESS | 5810 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;117 11:09:39 INFO - PROCESS | 5810 | |6;imaging-darkroom;146;145;145;145;145;156;146;146;147;145 11:09:39 INFO - PROCESS | 5810 | |7;imaging-desaturate;95;96;95;95;95;96;95;95;95;94 11:09:39 INFO - PROCESS | 5810 | |8;json-parse-financial;55;53;52;53;53;52;53;52;51;52 11:09:39 INFO - PROCESS | 5810 | |9;json-stringify-tinderbox;61;62;61;61;62;61;61;61;62;62 11:09:39 INFO - PROCESS | 5810 | |10;stanford-crypto-aes;75;75;75;76;75;75;74;74;76;82 11:09:39 INFO - PROCESS | 5810 | |11;stanford-crypto-ccm;125;119;130;119;120;129;128;118;192;121 11:09:39 INFO - PROCESS | 5810 | |12;stanford-crypto-pbkdf2;156;156;156;157;159;155;159;157;157;157 11:09:39 INFO - PROCESS | 5810 | |13;stanford-crypto-sha256-iterative;65;63;64;62;61;67;70;62;63;62 11:09:39 INFO - PROCESS | 5810 | __end_tp_report 11:09:39 INFO - PROCESS | 5810 | __start_cc_report 11:09:39 INFO - PROCESS | 5810 | _x_x_mozilla_cycle_collect,1690 11:09:39 INFO - PROCESS | 5810 | __end_cc_report 11:09:39 INFO - PROCESS | 5810 | __startTimestamp1469470179572__endTimestamp 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | ------- Summary: start ------- 11:09:39 INFO - PROCESS | 5810 | Number of tests: 14 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:3.10 (2.8%) stddev-sans-first:0.88 11:09:39 INFO - PROCESS | 5810 | Values: 103.0 114.0 112.0 112.0 112.0 113.0 113.0 111.0 113.0 112.0 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:131.50 stddev:21.93 (16.7%) stddev-sans-first:23.13 11:09:39 INFO - PROCESS | 5810 | Values: 141.0 121.0 118.0 184.0 120.0 117.0 144.0 122.0 156.0 122.0 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 11:09:39 INFO - PROCESS | 5810 | Values: 160.0 161.0 161.0 160.0 160.0 161.0 160.0 161.0 159.0 160.0 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.93 (17.0%) stddev-sans-first:13.40 11:09:39 INFO - PROCESS | 5810 | Values: 74.0 76.0 75.0 110.0 77.0 77.0 76.0 76.0 102.0 75.0 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:84.00 stddev:17.70 (21.1%) stddev-sans-first:18.40 11:09:39 INFO - PROCESS | 5810 | Values: 85.0 84.0 117.0 83.0 84.0 85.0 116.0 85.0 84.0 128.0 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 11:09:39 INFO - PROCESS | 5810 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.00 stddev:3.37 (2.3%) stddev-sans-first:3.57 11:09:39 INFO - PROCESS | 5810 | Values: 146.0 145.0 145.0 145.0 145.0 156.0 146.0 146.0 147.0 145.0 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 11:09:39 INFO - PROCESS | 5810 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.07 (2.0%) stddev-sans-first:0.71 11:09:39 INFO - PROCESS | 5810 | Values: 55.0 53.0 52.0 53.0 53.0 52.0 53.0 52.0 51.0 52.0 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 11:09:39 INFO - PROCESS | 5810 | Values: 61.0 62.0 61.0 61.0 62.0 61.0 61.0 61.0 62.0 62.0 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.00 stddev:2.31 (3.1%) stddev-sans-first:2.44 11:09:39 INFO - PROCESS | 5810 | Values: 75.0 75.0 75.0 76.0 75.0 75.0 74.0 74.0 76.0 82.0 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:126.50 stddev:22.21 (17.6%) stddev-sans-first:23.48 11:09:39 INFO - PROCESS | 5810 | Values: 125.0 119.0 130.0 119.0 120.0 129.0 128.0 118.0 192.0 121.0 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:157.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 11:09:39 INFO - PROCESS | 5810 | Values: 156.0 156.0 156.0 157.0 159.0 155.0 159.0 157.0 157.0 157.0 11:09:39 INFO - PROCESS | 5810 | 11:09:39 INFO - PROCESS | 5810 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:63.50 stddev:2.77 (4.4%) stddev-sans-first:2.91 11:09:39 INFO - PROCESS | 5810 | Values: 65.0 63.0 64.0 62.0 61.0 67.0 70.0 62.0 63.0 62.0 11:09:39 INFO - PROCESS | 5810 | -------- Summary: end -------- 11:09:39 INFO - PROCESS | 5810 | 11:09:40 INFO - TEST-INFO | 5810: exit 0 11:09:40 INFO - TEST-OK | kraken | took 60884ms 11:09:40 INFO - SUITE-END | took 1174s 11:09:40 INFO - Completed test suite (00:19:34) 11:09:40 INFO - javascript benchmark 11:09:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3021.6978302169787, 3048.5274782408733, 3059.6634370219285, 3069.309405383789, 3090.582771325872, 5175.844724658266, 5216.478352164781, 5229.477052294768, 5293.947060529394, 5311.362636483617, 5294.629375943686, 5299.125644268701, 5332.413434522209, 5354.839354819362, 5384.111621582434, 4783.497732738056, 4826.61387089032, 4877.926831097537, 4886.828960986366, 5020.196768517038, 4918.385201849769, 4940.703557786526, 4968.70187788732, 4979.875503112415, 5000.349954505909, 4692.97653511732, 4727.78724957376, 4760.6429517785955, 4777.665563410563, 4852.344933433977, 4803.279508073782, 4822.276658501218, 4833.32333473314, 4885.487023862479, 4921.138800709861, 4822.397200349957, 4842.878928026792, 4847.248676455155, 4864.975675121602, 4890.095332363524, 5121.8463446096675, 5185.0, 5239.633225674204, 5246.737663116867, 5399.757010934478, 5611.8877622447735, 5629.240052592889, 5648.4633959773755, 5667.291588551431, 5671.914921276184, 5649.096144616841, 5727.627704199213, 5727.828165155052, 5732.398098199671, 5733.0, 5189.766460509286, 5253.658512196695, 5305.65513241638, 5305.681659100466, 5376.46235376467, 5804.854878628068, 5829.15477255804, 5859.44335288147, 5861.062230043172, 5862.032764593794, 5617.41017193197, 5657.066584013674, 5660.943390566124, 5663.235463212496, 5672.177534257509, 5516.531094856902, 5562.916556251659, 5602.943970560243, 5608.158776183605, 5667.064934285879, 5594.1888426177975, 5602.943970560324, 5603.887922241533, 5607.579431542651, 5609.943900561024, 5562.777488900399, 5604.299462567179, 5606.411326810708, 5612.663240205601, 5619.550435965113, 4178.01816573105, 4220.894477638022, 4287.528371879091, 4294.398784170218, 4314.180305741899, 3867.0719027433215, 3876.205377897524, 3884.1843212925037, 3911.02224443889, 3919.627635374635, 5363.410024897258, 5371.167469042305, 5379.112446446293, 5379.596530260246, 5420.02439560875, 5529.336479622471, 5569.470900264469, 5644.040513112698, 5647.040003199384, 5667.4615911488345, 5351.117065684119, 5359.946400535945, 5364.463553644682, 5369.087255166631, 5372.328458942632, 4883.560479556857, 4883.658143929962, 4894.779734911937, 4925.482824303396, 4938.703677779345, 5621.381648018714, 5784.652920824764, 5839.474447299678, 5863.560232982543, 5872.236609240771, 5682.488576028178, 5685.687287199244, 5686.857828554319, 5700.25896633435, 5734.197212390185, 5859.062549992152, 5866.266716660418, 5869.442402971711, 5876.3536011037895, 5879.676617786063, 5357.973210134081, 5443.945560544344, 5448.782048718165, 5534.363548192009, 5614.157876318585, 5567.805126820542, 5594.300712410949, 5604.551635869202, 5607.859803504945, 5611.831645050655, 5495.2856128703015, 5497.835064948058, 5498.092814685532, 5502.064649009598, 5505.064139096283, 5442.6462279951675, 5456.154296084113, 5461.262729531462, 5482.23248745168, 5489.533389661764, 5477.945220547903, 5494.835154945358, 5541.9168712470155, 5546.58400619947, 5550.250716153268, 5563.471470210324, 5570.415106413769, 5614.2701448811395, 5617.410171931889, 5624.437556244507, 5266.762995665281, 5326.041312563776, 5402.135658294654, 5458.590605704509, 5466.34403871538], "value": 5216.513268262585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.2643342954448, 616.6331033035344, 624.1199908129538, 631.5074242091165, 633.0946746152999, 31314.0, 42414.787926060366, 43336.56663433365, 43343.566564334345, 43473.130537389276, 46107.308390374084, 46441.30338044924, 46477.53522464774, 46525.302120468135, 46548.0, 8965.372423930312, 9164.495952722598, 9171.495567743772, 9172.908270917305, 9174.17432431081, 8954.507502087383, 9046.547672616343, 9047.140521650466, 9049.773755656095, 9050.32122590805, 9070.365074444791, 9110.407823491485, 9116.407433516833, 9119.863202051974, 9121.49831759253, 9024.954875225614, 9048.0, 9066.863997040049, 9073.364864459458, 9073.863892041625, 8929.107089291085, 8985.101489851028, 8985.46087234768, 8989.550522473915, 8990.910090899073, 43827.561724382664, 44208.0, 44319.335209971876, 44334.778326108484, 44366.77816610929, 3392.3215356928713, 3572.1962558424407, 3572.8034958077296, 3710.5361829771277, 3907.902302442433, 34287.14282142966, 34547.654523454694, 34804.12989675253, 35676.64323356759, 35800.0, 4474.194644963905, 4487.371767952489, 4494.235979883428, 4500.437445319335, 4536.72779633223, 381487.0, 381618.09190954146, 382104.0, 383807.0, 384163.0, 53592.46407535953, 59833.70083149557, 61805.69097154486, 62007.689961549906, 62251.68874155691, 58598.0, 64834.35165648378, 65009.67495162494, 65223.347766522675, 65236.0, 17378.304867805145, 17543.561410964572, 17545.0, 17551.473455796346, 17557.64884702299, 10697.197710171768, 12379.814302785466, 12948.870511294956, 13011.739765204642, 13099.869001309866, 17794.288228470974, 17801.643967120584, 18119.18463669138, 18527.629447410975, 18554.628907421775, 6529.0, 6533.934660653427, 6773.322667733286, 6865.794026179223, 6890.552114112566, 968.4286271100085, 1055.3245922609535, 1090.8472813806075, 1098.5825386353295, 1120.38938778366, 32521.0, 33148.834255828566, 33347.499787503206, 33485.49771753426, 33581.66418335834, 1095.085603521053, 1131.5926266544038, 1145.0839328537138, 1209.4738788626976, 1210.3827048205303, 16965.491035268962, 17187.0, 17270.22283997223, 17478.388256410966, 17530.824691753176, 522620.0, 525748.0, 526172.0, 527588.0, 527836.0, 58896.11655825166, 58897.41102589005, 58968.0, 59046.40953590409, 59058.704706476194, 1247.1270110922392, 1378.476179051974, 1386.8197134372467, 1387.2855479427901, 1400.3628349101134, 32216.19459513531, 34270.314593708485, 34328.0, 34558.65441345655, 34586.30827383488, 51632.74183629058, 52108.47891521036, 52153.217701735266, 52241.21638175355, 52243.73878130585, 419161.6586838892, 420436.0, 421216.62091963924, 421240.0, 422863.0, 27972.58041129344, 28039.71960280371, 28523.144305670863, 29729.85135074311, 43651.34522982221, 49264.0, 49308.2603760951, 49374.25938610852, 49402.75298623484, 49553.25670114879, 41989.0, 42083.7895810519, 42631.786841065594, 43053.56946430621, 44493.77753111214, 42854.35718464288, 43097.56902431061, 43352.56647433611, 44387.55612443834, 44446.333304999804, 42038.0, 42937.14125717531, 42977.0, 43236.567634323255, 43507.56492435035, 36124.4581331275, 37878.62121378861, 38115.85652430431, 38807.6119238804, 38938.80530597442, 28407.28981775472, 28836.279093022844, 28913.277168070967, 28990.42019159563, 29120.0], "value": 20643.96491124679, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.99476507852404, 362.5540585080351, 378.1340729728921, 381.6374444277936, 392.55249016121627, 14476.420943162275, 18594.53513662159, 18891.0, 19486.415407537777, 20777.480562985933, 18811.341603043897, 19008.239670413168, 19451.221951121937, 19613.0, 19650.115744791485, 5521.696306703129, 5725.885482290351, 5731.541476681877, 5731.856703582402, 5731.971340143315, 5521.199426083215, 5595.664260144384, 5615.157726341061, 5667.829965101033, 5668.404817494165, 5599.300087489064, 5604.766951270714, 5606.775728970836, 5616.213730077792, 5618.297712785902, 5456.890862182734, 5533.723313834292, 5540.058190107691, 5561.833145005657, 5600.383957764642, 4988.0, 4990.900181996376, 4993.076280888047, 4996.800127994876, 4999.4250661174065, 23378.0, 23472.64791028136, 23513.647295290586, 23687.881560592257, 23820.285391438283, 2430.4166999920067, 2453.9263822085186, 2478.8884500197532, 2546.274311821122, 2910.985445072782, 13994.370253338624, 14476.203808790513, 14818.629534261621, 14842.480513182094, 14880.330385132587, 1851.7129844873932, 1914.7606549181353, 1926.6628340040577, 1934.4003358958769, 2001.5596568754995, 72663.0, 75568.0, 76522.0, 86696.0, 88837.0, 10345.793084138426, 10550.47247637615, 10831.783364332668, 10946.0, 11110.777784444266, 14806.481773138104, 14828.481003164838, 14832.480863169738, 14837.92581037088, 14848.62878428048, 7677.577733224614, 7825.882611760828, 7905.367570594339, 7916.445848790645, 8178.959105204436, 7346.853062938711, 7672.884906726404, 7676.232376762391, 7895.249951254622, 7919.524828510308, 4511.436070491189, 4518.096380723869, 4564.748938808398, 4590.747508886977, 4632.4672662644225, 1800.1539276540268, 1861.8324350808493, 1895.4408449507152, 1903.8096190381127, 1908.4656296237076, 940.9341346105707, 955.9952200238954, 1002.871769259583, 1018.6434747838198, 1038.9740256493496, 18837.905810471133, 19390.903045484683, 19822.90088549548, 19894.104765285596, 19918.402447926586, 936.3164889630608, 972.9610815567439, 976.7362812040709, 1012.2205901455837, 1041.598984391015, 10560.155187584975, 10853.477555004332, 11068.501917413736, 11616.128790340757, 12060.396980150957, 514955.0, 519045.0, 542502.0, 545546.0, 553065.0, 76458.59363286544, 78029.0, 101717.0, 104963.4751826236, 107795.0, 967.8790151231096, 969.2197780786394, 1018.6383833739064, 1020.3418794877263, 1024.533837104116, 16893.239804209086, 16934.57663558421, 17595.824041759417, 17848.46454606364, 17908.820911790714, 42556.0, 42611.57388426076, 43214.78392608017, 43286.35070473883, 44738.3289250668, 60012.69993650004, 62346.0, 62807.37192628015, 63790.0, 64104.679476602316, 7857.803554911173, 7865.646045927832, 7928.960355198187, 8005.199480051948, 8117.715879944174, 6390.105385245976, 10538.315009524356, 11681.415929203336, 11838.171328006956, 12931.5473958411, 10631.734206644896, 10726.141908647445, 10952.45237738094, 11085.22403431752, 11088.944555277494, 5555.194496798023, 11659.125565582446, 11676.416179191176, 11914.761704765682, 12029.278243305429, 8301.501909885426, 8360.163983601591, 8401.831963360577, 8428.915710842813, 8797.780055498664, 11873.940630297138, 12551.937240314106, 12950.287734174712, 12951.676208094874, 13048.347582620641, 12391.62825115248, 12448.385838973554, 12520.31138287403, 12603.18079324841, 12971.5459958901], "value": 9203.418088933728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.9492517761878, 1507.1710559192443, 1620.5948512871782, 1729.688656041912, 1788.204249109146, 7555.244475552442, 7987.960060199705, 7994.680212791482, 8001.0, 8012.879806802903, 6956.791296261107, 7490.6254687265555, 7670.501417407864, 7679.923200768005, 7847.882281765778, 2287.4738810073695, 2308.5036717105904, 2316.073570571776, 2318.8840557972035, 2318.93043208704, 2270.7275126984787, 2287.7025986621716, 2311.2835021143414, 2315.3632750993443, 2316.3051084674617, 2007.9498012549657, 2230.4423894026495, 2286.874221917794, 2287.0280130944366, 2303.332033710222, 2278.8063014643776, 2295.4605667668084, 2299.678045073691, 2318.0611852199886, 2318.119114736398, 2285.394370491821, 2291.450051987528, 2292.289390289016, 2294.6443301288327, 2294.8623082615095, 7960.721374751914, 7976.960115199445, 8008.119106898294, 8012.879806802903, 8084.0, 4648.418947631546, 4796.616270698336, 4818.566329030404, 4827.468978412372, 4862.149123903303, 3146.7010633989735, 3203.359328134359, 3290.8190049547266, 3322.90031299059, 3340.448825943716, 1078.4823284823328, 1094.7263184203948, 1096.3641088168843, 1109.5617231193714, 1118.245184500459, 10367.792644147075, 10450.947745261301, 10564.524596393181, 10574.365538067663, 10576.312539684895, 4150.377443383456, 4247.5540068292385, 4376.277914144131, 4390.868273951786, 4428.867133985921, 9152.267818574632, 9158.771030724285, 9163.908360916439, 9167.49578773174, 9168.44989300644, 4769.14155452015, 4773.164696178155, 4773.546513081321, 4797.472278049412, 4799.112164249625, 4375.978120109379, 4427.889302767392, 4435.600795928317, 4455.576720211575, 4573.63410927125, 3708.369577171887, 3718.3121122592406, 3830.4678128748724, 3844.2695887781233, 3848.826802793881, 1100.9504572294265, 1191.642507247822, 1211.5275042733165, 1212.1878341511033, 1227.8096894981293, 866.7833041739565, 904.0462312260628, 914.1041779056562, 914.4787471141518, 949.487276870496, 5603.551715862721, 5639.2668953035845, 5642.915356269659, 5673.943260567424, 5882.470577647947, 959.7264779537799, 962.9566669499749, 963.9036096390305, 965.9178969787506, 1004.9397036177853, 3990.6607938324987, 4071.491063617048, 4076.0421300994244, 4120.938185927213, 4179.644730197967, 9382.95308523453, 9598.712038638712, 9728.854067188999, 9776.706698799047, 9826.164775993977, 9577.760555986157, 9604.279679024101, 9665.081817227352, 9680.080392362714, 9692.369995950241, 7404.074490688664, 7494.288042635941, 7511.549307041595, 7513.511621744569, 7540.321371076519, 5318.361796584435, 5361.169018802092, 5365.839024829262, 5556.194351819045, 5706.600537962303, 8622.180892815173, 8871.112888711077, 8895.644174232959, 8929.06244844308, 8956.507392093237, 8953.59708813118, 9080.772980675272, 9089.863652045093, 9195.160967806332, 9213.815723685355, 6957.79126626202, 7095.432365410651, 7227.38567221771, 7256.1655409628565, 7290.161631412456, 7633.5419874807685, 7908.4464087513325, 7913.3669306456495, 7914.881276780968, 7931.048274206902, 6864.553804002923, 6964.930350696631, 7081.6459177039915, 7138.892916606152, 7283.126024877049, 7020.684069217, 7021.192562855133, 7153.248908864494, 7194.100737407824, 7200.675969581486, 6300.275468321019, 6324.30432652417, 6382.936170638234, 6393.776217832354, 6411.551191416556, 4902.7058376497525, 4908.533689299511, 4965.726885021359, 5017.3226614406585, 5156.896862062813, 4921.50784921505, 4979.701217926936, 5064.41759197697, 5081.23781432788, 5114.232865070269], "value": 4347.3043591849155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.33411668437935, 320.5384246684774, 325.30547281553874, 325.87453830275336, 329.62422837964715, 5074.873128171797, 5183.393148124075, 5206.167013277876, 5241.86895327617, 5253.343332083489, 5146.305248791412, 5188.325517682696, 5194.0781910693, 5207.843764687056, 5219.791208351661, 4122.546519882811, 4133.607307305816, 4141.213169497801, 4142.0, 4153.813078411479, 3952.170044290688, 4050.9594904051023, 4133.42132101506, 4150.439690641755, 4161.167766446708, 4035.717499775002, 4044.4924147028883, 4046.0, 4046.5548789633262, 4052.777097259664, 4030.8186131624147, 4035.152617950205, 4036.3541833306676, 4047.6238079053114, 4080.5307389649975, 3580.6598373154507, 3591.7844929304065, 3606.9819650901577, 3608.332458495187, 3613.313470440608, 5123.615728820316, 5137.974310128463, 5154.149565321717, 5158.432572417031, 5173.482651734834, 4627.722336659811, 4631.397918270637, 4646.395968524071, 4653.139169253699, 4665.113628410625, 5420.945790542083, 5470.370907345627, 5473.534749546293, 5475.370332411784, 5497.422770609109, 3817.503724515795, 3882.903232254579, 3918.216356728637, 3923.431102490123, 3931.705122115824, 5618.775248990036, 5643.351014633328, 5652.293463317085, 5664.6034777566, 5667.886642267173, 3998.1803730235233, 4011.6590089842107, 4026.6376026157786, 4033.51597808259, 4037.9192416151513, 3975.6620687241907, 3976.8806935791395, 4014.2573623879675, 4031.5565287818317, 4085.836566537365, 4576.4737055239075, 4585.10590434862, 4597.402337696078, 4630.745309008037, 4645.256758918556, 5492.148716948879, 5505.697186654692, 5509.190312940349, 5521.503064724194, 5552.972235138879, 1324.9668758280927, 1347.1512946843623, 1373.4300265389752, 1386.230641993683, 1390.9930450347683, 936.1434287626881, 937.7093101138669, 957.698325027614, 959.2374062620233, 962.31675510387, 5306.151015837525, 5319.893602127936, 5325.535477743651, 5329.9467005330225, 5361.490658387447, 5603.7478313475995, 5626.099824028136, 5635.154726791015, 5638.351589567253, 5648.604597678205, 5191.636585439059, 5277.577793776489, 5292.518094933424, 5335.092374655822, 5354.9196762048605, 2658.189252278035, 2674.93312667181, 2686.570148776186, 2687.9462410751676, 2696.379832638504, 5094.949050509522, 5128.71762072274, 5137.691738495702, 5181.35233095863, 5209.244659524347, 4831.879203019882, 4954.22563364517, 4998.775055122528, 5020.096382651158, 5036.614930894033, 5115.590752739772, 5124.8206312778875, 5156.5616922562, 5182.6372153949615, 5204.412654140523, 4967.925481117858, 4979.800807967786, 5023.572996295356, 5060.924086138637, 5070.340855688737, 4757.666963312535, 4874.926876096933, 4935.728534930613, 4946.282788995503, 4970.824507413789, 5085.949140508696, 5132.46109158533, 5156.458571849902, 5161.793528258828, 5186.8962620746615, 3624.7100231981904, 3689.741718079709, 3694.833732481991, 3712.9232522568154, 3720.330340538729, 4733.715977041388, 4955.72743499111, 4967.677100988424, 5116.9744151279, 5353.491418315254, 5343.7060961647485, 5503.9174412383045, 5509.834704958857, 5512.614117011771, 5514.476124768141, 5439.156930675752, 5468.2891224142195, 5519.199716041232, 5521.613487055867, 5552.3892371839875, 5212.739363031909, 5406.162044883049, 5431.456854314537, 5461.617686761889, 5474.260974768515, 5519.75805443772, 5542.473465020817, 5555.611107222456, 5558.165805284166, 5568.49883510486, 5454.236406903116, 5461.180822876441, 5466.753996070107, 5471.480209380103, 5472.589555783253], "value": 4068.1668152896304, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.9200387957325, 743.4498471131365, 790.56518914597, 790.6837265093961, 792.5482474989259, 15373.385064597416, 16641.41755038574, 16658.58353541159, 16709.081000544982, 16709.91645041776, 15164.317605707742, 15232.23838808058, 15323.0, 15340.6931861363, 15368.231588420562, 650.5413683353224, 792.6987744657022, 799.940004499662, 812.46377390922, 816.8652172391548, 807.6769292283104, 809.8501777171213, 811.0632219786156, 811.2739098506833, 812.1391325195311, 853.2065179383171, 857.939944203906, 858.2704701004159, 858.5535521528801, 858.5792961448876, 680.1939701453794, 832.8126171611369, 842.3093063687778, 843.2916350265745, 854.0136142755097, 618.77724019353, 620.6927570852457, 621.0776996160698, 621.0994058614981, 621.1242148570494, 14630.122192668368, 14727.190004549746, 14732.48436304735, 14738.11571305725, 14751.18868462234, 14305.57083287503, 14310.284485775774, 14354.856451435457, 14527.491537796232, 14565.49020784278, 12803.679908002281, 12899.742005159844, 13012.544560940321, 13058.412371443213, 13133.934330328288, 4417.690761646686, 4438.05178057733, 4521.706089104197, 4531.977340113312, 4541.795619197144, 80493.59753201314, 80527.0, 80581.59709201417, 80786.19213807845, 80900.0, 11500.597479088192, 11594.88405115938, 11798.351090689923, 12138.211016283913, 12174.026077913746, 21915.452113696967, 21984.230551930606, 22177.778222217894, 22255.666165007537, 22414.215502457337, 8268.793280168044, 8368.539730314891, 8485.109063548362, 8533.104024077507, 8770.649174033095, 4719.5752382285755, 4724.574788269004, 4777.211760059551, 4835.105505481497, 4838.056578967138, 3320.169957510622, 3424.366492198951, 3430.1767575782133, 3430.7255419566377, 3434.793912365266, 568.1789813719219, 571.6855729348924, 572.4561666416921, 573.9971300143557, 588.3733823477983, 583.9678817664984, 707.1508006562801, 713.3793599568305, 737.6901701285473, 788.755485799404, 9262.44425334482, 9704.223662107015, 9822.0, 9985.80028399428, 10009.849852252222, 665.6871270502855, 740.4261697184725, 744.2148533297424, 760.9581473018926, 764.9349805266614, 4343.0, 4814.566688998007, 4850.345203397496, 5283.353157520126, 5532.280803495601, 70874.29125708676, 71622.0, 71735.64132179305, 109123.45438272758, 126318.0, 107159.46420268004, 109037.45481272542, 109757.45121274343, 109886.0, 113905.4304728471, 58159.70920145372, 85354.57322713347, 90971.53140543457, 94585.0, 98296.50851745695, 10292.897071029194, 10812.459377031275, 10869.67390978272, 10897.881078596496, 10974.0, 53832.461675384315, 53923.73038134784, 54475.182872256155, 54654.45345546653, 57088.0, 68428.0, 69160.0, 69831.65084174546, 76681.0, 83084.58457707673, 12423.31671758062, 12460.144693975813, 12569.685757856127, 12611.180273282207, 12683.0, 14437.494687685881, 14577.562673119823, 14726.1900595464, 14738.484153054591, 15265.923670381577, 14216.431342746175, 14667.119972801665, 14786.778198327249, 15162.469313573973, 15170.924145379644, 13145.868541314465, 13308.920009778665, 13608.455661773418, 14299.35652895643, 15311.0, 13943.233122178377, 14128.646783830487, 14247.430102796186, 14314.713705725619, 14540.85459145395, 11604.76790464169, 11790.764184716087, 11841.5855445059, 12024.579139730417, 12136.635900922987, 11868.881311186778, 12371.443285052374, 12419.689507762017, 12568.560100396442, 12619.0], "value": 7696.463299302344, "unit": "score"}], "name": "dromaeo_css", "value": 7161.6629853397835, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 112.0, 112.0, 112.0, 113.0, 113.0, 111.0, 113.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 121.0, 118.0, 184.0, 120.0, 117.0, 144.0, 122.0, 156.0, 122.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 161.0, 160.0, 161.0, 159.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 110.0, 77.0, 77.0, 76.0, 76.0, 102.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 117.0, 83.0, 84.0, 85.0, 116.0, 85.0, 84.0, 128.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 156.0, 146.0, 146.0, 147.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 53.0, 53.0, 52.0, 53.0, 52.0, 51.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 76.0, 75.0, 75.0, 74.0, 74.0, 76.0, 82.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 119.0, 130.0, 119.0, 120.0, 129.0, 128.0, 118.0, 192.0, 121.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 156.0, 156.0, 157.0, 159.0, 155.0, 159.0, 157.0, 157.0, 157.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 62.0, 61.0, 67.0, 70.0, 62.0, 63.0, 62.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1482.6000000000004, "alertThreshold": 2.0}]} 11:09:40 INFO - Return code: 0 11:09:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:09:40 INFO - # TBPL SUCCESS # 11:09:40 INFO - Running post-action listener: _resource_record_post_action 11:09:40 INFO - [mozharness: 2016-07-25 18:09:40.905174Z] Finished run-tests step (success) 11:09:40 INFO - Running post-run listener: _resource_record_post_run 11:09:40 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 557580288; Read time: 0; Write time: 432504 11:09:40 INFO - TinderboxPrint: CPU usage
13.0% 11:09:40 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:09:40 INFO - TinderboxPrint: I/O write bytes / time
557,580,288 / 432,504 11:09:40 INFO - TinderboxPrint: CPU idle
8,274.4 (87.0%) 11:09:40 INFO - TinderboxPrint: CPU user
1,192.4 (12.5%) 11:09:40 INFO - TinderboxPrint: Swap in / out
0 / 0 11:09:40 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 267468800; Read time: 0; Write time: 236748 11:09:41 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 289927168; Read time: 0; Write time: 195732 11:09:41 INFO - Running post-run listener: _upload_blobber_files 11:09:41 INFO - Blob upload gear active. 11:09:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:09:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:09:41 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:09:41 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:09:41 INFO - (blobuploader) - INFO - Open directory for files ... 11:09:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:09:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:09:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:09:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:09:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:09:54 INFO - (blobuploader) - INFO - Done attempting. 11:09:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:09:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:09:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:09:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:09:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:09:55 INFO - (blobuploader) - INFO - Done attempting. 11:09:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:09:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:09:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:09:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:09:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:09:56 INFO - (blobuploader) - INFO - Done attempting. 11:09:56 INFO - (blobuploader) - INFO - Iteration through files over. 11:09:56 INFO - Return code: 0 11:09:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:09:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:09:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6977ecab6adc6521b425719a296f5dc3f88ac0fe14ad0541e7ccf5a695227f51514fcc01496f9c6fa06427f22c5c94fae1dd81ad0c54141c2c55cf4b292c362d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69ea922a602ae4f9d3260d4e4ac94bd6e4a8e34f75aac989d7efa9a942ebd4f30eb70a699dce8da59e6870dabf9a8455cf4a62ed61f543669e1459e15fc3e868", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49c9682bf57f49494eafecab9cc55f91c7710b9b51169033e61b4984a47266f12c70d92acbd60a10946eab74fc99b16259b4b7182db738062e38ad2301b6c71a"} 11:09:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:09:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:09:56 INFO - Contents: 11:09:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6977ecab6adc6521b425719a296f5dc3f88ac0fe14ad0541e7ccf5a695227f51514fcc01496f9c6fa06427f22c5c94fae1dd81ad0c54141c2c55cf4b292c362d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69ea922a602ae4f9d3260d4e4ac94bd6e4a8e34f75aac989d7efa9a942ebd4f30eb70a699dce8da59e6870dabf9a8455cf4a62ed61f543669e1459e15fc3e868", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49c9682bf57f49494eafecab9cc55f91c7710b9b51169033e61b4984a47266f12c70d92acbd60a10946eab74fc99b16259b4b7182db738062e38ad2301b6c71a"} 11:09:56 INFO - Running post-run listener: copy_logs_to_upload_dir 11:09:56 INFO - Copying logs to upload dir... 11:09:56 INFO - mkdir: /builds/slave/test/build/upload/logs 11:09:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.501884 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-25 11:09:55.442433) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 11:09:55.445636) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6977ecab6adc6521b425719a296f5dc3f88ac0fe14ad0541e7ccf5a695227f51514fcc01496f9c6fa06427f22c5c94fae1dd81ad0c54141c2c55cf4b292c362d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69ea922a602ae4f9d3260d4e4ac94bd6e4a8e34f75aac989d7efa9a942ebd4f30eb70a699dce8da59e6870dabf9a8455cf4a62ed61f543669e1459e15fc3e868", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49c9682bf57f49494eafecab9cc55f91c7710b9b51169033e61b4984a47266f12c70d92acbd60a10946eab74fc99b16259b4b7182db738062e38ad2301b6c71a"} build_url:https://queue.taskcluster.net/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/R1mdbcGkT1CUB4JU4DNHsg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6977ecab6adc6521b425719a296f5dc3f88ac0fe14ad0541e7ccf5a695227f51514fcc01496f9c6fa06427f22c5c94fae1dd81ad0c54141c2c55cf4b292c362d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69ea922a602ae4f9d3260d4e4ac94bd6e4a8e34f75aac989d7efa9a942ebd4f30eb70a699dce8da59e6870dabf9a8455cf4a62ed61f543669e1459e15fc3e868", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49c9682bf57f49494eafecab9cc55f91c7710b9b51169033e61b4984a47266f12c70d92acbd60a10946eab74fc99b16259b4b7182db738062e38ad2301b6c71a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 11:09:55.470963) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 11:09:55.471358) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469468953.816204-1137220609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 11:09:55.555434) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 11:09:55.555788) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 11:09:55.556084) ========= ========= Total master_lag: 0.17 =========