builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1469737672.72 results: success (0) buildid: 20160728103037 builduid: 1c819480ab384290816389e326b0c021 revision: 410cc90a90da1146d73bb27b3e3018a5be95db6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 13:27:52.724725) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 13:27:52.725252) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 13:27:52.725572) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 13:27:52.741225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:27:52.741535) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 13:27:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-28 13:27:53 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196918 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:27:52.952544) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:27:52.952849) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019862 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:27:53.001830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-07-28 13:27:53.002181) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 410cc90a90da1146d73bb27b3e3018a5be95db6a --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 410cc90a90da1146d73bb27b3e3018a5be95db6a --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=78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 13:27:53,218 truncating revision to first 12 chars 2016-07-28 13:27:53,218 Setting DEBUG logging. 2016-07-28 13:27:53,218 attempt 1/10 2016-07-28 13:27:53,218 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/410cc90a90da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 13:27:53,721 unpacking tar archive at: mozilla-inbound-410cc90a90da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.859773 ========= master_lag: 3.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-07-28 13:27:57.147062) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 13:27:57.147381) ========= script_repo_revision: 410cc90a90da1146d73bb27b3e3018a5be95db6a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 13:27:57.147759) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 13:27:57.148016) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 13:27:57.389480) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-28 13:27:57.389755) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:27:57 INFO - MultiFileLogger online at 20160728 13:27:57 in /builds/slave/test 13:27:57 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 13:27:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:27:57 INFO - {'append_to_log': False, 13:27:57 INFO - 'base_work_dir': '/builds/slave/test', 13:27:57 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:27:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:27:57 INFO - 'branch': 'Mozilla-Inbound', 13:27:57 INFO - 'buildbot_json_path': 'buildprops.json', 13:27:57 INFO - 'config_files': ('talos/linux_config.py',), 13:27:57 INFO - 'default_actions': ('clobber', 13:27:57 INFO - 'read-buildbot-config', 13:27:57 INFO - 'download-and-extract', 13:27:57 INFO - 'populate-webroot', 13:27:57 INFO - 'create-virtualenv', 13:27:57 INFO - 'install', 13:27:57 INFO - 'run-tests'), 13:27:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:27:57 INFO - 'download_minidump_stackwalk': True, 13:27:57 INFO - 'download_symbols': 'ondemand', 13:27:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:27:57 INFO - 'tooltool.py': '/tools/tooltool.py', 13:27:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:27:57 INFO - '/tools/misc-python/virtualenv.py')}, 13:27:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:27:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:27:57 INFO - 'installer_path': 'installer.exe', 13:27:57 INFO - 'log_level': 'info', 13:27:57 INFO - 'log_name': 'talos', 13:27:57 INFO - 'log_to_console': True, 13:27:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:27:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:27:57 INFO - 'opt_config_files': (), 13:27:57 INFO - 'pip_index': False, 13:27:57 INFO - 'sps_profile': False, 13:27:57 INFO - 'sps_profile_interval': 0, 13:27:57 INFO - 'suite': 'dromaeojs', 13:27:57 INFO - 'system_bits': '32', 13:27:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:27:57 INFO - 'title': 'talos-linux64-ix-019', 13:27:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:27:57 INFO - 'use_talos_json': True, 13:27:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:27:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:27:57 INFO - 'work_dir': 'build'} 13:27:57 INFO - [mozharness: 2016-07-28 20:27:57.699254Z] Running clobber step. 13:27:57 INFO - Running pre-action listener: _resource_record_pre_action 13:27:57 INFO - Running main action method: clobber 13:27:57 INFO - rmtree: /builds/slave/test/build 13:27:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:27:58 INFO - Running post-action listener: _resource_record_post_action 13:27:58 INFO - [mozharness: 2016-07-28 20:27:58.688654Z] Finished clobber step (success) 13:27:58 INFO - [mozharness: 2016-07-28 20:27:58.688757Z] Running read-buildbot-config step. 13:27:58 INFO - Running pre-action listener: _resource_record_pre_action 13:27:58 INFO - Running main action method: read_buildbot_config 13:27:58 INFO - Using buildbot properties: 13:27:58 INFO - { 13:27:58 INFO - "project": "", 13:27:58 INFO - "product": "firefox", 13:27:58 INFO - "script_repo_revision": "production", 13:27:58 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:27:58 INFO - "repository": "", 13:27:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:27:58 INFO - "buildid": "20160728103037", 13:27:58 INFO - "pgo_build": "True", 13:27:58 INFO - "basedir": "/builds/slave/test", 13:27:58 INFO - "buildnumber": 1316, 13:27:58 INFO - "slavename": "talos-linux64-ix-019", 13:27:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:27:58 INFO - "platform": "ubuntu64_hw", 13:27:58 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:27:58 INFO - "branch": "mozilla-inbound", 13:27:58 INFO - "repo_path": "integration/mozilla-inbound", 13:27:58 INFO - "revision": "410cc90a90da1146d73bb27b3e3018a5be95db6a", 13:27:58 INFO - "stage_platform": "linux64-pgo", 13:27:58 INFO - "builduid": "1c819480ab384290816389e326b0c021", 13:27:58 INFO - "slavebuilddir": "test" 13:27:58 INFO - } 13:27:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:27:58 INFO - Running post-action listener: _resource_record_post_action 13:27:58 INFO - [mozharness: 2016-07-28 20:27:58.691230Z] Finished read-buildbot-config step (success) 13:27:58 INFO - [mozharness: 2016-07-28 20:27:58.691320Z] Running download-and-extract step. 13:27:58 INFO - Running pre-action listener: _resource_record_pre_action 13:27:58 INFO - Running main action method: download_and_extract 13:27:58 INFO - mkdir: /builds/slave/test/build/tests 13:27:58 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')]} 13:27:58 INFO - https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:27:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:27:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:27:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:27:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:27:59 INFO - Downloaded 1361 bytes. 13:27:59 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:27:59 INFO - Using the following test package requirements: 13:27:59 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:27:59 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:27:59 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:27:59 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:59 INFO - u'jsshell-linux-x86_64.zip'], 13:27:59 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:27:59 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:27:59 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:27:59 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:27:59 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:27:59 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:27:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:59 INFO - https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:27:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:27:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:27:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:28:00 INFO - Downloaded 24321409 bytes. 13:28:00 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'] 13:28:00 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 13:28:01 INFO - Return code: 0 13:28:01 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 13:28:01 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')]} 13:28:01 INFO - https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:28:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:28:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:28:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:28:02 INFO - Downloaded 24321409 bytes. 13:28:02 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'] 13:28:02 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 13:28:04 INFO - Return code: 0 13:28:04 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')]} 13:28:04 INFO - https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:28:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:28:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:28:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:28:05 INFO - Downloaded 14413725 bytes. 13:28:05 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'] 13:28:05 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 13:28:05 INFO - Return code: 0 13:28: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')]} 13:28:05 INFO - https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:28:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:28:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:28:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:28:06 INFO - Downloaded 60998942 bytes. 13:28:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:28:06 INFO - mkdir: /builds/slave/test/properties 13:28:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:28:06 INFO - Writing to file /builds/slave/test/properties/build_url 13:28:06 INFO - Contents: 13:28:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:28:07 INFO - Running post-action listener: _resource_record_post_action 13:28:07 INFO - Running post-action listener: set_extra_try_arguments 13:28:07 INFO - [mozharness: 2016-07-28 20:28:07.556612Z] Finished download-and-extract step (success) 13:28:07 INFO - [mozharness: 2016-07-28 20:28:07.556941Z] Running populate-webroot step. 13:28:07 INFO - Running pre-action listener: _resource_record_pre_action 13:28:07 INFO - Running main action method: populate_webroot 13:28:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:28:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:28:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:28:07 INFO - '--tppagecycles', 13:28:07 INFO - '7'], 13:28:07 INFO - 'tests': ['tsvgm']}}, 13:28:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:28:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:28:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:28:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:28:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:28:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:28:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:07 INFO - 'talos_options': ['--disable-e10s'], 13:28:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:28:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:28:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:07 INFO - 'talos_options': ['--disable-e10s'], 13:28:07 INFO - 'tests': ['damp', 'tps']}, 13:28:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:07 INFO - 'tests': ['damp', 'tps']}, 13:28:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:28:07 INFO - 'tests': ['dromaeo_dom']}, 13:28:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:28:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:28:07 INFO - 'tests': ['basic_compositor_video']}, 13:28:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:28:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:28:07 INFO - 'tests': ['a11yr', 13:28:07 INFO - 'ts_paint', 13:28:07 INFO - 'tpaint', 13:28:07 INFO - 'sessionrestore', 13:28:07 INFO - 'sessionrestore_no_auto_restore', 13:28:07 INFO - 'tabpaint']}, 13:28:07 INFO - 'other-e10s': {'tests': ['a11yr', 13:28:07 INFO - 'ts_paint', 13:28:07 INFO - 'tpaint', 13:28:07 INFO - 'sessionrestore', 13:28:07 INFO - 'sessionrestore_no_auto_restore', 13:28:07 INFO - 'tabpaint']}, 13:28:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:28:07 INFO - 'ts_paint', 13:28:07 INFO - 'tpaint', 13:28:07 INFO - 'sessionrestore', 13:28:07 INFO - 'sessionrestore_no_auto_restore', 13:28:07 INFO - 'tabpaint']}, 13:28:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:28:07 INFO - 'ts_paint', 13:28:07 INFO - 'tpaint', 13:28:07 INFO - 'sessionrestore', 13:28:07 INFO - 'sessionrestore_no_auto_restore', 13:28:07 INFO - 'tabpaint']}, 13:28:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:28:07 INFO - 'tests': ['a11yr', 13:28:07 INFO - 'ts_paint', 13:28:07 INFO - 'tpaint', 13:28:07 INFO - 'sessionrestore', 13:28:07 INFO - 'sessionrestore_no_auto_restore', 13:28:07 INFO - 'tabpaint']}, 13:28:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:28:07 INFO - 'tests': ['a11yr', 13:28:07 INFO - 'ts_paint', 13:28:07 INFO - 'tpaint', 13:28:07 INFO - 'sessionrestore', 13:28:07 INFO - 'sessionrestore_no_auto_restore', 13:28:07 INFO - 'tabpaint']}, 13:28:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:28:07 INFO - 'tests': ['tsvgx', 13:28:07 INFO - 'tsvgr_opacity', 13:28:07 INFO - 'tart', 13:28:07 INFO - 'tscrollx', 13:28:07 INFO - 'cart']}, 13:28:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:28:07 INFO - 'tsvgr_opacity', 13:28:07 INFO - 'tart', 13:28:07 INFO - 'tscrollx', 13:28:07 INFO - 'cart']}, 13:28:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:07 INFO - 'talos_options': ['--disable-e10s'], 13:28:07 INFO - 'tests': ['tp5o']}, 13:28:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:07 INFO - 'tests': ['tp5o']}, 13:28:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:07 INFO - 'talos_options': ['--disable-e10s', 13:28:07 INFO - '--xperf_path', 13:28:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:28:07 INFO - 'tests': ['tp5n']}, 13:28:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:07 INFO - 'talos_options': ['--xperf_path', 13:28:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:28:07 INFO - 'tests': ['tp5n']}}, 13:28:07 INFO - 'talos.zip': {'path': '', 13:28:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:28:07 INFO - Running post-action listener: _resource_record_post_action 13:28:07 INFO - [mozharness: 2016-07-28 20:28:07.575799Z] Finished populate-webroot step (success) 13:28:07 INFO - [mozharness: 2016-07-28 20:28:07.575907Z] Running create-virtualenv step. 13:28:07 INFO - Running pre-action listener: _resource_record_pre_action 13:28:07 INFO - Running main action method: create_virtualenv 13:28:07 INFO - Creating virtualenv /builds/slave/test/build/venv 13:28:07 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 13:28:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:28:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:28:07 INFO - Using real prefix '/usr' 13:28:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:28:08 INFO - Installing distribute.............................................................................................................................................................................................done. 13:28:10 INFO - Installing pip.................done. 13:28:10 INFO - Return code: 0 13:28:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:10 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 0x2514030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33b0>, '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 0x27d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', '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 13:28:10 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 13:28:10 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 13:28:10 INFO - Using env: {'DISPLAY': ':0', 13:28:10 INFO - 'HOME': '/home/cltbld', 13:28:10 INFO - 'LANG': 'en_US.UTF-8', 13:28:10 INFO - 'LANGUAGE': 'en_US:en', 13:28:10 INFO - 'LOGNAME': 'cltbld', 13:28:10 INFO - 'MAIL': '/var/mail/cltbld', 13:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:10 INFO - 'MOZ_NO_REMOTE': '1', 13:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:10 INFO - 'NO_EM_RESTART': '1', 13:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:10 INFO - 'PWD': '/builds/slave/test', 13:28:10 INFO - 'SHELL': '/bin/bash', 13:28:10 INFO - 'SHLVL': '1', 13:28:10 INFO - 'TERM': 'linux', 13:28:10 INFO - 'TMOUT': '86400', 13:28:10 INFO - 'USER': 'cltbld', 13:28:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', 13:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:10 INFO - '_': '/tools/buildbot/bin/python'} 13:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:10 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 13:28:10 INFO - Cleaning up... 13:28:10 INFO - Return code: 0 13:28:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:10 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 0x2514030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33b0>, '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 0x27d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', '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 13:28:10 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 13:28:10 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 13:28:10 INFO - Using env: {'DISPLAY': ':0', 13:28:10 INFO - 'HOME': '/home/cltbld', 13:28:10 INFO - 'LANG': 'en_US.UTF-8', 13:28:10 INFO - 'LANGUAGE': 'en_US:en', 13:28:10 INFO - 'LOGNAME': 'cltbld', 13:28:10 INFO - 'MAIL': '/var/mail/cltbld', 13:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:10 INFO - 'MOZ_NO_REMOTE': '1', 13:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:10 INFO - 'NO_EM_RESTART': '1', 13:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:10 INFO - 'PWD': '/builds/slave/test', 13:28:10 INFO - 'SHELL': '/bin/bash', 13:28:10 INFO - 'SHLVL': '1', 13:28:10 INFO - 'TERM': 'linux', 13:28:10 INFO - 'TMOUT': '86400', 13:28:10 INFO - 'USER': 'cltbld', 13:28:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', 13:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:10 INFO - '_': '/tools/buildbot/bin/python'} 13:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:10 INFO - Downloading/unpacking psutil>=3.1.1 13:28:10 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 13:28:10 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 13:28:10 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 13:28:10 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 13:28:10 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 13:28:10 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 13:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:28:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:28:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:28:12 INFO - Installing collected packages: psutil 13:28:12 INFO - Running setup.py install for psutil 13:28:12 INFO - building 'psutil._psutil_linux' extension 13:28:12 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 13:28:12 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 13:28:12 INFO - building 'psutil._psutil_posix' extension 13:28:12 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 13:28:12 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 13:28:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:28:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:28:13 INFO - Successfully installed psutil 13:28:13 INFO - Cleaning up... 13:28:13 INFO - Return code: 0 13:28:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:28: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')]} 13:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28: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')]} 13:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2514030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33b0>, '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 0x27d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', '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 13:28: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:28: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 mozsystemmonitor==0.3 13:28:13 INFO - Using env: {'DISPLAY': ':0', 13:28:13 INFO - 'HOME': '/home/cltbld', 13:28:13 INFO - 'LANG': 'en_US.UTF-8', 13:28:13 INFO - 'LANGUAGE': 'en_US:en', 13:28:13 INFO - 'LOGNAME': 'cltbld', 13:28:13 INFO - 'MAIL': '/var/mail/cltbld', 13:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:13 INFO - 'MOZ_NO_REMOTE': '1', 13:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:13 INFO - 'NO_EM_RESTART': '1', 13:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:13 INFO - 'PWD': '/builds/slave/test', 13:28:13 INFO - 'SHELL': '/bin/bash', 13:28:13 INFO - 'SHLVL': '1', 13:28:13 INFO - 'TERM': 'linux', 13:28:13 INFO - 'TMOUT': '86400', 13:28:13 INFO - 'USER': 'cltbld', 13:28:13 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', 13:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:13 INFO - '_': '/tools/buildbot/bin/python'} 13:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:13 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 13:28:13 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 13:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:28:15 INFO - Installing collected packages: mozsystemmonitor 13:28:15 INFO - Running setup.py install for mozsystemmonitor 13:28:15 INFO - Successfully installed mozsystemmonitor 13:28:15 INFO - Cleaning up... 13:28:15 INFO - Return code: 0 13:28:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:28:15 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')]} 13:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:15 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')]} 13:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:15 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 0x2514030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33b0>, '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 0x27d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', '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 13:28:15 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 13:28:15 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 13:28:15 INFO - Using env: {'DISPLAY': ':0', 13:28:15 INFO - 'HOME': '/home/cltbld', 13:28:15 INFO - 'LANG': 'en_US.UTF-8', 13:28:15 INFO - 'LANGUAGE': 'en_US:en', 13:28:15 INFO - 'LOGNAME': 'cltbld', 13:28:15 INFO - 'MAIL': '/var/mail/cltbld', 13:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:15 INFO - 'MOZ_NO_REMOTE': '1', 13:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:15 INFO - 'NO_EM_RESTART': '1', 13:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:15 INFO - 'PWD': '/builds/slave/test', 13:28:15 INFO - 'SHELL': '/bin/bash', 13:28:15 INFO - 'SHLVL': '1', 13:28:15 INFO - 'TERM': 'linux', 13:28:15 INFO - 'TMOUT': '86400', 13:28:15 INFO - 'USER': 'cltbld', 13:28:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', 13:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:15 INFO - '_': '/tools/buildbot/bin/python'} 13:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:15 INFO - Downloading/unpacking jsonschema==2.5.1 13:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:15 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 13:28:15 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 13:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:28:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:28: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 13:28: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 13:28: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 13:28: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 13:28: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 13:28: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 13:28:17 INFO - Downloading functools32-3.2.3-2.tar.gz 13:28:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:28:17 INFO - warning: no files found matching '*.txt' 13:28:17 INFO - no previously-included directories found matching 'build' 13:28:17 INFO - no previously-included directories found matching 'dist' 13:28:17 INFO - no previously-included directories found matching '.git*' 13:28:17 INFO - Installing collected packages: jsonschema, functools32 13:28:17 INFO - Running setup.py install for functools32 13:28:18 INFO - warning: no files found matching '*.txt' 13:28:18 INFO - no previously-included directories found matching 'build' 13:28:18 INFO - no previously-included directories found matching 'dist' 13:28:18 INFO - no previously-included directories found matching '.git*' 13:28:18 INFO - Successfully installed jsonschema functools32 13:28:18 INFO - Cleaning up... 13:28:18 INFO - Return code: 0 13:28:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:18 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 0x2514030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33b0>, '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 0x27d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', '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 13:28:18 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 13:28:18 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 13:28:18 INFO - Using env: {'DISPLAY': ':0', 13:28:18 INFO - 'HOME': '/home/cltbld', 13:28:18 INFO - 'LANG': 'en_US.UTF-8', 13:28:18 INFO - 'LANGUAGE': 'en_US:en', 13:28:18 INFO - 'LOGNAME': 'cltbld', 13:28:18 INFO - 'MAIL': '/var/mail/cltbld', 13:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:18 INFO - 'MOZ_NO_REMOTE': '1', 13:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:18 INFO - 'NO_EM_RESTART': '1', 13:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:18 INFO - 'PWD': '/builds/slave/test', 13:28:18 INFO - 'SHELL': '/bin/bash', 13:28:18 INFO - 'SHLVL': '1', 13:28:18 INFO - 'TERM': 'linux', 13:28:18 INFO - 'TMOUT': '86400', 13:28:18 INFO - 'USER': 'cltbld', 13:28:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', 13:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:18 INFO - '_': '/tools/buildbot/bin/python'} 13:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:28:18 INFO - Cleaning up... 13:28:18 INFO - Return code: 0 13:28:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:18 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 0x2514030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33b0>, '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 0x27d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', '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 13:28:18 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 13:28:18 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 13:28:18 INFO - Using env: {'DISPLAY': ':0', 13:28:18 INFO - 'HOME': '/home/cltbld', 13:28:18 INFO - 'LANG': 'en_US.UTF-8', 13:28:18 INFO - 'LANGUAGE': 'en_US:en', 13:28:18 INFO - 'LOGNAME': 'cltbld', 13:28:18 INFO - 'MAIL': '/var/mail/cltbld', 13:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:18 INFO - 'MOZ_NO_REMOTE': '1', 13:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:18 INFO - 'NO_EM_RESTART': '1', 13:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:18 INFO - 'PWD': '/builds/slave/test', 13:28:18 INFO - 'SHELL': '/bin/bash', 13:28:18 INFO - 'SHLVL': '1', 13:28:18 INFO - 'TERM': 'linux', 13:28:18 INFO - 'TMOUT': '86400', 13:28:18 INFO - 'USER': 'cltbld', 13:28:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', 13:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:18 INFO - '_': '/tools/buildbot/bin/python'} 13:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:18 INFO - Downloading/unpacking blobuploader==1.2.4 13:28:18 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 13:28:18 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 13:28:18 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 13:28:18 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 13:28:18 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 13:28:18 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 13:28:20 INFO - Downloading blobuploader-1.2.4.tar.gz 13:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:28:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:28:20 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 13:28:20 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 13:28:20 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 13:28:20 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 13:28:20 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 13:28:20 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 13:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:28:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:28:20 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 13:28:20 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 13:28:20 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 13:28:20 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 13:28:20 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 13:28:20 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 13:28:21 INFO - Downloading docopt-0.6.1.tar.gz 13:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:28:21 INFO - Installing collected packages: blobuploader, requests, docopt 13:28:21 INFO - Running setup.py install for blobuploader 13:28:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:28:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:28:21 INFO - Running setup.py install for requests 13:28:21 INFO - Running setup.py install for docopt 13:28:21 INFO - Successfully installed blobuploader requests docopt 13:28:21 INFO - Cleaning up... 13:28:21 INFO - Return code: 0 13:28:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:28: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')]} 13:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28: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')]} 13:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:21 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 0x2514030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33b0>, '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 0x27d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', '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 13:28:21 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 13:28:21 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 13:28:21 INFO - Using env: {'DISPLAY': ':0', 13:28:21 INFO - 'HOME': '/home/cltbld', 13:28:21 INFO - 'LANG': 'en_US.UTF-8', 13:28:21 INFO - 'LANGUAGE': 'en_US:en', 13:28:21 INFO - 'LOGNAME': 'cltbld', 13:28:21 INFO - 'MAIL': '/var/mail/cltbld', 13:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:21 INFO - 'MOZ_NO_REMOTE': '1', 13:28:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:21 INFO - 'NO_EM_RESTART': '1', 13:28:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:21 INFO - 'PWD': '/builds/slave/test', 13:28:21 INFO - 'SHELL': '/bin/bash', 13:28:21 INFO - 'SHLVL': '1', 13:28:21 INFO - 'TERM': 'linux', 13:28:21 INFO - 'TMOUT': '86400', 13:28:21 INFO - 'USER': 'cltbld', 13:28:21 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', 13:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:21 INFO - '_': '/tools/buildbot/bin/python'} 13:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:28:22 INFO - Running setup.py (path:/tmp/pip-q1fauI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:28:22 INFO - Running setup.py (path:/tmp/pip-Uo0s9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:28:22 INFO - Running setup.py (path:/tmp/pip-ARyioK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:28:22 INFO - Running setup.py (path:/tmp/pip-vLnUxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:28:22 INFO - Running setup.py (path:/tmp/pip-ALm1c2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:28:22 INFO - Running setup.py (path:/tmp/pip-TcxQ7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:28:22 INFO - Running setup.py (path:/tmp/pip-s1zy4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:28:22 INFO - Running setup.py (path:/tmp/pip-CQNeQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:28:22 INFO - Running setup.py (path:/tmp/pip-yQUio0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:28:22 INFO - Running setup.py (path:/tmp/pip-_fnIx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:28:22 INFO - Running setup.py (path:/tmp/pip-RxbU_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:28:22 INFO - Running setup.py (path:/tmp/pip-kmekMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:28:22 INFO - Running setup.py (path:/tmp/pip-tKFiIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:28:22 INFO - Running setup.py (path:/tmp/pip-wthtic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:28:23 INFO - Running setup.py (path:/tmp/pip-SoTJM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:28:23 INFO - Running setup.py (path:/tmp/pip-0pL2ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:28:23 INFO - Running setup.py (path:/tmp/pip-1in7mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:28:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:28:23 INFO - Running setup.py install for manifestparser 13:28:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:28:23 INFO - Running setup.py install for mozcrash 13:28:23 INFO - Running setup.py install for mozdebug 13:28:23 INFO - Running setup.py install for mozdevice 13:28:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:28:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:28:23 INFO - Running setup.py install for mozfile 13:28:23 INFO - Running setup.py install for mozhttpd 13:28:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:28:23 INFO - Running setup.py install for mozinfo 13:28:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:28:23 INFO - Running setup.py install for mozInstall 13:28:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:28:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:28:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:28:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:28:24 INFO - Running setup.py install for mozleak 13:28:24 INFO - Running setup.py install for mozlog 13:28:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:28:24 INFO - Running setup.py install for moznetwork 13:28:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:28:24 INFO - Running setup.py install for mozprocess 13:28:24 INFO - Running setup.py install for mozprofile 13:28:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:28:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:28:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:28:24 INFO - Running setup.py install for mozrunner 13:28:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:28:24 INFO - Running setup.py install for mozscreenshot 13:28:24 INFO - Running setup.py install for moztest 13:28:24 INFO - Running setup.py install for mozversion 13:28:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:28:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:28:25 INFO - Cleaning up... 13:28:25 INFO - Return code: 0 13:28:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:28: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')]} 13:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28: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')]} 13:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:25 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 0x2514030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33b0>, '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 0x27d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', '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 13:28:25 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 13:28:25 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 13:28:25 INFO - Using env: {'DISPLAY': ':0', 13:28:25 INFO - 'HOME': '/home/cltbld', 13:28:25 INFO - 'LANG': 'en_US.UTF-8', 13:28:25 INFO - 'LANGUAGE': 'en_US:en', 13:28:25 INFO - 'LOGNAME': 'cltbld', 13:28:25 INFO - 'MAIL': '/var/mail/cltbld', 13:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:25 INFO - 'MOZ_NO_REMOTE': '1', 13:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:25 INFO - 'NO_EM_RESTART': '1', 13:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:25 INFO - 'PWD': '/builds/slave/test', 13:28:25 INFO - 'SHELL': '/bin/bash', 13:28:25 INFO - 'SHLVL': '1', 13:28:25 INFO - 'TERM': 'linux', 13:28:25 INFO - 'TMOUT': '86400', 13:28:25 INFO - 'USER': 'cltbld', 13:28:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', 13:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:25 INFO - '_': '/tools/buildbot/bin/python'} 13:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:28:25 INFO - Running setup.py (path:/tmp/pip-cGDTf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:28:25 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)) 13:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:28:25 INFO - Running setup.py (path:/tmp/pip-CqTVuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:28:25 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)) 13:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:28:25 INFO - Running setup.py (path:/tmp/pip-ytCnKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:28:25 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)) 13:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:28:25 INFO - Running setup.py (path:/tmp/pip-EZoMTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:28:25 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)) 13:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:28:25 INFO - Running setup.py (path:/tmp/pip-DXMzUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:28:25 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)) 13:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:28:25 INFO - Running setup.py (path:/tmp/pip-jx2Sgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:28:25 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)) 13:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:28:25 INFO - Running setup.py (path:/tmp/pip-CVSug8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:28:25 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)) 13:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:28:25 INFO - Running setup.py (path:/tmp/pip-RGy_QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:28:25 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)) 13:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:28:25 INFO - Running setup.py (path:/tmp/pip-VA3AeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:28:25 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)) 13:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:28:25 INFO - Running setup.py (path:/tmp/pip-gH17r9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:28:25 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)) 13:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:28:25 INFO - Running setup.py (path:/tmp/pip-SdPpTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:28:26 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)) 13:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:28:26 INFO - Running setup.py (path:/tmp/pip-jXoSz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:28:26 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)) 13:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:28:26 INFO - Running setup.py (path:/tmp/pip-AUrxxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:28:26 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)) 13:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:28:26 INFO - Running setup.py (path:/tmp/pip-G7QS6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:28:26 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)) 13:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:28:26 INFO - Running setup.py (path:/tmp/pip-0OX5sZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:28:26 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)) 13:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:28:26 INFO - Running setup.py (path:/tmp/pip-lkaGpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:28:26 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)) 13:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:28:26 INFO - Running setup.py (path:/tmp/pip-n6gOSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:28:26 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)) 13:28:26 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)) 13:28:26 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)) 13:28:26 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)) 13:28:26 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)) 13:28:26 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)) 13:28:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:28:26 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 13:28:26 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 13:28:26 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 13:28:26 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 13:28:26 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 13:28:26 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 13:28:28 INFO - Downloading blessings-1.6.tar.gz 13:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:28:28 INFO - Installing collected packages: blessings 13:28:28 INFO - Running setup.py install for blessings 13:28:28 INFO - Successfully installed blessings 13:28:28 INFO - Cleaning up... 13:28:28 INFO - Return code: 0 13:28:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:28:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:28:28 INFO - Reading from file tmpfile_stdout 13:28:28 INFO - Current package versions: 13:28:28 INFO - argparse == 1.2.1 13:28:28 INFO - blessings == 1.6 13:28:28 INFO - blobuploader == 1.2.4 13:28:28 INFO - docopt == 0.6.1 13:28:28 INFO - functools32 == 3.2.3-2 13:28:28 INFO - jsonschema == 2.5.1 13:28:28 INFO - manifestparser == 1.1 13:28:28 INFO - mozInstall == 1.12 13:28:28 INFO - mozcrash == 0.17 13:28:28 INFO - mozdebug == 0.1 13:28:28 INFO - mozdevice == 0.48 13:28:28 INFO - mozfile == 1.2 13:28:28 INFO - mozhttpd == 0.7 13:28:28 INFO - mozinfo == 0.9 13:28:28 INFO - mozleak == 0.1 13:28:28 INFO - mozlog == 3.3 13:28:28 INFO - moznetwork == 0.27 13:28:28 INFO - mozprocess == 0.23 13:28:28 INFO - mozprofile == 0.28 13:28:28 INFO - mozrunner == 6.12 13:28:28 INFO - mozscreenshot == 0.1 13:28:28 INFO - mozsystemmonitor == 0.3 13:28:28 INFO - moztest == 0.7 13:28:28 INFO - mozversion == 1.4 13:28:28 INFO - psutil == 3.1.1 13:28:28 INFO - requests == 1.2.3 13:28:28 INFO - wsgiref == 0.1.2 13:28:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:28: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')]} 13:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28: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')]} 13:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:28 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 0x2514030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33b0>, '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 0x27d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', '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 13:28:28 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 13:28:28 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 13:28:28 INFO - Using env: {'DISPLAY': ':0', 13:28:28 INFO - 'HOME': '/home/cltbld', 13:28:28 INFO - 'LANG': 'en_US.UTF-8', 13:28:28 INFO - 'LANGUAGE': 'en_US:en', 13:28:28 INFO - 'LOGNAME': 'cltbld', 13:28:28 INFO - 'MAIL': '/var/mail/cltbld', 13:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:28 INFO - 'MOZ_NO_REMOTE': '1', 13:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:28 INFO - 'NO_EM_RESTART': '1', 13:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:28 INFO - 'PWD': '/builds/slave/test', 13:28:28 INFO - 'SHELL': '/bin/bash', 13:28:28 INFO - 'SHLVL': '1', 13:28:28 INFO - 'TERM': 'linux', 13:28:28 INFO - 'TMOUT': '86400', 13:28:28 INFO - 'USER': 'cltbld', 13:28:28 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', 13:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:28 INFO - '_': '/tools/buildbot/bin/python'} 13:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:29 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)) 13:28:29 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)) 13:28:29 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)) 13:28:29 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)) 13:28:29 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)) 13:28:29 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)) 13:28:29 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)) 13:28:29 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)) 13:28:29 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)) 13:28:29 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)) 13:28:29 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)) 13:28:29 INFO - Cleaning up... 13:28:29 INFO - Return code: 0 13:28:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2514030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33b0>, '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 0x27d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', '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 13:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:28:29 INFO - Using env: {'DISPLAY': ':0', 13:28:29 INFO - 'HOME': '/home/cltbld', 13:28:29 INFO - 'LANG': 'en_US.UTF-8', 13:28:29 INFO - 'LANGUAGE': 'en_US:en', 13:28:29 INFO - 'LOGNAME': 'cltbld', 13:28:29 INFO - 'MAIL': '/var/mail/cltbld', 13:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:29 INFO - 'MOZ_NO_REMOTE': '1', 13:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:29 INFO - 'NO_EM_RESTART': '1', 13:28:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:29 INFO - 'PWD': '/builds/slave/test', 13:28:29 INFO - 'SHELL': '/bin/bash', 13:28:29 INFO - 'SHLVL': '1', 13:28:29 INFO - 'TERM': 'linux', 13:28:29 INFO - 'TMOUT': '86400', 13:28:29 INFO - 'USER': 'cltbld', 13:28:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', 13:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:29 INFO - '_': '/tools/buildbot/bin/python'} 13:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:28:29 INFO - Cleaning up... 13:28:29 INFO - Return code: 0 13:28:29 INFO - Running post-action listener: _resource_record_post_action 13:28:29 INFO - Running post-action listener: _start_resource_monitoring 13:28:29 INFO - Starting resource monitoring. 13:28:29 INFO - [mozharness: 2016-07-28 20:28:29.325115Z] Finished create-virtualenv step (success) 13:28:29 INFO - [mozharness: 2016-07-28 20:28:29.325559Z] Running install step. 13:28:29 INFO - Running pre-action listener: _resource_record_pre_action 13:28:29 INFO - Running main action method: install 13:28:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:28:29 INFO - Reading from file tmpfile_stdout 13:28:29 INFO - Detecting whether we're running mozinstall >=1.0... 13:28:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:28:29 INFO - Reading from file tmpfile_stdout 13:28:29 INFO - Output received: 13:28:29 INFO - Usage: mozinstall [options] installer 13:28:29 INFO - Options: 13:28:29 INFO - -h, --help show this help message and exit 13:28:29 INFO - -d DEST, --destination=DEST 13:28:29 INFO - Directory to install application into. [default: 13:28:29 INFO - "/builds/slave/test"] 13:28:29 INFO - --app=APP Application being installed. [default: firefox] 13:28:29 INFO - mkdir: /builds/slave/test/build/application 13:28:29 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'] 13:28:29 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 13:28:46 INFO - Reading from file tmpfile_stdout 13:28:46 INFO - Output received: 13:28:46 INFO - /builds/slave/test/build/application/firefox/firefox 13:28:46 INFO - Running post-action listener: _resource_record_post_action 13:28:46 INFO - [mozharness: 2016-07-28 20:28:46.962997Z] Finished install step (success) 13:28:46 INFO - [mozharness: 2016-07-28 20:28:46.963277Z] Running run-tests step. 13:28:46 INFO - Running pre-action listener: _resource_record_pre_action 13:28:46 INFO - Running main action method: run_tests 13:28:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:28:46 INFO - Python 2.7.3 13:28:46 INFO - Return code: 0 13:28:46 INFO - grabbing minidump binary from tooltool 13:28:46 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')]} 13:28:46 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 0x27d33b0>, '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 0x27d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:28:46 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 13:28:46 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 13:28:46 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 13:28:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:28:47 INFO - Return code: 0 13:28:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:28:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:28:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:28:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:28:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:28:47 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/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 13:28:47 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/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 13:28:47 INFO - Using env: {'DISPLAY': ':0', 13:28:47 INFO - 'HOME': '/home/cltbld', 13:28:47 INFO - 'LANG': 'en_US.UTF-8', 13:28:47 INFO - 'LANGUAGE': 'en_US:en', 13:28:47 INFO - 'LOGNAME': 'cltbld', 13:28:47 INFO - 'MAIL': '/var/mail/cltbld', 13:28:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:28:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:47 INFO - 'MOZ_NO_REMOTE': '1', 13:28:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:47 INFO - 'NO_EM_RESTART': '1', 13:28:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:47 INFO - 'PWD': '/builds/slave/test', 13:28:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:28:47 INFO - 'SHELL': '/bin/bash', 13:28:47 INFO - 'SHLVL': '1', 13:28:47 INFO - 'TERM': 'linux', 13:28:47 INFO - 'TMOUT': '86400', 13:28:47 INFO - 'USER': 'cltbld', 13:28:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331', 13:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:47 INFO - '_': '/tools/buildbot/bin/python'} 13:28:47 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/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 13:28:47 INFO - mozversion application_buildid: 20160728103037 13:28:47 INFO - mozversion application_changeset: 410cc90a90da1146d73bb27b3e3018a5be95db6a 13:28:47 INFO - mozversion application_display_name: Nightly 13:28:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:28:47 INFO - mozversion application_name: Firefox 13:28:47 INFO - mozversion application_remotingname: firefox 13:28:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:28:47 INFO - mozversion application_vendor: Mozilla 13:28:47 INFO - mozversion application_version: 50.0a1 13:28:47 INFO - mozversion platform_buildid: 20160728103037 13:28:47 INFO - mozversion platform_changeset: 410cc90a90da1146d73bb27b3e3018a5be95db6a 13:28:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:28:47 INFO - mozversion platform_version: 50.0a1 13:28:47 INFO - using testdate: 1469737727 13:28:47 INFO - actual date: 1469737727 13:28:47 INFO - starting webserver on 'localhost:51344' 13:28:47 INFO - SUITE-START | Running 2 tests 13:28:47 INFO - TEST-START | dromaeo_css 13:28:47 INFO - operating with platform_type : linux_ 13:28:47 INFO - Initialising browser for dromaeo_css test... 13:28:47 INFO - TEST-INFO | started process 15967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5h7dyg/profile http://localhost:51344/getInfo.html) 13:28:50 INFO - PROCESS | 15967 | JavaScript error: , line 0: uncaught exception: undefined 13:28:51 INFO - PROCESS | 15967 | __metrics Screen width/height:1600/1200 13:28:51 INFO - PROCESS | 15967 | colorDepth:24 13:28:51 INFO - PROCESS | 15967 | Browser inner width/height: 1024/697 13:28:51 INFO - PROCESS | 15967 | __metrics 13:28:52 INFO - PROCESS | 15967 | 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" 13:28:52 INFO - PROCESS | 15967 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:28:52 INFO - PROCESS | 15967 | console.error: PushService: 13:28:52 INFO - PROCESS | 15967 | stateChangeProcessEnqueue: Error transitioning state 13:28:52 INFO - PROCESS | 15967 | UnknownError 13:28:53 INFO - TEST-INFO | 15967: exit 0 13:28:53 INFO - Browser initialized. 13:28:53 INFO - Running cycle 1/1 for dromaeo_css test... 13:28:53 INFO - TEST-INFO | started process 16045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5h7dyg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:29:05 INFO - PROCESS | 16045 | RSS: Main: 158089216 13:29:05 INFO - PROCESS | 16045 | 13:29:56 INFO - PROCESS | 16045 | 1469737796262 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] 13:32:05 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:51344/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51344/tests/dromaeo/cssquery-ext.html) 13:32:06 INFO - PROCESS | 16045 | RSS: Main: 258953216 13:32:06 INFO - PROCESS | 16045 | 13:35:08 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:51344/tests/dromaeo/cssquery-ext.html (next: http://localhost:51344/tests/dromaeo/cssquery-jquery.html) 13:35:09 INFO - PROCESS | 16045 | RSS: Main: 248057856 13:35:09 INFO - PROCESS | 16045 | 13:38:11 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:51344/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51344/tests/dromaeo/cssquery-mootools.html) 13:38:12 INFO - PROCESS | 16045 | RSS: Main: 228851712 13:38:12 INFO - PROCESS | 16045 | 13:41:14 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:51344/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51344/tests/dromaeo/cssquery-prototype.html) 13:41:14 INFO - PROCESS | 16045 | RSS: Main: 211841024 13:41:14 INFO - PROCESS | 16045 | 13:44:17 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:51344/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51344/tests/dromaeo/cssquery-yui.html) 13:44:17 INFO - PROCESS | 16045 | RSS: Main: 185503744 13:44:17 INFO - PROCESS | 16045 | 13:47:20 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:51344/tests/dromaeo/cssquery-yui.html (next: http://localhost:51344/tests/dromaeo/cssquery-dojo.html) 13:47:21 INFO - PROCESS | 16045 | RSS: Main: 281182208 13:47:21 INFO - PROCESS | 16045 | 13:47:21 INFO - PROCESS | 16045 | __start_tp_report 13:47:21 INFO - PROCESS | 16045 | _x_x_mozilla_page_load 13:47:21 INFO - PROCESS | 16045 | _x_x_mozilla_page_load_details 13:47:21 INFO - PROCESS | 16045 | |i|pagename|runs| 13:47:21 INFO - PROCESS | 16045 | |0;dojo.html;3028.5457181422785;3034.893778717745;3075.969240307598;3083.2754302738854;3086.49072902971;5174.870628234296;5226.712530810804;5263.078961181792;5339.305890234269;5343.225232341313;5153.974230128853;5165.431802501731;5223.085959957011;5245.6852588844695;5308.283381743464;4726.952730472685;4764.499727528611;4789.90420191596;4798;4946.9752651236695;4850.951490485085;4878.560929516343;4881.707097574139;4895.853124406256;4901.460839307673;4756.167670657621;4772.308015337791;4776.140294746944;4829.082474329901;4842.1042107210105;4727.5272472752795;4741.336212930192;4744.454387745384;4855.417349918032;4878.609711223094;4749.4775574686755;4770.546798054179;4776.880577985544;4780.067886762083;4820.228763397839;5163.793448262065;5187.688738675692;5307.840764777025;5360.731963401814;5361.892762144775;5611.607187496877;5635.436456354373;5675.971620141873;5687.857803554903;5694.5159661428825;5637.126245431924;5658.264425624684;5682.062459694145;5729.197912292282;5734.97132514339;5147.716875571842;5222.582193424517;5252.816151434758;5309.150535914235;5310.734463276859;5819.767209311664;5836.299644042742;5843.678597677169;5845.620034697731;5862.765489380377;5570.721463926788;5621.0444224481935;5627.409122042209;5630.155476678531;5634.718264086861;5416.91874621881;5441.102218134043;5494.038543254915;5647.802326918538;5656.91514627281;5545.805896793593;5554.86112847174;5565.1374037024325;5567.053600887859;5622.381538030813;5539.750711218005;5577.832665020056;5584.804531841447;5586.35756887955;5588.524975377139;4154.937675934863;4186.288330983679;4229.830806767694;4247.214265360918;4284.871453856389;3867.903302417462;3879.8448062077764;3902.3951287550476;3927.0771368728324;3959.9010024749036;5278.261043453919;5305.495977882172;5329.9467005330225;5341.305630268041;5341.893162136813;5512.586556008316;5637.830865074055;5714.914276285859;5715.1713001614535;5747.597668163272;5315.760790764425;5316.0962636351915;5319.601029922771;5343.545798607084;5345.599080069011;4884.95115048852;4887.755612219375;4890.315355850184;4910.116179087799;4939.086269040239;5747.051736463437;5771.24973753401;5916.23088998436;5924.4667979882015;5930.140129681258;5589.049861523469;5627;5647.265855438766;5687.402822703722;5689.118186681071;5803.7968671096305;5805.332386775575;5807.506361959112;5808.07070868659;5809.2738407699035;5452.209429632601;5471.179323101566;5511.338639363142;5513.117901135799;5516.117421212587;5637;5670.036093863971;5685;5703.714814259188;5766.394528574439;5561;5566.220729097849;5571.4428557143965;5572.275604171594;5573.665580065209;5425.782968681208;5572.331320241597;5578.581606379619;5579.414161513145;5581.665100094007;5338.412774594869;5378.462153784591;5389.380221274447;5414.8646283841645;5453.15476101205;5477.4796394342475;5488.204210389551;5521.861953451035;5527.088030475087;5533.501984821385;5373.2746079278795;5392;5392.110301800316;5402.6758394496455;5405.351357837085 13:47:21 INFO - PROCESS | 16045 | |1;ext.html;571.6854459635099;579.7912751409493;603.5955909540608;625.9342769009254;631.693628590134;31701.841490792543;32219.51670724941;34289.31421371571;43995;44766;45710.771446142804;45964.770176149075;46056;46106.538934610646;46150;8863.645454181826;9063.95468022659;9079.636814527445;9083.727488175333;9096.909030909672;9001.819963600725;9092.727218183465;9095.317851161157;9099.909000910005;9100.681476148337;9135.17783399494;9174;9178.082191780803;9178.35751497392;9183.724488265329;9049.3665443419;9061.048589898064;9098.408603440756;9107;9109.999999999967;8950.59722312491;8971.147740964598;9002.504862232574;9032.909670903273;9041.412308200011;42500.78749606263;43065.56934430647;43180.568194317966;43292.56707432917;43353.783231083646;3620.981895090534;3645.325614761251;3664.029032306441;3797.715171362159;4240.342746874239;33075.6692433075;33605;33906.660933390594;34586;34617.13457163566;4279.572042795727;4326.286162783137;4467.441569803775;4499.797509112065;4508.45898492183;244015;244645;244739;244844;245373;59660.403395965484;60023;60111.398886011455;60158.69920650456;60233.69883150644;54522;59046;60644;60650;62041;13592.048556601141;13697.726045479234;13768.449262029608;13772.24252666113;13775.793363099561;11793.646190614296;11906.404679765978;11910;11920.821187682192;11922.701932451584;15263.465778697693;17017.48947531576;17376.91311543434;17398.65202695939;17532.649347013245;5861.120831875252;5907.261592300963;5924.911126333109;6089.117078023662;6089.5737298388685;996.4868092932146;1059.56557811297;1076.8355605233537;1117.4971262931713;1144.6737679761395;33744.15639609029;33988.83005584956;34001.48997765035;34070;34448.138796530286;1133.2747041893194;1154.440096553171;1207.4988879615037;1212.860521040074;1256.5036810459817;16874.493765187064;17605.383811566535;17767.317549913147;17775.111244437983;17947.461576152735;544049;550555;552218;552498;554755;60820.39179608147;61053.38946610566;61069.08396374058;61109.972353179954;61150;1305.4908585651604;1314.750197462479;1335.052112999781;1341.9932900335436;1360.1567028442232;30576.235594110327;33212.667873320956;33240.66759332376;33269.667303327624;33515.66484335125;53957;54305;54394;54458.72770636121;54496;491533;491994;492689;492943;496327;36697.81651091728;42088.57911420969;43425.3486197701;43492;44099.11801764011;50466.49533504618;50542;51233;51371.48628513667;52137.7393113032;42284.15431691287;42932.57067429286;43371;44232;45330.77334613306;42177.78911105425;42698;43489;43700.56299436965;44525.55474445214;42806.78596606997;43243.13513729771;43304.78347608368;43976;44003.11993760171;31266.21834454157;32450.350992979536;33390.16524586808;34243.31513369669;34590.65409345875;28858.27854303659;28896.42207155803;28937.421251575273;29371.265718356357;29410.705892940798 13:47:21 INFO - PROCESS | 16045 | |2;jquery.html;380.6106620544053;381.4564245949523;391.24880229958484;395.1070580488097;414.450852620278;14537.418503259856;18816.811831881678;19211.903940480297;19898.90050549747;19933.501662458446;18586;19598;20435.182592696274;20497.18011279547;20569.485762855937;5372.9462705372935;5729.054705973509;5764.423557644244;5773;5777.451142141511;5539.307586551681;5678.914816277759;5755.280589926259;5756;5764.164196191549;5629.831105066834;5678;5681;5686.004949133906;5691.630044047124;5472.151816468454;5600.831975040755;5689.2319536862615;5692.117721753114;5700.429957004287;5060.822871199527;5087.236914462823;5092.79628814847;5093.159628661267;5096.261042148904;22477.550448991093;24337.63493547598;24488.877555612286;24538;24553.263402097964;2201.3506015725397;2242.091952759135;2249.696291000727;2449.595816690244;2488.925332240036;9739.41563506192;9787.608495660164;9902.405855648612;10378.221633377527;10435.791284174275;1859.228420205613;1913.3112079651314;1922.6731455652573;1954.775200851906;1985.4341512668964;78456;83906.58046709727;85953.14046859514;89613;92731;10228.33515821484;10345.275830691779;10602.416867072385;11008.449577521093;11024.369764698846;13297.3351332433;13678.93160534191;13802.102863313852;13807.96440266984;13810.447582096804;7386.889196662054;7482.4388170887405;7710.884336734954;8037.638306276232;8138.959305203436;7315.817104572428;7450.0687414073245;7490.1386340571535;7521.8119547010665;7594.202608726115;4226.704130710821;4238.851640192578;4330.978345108318;4460.50934397216;4586.4496260448295;1792.1576858876308;1885.641728071662;1892.3187652445108;1910.8853468791917;1940.7013465174705;957.0525180071679;983.2625530851861;1014.7716763728102;1019.7399663085865;1055.4300677633992;19936.50158746043;20780.37658870206;20930.476738081365;20969.26607568758;20982.580348392945;984.3945973226557;985.2561316206219;1002.2783595811004;1063.9095676867553;1086.6631344283298;9038.734577159203;11318.830217546743;11375.886241137649;11458.140639452075;11458.713532161762;471456;472503;547523;549209;553523;99737;102531.53805800415;102557.48721256346;105226;107149;1002.5588740953957;1013.3919648211014;1051.363924825485;1056.5984925728328;1059.9682009539727;17258.568535786704;17941.461756147335;18323.175457104197;18360.816391836444;18517.81482185161;42858;43802.34296485619;43820;44746.552534475544;45197.54802451933;59503;62318;63143.36856631375;64321.67839160774;65383.34616653963;7019.4735394844565;7540.811479713051;7731.574763387843;7845.176256492986;8095.311898488459;11507.252028618113;13208.603741887759;13385.732285354043;13410.195388276734;13636.386362613905;11705;11928.224665396721;12021.338826364634;12021.677615462468;12205.75588488243;10908.127349811837;11546.249493782878;11771.646850594496;12152.817707734568;12195.634130976085;6692.330766923269;11333.489992950172;11735.23720958135;11850.170488066098;12031.217970831867;8140.308073813792;8208.302294305051;8324.042735085543;8356.289715374018;8458.661653533789;10194.337368071052;11942.820857687315;11983;12256.203346782431;12318.876811231772 13:47:21 INFO - PROCESS | 16045 | |3;mootools.html;1363.059488952622;1461.978070328945;1521.148157032062;1639.22956210581;1777.200259883053;8272.917270827289;8557;8662.566871656416;8802.471851688902;8806.691765788199;8653.826923461544;8680.435771674836;8733.91266087339;8745.91254087459;8752.737417877457;2316.1546035696974;2339.532093581282;2340.1692399198296;2340.6137987232087;2345.2143531916827;2250.85369450986;2293.6330187170056;2296.873671948042;2300.160441438871;2328.860268383902;2275.488015196576;2275.8293128015384;2297.908083676651;2301.850379725321;2305.7924786769186;2209.2046863129262;2234.3408694435097;2243.170027089971;2244.674522194281;2245.124401483423;2232.6985856909273;2232.910683572655;2233.888305584714;2239.484918468745;2242.215224671352;8611.913880861173;8671.913280867173;8683;8744.300455963508;8745.212930836191;5022.59819214462;5174.793008279665;5208.218767184915;5229.163333866563;5236;3254.1864533866533;3259.6903294187014;3266.921915767791;3333.8999830005137;3336.1492819331156;1029.0943969307036;1037.2998226197362;1044.7492601775596;1045.6078970386104;1062.3678911047914;12060.457279422359;12114;12168.878311216864;12227.082968777377;12235.93882030584;4199;4313.0726893718;4399.098184872094;4453.532379100213;4455.443069616298;9636.180924621345;9637.325387222967;9649.93850676425;9650.517474126405;9650.613975441043;5085.74571271435;5095.312132862016;5104.642675012788;5119.590432765444;5129.769160387791;4235.7670328131635;4595.356650068926;4701.012787314702;4765.11845308619;4765.9523404765505;3724.1806802503406;3745.9625403745613;3844.75009124406;3892.3577609694084;3894.4937158169255;1052.5947510208625;1150.1086657840074;1153.9538418463167;1159.3855256713955;1166.877477864829;991.5785791038924;1002.4787110702393;1003.2174903575223;1004.6935684616116;1011.8229309870743;5946.583739138306;5979.970100149471;6165.876682466325;6189.102580125857;6395.131319681758;434.88910327866193;438.9956100439019;441.91824512464655;442.97120687155234;449.8672891497016;4172.687048471316;4223.324268117087;4284.186004659105;4303.569643035671;4363.672724545671;10785.13718902486;10981.945090274497;11058.060064894413;11059.502322395512;11060.059894908862;10950.945245273722;10970.122390208764;10998.780024399468;11008.449577521093;11059.668209953714;7864.4888082274465;8101.554414507259;8197.549134797524;8228.177182281843;8242.835143297101;6231.345708700521;6354.4281014708895;6393.904091438539;6404.711787969646;6464.321246269074;10107.19142468586;10247.743806404602;10266.794664106825;10278.948605257225;10317.896821031694;10463.895361046292;10512.0013598708;10519.368837869752;10537.736556586147;10544.472776361305;7248.927510725036;7752.4573279869865;7938.3252423544645;7995.480293780885;8153.592320384076;8640.222379985831;8708.521031343336;8717.956410217908;8788.648454061766;8809.07504711996;7648.426368022532;7705.036870391201;7848.646810893638;7877.291043806085;7911.604419778873;7445.441591880739;7506.1743208248145;7590.544567325978;7634.541927484369;7790.844183116193;7130.643467826691;7218.169910460364;7237.059182306267;7245.94933734595;7252.2747725227055;4988.226824842155;5174.482551744946;5190.169572868323;5217.591250362457;5256.132738098171;5414.485623865727;5444.6188766785945;5503.862403439946;5513.365962914316;5683.60214784961 13:47:21 INFO - PROCESS | 16045 | |4;prototype.html;319.8624591425686;322.1880860232215;328.4432886257793;337.2445721583652;341.3275846582232;5307.222080602998;5350.678959262447;5360.9463905360935;5381;5385.1922211668225;4967.850964471063;5088.771005304761;5154.768035438405;5209.505097015787;5260;4095.9590404096025;4100.712950093494;4103.363978583325;4114.259433302004;4136.097395198198;4104.753714777123;4116.300228961069;4124.422580838685;4128.967758060485;4138.089620283533;3869.342211823983;3892.6691231245236;4085.6527195188446;4090.897727556805;4095.815688294034;4109.8972525686795;4110.917781644365;4114.300568903279;4114.773687447189;4118.588141185887;3597.8380972856285;3639.253952939641;3644.6173151819207;3647.5987641359693;3648.1062139775927;5028.723420211887;5090.821821236276;5091.66904151229;5163.483651634844;5188.533032027136;4644.674872758908;4648.511906249829;4649.651925777494;4649.674522783406;4655.208614535503;5393.946060539383;5407.242985981966;5412.72800891794;5412.729363531847;5424.430434804368;3750.3999360102252;3946.506686664167;3952.3083460394314;3960.1881614269005;3960.2079584083012;5624.850083952959;5626.578006649477;5635.900999305137;5647.548196144298;5659.943400565983;3866.903327416837;3871.554771201348;3873.96126038736;3875.651191392732;3877.0695033191832;3858.479105320802;3912.7456715313983;3936.8031598419966;3944.0928586425284;3950.1902110067367;4464.55354464551;4479.96960699041;4525.389072475239;4535.569120933506;4560.977195114069;5374.220737992969;5391.137418013099;5402.324709411324;5412.431694672082;5437.537809286176;1391.4016972701836;1411.3648858013935;1411.6047506697935;1412.5479846449039;1418.326295009862;936.424099179;973.8733964584559;977.7555611097225;983.1986930651639;988.9912289464705;5109.770060347293;5166.276721259027;5173.663711858717;5189.702574356411;5231.921521177185;5619.157126430986;5637.9718101409235;5657.6322539035655;5703.771849125988;5706.343770466367;5163.638545301793;5179.689218646893;5217.765200565984;5245.239440281214;5253.270178173463;2984.746296564773;2995.8801647933838;2997.2057404787747;3005.6242969628797;3009.4432529982023;5650.74571644277;5780.479756821822;5810.535157187415;5820.097884827858;5836.445537673914;5652.434756524314;5688.658680479184;5689.406966049512;5690.658560486384;5714.914276285859;5756.798512052225;5758.654480731169;5758.905807896403;5771.88456230873;5786.161006654096;5405.8918821622565;5465.289512363367;5535.806246781343;5562.415946325577;5570.972145139411;5481.287432633732;5512.401403592913;5520.834374968757;5521.1442226454965;5522.530584900168;5565.38780734127;5763.965224342893;5769.278840144982;5814.767409303749;5833.270841144857;4029.8388064478268;4037.7779222143063;4068.247374235776;4094.938575921304;4100;5421.376541697755;5625.268715067015;5680.289963754531;5769.509591684754;5780.421957804186;5488.780448782004;5530.308711411074;5547.278853748987;5553.194786755978;5572.247746554163;5503.917441238465;5509.201165831012;5513.696746678811;5514.834554963358;5517.641353312022;5199.532042116228;5395.81114660985;5463.180522921593;5466.562674986071;5471.972640136773;5540.833774986757;5542.7551841504255;5559.388467268516;5562.777488900399;5579.218909352775;5168.896622067462;5378.327709036371;5460.972695136499;5463.9180412294645;5471.781128754806 13:47:21 INFO - PROCESS | 16045 | |5;yui.html;766.5170942306346;766.8159641685997;769.6113462701335;847;880.5025160784154;15695.450659226915;16837.410690625817;16909.154542272867;16931.322747090133;16993.150342482873;14624.122552646848;15472.226388680578;15547.455839045635;15694.21528923555;15703.21483925802;827.2017503109513;848.6138806842903;850.4642075492432;851.5997481183833;853.0914575976597;662.9403353698166;802.0335495727634;839.5718183726283;840.0549381945311;841.9284360829337;842.5492361586553;842.806154584446;843.0515669871395;843.9535825529593;880.9691660791874;870.0733718589681;871.5642178910545;873.8339715454075;873.9388242823005;874.1608056266024;513.2224679610393;621.6953692690595;632.3044650884037;634.7968650031992;637.5600835423543;15860.44488442899;15893.284802183814;15904.522864314089;15910.284037218353;15917.840821591752;14475.78286325706;14502.492412765503;14660.193689347081;14722.337494812651;15104.471343502924;13375.866241337657;13589;13694.178349298974;13871.237081960488;14427;3882.825272862728;4126.3397856343145;4541.591256786905;4633.582977532038;4773.665843390964;66660;68217.3178268216;68554;84262.57868710678;85898.57050714768;12451.688707782378;12664.240145591293;12735.172213806072;12758;13427.798583021262;23485.41286467818;23678.526429471312;23715.169969051;23721.644175337384;24119.03523859026;9204;9309.44143351401;9465.290103242147;9536.618535258513;9607.471589062668;4961.627877909171;4973.502649734997;4976.701397916137;5072.264521644341;5130.948690513047;3392.8982130536124;3490.3193877194212;3500.842462089212;3505.36903357393;3506.982465087658;577.2409281794427;581.4069648958039;587.5974957154363;592.982210533676;609.1471939284947;684.0252639987997;771.9903278233626;786.7954331873754;809.1948511231362;821.6754382019069;10083.495825208856;10237;10422.895771042193;10584.4707764613;10723.678289651323;570.7688386203595;712.5510928115255;712.7968528969323;771.4021633234288;795.2921899509441;4833.4441539222735;4987.700737955734;5004.449510553836;5049.242613607915;5126.66676666023;69042.30957690459;69756.30243697498;71544;117343;125255;100620;100755;101041;102302;103622.48188759008;89623;92349.53825230965;93577;94812.52593736986;96139.51930240444;9374.953393685273;9576.377535460173;9766.169875560658;9899.662895130285;10024.097831195228;42271.57728422799;44661;48966.63433753589;49933.500664992884;50809.74595127001;72321.55356892938;74078;77343.61328193323;79419;79724.60137699507;13096;13313.334333283103;13555.796663049865;13601.863981360455;13761.655958600715;15205.77191342153;15910.60223494422;15934.60163495922;16349.182540873147;16412.09733464671;14539.854601454274;15123.39506419775;15456.149911754512;15615.297311621232;15667.608309792346;14962.850371496581;15050.774238386213;15059.171745553662;15066.09603423798;15104.924475377553;14177.858221417653;14242.21667808239;14380.784288235895;14426;14791.778123328373;11330.716732081764;11593.24643898144;11597.6520704379;11682.532698691957;12085;9037.954810225907;11001.889981100087;11561.59534416325;11603.767924641628;12157 13:47:21 INFO - PROCESS | 16045 | __end_tp_report 13:47:21 INFO - PROCESS | 16045 | __start_cc_report 13:47:21 INFO - PROCESS | 16045 | _x_x_mozilla_cycle_collect,974 13:47:21 INFO - PROCESS | 16045 | __end_cc_report 13:47:21 INFO - PROCESS | 16045 | __startTimestamp1469738841090__endTimestamp 13:47:21 INFO - PROCESS | 16045 | 13:47:21 INFO - PROCESS | 16045 | ------- Summary: start ------- 13:47:21 INFO - PROCESS | 16045 | Number of tests: 6 13:47:21 INFO - PROCESS | 16045 | 13:47:21 INFO - PROCESS | 16045 | [#0] dojo.html Cycles:165 Average:5238.42 Median:5405.35 stddev:592.76 (11.0%) stddev-sans-first:568.66 13:47:21 INFO - PROCESS | 16045 | Values: 3028.5 3034.9 3076.0 3083.3 3086.5 5174.9 5226.7 5263.1 5339.3 5343.2 5154.0 5165.4 5223.1 5245.7 5308.3 4727.0 4764.5 4789.9 4798.0 4947.0 4851.0 4878.6 4881.7 4895.9 4901.5 4756.2 4772.3 4776.1 4829.1 4842.1 4727.5 4741.3 4744.5 4855.4 4878.6 4749.5 4770.5 4776.9 4780.1 4820.2 5163.8 5187.7 5307.8 5360.7 5361.9 5611.6 5635.4 5676.0 5687.9 5694.5 5637.1 5658.3 5682.1 5729.2 5735.0 5147.7 5222.6 5252.8 5309.2 5310.7 5819.8 5836.3 5843.7 5845.6 5862.8 5570.7 5621.0 5627.4 5630.2 5634.7 5416.9 5441.1 5494.0 5647.8 5656.9 5545.8 5554.9 5565.1 5567.1 5622.4 5539.8 5577.8 5584.8 5586.4 5588.5 4154.9 4186.3 4229.8 4247.2 4284.9 3867.9 3879.8 3902.4 3927.1 3959.9 5278.3 5305.5 5329.9 5341.3 5341.9 5512.6 5637.8 5714.9 5715.2 5747.6 5315.8 5316.1 5319.6 5343.5 5345.6 4885.0 4887.8 4890.3 4910.1 4939.1 5747.1 5771.2 5916.2 5924.5 5930.1 5589.0 5627.0 5647.3 5687.4 5689.1 5803.8 5805.3 5807.5 5808.1 5809.3 5452.2 5471.2 5511.3 5513.1 5516.1 5637.0 5670.0 5685.0 5703.7 5766.4 5561.0 5566.2 5571.4 5572.3 5573.7 5425.8 5572.3 5578.6 5579.4 5581.7 5338.4 5378.5 5389.4 5414.9 5453.2 5477.5 5488.2 5521.9 5527.1 5533.5 5373.3 5392.0 5392.1 5402.7 5405.4 13:47:21 INFO - PROCESS | 16045 | 13:47:21 INFO - PROCESS | 16045 | [#1] ext.html Cycles:180 Average:60009.77 Median:43490.50 stddev:119686.37 (275.2%) stddev-sans-first:119938.93 13:47:21 INFO - PROCESS | 16045 | Values: 571.7 579.8 603.6 625.9 631.7 31701.8 32219.5 34289.3 43995.0 44766.0 45710.8 45964.8 46056.0 46106.5 46150.0 8863.6 9064.0 9079.6 9083.7 9096.9 9001.8 9092.7 9095.3 9099.9 9100.7 9135.2 9174.0 9178.1 9178.4 9183.7 9049.4 9061.0 9098.4 9107.0 9110.0 8950.6 8971.1 9002.5 9032.9 9041.4 42500.8 43065.6 43180.6 43292.6 43353.8 3621.0 3645.3 3664.0 3797.7 4240.3 33075.7 33605.0 33906.7 34586.0 34617.1 4279.6 4326.3 4467.4 4499.8 4508.5 244015.0 244645.0 244739.0 244844.0 245373.0 59660.4 60023.0 60111.4 60158.7 60233.7 54522.0 59046.0 60644.0 60650.0 62041.0 13592.0 13697.7 13768.4 13772.2 13775.8 11793.6 11906.4 11910.0 11920.8 11922.7 15263.5 17017.5 17376.9 17398.7 17532.6 5861.1 5907.3 5924.9 6089.1 6089.6 996.5 1059.6 1076.8 1117.5 1144.7 33744.2 33988.8 34001.5 34070.0 34448.1 1133.3 1154.4 1207.5 1212.9 1256.5 16874.5 17605.4 17767.3 17775.1 17947.5 544049.0 550555.0 552218.0 552498.0 554755.0 60820.4 61053.4 61069.1 61110.0 61150.0 1305.5 1314.8 1335.1 1342.0 1360.2 30576.2 33212.7 33240.7 33269.7 33515.7 53957.0 54305.0 54394.0 54458.7 54496.0 491533.0 491994.0 492689.0 492943.0 496327.0 36697.8 42088.6 43425.3 43492.0 44099.1 50466.5 50542.0 51233.0 51371.5 52137.7 42284.2 42932.6 43371.0 44232.0 45330.8 42177.8 42698.0 43489.0 43700.6 44525.6 42806.8 43243.1 43304.8 43976.0 44003.1 31266.2 32450.4 33390.2 34243.3 34590.7 28858.3 28896.4 28937.4 29371.3 29410.7 13:47:21 INFO - PROCESS | 16045 | 13:47:21 INFO - PROCESS | 16045 | [#2] jquery.html Cycles:180 Average:30392.41 Median:13469.24 stddev:86071.18 (639.0%) stddev-sans-first:86283.13 13:47:21 INFO - PROCESS | 16045 | Values: 380.6 381.5 391.2 395.1 414.5 14537.4 18816.8 19211.9 19898.9 19933.5 18586.0 19598.0 20435.2 20497.2 20569.5 5372.9 5729.1 5764.4 5773.0 5777.5 5539.3 5678.9 5755.3 5756.0 5764.2 5629.8 5678.0 5681.0 5686.0 5691.6 5472.2 5600.8 5689.2 5692.1 5700.4 5060.8 5087.2 5092.8 5093.2 5096.3 22477.6 24337.6 24488.9 24538.0 24553.3 2201.4 2242.1 2249.7 2449.6 2488.9 9739.4 9787.6 9902.4 10378.2 10435.8 1859.2 1913.3 1922.7 1954.8 1985.4 78456.0 83906.6 85953.1 89613.0 92731.0 10228.3 10345.3 10602.4 11008.4 11024.4 13297.3 13678.9 13802.1 13808.0 13810.4 7386.9 7482.4 7710.9 8037.6 8139.0 7315.8 7450.1 7490.1 7521.8 7594.2 4226.7 4238.9 4331.0 4460.5 4586.4 1792.2 1885.6 1892.3 1910.9 1940.7 957.1 983.3 1014.8 1019.7 1055.4 19936.5 20780.4 20930.5 20969.3 20982.6 984.4 985.3 1002.3 1063.9 1086.7 9038.7 11318.8 11375.9 11458.1 11458.7 471456.0 472503.0 547523.0 549209.0 553523.0 99737.0 102531.5 102557.5 105226.0 107149.0 1002.6 1013.4 1051.4 1056.6 1060.0 17258.6 17941.5 18323.2 18360.8 18517.8 42858.0 43802.3 43820.0 44746.6 45197.5 59503.0 62318.0 63143.4 64321.7 65383.3 7019.5 7540.8 7731.6 7845.2 8095.3 11507.3 13208.6 13385.7 13410.2 13636.4 11705.0 11928.2 12021.3 12021.7 12205.8 10908.1 11546.2 11771.6 12152.8 12195.6 6692.3 11333.5 11735.2 11850.2 12031.2 8140.3 8208.3 8324.0 8356.3 8458.7 10194.3 11942.8 11983.0 12256.2 12318.9 13:47:21 INFO - PROCESS | 16045 | 13:47:21 INFO - PROCESS | 16045 | [#3] mootools.html Cycles:180 Average:5784.83 Median:442.44 stddev:3332.55 (753.2%) stddev-sans-first:3325.33 13:47:21 INFO - PROCESS | 16045 | Values: 1363.1 1462.0 1521.1 1639.2 1777.2 8272.9 8557.0 8662.6 8802.5 8806.7 8653.8 8680.4 8733.9 8745.9 8752.7 2316.2 2339.5 2340.2 2340.6 2345.2 2250.9 2293.6 2296.9 2300.2 2328.9 2275.5 2275.8 2297.9 2301.9 2305.8 2209.2 2234.3 2243.2 2244.7 2245.1 2232.7 2232.9 2233.9 2239.5 2242.2 8611.9 8671.9 8683.0 8744.3 8745.2 5022.6 5174.8 5208.2 5229.2 5236.0 3254.2 3259.7 3266.9 3333.9 3336.1 1029.1 1037.3 1044.7 1045.6 1062.4 12060.5 12114.0 12168.9 12227.1 12235.9 4199.0 4313.1 4399.1 4453.5 4455.4 9636.2 9637.3 9649.9 9650.5 9650.6 5085.7 5095.3 5104.6 5119.6 5129.8 4235.8 4595.4 4701.0 4765.1 4766.0 3724.2 3746.0 3844.8 3892.4 3894.5 1052.6 1150.1 1154.0 1159.4 1166.9 991.6 1002.5 1003.2 1004.7 1011.8 5946.6 5980.0 6165.9 6189.1 6395.1 434.9 439.0 441.9 443.0 449.9 4172.7 4223.3 4284.2 4303.6 4363.7 10785.1 10981.9 11058.1 11059.5 11060.1 10950.9 10970.1 10998.8 11008.4 11059.7 7864.5 8101.6 8197.5 8228.2 8242.8 6231.3 6354.4 6393.9 6404.7 6464.3 10107.2 10247.7 10266.8 10278.9 10317.9 10463.9 10512.0 10519.4 10537.7 10544.5 7248.9 7752.5 7938.3 7995.5 8153.6 8640.2 8708.5 8718.0 8788.6 8809.1 7648.4 7705.0 7848.6 7877.3 7911.6 7445.4 7506.2 7590.5 7634.5 7790.8 7130.6 7218.2 7237.1 7245.9 7252.3 4988.2 5174.5 5190.2 5217.6 5256.1 5414.5 5444.6 5503.9 5513.4 5683.6 13:47:21 INFO - PROCESS | 16045 | 13:47:21 INFO - PROCESS | 16045 | [#4] prototype.html Cycles:180 Average:4605.48 Median:5256.64 stddev:1349.98 (25.7%) stddev-sans-first:1314.88 13:47:21 INFO - PROCESS | 16045 | Values: 319.9 322.2 328.4 337.2 341.3 5307.2 5350.7 5360.9 5381.0 5385.2 4967.9 5088.8 5154.8 5209.5 5260.0 4096.0 4100.7 4103.4 4114.3 4136.1 4104.8 4116.3 4124.4 4129.0 4138.1 3869.3 3892.7 4085.7 4090.9 4095.8 4109.9 4110.9 4114.3 4114.8 4118.6 3597.8 3639.3 3644.6 3647.6 3648.1 5028.7 5090.8 5091.7 5163.5 5188.5 4644.7 4648.5 4649.7 4649.7 4655.2 5393.9 5407.2 5412.7 5412.7 5424.4 3750.4 3946.5 3952.3 3960.2 3960.2 5624.9 5626.6 5635.9 5647.5 5659.9 3866.9 3871.6 3874.0 3875.7 3877.1 3858.5 3912.7 3936.8 3944.1 3950.2 4464.6 4480.0 4525.4 4535.6 4561.0 5374.2 5391.1 5402.3 5412.4 5437.5 1391.4 1411.4 1411.6 1412.5 1418.3 936.4 973.9 977.8 983.2 989.0 5109.8 5166.3 5173.7 5189.7 5231.9 5619.2 5638.0 5657.6 5703.8 5706.3 5163.6 5179.7 5217.8 5245.2 5253.3 2984.7 2995.9 2997.2 3005.6 3009.4 5650.7 5780.5 5810.5 5820.1 5836.4 5652.4 5688.7 5689.4 5690.7 5714.9 5756.8 5758.7 5758.9 5771.9 5786.2 5405.9 5465.3 5535.8 5562.4 5571.0 5481.3 5512.4 5520.8 5521.1 5522.5 5565.4 5764.0 5769.3 5814.8 5833.3 4029.8 4037.8 4068.2 4094.9 4100.0 5421.4 5625.3 5680.3 5769.5 5780.4 5488.8 5530.3 5547.3 5553.2 5572.2 5503.9 5509.2 5513.7 5514.8 5517.6 5199.5 5395.8 5463.2 5466.6 5472.0 5540.8 5542.8 5559.4 5562.8 5579.2 5168.9 5378.3 5461.0 5463.9 5471.8 13:47:21 INFO - PROCESS | 16045 | 13:47:21 INFO - PROCESS | 16045 | [#5] yui.html Cycles:180 Average:20788.95 Median:24601.30 stddev:28829.70 (117.2%) stddev-sans-first:28871.37 13:47:21 INFO - PROCESS | 16045 | Values: 766.5 766.8 769.6 847.0 880.5 15695.5 16837.4 16909.2 16931.3 16993.2 14624.1 15472.2 15547.5 15694.2 15703.2 827.2 848.6 850.5 851.6 853.1 662.9 802.0 839.6 840.1 841.9 842.5 842.8 843.1 844.0 881.0 870.1 871.6 873.8 873.9 874.2 513.2 621.7 632.3 634.8 637.6 15860.4 15893.3 15904.5 15910.3 15917.8 14475.8 14502.5 14660.2 14722.3 15104.5 13375.9 13589.0 13694.2 13871.2 14427.0 3882.8 4126.3 4541.6 4633.6 4773.7 66660.0 68217.3 68554.0 84262.6 85898.6 12451.7 12664.2 12735.2 12758.0 13427.8 23485.4 23678.5 23715.2 23721.6 24119.0 9204.0 9309.4 9465.3 9536.6 9607.5 4961.6 4973.5 4976.7 5072.3 5130.9 3392.9 3490.3 3500.8 3505.4 3507.0 577.2 581.4 587.6 593.0 609.1 684.0 772.0 786.8 809.2 821.7 10083.5 10237.0 10422.9 10584.5 10723.7 570.8 712.6 712.8 771.4 795.3 4833.4 4987.7 5004.4 5049.2 5126.7 69042.3 69756.3 71544.0 117343.0 125255.0 100620.0 100755.0 101041.0 102302.0 103622.5 89623.0 92349.5 93577.0 94812.5 96139.5 9375.0 9576.4 9766.2 9899.7 10024.1 42271.6 44661.0 48966.6 49933.5 50809.7 72321.6 74078.0 77343.6 79419.0 79724.6 13096.0 13313.3 13555.8 13601.9 13761.7 15205.8 15910.6 15934.6 16349.2 16412.1 14539.9 15123.4 15456.1 15615.3 15667.6 14962.9 15050.8 15059.2 15066.1 15104.9 14177.9 14242.2 14380.8 14426.0 14791.8 11330.7 11593.2 11597.7 11682.5 12085.0 9038.0 11001.9 11561.6 11603.8 12157.0 13:47:21 INFO - PROCESS | 16045 | -------- Summary: end -------- 13:47:21 INFO - PROCESS | 16045 | 13:47:21 INFO - TEST-INFO | 16045: exit 0 13:47:21 INFO - TEST-OK | dromaeo_css | took 1114660ms 13:47:21 INFO - TEST-START | kraken 13:47:21 INFO - operating with platform_type : linux_ 13:47:21 INFO - Initialising browser for kraken test... 13:47:21 INFO - TEST-INFO | started process 16229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgSDZtN/profile http://localhost:51344/getInfo.html) 13:47:25 INFO - PROCESS | 16229 | JavaScript error: , line 0: uncaught exception: undefined 13:47:26 INFO - PROCESS | 16229 | __metrics Screen width/height:1600/1200 13:47:26 INFO - PROCESS | 16229 | colorDepth:24 13:47:26 INFO - PROCESS | 16229 | Browser inner width/height: 1024/697 13:47:26 INFO - PROCESS | 16229 | __metrics 13:47:27 INFO - PROCESS | 16229 | 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" 13:47:27 INFO - PROCESS | 16229 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:47:28 INFO - TEST-INFO | 16229: exit 0 13:47:28 INFO - Browser initialized. 13:47:28 INFO - Running cycle 1/1 for kraken test... 13:47:28 INFO - TEST-INFO | started process 16309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgSDZtN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:47:39 INFO - PROCESS | 16309 | RSS: Main: 157999104 13:47:39 INFO - PROCESS | 16309 | 13:47:42 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51344/tests/kraken/driver.html?testName=audio-beat-detection) 13:47:43 INFO - PROCESS | 16309 | RSS: Main: 214425600 13:47:43 INFO - PROCESS | 16309 | 13:47:45 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51344/tests/kraken/driver.html?testName=audio-dft) 13:47:46 INFO - PROCESS | 16309 | RSS: Main: 193216512 13:47:46 INFO - PROCESS | 16309 | 13:47:49 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51344/tests/kraken/driver.html?testName=audio-fft) 13:47:50 INFO - PROCESS | 16309 | RSS: Main: 271458304 13:47:50 INFO - PROCESS | 16309 | 13:47:52 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51344/tests/kraken/driver.html?testName=audio-oscillator) 13:47:52 INFO - PROCESS | 16309 | RSS: Main: 180936704 13:47:52 INFO - PROCESS | 16309 | 13:47:55 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51344/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:47:55 INFO - PROCESS | 16309 | RSS: Main: 185278464 13:47:55 INFO - PROCESS | 16309 | 13:47:58 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51344/tests/kraken/driver.html?testName=imaging-darkroom) 13:47:59 INFO - PROCESS | 16309 | RSS: Main: 220217344 13:47:59 INFO - PROCESS | 16309 | 13:48:02 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51344/tests/kraken/driver.html?testName=imaging-desaturate) 13:48:03 INFO - PROCESS | 16309 | RSS: Main: 221585408 13:48:03 INFO - PROCESS | 16309 | 13:48:06 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51344/tests/kraken/driver.html?testName=json-parse-financial) 13:48:06 INFO - PROCESS | 16309 | RSS: Main: 220815360 13:48:06 INFO - PROCESS | 16309 | 13:48:08 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51344/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:48:08 INFO - PROCESS | 16309 | RSS: Main: 185577472 13:48:08 INFO - PROCESS | 16309 | 13:48:10 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51344/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:48:11 INFO - PROCESS | 16309 | RSS: Main: 191000576 13:48:11 INFO - PROCESS | 16309 | 13:48:13 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51344/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:48:13 INFO - PROCESS | 16309 | RSS: Main: 195842048 13:48:13 INFO - PROCESS | 16309 | 13:48:16 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:48:17 INFO - PROCESS | 16309 | RSS: Main: 189108224 13:48:17 INFO - PROCESS | 16309 | 13:48:19 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:48:20 INFO - PROCESS | 16309 | RSS: Main: 194334720 13:48:20 INFO - PROCESS | 16309 | 13:48:21 INFO - PROCESS | 16309 | Cycle 1(1): loaded http://localhost:51344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51344/tests/kraken/driver.html?testName=ai-astar) 13:48:22 INFO - PROCESS | 16309 | RSS: Main: 245170176 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | __start_tp_report 13:48:22 INFO - PROCESS | 16309 | _x_x_mozilla_page_load 13:48:22 INFO - PROCESS | 16309 | _x_x_mozilla_page_load_details 13:48:22 INFO - PROCESS | 16309 | |i|pagename|runs| 13:48:22 INFO - PROCESS | 16309 | |0;ai-astar;102;111;110;111;112;112;113;113;110;113 13:48:22 INFO - PROCESS | 16309 | |1;audio-beat-detection;150;119;120;182;117;119;151;117;150;116 13:48:22 INFO - PROCESS | 16309 | |2;audio-dft;163;160;160;160;160;160;162;161;161;160 13:48:22 INFO - PROCESS | 16309 | |3;audio-fft;75;75;82;107;75;75;74;75;98;74 13:48:22 INFO - PROCESS | 16309 | |4;audio-oscillator;84;83;125;84;85;85;123;85;84;132 13:48:22 INFO - PROCESS | 16309 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;118;118 13:48:22 INFO - PROCESS | 16309 | |6;imaging-darkroom;145;147;146;146;145;146;146;146;147;147 13:48:22 INFO - PROCESS | 16309 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 13:48:22 INFO - PROCESS | 16309 | |8;json-parse-financial;52;51;51;53;52;52;52;52;51;51 13:48:22 INFO - PROCESS | 16309 | |9;json-stringify-tinderbox;62;63;64;63;63;63;64;63;63;64 13:48:22 INFO - PROCESS | 16309 | |10;stanford-crypto-aes;77;77;76;76;76;75;76;76;76;79 13:48:22 INFO - PROCESS | 16309 | |11;stanford-crypto-ccm;122;126;120;119;121;119;131;122;178;136 13:48:22 INFO - PROCESS | 16309 | |12;stanford-crypto-pbkdf2;158;164;157;156;156;158;155;155;157;162 13:48:22 INFO - PROCESS | 16309 | |13;stanford-crypto-sha256-iterative;63;63;63;63;63;63;62;62;61;61 13:48:22 INFO - PROCESS | 16309 | __end_tp_report 13:48:22 INFO - PROCESS | 16309 | __start_cc_report 13:48:22 INFO - PROCESS | 16309 | _x_x_mozilla_cycle_collect,1717 13:48:22 INFO - PROCESS | 16309 | __end_cc_report 13:48:22 INFO - PROCESS | 16309 | __startTimestamp1469738902175__endTimestamp 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | ------- Summary: start ------- 13:48:22 INFO - PROCESS | 16309 | Number of tests: 14 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.27 (2.9%) stddev-sans-first:1.22 13:48:22 INFO - PROCESS | 16309 | Values: 102.0 111.0 110.0 111.0 112.0 112.0 113.0 113.0 110.0 113.0 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:135.00 stddev:22.74 (16.8%) stddev-sans-first:23.38 13:48:22 INFO - PROCESS | 16309 | Values: 150.0 119.0 120.0 182.0 117.0 119.0 151.0 117.0 150.0 116.0 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:1.06 (0.7%) stddev-sans-first:0.73 13:48:22 INFO - PROCESS | 16309 | Values: 163.0 160.0 160.0 160.0 160.0 160.0 162.0 161.0 161.0 160.0 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:11.76 (15.7%) stddev-sans-first:12.27 13:48:22 INFO - PROCESS | 16309 | Values: 75.0 75.0 82.0 107.0 75.0 75.0 74.0 75.0 98.0 74.0 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:84.00 stddev:20.60 (24.5%) stddev-sans-first:21.31 13:48:22 INFO - PROCESS | 16309 | Values: 84.0 83.0 125.0 84.0 85.0 85.0 123.0 85.0 84.0 132.0 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 13:48:22 INFO - PROCESS | 16309 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 118.0 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 13:48:22 INFO - PROCESS | 16309 | Values: 145.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 147.0 147.0 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 13:48:22 INFO - PROCESS | 16309 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 13:48:22 INFO - PROCESS | 16309 | Values: 52.0 51.0 51.0 53.0 52.0 52.0 52.0 52.0 51.0 51.0 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 13:48:22 INFO - PROCESS | 16309 | Values: 62.0 63.0 64.0 63.0 63.0 63.0 64.0 63.0 63.0 64.0 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:76.00 stddev:1.07 (1.4%) stddev-sans-first:1.12 13:48:22 INFO - PROCESS | 16309 | Values: 77.0 77.0 76.0 76.0 76.0 75.0 76.0 76.0 76.0 79.0 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:124.00 stddev:17.96 (14.5%) stddev-sans-first:18.85 13:48:22 INFO - PROCESS | 16309 | Values: 122.0 126.0 120.0 119.0 121.0 119.0 131.0 122.0 178.0 136.0 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.80 Median:157.50 stddev:2.97 (1.9%) stddev-sans-first:3.15 13:48:22 INFO - PROCESS | 16309 | Values: 158.0 164.0 157.0 156.0 156.0 158.0 155.0 155.0 157.0 162.0 13:48:22 INFO - PROCESS | 16309 | 13:48:22 INFO - PROCESS | 16309 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:63.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 13:48:22 INFO - PROCESS | 16309 | Values: 63.0 63.0 63.0 63.0 63.0 63.0 62.0 62.0 61.0 61.0 13:48:22 INFO - PROCESS | 16309 | -------- Summary: end -------- 13:48:22 INFO - PROCESS | 16309 | 13:48:23 INFO - TEST-INFO | 16309: exit 0 13:48:23 INFO - TEST-OK | kraken | took 61378ms 13:48:23 INFO - SUITE-END | took 1176s 13:48:23 INFO - Completed test suite (00:19:36) 13:48:23 INFO - javascript benchmark 13:48:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3028.5457181422785, 3034.893778717745, 3075.969240307598, 3083.2754302738854, 3086.49072902971, 5174.870628234296, 5226.712530810804, 5263.078961181792, 5339.305890234269, 5343.225232341313, 5153.974230128853, 5165.431802501731, 5223.085959957011, 5245.6852588844695, 5308.283381743464, 4726.952730472685, 4764.499727528611, 4789.90420191596, 4798.0, 4946.9752651236695, 4850.951490485085, 4878.560929516343, 4881.707097574139, 4895.853124406256, 4901.460839307673, 4756.167670657621, 4772.308015337791, 4776.140294746944, 4829.082474329901, 4842.1042107210105, 4727.5272472752795, 4741.336212930192, 4744.454387745384, 4855.417349918032, 4878.609711223094, 4749.4775574686755, 4770.546798054179, 4776.880577985544, 4780.067886762083, 4820.228763397839, 5163.793448262065, 5187.688738675692, 5307.840764777025, 5360.731963401814, 5361.892762144775, 5611.607187496877, 5635.436456354373, 5675.971620141873, 5687.857803554903, 5694.5159661428825, 5637.126245431924, 5658.264425624684, 5682.062459694145, 5729.197912292282, 5734.97132514339, 5147.716875571842, 5222.582193424517, 5252.816151434758, 5309.150535914235, 5310.734463276859, 5819.767209311664, 5836.299644042742, 5843.678597677169, 5845.620034697731, 5862.765489380377, 5570.721463926788, 5621.0444224481935, 5627.409122042209, 5630.155476678531, 5634.718264086861, 5416.91874621881, 5441.102218134043, 5494.038543254915, 5647.802326918538, 5656.91514627281, 5545.805896793593, 5554.86112847174, 5565.1374037024325, 5567.053600887859, 5622.381538030813, 5539.750711218005, 5577.832665020056, 5584.804531841447, 5586.35756887955, 5588.524975377139, 4154.937675934863, 4186.288330983679, 4229.830806767694, 4247.214265360918, 4284.871453856389, 3867.903302417462, 3879.8448062077764, 3902.3951287550476, 3927.0771368728324, 3959.9010024749036, 5278.261043453919, 5305.495977882172, 5329.9467005330225, 5341.305630268041, 5341.893162136813, 5512.586556008316, 5637.830865074055, 5714.914276285859, 5715.1713001614535, 5747.597668163272, 5315.760790764425, 5316.0962636351915, 5319.601029922771, 5343.545798607084, 5345.599080069011, 4884.95115048852, 4887.755612219375, 4890.315355850184, 4910.116179087799, 4939.086269040239, 5747.051736463437, 5771.24973753401, 5916.23088998436, 5924.4667979882015, 5930.140129681258, 5589.049861523469, 5627.0, 5647.265855438766, 5687.402822703722, 5689.118186681071, 5803.7968671096305, 5805.332386775575, 5807.506361959112, 5808.07070868659, 5809.2738407699035, 5452.209429632601, 5471.179323101566, 5511.338639363142, 5513.117901135799, 5516.117421212587, 5637.0, 5670.036093863971, 5685.0, 5703.714814259188, 5766.394528574439, 5561.0, 5566.220729097849, 5571.4428557143965, 5572.275604171594, 5573.665580065209, 5425.782968681208, 5572.331320241597, 5578.581606379619, 5579.414161513145, 5581.665100094007, 5338.412774594869, 5378.462153784591, 5389.380221274447, 5414.8646283841645, 5453.15476101205, 5477.4796394342475, 5488.204210389551, 5521.861953451035, 5527.088030475087, 5533.501984821385, 5373.2746079278795, 5392.0, 5392.110301800316, 5402.6758394496455, 5405.351357837085], "value": 5198.620314580405, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.6854459635099, 579.7912751409493, 603.5955909540608, 625.9342769009254, 631.693628590134, 31701.841490792543, 32219.51670724941, 34289.31421371571, 43995.0, 44766.0, 45710.771446142804, 45964.770176149075, 46056.0, 46106.538934610646, 46150.0, 8863.645454181826, 9063.95468022659, 9079.636814527445, 9083.727488175333, 9096.909030909672, 9001.819963600725, 9092.727218183465, 9095.317851161157, 9099.909000910005, 9100.681476148337, 9135.17783399494, 9174.0, 9178.082191780803, 9178.35751497392, 9183.724488265329, 9049.3665443419, 9061.048589898064, 9098.408603440756, 9107.0, 9109.999999999967, 8950.59722312491, 8971.147740964598, 9002.504862232574, 9032.909670903273, 9041.412308200011, 42500.78749606263, 43065.56934430647, 43180.568194317966, 43292.56707432917, 43353.783231083646, 3620.981895090534, 3645.325614761251, 3664.029032306441, 3797.715171362159, 4240.342746874239, 33075.6692433075, 33605.0, 33906.660933390594, 34586.0, 34617.13457163566, 4279.572042795727, 4326.286162783137, 4467.441569803775, 4499.797509112065, 4508.45898492183, 244015.0, 244645.0, 244739.0, 244844.0, 245373.0, 59660.403395965484, 60023.0, 60111.398886011455, 60158.69920650456, 60233.69883150644, 54522.0, 59046.0, 60644.0, 60650.0, 62041.0, 13592.048556601141, 13697.726045479234, 13768.449262029608, 13772.24252666113, 13775.793363099561, 11793.646190614296, 11906.404679765978, 11910.0, 11920.821187682192, 11922.701932451584, 15263.465778697693, 17017.48947531576, 17376.91311543434, 17398.65202695939, 17532.649347013245, 5861.120831875252, 5907.261592300963, 5924.911126333109, 6089.117078023662, 6089.5737298388685, 996.4868092932146, 1059.56557811297, 1076.8355605233537, 1117.4971262931713, 1144.6737679761395, 33744.15639609029, 33988.83005584956, 34001.48997765035, 34070.0, 34448.138796530286, 1133.2747041893194, 1154.440096553171, 1207.4988879615037, 1212.860521040074, 1256.5036810459817, 16874.493765187064, 17605.383811566535, 17767.317549913147, 17775.111244437983, 17947.461576152735, 544049.0, 550555.0, 552218.0, 552498.0, 554755.0, 60820.39179608147, 61053.38946610566, 61069.08396374058, 61109.972353179954, 61150.0, 1305.4908585651604, 1314.750197462479, 1335.052112999781, 1341.9932900335436, 1360.1567028442232, 30576.235594110327, 33212.667873320956, 33240.66759332376, 33269.667303327624, 33515.66484335125, 53957.0, 54305.0, 54394.0, 54458.72770636121, 54496.0, 491533.0, 491994.0, 492689.0, 492943.0, 496327.0, 36697.81651091728, 42088.57911420969, 43425.3486197701, 43492.0, 44099.11801764011, 50466.49533504618, 50542.0, 51233.0, 51371.48628513667, 52137.7393113032, 42284.15431691287, 42932.57067429286, 43371.0, 44232.0, 45330.77334613306, 42177.78911105425, 42698.0, 43489.0, 43700.56299436965, 44525.55474445214, 42806.78596606997, 43243.13513729771, 43304.78347608368, 43976.0, 44003.11993760171, 31266.21834454157, 32450.350992979536, 33390.16524586808, 34243.31513369669, 34590.65409345875, 28858.27854303659, 28896.42207155803, 28937.421251575273, 29371.265718356357, 29410.705892940798], "value": 20295.186684582186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.6106620544053, 381.4564245949523, 391.24880229958484, 395.1070580488097, 414.450852620278, 14537.418503259856, 18816.811831881678, 19211.903940480297, 19898.90050549747, 19933.501662458446, 18586.0, 19598.0, 20435.182592696274, 20497.18011279547, 20569.485762855937, 5372.9462705372935, 5729.054705973509, 5764.423557644244, 5773.0, 5777.451142141511, 5539.307586551681, 5678.914816277759, 5755.280589926259, 5756.0, 5764.164196191549, 5629.831105066834, 5678.0, 5681.0, 5686.004949133906, 5691.630044047124, 5472.151816468454, 5600.831975040755, 5689.2319536862615, 5692.117721753114, 5700.429957004287, 5060.822871199527, 5087.236914462823, 5092.79628814847, 5093.159628661267, 5096.261042148904, 22477.550448991093, 24337.63493547598, 24488.877555612286, 24538.0, 24553.263402097964, 2201.3506015725397, 2242.091952759135, 2249.696291000727, 2449.595816690244, 2488.925332240036, 9739.41563506192, 9787.608495660164, 9902.405855648612, 10378.221633377527, 10435.791284174275, 1859.228420205613, 1913.3112079651314, 1922.6731455652573, 1954.775200851906, 1985.4341512668964, 78456.0, 83906.58046709727, 85953.14046859514, 89613.0, 92731.0, 10228.33515821484, 10345.275830691779, 10602.416867072385, 11008.449577521093, 11024.369764698846, 13297.3351332433, 13678.93160534191, 13802.102863313852, 13807.96440266984, 13810.447582096804, 7386.889196662054, 7482.4388170887405, 7710.884336734954, 8037.638306276232, 8138.959305203436, 7315.817104572428, 7450.0687414073245, 7490.1386340571535, 7521.8119547010665, 7594.202608726115, 4226.704130710821, 4238.851640192578, 4330.978345108318, 4460.50934397216, 4586.4496260448295, 1792.1576858876308, 1885.641728071662, 1892.3187652445108, 1910.8853468791917, 1940.7013465174705, 957.0525180071679, 983.2625530851861, 1014.7716763728102, 1019.7399663085865, 1055.4300677633992, 19936.50158746043, 20780.37658870206, 20930.476738081365, 20969.26607568758, 20982.580348392945, 984.3945973226557, 985.2561316206219, 1002.2783595811004, 1063.9095676867553, 1086.6631344283298, 9038.734577159203, 11318.830217546743, 11375.886241137649, 11458.140639452075, 11458.713532161762, 471456.0, 472503.0, 547523.0, 549209.0, 553523.0, 99737.0, 102531.53805800415, 102557.48721256346, 105226.0, 107149.0, 1002.5588740953957, 1013.3919648211014, 1051.363924825485, 1056.5984925728328, 1059.9682009539727, 17258.568535786704, 17941.461756147335, 18323.175457104197, 18360.816391836444, 18517.81482185161, 42858.0, 43802.34296485619, 43820.0, 44746.552534475544, 45197.54802451933, 59503.0, 62318.0, 63143.36856631375, 64321.67839160774, 65383.34616653963, 7019.4735394844565, 7540.811479713051, 7731.574763387843, 7845.176256492986, 8095.311898488459, 11507.252028618113, 13208.603741887759, 13385.732285354043, 13410.195388276734, 13636.386362613905, 11705.0, 11928.224665396721, 12021.338826364634, 12021.677615462468, 12205.75588488243, 10908.127349811837, 11546.249493782878, 11771.646850594496, 12152.817707734568, 12195.634130976085, 6692.330766923269, 11333.489992950172, 11735.23720958135, 11850.170488066098, 12031.217970831867, 8140.308073813792, 8208.302294305051, 8324.042735085543, 8356.289715374018, 8458.661653533789, 10194.337368071052, 11942.820857687315, 11983.0, 12256.203346782431, 12318.876811231772], "value": 9187.153201273473, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.059488952622, 1461.978070328945, 1521.148157032062, 1639.22956210581, 1777.200259883053, 8272.917270827289, 8557.0, 8662.566871656416, 8802.471851688902, 8806.691765788199, 8653.826923461544, 8680.435771674836, 8733.91266087339, 8745.91254087459, 8752.737417877457, 2316.1546035696974, 2339.532093581282, 2340.1692399198296, 2340.6137987232087, 2345.2143531916827, 2250.85369450986, 2293.6330187170056, 2296.873671948042, 2300.160441438871, 2328.860268383902, 2275.488015196576, 2275.8293128015384, 2297.908083676651, 2301.850379725321, 2305.7924786769186, 2209.2046863129262, 2234.3408694435097, 2243.170027089971, 2244.674522194281, 2245.124401483423, 2232.6985856909273, 2232.910683572655, 2233.888305584714, 2239.484918468745, 2242.215224671352, 8611.913880861173, 8671.913280867173, 8683.0, 8744.300455963508, 8745.212930836191, 5022.59819214462, 5174.793008279665, 5208.218767184915, 5229.163333866563, 5236.0, 3254.1864533866533, 3259.6903294187014, 3266.921915767791, 3333.8999830005137, 3336.1492819331156, 1029.0943969307036, 1037.2998226197362, 1044.7492601775596, 1045.6078970386104, 1062.3678911047914, 12060.457279422359, 12114.0, 12168.878311216864, 12227.082968777377, 12235.93882030584, 4199.0, 4313.0726893718, 4399.098184872094, 4453.532379100213, 4455.443069616298, 9636.180924621345, 9637.325387222967, 9649.93850676425, 9650.517474126405, 9650.613975441043, 5085.74571271435, 5095.312132862016, 5104.642675012788, 5119.590432765444, 5129.769160387791, 4235.7670328131635, 4595.356650068926, 4701.012787314702, 4765.11845308619, 4765.9523404765505, 3724.1806802503406, 3745.9625403745613, 3844.75009124406, 3892.3577609694084, 3894.4937158169255, 1052.5947510208625, 1150.1086657840074, 1153.9538418463167, 1159.3855256713955, 1166.877477864829, 991.5785791038924, 1002.4787110702393, 1003.2174903575223, 1004.6935684616116, 1011.8229309870743, 5946.583739138306, 5979.970100149471, 6165.876682466325, 6189.102580125857, 6395.131319681758, 434.88910327866193, 438.9956100439019, 441.91824512464655, 442.97120687155234, 449.8672891497016, 4172.687048471316, 4223.324268117087, 4284.186004659105, 4303.569643035671, 4363.672724545671, 10785.13718902486, 10981.945090274497, 11058.060064894413, 11059.502322395512, 11060.059894908862, 10950.945245273722, 10970.122390208764, 10998.780024399468, 11008.449577521093, 11059.668209953714, 7864.4888082274465, 8101.554414507259, 8197.549134797524, 8228.177182281843, 8242.835143297101, 6231.345708700521, 6354.4281014708895, 6393.904091438539, 6404.711787969646, 6464.321246269074, 10107.19142468586, 10247.743806404602, 10266.794664106825, 10278.948605257225, 10317.896821031694, 10463.895361046292, 10512.0013598708, 10519.368837869752, 10537.736556586147, 10544.472776361305, 7248.927510725036, 7752.4573279869865, 7938.3252423544645, 7995.480293780885, 8153.592320384076, 8640.222379985831, 8708.521031343336, 8717.956410217908, 8788.648454061766, 8809.07504711996, 7648.426368022532, 7705.036870391201, 7848.646810893638, 7877.291043806085, 7911.604419778873, 7445.441591880739, 7506.1743208248145, 7590.544567325978, 7634.541927484369, 7790.844183116193, 7130.643467826691, 7218.169910460364, 7237.059182306267, 7245.94933734595, 7252.2747725227055, 4988.226824842155, 5174.482551744946, 5190.169572868323, 5217.591250362457, 5256.132738098171, 5414.485623865727, 5444.6188766785945, 5503.862403439946, 5513.365962914316, 5683.60214784961], "value": 4517.66369011202, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.8624591425686, 322.1880860232215, 328.4432886257793, 337.2445721583652, 341.3275846582232, 5307.222080602998, 5350.678959262447, 5360.9463905360935, 5381.0, 5385.1922211668225, 4967.850964471063, 5088.771005304761, 5154.768035438405, 5209.505097015787, 5260.0, 4095.9590404096025, 4100.712950093494, 4103.363978583325, 4114.259433302004, 4136.097395198198, 4104.753714777123, 4116.300228961069, 4124.422580838685, 4128.967758060485, 4138.089620283533, 3869.342211823983, 3892.6691231245236, 4085.6527195188446, 4090.897727556805, 4095.815688294034, 4109.8972525686795, 4110.917781644365, 4114.300568903279, 4114.773687447189, 4118.588141185887, 3597.8380972856285, 3639.253952939641, 3644.6173151819207, 3647.5987641359693, 3648.1062139775927, 5028.723420211887, 5090.821821236276, 5091.66904151229, 5163.483651634844, 5188.533032027136, 4644.674872758908, 4648.511906249829, 4649.651925777494, 4649.674522783406, 4655.208614535503, 5393.946060539383, 5407.242985981966, 5412.72800891794, 5412.729363531847, 5424.430434804368, 3750.3999360102252, 3946.506686664167, 3952.3083460394314, 3960.1881614269005, 3960.2079584083012, 5624.850083952959, 5626.578006649477, 5635.900999305137, 5647.548196144298, 5659.943400565983, 3866.903327416837, 3871.554771201348, 3873.96126038736, 3875.651191392732, 3877.0695033191832, 3858.479105320802, 3912.7456715313983, 3936.8031598419966, 3944.0928586425284, 3950.1902110067367, 4464.55354464551, 4479.96960699041, 4525.389072475239, 4535.569120933506, 4560.977195114069, 5374.220737992969, 5391.137418013099, 5402.324709411324, 5412.431694672082, 5437.537809286176, 1391.4016972701836, 1411.3648858013935, 1411.6047506697935, 1412.5479846449039, 1418.326295009862, 936.424099179, 973.8733964584559, 977.7555611097225, 983.1986930651639, 988.9912289464705, 5109.770060347293, 5166.276721259027, 5173.663711858717, 5189.702574356411, 5231.921521177185, 5619.157126430986, 5637.9718101409235, 5657.6322539035655, 5703.771849125988, 5706.343770466367, 5163.638545301793, 5179.689218646893, 5217.765200565984, 5245.239440281214, 5253.270178173463, 2984.746296564773, 2995.8801647933838, 2997.2057404787747, 3005.6242969628797, 3009.4432529982023, 5650.74571644277, 5780.479756821822, 5810.535157187415, 5820.097884827858, 5836.445537673914, 5652.434756524314, 5688.658680479184, 5689.406966049512, 5690.658560486384, 5714.914276285859, 5756.798512052225, 5758.654480731169, 5758.905807896403, 5771.88456230873, 5786.161006654096, 5405.8918821622565, 5465.289512363367, 5535.806246781343, 5562.415946325577, 5570.972145139411, 5481.287432633732, 5512.401403592913, 5520.834374968757, 5521.1442226454965, 5522.530584900168, 5565.38780734127, 5763.965224342893, 5769.278840144982, 5814.767409303749, 5833.270841144857, 4029.8388064478268, 4037.7779222143063, 4068.247374235776, 4094.938575921304, 4100.0, 5421.376541697755, 5625.268715067015, 5680.289963754531, 5769.509591684754, 5780.421957804186, 5488.780448782004, 5530.308711411074, 5547.278853748987, 5553.194786755978, 5572.247746554163, 5503.917441238465, 5509.201165831012, 5513.696746678811, 5514.834554963358, 5517.641353312022, 5199.532042116228, 5395.81114660985, 5463.180522921593, 5466.562674986071, 5471.972640136773, 5540.833774986757, 5542.7551841504255, 5559.388467268516, 5562.777488900399, 5579.218909352775, 5168.896622067462, 5378.327709036371, 5460.972695136499, 5463.9180412294645, 5471.781128754806], "value": 4179.261627364878, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.5170942306346, 766.8159641685997, 769.6113462701335, 847.0, 880.5025160784154, 15695.450659226915, 16837.410690625817, 16909.154542272867, 16931.322747090133, 16993.150342482873, 14624.122552646848, 15472.226388680578, 15547.455839045635, 15694.21528923555, 15703.21483925802, 827.2017503109513, 848.6138806842903, 850.4642075492432, 851.5997481183833, 853.0914575976597, 662.9403353698166, 802.0335495727634, 839.5718183726283, 840.0549381945311, 841.9284360829337, 842.5492361586553, 842.806154584446, 843.0515669871395, 843.9535825529593, 880.9691660791874, 870.0733718589681, 871.5642178910545, 873.8339715454075, 873.9388242823005, 874.1608056266024, 513.2224679610393, 621.6953692690595, 632.3044650884037, 634.7968650031992, 637.5600835423543, 15860.44488442899, 15893.284802183814, 15904.522864314089, 15910.284037218353, 15917.840821591752, 14475.78286325706, 14502.492412765503, 14660.193689347081, 14722.337494812651, 15104.471343502924, 13375.866241337657, 13589.0, 13694.178349298974, 13871.237081960488, 14427.0, 3882.825272862728, 4126.3397856343145, 4541.591256786905, 4633.582977532038, 4773.665843390964, 66660.0, 68217.3178268216, 68554.0, 84262.57868710678, 85898.57050714768, 12451.688707782378, 12664.240145591293, 12735.172213806072, 12758.0, 13427.798583021262, 23485.41286467818, 23678.526429471312, 23715.169969051, 23721.644175337384, 24119.03523859026, 9204.0, 9309.44143351401, 9465.290103242147, 9536.618535258513, 9607.471589062668, 4961.627877909171, 4973.502649734997, 4976.701397916137, 5072.264521644341, 5130.948690513047, 3392.8982130536124, 3490.3193877194212, 3500.842462089212, 3505.36903357393, 3506.982465087658, 577.2409281794427, 581.4069648958039, 587.5974957154363, 592.982210533676, 609.1471939284947, 684.0252639987997, 771.9903278233626, 786.7954331873754, 809.1948511231362, 821.6754382019069, 10083.495825208856, 10237.0, 10422.895771042193, 10584.4707764613, 10723.678289651323, 570.7688386203595, 712.5510928115255, 712.7968528969323, 771.4021633234288, 795.2921899509441, 4833.4441539222735, 4987.700737955734, 5004.449510553836, 5049.242613607915, 5126.66676666023, 69042.30957690459, 69756.30243697498, 71544.0, 117343.0, 125255.0, 100620.0, 100755.0, 101041.0, 102302.0, 103622.48188759008, 89623.0, 92349.53825230965, 93577.0, 94812.52593736986, 96139.51930240444, 9374.953393685273, 9576.377535460173, 9766.169875560658, 9899.662895130285, 10024.097831195228, 42271.57728422799, 44661.0, 48966.63433753589, 49933.500664992884, 50809.74595127001, 72321.55356892938, 74078.0, 77343.61328193323, 79419.0, 79724.60137699507, 13096.0, 13313.334333283103, 13555.796663049865, 13601.863981360455, 13761.655958600715, 15205.77191342153, 15910.60223494422, 15934.60163495922, 16349.182540873147, 16412.09733464671, 14539.854601454274, 15123.39506419775, 15456.149911754512, 15615.297311621232, 15667.608309792346, 14962.850371496581, 15050.774238386213, 15059.171745553662, 15066.09603423798, 15104.924475377553, 14177.858221417653, 14242.21667808239, 14380.784288235895, 14426.0, 14791.778123328373, 11330.716732081764, 11593.24643898144, 11597.6520704379, 11682.532698691957, 12085.0, 9037.954810225907, 11001.889981100087, 11561.59534416325, 11603.767924641628, 12157.0], "value": 7843.076080722777, "unit": "score"}], "name": "dromaeo_css", "value": 7236.050416751782, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 111.0, 112.0, 112.0, 113.0, 113.0, 110.0, 113.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 120.0, 182.0, 117.0, 119.0, 151.0, 117.0, 150.0, 116.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 82.0, 107.0, 75.0, 75.0, 74.0, 75.0, 98.0, 74.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 125.0, 84.0, 85.0, 85.0, 123.0, 85.0, 84.0, 132.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 53.0, 52.0, 52.0, 52.0, 52.0, 51.0, 51.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 76.0, 76.0, 75.0, 76.0, 76.0, 76.0, 79.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 126.0, 120.0, 119.0, 121.0, 119.0, 131.0, 122.0, 178.0, 136.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 164.0, 157.0, 156.0, 156.0, 158.0, 155.0, 155.0, 157.0, 162.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 61.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1482.7000000000003, "alertThreshold": 2.0}]} 13:48:23 INFO - Return code: 0 13:48:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:48:23 INFO - # TBPL SUCCESS # 13:48:23 INFO - Running post-action listener: _resource_record_post_action 13:48:23 INFO - [mozharness: 2016-07-28 20:48:23.500482Z] Finished run-tests step (success) 13:48:23 INFO - Running post-run listener: _resource_record_post_run 13:48:23 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 553558016; Read time: 184; Write time: 430676 13:48:23 INFO - TinderboxPrint: CPU usage
13.0% 13:48:23 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 184 13:48:23 INFO - TinderboxPrint: I/O write bytes / time
553,558,016 / 430,676 13:48:23 INFO - TinderboxPrint: CPU idle
8,289.8 (87.0%) 13:48:23 INFO - TinderboxPrint: CPU user
1,194.6 (12.5%) 13:48:23 INFO - TinderboxPrint: Swap in / out
0 / 0 13:48:23 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 4096; Write bytes: 257974272; Read time: 132; Write time: 250464 13:48:23 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295391232; Read time: 52; Write time: 180196 13:48:24 INFO - Running post-run listener: _upload_blobber_files 13:48:24 INFO - Blob upload gear active. 13:48:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:48:24 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 13:48:24 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'] 13:48:24 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 13:48:24 INFO - (blobuploader) - INFO - Open directory for files ... 13:48:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:48:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:48:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:48:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:48:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:48:25 INFO - (blobuploader) - INFO - Done attempting. 13:48:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:48:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:48:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:48:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:48:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:48:26 INFO - (blobuploader) - INFO - Done attempting. 13:48:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:48:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:48:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:48:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:48:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:48:30 INFO - (blobuploader) - INFO - Done attempting. 13:48:30 INFO - (blobuploader) - INFO - Iteration through files over. 13:48:30 INFO - Return code: 0 13:48:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:48:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:48:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a8a8063f2959c90c076a64e6b74814acb32e618ab0d24a3d6a37bf220158fbf53183d838ec2a94f4879487fce92e55b019af4985ec73168e07473b12836e1e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2738a670603d952567b3bc0048e420690c93306a8aa076fd52bfd71517135b65661083d2482321623b4d12c616e6b495f678aec86426f2ef04d9ff75ffbf1de9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/35dceefb47775b7d0b4e534ffe21384e15648269d30bfeb4556e054a85bf62a26157979b79bd4e5764b68b5801d87e04b87bcc3760b7920d3abde54a3a4355a2"} 13:48:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:48:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:48:30 INFO - Contents: 13:48:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a8a8063f2959c90c076a64e6b74814acb32e618ab0d24a3d6a37bf220158fbf53183d838ec2a94f4879487fce92e55b019af4985ec73168e07473b12836e1e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2738a670603d952567b3bc0048e420690c93306a8aa076fd52bfd71517135b65661083d2482321623b4d12c616e6b495f678aec86426f2ef04d9ff75ffbf1de9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/35dceefb47775b7d0b4e534ffe21384e15648269d30bfeb4556e054a85bf62a26157979b79bd4e5764b68b5801d87e04b87bcc3760b7920d3abde54a3a4355a2"} 13:48:30 INFO - Running post-run listener: copy_logs_to_upload_dir 13:48:30 INFO - Copying logs to upload dir... 13:48:30 INFO - mkdir: /builds/slave/test/build/upload/logs 13:48:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.616803 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-28 13:48:30.023569) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 13:48:30.026700) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331 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/1a8a8063f2959c90c076a64e6b74814acb32e618ab0d24a3d6a37bf220158fbf53183d838ec2a94f4879487fce92e55b019af4985ec73168e07473b12836e1e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2738a670603d952567b3bc0048e420690c93306a8aa076fd52bfd71517135b65661083d2482321623b4d12c616e6b495f678aec86426f2ef04d9ff75ffbf1de9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/35dceefb47775b7d0b4e534ffe21384e15648269d30bfeb4556e054a85bf62a26157979b79bd4e5764b68b5801d87e04b87bcc3760b7920d3abde54a3a4355a2"} build_url:https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/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/1a8a8063f2959c90c076a64e6b74814acb32e618ab0d24a3d6a37bf220158fbf53183d838ec2a94f4879487fce92e55b019af4985ec73168e07473b12836e1e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2738a670603d952567b3bc0048e420690c93306a8aa076fd52bfd71517135b65661083d2482321623b4d12c616e6b495f678aec86426f2ef04d9ff75ffbf1de9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/35dceefb47775b7d0b4e534ffe21384e15648269d30bfeb4556e054a85bf62a26157979b79bd4e5764b68b5801d87e04b87bcc3760b7920d3abde54a3a4355a2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 13:48:30.052045) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:48:30.052381) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1469737660.490634-1346687331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:48:30.135096) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 13:48:30.135468) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 13:48:30.135764) ========= ========= Total master_lag: 3.44 =========