builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1469931416.73 results: success (0) buildid: 20160730163003 builduid: aa2dfe8c516e4ddaa1893d519a697a9a revision: 0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 19:16:56.732905) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 19:16:56.733305) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 19:16:56.733661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 19:16:56.795394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:16:56.795751) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 19:16:57-- 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% 42.6M=0s 2016-07-30 19:16:57 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124937 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:16:56.945783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:16:56.946107) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018208 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:16:57.003333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 19:16:57.003703) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4 --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 0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4 --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=6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 19:16:57,966 truncating revision to first 12 chars 2016-07-30 19:16:57,966 Setting DEBUG logging. 2016-07-30 19:16:57,966 attempt 1/10 2016-07-30 19:16:57,966 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0e1f1a9c666d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 19:16:58,692 unpacking tar archive at: mozilla-inbound-0e1f1a9c666d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.164347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 19:16:58.181904) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 19:16:58.182228) ========= script_repo_revision: 0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 19:16:58.182673) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 19:16:58.182982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 19:16:58.196088) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-30 19:16:58.196412) ========= /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=6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:16:59 INFO - MultiFileLogger online at 20160730 19:16:59 in /builds/slave/test 19:16:59 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 19:16:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:16:59 INFO - {'append_to_log': False, 19:16:59 INFO - 'base_work_dir': '/builds/slave/test', 19:16:59 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:16:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:16:59 INFO - 'branch': 'Mozilla-Inbound', 19:16:59 INFO - 'buildbot_json_path': 'buildprops.json', 19:16:59 INFO - 'config_files': ('talos/linux_config.py',), 19:16:59 INFO - 'default_actions': ('clobber', 19:16:59 INFO - 'read-buildbot-config', 19:16:59 INFO - 'download-and-extract', 19:16:59 INFO - 'populate-webroot', 19:16:59 INFO - 'create-virtualenv', 19:16:59 INFO - 'install', 19:16:59 INFO - 'run-tests'), 19:16:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:16:59 INFO - 'download_minidump_stackwalk': True, 19:16:59 INFO - 'download_symbols': 'ondemand', 19:16:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:16:59 INFO - 'tooltool.py': '/tools/tooltool.py', 19:16:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:16:59 INFO - '/tools/misc-python/virtualenv.py')}, 19:16:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:16:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:16:59 INFO - 'installer_path': 'installer.exe', 19:16:59 INFO - 'log_level': 'info', 19:16:59 INFO - 'log_name': 'talos', 19:16:59 INFO - 'log_to_console': True, 19:16:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:16:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:16:59 INFO - 'opt_config_files': (), 19:16:59 INFO - 'pip_index': False, 19:16:59 INFO - 'sps_profile': False, 19:16:59 INFO - 'sps_profile_interval': 0, 19:16:59 INFO - 'suite': 'dromaeojs', 19:16:59 INFO - 'system_bits': '32', 19:16:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:16:59 INFO - 'title': 'talos-linux64-ix-023', 19:16:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:16:59 INFO - 'use_talos_json': True, 19:16:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:16:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:16:59 INFO - 'work_dir': 'build'} 19:16:59 INFO - [mozharness: 2016-07-31 02:16:59.252114Z] Running clobber step. 19:16:59 INFO - Running pre-action listener: _resource_record_pre_action 19:16:59 INFO - Running main action method: clobber 19:16:59 INFO - rmtree: /builds/slave/test/build 19:16:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:16:59 INFO - Running post-action listener: _resource_record_post_action 19:16:59 INFO - [mozharness: 2016-07-31 02:16:59.711732Z] Finished clobber step (success) 19:16:59 INFO - [mozharness: 2016-07-31 02:16:59.711833Z] Running read-buildbot-config step. 19:16:59 INFO - Running pre-action listener: _resource_record_pre_action 19:16:59 INFO - Running main action method: read_buildbot_config 19:16:59 INFO - Using buildbot properties: 19:16:59 INFO - { 19:16:59 INFO - "project": "", 19:16:59 INFO - "product": "firefox", 19:16:59 INFO - "script_repo_revision": "production", 19:16:59 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:16:59 INFO - "repository": "", 19:16:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:16:59 INFO - "buildid": "20160730163003", 19:16:59 INFO - "pgo_build": "True", 19:16:59 INFO - "basedir": "/builds/slave/test", 19:16:59 INFO - "buildnumber": 2166, 19:16:59 INFO - "slavename": "talos-linux64-ix-023", 19:16:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:16:59 INFO - "platform": "ubuntu64_hw", 19:16:59 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:16:59 INFO - "branch": "mozilla-inbound", 19:16:59 INFO - "repo_path": "integration/mozilla-inbound", 19:16:59 INFO - "revision": "0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4", 19:16:59 INFO - "stage_platform": "linux64-pgo", 19:16:59 INFO - "builduid": "aa2dfe8c516e4ddaa1893d519a697a9a", 19:16:59 INFO - "slavebuilddir": "test" 19:16:59 INFO - } 19:16:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:16:59 INFO - Running post-action listener: _resource_record_post_action 19:16:59 INFO - [mozharness: 2016-07-31 02:16:59.714272Z] Finished read-buildbot-config step (success) 19:16:59 INFO - [mozharness: 2016-07-31 02:16:59.714360Z] Running download-and-extract step. 19:16:59 INFO - Running pre-action listener: _resource_record_pre_action 19:16:59 INFO - Running main action method: download_and_extract 19:16:59 INFO - mkdir: /builds/slave/test/build/tests 19:16:59 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')]} 19:16:59 INFO - https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:16:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:16:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:16:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:17:14 INFO - Downloaded 1361 bytes. 19:17:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:17:14 INFO - Using the following test package requirements: 19:17:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:17:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:17:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:14 INFO - u'jsshell-linux-x86_64.zip'], 19:17:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:17:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:17:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:17:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:17:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:17:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:17:14 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')]} 19:17:14 INFO - https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:17:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:17:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:17:24 INFO - Downloaded 21803709 bytes. 19:17:24 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'] 19:17:24 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 19:17:26 INFO - Return code: 0 19:17:26 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 19:17:26 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')]} 19:17:26 INFO - https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:17:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:17:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:17:27 INFO - Downloaded 21803709 bytes. 19:17:27 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'] 19:17:27 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 19:17:28 INFO - Return code: 0 19:17:28 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')]} 19:17:28 INFO - https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:17:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:17:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:17:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:17:29 INFO - Downloaded 14413723 bytes. 19:17:29 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'] 19:17:29 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 19:17:29 INFO - Return code: 0 19:17: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')]} 19:17:29 INFO - https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:17:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:17:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:17:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:17:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:17:30 INFO - Downloaded 59367804 bytes. 19:17:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:17:30 INFO - mkdir: /builds/slave/test/properties 19:17:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:17:30 INFO - Writing to file /builds/slave/test/properties/build_url 19:17:30 INFO - Contents: 19:17:30 INFO - build_url:https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:17:31 INFO - Running post-action listener: _resource_record_post_action 19:17:31 INFO - Running post-action listener: set_extra_try_arguments 19:17:31 INFO - [mozharness: 2016-07-31 02:17:31.473147Z] Finished download-and-extract step (success) 19:17:31 INFO - [mozharness: 2016-07-31 02:17:31.473385Z] Running populate-webroot step. 19:17:31 INFO - Running pre-action listener: _resource_record_pre_action 19:17:31 INFO - Running main action method: populate_webroot 19:17:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:17:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:17:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:17:31 INFO - '--tppagecycles', 19:17:31 INFO - '7'], 19:17:31 INFO - 'tests': ['tsvgm']}}, 19:17:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:17:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:17:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:17:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:17:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:17:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:17:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:31 INFO - 'talos_options': ['--disable-e10s'], 19:17:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:31 INFO - 'talos_options': ['--disable-e10s'], 19:17:31 INFO - 'tests': ['damp', 'tps']}, 19:17:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:31 INFO - 'tests': ['damp', 'tps']}, 19:17:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:17:31 INFO - 'tests': ['dromaeo_dom']}, 19:17:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:17:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:17:31 INFO - 'tests': ['basic_compositor_video']}, 19:17:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:17:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:17:31 INFO - 'tests': ['a11yr', 19:17:31 INFO - 'ts_paint', 19:17:31 INFO - 'tpaint', 19:17:31 INFO - 'sessionrestore', 19:17:31 INFO - 'sessionrestore_no_auto_restore', 19:17:31 INFO - 'tabpaint']}, 19:17:31 INFO - 'other-e10s': {'tests': ['a11yr', 19:17:31 INFO - 'ts_paint', 19:17:31 INFO - 'tpaint', 19:17:31 INFO - 'sessionrestore', 19:17:31 INFO - 'sessionrestore_no_auto_restore', 19:17:31 INFO - 'tabpaint']}, 19:17:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:17:31 INFO - 'ts_paint', 19:17:31 INFO - 'tpaint', 19:17:31 INFO - 'sessionrestore', 19:17:31 INFO - 'sessionrestore_no_auto_restore', 19:17:31 INFO - 'tabpaint']}, 19:17:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:17:31 INFO - 'ts_paint', 19:17:31 INFO - 'tpaint', 19:17:31 INFO - 'sessionrestore', 19:17:31 INFO - 'sessionrestore_no_auto_restore', 19:17:31 INFO - 'tabpaint']}, 19:17:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:17:31 INFO - 'tests': ['a11yr', 19:17:31 INFO - 'ts_paint', 19:17:31 INFO - 'tpaint', 19:17:31 INFO - 'sessionrestore', 19:17:31 INFO - 'sessionrestore_no_auto_restore', 19:17:31 INFO - 'tabpaint']}, 19:17:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:17:31 INFO - 'tests': ['a11yr', 19:17:31 INFO - 'ts_paint', 19:17:31 INFO - 'tpaint', 19:17:31 INFO - 'sessionrestore', 19:17:31 INFO - 'sessionrestore_no_auto_restore', 19:17:31 INFO - 'tabpaint']}, 19:17:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:17:31 INFO - 'tests': ['tsvgx', 19:17:31 INFO - 'tsvgr_opacity', 19:17:31 INFO - 'tart', 19:17:31 INFO - 'tscrollx', 19:17:31 INFO - 'cart']}, 19:17:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:17:31 INFO - 'tsvgr_opacity', 19:17:31 INFO - 'tart', 19:17:31 INFO - 'tscrollx', 19:17:31 INFO - 'cart']}, 19:17:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:31 INFO - 'talos_options': ['--disable-e10s'], 19:17:31 INFO - 'tests': ['tp5o']}, 19:17:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:31 INFO - 'tests': ['tp5o']}, 19:17:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:31 INFO - 'talos_options': ['--disable-e10s', 19:17:31 INFO - '--xperf_path', 19:17:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:31 INFO - 'tests': ['tp5n']}, 19:17:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:31 INFO - 'talos_options': ['--xperf_path', 19:17:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:31 INFO - 'tests': ['tp5n']}}, 19:17:31 INFO - 'talos.zip': {'path': '', 19:17:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:17:31 INFO - Running post-action listener: _resource_record_post_action 19:17:31 INFO - [mozharness: 2016-07-31 02:17:31.494042Z] Finished populate-webroot step (success) 19:17:31 INFO - [mozharness: 2016-07-31 02:17:31.494130Z] Running create-virtualenv step. 19:17:31 INFO - Running pre-action listener: _resource_record_pre_action 19:17:31 INFO - Running main action method: create_virtualenv 19:17:31 INFO - Creating virtualenv /builds/slave/test/build/venv 19:17:31 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 19:17:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:17:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:17:31 INFO - Using real prefix '/usr' 19:17:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:17:32 INFO - Installing distribute.............................................................................................................................................................................................done. 19:17:34 INFO - Installing pip.................done. 19:17:34 INFO - Return code: 0 19:17:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:17: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')]} 19:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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')]} 19:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20283b0>, '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 0x20292b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2029740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', '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 19:17: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', 'pip>=1.5'] in /builds/slave/test/build 19:17: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 pip>=1.5 19:17:34 INFO - Using env: {'DISPLAY': ':0', 19:17:34 INFO - 'HOME': '/home/cltbld', 19:17:34 INFO - 'LANG': 'en_US.UTF-8', 19:17:34 INFO - 'LANGUAGE': 'en_US:en', 19:17:34 INFO - 'LOGNAME': 'cltbld', 19:17:34 INFO - 'MAIL': '/var/mail/cltbld', 19:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:34 INFO - 'MOZ_NO_REMOTE': '1', 19:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:34 INFO - 'NO_EM_RESTART': '1', 19:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:34 INFO - 'PWD': '/builds/slave/test', 19:17:34 INFO - 'SHELL': '/bin/bash', 19:17:34 INFO - 'SHLVL': '1', 19:17:34 INFO - 'TERM': 'linux', 19:17:34 INFO - 'TMOUT': '86400', 19:17:34 INFO - 'USER': 'cltbld', 19:17:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', 19:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:34 INFO - '_': '/tools/buildbot/bin/python'} 19:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:34 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 19:17:34 INFO - Cleaning up... 19:17:34 INFO - Return code: 0 19:17:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:17: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')]} 19:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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')]} 19:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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', '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 0x1d69030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20283b0>, '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 0x20292b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2029740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', '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 19:17: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:17: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 psutil>=3.1.1 19:17:34 INFO - Using env: {'DISPLAY': ':0', 19:17:34 INFO - 'HOME': '/home/cltbld', 19:17:34 INFO - 'LANG': 'en_US.UTF-8', 19:17:34 INFO - 'LANGUAGE': 'en_US:en', 19:17:34 INFO - 'LOGNAME': 'cltbld', 19:17:34 INFO - 'MAIL': '/var/mail/cltbld', 19:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:34 INFO - 'MOZ_NO_REMOTE': '1', 19:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:34 INFO - 'NO_EM_RESTART': '1', 19:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:34 INFO - 'PWD': '/builds/slave/test', 19:17:34 INFO - 'SHELL': '/bin/bash', 19:17:34 INFO - 'SHLVL': '1', 19:17:34 INFO - 'TERM': 'linux', 19:17:34 INFO - 'TMOUT': '86400', 19:17:34 INFO - 'USER': 'cltbld', 19:17:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', 19:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:34 INFO - '_': '/tools/buildbot/bin/python'} 19:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:34 INFO - Downloading/unpacking psutil>=3.1.1 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:17:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:36 INFO - Installing collected packages: psutil 19:17:36 INFO - Running setup.py install for psutil 19:17:36 INFO - building 'psutil._psutil_linux' extension 19:17:36 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 19:17:36 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 19:17:36 INFO - building 'psutil._psutil_posix' extension 19:17:36 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 19:17:36 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 19:17:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:36 INFO - Successfully installed psutil 19:17:36 INFO - Cleaning up... 19:17:37 INFO - Return code: 0 19:17:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:17: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')]} 19:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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')]} 19:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20283b0>, '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 0x20292b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2029740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', '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 19:17: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:17: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 mozsystemmonitor==0.3 19:17:37 INFO - Using env: {'DISPLAY': ':0', 19:17:37 INFO - 'HOME': '/home/cltbld', 19:17:37 INFO - 'LANG': 'en_US.UTF-8', 19:17:37 INFO - 'LANGUAGE': 'en_US:en', 19:17:37 INFO - 'LOGNAME': 'cltbld', 19:17:37 INFO - 'MAIL': '/var/mail/cltbld', 19:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:37 INFO - 'MOZ_NO_REMOTE': '1', 19:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:37 INFO - 'NO_EM_RESTART': '1', 19:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:37 INFO - 'PWD': '/builds/slave/test', 19:17:37 INFO - 'SHELL': '/bin/bash', 19:17:37 INFO - 'SHLVL': '1', 19:17:37 INFO - 'TERM': 'linux', 19:17:37 INFO - 'TMOUT': '86400', 19:17:37 INFO - 'USER': 'cltbld', 19:17:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', 19:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:37 INFO - '_': '/tools/buildbot/bin/python'} 19:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:17:39 INFO - Installing collected packages: mozsystemmonitor 19:17:39 INFO - Running setup.py install for mozsystemmonitor 19:17:39 INFO - Successfully installed mozsystemmonitor 19:17:39 INFO - Cleaning up... 19:17:39 INFO - Return code: 0 19:17:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:17:39 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')]} 19:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:39 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')]} 19:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:39 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 0x1d69030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20283b0>, '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 0x20292b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2029740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', '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 19:17:39 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 19:17:39 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 19:17:39 INFO - Using env: {'DISPLAY': ':0', 19:17:39 INFO - 'HOME': '/home/cltbld', 19:17:39 INFO - 'LANG': 'en_US.UTF-8', 19:17:39 INFO - 'LANGUAGE': 'en_US:en', 19:17:39 INFO - 'LOGNAME': 'cltbld', 19:17:39 INFO - 'MAIL': '/var/mail/cltbld', 19:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:39 INFO - 'MOZ_NO_REMOTE': '1', 19:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:39 INFO - 'NO_EM_RESTART': '1', 19:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:39 INFO - 'PWD': '/builds/slave/test', 19:17:39 INFO - 'SHELL': '/bin/bash', 19:17:39 INFO - 'SHLVL': '1', 19:17:39 INFO - 'TERM': 'linux', 19:17:39 INFO - 'TMOUT': '86400', 19:17:39 INFO - 'USER': 'cltbld', 19:17:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', 19:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:39 INFO - '_': '/tools/buildbot/bin/python'} 19:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:39 INFO - Downloading/unpacking jsonschema==2.5.1 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:17:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:17:41 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 19:17:41 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 19:17:41 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 19:17:41 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 19:17:41 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 19:17:41 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 19:17:41 INFO - Downloading functools32-3.2.3-2.tar.gz 19:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:17:41 INFO - warning: no files found matching '*.txt' 19:17:41 INFO - no previously-included directories found matching 'build' 19:17:41 INFO - no previously-included directories found matching 'dist' 19:17:41 INFO - no previously-included directories found matching '.git*' 19:17:41 INFO - Installing collected packages: jsonschema, functools32 19:17:41 INFO - Running setup.py install for functools32 19:17:41 INFO - warning: no files found matching '*.txt' 19:17:41 INFO - no previously-included directories found matching 'build' 19:17:41 INFO - no previously-included directories found matching 'dist' 19:17:41 INFO - no previously-included directories found matching '.git*' 19:17:41 INFO - Successfully installed jsonschema functools32 19:17:41 INFO - Cleaning up... 19:17:41 INFO - Return code: 0 19:17:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:17:41 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')]} 19:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:41 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')]} 19:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:41 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 0x1d69030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20283b0>, '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 0x20292b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2029740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', '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 19:17:41 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 19:17:41 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 19:17:41 INFO - Using env: {'DISPLAY': ':0', 19:17:41 INFO - 'HOME': '/home/cltbld', 19:17:41 INFO - 'LANG': 'en_US.UTF-8', 19:17:41 INFO - 'LANGUAGE': 'en_US:en', 19:17:41 INFO - 'LOGNAME': 'cltbld', 19:17:41 INFO - 'MAIL': '/var/mail/cltbld', 19:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:41 INFO - 'MOZ_NO_REMOTE': '1', 19:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:41 INFO - 'NO_EM_RESTART': '1', 19:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:41 INFO - 'PWD': '/builds/slave/test', 19:17:41 INFO - 'SHELL': '/bin/bash', 19:17:41 INFO - 'SHLVL': '1', 19:17:41 INFO - 'TERM': 'linux', 19:17:41 INFO - 'TMOUT': '86400', 19:17:41 INFO - 'USER': 'cltbld', 19:17:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', 19:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:41 INFO - '_': '/tools/buildbot/bin/python'} 19:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:17:42 INFO - Cleaning up... 19:17:42 INFO - Return code: 0 19:17:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:17:42 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')]} 19:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:42 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')]} 19:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:42 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 0x1d69030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20283b0>, '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 0x20292b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2029740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', '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 19:17:42 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 19:17:42 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 19:17:42 INFO - Using env: {'DISPLAY': ':0', 19:17:42 INFO - 'HOME': '/home/cltbld', 19:17:42 INFO - 'LANG': 'en_US.UTF-8', 19:17:42 INFO - 'LANGUAGE': 'en_US:en', 19:17:42 INFO - 'LOGNAME': 'cltbld', 19:17:42 INFO - 'MAIL': '/var/mail/cltbld', 19:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:42 INFO - 'MOZ_NO_REMOTE': '1', 19:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:42 INFO - 'NO_EM_RESTART': '1', 19:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:42 INFO - 'PWD': '/builds/slave/test', 19:17:42 INFO - 'SHELL': '/bin/bash', 19:17:42 INFO - 'SHLVL': '1', 19:17:42 INFO - 'TERM': 'linux', 19:17:42 INFO - 'TMOUT': '86400', 19:17:42 INFO - 'USER': 'cltbld', 19:17:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', 19:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:42 INFO - '_': '/tools/buildbot/bin/python'} 19:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:42 INFO - Downloading/unpacking blobuploader==1.2.4 19:17:42 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 19:17:42 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 19:17:42 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 19:17:42 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 19:17:42 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 19:17:42 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 19:17:44 INFO - Downloading blobuploader-1.2.4.tar.gz 19:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:17:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:17:44 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 19:17:44 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 19:17:44 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 19:17:44 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 19:17:44 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 19:17:44 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 19:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:17:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:17:44 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 19:17:44 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 19:17:44 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 19:17:44 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 19:17:44 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 19:17:44 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 19:17:44 INFO - Downloading docopt-0.6.1.tar.gz 19:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:17:44 INFO - Installing collected packages: blobuploader, requests, docopt 19:17:44 INFO - Running setup.py install for blobuploader 19:17:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:17:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:17:45 INFO - Running setup.py install for requests 19:17:45 INFO - Running setup.py install for docopt 19:17:45 INFO - Successfully installed blobuploader requests docopt 19:17:45 INFO - Cleaning up... 19:17:45 INFO - Return code: 0 19:17:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:17:45 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')]} 19:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:45 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')]} 19:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:45 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 0x1d69030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20283b0>, '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 0x20292b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2029740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', '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 19:17:45 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 19:17:45 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 19:17:45 INFO - Using env: {'DISPLAY': ':0', 19:17:45 INFO - 'HOME': '/home/cltbld', 19:17:45 INFO - 'LANG': 'en_US.UTF-8', 19:17:45 INFO - 'LANGUAGE': 'en_US:en', 19:17:45 INFO - 'LOGNAME': 'cltbld', 19:17:45 INFO - 'MAIL': '/var/mail/cltbld', 19:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:45 INFO - 'MOZ_NO_REMOTE': '1', 19:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:45 INFO - 'NO_EM_RESTART': '1', 19:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:45 INFO - 'PWD': '/builds/slave/test', 19:17:45 INFO - 'SHELL': '/bin/bash', 19:17:45 INFO - 'SHLVL': '1', 19:17:45 INFO - 'TERM': 'linux', 19:17:45 INFO - 'TMOUT': '86400', 19:17:45 INFO - 'USER': 'cltbld', 19:17:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', 19:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:45 INFO - '_': '/tools/buildbot/bin/python'} 19:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:17:45 INFO - Running setup.py (path:/tmp/pip-t9wIYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:17:45 INFO - Running setup.py (path:/tmp/pip-CEK7rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:17:45 INFO - Running setup.py (path:/tmp/pip-wpqm4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:17:45 INFO - Running setup.py (path:/tmp/pip-lkEQSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:17:46 INFO - Running setup.py (path:/tmp/pip-nimHct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:17:46 INFO - Running setup.py (path:/tmp/pip-ywL0gY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:17:46 INFO - Running setup.py (path:/tmp/pip-kuxRwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:17:46 INFO - Running setup.py (path:/tmp/pip-9C2ZFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:17:46 INFO - Running setup.py (path:/tmp/pip-CJokmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:17:46 INFO - Running setup.py (path:/tmp/pip-iwC1ZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:17:46 INFO - Running setup.py (path:/tmp/pip-38Ti8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:17:46 INFO - Running setup.py (path:/tmp/pip-cYR7qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:17:46 INFO - Running setup.py (path:/tmp/pip-Bs4bRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:17:46 INFO - Running setup.py (path:/tmp/pip-PGWCNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:46 INFO - Running setup.py (path:/tmp/pip-lbkq4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:17:46 INFO - Running setup.py (path:/tmp/pip-3QJXzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:17:46 INFO - Running setup.py (path:/tmp/pip-EQAxdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:17:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:17:46 INFO - Running setup.py install for manifestparser 19:17:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:17:47 INFO - Running setup.py install for mozcrash 19:17:47 INFO - Running setup.py install for mozdebug 19:17:47 INFO - Running setup.py install for mozdevice 19:17:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:17:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:17:47 INFO - Running setup.py install for mozfile 19:17:47 INFO - Running setup.py install for mozhttpd 19:17:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:17:47 INFO - Running setup.py install for mozinfo 19:17:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:17:47 INFO - Running setup.py install for mozInstall 19:17:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:17:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:17:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:17:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:17:47 INFO - Running setup.py install for mozleak 19:17:47 INFO - Running setup.py install for mozlog 19:17:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:17:48 INFO - Running setup.py install for moznetwork 19:17:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:17:48 INFO - Running setup.py install for mozprocess 19:17:48 INFO - Running setup.py install for mozprofile 19:17:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:17:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:17:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:17:48 INFO - Running setup.py install for mozrunner 19:17:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:17:48 INFO - Running setup.py install for mozscreenshot 19:17:48 INFO - Running setup.py install for moztest 19:17:48 INFO - Running setup.py install for mozversion 19:17:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:17:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:17:48 INFO - Cleaning up... 19:17:48 INFO - Return code: 0 19:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:17:48 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')]} 19:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:48 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')]} 19:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:48 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 0x1d69030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20283b0>, '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 0x20292b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2029740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', '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 19:17:48 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 19:17:48 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 19:17:48 INFO - Using env: {'DISPLAY': ':0', 19:17:48 INFO - 'HOME': '/home/cltbld', 19:17:48 INFO - 'LANG': 'en_US.UTF-8', 19:17:48 INFO - 'LANGUAGE': 'en_US:en', 19:17:48 INFO - 'LOGNAME': 'cltbld', 19:17:48 INFO - 'MAIL': '/var/mail/cltbld', 19:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:48 INFO - 'MOZ_NO_REMOTE': '1', 19:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:48 INFO - 'NO_EM_RESTART': '1', 19:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:48 INFO - 'PWD': '/builds/slave/test', 19:17:48 INFO - 'SHELL': '/bin/bash', 19:17:48 INFO - 'SHLVL': '1', 19:17:48 INFO - 'TERM': 'linux', 19:17:48 INFO - 'TMOUT': '86400', 19:17:48 INFO - 'USER': 'cltbld', 19:17:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', 19:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:48 INFO - '_': '/tools/buildbot/bin/python'} 19:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:17:49 INFO - Running setup.py (path:/tmp/pip-S5SpP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:17:49 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)) 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:17:49 INFO - Running setup.py (path:/tmp/pip-V5ylf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:17:49 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)) 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:17:49 INFO - Running setup.py (path:/tmp/pip-qwfcgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:17:49 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)) 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:17:49 INFO - Running setup.py (path:/tmp/pip-H0ZxVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:17:49 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)) 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:17:49 INFO - Running setup.py (path:/tmp/pip-MJfTny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:17:49 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)) 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:17:49 INFO - Running setup.py (path:/tmp/pip-n2qqVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:17:49 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)) 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:17:49 INFO - Running setup.py (path:/tmp/pip-u8BNJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:17:49 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)) 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:17:49 INFO - Running setup.py (path:/tmp/pip-PXRP8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:17:49 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)) 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:17:49 INFO - Running setup.py (path:/tmp/pip-3K0b3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:17:49 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)) 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:17:49 INFO - Running setup.py (path:/tmp/pip-x1vX7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:17:49 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)) 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:17:49 INFO - Running setup.py (path:/tmp/pip-jVfRr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:17:49 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)) 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:17:49 INFO - Running setup.py (path:/tmp/pip-4NKPAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:17:49 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)) 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:17:49 INFO - Running setup.py (path:/tmp/pip-xo9uBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:17:49 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)) 19:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:17:49 INFO - Running setup.py (path:/tmp/pip-8fIAni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:17:50 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)) 19:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:50 INFO - Running setup.py (path:/tmp/pip-AEOfL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:50 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)) 19:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:17:50 INFO - Running setup.py (path:/tmp/pip-acdCcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:17:50 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)) 19:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:17:50 INFO - Running setup.py (path:/tmp/pip-nXKnV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:17:50 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)) 19:17:50 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)) 19:17:50 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)) 19:17:50 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)) 19:17:50 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)) 19:17:50 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)) 19:17:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:50 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 19:17:50 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 19:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:52 INFO - Downloading blessings-1.6.tar.gz 19:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:17:52 INFO - Installing collected packages: blessings 19:17:52 INFO - Running setup.py install for blessings 19:17:52 INFO - Successfully installed blessings 19:17:52 INFO - Cleaning up... 19:17:52 INFO - Return code: 0 19:17:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:17:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:17:52 INFO - Reading from file tmpfile_stdout 19:17:52 INFO - Current package versions: 19:17:52 INFO - argparse == 1.2.1 19:17:52 INFO - blessings == 1.6 19:17:52 INFO - blobuploader == 1.2.4 19:17:52 INFO - docopt == 0.6.1 19:17:52 INFO - functools32 == 3.2.3-2 19:17:52 INFO - jsonschema == 2.5.1 19:17:52 INFO - manifestparser == 1.1 19:17:52 INFO - mozInstall == 1.12 19:17:52 INFO - mozcrash == 0.17 19:17:52 INFO - mozdebug == 0.1 19:17:52 INFO - mozdevice == 0.48 19:17:52 INFO - mozfile == 1.2 19:17:52 INFO - mozhttpd == 0.7 19:17:52 INFO - mozinfo == 0.9 19:17:52 INFO - mozleak == 0.1 19:17:52 INFO - mozlog == 3.3 19:17:52 INFO - moznetwork == 0.27 19:17:52 INFO - mozprocess == 0.23 19:17:52 INFO - mozprofile == 0.28 19:17:52 INFO - mozrunner == 6.12 19:17:52 INFO - mozscreenshot == 0.1 19:17:52 INFO - mozsystemmonitor == 0.3 19:17:52 INFO - moztest == 0.7 19:17:52 INFO - mozversion == 1.4 19:17:52 INFO - psutil == 3.1.1 19:17:52 INFO - requests == 1.2.3 19:17:52 INFO - wsgiref == 0.1.2 19:17:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:17:52 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')]} 19:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:52 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')]} 19:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:52 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 0x1d69030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20283b0>, '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 0x20292b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2029740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', '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 19:17:52 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 19:17:52 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 19:17:52 INFO - Using env: {'DISPLAY': ':0', 19:17:52 INFO - 'HOME': '/home/cltbld', 19:17:52 INFO - 'LANG': 'en_US.UTF-8', 19:17:52 INFO - 'LANGUAGE': 'en_US:en', 19:17:52 INFO - 'LOGNAME': 'cltbld', 19:17:52 INFO - 'MAIL': '/var/mail/cltbld', 19:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:52 INFO - 'MOZ_NO_REMOTE': '1', 19:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:52 INFO - 'NO_EM_RESTART': '1', 19:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:52 INFO - 'PWD': '/builds/slave/test', 19:17:52 INFO - 'SHELL': '/bin/bash', 19:17:52 INFO - 'SHLVL': '1', 19:17:52 INFO - 'TERM': 'linux', 19:17:52 INFO - 'TMOUT': '86400', 19:17:52 INFO - 'USER': 'cltbld', 19:17:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', 19:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:52 INFO - '_': '/tools/buildbot/bin/python'} 19:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:52 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)) 19:17:52 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)) 19:17:52 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)) 19:17:52 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)) 19:17:52 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)) 19:17:52 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)) 19:17:52 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)) 19:17:52 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)) 19:17:52 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)) 19:17:52 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)) 19:17:52 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)) 19:17:52 INFO - Cleaning up... 19:17:52 INFO - Return code: 0 19:17:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:17:52 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')]} 19:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:52 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')]} 19:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1d69030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20283b0>, '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 0x20292b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2029740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', '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 19:17:52 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 19:17:52 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 19:17:52 INFO - Using env: {'DISPLAY': ':0', 19:17:52 INFO - 'HOME': '/home/cltbld', 19:17:52 INFO - 'LANG': 'en_US.UTF-8', 19:17:52 INFO - 'LANGUAGE': 'en_US:en', 19:17:52 INFO - 'LOGNAME': 'cltbld', 19:17:52 INFO - 'MAIL': '/var/mail/cltbld', 19:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:52 INFO - 'MOZ_NO_REMOTE': '1', 19:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:52 INFO - 'NO_EM_RESTART': '1', 19:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:52 INFO - 'PWD': '/builds/slave/test', 19:17:52 INFO - 'SHELL': '/bin/bash', 19:17:52 INFO - 'SHLVL': '1', 19:17:52 INFO - 'TERM': 'linux', 19:17:52 INFO - 'TMOUT': '86400', 19:17:52 INFO - 'USER': 'cltbld', 19:17:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', 19:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:52 INFO - '_': '/tools/buildbot/bin/python'} 19:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:17:53 INFO - Cleaning up... 19:17:53 INFO - Return code: 0 19:17:53 INFO - Running post-action listener: _resource_record_post_action 19:17:53 INFO - Running post-action listener: _start_resource_monitoring 19:17:53 INFO - Starting resource monitoring. 19:17:53 INFO - [mozharness: 2016-07-31 02:17:53.066675Z] Finished create-virtualenv step (success) 19:17:53 INFO - [mozharness: 2016-07-31 02:17:53.067151Z] Running install step. 19:17:53 INFO - Running pre-action listener: _resource_record_pre_action 19:17:53 INFO - Running main action method: install 19:17:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:17:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:17:53 INFO - Reading from file tmpfile_stdout 19:17:53 INFO - Detecting whether we're running mozinstall >=1.0... 19:17:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:17:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:17:53 INFO - Reading from file tmpfile_stdout 19:17:53 INFO - Output received: 19:17:53 INFO - Usage: mozinstall [options] installer 19:17:53 INFO - Options: 19:17:53 INFO - -h, --help show this help message and exit 19:17:53 INFO - -d DEST, --destination=DEST 19:17:53 INFO - Directory to install application into. [default: 19:17:53 INFO - "/builds/slave/test"] 19:17:53 INFO - --app=APP Application being installed. [default: firefox] 19:17:53 INFO - mkdir: /builds/slave/test/build/application 19:17:53 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'] 19:17:53 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 19:18:10 INFO - Reading from file tmpfile_stdout 19:18:10 INFO - Output received: 19:18:10 INFO - /builds/slave/test/build/application/firefox/firefox 19:18:10 INFO - Running post-action listener: _resource_record_post_action 19:18:10 INFO - [mozharness: 2016-07-31 02:18:10.266949Z] Finished install step (success) 19:18:10 INFO - [mozharness: 2016-07-31 02:18:10.267227Z] Running run-tests step. 19:18:10 INFO - Running pre-action listener: _resource_record_pre_action 19:18:10 INFO - Running main action method: run_tests 19:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:18:10 INFO - Python 2.7.3 19:18:10 INFO - Return code: 0 19:18:10 INFO - grabbing minidump binary from tooltool 19:18:10 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')]} 19:18:10 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 0x20283b0>, '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 0x20292b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2029740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:18:10 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 19:18:10 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 19:18:10 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 19:18:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:18:10 INFO - Return code: 0 19:18:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:18:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:18:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:18:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:18:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:18:10 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/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 19:18:10 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/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 19:18:10 INFO - Using env: {'DISPLAY': ':0', 19:18:10 INFO - 'HOME': '/home/cltbld', 19:18:10 INFO - 'LANG': 'en_US.UTF-8', 19:18:10 INFO - 'LANGUAGE': 'en_US:en', 19:18:10 INFO - 'LOGNAME': 'cltbld', 19:18:10 INFO - 'MAIL': '/var/mail/cltbld', 19:18:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:18:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:10 INFO - 'MOZ_NO_REMOTE': '1', 19:18:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:10 INFO - 'NO_EM_RESTART': '1', 19:18:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:10 INFO - 'PWD': '/builds/slave/test', 19:18:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:18:10 INFO - 'SHELL': '/bin/bash', 19:18:10 INFO - 'SHLVL': '1', 19:18:10 INFO - 'TERM': 'linux', 19:18:10 INFO - 'TMOUT': '86400', 19:18:10 INFO - 'USER': 'cltbld', 19:18:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338', 19:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:10 INFO - '_': '/tools/buildbot/bin/python'} 19:18:10 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/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 19:18:10 INFO - mozversion application_buildid: 20160730163003 19:18:10 INFO - mozversion application_changeset: 0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4 19:18:10 INFO - mozversion application_display_name: Nightly 19:18:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:18:10 INFO - mozversion application_name: Firefox 19:18:10 INFO - mozversion application_remotingname: firefox 19:18:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:18:10 INFO - mozversion application_vendor: Mozilla 19:18:10 INFO - mozversion application_version: 50.0a1 19:18:10 INFO - mozversion platform_buildid: 20160730163003 19:18:10 INFO - mozversion platform_changeset: 0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4 19:18:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:18:10 INFO - mozversion platform_version: 50.0a1 19:18:10 INFO - using testdate: 1469931490 19:18:10 INFO - actual date: 1469931490 19:18:10 INFO - starting webserver on 'localhost:41700' 19:18:10 INFO - SUITE-START | Running 2 tests 19:18:10 INFO - TEST-START | dromaeo_css 19:18:10 INFO - operating with platform_type : linux_ 19:18:10 INFO - Initialising browser for dromaeo_css test... 19:18:10 INFO - TEST-INFO | started process 27701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnNM9el/profile http://localhost:41700/getInfo.html) 19:18:14 INFO - PROCESS | 27701 | __metrics Screen width/height:1600/1200 19:18:14 INFO - PROCESS | 27701 | colorDepth:24 19:18:14 INFO - PROCESS | 27701 | Browser inner width/height: 1024/697 19:18:14 INFO - PROCESS | 27701 | __metrics 19:18:15 INFO - PROCESS | 27701 | 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" 19:18:15 INFO - PROCESS | 27701 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:18:16 INFO - TEST-INFO | 27701: exit 0 19:18:16 INFO - Browser initialized. 19:18:16 INFO - Running cycle 1/1 for dromaeo_css test... 19:18:16 INFO - TEST-INFO | started process 27779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnNM9el/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:27 INFO - PROCESS | 27779 | RSS: Main: 155803648 19:18:27 INFO - PROCESS | 27779 | 19:19:18 INFO - PROCESS | 27779 | 1469931558644 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] 19:21:27 INFO - PROCESS | 27779 | Cycle 1(1): loaded http://localhost:41700/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41700/tests/dromaeo/cssquery-ext.html) 19:21:28 INFO - PROCESS | 27779 | RSS: Main: 254926848 19:21:28 INFO - PROCESS | 27779 | 19:24:31 INFO - PROCESS | 27779 | Cycle 1(1): loaded http://localhost:41700/tests/dromaeo/cssquery-ext.html (next: http://localhost:41700/tests/dromaeo/cssquery-jquery.html) 19:24:31 INFO - PROCESS | 27779 | RSS: Main: 246992896 19:24:31 INFO - PROCESS | 27779 | 19:27:33 INFO - PROCESS | 27779 | Cycle 1(1): loaded http://localhost:41700/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41700/tests/dromaeo/cssquery-mootools.html) 19:27:34 INFO - PROCESS | 27779 | RSS: Main: 218025984 19:27:34 INFO - PROCESS | 27779 | 19:30:36 INFO - PROCESS | 27779 | Cycle 1(1): loaded http://localhost:41700/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41700/tests/dromaeo/cssquery-prototype.html) 19:30:37 INFO - PROCESS | 27779 | RSS: Main: 223502336 19:30:37 INFO - PROCESS | 27779 | 19:33:39 INFO - PROCESS | 27779 | Cycle 1(1): loaded http://localhost:41700/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41700/tests/dromaeo/cssquery-yui.html) 19:33:40 INFO - PROCESS | 27779 | RSS: Main: 190984192 19:33:40 INFO - PROCESS | 27779 | 19:36:42 INFO - PROCESS | 27779 | Cycle 1(1): loaded http://localhost:41700/tests/dromaeo/cssquery-yui.html (next: http://localhost:41700/tests/dromaeo/cssquery-dojo.html) 19:36:43 INFO - PROCESS | 27779 | RSS: Main: 284749824 19:36:43 INFO - PROCESS | 27779 | 19:36:43 INFO - PROCESS | 27779 | __start_tp_report 19:36:43 INFO - PROCESS | 27779 | _x_x_mozilla_page_load 19:36:43 INFO - PROCESS | 27779 | _x_x_mozilla_page_load_details 19:36:43 INFO - PROCESS | 27779 | |i|pagename|runs| 19:36:43 INFO - PROCESS | 27779 | |0;dojo.html;3043.0566524377437;3056.25121845148;3078.599782028337;3090.4282707699062;3097.0863595239402;5225.503577160173;5242.606804489669;5272.8154514592;5357.2232026356205;5370.758315875781;5231.110711179099;5234.136367499367;5289.973550132244;5325.227841962913;5336.279602253695;4765.380500534926;4820.180569303227;4828.106800241949;4829.22732362822;5046.09170349337;4930.98914722481;4970.6520543561965;4993.525615066581;5010.073136469747;5011.2483127530795;4741.8103275868925;4774.9522504775205;4785.377900872864;4838.274258861164;4914.533119353656;4790.640701947333;4799.616030717534;4808.110499557593;4914.950850491485;4925.827596034157;4778.761061946889;4805.3753012108555;4820.301056346845;4826.034793041371;4861.975690121562;5143.588512918957;5212.869678258036;5315.335583052119;5362.4637536246455;5374.086405311106;5581.720913954286;5669.688167150805;5675.120356344732;5682.261306030231;5683.147527870811;5639;5659.801906933238;5680.091185410356;5708.20085188074;5713.8285851424525;5124.256982737519;5246.527812496817;5262.657927234717;5284.128118860422;5297.549708274802;5886.381929897299;5893;5907.675077870758;5917.5857689961285;5918.378570250062;5652.7173641318595;5657.971710141423;5660.405657405995;5667.773289068474;5669.489745922887;5521.337439507285;5622.578306626938;5682.801101961494;5712.885742285131;5718.971405142947;5698;5749.712514374264;5754.280714910637;5759;5759.51044161251;5636.351819540723;5692.345380281238;5694.715264236772;5703.600747947687;5713.085906254979;4306.655467562588;4361.062371590124;4395.1429471252795;4408.801603927767;4447.199504089231;3861.555921069113;3882.6311500407414;3896.1428485733095;3930.6462418382484;4009.077912080238;5440.483154100354;5443.074677304868;5445.863853403696;5450.400455949843;5456.236126942231;5752.108423194411;5755.309362876398;5759.164921086419;5765.740541675635;5799.681017544076;5164.14791559396;5373.167159090347;5418.945810541844;5420.105682562412;5475.233467314579;4975.676581022222;4981.750912454363;4984.40187177541;4989.326440930428;5022.447530771612;5918.6704349596685;5959.28488581373;5961.850953726192;5974.551908606785;6024;5608.130739735348;5636.830895073154;5668.574856885833;5673.517750991212;5726.398728133652;5936.554758393224;5937.168796368598;5942.7920022799;5946.940530594638;5991.520678345809;5542.418046105101;5603.691796951207;5604.439556044526;5609.130584759206;5615.410381910004;5618.073017951992;5682.943170568242;5691;5702.6863522506665;5714.771409143587;5624.128260119688;5627.043402621646;5641.323041235078;5642.294713160855;5643;5528.668279903219;5599.608027438203;5602.439756024365;5604.2154098425435;5608.747606357642;5410.810621628224;5500.312460942382;5523.696196709219;5535.557155427637;5546.223528705904;5658.519025882846;5669.206311116364;5713.8285851424525;5718.714064296852;5720.2849643794525;5488.945110549003;5538.750756215899;5544.362398324244;5544.861378465571;5552.278203833475 19:36:43 INFO - PROCESS | 27779 | |1;ext.html;578.5718568259488;590.3977942498652;594.1236675903043;595.821253623913;598.2103623217355;32485.187870303223;42849.78575107124;44752.3287150693;44756.10487790242;48119.27821082678;45412;45737;45804.770976145155;45823.77088114563;45891.77054114725;8825.867611985825;9006.86489702655;9008.774780630503;9011.594478248495;9018.413803102778;8778.078301778318;8875.06811784763;8876.778080547974;8878.156575125386;8878.73363799087;8923.509206993645;8955.238804701608;8962.820743585124;8962.955185224097;8965.417247878868;8859.06979767128;8880.978687450961;8922.73231803047;8927.062658420902;8927.151920567536;8807.515586642732;8862.423942443786;8862.689805856828;8864.512451815148;8878.600462979182;41950.37074443886;42307;42312.57687423117;42345.57654423478;42372.78813605912;3511.0344655219765;3527.3474407234744;3613.8012409317475;3623.691986181178;3665.7433979621437;32360.249378802593;32592;32669.346613067843;33938.830305848314;36356.454653180226;4515.841945531924;4612.884677883047;4688.5077066907825;4697.647676424248;4697.976510117462;324860;329805;329894.9999999976;329925;330231;54110.18834717482;61198.694006530575;62635;62704.68647656824;66548.33451665519;68379.31620683729;68385.65807171032;68819.65590172017;68838;68998;16012.759808602881;16019.759703604455;16020.19899005045;16030.358785648443;16101.436449724204;11542.07663386927;11576.24754390962;11580.247283926517;11622.418879056013;11739.647810565697;17724.202410891285;19481.16538847937;20022.59954800896;20989.68515472269;21156.682649760267;7493.925060749323;7612.581308028;7623;7635.961820190863;7660.80847978805;1030.5311083457009;1038.1694644284541;1076.311160857052;1152.5793085523724;1166.6033548593518;32942;33105.02054815078;33198.83400582981;33281.500777487876;33913.83043084769;1080.9946749522862;1141.4178768827958;1142.2580564638993;1166.719987203065;1221.2062159596155;17303.91348043252;17352.739708904377;17385.56536086608;17502.649947000988;17535.831976813508;526969;531476;535561;536487;536609;59492.40507594955;59632.40367596268;60053.69973150106;60468;60767;1191.582945968904;1285.2866659004342;1326.1843965961057;1336.1982810313928;1371.2252577293996;31995;33435.83282083574;33585.32829343448;33588.66411335953;34064.65935340615;50850.49149508458;51422;51435;51495;51538.74230628823;412598;414659;414875;417024;417738;44269.55730442654;44606;46179.53820461752;46212.306815397125;46247;47643.285350719074;48564.75717621531;48809.75595122002;48812.75593622009;48951.510484894694;41023.179536408505;41679.58320416757;41977.58022419859;42320.788396057826;43454.34818477662;41196.79401602973;41417.58582414258;41753;42260;42440;41370;41628.79185604174;42160.57839421689;42505.57494425016;42635.57364426316;33758.662413376536;37219;37556.81221593874;37624.247515049;38495.80752096222;28045.190071757464;28198.577021345107;28217.294567635974;28281.858590706914;28283.151505454047 19:36:43 INFO - PROCESS | 27779 | |2;jquery.html;362.8312834531942;382.3423711216708;395.45822223553733;401.570319757859;415.56988516885013;16282.023078615292;19072.42782716519;19138;19217.32739354123;19856.305029323976;19239;19439.514012149702;19676.80323196771;19725.901370493128;19820.306289279877;5567.832965011056;5581.6371935824045;5771;5776.451237132465;6438.098666186737;6412.326705695905;6474.643894585796;6488.610683359014;6497.772577959772;6511.57674751142;6263.467605253559;6269.216347956505;6379.515680825733;6382.648954307511;6390.329015453381;6190.133381326618;6343.777967771129;6343.904841427382;6346.777862774804;6376.234851817811;5662.348829884575;5665.036943719537;5665.66006039639;5669.6314739541795;5683.175939488792;23444.88277558601;23647.527049459088;23737.16919907795;24217.878910605512;24396.63405048908;2136.5086030212983;2226.2096955580696;2235.910563577455;2388.044782087179;2393.8563686178886;10292.485375731183;10378;10475.895241047569;10633.096186824128;10849;1842.9078546072642;1886.9811301886944;1887.5564242403025;1975.8221760041522;2030.0966070098812;60710.696446517926;81804;84342.57828710879;85153.57423212906;87050.5647471765;10707.14542764604;10861.619843305605;10957.287776294515;11013.229073964745;11126.828853776635;15401.922990384975;15417.691646167013;15424.383024679111;15426;15430.074195548303;7594.8101297468;7794;7914.762557123296;7988.960055199686;8012.1186669466315;7480.663370148356;7559.924400756032;7717.922820771832;7726.690932362642;7740.6129693515095;4629.699069560468;4716.1510928033285;4769.046190761862;4769.284607308931;4866.829660961849;1870.046276399019;1944.3777991043014;1965.2335589120255;1967.950801229952;1988.7812340642517;902.7697937026016;979.2704435195682;985.4136788610765;996.2627655534852;1006.8892421833592;18963;19425.611487770166;19647.901760491393;19708.802911970695;19939.800601994084;912.8950170730451;930.8976012638605;937.4047479850344;977.6953895832042;978.0659470205936;6650.9667451662435;6657.600543967377;7000.824979375557;10083.288059054234;10873.238873278795;282101;284302;400254;509194;513718;56580.71709641426;96275;96733.5163324193;98157.50921245491;98965.50517247367;447.91265703187565;464.79781295136723;466.86927660255185;467.22907203114454;468.22976204144675;11680.649580512598;11787.469563869818;11842.585509507126;11866.466009029788;11898.405079746151;40892.59107408888;41640.96236890851;42720.57279427166;43122;43456.34815477707;59833.40166598278;60038.699806500685;61375.69312153589;62244.68877655583;62412.37587624066;5697.401772813795;8109.351251899951;8235.34117270605;8360.958195208985;8474.576271186539;11322.547098116313;12707.428165732379;12903.354832258537;13301.933490332487;13306.401211945293;11341.432928353714;11363.54545818158;11677.124215683687;11719.531218751154;11860.22908510944;10979.231453798477;11243.943780281046;11298;11353.318800871974;11449.198556100993;11331.32012079278;11333.829992549954;11420.257683250895;11437.313761174357;11881.940590296994;8193.098759136372;8392.538410387488;11228.88771112311;11811.586594469152;11944.116882857272;11615.419229038684;11817.704557386134;12209.633710988684;12291.323977180984;12312.692182695504 19:36:43 INFO - PROCESS | 27779 | |3;mootools.html;1330.700592366717;1405.2201028429217;1487.5686051045197;1532.8160620725507;1761.1810508113724;8491.448055876364;8824.11758824118;8842.469451832878;9158.450492970409;9168.679096231634;8860.77848053799;8962.193402593764;8975.057618950013;8975.820483590323;8982.640694372218;2347.8943447544816;2373.1575290771784;2373.371056669984;2375.10933399975;2376.9168079117235;2330.9883450582724;2364.0425627620757;2413.963790543143;2419.5765740995344;2421.8546887186826;2313.9652905206435;2314.36355002374;2343.8242131840093;2347.94130146746;2351.5532048910736;2308.538292341522;2326.76732326766;2327.60430726776;2348.1429278313462;2350.4476448034698;2288.164819840763;2291.346966114666;2296.1619009061737;2297.5404919016096;2306.215886598548;8966.327525435618;8967.327450441178;8991.14584114508;9054.185123338866;9067.183953444222;5198.142306519419;5363.570914326844;5382.300300960889;5384.057789886754;5400.351957765093;3433.2790114076074;3458.9308213835584;3487.633798451177;3517.7889326640484;3518.736094792875;1093.1309608860895;1100.301308669001;1101.2841652925583;1111.6053800900645;1127.3743072594707;11593.362365069917;11633.185677002613;11686.649400517997;11701.53193872244;11706;4273.380359847804;4401.625861801719;4542.136993971201;4556.794944227518;4558.247889098262;9959.651412200537;9960.750981225383;9962.452065136487;9963.252756043326;9971.650992215238;5212.530872221519;5215.7913683453;5217.217417387346;5220.086484865134;5225.921611175835;4038.7980600970423;4609.377734005866;4767.165745994437;4798.184308667535;4823.638227132979;3810.256999884996;3852.287326844543;3917.7257591968287;3950.7036972227197;3965.167314863911;1110.3116068037868;1137.374444055766;1157.5196293538256;1164.470166074434;1167.5271515036425;946.914777670013;970.815545046439;971.820213260549;974.7270764186039;995.2380003586454;5769.451902069297;5908.704564771744;5945.256842894638;6003.429674180946;6004.1294012368835;449.72117287282094;450.73631925324054;451.87799294190387;452.1747810246314;454.9408576884984;3839.3281175794123;3857.9776359264815;3860.1121741999495;3954.4463775071513;4023.4970628671417;10792.892071079346;11068.059214966657;11353.772924541463;11385.487653055632;11394.77801828652;11033.172512061466;11321.377324247245;11327.943360283145;11335.14986376025;11370.31778093317;8024.638891249908;8286.46138001028;8324.750257492406;8373.8325233495;8389.32885369169;5936.762529498945;5947.791827286024;5996.5502587305255;6011.188489553854;6066.939330606814;9886.752831179278;9998.950005249928;10184.898151018395;10245.385276883411;10327.070563649007;10540.84188737185;10626.574937002433;10627.149828013586;10646.8402973957;10683.412412317397;6873.690683919136;7364.0426744522865;7517.097948246245;7531.435142364454;7543.924560754323;8572.785680358042;8701.95649021776;8708.60811263482;8719;8723.476591404537;7470.327670509463;7572.242775722384;7601.809954751176;7953.8409231813885;7956.801079973047;7554.584497852451;7582.962085189539;7608.0489938757655;7768.106667733283;7929.643166057426;6761.256261811295;6858.382745552724;6869.347411995853;6874.690638921161;6876.346747059021;4884.5603895649565;4939.777710002986;4997.400311962442;5002.749862506933;5019.824306149268;4914.336564563738;4957.801687932587;5055.469175736494;5095.031943930641;5166.741662916764 19:36:43 INFO - PROCESS | 27779 | |4;prototype.html;309.648548897002;317.8204314562272;326.30008631485464;326.6097014068188;327.0809026635157;5227.666944929042;5277.973610131949;5299.999999999995;5314.229436731681;5316.6544174628625;4902.43621983472;5050.343455350809;5073.086844368012;5073.188289873621;5200.557952574026;3952.940705889414;4056.127932494513;4066.227416790815;4118.794060296988;4122.587741225883;4102.835886564549;4118;4118.97940510297;4129.29801933672;4139.296319625656;3977.9801100994455;4059.9594004059877;4070.1656160487178;4082.4692789937417;4088.6524645405175;4087.509498860156;4088.6115818997146;4090.6318431341174;4095.136712795671;4128.69034822388;3630.16506203572;3635.4001589737663;3648.343298206322;3649.7810131392202;3669.972407725841;5071.797128114871;5149.691018538862;5192.546087095619;5204.193350030751;5205.241222152265;4651.976740116312;4662.860114196579;4703.2239680452685;4708.976455117737;4718.528147185289;5387.542058924996;5397.865053373697;5421.72589441481;5426.8914621707345;5460.31746031746;3815.8855234343014;3933.8819835404984;3947.664448521879;3948.072203032285;3976.840926362942;5613.494785469327;5649.813539156782;5657.547396208252;5662.858428539278;5700.144978253254;4037.7779222143063;4071.185762847442;4074.796260187038;4077.510698716114;4090.9386359204636;4101.52832424275;4117.2588933992165;4120.526139493936;4132.628063474242;4149.7095203335475;4473.843415480443;4596.4254468191475;4603.102395033004;4606.631469482433;4612.86161415158;5448.700321482356;5454.645448045943;5458.4814442627885;5463.863403414867;5501.174823776386;1364.5838019404177;1400.3208443904698;1425.2944792327864;1427.600271923863;1433.269032793283;947.8199142162968;976.1800087926034;977.3256453047375;992.1318846009741;994.5922171909482;5292.629515933924;5358.758855851496;5360.061989151883;5361.1422172453;5383.542398896059;5500.889982200333;5559.360673522516;5565.721713914288;5626.718664066781;5634.605577609528;5246.4753524647995;5253.44838791929;5294.49702278283;5301.390340110859;5320.733963301819;2970.2722832905642;2975.7916945814018;2984.686607906182;2996.022625067445;3012.894548690785;5641.379448260688;5802.767889284381;5812.738426770806;5884.735186916599;5911.76352945886;5721.942780572224;5724.255846739898;5727.11229759388;5728.112142617901;5742.13867919807;5845.7369418376275;5896.380880007623;5897.292324921037;5905.40945905406;5905.907407129695;5434.755436005468;5637.8590535236945;5654.886902261849;5672.659640421588;5695.401982791913;5561.777528898961;5579.832605021856;5579.832605021856;5592.720363981866;5668.149777533403;5770.740316685843;5871.266091738533;5913.763449461973;5989.161517387656;6022.397760223943;4045.797710114424;4054.878353649395;4082.183563287295;4113.650339721157;4116.271166110181;5747.7929634777165;5760.366359700513;5774.220480235283;5780.335261444988;5784.537237021113;5516.393196748274;5606.729274643776;5637.351704554028;5640.943590564042;5644.266245388073;5532.944670553404;5533.889322213614;5539.833804985696;5546.306711661043;5546.473085056913;5261.842144735664;5408.701301946736;5412.215228791882;5485.0949593318255;5576.414476479911;5346.144616861284;5444.373897001896;5553;5557.499825015768;5559.33288005442;5449;5471.316085489314;5474.425185355481;5502.339719233558;5521.751521181476 19:36:43 INFO - PROCESS | 27779 | |5;yui.html;689.2762599270765;768.427521496485;772.3898120484818;848.1264297773296;851.4461108477029;15239.619009524753;16468.752968705478;16475.17624118792;16476.505704828873;16481.340746370144;15029.473968411108;15261.847381526182;15266.236688165574;15268.465603703873;15303.387864485436;662.2351184382046;792.6631181747763;810.4084018666377;818.8198596308803;824.1593574553951;819.983600327993;829.274384913201;831.2934006094831;831.8336332733447;831.9292860106898;884.783228109111;887.7203680840514;887.9422837515541;888.0586578227068;888.1828717579842;703.2967032967058;856.9100244474303;875.4965894610624;880.5245167609484;880.8018195905934;624.7844493649684;624.9781257656006;625.1841347042108;625.4589779840451;627.8807026664965;14539.636509087251;14575.854241457662;14575.927120364437;14586.9789114762;14594.854051459455;13945.651358716012;13985.440582376692;14289.785653215211;14367.137971721626;14578.343974521065;12996.610101696964;13045.934770326183;13068.673283167996;13091.427602779988;13226.735465290736;4182.895427614303;4210.726302790309;4314.697971142022;4431.423914891044;4431.711938723973;71678.64160679163;71734.2826571738;72195.27804721991;73241.6337918307;73560;11566.884331156582;11570.710732231593;11587;11699.181057325906;11721.4139293035;21656.458588535414;21772.56454870894;21874.562508750056;21924.671129933064;22061.669074963887;8335.291500222549;8344.499330040217;8390.454620449773;8463.195996380335;8539.444936079135;4468.419105516262;4503.279475283939;4527.185106680763;4704.1062198182235;4749.762511874393;3524.5065690802794;3614.1145419371896;3617.366960781853;3624.7825130492256;3983.5817239190046;740.3447948565558;753.8115471132216;769.3883362726646;770.2528547309101;776.47587878182;667.7696194812781;687.6252442418894;701.0955866931703;756.4666909828558;782.1083964280724;10242.6415075472;10358.896411035945;10650.946745266225;10662.520186591622;10781.838272425919;629.9212598425197;707.3916431868589;711.6157275071507;730.8903664450374;762.0871612253173;4996.475370086088;5550.972245138749;5633.295838020247;5748.396418376094;5841.881473561214;74921.62539187378;82881;117119;127211;129122.35438822745;65913.67043164754;66486.33513664802;68033;98737.01262987423;106618;62587.37412625906;62603.37396626067;78019;86238;87058;10492.265541412333;10507.94746026265;10710.410927399067;10789.676309710721;10801.945990269998;53415.19877201923;55216;56105.71947140238;56317.43682563122;57203.71398142983;69165.88753506205;69458.30541694518;74491;80420;83212.58393707992;13781;13843.515476958259;13952.511662091778;14007.579772606838;14049.297535123407;15456.690866182838;15627.609309767347;15688.215589220721;15827.446039389028;15844.920775396049;14478.855211447752;14504.709905801614;14545.545345585551;14896.32966516531;15125.773113403087;14423.711525769635;14446.32742942559;14557.781633275297;14892.32984515721;14955.102693838404;14289.928550357181;14290.499832505813;14593.343299551758;14666.633334166305;15331.003484773453;11499.942500287445;11609.709757256136;11624.128190385924;11801.409929503663;12401.069919755873;10595.80230196328;10913.890861091606;11334.376609286568;12105.576304829288;12457.06572007085 19:36:43 INFO - PROCESS | 27779 | __end_tp_report 19:36:43 INFO - PROCESS | 27779 | __start_cc_report 19:36:43 INFO - PROCESS | 27779 | _x_x_mozilla_cycle_collect,897 19:36:43 INFO - PROCESS | 27779 | __end_cc_report 19:36:43 INFO - PROCESS | 27779 | __startTimestamp1469932603106__endTimestamp 19:36:43 INFO - PROCESS | 27779 | 19:36:43 INFO - PROCESS | 27779 | ------- Summary: start ------- 19:36:43 INFO - PROCESS | 27779 | Number of tests: 6 19:36:43 INFO - PROCESS | 27779 | 19:36:43 INFO - PROCESS | 27779 | [#0] dojo.html Cycles:165 Average:5308.25 Median:5538.75 stddev:605.42 (10.9%) stddev-sans-first:580.62 19:36:43 INFO - PROCESS | 27779 | Values: 3043.1 3056.3 3078.6 3090.4 3097.1 5225.5 5242.6 5272.8 5357.2 5370.8 5231.1 5234.1 5290.0 5325.2 5336.3 4765.4 4820.2 4828.1 4829.2 5046.1 4931.0 4970.7 4993.5 5010.1 5011.2 4741.8 4775.0 4785.4 4838.3 4914.5 4790.6 4799.6 4808.1 4915.0 4925.8 4778.8 4805.4 4820.3 4826.0 4862.0 5143.6 5212.9 5315.3 5362.5 5374.1 5581.7 5669.7 5675.1 5682.3 5683.1 5639.0 5659.8 5680.1 5708.2 5713.8 5124.3 5246.5 5262.7 5284.1 5297.5 5886.4 5893.0 5907.7 5917.6 5918.4 5652.7 5658.0 5660.4 5667.8 5669.5 5521.3 5622.6 5682.8 5712.9 5719.0 5698.0 5749.7 5754.3 5759.0 5759.5 5636.4 5692.3 5694.7 5703.6 5713.1 4306.7 4361.1 4395.1 4408.8 4447.2 3861.6 3882.6 3896.1 3930.6 4009.1 5440.5 5443.1 5445.9 5450.4 5456.2 5752.1 5755.3 5759.2 5765.7 5799.7 5164.1 5373.2 5418.9 5420.1 5475.2 4975.7 4981.8 4984.4 4989.3 5022.4 5918.7 5959.3 5961.9 5974.6 6024.0 5608.1 5636.8 5668.6 5673.5 5726.4 5936.6 5937.2 5942.8 5946.9 5991.5 5542.4 5603.7 5604.4 5609.1 5615.4 5618.1 5682.9 5691.0 5702.7 5714.8 5624.1 5627.0 5641.3 5642.3 5643.0 5528.7 5599.6 5602.4 5604.2 5608.7 5410.8 5500.3 5523.7 5535.6 5546.2 5658.5 5669.2 5713.8 5718.7 5720.3 5488.9 5538.8 5544.4 5544.9 5552.3 19:36:43 INFO - PROCESS | 27779 | 19:36:43 INFO - PROCESS | 27779 | [#1] ext.html Cycles:180 Average:60130.66 Median:42359.18 stddev:114875.41 (271.2%) stddev-sans-first:115110.65 19:36:43 INFO - PROCESS | 27779 | Values: 578.6 590.4 594.1 595.8 598.2 32485.2 42849.8 44752.3 44756.1 48119.3 45412.0 45737.0 45804.8 45823.8 45891.8 8825.9 9006.9 9008.8 9011.6 9018.4 8778.1 8875.1 8876.8 8878.2 8878.7 8923.5 8955.2 8962.8 8963.0 8965.4 8859.1 8881.0 8922.7 8927.1 8927.2 8807.5 8862.4 8862.7 8864.5 8878.6 41950.4 42307.0 42312.6 42345.6 42372.8 3511.0 3527.3 3613.8 3623.7 3665.7 32360.2 32592.0 32669.3 33938.8 36356.5 4515.8 4612.9 4688.5 4697.6 4698.0 324860.0 329805.0 329895.0 329925.0 330231.0 54110.2 61198.7 62635.0 62704.7 66548.3 68379.3 68385.7 68819.7 68838.0 68998.0 16012.8 16019.8 16020.2 16030.4 16101.4 11542.1 11576.2 11580.2 11622.4 11739.6 17724.2 19481.2 20022.6 20989.7 21156.7 7493.9 7612.6 7623.0 7636.0 7660.8 1030.5 1038.2 1076.3 1152.6 1166.6 32942.0 33105.0 33198.8 33281.5 33913.8 1081.0 1141.4 1142.3 1166.7 1221.2 17303.9 17352.7 17385.6 17502.6 17535.8 526969.0 531476.0 535561.0 536487.0 536609.0 59492.4 59632.4 60053.7 60468.0 60767.0 1191.6 1285.3 1326.2 1336.2 1371.2 31995.0 33435.8 33585.3 33588.7 34064.7 50850.5 51422.0 51435.0 51495.0 51538.7 412598.0 414659.0 414875.0 417024.0 417738.0 44269.6 44606.0 46179.5 46212.3 46247.0 47643.3 48564.8 48809.8 48812.8 48951.5 41023.2 41679.6 41977.6 42320.8 43454.3 41196.8 41417.6 41753.0 42260.0 42440.0 41370.0 41628.8 42160.6 42505.6 42635.6 33758.7 37219.0 37556.8 37624.2 38495.8 28045.2 28198.6 28217.3 28281.9 28283.2 19:36:43 INFO - PROCESS | 27779 | 19:36:43 INFO - PROCESS | 27779 | [#2] jquery.html Cycles:180 Average:26285.52 Median:200324.73 stddev:68447.60 (34.2%) stddev-sans-first:68611.94 19:36:43 INFO - PROCESS | 27779 | Values: 362.8 382.3 395.5 401.6 415.6 16282.0 19072.4 19138.0 19217.3 19856.3 19239.0 19439.5 19676.8 19725.9 19820.3 5567.8 5581.6 5771.0 5776.5 6438.1 6412.3 6474.6 6488.6 6497.8 6511.6 6263.5 6269.2 6379.5 6382.6 6390.3 6190.1 6343.8 6343.9 6346.8 6376.2 5662.3 5665.0 5665.7 5669.6 5683.2 23444.9 23647.5 23737.2 24217.9 24396.6 2136.5 2226.2 2235.9 2388.0 2393.9 10292.5 10378.0 10475.9 10633.1 10849.0 1842.9 1887.0 1887.6 1975.8 2030.1 60710.7 81804.0 84342.6 85153.6 87050.6 10707.1 10861.6 10957.3 11013.2 11126.8 15401.9 15417.7 15424.4 15426.0 15430.1 7594.8 7794.0 7914.8 7989.0 8012.1 7480.7 7559.9 7717.9 7726.7 7740.6 4629.7 4716.2 4769.0 4769.3 4866.8 1870.0 1944.4 1965.2 1968.0 1988.8 902.8 979.3 985.4 996.3 1006.9 18963.0 19425.6 19647.9 19708.8 19939.8 912.9 930.9 937.4 977.7 978.1 6651.0 6657.6 7000.8 10083.3 10873.2 282101.0 284302.0 400254.0 509194.0 513718.0 56580.7 96275.0 96733.5 98157.5 98965.5 447.9 464.8 466.9 467.2 468.2 11680.6 11787.5 11842.6 11866.5 11898.4 40892.6 41641.0 42720.6 43122.0 43456.3 59833.4 60038.7 61375.7 62244.7 62412.4 5697.4 8109.4 8235.3 8361.0 8474.6 11322.5 12707.4 12903.4 13301.9 13306.4 11341.4 11363.5 11677.1 11719.5 11860.2 10979.2 11243.9 11298.0 11353.3 11449.2 11331.3 11333.8 11420.3 11437.3 11881.9 8193.1 8392.5 11228.9 11811.6 11944.1 11615.4 11817.7 12209.6 12291.3 12312.7 19:36:43 INFO - PROCESS | 27779 | 19:36:43 INFO - PROCESS | 27779 | [#3] mootools.html Cycles:180 Average:5779.16 Median:4782.68 stddev:3341.84 (69.9%) stddev-sans-first:3334.49 19:36:43 INFO - PROCESS | 27779 | Values: 1330.7 1405.2 1487.6 1532.8 1761.2 8491.4 8824.1 8842.5 9158.5 9168.7 8860.8 8962.2 8975.1 8975.8 8982.6 2347.9 2373.2 2373.4 2375.1 2376.9 2331.0 2364.0 2414.0 2419.6 2421.9 2314.0 2314.4 2343.8 2347.9 2351.6 2308.5 2326.8 2327.6 2348.1 2350.4 2288.2 2291.3 2296.2 2297.5 2306.2 8966.3 8967.3 8991.1 9054.2 9067.2 5198.1 5363.6 5382.3 5384.1 5400.4 3433.3 3458.9 3487.6 3517.8 3518.7 1093.1 1100.3 1101.3 1111.6 1127.4 11593.4 11633.2 11686.6 11701.5 11706.0 4273.4 4401.6 4542.1 4556.8 4558.2 9959.7 9960.8 9962.5 9963.3 9971.7 5212.5 5215.8 5217.2 5220.1 5225.9 4038.8 4609.4 4767.2 4798.2 4823.6 3810.3 3852.3 3917.7 3950.7 3965.2 1110.3 1137.4 1157.5 1164.5 1167.5 946.9 970.8 971.8 974.7 995.2 5769.5 5908.7 5945.3 6003.4 6004.1 449.7 450.7 451.9 452.2 454.9 3839.3 3858.0 3860.1 3954.4 4023.5 10792.9 11068.1 11353.8 11385.5 11394.8 11033.2 11321.4 11327.9 11335.1 11370.3 8024.6 8286.5 8324.8 8373.8 8389.3 5936.8 5947.8 5996.6 6011.2 6066.9 9886.8 9999.0 10184.9 10245.4 10327.1 10540.8 10626.6 10627.1 10646.8 10683.4 6873.7 7364.0 7517.1 7531.4 7543.9 8572.8 8702.0 8708.6 8719.0 8723.5 7470.3 7572.2 7601.8 7953.8 7956.8 7554.6 7583.0 7608.0 7768.1 7929.6 6761.3 6858.4 6869.3 6874.7 6876.3 4884.6 4939.8 4997.4 5002.7 5019.8 4914.3 4957.8 5055.5 5095.0 5166.7 19:36:43 INFO - PROCESS | 27779 | 19:36:43 INFO - PROCESS | 27779 | [#4] prototype.html Cycles:180 Average:4647.20 Median:5318.69 stddev:1364.31 (25.7%) stddev-sans-first:1328.72 19:36:43 INFO - PROCESS | 27779 | Values: 309.6 317.8 326.3 326.6 327.1 5227.7 5278.0 5300.0 5314.2 5316.7 4902.4 5050.3 5073.1 5073.2 5200.6 3952.9 4056.1 4066.2 4118.8 4122.6 4102.8 4118.0 4119.0 4129.3 4139.3 3978.0 4060.0 4070.2 4082.5 4088.7 4087.5 4088.6 4090.6 4095.1 4128.7 3630.2 3635.4 3648.3 3649.8 3670.0 5071.8 5149.7 5192.5 5204.2 5205.2 4652.0 4662.9 4703.2 4709.0 4718.5 5387.5 5397.9 5421.7 5426.9 5460.3 3815.9 3933.9 3947.7 3948.1 3976.8 5613.5 5649.8 5657.5 5662.9 5700.1 4037.8 4071.2 4074.8 4077.5 4090.9 4101.5 4117.3 4120.5 4132.6 4149.7 4473.8 4596.4 4603.1 4606.6 4612.9 5448.7 5454.6 5458.5 5463.9 5501.2 1364.6 1400.3 1425.3 1427.6 1433.3 947.8 976.2 977.3 992.1 994.6 5292.6 5358.8 5360.1 5361.1 5383.5 5500.9 5559.4 5565.7 5626.7 5634.6 5246.5 5253.4 5294.5 5301.4 5320.7 2970.3 2975.8 2984.7 2996.0 3012.9 5641.4 5802.8 5812.7 5884.7 5911.8 5721.9 5724.3 5727.1 5728.1 5742.1 5845.7 5896.4 5897.3 5905.4 5905.9 5434.8 5637.9 5654.9 5672.7 5695.4 5561.8 5579.8 5579.8 5592.7 5668.1 5770.7 5871.3 5913.8 5989.2 6022.4 4045.8 4054.9 4082.2 4113.7 4116.3 5747.8 5760.4 5774.2 5780.3 5784.5 5516.4 5606.7 5637.4 5640.9 5644.3 5532.9 5533.9 5539.8 5546.3 5546.5 5261.8 5408.7 5412.2 5485.1 5576.4 5346.1 5444.4 5553.0 5557.5 5559.3 5449.0 5471.3 5474.4 5502.3 5521.8 19:36:43 INFO - PROCESS | 27779 | 19:36:43 INFO - PROCESS | 27779 | [#5] yui.html Cycles:180 Average:20127.68 Median:4262.71 stddev:27673.35 (649.2%) stddev-sans-first:27712.49 19:36:43 INFO - PROCESS | 27779 | Values: 689.3 768.4 772.4 848.1 851.4 15239.6 16468.8 16475.2 16476.5 16481.3 15029.5 15261.8 15266.2 15268.5 15303.4 662.2 792.7 810.4 818.8 824.2 820.0 829.3 831.3 831.8 831.9 884.8 887.7 887.9 888.1 888.2 703.3 856.9 875.5 880.5 880.8 624.8 625.0 625.2 625.5 627.9 14539.6 14575.9 14575.9 14587.0 14594.9 13945.7 13985.4 14289.8 14367.1 14578.3 12996.6 13045.9 13068.7 13091.4 13226.7 4182.9 4210.7 4314.7 4431.4 4431.7 71678.6 71734.3 72195.3 73241.6 73560.0 11566.9 11570.7 11587.0 11699.2 11721.4 21656.5 21772.6 21874.6 21924.7 22061.7 8335.3 8344.5 8390.5 8463.2 8539.4 4468.4 4503.3 4527.2 4704.1 4749.8 3524.5 3614.1 3617.4 3624.8 3983.6 740.3 753.8 769.4 770.3 776.5 667.8 687.6 701.1 756.5 782.1 10242.6 10358.9 10650.9 10662.5 10781.8 629.9 707.4 711.6 730.9 762.1 4996.5 5551.0 5633.3 5748.4 5841.9 74921.6 82881.0 117119.0 127211.0 129122.4 65913.7 66486.3 68033.0 98737.0 106618.0 62587.4 62603.4 78019.0 86238.0 87058.0 10492.3 10507.9 10710.4 10789.7 10801.9 53415.2 55216.0 56105.7 56317.4 57203.7 69165.9 69458.3 74491.0 80420.0 83212.6 13781.0 13843.5 13952.5 14007.6 14049.3 15456.7 15627.6 15688.2 15827.4 15844.9 14478.9 14504.7 14545.5 14896.3 15125.8 14423.7 14446.3 14557.8 14892.3 14955.1 14289.9 14290.5 14593.3 14666.6 15331.0 11499.9 11609.7 11624.1 11801.4 12401.1 10595.8 10913.9 11334.4 12105.6 12457.1 19:36:43 INFO - PROCESS | 27779 | -------- Summary: end -------- 19:36:43 INFO - PROCESS | 27779 | 19:36:43 INFO - TEST-INFO | 27779: exit 0 19:36:43 INFO - TEST-OK | dromaeo_css | took 1113300ms 19:36:43 INFO - TEST-START | kraken 19:36:43 INFO - operating with platform_type : linux_ 19:36:43 INFO - Initialising browser for kraken test... 19:36:43 INFO - TEST-INFO | started process 27964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc4Trf7/profile http://localhost:41700/getInfo.html) 19:36:47 INFO - PROCESS | 27964 | __metrics Screen width/height:1600/1200 19:36:47 INFO - PROCESS | 27964 | colorDepth:24 19:36:47 INFO - PROCESS | 27964 | Browser inner width/height: 1024/697 19:36:47 INFO - PROCESS | 27964 | __metrics 19:36:48 INFO - PROCESS | 27964 | 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" 19:36:48 INFO - PROCESS | 27964 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:36:49 INFO - TEST-INFO | 27964: exit 0 19:36:49 INFO - Browser initialized. 19:36:49 INFO - Running cycle 1/1 for kraken test... 19:36:49 INFO - TEST-INFO | started process 28043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc4Trf7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:01 INFO - PROCESS | 28043 | RSS: Main: 156082176 19:37:01 INFO - PROCESS | 28043 | 19:37:03 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41700/tests/kraken/driver.html?testName=audio-beat-detection) 19:37:04 INFO - PROCESS | 28043 | RSS: Main: 212463616 19:37:04 INFO - PROCESS | 28043 | 19:37:07 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41700/tests/kraken/driver.html?testName=audio-dft) 19:37:07 INFO - PROCESS | 28043 | RSS: Main: 190767104 19:37:07 INFO - PROCESS | 28043 | 19:37:10 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41700/tests/kraken/driver.html?testName=audio-fft) 19:37:11 INFO - PROCESS | 28043 | RSS: Main: 268173312 19:37:11 INFO - PROCESS | 28043 | 19:37:13 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41700/tests/kraken/driver.html?testName=audio-oscillator) 19:37:13 INFO - PROCESS | 28043 | RSS: Main: 179580928 19:37:13 INFO - PROCESS | 28043 | 19:37:16 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41700/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:37:16 INFO - PROCESS | 28043 | RSS: Main: 184238080 19:37:16 INFO - PROCESS | 28043 | 19:37:19 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41700/tests/kraken/driver.html?testName=imaging-darkroom) 19:37:20 INFO - PROCESS | 28043 | RSS: Main: 220106752 19:37:20 INFO - PROCESS | 28043 | 19:37:23 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41700/tests/kraken/driver.html?testName=imaging-desaturate) 19:37:24 INFO - PROCESS | 28043 | RSS: Main: 219639808 19:37:24 INFO - PROCESS | 28043 | 19:37:26 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41700/tests/kraken/driver.html?testName=json-parse-financial) 19:37:27 INFO - PROCESS | 28043 | RSS: Main: 219631616 19:37:27 INFO - PROCESS | 28043 | 19:37:29 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41700/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:37:29 INFO - PROCESS | 28043 | RSS: Main: 183406592 19:37:29 INFO - PROCESS | 28043 | 19:37:31 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41700/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:37:31 INFO - PROCESS | 28043 | RSS: Main: 189251584 19:37:31 INFO - PROCESS | 28043 | 19:37:33 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41700/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:37:34 INFO - PROCESS | 28043 | RSS: Main: 194166784 19:37:34 INFO - PROCESS | 28043 | 19:37:37 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:37:37 INFO - PROCESS | 28043 | RSS: Main: 188780544 19:37:37 INFO - PROCESS | 28043 | 19:37:40 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:37:41 INFO - PROCESS | 28043 | RSS: Main: 191930368 19:37:41 INFO - PROCESS | 28043 | 19:37:42 INFO - PROCESS | 28043 | Cycle 1(1): loaded http://localhost:41700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41700/tests/kraken/driver.html?testName=ai-astar) 19:37:43 INFO - PROCESS | 28043 | RSS: Main: 242683904 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | __start_tp_report 19:37:43 INFO - PROCESS | 28043 | _x_x_mozilla_page_load 19:37:43 INFO - PROCESS | 28043 | _x_x_mozilla_page_load_details 19:37:43 INFO - PROCESS | 28043 | |i|pagename|runs| 19:37:43 INFO - PROCESS | 28043 | |0;ai-astar;101;110;110;110;110;111;109;111;110;108 19:37:43 INFO - PROCESS | 28043 | |1;audio-beat-detection;144;115;118;187;119;117;153;118;151;118 19:37:43 INFO - PROCESS | 28043 | |2;audio-dft;163;163;161;162;163;163;164;162;163;161 19:37:43 INFO - PROCESS | 28043 | |3;audio-fft;74;75;76;125;76;76;75;76;108;74 19:37:43 INFO - PROCESS | 28043 | |4;audio-oscillator;84;84;124;84;84;84;123;83;83;134 19:37:43 INFO - PROCESS | 28043 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;117;117 19:37:43 INFO - PROCESS | 28043 | |6;imaging-darkroom;146;147;146;145;146;146;146;145;146;145 19:37:43 INFO - PROCESS | 28043 | |7;imaging-desaturate;96;95;95;95;95;95;94;94;96;94 19:37:43 INFO - PROCESS | 28043 | |8;json-parse-financial;50;50;50;54;50;50;50;51;51;50 19:37:43 INFO - PROCESS | 28043 | |9;json-stringify-tinderbox;62;61;60;60;62;60;60;60;61;61 19:37:43 INFO - PROCESS | 28043 | |10;stanford-crypto-aes;77;76;75;84;76;75;75;82;76;75 19:37:43 INFO - PROCESS | 28043 | |11;stanford-crypto-ccm;129;120;119;121;119;118;118;128;165;121 19:37:43 INFO - PROCESS | 28043 | |12;stanford-crypto-pbkdf2;158;157;158;158;161;159;157;157;157;158 19:37:43 INFO - PROCESS | 28043 | |13;stanford-crypto-sha256-iterative;63;64;66;64;63;67;65;62;63;61 19:37:43 INFO - PROCESS | 28043 | __end_tp_report 19:37:43 INFO - PROCESS | 28043 | __start_cc_report 19:37:43 INFO - PROCESS | 28043 | _x_x_mozilla_cycle_collect,1687 19:37:43 INFO - PROCESS | 28043 | __end_cc_report 19:37:43 INFO - PROCESS | 28043 | __startTimestamp1469932663010__endTimestamp 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | ------- Summary: start ------- 19:37:43 INFO - PROCESS | 28043 | Number of tests: 14 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.94 (2.7%) stddev-sans-first:0.93 19:37:43 INFO - PROCESS | 28043 | Values: 101.0 110.0 110.0 110.0 110.0 111.0 109.0 111.0 110.0 108.0 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:131.50 stddev:24.04 (18.3%) stddev-sans-first:25.23 19:37:43 INFO - PROCESS | 28043 | Values: 144.0 115.0 118.0 187.0 119.0 117.0 153.0 118.0 151.0 118.0 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 19:37:43 INFO - PROCESS | 28043 | Values: 163.0 163.0 161.0 162.0 163.0 163.0 164.0 162.0 163.0 161.0 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.50 stddev:17.87 (23.7%) stddev-sans-first:18.62 19:37:43 INFO - PROCESS | 28043 | Values: 74.0 75.0 76.0 125.0 76.0 76.0 75.0 76.0 108.0 74.0 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:84.00 stddev:21.11 (25.1%) stddev-sans-first:21.88 19:37:43 INFO - PROCESS | 28043 | Values: 84.0 84.0 124.0 84.0 84.0 84.0 123.0 83.0 83.0 134.0 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:37:43 INFO - PROCESS | 28043 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 19:37:43 INFO - PROCESS | 28043 | Values: 146.0 147.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 19:37:43 INFO - PROCESS | 28043 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 96.0 94.0 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:50.00 stddev:1.26 (2.5%) stddev-sans-first:1.32 19:37:43 INFO - PROCESS | 28043 | Values: 50.0 50.0 50.0 54.0 50.0 50.0 50.0 51.0 51.0 50.0 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 19:37:43 INFO - PROCESS | 28043 | Values: 62.0 61.0 60.0 60.0 62.0 60.0 60.0 60.0 61.0 61.0 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.00 stddev:3.21 (4.2%) stddev-sans-first:3.41 19:37:43 INFO - PROCESS | 28043 | Values: 77.0 76.0 75.0 84.0 76.0 75.0 75.0 82.0 76.0 75.0 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:121.00 stddev:14.32 (11.8%) stddev-sans-first:15.14 19:37:43 INFO - PROCESS | 28043 | Values: 129.0 120.0 119.0 121.0 119.0 118.0 118.0 128.0 165.0 121.0 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 19:37:43 INFO - PROCESS | 28043 | Values: 158.0 157.0 158.0 158.0 161.0 159.0 157.0 157.0 157.0 158.0 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - PROCESS | 28043 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.81 (2.8%) stddev-sans-first:1.90 19:37:43 INFO - PROCESS | 28043 | Values: 63.0 64.0 66.0 64.0 63.0 67.0 65.0 62.0 63.0 61.0 19:37:43 INFO - PROCESS | 28043 | -------- Summary: end -------- 19:37:43 INFO - PROCESS | 28043 | 19:37:43 INFO - TEST-INFO | 28043: exit 0 19:37:44 INFO - TEST-OK | kraken | took 60158ms 19:37:44 INFO - SUITE-END | took 1173s 19:37:44 INFO - Completed test suite (00:19:33) 19:37:44 INFO - javascript benchmark 19:37:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.0566524377437, 3056.25121845148, 3078.599782028337, 3090.4282707699062, 3097.0863595239402, 5225.503577160173, 5242.606804489669, 5272.8154514592, 5357.2232026356205, 5370.758315875781, 5231.110711179099, 5234.136367499367, 5289.973550132244, 5325.227841962913, 5336.279602253695, 4765.380500534926, 4820.180569303227, 4828.106800241949, 4829.22732362822, 5046.09170349337, 4930.98914722481, 4970.6520543561965, 4993.525615066581, 5010.073136469747, 5011.2483127530795, 4741.8103275868925, 4774.9522504775205, 4785.377900872864, 4838.274258861164, 4914.533119353656, 4790.640701947333, 4799.616030717534, 4808.110499557593, 4914.950850491485, 4925.827596034157, 4778.761061946889, 4805.3753012108555, 4820.301056346845, 4826.034793041371, 4861.975690121562, 5143.588512918957, 5212.869678258036, 5315.335583052119, 5362.4637536246455, 5374.086405311106, 5581.720913954286, 5669.688167150805, 5675.120356344732, 5682.261306030231, 5683.147527870811, 5639.0, 5659.801906933238, 5680.091185410356, 5708.20085188074, 5713.8285851424525, 5124.256982737519, 5246.527812496817, 5262.657927234717, 5284.128118860422, 5297.549708274802, 5886.381929897299, 5893.0, 5907.675077870758, 5917.5857689961285, 5918.378570250062, 5652.7173641318595, 5657.971710141423, 5660.405657405995, 5667.773289068474, 5669.489745922887, 5521.337439507285, 5622.578306626938, 5682.801101961494, 5712.885742285131, 5718.971405142947, 5698.0, 5749.712514374264, 5754.280714910637, 5759.0, 5759.51044161251, 5636.351819540723, 5692.345380281238, 5694.715264236772, 5703.600747947687, 5713.085906254979, 4306.655467562588, 4361.062371590124, 4395.1429471252795, 4408.801603927767, 4447.199504089231, 3861.555921069113, 3882.6311500407414, 3896.1428485733095, 3930.6462418382484, 4009.077912080238, 5440.483154100354, 5443.074677304868, 5445.863853403696, 5450.400455949843, 5456.236126942231, 5752.108423194411, 5755.309362876398, 5759.164921086419, 5765.740541675635, 5799.681017544076, 5164.14791559396, 5373.167159090347, 5418.945810541844, 5420.105682562412, 5475.233467314579, 4975.676581022222, 4981.750912454363, 4984.40187177541, 4989.326440930428, 5022.447530771612, 5918.6704349596685, 5959.28488581373, 5961.850953726192, 5974.551908606785, 6024.0, 5608.130739735348, 5636.830895073154, 5668.574856885833, 5673.517750991212, 5726.398728133652, 5936.554758393224, 5937.168796368598, 5942.7920022799, 5946.940530594638, 5991.520678345809, 5542.418046105101, 5603.691796951207, 5604.439556044526, 5609.130584759206, 5615.410381910004, 5618.073017951992, 5682.943170568242, 5691.0, 5702.6863522506665, 5714.771409143587, 5624.128260119688, 5627.043402621646, 5641.323041235078, 5642.294713160855, 5643.0, 5528.668279903219, 5599.608027438203, 5602.439756024365, 5604.2154098425435, 5608.747606357642, 5410.810621628224, 5500.312460942382, 5523.696196709219, 5535.557155427637, 5546.223528705904, 5658.519025882846, 5669.206311116364, 5713.8285851424525, 5718.714064296852, 5720.2849643794525, 5488.945110549003, 5538.750756215899, 5544.362398324244, 5544.861378465571, 5552.278203833475], "value": 5267.135552636901, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.5718568259488, 590.3977942498652, 594.1236675903043, 595.821253623913, 598.2103623217355, 32485.187870303223, 42849.78575107124, 44752.3287150693, 44756.10487790242, 48119.27821082678, 45412.0, 45737.0, 45804.770976145155, 45823.77088114563, 45891.77054114725, 8825.867611985825, 9006.86489702655, 9008.774780630503, 9011.594478248495, 9018.413803102778, 8778.078301778318, 8875.06811784763, 8876.778080547974, 8878.156575125386, 8878.73363799087, 8923.509206993645, 8955.238804701608, 8962.820743585124, 8962.955185224097, 8965.417247878868, 8859.06979767128, 8880.978687450961, 8922.73231803047, 8927.062658420902, 8927.151920567536, 8807.515586642732, 8862.423942443786, 8862.689805856828, 8864.512451815148, 8878.600462979182, 41950.37074443886, 42307.0, 42312.57687423117, 42345.57654423478, 42372.78813605912, 3511.0344655219765, 3527.3474407234744, 3613.8012409317475, 3623.691986181178, 3665.7433979621437, 32360.249378802593, 32592.0, 32669.346613067843, 33938.830305848314, 36356.454653180226, 4515.841945531924, 4612.884677883047, 4688.5077066907825, 4697.647676424248, 4697.976510117462, 324860.0, 329805.0, 329894.9999999976, 329925.0, 330231.0, 54110.18834717482, 61198.694006530575, 62635.0, 62704.68647656824, 66548.33451665519, 68379.31620683729, 68385.65807171032, 68819.65590172017, 68838.0, 68998.0, 16012.759808602881, 16019.759703604455, 16020.19899005045, 16030.358785648443, 16101.436449724204, 11542.07663386927, 11576.24754390962, 11580.247283926517, 11622.418879056013, 11739.647810565697, 17724.202410891285, 19481.16538847937, 20022.59954800896, 20989.68515472269, 21156.682649760267, 7493.925060749323, 7612.581308028, 7623.0, 7635.961820190863, 7660.80847978805, 1030.5311083457009, 1038.1694644284541, 1076.311160857052, 1152.5793085523724, 1166.6033548593518, 32942.0, 33105.02054815078, 33198.83400582981, 33281.500777487876, 33913.83043084769, 1080.9946749522862, 1141.4178768827958, 1142.2580564638993, 1166.719987203065, 1221.2062159596155, 17303.91348043252, 17352.739708904377, 17385.56536086608, 17502.649947000988, 17535.831976813508, 526969.0, 531476.0, 535561.0, 536487.0, 536609.0, 59492.40507594955, 59632.40367596268, 60053.69973150106, 60468.0, 60767.0, 1191.582945968904, 1285.2866659004342, 1326.1843965961057, 1336.1982810313928, 1371.2252577293996, 31995.0, 33435.83282083574, 33585.32829343448, 33588.66411335953, 34064.65935340615, 50850.49149508458, 51422.0, 51435.0, 51495.0, 51538.74230628823, 412598.0, 414659.0, 414875.0, 417024.0, 417738.0, 44269.55730442654, 44606.0, 46179.53820461752, 46212.306815397125, 46247.0, 47643.285350719074, 48564.75717621531, 48809.75595122002, 48812.75593622009, 48951.510484894694, 41023.179536408505, 41679.58320416757, 41977.58022419859, 42320.788396057826, 43454.34818477662, 41196.79401602973, 41417.58582414258, 41753.0, 42260.0, 42440.0, 41370.0, 41628.79185604174, 42160.57839421689, 42505.57494425016, 42635.57364426316, 33758.662413376536, 37219.0, 37556.81221593874, 37624.247515049, 38495.80752096222, 28045.190071757464, 28198.577021345107, 28217.294567635974, 28281.858590706914, 28283.151505454047], "value": 20659.589560181576, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.8312834531942, 382.3423711216708, 395.45822223553733, 401.570319757859, 415.56988516885013, 16282.023078615292, 19072.42782716519, 19138.0, 19217.32739354123, 19856.305029323976, 19239.0, 19439.514012149702, 19676.80323196771, 19725.901370493128, 19820.306289279877, 5567.832965011056, 5581.6371935824045, 5771.0, 5776.451237132465, 6438.098666186737, 6412.326705695905, 6474.643894585796, 6488.610683359014, 6497.772577959772, 6511.57674751142, 6263.467605253559, 6269.216347956505, 6379.515680825733, 6382.648954307511, 6390.329015453381, 6190.133381326618, 6343.777967771129, 6343.904841427382, 6346.777862774804, 6376.234851817811, 5662.348829884575, 5665.036943719537, 5665.66006039639, 5669.6314739541795, 5683.175939488792, 23444.88277558601, 23647.527049459088, 23737.16919907795, 24217.878910605512, 24396.63405048908, 2136.5086030212983, 2226.2096955580696, 2235.910563577455, 2388.044782087179, 2393.8563686178886, 10292.485375731183, 10378.0, 10475.895241047569, 10633.096186824128, 10849.0, 1842.9078546072642, 1886.9811301886944, 1887.5564242403025, 1975.8221760041522, 2030.0966070098812, 60710.696446517926, 81804.0, 84342.57828710879, 85153.57423212906, 87050.5647471765, 10707.14542764604, 10861.619843305605, 10957.287776294515, 11013.229073964745, 11126.828853776635, 15401.922990384975, 15417.691646167013, 15424.383024679111, 15426.0, 15430.074195548303, 7594.8101297468, 7794.0, 7914.762557123296, 7988.960055199686, 8012.1186669466315, 7480.663370148356, 7559.924400756032, 7717.922820771832, 7726.690932362642, 7740.6129693515095, 4629.699069560468, 4716.1510928033285, 4769.046190761862, 4769.284607308931, 4866.829660961849, 1870.046276399019, 1944.3777991043014, 1965.2335589120255, 1967.950801229952, 1988.7812340642517, 902.7697937026016, 979.2704435195682, 985.4136788610765, 996.2627655534852, 1006.8892421833592, 18963.0, 19425.611487770166, 19647.901760491393, 19708.802911970695, 19939.800601994084, 912.8950170730451, 930.8976012638605, 937.4047479850344, 977.6953895832042, 978.0659470205936, 6650.9667451662435, 6657.600543967377, 7000.824979375557, 10083.288059054234, 10873.238873278795, 282101.0, 284302.0, 400254.0, 509194.0, 513718.0, 56580.71709641426, 96275.0, 96733.5163324193, 98157.50921245491, 98965.50517247367, 447.91265703187565, 464.79781295136723, 466.86927660255185, 467.22907203114454, 468.22976204144675, 11680.649580512598, 11787.469563869818, 11842.585509507126, 11866.466009029788, 11898.405079746151, 40892.59107408888, 41640.96236890851, 42720.57279427166, 43122.0, 43456.34815477707, 59833.40166598278, 60038.699806500685, 61375.69312153589, 62244.68877655583, 62412.37587624066, 5697.401772813795, 8109.351251899951, 8235.34117270605, 8360.958195208985, 8474.576271186539, 11322.547098116313, 12707.428165732379, 12903.354832258537, 13301.933490332487, 13306.401211945293, 11341.432928353714, 11363.54545818158, 11677.124215683687, 11719.531218751154, 11860.22908510944, 10979.231453798477, 11243.943780281046, 11298.0, 11353.318800871974, 11449.198556100993, 11331.32012079278, 11333.829992549954, 11420.257683250895, 11437.313761174357, 11881.940590296994, 8193.098759136372, 8392.538410387488, 11228.88771112311, 11811.586594469152, 11944.116882857272, 11615.419229038684, 11817.704557386134, 12209.633710988684, 12291.323977180984, 12312.692182695504], "value": 8883.375556837585, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.700592366717, 1405.2201028429217, 1487.5686051045197, 1532.8160620725507, 1761.1810508113724, 8491.448055876364, 8824.11758824118, 8842.469451832878, 9158.450492970409, 9168.679096231634, 8860.77848053799, 8962.193402593764, 8975.057618950013, 8975.820483590323, 8982.640694372218, 2347.8943447544816, 2373.1575290771784, 2373.371056669984, 2375.10933399975, 2376.9168079117235, 2330.9883450582724, 2364.0425627620757, 2413.963790543143, 2419.5765740995344, 2421.8546887186826, 2313.9652905206435, 2314.36355002374, 2343.8242131840093, 2347.94130146746, 2351.5532048910736, 2308.538292341522, 2326.76732326766, 2327.60430726776, 2348.1429278313462, 2350.4476448034698, 2288.164819840763, 2291.346966114666, 2296.1619009061737, 2297.5404919016096, 2306.215886598548, 8966.327525435618, 8967.327450441178, 8991.14584114508, 9054.185123338866, 9067.183953444222, 5198.142306519419, 5363.570914326844, 5382.300300960889, 5384.057789886754, 5400.351957765093, 3433.2790114076074, 3458.9308213835584, 3487.633798451177, 3517.7889326640484, 3518.736094792875, 1093.1309608860895, 1100.301308669001, 1101.2841652925583, 1111.6053800900645, 1127.3743072594707, 11593.362365069917, 11633.185677002613, 11686.649400517997, 11701.53193872244, 11706.0, 4273.380359847804, 4401.625861801719, 4542.136993971201, 4556.794944227518, 4558.247889098262, 9959.651412200537, 9960.750981225383, 9962.452065136487, 9963.252756043326, 9971.650992215238, 5212.530872221519, 5215.7913683453, 5217.217417387346, 5220.086484865134, 5225.921611175835, 4038.7980600970423, 4609.377734005866, 4767.165745994437, 4798.184308667535, 4823.638227132979, 3810.256999884996, 3852.287326844543, 3917.7257591968287, 3950.7036972227197, 3965.167314863911, 1110.3116068037868, 1137.374444055766, 1157.5196293538256, 1164.470166074434, 1167.5271515036425, 946.914777670013, 970.815545046439, 971.820213260549, 974.7270764186039, 995.2380003586454, 5769.451902069297, 5908.704564771744, 5945.256842894638, 6003.429674180946, 6004.1294012368835, 449.72117287282094, 450.73631925324054, 451.87799294190387, 452.1747810246314, 454.9408576884984, 3839.3281175794123, 3857.9776359264815, 3860.1121741999495, 3954.4463775071513, 4023.4970628671417, 10792.892071079346, 11068.059214966657, 11353.772924541463, 11385.487653055632, 11394.77801828652, 11033.172512061466, 11321.377324247245, 11327.943360283145, 11335.14986376025, 11370.31778093317, 8024.638891249908, 8286.46138001028, 8324.750257492406, 8373.8325233495, 8389.32885369169, 5936.762529498945, 5947.791827286024, 5996.5502587305255, 6011.188489553854, 6066.939330606814, 9886.752831179278, 9998.950005249928, 10184.898151018395, 10245.385276883411, 10327.070563649007, 10540.84188737185, 10626.574937002433, 10627.149828013586, 10646.8402973957, 10683.412412317397, 6873.690683919136, 7364.0426744522865, 7517.097948246245, 7531.435142364454, 7543.924560754323, 8572.785680358042, 8701.95649021776, 8708.60811263482, 8719.0, 8723.476591404537, 7470.327670509463, 7572.242775722384, 7601.809954751176, 7953.8409231813885, 7956.801079973047, 7554.584497852451, 7582.962085189539, 7608.0489938757655, 7768.106667733283, 7929.643166057426, 6761.256261811295, 6858.382745552724, 6869.347411995853, 6874.690638921161, 6876.346747059021, 4884.5603895649565, 4939.777710002986, 4997.400311962442, 5002.749862506933, 5019.824306149268, 4914.336564563738, 4957.801687932587, 5055.469175736494, 5095.031943930641, 5166.741662916764], "value": 4522.8027238969335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.648548897002, 317.8204314562272, 326.30008631485464, 326.6097014068188, 327.0809026635157, 5227.666944929042, 5277.973610131949, 5299.999999999995, 5314.229436731681, 5316.6544174628625, 4902.43621983472, 5050.343455350809, 5073.086844368012, 5073.188289873621, 5200.557952574026, 3952.940705889414, 4056.127932494513, 4066.227416790815, 4118.794060296988, 4122.587741225883, 4102.835886564549, 4118.0, 4118.97940510297, 4129.29801933672, 4139.296319625656, 3977.9801100994455, 4059.9594004059877, 4070.1656160487178, 4082.4692789937417, 4088.6524645405175, 4087.509498860156, 4088.6115818997146, 4090.6318431341174, 4095.136712795671, 4128.69034822388, 3630.16506203572, 3635.4001589737663, 3648.343298206322, 3649.7810131392202, 3669.972407725841, 5071.797128114871, 5149.691018538862, 5192.546087095619, 5204.193350030751, 5205.241222152265, 4651.976740116312, 4662.860114196579, 4703.2239680452685, 4708.976455117737, 4718.528147185289, 5387.542058924996, 5397.865053373697, 5421.72589441481, 5426.8914621707345, 5460.31746031746, 3815.8855234343014, 3933.8819835404984, 3947.664448521879, 3948.072203032285, 3976.840926362942, 5613.494785469327, 5649.813539156782, 5657.547396208252, 5662.858428539278, 5700.144978253254, 4037.7779222143063, 4071.185762847442, 4074.796260187038, 4077.510698716114, 4090.9386359204636, 4101.52832424275, 4117.2588933992165, 4120.526139493936, 4132.628063474242, 4149.7095203335475, 4473.843415480443, 4596.4254468191475, 4603.102395033004, 4606.631469482433, 4612.86161415158, 5448.700321482356, 5454.645448045943, 5458.4814442627885, 5463.863403414867, 5501.174823776386, 1364.5838019404177, 1400.3208443904698, 1425.2944792327864, 1427.600271923863, 1433.269032793283, 947.8199142162968, 976.1800087926034, 977.3256453047375, 992.1318846009741, 994.5922171909482, 5292.629515933924, 5358.758855851496, 5360.061989151883, 5361.1422172453, 5383.542398896059, 5500.889982200333, 5559.360673522516, 5565.721713914288, 5626.718664066781, 5634.605577609528, 5246.4753524647995, 5253.44838791929, 5294.49702278283, 5301.390340110859, 5320.733963301819, 2970.2722832905642, 2975.7916945814018, 2984.686607906182, 2996.022625067445, 3012.894548690785, 5641.379448260688, 5802.767889284381, 5812.738426770806, 5884.735186916599, 5911.76352945886, 5721.942780572224, 5724.255846739898, 5727.11229759388, 5728.112142617901, 5742.13867919807, 5845.7369418376275, 5896.380880007623, 5897.292324921037, 5905.40945905406, 5905.907407129695, 5434.755436005468, 5637.8590535236945, 5654.886902261849, 5672.659640421588, 5695.401982791913, 5561.777528898961, 5579.832605021856, 5579.832605021856, 5592.720363981866, 5668.149777533403, 5770.740316685843, 5871.266091738533, 5913.763449461973, 5989.161517387656, 6022.397760223943, 4045.797710114424, 4054.878353649395, 4082.183563287295, 4113.650339721157, 4116.271166110181, 5747.7929634777165, 5760.366359700513, 5774.220480235283, 5780.335261444988, 5784.537237021113, 5516.393196748274, 5606.729274643776, 5637.351704554028, 5640.943590564042, 5644.266245388073, 5532.944670553404, 5533.889322213614, 5539.833804985696, 5546.306711661043, 5546.473085056913, 5261.842144735664, 5408.701301946736, 5412.215228791882, 5485.0949593318255, 5576.414476479911, 5346.144616861284, 5444.373897001896, 5553.0, 5557.499825015768, 5559.33288005442, 5449.0, 5471.316085489314, 5474.425185355481, 5502.339719233558, 5521.751521181476], "value": 4212.273909928672, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.2762599270765, 768.427521496485, 772.3898120484818, 848.1264297773296, 851.4461108477029, 15239.619009524753, 16468.752968705478, 16475.17624118792, 16476.505704828873, 16481.340746370144, 15029.473968411108, 15261.847381526182, 15266.236688165574, 15268.465603703873, 15303.387864485436, 662.2351184382046, 792.6631181747763, 810.4084018666377, 818.8198596308803, 824.1593574553951, 819.983600327993, 829.274384913201, 831.2934006094831, 831.8336332733447, 831.9292860106898, 884.783228109111, 887.7203680840514, 887.9422837515541, 888.0586578227068, 888.1828717579842, 703.2967032967058, 856.9100244474303, 875.4965894610624, 880.5245167609484, 880.8018195905934, 624.7844493649684, 624.9781257656006, 625.1841347042108, 625.4589779840451, 627.8807026664965, 14539.636509087251, 14575.854241457662, 14575.927120364437, 14586.9789114762, 14594.854051459455, 13945.651358716012, 13985.440582376692, 14289.785653215211, 14367.137971721626, 14578.343974521065, 12996.610101696964, 13045.934770326183, 13068.673283167996, 13091.427602779988, 13226.735465290736, 4182.895427614303, 4210.726302790309, 4314.697971142022, 4431.423914891044, 4431.711938723973, 71678.64160679163, 71734.2826571738, 72195.27804721991, 73241.6337918307, 73560.0, 11566.884331156582, 11570.710732231593, 11587.0, 11699.181057325906, 11721.4139293035, 21656.458588535414, 21772.56454870894, 21874.562508750056, 21924.671129933064, 22061.669074963887, 8335.291500222549, 8344.499330040217, 8390.454620449773, 8463.195996380335, 8539.444936079135, 4468.419105516262, 4503.279475283939, 4527.185106680763, 4704.1062198182235, 4749.762511874393, 3524.5065690802794, 3614.1145419371896, 3617.366960781853, 3624.7825130492256, 3983.5817239190046, 740.3447948565558, 753.8115471132216, 769.3883362726646, 770.2528547309101, 776.47587878182, 667.7696194812781, 687.6252442418894, 701.0955866931703, 756.4666909828558, 782.1083964280724, 10242.6415075472, 10358.896411035945, 10650.946745266225, 10662.520186591622, 10781.838272425919, 629.9212598425197, 707.3916431868589, 711.6157275071507, 730.8903664450374, 762.0871612253173, 4996.475370086088, 5550.972245138749, 5633.295838020247, 5748.396418376094, 5841.881473561214, 74921.62539187378, 82881.0, 117119.0, 127211.0, 129122.35438822745, 65913.67043164754, 66486.33513664802, 68033.0, 98737.01262987423, 106618.0, 62587.37412625906, 62603.37396626067, 78019.0, 86238.0, 87058.0, 10492.265541412333, 10507.94746026265, 10710.410927399067, 10789.676309710721, 10801.945990269998, 53415.19877201923, 55216.0, 56105.71947140238, 56317.43682563122, 57203.71398142983, 69165.88753506205, 69458.30541694518, 74491.0, 80420.0, 83212.58393707992, 13781.0, 13843.515476958259, 13952.511662091778, 14007.579772606838, 14049.297535123407, 15456.690866182838, 15627.609309767347, 15688.215589220721, 15827.446039389028, 15844.920775396049, 14478.855211447752, 14504.709905801614, 14545.545345585551, 14896.32966516531, 15125.773113403087, 14423.711525769635, 14446.32742942559, 14557.781633275297, 14892.32984515721, 14955.102693838404, 14289.928550357181, 14290.499832505813, 14593.343299551758, 14666.633334166305, 15331.003484773453, 11499.942500287445, 11609.709757256136, 11624.128190385924, 11801.409929503663, 12401.069919755873, 10595.80230196328, 10913.890861091606, 11334.376609286568, 12105.576304829288, 12457.06572007085], "value": 7766.0388051106465, "unit": "score"}], "name": "dromaeo_css", "value": 7231.707429154113, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 110.0, 110.0, 111.0, 109.0, 111.0, 110.0, 108.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 118.0, 187.0, 119.0, 117.0, 153.0, 118.0, 151.0, 118.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 162.0, 163.0, 163.0, 164.0, 162.0, 163.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 125.0, 76.0, 76.0, 75.0, 76.0, 108.0, 74.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 124.0, 84.0, 84.0, 84.0, 123.0, 83.0, 83.0, 134.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 96.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 54.0, 50.0, 50.0, 50.0, 51.0, 51.0, 50.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 60.0, 62.0, 60.0, 60.0, 60.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 84.0, 76.0, 75.0, 75.0, 82.0, 76.0, 75.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 120.0, 119.0, 121.0, 119.0, 118.0, 118.0, 128.0, 165.0, 121.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 158.0, 158.0, 161.0, 159.0, 157.0, 157.0, 157.0, 158.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 64.0, 63.0, 67.0, 65.0, 62.0, 63.0, 61.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1479.5, "alertThreshold": 2.0}]} 19:37:44 INFO - Return code: 0 19:37:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:37:44 INFO - # TBPL SUCCESS # 19:37:44 INFO - Running post-action listener: _resource_record_post_action 19:37:44 INFO - [mozharness: 2016-07-31 02:37:44.302022Z] Finished run-tests step (success) 19:37:44 INFO - Running post-run listener: _resource_record_post_run 19:37:44 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 548880384; Read time: 0; Write time: 512316 19:37:44 INFO - TinderboxPrint: CPU usage
13.0% 19:37:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:37:44 INFO - TinderboxPrint: I/O write bytes / time
548,880,384 / 512,316 19:37:44 INFO - TinderboxPrint: CPU idle
8,267.7 (87.0%) 19:37:44 INFO - TinderboxPrint: CPU user
1,193.7 (12.6%) 19:37:44 INFO - TinderboxPrint: Swap in / out
0 / 0 19:37:44 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254136320; Read time: 0; Write time: 257248 19:37:44 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 294154240; Read time: 0; Write time: 254952 19:37:44 INFO - Running post-run listener: _upload_blobber_files 19:37:44 INFO - Blob upload gear active. 19:37:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:37:44 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 19:37:44 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'] 19:37:44 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 19:37:45 INFO - (blobuploader) - INFO - Open directory for files ... 19:37:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:37:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:37:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:46 INFO - (blobuploader) - INFO - Done attempting. 19:37:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:37:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:37:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:46 INFO - (blobuploader) - INFO - Done attempting. 19:37:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:37:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:37:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:50 INFO - (blobuploader) - INFO - Done attempting. 19:37:50 INFO - (blobuploader) - INFO - Iteration through files over. 19:37:50 INFO - Return code: 0 19:37:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:37:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:37:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da8d34046e04e21b8cf908cbc32e4e80961aba2c1e5bfd1bf407801f81a95506d2c6d9f0b34afc6a8fc5ce90af0a7e79698e1337a1d2f83bc7c6183c0b70832a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/569f269ff2363ddf183c763c4c40d08ccfeeb0124e9866e8e763a05df18b1f827076cc0219edeab8c6739185781f261014c3a9ef53fb7be3c94dbaf6e38f0bf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/058fa8130c7d49d2308e418c402b39131fef4f201d639bd7737db7d2ef09328e40f5eb8bf8321722f6bc35b5a16c9cc05bbd3e2e4ad88821c1028118dbeedaf8"} 19:37:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:37:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:37:50 INFO - Contents: 19:37:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da8d34046e04e21b8cf908cbc32e4e80961aba2c1e5bfd1bf407801f81a95506d2c6d9f0b34afc6a8fc5ce90af0a7e79698e1337a1d2f83bc7c6183c0b70832a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/569f269ff2363ddf183c763c4c40d08ccfeeb0124e9866e8e763a05df18b1f827076cc0219edeab8c6739185781f261014c3a9ef53fb7be3c94dbaf6e38f0bf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/058fa8130c7d49d2308e418c402b39131fef4f201d639bd7737db7d2ef09328e40f5eb8bf8321722f6bc35b5a16c9cc05bbd3e2e4ad88821c1028118dbeedaf8"} 19:37:50 INFO - Running post-run listener: copy_logs_to_upload_dir 19:37:50 INFO - Copying logs to upload dir... 19:37:50 INFO - mkdir: /builds/slave/test/build/upload/logs 19:37:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.461835 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-30 19:37:49.664251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 19:37:49.667785) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338 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/da8d34046e04e21b8cf908cbc32e4e80961aba2c1e5bfd1bf407801f81a95506d2c6d9f0b34afc6a8fc5ce90af0a7e79698e1337a1d2f83bc7c6183c0b70832a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/569f269ff2363ddf183c763c4c40d08ccfeeb0124e9866e8e763a05df18b1f827076cc0219edeab8c6739185781f261014c3a9ef53fb7be3c94dbaf6e38f0bf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/058fa8130c7d49d2308e418c402b39131fef4f201d639bd7737db7d2ef09328e40f5eb8bf8321722f6bc35b5a16c9cc05bbd3e2e4ad88821c1028118dbeedaf8"} build_url:https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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/da8d34046e04e21b8cf908cbc32e4e80961aba2c1e5bfd1bf407801f81a95506d2c6d9f0b34afc6a8fc5ce90af0a7e79698e1337a1d2f83bc7c6183c0b70832a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/569f269ff2363ddf183c763c4c40d08ccfeeb0124e9866e8e763a05df18b1f827076cc0219edeab8c6739185781f261014c3a9ef53fb7be3c94dbaf6e38f0bf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/058fa8130c7d49d2308e418c402b39131fef4f201d639bd7737db7d2ef09328e40f5eb8bf8321722f6bc35b5a16c9cc05bbd3e2e4ad88821c1028118dbeedaf8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 19:37:49.693671) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:37:49.694043) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469931378.335421-270541338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:37:49.776562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 19:37:49.776920) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 19:37:49.777253) ========= ========= Total master_lag: 0.18 =========