builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1469661780.25 results: success (0) buildid: 20160727133057 builduid: d64a5afcd967446381ad18ddb0a4ad5d revision: 38583e7686b7a283daf83b30f29eb47bd1fc36a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:00.249483) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:00.250024) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:00.250345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:00.264775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:00.265082) ========= 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=bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 16:23:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.6M=0s 2016-07-27 16:23:00 (37.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074153 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:00.353298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:00.353623) ========= 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=bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016393 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:00.402752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:00.403089) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 38583e7686b7a283daf83b30f29eb47bd1fc36a0 --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 38583e7686b7a283daf83b30f29eb47bd1fc36a0 --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=bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 16:23:00,773 truncating revision to first 12 chars 2016-07-27 16:23:00,773 Setting DEBUG logging. 2016-07-27 16:23:00,773 attempt 1/10 2016-07-27 16:23:00,773 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/38583e7686b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 16:23:01,091 unpacking tar archive at: mozilla-inbound-38583e7686b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681293 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:01.099289) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:01.099607) ========= script_repo_revision: 38583e7686b7a283daf83b30f29eb47bd1fc36a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:01.099983) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:01.100260) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 16:23:01.110475) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-27 16:23:01.110851) ========= /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=bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:23:01 INFO - MultiFileLogger online at 20160727 16:23:01 in /builds/slave/test 16:23:01 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 16:23:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:23:01 INFO - {'append_to_log': False, 16:23:01 INFO - 'base_work_dir': '/builds/slave/test', 16:23:01 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:23:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:23:01 INFO - 'branch': 'Mozilla-Inbound', 16:23:01 INFO - 'buildbot_json_path': 'buildprops.json', 16:23:01 INFO - 'config_files': ('talos/linux_config.py',), 16:23:01 INFO - 'default_actions': ('clobber', 16:23:01 INFO - 'read-buildbot-config', 16:23:01 INFO - 'download-and-extract', 16:23:01 INFO - 'populate-webroot', 16:23:01 INFO - 'create-virtualenv', 16:23:01 INFO - 'install', 16:23:01 INFO - 'run-tests'), 16:23:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:23:01 INFO - 'download_minidump_stackwalk': True, 16:23:01 INFO - 'download_symbols': 'ondemand', 16:23:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:23:01 INFO - 'tooltool.py': '/tools/tooltool.py', 16:23:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:23:01 INFO - '/tools/misc-python/virtualenv.py')}, 16:23:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:23:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:23:01 INFO - 'installer_path': 'installer.exe', 16:23:01 INFO - 'log_level': 'info', 16:23:01 INFO - 'log_name': 'talos', 16:23:01 INFO - 'log_to_console': True, 16:23:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:23:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:23:01 INFO - 'opt_config_files': (), 16:23:01 INFO - 'pip_index': False, 16:23:01 INFO - 'sps_profile': False, 16:23:01 INFO - 'sps_profile_interval': 0, 16:23:01 INFO - 'suite': 'dromaeojs', 16:23:01 INFO - 'system_bits': '32', 16:23:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:23:01 INFO - 'title': 'talos-linux64-ix-055', 16:23:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:23:01 INFO - 'use_talos_json': True, 16:23:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:23:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:23:01 INFO - 'work_dir': 'build'} 16:23:01 INFO - [mozharness: 2016-07-27 23:23:01.563028Z] Running clobber step. 16:23:01 INFO - Running pre-action listener: _resource_record_pre_action 16:23:01 INFO - Running main action method: clobber 16:23:01 INFO - rmtree: /builds/slave/test/build 16:23:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:23:02 INFO - Running post-action listener: _resource_record_post_action 16:23:02 INFO - [mozharness: 2016-07-27 23:23:02.545726Z] Finished clobber step (success) 16:23:02 INFO - [mozharness: 2016-07-27 23:23:02.545838Z] Running read-buildbot-config step. 16:23:02 INFO - Running pre-action listener: _resource_record_pre_action 16:23:02 INFO - Running main action method: read_buildbot_config 16:23:02 INFO - Using buildbot properties: 16:23:02 INFO - { 16:23:02 INFO - "project": "", 16:23:02 INFO - "product": "firefox", 16:23:02 INFO - "script_repo_revision": "production", 16:23:02 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:23:02 INFO - "repository": "", 16:23:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:23:02 INFO - "buildid": "20160727133057", 16:23:02 INFO - "pgo_build": "True", 16:23:02 INFO - "basedir": "/builds/slave/test", 16:23:02 INFO - "buildnumber": 1309, 16:23:02 INFO - "slavename": "talos-linux64-ix-055", 16:23:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:23:02 INFO - "platform": "ubuntu64_hw", 16:23:02 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:23:02 INFO - "branch": "mozilla-inbound", 16:23:02 INFO - "repo_path": "integration/mozilla-inbound", 16:23:02 INFO - "revision": "38583e7686b7a283daf83b30f29eb47bd1fc36a0", 16:23:02 INFO - "stage_platform": "linux64-pgo", 16:23:02 INFO - "builduid": "d64a5afcd967446381ad18ddb0a4ad5d", 16:23:02 INFO - "slavebuilddir": "test" 16:23:02 INFO - } 16:23:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:23:02 INFO - Running post-action listener: _resource_record_post_action 16:23:02 INFO - [mozharness: 2016-07-27 23:23:02.548604Z] Finished read-buildbot-config step (success) 16:23:02 INFO - [mozharness: 2016-07-27 23:23:02.548695Z] Running download-and-extract step. 16:23:02 INFO - Running pre-action listener: _resource_record_pre_action 16:23:02 INFO - Running main action method: download_and_extract 16:23:02 INFO - mkdir: /builds/slave/test/build/tests 16:23:02 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')]} 16:23:02 INFO - https://queue.taskcluster.net/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:23:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:23:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:23:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/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 16:23:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/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 16:23:03 INFO - Downloaded 1361 bytes. 16:23:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:23:03 INFO - Using the following test package requirements: 16:23:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:23:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:23:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:23:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:03 INFO - u'jsshell-linux-x86_64.zip'], 16:23:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:23:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:23:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:23:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:23:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:23:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:23:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:23:03 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')]} 16:23:03 INFO - https://queue.taskcluster.net/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:23:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:23:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:23:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/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 16:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/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 16:23:04 INFO - Downloaded 24321223 bytes. 16:23:04 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'] 16:23:04 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 16:23:05 INFO - Return code: 0 16:23:05 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 16:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:05 INFO - https://queue.taskcluster.net/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:23:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:23:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:23:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/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 16:23:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/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 16:23:06 INFO - Downloaded 24321223 bytes. 16:23:06 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'] 16:23:06 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 16:23:07 INFO - Return code: 0 16:23:08 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')]} 16:23:08 INFO - https://queue.taskcluster.net/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:23:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:23:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:23:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/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 16:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/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 16:23:08 INFO - Downloaded 14413725 bytes. 16:23:08 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'] 16:23:08 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 16:23:09 INFO - Return code: 0 16:23:09 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')]} 16:23:09 INFO - https://queue.taskcluster.net/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:23:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:23:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:23:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/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 16:23:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/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 16:23:10 INFO - Downloaded 60995538 bytes. 16:23:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:23:10 INFO - mkdir: /builds/slave/test/properties 16:23:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:23:10 INFO - Writing to file /builds/slave/test/properties/build_url 16:23:10 INFO - Contents: 16:23:10 INFO - build_url:https://queue.taskcluster.net/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:23:11 INFO - Running post-action listener: _resource_record_post_action 16:23:11 INFO - Running post-action listener: set_extra_try_arguments 16:23:11 INFO - [mozharness: 2016-07-27 23:23:11.384576Z] Finished download-and-extract step (success) 16:23:11 INFO - [mozharness: 2016-07-27 23:23:11.384900Z] Running populate-webroot step. 16:23:11 INFO - Running pre-action listener: _resource_record_pre_action 16:23:11 INFO - Running main action method: populate_webroot 16:23:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:23:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:23:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:23:11 INFO - '--tppagecycles', 16:23:11 INFO - '7'], 16:23:11 INFO - 'tests': ['tsvgm']}}, 16:23:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:23:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:23:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:23:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:23:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:23:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:23:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'talos_options': ['--disable-e10s'], 16:23:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'talos_options': ['--disable-e10s'], 16:23:11 INFO - 'tests': ['damp', 'tps']}, 16:23:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'tests': ['damp', 'tps']}, 16:23:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:23:11 INFO - 'tests': ['dromaeo_dom']}, 16:23:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:23:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:23:11 INFO - 'tests': ['basic_compositor_video']}, 16:23:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:23:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:23:11 INFO - 'tests': ['a11yr', 16:23:11 INFO - 'ts_paint', 16:23:11 INFO - 'tpaint', 16:23:11 INFO - 'sessionrestore', 16:23:11 INFO - 'sessionrestore_no_auto_restore', 16:23:11 INFO - 'tabpaint']}, 16:23:11 INFO - 'other-e10s': {'tests': ['a11yr', 16:23:11 INFO - 'ts_paint', 16:23:11 INFO - 'tpaint', 16:23:11 INFO - 'sessionrestore', 16:23:11 INFO - 'sessionrestore_no_auto_restore', 16:23:11 INFO - 'tabpaint']}, 16:23:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:23:11 INFO - 'ts_paint', 16:23:11 INFO - 'tpaint', 16:23:11 INFO - 'sessionrestore', 16:23:11 INFO - 'sessionrestore_no_auto_restore', 16:23:11 INFO - 'tabpaint']}, 16:23:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:23:11 INFO - 'ts_paint', 16:23:11 INFO - 'tpaint', 16:23:11 INFO - 'sessionrestore', 16:23:11 INFO - 'sessionrestore_no_auto_restore', 16:23:11 INFO - 'tabpaint']}, 16:23:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:23:11 INFO - 'tests': ['a11yr', 16:23:11 INFO - 'ts_paint', 16:23:11 INFO - 'tpaint', 16:23:11 INFO - 'sessionrestore', 16:23:11 INFO - 'sessionrestore_no_auto_restore', 16:23:11 INFO - 'tabpaint']}, 16:23:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:23:11 INFO - 'tests': ['a11yr', 16:23:11 INFO - 'ts_paint', 16:23:11 INFO - 'tpaint', 16:23:11 INFO - 'sessionrestore', 16:23:11 INFO - 'sessionrestore_no_auto_restore', 16:23:11 INFO - 'tabpaint']}, 16:23:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:23:11 INFO - 'tests': ['tsvgx', 16:23:11 INFO - 'tsvgr_opacity', 16:23:11 INFO - 'tart', 16:23:11 INFO - 'tscrollx', 16:23:11 INFO - 'cart']}, 16:23:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:23:11 INFO - 'tsvgr_opacity', 16:23:11 INFO - 'tart', 16:23:11 INFO - 'tscrollx', 16:23:11 INFO - 'cart']}, 16:23:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'talos_options': ['--disable-e10s'], 16:23:11 INFO - 'tests': ['tp5o']}, 16:23:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'tests': ['tp5o']}, 16:23:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'talos_options': ['--disable-e10s', 16:23:11 INFO - '--xperf_path', 16:23:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:11 INFO - 'tests': ['tp5n']}, 16:23:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'talos_options': ['--xperf_path', 16:23:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:11 INFO - 'tests': ['tp5n']}}, 16:23:11 INFO - 'talos.zip': {'path': '', 16:23:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:23:11 INFO - Running post-action listener: _resource_record_post_action 16:23:11 INFO - [mozharness: 2016-07-27 23:23:11.402025Z] Finished populate-webroot step (success) 16:23:11 INFO - [mozharness: 2016-07-27 23:23:11.402115Z] Running create-virtualenv step. 16:23:11 INFO - Running pre-action listener: _resource_record_pre_action 16:23:11 INFO - Running main action method: create_virtualenv 16:23:11 INFO - Creating virtualenv /builds/slave/test/build/venv 16:23:11 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 16:23:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:23:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:23:11 INFO - Using real prefix '/usr' 16:23:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:23:12 INFO - Installing distribute.............................................................................................................................................................................................done. 16:23:13 INFO - Installing pip.................done. 16:23:13 INFO - Return code: 0 16:23:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:23:13 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')]} 16:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:13 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')]} 16:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:13 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 0x10bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137b3b0>, '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 0x137c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137c740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', '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 16:23:13 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 16:23:13 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 16:23:14 INFO - Using env: {'DISPLAY': ':0', 16:23:14 INFO - 'HOME': '/home/cltbld', 16:23:14 INFO - 'LANG': 'en_US.UTF-8', 16:23:14 INFO - 'LANGUAGE': 'en_US:en', 16:23:14 INFO - 'LOGNAME': 'cltbld', 16:23:14 INFO - 'MAIL': '/var/mail/cltbld', 16:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:14 INFO - 'MOZ_NO_REMOTE': '1', 16:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:14 INFO - 'NO_EM_RESTART': '1', 16:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:14 INFO - 'PWD': '/builds/slave/test', 16:23:14 INFO - 'SHELL': '/bin/bash', 16:23:14 INFO - 'SHLVL': '1', 16:23:14 INFO - 'TERM': 'linux', 16:23:14 INFO - 'TMOUT': '86400', 16:23:14 INFO - 'USER': 'cltbld', 16:23:14 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', 16:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:14 INFO - '_': '/tools/buildbot/bin/python'} 16:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:14 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 16:23:14 INFO - Cleaning up... 16:23:14 INFO - Return code: 0 16:23:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:23: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')]} 16:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23: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')]} 16:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x10bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137b3b0>, '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 0x137c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137c740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', '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 16:23:14 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 16:23:14 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 16:23:14 INFO - Using env: {'DISPLAY': ':0', 16:23:14 INFO - 'HOME': '/home/cltbld', 16:23:14 INFO - 'LANG': 'en_US.UTF-8', 16:23:14 INFO - 'LANGUAGE': 'en_US:en', 16:23:14 INFO - 'LOGNAME': 'cltbld', 16:23:14 INFO - 'MAIL': '/var/mail/cltbld', 16:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:14 INFO - 'MOZ_NO_REMOTE': '1', 16:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:14 INFO - 'NO_EM_RESTART': '1', 16:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:14 INFO - 'PWD': '/builds/slave/test', 16:23:14 INFO - 'SHELL': '/bin/bash', 16:23:14 INFO - 'SHLVL': '1', 16:23:14 INFO - 'TERM': 'linux', 16:23:14 INFO - 'TMOUT': '86400', 16:23:14 INFO - 'USER': 'cltbld', 16:23:14 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', 16:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:14 INFO - '_': '/tools/buildbot/bin/python'} 16:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:14 INFO - Downloading/unpacking psutil>=3.1.1 16:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:14 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 16:23:14 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 16:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:23:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:16 INFO - Installing collected packages: psutil 16:23:16 INFO - Running setup.py install for psutil 16:23:16 INFO - building 'psutil._psutil_linux' extension 16:23:16 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 16:23:16 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 16:23:16 INFO - building 'psutil._psutil_posix' extension 16:23:16 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 16:23:16 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 16:23:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:16 INFO - Successfully installed psutil 16:23:16 INFO - Cleaning up... 16:23:16 INFO - Return code: 0 16:23:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:23:16 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')]} 16:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:16 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')]} 16:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:16 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 0x10bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137b3b0>, '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 0x137c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137c740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', '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 16:23:16 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 16:23:16 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 16:23:16 INFO - Using env: {'DISPLAY': ':0', 16:23:16 INFO - 'HOME': '/home/cltbld', 16:23:16 INFO - 'LANG': 'en_US.UTF-8', 16:23:16 INFO - 'LANGUAGE': 'en_US:en', 16:23:16 INFO - 'LOGNAME': 'cltbld', 16:23:16 INFO - 'MAIL': '/var/mail/cltbld', 16:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:16 INFO - 'MOZ_NO_REMOTE': '1', 16:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:16 INFO - 'NO_EM_RESTART': '1', 16:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:16 INFO - 'PWD': '/builds/slave/test', 16:23:16 INFO - 'SHELL': '/bin/bash', 16:23:16 INFO - 'SHLVL': '1', 16:23:16 INFO - 'TERM': 'linux', 16:23:16 INFO - 'TMOUT': '86400', 16:23:16 INFO - 'USER': 'cltbld', 16:23:16 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', 16:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:16 INFO - '_': '/tools/buildbot/bin/python'} 16:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:23:17 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 16:23:17 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 16:23:17 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 16:23:17 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 16:23:17 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 16:23:17 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 16:23:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:23:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:23:19 INFO - Installing collected packages: mozsystemmonitor 16:23:19 INFO - Running setup.py install for mozsystemmonitor 16:23:19 INFO - Successfully installed mozsystemmonitor 16:23:19 INFO - Cleaning up... 16:23:19 INFO - Return code: 0 16:23:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:23:19 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')]} 16:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:19 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')]} 16:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:19 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 0x10bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137b3b0>, '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 0x137c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137c740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', '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 16:23:19 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 16:23:19 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 16:23:19 INFO - Using env: {'DISPLAY': ':0', 16:23:19 INFO - 'HOME': '/home/cltbld', 16:23:19 INFO - 'LANG': 'en_US.UTF-8', 16:23:19 INFO - 'LANGUAGE': 'en_US:en', 16:23:19 INFO - 'LOGNAME': 'cltbld', 16:23:19 INFO - 'MAIL': '/var/mail/cltbld', 16:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:19 INFO - 'MOZ_NO_REMOTE': '1', 16:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:19 INFO - 'NO_EM_RESTART': '1', 16:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:19 INFO - 'PWD': '/builds/slave/test', 16:23:19 INFO - 'SHELL': '/bin/bash', 16:23:19 INFO - 'SHLVL': '1', 16:23:19 INFO - 'TERM': 'linux', 16:23:19 INFO - 'TMOUT': '86400', 16:23:19 INFO - 'USER': 'cltbld', 16:23:19 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', 16:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:19 INFO - '_': '/tools/buildbot/bin/python'} 16:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:19 INFO - Downloading/unpacking jsonschema==2.5.1 16:23:19 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 16:23:19 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 16:23:19 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 16:23:19 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 16:23:19 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 16:23:19 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 16:23:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:23:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:21 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 16:23:21 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 16:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:21 INFO - Downloading functools32-3.2.3-2.tar.gz 16:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:23:21 INFO - warning: no files found matching '*.txt' 16:23:21 INFO - no previously-included directories found matching 'build' 16:23:21 INFO - no previously-included directories found matching 'dist' 16:23:21 INFO - no previously-included directories found matching '.git*' 16:23:21 INFO - Installing collected packages: jsonschema, functools32 16:23:21 INFO - Running setup.py install for functools32 16:23:21 INFO - warning: no files found matching '*.txt' 16:23:21 INFO - no previously-included directories found matching 'build' 16:23:21 INFO - no previously-included directories found matching 'dist' 16:23:21 INFO - no previously-included directories found matching '.git*' 16:23:21 INFO - Successfully installed jsonschema functools32 16:23:21 INFO - Cleaning up... 16:23:21 INFO - Return code: 0 16:23:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:23:21 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')]} 16:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:21 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')]} 16:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:21 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 0x10bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137b3b0>, '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 0x137c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137c740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', '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 16:23:21 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 16:23:21 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 16:23:21 INFO - Using env: {'DISPLAY': ':0', 16:23:21 INFO - 'HOME': '/home/cltbld', 16:23:21 INFO - 'LANG': 'en_US.UTF-8', 16:23:21 INFO - 'LANGUAGE': 'en_US:en', 16:23:21 INFO - 'LOGNAME': 'cltbld', 16:23:21 INFO - 'MAIL': '/var/mail/cltbld', 16:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:21 INFO - 'MOZ_NO_REMOTE': '1', 16:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:21 INFO - 'NO_EM_RESTART': '1', 16:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:21 INFO - 'PWD': '/builds/slave/test', 16:23:21 INFO - 'SHELL': '/bin/bash', 16:23:21 INFO - 'SHLVL': '1', 16:23:21 INFO - 'TERM': 'linux', 16:23:21 INFO - 'TMOUT': '86400', 16:23:21 INFO - 'USER': 'cltbld', 16:23:21 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', 16:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:21 INFO - '_': '/tools/buildbot/bin/python'} 16:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:23:22 INFO - Cleaning up... 16:23:22 INFO - Return code: 0 16:23:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:22 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 0x10bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137b3b0>, '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 0x137c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137c740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', '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 16:23:22 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 16:23:22 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 16:23:22 INFO - Using env: {'DISPLAY': ':0', 16:23:22 INFO - 'HOME': '/home/cltbld', 16:23:22 INFO - 'LANG': 'en_US.UTF-8', 16:23:22 INFO - 'LANGUAGE': 'en_US:en', 16:23:22 INFO - 'LOGNAME': 'cltbld', 16:23:22 INFO - 'MAIL': '/var/mail/cltbld', 16:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:22 INFO - 'MOZ_NO_REMOTE': '1', 16:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:22 INFO - 'NO_EM_RESTART': '1', 16:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:22 INFO - 'PWD': '/builds/slave/test', 16:23:22 INFO - 'SHELL': '/bin/bash', 16:23:22 INFO - 'SHLVL': '1', 16:23:22 INFO - 'TERM': 'linux', 16:23:22 INFO - 'TMOUT': '86400', 16:23:22 INFO - 'USER': 'cltbld', 16:23:22 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', 16:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:22 INFO - '_': '/tools/buildbot/bin/python'} 16:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:22 INFO - Downloading/unpacking blobuploader==1.2.4 16:23:22 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 16:23:22 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 16:23:22 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 16:23:22 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 16:23:22 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 16:23:22 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 16:23:24 INFO - Downloading blobuploader-1.2.4.tar.gz 16:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:23:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:23:24 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 16:23:24 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 16:23:24 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 16:23:24 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 16:23:24 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 16:23:24 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 16:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:23:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:23:24 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 16:23:24 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 16:23:24 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 16:23:24 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 16:23:24 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 16:23:24 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 16:23:25 INFO - Downloading docopt-0.6.1.tar.gz 16:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:23:25 INFO - Installing collected packages: blobuploader, requests, docopt 16:23:25 INFO - Running setup.py install for blobuploader 16:23:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:23:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:23:25 INFO - Running setup.py install for requests 16:23:25 INFO - Running setup.py install for docopt 16:23:25 INFO - Successfully installed blobuploader requests docopt 16:23:25 INFO - Cleaning up... 16:23:25 INFO - Return code: 0 16:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:25 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')]} 16:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:25 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')]} 16:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:25 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 0x10bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137b3b0>, '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 0x137c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137c740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', '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 16:23:25 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 16:23:25 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 16:23:25 INFO - Using env: {'DISPLAY': ':0', 16:23:25 INFO - 'HOME': '/home/cltbld', 16:23:25 INFO - 'LANG': 'en_US.UTF-8', 16:23:25 INFO - 'LANGUAGE': 'en_US:en', 16:23:25 INFO - 'LOGNAME': 'cltbld', 16:23:25 INFO - 'MAIL': '/var/mail/cltbld', 16:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:25 INFO - 'MOZ_NO_REMOTE': '1', 16:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:25 INFO - 'NO_EM_RESTART': '1', 16:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:25 INFO - 'PWD': '/builds/slave/test', 16:23:25 INFO - 'SHELL': '/bin/bash', 16:23:25 INFO - 'SHLVL': '1', 16:23:25 INFO - 'TERM': 'linux', 16:23:25 INFO - 'TMOUT': '86400', 16:23:25 INFO - 'USER': 'cltbld', 16:23:25 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', 16:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:25 INFO - '_': '/tools/buildbot/bin/python'} 16:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:25 INFO - Running setup.py (path:/tmp/pip-6FkXQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:26 INFO - Running setup.py (path:/tmp/pip-kN_aps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:26 INFO - Running setup.py (path:/tmp/pip-tbNqOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:26 INFO - Running setup.py (path:/tmp/pip-hxfj8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:26 INFO - Running setup.py (path:/tmp/pip-TasflO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:26 INFO - Running setup.py (path:/tmp/pip-RGWNlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:26 INFO - Running setup.py (path:/tmp/pip-eCUA6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:26 INFO - Running setup.py (path:/tmp/pip-3pxEZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:26 INFO - Running setup.py (path:/tmp/pip-m0z_hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:26 INFO - Running setup.py (path:/tmp/pip-hYxLUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:26 INFO - Running setup.py (path:/tmp/pip-s1mbn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:26 INFO - Running setup.py (path:/tmp/pip-1lCtnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:26 INFO - Running setup.py (path:/tmp/pip-ybPlyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:26 INFO - Running setup.py (path:/tmp/pip-q2DaEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:26 INFO - Running setup.py (path:/tmp/pip-a3EJj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:27 INFO - Running setup.py (path:/tmp/pip-QeJJ2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:27 INFO - Running setup.py (path:/tmp/pip-cceRi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:23:27 INFO - Running setup.py install for manifestparser 16:23:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:23:27 INFO - Running setup.py install for mozcrash 16:23:27 INFO - Running setup.py install for mozdebug 16:23:27 INFO - Running setup.py install for mozdevice 16:23:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:23:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:23:27 INFO - Running setup.py install for mozfile 16:23:27 INFO - Running setup.py install for mozhttpd 16:23:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:23:27 INFO - Running setup.py install for mozinfo 16:23:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:23:27 INFO - Running setup.py install for mozInstall 16:23:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:23:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:23:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:23:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:23:27 INFO - Running setup.py install for mozleak 16:23:28 INFO - Running setup.py install for mozlog 16:23:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Running setup.py install for moznetwork 16:23:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Running setup.py install for mozprocess 16:23:28 INFO - Running setup.py install for mozprofile 16:23:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Running setup.py install for mozrunner 16:23:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Running setup.py install for mozscreenshot 16:23:28 INFO - Running setup.py install for moztest 16:23:28 INFO - Running setup.py install for mozversion 16:23:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:23:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:23:28 INFO - Cleaning up... 16:23:28 INFO - Return code: 0 16:23:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23: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')]} 16:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23: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')]} 16:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:28 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 0x10bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137b3b0>, '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 0x137c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137c740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', '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 16:23:28 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 16:23:28 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 16:23:28 INFO - Using env: {'DISPLAY': ':0', 16:23:28 INFO - 'HOME': '/home/cltbld', 16:23:28 INFO - 'LANG': 'en_US.UTF-8', 16:23:28 INFO - 'LANGUAGE': 'en_US:en', 16:23:28 INFO - 'LOGNAME': 'cltbld', 16:23:28 INFO - 'MAIL': '/var/mail/cltbld', 16:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:28 INFO - 'MOZ_NO_REMOTE': '1', 16:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:28 INFO - 'NO_EM_RESTART': '1', 16:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:28 INFO - 'PWD': '/builds/slave/test', 16:23:28 INFO - 'SHELL': '/bin/bash', 16:23:28 INFO - 'SHLVL': '1', 16:23:28 INFO - 'TERM': 'linux', 16:23:29 INFO - 'TMOUT': '86400', 16:23:29 INFO - 'USER': 'cltbld', 16:23:29 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', 16:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:29 INFO - '_': '/tools/buildbot/bin/python'} 16:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:29 INFO - Running setup.py (path:/tmp/pip-LzpYuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:29 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)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:29 INFO - Running setup.py (path:/tmp/pip-x7Y0JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:29 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)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:29 INFO - Running setup.py (path:/tmp/pip-4Efq_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:29 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)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:29 INFO - Running setup.py (path:/tmp/pip-5pkNa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:29 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)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:29 INFO - Running setup.py (path:/tmp/pip-qW0qSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:29 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)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:29 INFO - Running setup.py (path:/tmp/pip-0_Ginz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:29 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)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:29 INFO - Running setup.py (path:/tmp/pip-IBpj_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:29 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)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:29 INFO - Running setup.py (path:/tmp/pip-zk5OoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:29 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)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:29 INFO - Running setup.py (path:/tmp/pip-8B_uF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:29 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)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:29 INFO - Running setup.py (path:/tmp/pip-q4Zgo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:29 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)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:29 INFO - Running setup.py (path:/tmp/pip-Zbpkzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:29 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)) 16:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:30 INFO - Running setup.py (path:/tmp/pip-oIhB9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:30 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)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:30 INFO - Running setup.py (path:/tmp/pip-AziUe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:30 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)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:30 INFO - Running setup.py (path:/tmp/pip-gdFBH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:30 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)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:30 INFO - Running setup.py (path:/tmp/pip-bOECKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:30 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)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:30 INFO - Running setup.py (path:/tmp/pip-wYqV3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:30 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)) 16:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:30 INFO - Running setup.py (path:/tmp/pip-iwcyjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:30 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)) 16:23:30 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)) 16:23:30 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)) 16:23:30 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)) 16:23:30 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)) 16:23:30 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)) 16:23:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:23:30 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 16:23:30 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 16:23:30 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 16:23:30 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 16:23:30 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 16:23:30 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 16:23:32 INFO - Downloading blessings-1.6.tar.gz 16:23:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:23:32 INFO - Installing collected packages: blessings 16:23:32 INFO - Running setup.py install for blessings 16:23:32 INFO - Successfully installed blessings 16:23:32 INFO - Cleaning up... 16:23:32 INFO - Return code: 0 16:23:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:32 INFO - Reading from file tmpfile_stdout 16:23:32 INFO - Current package versions: 16:23:32 INFO - argparse == 1.2.1 16:23:32 INFO - blessings == 1.6 16:23:32 INFO - blobuploader == 1.2.4 16:23:32 INFO - docopt == 0.6.1 16:23:32 INFO - functools32 == 3.2.3-2 16:23:32 INFO - jsonschema == 2.5.1 16:23:32 INFO - manifestparser == 1.1 16:23:32 INFO - mozInstall == 1.12 16:23:32 INFO - mozcrash == 0.17 16:23:32 INFO - mozdebug == 0.1 16:23:32 INFO - mozdevice == 0.48 16:23:32 INFO - mozfile == 1.2 16:23:32 INFO - mozhttpd == 0.7 16:23:32 INFO - mozinfo == 0.9 16:23:32 INFO - mozleak == 0.1 16:23:32 INFO - mozlog == 3.3 16:23:32 INFO - moznetwork == 0.27 16:23:32 INFO - mozprocess == 0.23 16:23:32 INFO - mozprofile == 0.28 16:23:32 INFO - mozrunner == 6.12 16:23:32 INFO - mozscreenshot == 0.1 16:23:32 INFO - mozsystemmonitor == 0.3 16:23:32 INFO - moztest == 0.7 16:23:32 INFO - mozversion == 1.4 16:23:32 INFO - psutil == 3.1.1 16:23:32 INFO - requests == 1.2.3 16:23:32 INFO - wsgiref == 0.1.2 16:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:32 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 0x10bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137b3b0>, '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 0x137c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137c740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', '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 16:23:32 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 16:23:32 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 16:23:32 INFO - Using env: {'DISPLAY': ':0', 16:23:32 INFO - 'HOME': '/home/cltbld', 16:23:32 INFO - 'LANG': 'en_US.UTF-8', 16:23:32 INFO - 'LANGUAGE': 'en_US:en', 16:23:32 INFO - 'LOGNAME': 'cltbld', 16:23:32 INFO - 'MAIL': '/var/mail/cltbld', 16:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:32 INFO - 'MOZ_NO_REMOTE': '1', 16:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:32 INFO - 'NO_EM_RESTART': '1', 16:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:32 INFO - 'PWD': '/builds/slave/test', 16:23:32 INFO - 'SHELL': '/bin/bash', 16:23:32 INFO - 'SHLVL': '1', 16:23:32 INFO - 'TERM': 'linux', 16:23:32 INFO - 'TMOUT': '86400', 16:23:32 INFO - 'USER': 'cltbld', 16:23:32 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', 16:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:32 INFO - '_': '/tools/buildbot/bin/python'} 16:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:32 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)) 16:23:32 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)) 16:23:32 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)) 16:23:32 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)) 16:23:32 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)) 16:23:32 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)) 16:23:32 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)) 16:23:32 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)) 16:23:32 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)) 16:23:32 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)) 16:23:32 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)) 16:23:32 INFO - Cleaning up... 16:23:33 INFO - Return code: 0 16:23:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:23:33 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')]} 16:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:33 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')]} 16:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:33 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 0x10bc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137b3b0>, '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 0x137c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137c740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', '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 16:23:33 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 16:23:33 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 16:23:33 INFO - Using env: {'DISPLAY': ':0', 16:23:33 INFO - 'HOME': '/home/cltbld', 16:23:33 INFO - 'LANG': 'en_US.UTF-8', 16:23:33 INFO - 'LANGUAGE': 'en_US:en', 16:23:33 INFO - 'LOGNAME': 'cltbld', 16:23:33 INFO - 'MAIL': '/var/mail/cltbld', 16:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:33 INFO - 'MOZ_NO_REMOTE': '1', 16:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:33 INFO - 'NO_EM_RESTART': '1', 16:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:33 INFO - 'PWD': '/builds/slave/test', 16:23:33 INFO - 'SHELL': '/bin/bash', 16:23:33 INFO - 'SHLVL': '1', 16:23:33 INFO - 'TERM': 'linux', 16:23:33 INFO - 'TMOUT': '86400', 16:23:33 INFO - 'USER': 'cltbld', 16:23:33 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', 16:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:33 INFO - '_': '/tools/buildbot/bin/python'} 16:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:23:33 INFO - Cleaning up... 16:23:33 INFO - Return code: 0 16:23:33 INFO - Running post-action listener: _resource_record_post_action 16:23:33 INFO - Running post-action listener: _start_resource_monitoring 16:23:33 INFO - Starting resource monitoring. 16:23:33 INFO - [mozharness: 2016-07-27 23:23:33.246342Z] Finished create-virtualenv step (success) 16:23:33 INFO - [mozharness: 2016-07-27 23:23:33.246826Z] Running install step. 16:23:33 INFO - Running pre-action listener: _resource_record_pre_action 16:23:33 INFO - Running main action method: install 16:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:33 INFO - Reading from file tmpfile_stdout 16:23:33 INFO - Detecting whether we're running mozinstall >=1.0... 16:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:23:33 INFO - Reading from file tmpfile_stdout 16:23:33 INFO - Output received: 16:23:33 INFO - Usage: mozinstall [options] installer 16:23:33 INFO - Options: 16:23:33 INFO - -h, --help show this help message and exit 16:23:33 INFO - -d DEST, --destination=DEST 16:23:33 INFO - Directory to install application into. [default: 16:23:33 INFO - "/builds/slave/test"] 16:23:33 INFO - --app=APP Application being installed. [default: firefox] 16:23:33 INFO - mkdir: /builds/slave/test/build/application 16:23:33 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'] 16:23:33 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 16:23:50 INFO - Reading from file tmpfile_stdout 16:23:50 INFO - Output received: 16:23:50 INFO - /builds/slave/test/build/application/firefox/firefox 16:23:50 INFO - Running post-action listener: _resource_record_post_action 16:23:50 INFO - [mozharness: 2016-07-27 23:23:50.844129Z] Finished install step (success) 16:23:50 INFO - [mozharness: 2016-07-27 23:23:50.844378Z] Running run-tests step. 16:23:50 INFO - Running pre-action listener: _resource_record_pre_action 16:23:50 INFO - Running main action method: run_tests 16:23:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:23:50 INFO - Python 2.7.3 16:23:50 INFO - Return code: 0 16:23:50 INFO - grabbing minidump binary from tooltool 16:23:50 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')]} 16:23:50 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 0x137b3b0>, '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 0x137c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:23:50 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 16:23:50 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 16:23:50 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 16:23:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:23:50 INFO - Return code: 0 16:23:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:23:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:23:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:23:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:23:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:23:50 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/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 16:23:50 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/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 16:23:50 INFO - Using env: {'DISPLAY': ':0', 16:23:50 INFO - 'HOME': '/home/cltbld', 16:23:50 INFO - 'LANG': 'en_US.UTF-8', 16:23:50 INFO - 'LANGUAGE': 'en_US:en', 16:23:50 INFO - 'LOGNAME': 'cltbld', 16:23:50 INFO - 'MAIL': '/var/mail/cltbld', 16:23:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:23:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:50 INFO - 'MOZ_NO_REMOTE': '1', 16:23:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:50 INFO - 'NO_EM_RESTART': '1', 16:23:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:50 INFO - 'PWD': '/builds/slave/test', 16:23:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:23:50 INFO - 'SHELL': '/bin/bash', 16:23:50 INFO - 'SHLVL': '1', 16:23:50 INFO - 'TERM': 'linux', 16:23:50 INFO - 'TMOUT': '86400', 16:23:50 INFO - 'USER': 'cltbld', 16:23:50 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447', 16:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:50 INFO - '_': '/tools/buildbot/bin/python'} 16:23:50 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/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 16:23:51 INFO - mozversion application_buildid: 20160727133057 16:23:51 INFO - mozversion application_changeset: 38583e7686b7a283daf83b30f29eb47bd1fc36a0 16:23:51 INFO - mozversion application_display_name: Nightly 16:23:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:23:51 INFO - mozversion application_name: Firefox 16:23:51 INFO - mozversion application_remotingname: firefox 16:23:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:23:51 INFO - mozversion application_vendor: Mozilla 16:23:51 INFO - mozversion application_version: 50.0a1 16:23:51 INFO - mozversion platform_buildid: 20160727133057 16:23:51 INFO - mozversion platform_changeset: 38583e7686b7a283daf83b30f29eb47bd1fc36a0 16:23:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:23:51 INFO - mozversion platform_version: 50.0a1 16:23:51 INFO - using testdate: 1469661831 16:23:51 INFO - actual date: 1469661831 16:23:51 INFO - starting webserver on 'localhost:60858' 16:23:51 INFO - SUITE-START | Running 2 tests 16:23:51 INFO - TEST-START | dromaeo_css 16:23:51 INFO - operating with platform_type : linux_ 16:23:51 INFO - Initialising browser for dromaeo_css test... 16:23:51 INFO - TEST-INFO | started process 4178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEJfddx/profile http://localhost:60858/getInfo.html) 16:23:54 INFO - PROCESS | 4178 | JavaScript error: , line 0: uncaught exception: undefined 16:23:55 INFO - PROCESS | 4178 | __metrics Screen width/height:1600/1200 16:23:55 INFO - PROCESS | 4178 | colorDepth:24 16:23:55 INFO - PROCESS | 4178 | Browser inner width/height: 1024/697 16:23:55 INFO - PROCESS | 4178 | __metrics 16:23:55 INFO - PROCESS | 4178 | 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" 16:23:55 INFO - PROCESS | 4178 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:23:56 INFO - TEST-INFO | 4178: exit 0 16:23:56 INFO - Browser initialized. 16:23:56 INFO - Running cycle 1/1 for dromaeo_css test... 16:23:56 INFO - TEST-INFO | started process 4256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEJfddx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:24:08 INFO - PROCESS | 4256 | RSS: Main: 158003200 16:24:08 INFO - PROCESS | 4256 | 16:24:59 INFO - PROCESS | 4256 | 1469661899418 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] 16:27:08 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:60858/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60858/tests/dromaeo/cssquery-ext.html) 16:27:09 INFO - PROCESS | 4256 | RSS: Main: 260202496 16:27:09 INFO - PROCESS | 4256 | 16:30:11 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:60858/tests/dromaeo/cssquery-ext.html (next: http://localhost:60858/tests/dromaeo/cssquery-jquery.html) 16:30:12 INFO - PROCESS | 4256 | RSS: Main: 248717312 16:30:12 INFO - PROCESS | 4256 | 16:33:14 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:60858/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60858/tests/dromaeo/cssquery-mootools.html) 16:33:15 INFO - PROCESS | 4256 | RSS: Main: 187916288 16:33:15 INFO - PROCESS | 4256 | 16:36:17 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:60858/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60858/tests/dromaeo/cssquery-prototype.html) 16:36:17 INFO - PROCESS | 4256 | RSS: Main: 231636992 16:36:17 INFO - PROCESS | 4256 | 16:39:20 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:60858/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60858/tests/dromaeo/cssquery-yui.html) 16:39:20 INFO - PROCESS | 4256 | RSS: Main: 186859520 16:39:20 INFO - PROCESS | 4256 | 16:42:23 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:60858/tests/dromaeo/cssquery-yui.html (next: http://localhost:60858/tests/dromaeo/cssquery-dojo.html) 16:42:23 INFO - PROCESS | 4256 | RSS: Main: 284790784 16:42:23 INFO - PROCESS | 4256 | 16:42:23 INFO - PROCESS | 4256 | __start_tp_report 16:42:23 INFO - PROCESS | 4256 | _x_x_mozilla_page_load 16:42:23 INFO - PROCESS | 4256 | _x_x_mozilla_page_load_details 16:42:23 INFO - PROCESS | 4256 | |i|pagename|runs| 16:42:23 INFO - PROCESS | 4256 | |0;dojo.html;3013.3370658455146;3028.5002974509202;3042.5740396344518;3049.801762885411;3074.062410964655;5147.588192944565;5204.375474943003;5230.476952304768;5295.629305948585;5305.363356397233;5321.840344789663;5348.438413966526;5392.0294347017525;5406.621536492447;5441.646292990953;4865.635077369194;4869.220924652056;4951.950480495185;4958.826441074563;5108.131617625013;5020.3724534433195;5056.797728090872;5062.949370506285;5063.924041139386;5076.390833100015;4781.6891902026255;4799.664023518355;4926.630502712311;4948.777305021283;4982.526659967298;4823.903521929542;4848.17581011229;4861.270809378586;5008.474110218447;5016.3980322361185;4891.388576427947;4908.533689299511;4912.950870491285;4923.138450771136;4955.628327875424;5197.0385478686185;5298.205269209611;5405;5441.782328706847;5443.618946673734;5706.3152421709665;5784.913226301609;5787.565932555033;5800.10098434739;5800.796972105998;5781.219535362757;5801.216835727208;5810.1865738796605;5837.182794408786;5864;5130.589552835764;5309.203619457112;5365.839024829262;5387.757550910218;5426.782928682848;5941.049432090931;5944.078667806497;5957.4042595740075;5959.4934430573885;5960.195373624592;5687.317521897398;5697.544196464356;5701.971490142523;5704.258446401941;5704.4295570443455;5557.166425036277;5605;5682.431756824284;5772.826815195551;5792.4497172768515;5686.886262274731;5694.316681998187;5699.458551437607;5724.799632012943;5751.769929202785;5662.405447428043;5690.658560486384;5703.62926409782;5705.286839145107;5710.400407957188;4295.463067116611;4346.1090476452255;4353.542877997765;4355.73865568067;4362.083962367875;3888.6111388860886;3924.4505769192338;3943.664788492953;3953.0512676957896;3988.1824226033596;5455.890882182334;5463.426340234298;5466.453354664502;5469.890602187934;5481.561475082063;5514.007478653801;5737.139429085671;5780.768769249267;5783.8554036149435;5815.941840581625;5449.863753406196;5489.066858634042;5497.697626630494;5537.003339398866;5554;4967.08108999829;4968.652194346361;4972.5276098770555;4973.154563724175;5017.899642007213;5810.622309549865;5856.619319744203;5938.49522790559;6004.249468816398;6010.579259451796;5673.716314184357;5753.798617048383;5788.594798364074;5790.10253410722;5797.449242321973;5885.941140588539;5903.645781253139;5904.911426328523;5910.881782364243;5933.762649494144;5487;5493.642913210629;5502.174673798962;5550.139728342114;5550.4449555044175;5689.2319536862;5758.452946970031;5771.192033115283;5822.592418530831;5861.472467477947;5612.7754889803955;5649.039663257174;5661.264035675335;5666.631668941671;5667.4615911488345;5487.670739755627;5643.068893632505;5646.265985421869;5650.0959846424375;5666.9716651416475;5501.4223506532835;5528;5540.445955404427;5587.161925711013;5608.943910560843;5587.552995760248;5605.187247848958;5645.463680950304;5649.406812284816;5653.660780353192;5336.359636843604;5513.09034009384;5518.86202844916;5526.585506086979;5541.307336582927 16:42:23 INFO - PROCESS | 4256 | |1;ext.html;592.3780030967483;595.4373117404052;609.7865746988557;619.4734475695659;633.8573820890299;31022.53466198006;43347.34978975318;44583;44644.77677611607;44710.32934505985;46125.769371153096;46447.53552464474;46546.30180547295;46553.53446465534;46574.53425465745;8939.195472407482;9083.454992700426;9084.454932704026;9086.86369704455;9096.454212747256;8902.465852048897;8961.775955601097;8996.235319997808;9000.684976025841;9006.504642244674;9020.639174433014;9055.230305424015;9075.273978081737;9076.500792456412;9077.36458447909;8921.197092261662;8945.73162805117;8975.237104846095;8985.820283594358;8995.730128096167;8764.211220990077;8864.55677216143;8864.867026994536;8869.866951995726;8870.2016818486;43928.3410748839;43991.340129898075;44130;44233;44318;3291.769576129672;3409.9147521311916;3644.362236608583;3851.5955824638568;3859.671927886133;33184.3363132736;33522.6647733522;33906.660933390594;34526;35042.47436288432;3976.9602303977167;3990.3016972029777;4015.437838702584;4015.9397609035886;4072.1041370898356;349293;351700;352061;353181;353913.23043384874;33946.49080263748;35096;35116.82441587776;59079;59441.10838337428;36816.44775328372;36874;36949.44575831365;36994.26011479755;37083.62916370856;13847.861521384859;13887.305634718223;13905.930470347786;13907.165570065828;13913.234772087633;12176.269423834598;12184.329861857506;12201.45093470796;12207.389630518439;12210.389480526115;8347.29048030912;8350;8364.330853531703;8419.368547358972;8444.493330400195;3227.580414546094;3243.497257925025;3280.7867488613165;3325.48454989477;3335.216224187314;973.8928717841031;1058.7088550648634;1123.6572845282267;1154.4227886056972;1174.0548858169086;32898.50652240218;33251.83374083114;33724.49413258803;33802.32395352079;34036.31927361439;1086.223350304536;1087.8912108789057;1092.2736380307165;1095.8465814785936;1097.078454098545;16895.577610559834;17353.652926941642;17507.299708011793;17815.821841781675;17880.55298617519;582388;586941;587350;588580;589056;59625.70187149037;59766;60160.39839601635;60351.39648603545;60384.396156037874;1241.30486927321;1287.9889286909731;1342.2483409291024;1353.7157196988546;1357.1178733823094;29847.70152298536;34092.488612671325;34312.313753725284;34332.82833585816;34539;51932;52417;52530;52592.47407526029;52704;408365;410120;411121;411182;411318;25219.991200351782;27849.582256265767;28643.856780715963;28782.424351513273;29073.85463072671;48900.5109948896;49288;49451.258231125845;49474.50525494699;49490;42193.36709949292;43098.353524696526;43387.78306108449;43530;44272.55727442684;42880.57119428766;43931;44354.55645443634;44702.552974469836;44781;43124;43767.78116109399;43932.121357573305;43991;44121.338179926686;35625.643743562236;37737;38962.6103738959;39069.218615628095;39416.80291598524;29191.708082919748;29288.414231715673;29312.43001119821;29383.412331752817;29574.556381654722 16:42:23 INFO - PROCESS | 4256 | |2;jquery.html;363.92539529396475;365.40074278183783;373.6543697080201;378.7046104038847;381.36312358361533;18815.905920470395;20156;20273.290434834784;20362.592748145064;20471.897640511816;19254.51863703408;19455.805441945613;19858.404247872586;20136.59726805463;20154.19383224673;5136.43499215086;5603.60774745767;5791.768329266824;5815.185873977646;5817.970910145444;5711.343195532525;5744.396838331978;5776.59563830532;5778.711064446761;5783.479486846204;5515.338159420875;5670.036093864032;5716.771329146829;5752.079667253241;5773.162891380747;5735.971320143414;5743.282089738783;5773.162891380726;5776.191333213333;5778.942210577903;4996.625253106032;5048.3941926969;5222.895542089137;5252.23842542833;5308.734563271821;12216.816747748791;12430.197621344945;12546.184498007691;21727.370447216523;22732.886335568215;2250.22367283287;2341.6487526870937;2452.264320703782;2517.55942710025;2880.5247134222827;9340.439573625605;9436.575354109082;9670.178034867045;10015.649452269136;10121.797564048678;1566.0994927916493;1788.97316540252;1835.7613510243716;1955.4133759871982;1961.4213806926991;58495.99999999958;64745.3525464744;66971.66514167398;71259.64370178115;78626.21373786246;9784.804303913881;9888.901110988942;9894.30739848218;10213.489325533694;10261.58953641846;12013.87986120145;13352.332383380986;13499.19004859692;14034.649133771738;14151.787723184161;7577.810554736066;7595.506292090997;7643.273888980538;7645.19725428833;7686.461947663722;7431.442641801887;7483.588402637907;7549.245075492407;7771.417143714244;7932.484388514728;4163.75017498951;4173.394857745609;4203.70574059819;4257.127288905767;4439.356293337448;1749.6325771587854;1761.7005109131478;1764.1481805050148;1784.7947486039272;1859.828308165874;895.4537731983485;980.4460479828874;999.3654029691053;1010.9747256318651;1063.9095676867398;19088.904555477413;19563.43492520595;20345.694814577793;20365.898170509052;20481.89759051195;925.1118925831278;956.6747305916022;962.1581116523042;987.0672214757129;993.145894530703;10608.67391576053;11112.944435277772;11202.495887685074;11317.207795454238;11327.490262938023;456772;463916;473064.63467682444;474387;475881;88077.55961220281;88320.5583972076;89815;89924;92750;960.4669408478362;968.2834702320232;978.6085565773748;980.3872579637726;988.3427520698655;17179.31282748726;17528;17654.969678486625;17930.193141308413;18186.545336366697;42767.572324276356;42781.14437711166;43740;44179.55820441883;44703.776481118686;59155;59539;59580;60143.699281503315;61070;5824.446677565625;8087.63605637736;8104.108548059827;8105.797355066171;8132.617455032777;7520.285572870568;10025.69922902285;12875;13234.602961911158;13251.072424930162;10904.454777260946;10906.236563440483;11106;11132.721681958015;11433.885661143282;11142.888571114509;11187.32876027441;11230.494627741935;11351.772964540498;11710.4730287139;11164.665060048212;11224.887751122384;11412.543498259976;11572.074234061087;11643.59247426336;8044.557549334842;8093;8244.876326854983;8299.460535065202;8322.417430779788;8127.512349259064;10815.945920270347;11053.171012173958;11189.944050279697;11569.768604627692 16:42:23 INFO - PROCESS | 4256 | |3;mootools.html;1339.4039652354707;1471.536466013206;1508.7887695722598;1620.2465853378176;1778.5553611597109;8279.751607451779;8672.219500244984;8691.391602587813;8953.641854325819;8957.820843583124;8802.03177650458;8815.074417186199;8833.690820821272;8895.377323587336;8900.643974241038;2349.447879748262;2370.3481542575755;2371.336025912747;2371.774681405264;2373.0151986925407;2334.2180369576213;2395.2933884504114;2404.5912194926905;2406.915757948472;2409.5662780699467;2330.102910379499;2331.265651319837;2360.232924299601;2362.2204672458047;2365.053978408633;2297.6668383084525;2306.6770652108717;2321.5356928614174;2334.078039174525;2334.6964894563685;2274.943126421836;2289.553537060274;2289.782470665284;2292.255017119426;2295.908163673451;8515.616797244076;8765.342599305013;8802.559872006374;8843.248323892476;8873.866891996626;5144.948550514484;5318.494742999409;5319.840404787824;5327.493888080626;5333.866653333659;3285.4578994465883;3293.571835661349;3313.519539666735;3342.4484959981573;3357.731381489475;1010.64627380417;1012.6455740490843;1029.7734498410339;1033.297357796698;1047.8952104789537;11805.350705711182;11832.349220792852;11881.94059029708;11893.583724569598;11896.940515297454;4270.42349282849;4425.09285596452;4484.0583477469445;4520.728756274634;4522.4346956630425;9515.143637072697;9515.666951656658;9521.761955951157;9528.142467177988;9536;5146.305248791366;5149.562287205555;5159.948400516022;5160.561352285098;5163.380394352702;4203.852865149766;4673.579377856009;4812.470628230892;4816.807327706852;4835.516448355207;3625.4018087015875;3685.9262814743556;3754.4931434256573;3771.9434208486896;3772.3775577029483;1071.8499410082595;1084.6366467233408;1092.1099304067159;1101.9063379612824;1102.415719668577;1001.6444162322271;1011.3982180602529;1019.1184625299063;1025.9076683098558;1028.665683652816;6035.577509574287;6133.202683651186;6181.907271390933;6240.5319601030105;6346.524010699216;450.07060420232114;457.97939092740904;464.02091586751925;466.9066186762661;1021.6475316015963;4185.811638476276;4379.671524635665;4401;4402;4448.065906159743;10453.21600879937;10794.352338859537;10795;10820.567177312976;10844.13246940243;10739.355638661706;10758.246922715334;10762.139028877671;10765.192610554239;10767.192460565333;7876.921230787733;8171.10117887032;8199;8227.71203007892;8365.372597055246;6026.367231440811;6176.166217560752;6189.288231853395;6243.43809057187;6308.400701933309;10071.647492337734;10079.798404032024;10250.53872575721;10295.639652612123;10319.174466042849;9840.45877476717;10002.349847259904;10339.121174700234;10385.63650272237;10479.738006549593;6965.825854353681;7998.120206777367;8045.87931181021;8143.226393492609;8337.082920878578;8342.958285208779;8605.870911936452;8610.05289418151;8616.655333786579;8618.612162452579;7554.357879580297;7567.810804729926;7592.16486186508;7620.314171724572;7874.881876771968;7475.4019678426685;7529.247075292646;7562;7632.771016869503;7656.961715191611;7124.536905101152;7242.6740796663225;7243.529170603894;7247.637618119178;7267.127944646676;5359.383670877899;5454.809081682122;5480.588955828409;5484.506394424521;5634.52106570946;5425.430329815313;5474.069408200695;5495.862603434946;5498.615096943336;5607.971960140337 16:42:23 INFO - PROCESS | 4256 | |4;prototype.html;304.26671721152013;311.2902582112783;321.84229727433564;322.68699361619224;323.0792242109987;5109.744512774365;5186;5244.557746619676;5291.259223708679;5299.602529810265;5204.698825293676;5205.193195054772;5216.556592689626;5219.217117432387;5255.237990491386;4112.609302116294;4118.238125946695;4130.772807495594;4139.917201655965;4180.3729440584;3974.940375894364;4072.5927407259333;4165.375193720935;4170.249355116078;4185.644220241283;4029.9395509067385;4050.1697152083752;4056.9797151014204;4088.3458646616546;4091.774952377618;4086.1827634473075;4089.6319331260033;4113.177364527107;4121.443605113332;4138.6482149017365;3580.6240344763687;3648.4858783605036;3673.3938900081453;3680;3687.1748484500345;5075.720835354054;5108.795648174106;5116.923246151311;5127.359080114986;5138.897222055538;4691.835785747482;4695.436547614274;4696.131215725068;4699.459562150362;4731.266653668687;5322.441143679896;5367.329083864517;5436.836894893159;5476.58925580583;5531.225628412026;3957.5053118360206;3963.207358528277;3977.3238549446664;3977.3835055566433;3977.9005524861823;5663.801766938179;5670.773169073233;5684.488396044335;5696.11710184922;5710.743016564223;4013.8996525086523;4069.206504731549;4083.5099788025627;4104.651104656137;4127.422160897477;4123.793810309473;4128.814203360856;4129.15352352767;4149.481314835645;4181.414601955728;4690.6951048182445;4701.6003639690325;4717.693349932243;4722.409698787652;4741.502142275081;5386.730663466811;5466.644668096561;5502.312210973629;5520.647441376888;5525.392206857323;1342.1879762743595;1368.5141774669848;1371.945122195101;1372.9702722957782;1377.7106807570322;958.4568844160896;966.2559828931824;971.2521358553875;989.9851502227473;992.6575331510618;5240.371155461369;5256.842294731164;5264.526192642604;5289.338832645919;5332.693490094952;5497.065498865202;5566.248556444828;5581.832545023656;5587.106063029895;5623.437656234426;5234.712090835041;5238.476152384731;5249.921251181236;5250.212468129811;5262.7631756571045;2881.2940829496906;2934.6038284831275;2941.8823247070304;2973.2864112612815;2978.7914845960577;5653.858653533694;5680.6591604503865;5703.942960570341;5710.65736055838;5711.971440142773;5602.663840169603;5603.495685388335;5607.523360514402;5631.8592035199445;5678.659280443104;5459.918101228484;5716.571257155647;5744.971275143597;5789.247397838254;5806;5557.666540007613;5562.110062389998;5567.47109024642;5604.523615492729;5611.57913156523;5478.808241711521;5481.917771233355;5486.177073439016;5512.228288039758;5546.334439867242;5505.119180931032;5674.319081710221;5680.857978550569;5686.459786320458;5694.800681976111;4050.784764570676;4053.3717273822604;4073.1650011748116;4074.6129117733767;4097.815598298024;5467.398586155599;5517.641353312022;5574.749136288958;5596.949662433902;5597.216389705363;5368.22160786676;5383.9002788911575;5424.728763561727;5438.428964958623;5448.264484294569;5222.12003678683;5280.471952804689;5315.654482458628;5321.308229930084;5418.539424148834;5241.6068794839775;5370.570354371719;5397.892042159214;5415.214793854948;5417.756200971045;5442.836714898559;5461.371942226695;5496.230527726041;5506.0089183947275;5508.531774799027;5169.276301317894;5389.326334208224;5394.892102158014;5413.133898576209;5421.783128674809 16:42:23 INFO - PROCESS | 4256 | |5;yui.html;797.4378063465258;840.4915026409022;844.6156998565649;851.4167795060382;862.0904945282732;15074.92462537687;16912.577185570353;17598.472045838615;17664.646707065865;18434.907825460887;16233.26950287237;16298.755518667229;16298.83701162991;16310.510684679479;16340.264688089035;684.2473279392678;811.4319976016783;832.2052439919893;833.3458235285302;833.729038062629;812.6708682983372;833.8415701016787;834.3867257565685;836.9078352749659;837.8826964225013;875.5709702245886;877.442823806884;880.1286726141138;881.6253092435721;882.8322618702426;702.9718811247595;865.1348651348651;866.6143566113083;866.9219770220678;867.6312567158964;610.7709608896664;628.852219728368;629.559308484063;629.7606909374455;630.6184758221256;15387.53837384869;15524.456644017519;15551.611209719735;15574.299156537983;15593.220338983005;14459.71080578393;14535.854641453556;14718.484853030093;14757.114573125647;14784.630384240372;13316.600501984956;13396.799048014287;13418.329083545881;13431.597052088453;13510.32448377587;3923.2741942740686;4112.629863312286;4491;4569.383133276999;4680.531946805327;77677.22322776756;78760.60619696922;81576;81864.59067704623;84212.57893710492;12046.819297710541;12150.939245303716;12242.303241603093;12314.568990085305;12458.75082498345;22524.436889077577;22650.773492265194;22733.43166420853;22743.658845117337;22811.429714256945;8470.618822153017;8522.74431767048;8580.35647326453;8722.781930451663;9142.862857057149;4778.641601879804;4807.419606828512;4890.510948905081;5052.3937127544195;5079.619028572872;3453.240287136826;3549;3550.55618047744;3550.5916819565564;3552.5559305086863;606.6996836565928;607.4684650930436;618.1068356225211;625.3652542669195;631.3150231998242;621.3941407128013;640.471610920992;656.0847617573459;668.8227619680788;709.5636183746958;9346.915517879084;9916.893079750726;10030.197584193393;10152.746181345377;10276.482261845895;645.6965226343611;661.7419206509466;723.8841785314324;737.8671839069019;739.8668239716902;4610.585047345755;4961.875953101129;5000.374953130859;5011.448740638527;5018.723970181602;71094.64452677807;77301;87396.12603874007;125610;125645.37177314238;99183.50408248056;101596.49201753944;102888.48555757174;104385.47807260916;107640;55247.72376138174;88713.11286887049;90853;90881.54559227162;92192.53903730573;9442.433453992782;9475.620975161191;9501.904980950101;9559.139677429064;9753.707388778348;52575.737121314145;53133;53149.20276195783;54087.45912540824;55641;65968.6701566489;67376.326236737;68899.31100688929;74975.25024749682;76109.23890761021;13571.1857288563;13707.931460343034;13893.791593125909;14275.571732848031;14301.928490357897;15400.306986185873;15924.442644507386;16227.918860406095;17154.571135721708;17306.74039889428;14663;15052.924735376253;15271.770923435935;15683.561318889711;15868.127253001196;14431.49489767853;15177.6205594861;15281.46514871974;15646.608834778766;16371.181440928143;14792.852071479147;14916.776248356065;15084.321205545997;15324.923375383052;15735.213239337758;12195.573154939535;12270.693232669255;12302.876971230173;12329.691757706129;12662.620121396005;11447.713807154887;12185.634430967086;12586.748265034465;12791.808122877977;12890.226586404846 16:42:23 INFO - PROCESS | 4256 | __end_tp_report 16:42:23 INFO - PROCESS | 4256 | __start_cc_report 16:42:23 INFO - PROCESS | 4256 | _x_x_mozilla_cycle_collect,960 16:42:23 INFO - PROCESS | 4256 | __end_cc_report 16:42:23 INFO - PROCESS | 4256 | __startTimestamp1469662943745__endTimestamp 16:42:23 INFO - PROCESS | 4256 | 16:42:23 INFO - PROCESS | 4256 | ------- Summary: start ------- 16:42:23 INFO - PROCESS | 4256 | Number of tests: 6 16:42:23 INFO - PROCESS | 4256 | 16:42:23 INFO - PROCESS | 4256 | [#0] dojo.html Cycles:165 Average:5339.11 Median:5526.59 stddev:609.05 (11.0%) stddev-sans-first:582.95 16:42:23 INFO - PROCESS | 4256 | Values: 3013.3 3028.5 3042.6 3049.8 3074.1 5147.6 5204.4 5230.5 5295.6 5305.4 5321.8 5348.4 5392.0 5406.6 5441.6 4865.6 4869.2 4952.0 4958.8 5108.1 5020.4 5056.8 5062.9 5063.9 5076.4 4781.7 4799.7 4926.6 4948.8 4982.5 4823.9 4848.2 4861.3 5008.5 5016.4 4891.4 4908.5 4913.0 4923.1 4955.6 5197.0 5298.2 5405.0 5441.8 5443.6 5706.3 5784.9 5787.6 5800.1 5800.8 5781.2 5801.2 5810.2 5837.2 5864.0 5130.6 5309.2 5365.8 5387.8 5426.8 5941.0 5944.1 5957.4 5959.5 5960.2 5687.3 5697.5 5702.0 5704.3 5704.4 5557.2 5605.0 5682.4 5772.8 5792.4 5686.9 5694.3 5699.5 5724.8 5751.8 5662.4 5690.7 5703.6 5705.3 5710.4 4295.5 4346.1 4353.5 4355.7 4362.1 3888.6 3924.5 3943.7 3953.1 3988.2 5455.9 5463.4 5466.5 5469.9 5481.6 5514.0 5737.1 5780.8 5783.9 5815.9 5449.9 5489.1 5497.7 5537.0 5554.0 4967.1 4968.7 4972.5 4973.2 5017.9 5810.6 5856.6 5938.5 6004.2 6010.6 5673.7 5753.8 5788.6 5790.1 5797.4 5885.9 5903.6 5904.9 5910.9 5933.8 5487.0 5493.6 5502.2 5550.1 5550.4 5689.2 5758.5 5771.2 5822.6 5861.5 5612.8 5649.0 5661.3 5666.6 5667.5 5487.7 5643.1 5646.3 5650.1 5667.0 5501.4 5528.0 5540.4 5587.2 5608.9 5587.6 5605.2 5645.5 5649.4 5653.7 5336.4 5513.1 5518.9 5526.6 5541.3 16:42:23 INFO - PROCESS | 4256 | 16:42:23 INFO - PROCESS | 4256 | [#1] ext.html Cycles:180 Average:60121.49 Median:411151.50 stddev:122614.10 (29.8%) stddev-sans-first:122876.61 16:42:23 INFO - PROCESS | 4256 | Values: 592.4 595.4 609.8 619.5 633.9 31022.5 43347.3 44583.0 44644.8 44710.3 46125.8 46447.5 46546.3 46553.5 46574.5 8939.2 9083.5 9084.5 9086.9 9096.5 8902.5 8961.8 8996.2 9000.7 9006.5 9020.6 9055.2 9075.3 9076.5 9077.4 8921.2 8945.7 8975.2 8985.8 8995.7 8764.2 8864.6 8864.9 8869.9 8870.2 43928.3 43991.3 44130.0 44233.0 44318.0 3291.8 3409.9 3644.4 3851.6 3859.7 33184.3 33522.7 33906.7 34526.0 35042.5 3977.0 3990.3 4015.4 4015.9 4072.1 349293.0 351700.0 352061.0 353181.0 353913.2 33946.5 35096.0 35116.8 59079.0 59441.1 36816.4 36874.0 36949.4 36994.3 37083.6 13847.9 13887.3 13905.9 13907.2 13913.2 12176.3 12184.3 12201.5 12207.4 12210.4 8347.3 8350.0 8364.3 8419.4 8444.5 3227.6 3243.5 3280.8 3325.5 3335.2 973.9 1058.7 1123.7 1154.4 1174.1 32898.5 33251.8 33724.5 33802.3 34036.3 1086.2 1087.9 1092.3 1095.8 1097.1 16895.6 17353.7 17507.3 17815.8 17880.6 582388.0 586941.0 587350.0 588580.0 589056.0 59625.7 59766.0 60160.4 60351.4 60384.4 1241.3 1288.0 1342.2 1353.7 1357.1 29847.7 34092.5 34312.3 34332.8 34539.0 51932.0 52417.0 52530.0 52592.5 52704.0 408365.0 410120.0 411121.0 411182.0 411318.0 25220.0 27849.6 28643.9 28782.4 29073.9 48900.5 49288.0 49451.3 49474.5 49490.0 42193.4 43098.4 43387.8 43530.0 44272.6 42880.6 43931.0 44354.6 44702.6 44781.0 43124.0 43767.8 43932.1 43991.0 44121.3 35625.6 37737.0 38962.6 39069.2 39416.8 29191.7 29288.4 29312.4 29383.4 29574.6 16:42:23 INFO - PROCESS | 4256 | 16:42:23 INFO - PROCESS | 4256 | [#2] jquery.html Cycles:180 Average:27685.77 Median:43959.78 stddev:77282.86 (175.8%) stddev-sans-first:77472.43 16:42:23 INFO - PROCESS | 4256 | Values: 363.9 365.4 373.7 378.7 381.4 18815.9 20156.0 20273.3 20362.6 20471.9 19254.5 19455.8 19858.4 20136.6 20154.2 5136.4 5603.6 5791.8 5815.2 5818.0 5711.3 5744.4 5776.6 5778.7 5783.5 5515.3 5670.0 5716.8 5752.1 5773.2 5736.0 5743.3 5773.2 5776.2 5778.9 4996.6 5048.4 5222.9 5252.2 5308.7 12216.8 12430.2 12546.2 21727.4 22732.9 2250.2 2341.6 2452.3 2517.6 2880.5 9340.4 9436.6 9670.2 10015.6 10121.8 1566.1 1789.0 1835.8 1955.4 1961.4 58496.0 64745.4 66971.7 71259.6 78626.2 9784.8 9888.9 9894.3 10213.5 10261.6 12013.9 13352.3 13499.2 14034.6 14151.8 7577.8 7595.5 7643.3 7645.2 7686.5 7431.4 7483.6 7549.2 7771.4 7932.5 4163.8 4173.4 4203.7 4257.1 4439.4 1749.6 1761.7 1764.1 1784.8 1859.8 895.5 980.4 999.4 1011.0 1063.9 19088.9 19563.4 20345.7 20365.9 20481.9 925.1 956.7 962.2 987.1 993.1 10608.7 11112.9 11202.5 11317.2 11327.5 456772.0 463916.0 473064.6 474387.0 475881.0 88077.6 88320.6 89815.0 89924.0 92750.0 960.5 968.3 978.6 980.4 988.3 17179.3 17528.0 17655.0 17930.2 18186.5 42767.6 42781.1 43740.0 44179.6 44703.8 59155.0 59539.0 59580.0 60143.7 61070.0 5824.4 8087.6 8104.1 8105.8 8132.6 7520.3 10025.7 12875.0 13234.6 13251.1 10904.5 10906.2 11106.0 11132.7 11433.9 11142.9 11187.3 11230.5 11351.8 11710.5 11164.7 11224.9 11412.5 11572.1 11643.6 8044.6 8093.0 8244.9 8299.5 8322.4 8127.5 10815.9 11053.2 11189.9 11569.8 16:42:23 INFO - PROCESS | 4256 | 16:42:23 INFO - PROCESS | 4256 | [#3] mootools.html Cycles:180 Average:5776.89 Median:4521.58 stddev:3265.14 (72.2%) stddev-sans-first:3257.26 16:42:23 INFO - PROCESS | 4256 | Values: 1339.4 1471.5 1508.8 1620.2 1778.6 8279.8 8672.2 8691.4 8953.6 8957.8 8802.0 8815.1 8833.7 8895.4 8900.6 2349.4 2370.3 2371.3 2371.8 2373.0 2334.2 2395.3 2404.6 2406.9 2409.6 2330.1 2331.3 2360.2 2362.2 2365.1 2297.7 2306.7 2321.5 2334.1 2334.7 2274.9 2289.6 2289.8 2292.3 2295.9 8515.6 8765.3 8802.6 8843.2 8873.9 5144.9 5318.5 5319.8 5327.5 5333.9 3285.5 3293.6 3313.5 3342.4 3357.7 1010.6 1012.6 1029.8 1033.3 1047.9 11805.4 11832.3 11881.9 11893.6 11896.9 4270.4 4425.1 4484.1 4520.7 4522.4 9515.1 9515.7 9521.8 9528.1 9536.0 5146.3 5149.6 5159.9 5160.6 5163.4 4203.9 4673.6 4812.5 4816.8 4835.5 3625.4 3685.9 3754.5 3771.9 3772.4 1071.8 1084.6 1092.1 1101.9 1102.4 1001.6 1011.4 1019.1 1025.9 1028.7 6035.6 6133.2 6181.9 6240.5 6346.5 450.1 458.0 464.0 466.9 1021.6 4185.8 4379.7 4401.0 4402.0 4448.1 10453.2 10794.4 10795.0 10820.6 10844.1 10739.4 10758.2 10762.1 10765.2 10767.2 7876.9 8171.1 8199.0 8227.7 8365.4 6026.4 6176.2 6189.3 6243.4 6308.4 10071.6 10079.8 10250.5 10295.6 10319.2 9840.5 10002.3 10339.1 10385.6 10479.7 6965.8 7998.1 8045.9 8143.2 8337.1 8343.0 8605.9 8610.1 8616.7 8618.6 7554.4 7567.8 7592.2 7620.3 7874.9 7475.4 7529.2 7562.0 7632.8 7657.0 7124.5 7242.7 7243.5 7247.6 7267.1 5359.4 5454.8 5480.6 5484.5 5634.5 5425.4 5474.1 5495.9 5498.6 5608.0 16:42:23 INFO - PROCESS | 4256 | 16:42:23 INFO - PROCESS | 4256 | [#4] prototype.html Cycles:180 Average:4606.70 Median:5256.04 stddev:1333.51 (25.4%) stddev-sans-first:1297.56 16:42:23 INFO - PROCESS | 4256 | Values: 304.3 311.3 321.8 322.7 323.1 5109.7 5186.0 5244.6 5291.3 5299.6 5204.7 5205.2 5216.6 5219.2 5255.2 4112.6 4118.2 4130.8 4139.9 4180.4 3974.9 4072.6 4165.4 4170.2 4185.6 4029.9 4050.2 4057.0 4088.3 4091.8 4086.2 4089.6 4113.2 4121.4 4138.6 3580.6 3648.5 3673.4 3680.0 3687.2 5075.7 5108.8 5116.9 5127.4 5138.9 4691.8 4695.4 4696.1 4699.5 4731.3 5322.4 5367.3 5436.8 5476.6 5531.2 3957.5 3963.2 3977.3 3977.4 3977.9 5663.8 5670.8 5684.5 5696.1 5710.7 4013.9 4069.2 4083.5 4104.7 4127.4 4123.8 4128.8 4129.2 4149.5 4181.4 4690.7 4701.6 4717.7 4722.4 4741.5 5386.7 5466.6 5502.3 5520.6 5525.4 1342.2 1368.5 1371.9 1373.0 1377.7 958.5 966.3 971.3 990.0 992.7 5240.4 5256.8 5264.5 5289.3 5332.7 5497.1 5566.2 5581.8 5587.1 5623.4 5234.7 5238.5 5249.9 5250.2 5262.8 2881.3 2934.6 2941.9 2973.3 2978.8 5653.9 5680.7 5703.9 5710.7 5712.0 5602.7 5603.5 5607.5 5631.9 5678.7 5459.9 5716.6 5745.0 5789.2 5806.0 5557.7 5562.1 5567.5 5604.5 5611.6 5478.8 5481.9 5486.2 5512.2 5546.3 5505.1 5674.3 5680.9 5686.5 5694.8 4050.8 4053.4 4073.2 4074.6 4097.8 5467.4 5517.6 5574.7 5596.9 5597.2 5368.2 5383.9 5424.7 5438.4 5448.3 5222.1 5280.5 5315.7 5321.3 5418.5 5241.6 5370.6 5397.9 5415.2 5417.8 5442.8 5461.4 5496.2 5506.0 5508.5 5169.3 5389.3 5394.9 5413.1 5421.8 16:42:23 INFO - PROCESS | 4256 | 16:42:23 INFO - PROCESS | 4256 | [#5] yui.html Cycles:180 Average:20970.26 Median:4793.03 stddev:29028.31 (605.6%) stddev-sans-first:29070.22 16:42:23 INFO - PROCESS | 4256 | Values: 797.4 840.5 844.6 851.4 862.1 15074.9 16912.6 17598.5 17664.6 18434.9 16233.3 16298.8 16298.8 16310.5 16340.3 684.2 811.4 832.2 833.3 833.7 812.7 833.8 834.4 836.9 837.9 875.6 877.4 880.1 881.6 882.8 703.0 865.1 866.6 866.9 867.6 610.8 628.9 629.6 629.8 630.6 15387.5 15524.5 15551.6 15574.3 15593.2 14459.7 14535.9 14718.5 14757.1 14784.6 13316.6 13396.8 13418.3 13431.6 13510.3 3923.3 4112.6 4491.0 4569.4 4680.5 77677.2 78760.6 81576.0 81864.6 84212.6 12046.8 12150.9 12242.3 12314.6 12458.8 22524.4 22650.8 22733.4 22743.7 22811.4 8470.6 8522.7 8580.4 8722.8 9142.9 4778.6 4807.4 4890.5 5052.4 5079.6 3453.2 3549.0 3550.6 3550.6 3552.6 606.7 607.5 618.1 625.4 631.3 621.4 640.5 656.1 668.8 709.6 9346.9 9916.9 10030.2 10152.7 10276.5 645.7 661.7 723.9 737.9 739.9 4610.6 4961.9 5000.4 5011.4 5018.7 71094.6 77301.0 87396.1 125610.0 125645.4 99183.5 101596.5 102888.5 104385.5 107640.0 55247.7 88713.1 90853.0 90881.5 92192.5 9442.4 9475.6 9501.9 9559.1 9753.7 52575.7 53133.0 53149.2 54087.5 55641.0 65968.7 67376.3 68899.3 74975.3 76109.2 13571.2 13707.9 13893.8 14275.6 14301.9 15400.3 15924.4 16227.9 17154.6 17306.7 14663.0 15052.9 15271.8 15683.6 15868.1 14431.5 15177.6 15281.5 15646.6 16371.2 14792.9 14916.8 15084.3 15324.9 15735.2 12195.6 12270.7 12302.9 12329.7 12662.6 11447.7 12185.6 12586.7 12791.8 12890.2 16:42:23 INFO - PROCESS | 4256 | -------- Summary: end -------- 16:42:23 INFO - PROCESS | 4256 | 16:42:24 INFO - TEST-INFO | 4256: exit 0 16:42:24 INFO - TEST-OK | dromaeo_css | took 1113378ms 16:42:24 INFO - TEST-START | kraken 16:42:24 INFO - operating with platform_type : linux_ 16:42:24 INFO - Initialising browser for kraken test... 16:42:24 INFO - TEST-INFO | started process 4445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmcjMNZ/profile http://localhost:60858/getInfo.html) 16:42:27 INFO - PROCESS | 4445 | JavaScript error: , line 0: uncaught exception: undefined 16:42:28 INFO - PROCESS | 4445 | __metrics Screen width/height:1600/1200 16:42:28 INFO - PROCESS | 4445 | colorDepth:24 16:42:28 INFO - PROCESS | 4445 | Browser inner width/height: 1024/697 16:42:28 INFO - PROCESS | 4445 | __metrics 16:42:29 INFO - PROCESS | 4445 | 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" 16:42:29 INFO - PROCESS | 4445 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:42:29 INFO - PROCESS | 4445 | console.error: PushService: 16:42:29 INFO - PROCESS | 4445 | stateChangeProcessEnqueue: Error transitioning state 16:42:29 INFO - PROCESS | 4445 | UnknownError 16:42:30 INFO - TEST-INFO | 4445: exit 0 16:42:30 INFO - Browser initialized. 16:42:30 INFO - Running cycle 1/1 for kraken test... 16:42:30 INFO - TEST-INFO | started process 4524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmcjMNZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:41 INFO - PROCESS | 4524 | RSS: Main: 157822976 16:42:41 INFO - PROCESS | 4524 | 16:42:44 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60858/tests/kraken/driver.html?testName=audio-beat-detection) 16:42:45 INFO - PROCESS | 4524 | RSS: Main: 214384640 16:42:45 INFO - PROCESS | 4524 | 16:42:47 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60858/tests/kraken/driver.html?testName=audio-dft) 16:42:48 INFO - PROCESS | 4524 | RSS: Main: 192671744 16:42:48 INFO - PROCESS | 4524 | 16:42:51 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60858/tests/kraken/driver.html?testName=audio-fft) 16:42:51 INFO - PROCESS | 4524 | RSS: Main: 270270464 16:42:51 INFO - PROCESS | 4524 | 16:42:54 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60858/tests/kraken/driver.html?testName=audio-oscillator) 16:42:54 INFO - PROCESS | 4524 | RSS: Main: 181428224 16:42:54 INFO - PROCESS | 4524 | 16:42:56 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60858/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:42:57 INFO - PROCESS | 4524 | RSS: Main: 185606144 16:42:57 INFO - PROCESS | 4524 | 16:43:00 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60858/tests/kraken/driver.html?testName=imaging-darkroom) 16:43:00 INFO - PROCESS | 4524 | RSS: Main: 221954048 16:43:00 INFO - PROCESS | 4524 | 16:43:04 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60858/tests/kraken/driver.html?testName=imaging-desaturate) 16:43:04 INFO - PROCESS | 4524 | RSS: Main: 220680192 16:43:04 INFO - PROCESS | 4524 | 16:43:07 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60858/tests/kraken/driver.html?testName=json-parse-financial) 16:43:08 INFO - PROCESS | 4524 | RSS: Main: 220581888 16:43:08 INFO - PROCESS | 4524 | 16:43:09 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60858/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:43:10 INFO - PROCESS | 4524 | RSS: Main: 184922112 16:43:10 INFO - PROCESS | 4524 | 16:43:12 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:43:12 INFO - PROCESS | 4524 | RSS: Main: 191016960 16:43:12 INFO - PROCESS | 4524 | 16:43:14 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:43:15 INFO - PROCESS | 4524 | RSS: Main: 195743744 16:43:15 INFO - PROCESS | 4524 | 16:43:17 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:43:18 INFO - PROCESS | 4524 | RSS: Main: 188276736 16:43:18 INFO - PROCESS | 4524 | 16:43:21 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:43:21 INFO - PROCESS | 4524 | RSS: Main: 193757184 16:43:21 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60858/tests/kraken/driver.html?testName=ai-astar) 16:43:23 INFO - PROCESS | 4524 | RSS: Main: 244002816 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | __start_tp_report 16:43:23 INFO - PROCESS | 4524 | _x_x_mozilla_page_load 16:43:23 INFO - PROCESS | 4524 | _x_x_mozilla_page_load_details 16:43:23 INFO - PROCESS | 4524 | |i|pagename|runs| 16:43:23 INFO - PROCESS | 4524 | |0;ai-astar;102;110;110;109;110;109;109;109;111;109 16:43:23 INFO - PROCESS | 4524 | |1;audio-beat-detection;154;117;127;176;117;125;146;120;173;118 16:43:23 INFO - PROCESS | 4524 | |2;audio-dft;161;161;162;161;162;161;160;161;162;160 16:43:23 INFO - PROCESS | 4524 | |3;audio-fft;75;75;75;123;76;76;74;74;111;75 16:43:23 INFO - PROCESS | 4524 | |4;audio-oscillator;83;83;116;85;84;84;124;83;84;126 16:43:23 INFO - PROCESS | 4524 | |5;imaging-gaussian-blur;117;116;116;116;117;117;116;116;117;117 16:43:23 INFO - PROCESS | 4524 | |6;imaging-darkroom;146;146;148;145;146;147;146;145;145;147 16:43:23 INFO - PROCESS | 4524 | |7;imaging-desaturate;94;94;94;95;94;95;95;94;96;94 16:43:23 INFO - PROCESS | 4524 | |8;json-parse-financial;51;52;51;51;53;53;53;52;52;51 16:43:23 INFO - PROCESS | 4524 | |9;json-stringify-tinderbox;62;64;64;73;64;63;62;63;64;64 16:43:23 INFO - PROCESS | 4524 | |10;stanford-crypto-aes;76;80;76;76;76;75;75;75;74;80 16:43:23 INFO - PROCESS | 4524 | |11;stanford-crypto-ccm;122;119;120;120;120;119;119;128;165;120 16:43:23 INFO - PROCESS | 4524 | |12;stanford-crypto-pbkdf2;154;154;157;157;155;158;153;160;154;159 16:43:23 INFO - PROCESS | 4524 | |13;stanford-crypto-sha256-iterative;62;62;65;61;63;62;66;61;61;60 16:43:23 INFO - PROCESS | 4524 | __end_tp_report 16:43:23 INFO - PROCESS | 4524 | __start_cc_report 16:43:23 INFO - PROCESS | 4524 | _x_x_mozilla_cycle_collect,1644 16:43:23 INFO - PROCESS | 4524 | __end_cc_report 16:43:23 INFO - PROCESS | 4524 | __startTimestamp1469663003753__endTimestamp 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | ------- Summary: start ------- 16:43:23 INFO - PROCESS | 4524 | Number of tests: 14 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.50 stddev:2.49 (2.3%) stddev-sans-first:0.73 16:43:23 INFO - PROCESS | 4524 | Values: 102.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 111.0 109.0 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:136.50 stddev:23.29 (17.1%) stddev-sans-first:23.90 16:43:23 INFO - PROCESS | 4524 | Values: 154.0 117.0 127.0 176.0 117.0 125.0 146.0 120.0 173.0 118.0 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 16:43:23 INFO - PROCESS | 4524 | Values: 161.0 161.0 162.0 161.0 162.0 161.0 160.0 161.0 162.0 160.0 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.00 stddev:17.95 (23.9%) stddev-sans-first:18.77 16:43:23 INFO - PROCESS | 4524 | Values: 75.0 75.0 75.0 123.0 76.0 76.0 74.0 74.0 111.0 75.0 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:83.50 stddev:18.67 (22.4%) stddev-sans-first:19.28 16:43:23 INFO - PROCESS | 4524 | Values: 83.0 83.0 116.0 85.0 84.0 84.0 124.0 83.0 84.0 126.0 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:43:23 INFO - PROCESS | 4524 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 16:43:23 INFO - PROCESS | 4524 | Values: 146.0 146.0 148.0 145.0 146.0 147.0 146.0 145.0 145.0 147.0 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 16:43:23 INFO - PROCESS | 4524 | Values: 94.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 96.0 94.0 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.88 (1.7%) stddev-sans-first:0.87 16:43:23 INFO - PROCESS | 4524 | Values: 51.0 52.0 51.0 51.0 53.0 53.0 53.0 52.0 52.0 51.0 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:3.16 (4.9%) stddev-sans-first:3.24 16:43:23 INFO - PROCESS | 4524 | Values: 62.0 64.0 64.0 73.0 64.0 63.0 62.0 63.0 64.0 64.0 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:2.06 (2.7%) stddev-sans-first:2.18 16:43:23 INFO - PROCESS | 4524 | Values: 76.0 80.0 76.0 76.0 76.0 75.0 75.0 75.0 74.0 80.0 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:120.00 stddev:14.24 (11.9%) stddev-sans-first:15.06 16:43:23 INFO - PROCESS | 4524 | Values: 122.0 119.0 120.0 120.0 120.0 119.0 119.0 128.0 165.0 120.0 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:157.00 stddev:2.42 (1.5%) stddev-sans-first:2.45 16:43:23 INFO - PROCESS | 4524 | Values: 154.0 154.0 157.0 157.0 155.0 158.0 153.0 160.0 154.0 159.0 16:43:23 INFO - PROCESS | 4524 | 16:43:23 INFO - PROCESS | 4524 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.89 (3.0%) stddev-sans-first:2.00 16:43:23 INFO - PROCESS | 4524 | Values: 62.0 62.0 65.0 61.0 63.0 62.0 66.0 61.0 61.0 60.0 16:43:23 INFO - PROCESS | 4524 | -------- Summary: end -------- 16:43:23 INFO - PROCESS | 4524 | 16:43:24 INFO - TEST-INFO | 4524: exit 0 16:43:24 INFO - TEST-OK | kraken | took 60325ms 16:43:24 INFO - SUITE-END | took 1173s 16:43:24 INFO - Completed test suite (00:19:33) 16:43:24 INFO - javascript benchmark 16:43:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3013.3370658455146, 3028.5002974509202, 3042.5740396344518, 3049.801762885411, 3074.062410964655, 5147.588192944565, 5204.375474943003, 5230.476952304768, 5295.629305948585, 5305.363356397233, 5321.840344789663, 5348.438413966526, 5392.0294347017525, 5406.621536492447, 5441.646292990953, 4865.635077369194, 4869.220924652056, 4951.950480495185, 4958.826441074563, 5108.131617625013, 5020.3724534433195, 5056.797728090872, 5062.949370506285, 5063.924041139386, 5076.390833100015, 4781.6891902026255, 4799.664023518355, 4926.630502712311, 4948.777305021283, 4982.526659967298, 4823.903521929542, 4848.17581011229, 4861.270809378586, 5008.474110218447, 5016.3980322361185, 4891.388576427947, 4908.533689299511, 4912.950870491285, 4923.138450771136, 4955.628327875424, 5197.0385478686185, 5298.205269209611, 5405.0, 5441.782328706847, 5443.618946673734, 5706.3152421709665, 5784.913226301609, 5787.565932555033, 5800.10098434739, 5800.796972105998, 5781.219535362757, 5801.216835727208, 5810.1865738796605, 5837.182794408786, 5864.0, 5130.589552835764, 5309.203619457112, 5365.839024829262, 5387.757550910218, 5426.782928682848, 5941.049432090931, 5944.078667806497, 5957.4042595740075, 5959.4934430573885, 5960.195373624592, 5687.317521897398, 5697.544196464356, 5701.971490142523, 5704.258446401941, 5704.4295570443455, 5557.166425036277, 5605.0, 5682.431756824284, 5772.826815195551, 5792.4497172768515, 5686.886262274731, 5694.316681998187, 5699.458551437607, 5724.799632012943, 5751.769929202785, 5662.405447428043, 5690.658560486384, 5703.62926409782, 5705.286839145107, 5710.400407957188, 4295.463067116611, 4346.1090476452255, 4353.542877997765, 4355.73865568067, 4362.083962367875, 3888.6111388860886, 3924.4505769192338, 3943.664788492953, 3953.0512676957896, 3988.1824226033596, 5455.890882182334, 5463.426340234298, 5466.453354664502, 5469.890602187934, 5481.561475082063, 5514.007478653801, 5737.139429085671, 5780.768769249267, 5783.8554036149435, 5815.941840581625, 5449.863753406196, 5489.066858634042, 5497.697626630494, 5537.003339398866, 5554.0, 4967.08108999829, 4968.652194346361, 4972.5276098770555, 4973.154563724175, 5017.899642007213, 5810.622309549865, 5856.619319744203, 5938.49522790559, 6004.249468816398, 6010.579259451796, 5673.716314184357, 5753.798617048383, 5788.594798364074, 5790.10253410722, 5797.449242321973, 5885.941140588539, 5903.645781253139, 5904.911426328523, 5910.881782364243, 5933.762649494144, 5487.0, 5493.642913210629, 5502.174673798962, 5550.139728342114, 5550.4449555044175, 5689.2319536862, 5758.452946970031, 5771.192033115283, 5822.592418530831, 5861.472467477947, 5612.7754889803955, 5649.039663257174, 5661.264035675335, 5666.631668941671, 5667.4615911488345, 5487.670739755627, 5643.068893632505, 5646.265985421869, 5650.0959846424375, 5666.9716651416475, 5501.4223506532835, 5528.0, 5540.445955404427, 5587.161925711013, 5608.943910560843, 5587.552995760248, 5605.187247848958, 5645.463680950304, 5649.406812284816, 5653.660780353192, 5336.359636843604, 5513.09034009384, 5518.86202844916, 5526.585506086979, 5541.307336582927], "value": 5297.282302981095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.3780030967483, 595.4373117404052, 609.7865746988557, 619.4734475695659, 633.8573820890299, 31022.53466198006, 43347.34978975318, 44583.0, 44644.77677611607, 44710.32934505985, 46125.769371153096, 46447.53552464474, 46546.30180547295, 46553.53446465534, 46574.53425465745, 8939.195472407482, 9083.454992700426, 9084.454932704026, 9086.86369704455, 9096.454212747256, 8902.465852048897, 8961.775955601097, 8996.235319997808, 9000.684976025841, 9006.504642244674, 9020.639174433014, 9055.230305424015, 9075.273978081737, 9076.500792456412, 9077.36458447909, 8921.197092261662, 8945.73162805117, 8975.237104846095, 8985.820283594358, 8995.730128096167, 8764.211220990077, 8864.55677216143, 8864.867026994536, 8869.866951995726, 8870.2016818486, 43928.3410748839, 43991.340129898075, 44130.0, 44233.0, 44318.0, 3291.769576129672, 3409.9147521311916, 3644.362236608583, 3851.5955824638568, 3859.671927886133, 33184.3363132736, 33522.6647733522, 33906.660933390594, 34526.0, 35042.47436288432, 3976.9602303977167, 3990.3016972029777, 4015.437838702584, 4015.9397609035886, 4072.1041370898356, 349293.0, 351700.0, 352061.0, 353181.0, 353913.23043384874, 33946.49080263748, 35096.0, 35116.82441587776, 59079.0, 59441.10838337428, 36816.44775328372, 36874.0, 36949.44575831365, 36994.26011479755, 37083.62916370856, 13847.861521384859, 13887.305634718223, 13905.930470347786, 13907.165570065828, 13913.234772087633, 12176.269423834598, 12184.329861857506, 12201.45093470796, 12207.389630518439, 12210.389480526115, 8347.29048030912, 8350.0, 8364.330853531703, 8419.368547358972, 8444.493330400195, 3227.580414546094, 3243.497257925025, 3280.7867488613165, 3325.48454989477, 3335.216224187314, 973.8928717841031, 1058.7088550648634, 1123.6572845282267, 1154.4227886056972, 1174.0548858169086, 32898.50652240218, 33251.83374083114, 33724.49413258803, 33802.32395352079, 34036.31927361439, 1086.223350304536, 1087.8912108789057, 1092.2736380307165, 1095.8465814785936, 1097.078454098545, 16895.577610559834, 17353.652926941642, 17507.299708011793, 17815.821841781675, 17880.55298617519, 582388.0, 586941.0, 587350.0, 588580.0, 589056.0, 59625.70187149037, 59766.0, 60160.39839601635, 60351.39648603545, 60384.396156037874, 1241.30486927321, 1287.9889286909731, 1342.2483409291024, 1353.7157196988546, 1357.1178733823094, 29847.70152298536, 34092.488612671325, 34312.313753725284, 34332.82833585816, 34539.0, 51932.0, 52417.0, 52530.0, 52592.47407526029, 52704.0, 408365.0, 410120.0, 411121.0, 411182.0, 411318.0, 25219.991200351782, 27849.582256265767, 28643.856780715963, 28782.424351513273, 29073.85463072671, 48900.5109948896, 49288.0, 49451.258231125845, 49474.50525494699, 49490.0, 42193.36709949292, 43098.353524696526, 43387.78306108449, 43530.0, 44272.55727442684, 42880.57119428766, 43931.0, 44354.55645443634, 44702.552974469836, 44781.0, 43124.0, 43767.78116109399, 43932.121357573305, 43991.0, 44121.338179926686, 35625.643743562236, 37737.0, 38962.6103738959, 39069.218615628095, 39416.80291598524, 29191.708082919748, 29288.414231715673, 29312.43001119821, 29383.412331752817, 29574.556381654722], "value": 19067.82233295012, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.92539529396475, 365.40074278183783, 373.6543697080201, 378.7046104038847, 381.36312358361533, 18815.905920470395, 20156.0, 20273.290434834784, 20362.592748145064, 20471.897640511816, 19254.51863703408, 19455.805441945613, 19858.404247872586, 20136.59726805463, 20154.19383224673, 5136.43499215086, 5603.60774745767, 5791.768329266824, 5815.185873977646, 5817.970910145444, 5711.343195532525, 5744.396838331978, 5776.59563830532, 5778.711064446761, 5783.479486846204, 5515.338159420875, 5670.036093864032, 5716.771329146829, 5752.079667253241, 5773.162891380747, 5735.971320143414, 5743.282089738783, 5773.162891380726, 5776.191333213333, 5778.942210577903, 4996.625253106032, 5048.3941926969, 5222.895542089137, 5252.23842542833, 5308.734563271821, 12216.816747748791, 12430.197621344945, 12546.184498007691, 21727.370447216523, 22732.886335568215, 2250.22367283287, 2341.6487526870937, 2452.264320703782, 2517.55942710025, 2880.5247134222827, 9340.439573625605, 9436.575354109082, 9670.178034867045, 10015.649452269136, 10121.797564048678, 1566.0994927916493, 1788.97316540252, 1835.7613510243716, 1955.4133759871982, 1961.4213806926991, 58495.99999999958, 64745.3525464744, 66971.66514167398, 71259.64370178115, 78626.21373786246, 9784.804303913881, 9888.901110988942, 9894.30739848218, 10213.489325533694, 10261.58953641846, 12013.87986120145, 13352.332383380986, 13499.19004859692, 14034.649133771738, 14151.787723184161, 7577.810554736066, 7595.506292090997, 7643.273888980538, 7645.19725428833, 7686.461947663722, 7431.442641801887, 7483.588402637907, 7549.245075492407, 7771.417143714244, 7932.484388514728, 4163.75017498951, 4173.394857745609, 4203.70574059819, 4257.127288905767, 4439.356293337448, 1749.6325771587854, 1761.7005109131478, 1764.1481805050148, 1784.7947486039272, 1859.828308165874, 895.4537731983485, 980.4460479828874, 999.3654029691053, 1010.9747256318651, 1063.9095676867398, 19088.904555477413, 19563.43492520595, 20345.694814577793, 20365.898170509052, 20481.89759051195, 925.1118925831278, 956.6747305916022, 962.1581116523042, 987.0672214757129, 993.145894530703, 10608.67391576053, 11112.944435277772, 11202.495887685074, 11317.207795454238, 11327.490262938023, 456772.0, 463916.0, 473064.63467682444, 474387.0, 475881.0, 88077.55961220281, 88320.5583972076, 89815.0, 89924.0, 92750.0, 960.4669408478362, 968.2834702320232, 978.6085565773748, 980.3872579637726, 988.3427520698655, 17179.31282748726, 17528.0, 17654.969678486625, 17930.193141308413, 18186.545336366697, 42767.572324276356, 42781.14437711166, 43740.0, 44179.55820441883, 44703.776481118686, 59155.0, 59539.0, 59580.0, 60143.699281503315, 61070.0, 5824.446677565625, 8087.63605637736, 8104.108548059827, 8105.797355066171, 8132.617455032777, 7520.285572870568, 10025.69922902285, 12875.0, 13234.602961911158, 13251.072424930162, 10904.454777260946, 10906.236563440483, 11106.0, 11132.721681958015, 11433.885661143282, 11142.888571114509, 11187.32876027441, 11230.494627741935, 11351.772964540498, 11710.4730287139, 11164.665060048212, 11224.887751122384, 11412.543498259976, 11572.074234061087, 11643.59247426336, 8044.557549334842, 8093.0, 8244.876326854983, 8299.460535065202, 8322.417430779788, 8127.512349259064, 10815.945920270347, 11053.171012173958, 11189.944050279697, 11569.768604627692], "value": 8805.373033388676, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.4039652354707, 1471.536466013206, 1508.7887695722598, 1620.2465853378176, 1778.5553611597109, 8279.751607451779, 8672.219500244984, 8691.391602587813, 8953.641854325819, 8957.820843583124, 8802.03177650458, 8815.074417186199, 8833.690820821272, 8895.377323587336, 8900.643974241038, 2349.447879748262, 2370.3481542575755, 2371.336025912747, 2371.774681405264, 2373.0151986925407, 2334.2180369576213, 2395.2933884504114, 2404.5912194926905, 2406.915757948472, 2409.5662780699467, 2330.102910379499, 2331.265651319837, 2360.232924299601, 2362.2204672458047, 2365.053978408633, 2297.6668383084525, 2306.6770652108717, 2321.5356928614174, 2334.078039174525, 2334.6964894563685, 2274.943126421836, 2289.553537060274, 2289.782470665284, 2292.255017119426, 2295.908163673451, 8515.616797244076, 8765.342599305013, 8802.559872006374, 8843.248323892476, 8873.866891996626, 5144.948550514484, 5318.494742999409, 5319.840404787824, 5327.493888080626, 5333.866653333659, 3285.4578994465883, 3293.571835661349, 3313.519539666735, 3342.4484959981573, 3357.731381489475, 1010.64627380417, 1012.6455740490843, 1029.7734498410339, 1033.297357796698, 1047.8952104789537, 11805.350705711182, 11832.349220792852, 11881.94059029708, 11893.583724569598, 11896.940515297454, 4270.42349282849, 4425.09285596452, 4484.0583477469445, 4520.728756274634, 4522.4346956630425, 9515.143637072697, 9515.666951656658, 9521.761955951157, 9528.142467177988, 9536.0, 5146.305248791366, 5149.562287205555, 5159.948400516022, 5160.561352285098, 5163.380394352702, 4203.852865149766, 4673.579377856009, 4812.470628230892, 4816.807327706852, 4835.516448355207, 3625.4018087015875, 3685.9262814743556, 3754.4931434256573, 3771.9434208486896, 3772.3775577029483, 1071.8499410082595, 1084.6366467233408, 1092.1099304067159, 1101.9063379612824, 1102.415719668577, 1001.6444162322271, 1011.3982180602529, 1019.1184625299063, 1025.9076683098558, 1028.665683652816, 6035.577509574287, 6133.202683651186, 6181.907271390933, 6240.5319601030105, 6346.524010699216, 450.07060420232114, 457.97939092740904, 464.02091586751925, 466.9066186762661, 1021.6475316015963, 4185.811638476276, 4379.671524635665, 4401.0, 4402.0, 4448.065906159743, 10453.21600879937, 10794.352338859537, 10795.0, 10820.567177312976, 10844.13246940243, 10739.355638661706, 10758.246922715334, 10762.139028877671, 10765.192610554239, 10767.192460565333, 7876.921230787733, 8171.10117887032, 8199.0, 8227.71203007892, 8365.372597055246, 6026.367231440811, 6176.166217560752, 6189.288231853395, 6243.43809057187, 6308.400701933309, 10071.647492337734, 10079.798404032024, 10250.53872575721, 10295.639652612123, 10319.174466042849, 9840.45877476717, 10002.349847259904, 10339.121174700234, 10385.63650272237, 10479.738006549593, 6965.825854353681, 7998.120206777367, 8045.87931181021, 8143.226393492609, 8337.082920878578, 8342.958285208779, 8605.870911936452, 8610.05289418151, 8616.655333786579, 8618.612162452579, 7554.357879580297, 7567.810804729926, 7592.16486186508, 7620.314171724572, 7874.881876771968, 7475.4019678426685, 7529.247075292646, 7562.0, 7632.771016869503, 7656.961715191611, 7124.536905101152, 7242.6740796663225, 7243.529170603894, 7247.637618119178, 7267.127944646676, 5359.383670877899, 5454.809081682122, 5480.588955828409, 5484.506394424521, 5634.52106570946, 5425.430329815313, 5474.069408200695, 5495.862603434946, 5498.615096943336, 5607.971960140337], "value": 4560.869977843796, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.26671721152013, 311.2902582112783, 321.84229727433564, 322.68699361619224, 323.0792242109987, 5109.744512774365, 5186.0, 5244.557746619676, 5291.259223708679, 5299.602529810265, 5204.698825293676, 5205.193195054772, 5216.556592689626, 5219.217117432387, 5255.237990491386, 4112.609302116294, 4118.238125946695, 4130.772807495594, 4139.917201655965, 4180.3729440584, 3974.940375894364, 4072.5927407259333, 4165.375193720935, 4170.249355116078, 4185.644220241283, 4029.9395509067385, 4050.1697152083752, 4056.9797151014204, 4088.3458646616546, 4091.774952377618, 4086.1827634473075, 4089.6319331260033, 4113.177364527107, 4121.443605113332, 4138.6482149017365, 3580.6240344763687, 3648.4858783605036, 3673.3938900081453, 3680.0, 3687.1748484500345, 5075.720835354054, 5108.795648174106, 5116.923246151311, 5127.359080114986, 5138.897222055538, 4691.835785747482, 4695.436547614274, 4696.131215725068, 4699.459562150362, 4731.266653668687, 5322.441143679896, 5367.329083864517, 5436.836894893159, 5476.58925580583, 5531.225628412026, 3957.5053118360206, 3963.207358528277, 3977.3238549446664, 3977.3835055566433, 3977.9005524861823, 5663.801766938179, 5670.773169073233, 5684.488396044335, 5696.11710184922, 5710.743016564223, 4013.8996525086523, 4069.206504731549, 4083.5099788025627, 4104.651104656137, 4127.422160897477, 4123.793810309473, 4128.814203360856, 4129.15352352767, 4149.481314835645, 4181.414601955728, 4690.6951048182445, 4701.6003639690325, 4717.693349932243, 4722.409698787652, 4741.502142275081, 5386.730663466811, 5466.644668096561, 5502.312210973629, 5520.647441376888, 5525.392206857323, 1342.1879762743595, 1368.5141774669848, 1371.945122195101, 1372.9702722957782, 1377.7106807570322, 958.4568844160896, 966.2559828931824, 971.2521358553875, 989.9851502227473, 992.6575331510618, 5240.371155461369, 5256.842294731164, 5264.526192642604, 5289.338832645919, 5332.693490094952, 5497.065498865202, 5566.248556444828, 5581.832545023656, 5587.106063029895, 5623.437656234426, 5234.712090835041, 5238.476152384731, 5249.921251181236, 5250.212468129811, 5262.7631756571045, 2881.2940829496906, 2934.6038284831275, 2941.8823247070304, 2973.2864112612815, 2978.7914845960577, 5653.858653533694, 5680.6591604503865, 5703.942960570341, 5710.65736055838, 5711.971440142773, 5602.663840169603, 5603.495685388335, 5607.523360514402, 5631.8592035199445, 5678.659280443104, 5459.918101228484, 5716.571257155647, 5744.971275143597, 5789.247397838254, 5806.0, 5557.666540007613, 5562.110062389998, 5567.47109024642, 5604.523615492729, 5611.57913156523, 5478.808241711521, 5481.917771233355, 5486.177073439016, 5512.228288039758, 5546.334439867242, 5505.119180931032, 5674.319081710221, 5680.857978550569, 5686.459786320458, 5694.800681976111, 4050.784764570676, 4053.3717273822604, 4073.1650011748116, 4074.6129117733767, 4097.815598298024, 5467.398586155599, 5517.641353312022, 5574.749136288958, 5596.949662433902, 5597.216389705363, 5368.22160786676, 5383.9002788911575, 5424.728763561727, 5438.428964958623, 5448.264484294569, 5222.12003678683, 5280.471952804689, 5315.654482458628, 5321.308229930084, 5418.539424148834, 5241.6068794839775, 5370.570354371719, 5397.892042159214, 5415.214793854948, 5417.756200971045, 5442.836714898559, 5461.371942226695, 5496.230527726041, 5506.0089183947275, 5508.531774799027, 5169.276301317894, 5389.326334208224, 5394.892102158014, 5413.133898576209, 5421.783128674809], "value": 4178.416974961801, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.4378063465258, 840.4915026409022, 844.6156998565649, 851.4167795060382, 862.0904945282732, 15074.92462537687, 16912.577185570353, 17598.472045838615, 17664.646707065865, 18434.907825460887, 16233.26950287237, 16298.755518667229, 16298.83701162991, 16310.510684679479, 16340.264688089035, 684.2473279392678, 811.4319976016783, 832.2052439919893, 833.3458235285302, 833.729038062629, 812.6708682983372, 833.8415701016787, 834.3867257565685, 836.9078352749659, 837.8826964225013, 875.5709702245886, 877.442823806884, 880.1286726141138, 881.6253092435721, 882.8322618702426, 702.9718811247595, 865.1348651348651, 866.6143566113083, 866.9219770220678, 867.6312567158964, 610.7709608896664, 628.852219728368, 629.559308484063, 629.7606909374455, 630.6184758221256, 15387.53837384869, 15524.456644017519, 15551.611209719735, 15574.299156537983, 15593.220338983005, 14459.71080578393, 14535.854641453556, 14718.484853030093, 14757.114573125647, 14784.630384240372, 13316.600501984956, 13396.799048014287, 13418.329083545881, 13431.597052088453, 13510.32448377587, 3923.2741942740686, 4112.629863312286, 4491.0, 4569.383133276999, 4680.531946805327, 77677.22322776756, 78760.60619696922, 81576.0, 81864.59067704623, 84212.57893710492, 12046.819297710541, 12150.939245303716, 12242.303241603093, 12314.568990085305, 12458.75082498345, 22524.436889077577, 22650.773492265194, 22733.43166420853, 22743.658845117337, 22811.429714256945, 8470.618822153017, 8522.74431767048, 8580.35647326453, 8722.781930451663, 9142.862857057149, 4778.641601879804, 4807.419606828512, 4890.510948905081, 5052.3937127544195, 5079.619028572872, 3453.240287136826, 3549.0, 3550.55618047744, 3550.5916819565564, 3552.5559305086863, 606.6996836565928, 607.4684650930436, 618.1068356225211, 625.3652542669195, 631.3150231998242, 621.3941407128013, 640.471610920992, 656.0847617573459, 668.8227619680788, 709.5636183746958, 9346.915517879084, 9916.893079750726, 10030.197584193393, 10152.746181345377, 10276.482261845895, 645.6965226343611, 661.7419206509466, 723.8841785314324, 737.8671839069019, 739.8668239716902, 4610.585047345755, 4961.875953101129, 5000.374953130859, 5011.448740638527, 5018.723970181602, 71094.64452677807, 77301.0, 87396.12603874007, 125610.0, 125645.37177314238, 99183.50408248056, 101596.49201753944, 102888.48555757174, 104385.47807260916, 107640.0, 55247.72376138174, 88713.11286887049, 90853.0, 90881.54559227162, 92192.53903730573, 9442.433453992782, 9475.620975161191, 9501.904980950101, 9559.139677429064, 9753.707388778348, 52575.737121314145, 53133.0, 53149.20276195783, 54087.45912540824, 55641.0, 65968.6701566489, 67376.326236737, 68899.31100688929, 74975.25024749682, 76109.23890761021, 13571.1857288563, 13707.931460343034, 13893.791593125909, 14275.571732848031, 14301.928490357897, 15400.306986185873, 15924.442644507386, 16227.918860406095, 17154.571135721708, 17306.74039889428, 14663.0, 15052.924735376253, 15271.770923435935, 15683.561318889711, 15868.127253001196, 14431.49489767853, 15177.6205594861, 15281.46514871974, 15646.608834778766, 16371.181440928143, 14792.852071479147, 14916.776248356065, 15084.321205545997, 15324.923375383052, 15735.213239337758, 12195.573154939535, 12270.693232669255, 12302.876971230173, 12329.691757706129, 12662.620121396005, 11447.713807154887, 12185.634430967086, 12586.748265034465, 12791.808122877977, 12890.226586404846], "value": 7861.3577717312455, "unit": "score"}], "name": "dromaeo_css", "value": 7146.890794648014, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 111.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 117.0, 127.0, 176.0, 117.0, 125.0, 146.0, 120.0, 173.0, 118.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 160.0, 161.0, 162.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 123.0, 76.0, 76.0, 74.0, 74.0, 111.0, 75.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 116.0, 85.0, 84.0, 84.0, 124.0, 83.0, 84.0, 126.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 145.0, 146.0, 147.0, 146.0, 145.0, 145.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 96.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 51.0, 51.0, 53.0, 53.0, 53.0, 52.0, 52.0, 51.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 64.0, 73.0, 64.0, 63.0, 62.0, 63.0, 64.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 76.0, 76.0, 76.0, 75.0, 75.0, 75.0, 74.0, 80.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 119.0, 120.0, 120.0, 120.0, 119.0, 119.0, 128.0, 165.0, 120.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 157.0, 157.0, 155.0, 158.0, 153.0, 160.0, 154.0, 159.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 65.0, 61.0, 63.0, 62.0, 66.0, 61.0, 61.0, 60.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1479.0, "alertThreshold": 2.0}]} 16:43:25 INFO - Return code: 0 16:43:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:43:25 INFO - # TBPL SUCCESS # 16:43:25 INFO - Running post-action listener: _resource_record_post_action 16:43:25 INFO - [mozharness: 2016-07-27 23:43:25.065816Z] Finished run-tests step (success) 16:43:25 INFO - Running post-run listener: _resource_record_post_run 16:43:25 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 557170688; Read time: 0; Write time: 416528 16:43:25 INFO - TinderboxPrint: CPU usage
13.0% 16:43:25 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:43:25 INFO - TinderboxPrint: I/O write bytes / time
557,170,688 / 416,528 16:43:25 INFO - TinderboxPrint: CPU idle
8,273.1 (87.0%) 16:43:25 INFO - TinderboxPrint: CPU user
1,189.1 (12.5%) 16:43:25 INFO - TinderboxPrint: Swap in / out
0 / 0 16:43:25 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 264032256; Read time: 0; Write time: 235328 16:43:25 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 293138432; Read time: 0; Write time: 181200 16:43:25 INFO - Running post-run listener: _upload_blobber_files 16:43:25 INFO - Blob upload gear active. 16:43:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:43:25 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 16:43:25 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'] 16:43:25 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 16:43:26 INFO - (blobuploader) - INFO - Open directory for files ... 16:43:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:43:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:43:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:26 INFO - (blobuploader) - INFO - Done attempting. 16:43:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:43:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:43:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:27 INFO - (blobuploader) - INFO - Done attempting. 16:43:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:43:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:43:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:31 INFO - (blobuploader) - INFO - Done attempting. 16:43:31 INFO - (blobuploader) - INFO - Iteration through files over. 16:43:31 INFO - Return code: 0 16:43:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:43:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:43:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4ce27d3e3d108e404015624010b35556d688dd9b20adc494191f3391325db34aa3356157bc323b4852ca29518f82d3a76a0f9ec611e8f3909131c0d9fbb4267c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/135002941d3f828e84e6b024cd46f289d1cbeed19d7f887167f3a3ca330791ed67189bad44c9736c9431846144d25e3b842301a1b25dae6b44d0c71de9002f34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6aa9b25c88b612788c04f9919056f292b44fd196ef37616bf37700aa094dd511279d3f1ebd129b70daf02fd6e218e0eed5da6c73511ac0a417bdbdd0ed47eeaa"} 16:43:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:43:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:43:31 INFO - Contents: 16:43:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4ce27d3e3d108e404015624010b35556d688dd9b20adc494191f3391325db34aa3356157bc323b4852ca29518f82d3a76a0f9ec611e8f3909131c0d9fbb4267c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/135002941d3f828e84e6b024cd46f289d1cbeed19d7f887167f3a3ca330791ed67189bad44c9736c9431846144d25e3b842301a1b25dae6b44d0c71de9002f34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6aa9b25c88b612788c04f9919056f292b44fd196ef37616bf37700aa094dd511279d3f1ebd129b70daf02fd6e218e0eed5da6c73511ac0a417bdbdd0ed47eeaa"} 16:43:31 INFO - Running post-run listener: copy_logs_to_upload_dir 16:43:31 INFO - Copying logs to upload dir... 16:43:31 INFO - mkdir: /builds/slave/test/build/upload/logs 16:43:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.798403 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-27 16:43:30.921403) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 16:43:30.927022) ========= 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=bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447 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/4ce27d3e3d108e404015624010b35556d688dd9b20adc494191f3391325db34aa3356157bc323b4852ca29518f82d3a76a0f9ec611e8f3909131c0d9fbb4267c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/135002941d3f828e84e6b024cd46f289d1cbeed19d7f887167f3a3ca330791ed67189bad44c9736c9431846144d25e3b842301a1b25dae6b44d0c71de9002f34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6aa9b25c88b612788c04f9919056f292b44fd196ef37616bf37700aa094dd511279d3f1ebd129b70daf02fd6e218e0eed5da6c73511ac0a417bdbdd0ed47eeaa"} build_url:https://queue.taskcluster.net/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/ZYapLKMqTZaGUi3DS5O9Xw/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/4ce27d3e3d108e404015624010b35556d688dd9b20adc494191f3391325db34aa3356157bc323b4852ca29518f82d3a76a0f9ec611e8f3909131c0d9fbb4267c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/135002941d3f828e84e6b024cd46f289d1cbeed19d7f887167f3a3ca330791ed67189bad44c9736c9431846144d25e3b842301a1b25dae6b44d0c71de9002f34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6aa9b25c88b612788c04f9919056f292b44fd196ef37616bf37700aa094dd511279d3f1ebd129b70daf02fd6e218e0eed5da6c73511ac0a417bdbdd0ed47eeaa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 16:43:30.957021) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 16:43:30.957364) ========= 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=bb9b54edd4a927dc735d112f000001d9-1469661779.743114-1366265447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 16:43:31.041106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 16:43:31.041438) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 16:43:31.041755) ========= ========= Total master_lag: 0.17 =========