builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1462997720.1 results: success (0) buildid: 20160511073006 builduid: c0dfd175262a481abcc3f0f0056564c5 revision: 6578e218bdbaabd3b73d44e7786c3b7649053df2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 13:15:20.098514) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 13:15:20.098998) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 13:15:20.099272) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 13:15:20.115305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:15:20.115607) ========= 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=7de08804244eb36560b44971000001c3-1462997719.628228-1240805168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 13:15:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-05-11 13:15:20 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159557 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:15:20.288228) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:15:20.288556) ========= 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=7de08804244eb36560b44971000001c3-1462997719.628228-1240805168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017911 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:15:20.338224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 13:15:20.338556) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6578e218bdbaabd3b73d44e7786c3b7649053df2 --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 6578e218bdbaabd3b73d44e7786c3b7649053df2 --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=7de08804244eb36560b44971000001c3-1462997719.628228-1240805168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 13:15:20,564 truncating revision to first 12 chars 2016-05-11 13:15:20,564 Setting DEBUG logging. 2016-05-11 13:15:20,564 attempt 1/10 2016-05-11 13:15:20,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6578e218bdba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 13:15:21,756 unpacking tar archive at: mozilla-inbound-6578e218bdba/testing/mozharness/ program finished with exit code 0 elapsedTime=1.499708 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 13:15:21.850935) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 13:15:21.851277) ========= script_repo_revision: 6578e218bdbaabd3b73d44e7786c3b7649053df2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 13:15:21.851710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 13:15:21.851986) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 13:15:21.862225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-11 13:15:21.862649) ========= /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=7de08804244eb36560b44971000001c3-1462997719.628228-1240805168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:15:22 INFO - MultiFileLogger online at 20160511 13:15:22 in /builds/slave/test 13:15:22 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:15:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:15:22 INFO - {'append_to_log': False, 13:15:22 INFO - 'base_work_dir': '/builds/slave/test', 13:15:22 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:15:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:15:22 INFO - 'branch': 'Mozilla-Inbound', 13:15:22 INFO - 'buildbot_json_path': 'buildprops.json', 13:15:22 INFO - 'config_files': ('talos/linux_config.py',), 13:15:22 INFO - 'default_actions': ('clobber', 13:15:22 INFO - 'read-buildbot-config', 13:15:22 INFO - 'download-and-extract', 13:15:22 INFO - 'populate-webroot', 13:15:22 INFO - 'create-virtualenv', 13:15:22 INFO - 'install', 13:15:22 INFO - 'run-tests'), 13:15:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:15:22 INFO - 'download_minidump_stackwalk': True, 13:15:22 INFO - 'download_symbols': 'ondemand', 13:15:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:15:22 INFO - 'tooltool.py': '/tools/tooltool.py', 13:15:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:15:22 INFO - '/tools/misc-python/virtualenv.py')}, 13:15:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:15:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:15:22 INFO - 'installer_path': 'installer.exe', 13:15:22 INFO - 'log_level': 'info', 13:15:22 INFO - 'log_name': 'talos', 13:15:22 INFO - 'log_to_console': True, 13:15:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:15:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:15:22 INFO - 'opt_config_files': (), 13:15:22 INFO - 'pip_index': False, 13:15:22 INFO - 'sps_profile': False, 13:15:22 INFO - 'sps_profile_interval': 0, 13:15:22 INFO - 'suite': 'dromaeojs', 13:15:22 INFO - 'system_bits': '32', 13:15:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:15:22 INFO - 'title': 'talos-linux64-ix-003', 13:15:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:15:22 INFO - 'use_talos_json': True, 13:15:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:15:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:15:22 INFO - 'work_dir': 'build'} 13:15:22 INFO - ##### 13:15:22 INFO - ##### Running clobber step. 13:15:22 INFO - ##### 13:15:22 INFO - Running pre-action listener: _resource_record_pre_action 13:15:22 INFO - Running main action method: clobber 13:15:22 INFO - rmtree: /builds/slave/test/build 13:15:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:15:23 INFO - Running post-action listener: _resource_record_post_action 13:15:23 INFO - ##### 13:15:23 INFO - ##### Finished clobber step (success) 13:15:23 INFO - ##### 13:15:23 INFO - ##### 13:15:23 INFO - ##### Running read-buildbot-config step. 13:15:23 INFO - ##### 13:15:23 INFO - Running pre-action listener: _resource_record_pre_action 13:15:23 INFO - Running main action method: read_buildbot_config 13:15:23 INFO - Using buildbot properties: 13:15:23 INFO - { 13:15:23 INFO - "project": "", 13:15:23 INFO - "product": "firefox", 13:15:23 INFO - "script_repo_revision": "production", 13:15:23 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:15:23 INFO - "repository": "", 13:15:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:15:23 INFO - "buildid": "20160511073006", 13:15:23 INFO - "pgo_build": "True", 13:15:23 INFO - "basedir": "/builds/slave/test", 13:15:23 INFO - "buildnumber": 895, 13:15:23 INFO - "slavename": "talos-linux64-ix-003", 13:15:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:15:23 INFO - "platform": "ubuntu64_hw", 13:15:23 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:15:23 INFO - "branch": "mozilla-inbound", 13:15:23 INFO - "repo_path": "integration/mozilla-inbound", 13:15:23 INFO - "revision": "6578e218bdbaabd3b73d44e7786c3b7649053df2", 13:15:23 INFO - "stage_platform": "linux64-pgo", 13:15:23 INFO - "builduid": "c0dfd175262a481abcc3f0f0056564c5", 13:15:23 INFO - "slavebuilddir": "test" 13:15:23 INFO - } 13:15:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:15:23 INFO - Running post-action listener: _resource_record_post_action 13:15:23 INFO - ##### 13:15:23 INFO - ##### Finished read-buildbot-config step (success) 13:15:23 INFO - ##### 13:15:23 INFO - ##### 13:15:23 INFO - ##### Running download-and-extract step. 13:15:23 INFO - ##### 13:15:23 INFO - Running pre-action listener: _resource_record_pre_action 13:15:23 INFO - Running main action method: download_and_extract 13:15:23 INFO - mkdir: /builds/slave/test/build/tests 13:15:23 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:15:23 INFO - https://queue.taskcluster.net/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:15:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:15:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:15:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:15:23 INFO - Downloaded 1361 bytes. 13:15:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:15:23 INFO - Using the following test package requirements: 13:15:23 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:15:23 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:15:23 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:15:23 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:23 INFO - u'jsshell-linux-x86_64.zip'], 13:15:23 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:15:23 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:15:23 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:15:23 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:15:23 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:15:23 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:15:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:15:23 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:15:23 INFO - https://queue.taskcluster.net/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:15:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:15:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:15:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:15:25 INFO - Downloaded 23903201 bytes. 13:15:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:15:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:15:26 INFO - Return code: 0 13:15:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:26 INFO - https://queue.taskcluster.net/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:15:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:15:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:15:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:15:27 INFO - Downloaded 23903201 bytes. 13:15:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:15:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:15:28 INFO - Return code: 0 13:15: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:15:28 INFO - https://queue.taskcluster.net/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:15:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:15:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:15:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:15:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:15:30 INFO - Downloaded 10840152 bytes. 13:15:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:15:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:15:30 INFO - Return code: 0 13:15:30 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:15:30 INFO - https://queue.taskcluster.net/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:15:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:15:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:15:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:15:31 INFO - Downloaded 58341890 bytes. 13:15:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:15:31 INFO - mkdir: /builds/slave/test/properties 13:15:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:15:31 INFO - Writing to file /builds/slave/test/properties/build_url 13:15:31 INFO - Contents: 13:15:31 INFO - build_url:https://queue.taskcluster.net/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:15:32 INFO - Running post-action listener: _resource_record_post_action 13:15:32 INFO - Running post-action listener: set_extra_try_arguments 13:15:32 INFO - ##### 13:15:32 INFO - ##### Finished download-and-extract step (success) 13:15:32 INFO - ##### 13:15:32 INFO - ##### 13:15:32 INFO - ##### Running populate-webroot step. 13:15:32 INFO - ##### 13:15:32 INFO - Running pre-action listener: _resource_record_pre_action 13:15:32 INFO - Running main action method: populate_webroot 13:15:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:15:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:15:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:15:32 INFO - '--tppagecycles', 13:15:32 INFO - '7'], 13:15:32 INFO - 'tests': ['tsvgm']}}, 13:15:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:15:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:15:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:15:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:15:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:15:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:15:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:32 INFO - 'talos_options': ['--disable-e10s'], 13:15:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:15:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:15:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:32 INFO - 'talos_options': ['--disable-e10s'], 13:15:32 INFO - 'tests': ['damp', 'tps']}, 13:15:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:32 INFO - 'tests': ['damp', 'tps']}, 13:15:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:15:32 INFO - 'tests': ['dromaeo_dom']}, 13:15:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:15:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:15:32 INFO - 'tests': ['a11yr', 13:15:32 INFO - 'ts_paint', 13:15:32 INFO - 'tpaint', 13:15:32 INFO - 'sessionrestore', 13:15:32 INFO - 'sessionrestore_no_auto_restore', 13:15:32 INFO - 'tabpaint']}, 13:15:32 INFO - 'other-e10s': {'tests': ['a11yr', 13:15:32 INFO - 'ts_paint', 13:15:32 INFO - 'tpaint', 13:15:32 INFO - 'sessionrestore', 13:15:32 INFO - 'sessionrestore_no_auto_restore', 13:15:32 INFO - 'tabpaint']}, 13:15:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:15:32 INFO - 'ts_paint', 13:15:32 INFO - 'tpaint', 13:15:32 INFO - 'sessionrestore', 13:15:32 INFO - 'sessionrestore_no_auto_restore', 13:15:32 INFO - 'tabpaint']}, 13:15:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:15:32 INFO - 'ts_paint', 13:15:32 INFO - 'tpaint', 13:15:32 INFO - 'sessionrestore', 13:15:32 INFO - 'sessionrestore_no_auto_restore', 13:15:32 INFO - 'tabpaint']}, 13:15:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:15:32 INFO - 'tests': ['a11yr', 13:15:32 INFO - 'ts_paint', 13:15:32 INFO - 'tpaint', 13:15:32 INFO - 'sessionrestore', 13:15:32 INFO - 'sessionrestore_no_auto_restore', 13:15:32 INFO - 'tabpaint']}, 13:15:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:15:32 INFO - 'tests': ['a11yr', 13:15:32 INFO - 'ts_paint', 13:15:32 INFO - 'tpaint', 13:15:32 INFO - 'sessionrestore', 13:15:32 INFO - 'sessionrestore_no_auto_restore', 13:15:32 INFO - 'tabpaint']}, 13:15:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:15:32 INFO - 'tests': ['tsvgx', 13:15:32 INFO - 'tsvgr_opacity', 13:15:32 INFO - 'tart', 13:15:32 INFO - 'tscrollx', 13:15:32 INFO - 'cart']}, 13:15:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:15:32 INFO - 'tsvgr_opacity', 13:15:32 INFO - 'tart', 13:15:32 INFO - 'tscrollx', 13:15:32 INFO - 'cart']}, 13:15:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:32 INFO - 'talos_options': ['--disable-e10s'], 13:15:32 INFO - 'tests': ['tp5o']}, 13:15:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:32 INFO - 'tests': ['tp5o']}, 13:15:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:32 INFO - 'talos_options': ['--disable-e10s', 13:15:32 INFO - '--xperf_path', 13:15:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:15:32 INFO - 'tests': ['tp5n']}, 13:15:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:32 INFO - 'talos_options': ['--xperf_path', 13:15:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:15:32 INFO - 'tests': ['tp5n']}}, 13:15:32 INFO - 'talos.zip': {'path': '', 13:15:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:15:32 INFO - Running post-action listener: _resource_record_post_action 13:15:32 INFO - ##### 13:15:32 INFO - ##### Finished populate-webroot step (success) 13:15:32 INFO - ##### 13:15:32 INFO - ##### 13:15:32 INFO - ##### Running create-virtualenv step. 13:15:32 INFO - ##### 13:15:32 INFO - Running pre-action listener: _resource_record_pre_action 13:15:32 INFO - Running main action method: create_virtualenv 13:15:32 INFO - Creating virtualenv /builds/slave/test/build/venv 13:15:32 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:15:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:15:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:15:32 INFO - Using real prefix '/usr' 13:15:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:15:33 INFO - Installing distribute.............................................................................................................................................................................................done. 13:15:35 INFO - Installing pip.................done. 13:15:35 INFO - Return code: 0 13:15:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:15:35 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:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:35 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:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:35 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 0x7f494bc6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d69c0>, '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 0x22d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d7d50>, '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': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', '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:15:35 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:15:35 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:15:35 INFO - Using env: {'DISPLAY': ':0', 13:15:35 INFO - 'HOME': '/home/cltbld', 13:15:35 INFO - 'LANG': 'en_US.UTF-8', 13:15:35 INFO - 'LANGUAGE': 'en_US:en', 13:15:35 INFO - 'LOGNAME': 'cltbld', 13:15:35 INFO - 'MAIL': '/var/mail/cltbld', 13:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:35 INFO - 'MOZ_NO_REMOTE': '1', 13:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:35 INFO - 'NO_EM_RESTART': '1', 13:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:35 INFO - 'PWD': '/builds/slave/test', 13:15:35 INFO - 'SHELL': '/bin/bash', 13:15:35 INFO - 'SHLVL': '1', 13:15:35 INFO - 'TERM': 'linux', 13:15:35 INFO - 'TMOUT': '86400', 13:15:35 INFO - 'USER': 'cltbld', 13:15:35 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', 13:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:35 INFO - '_': '/tools/buildbot/bin/python'} 13:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:35 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:15:35 INFO - Cleaning up... 13:15:35 INFO - Return code: 0 13:15:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:15:35 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:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:35 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:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:35 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f494bc6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d69c0>, '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 0x22d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d7d50>, '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': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', '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:15:35 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>=0.7.1'] in /builds/slave/test/build 13:15:35 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>=0.7.1 13:15:35 INFO - Using env: {'DISPLAY': ':0', 13:15:35 INFO - 'HOME': '/home/cltbld', 13:15:35 INFO - 'LANG': 'en_US.UTF-8', 13:15:35 INFO - 'LANGUAGE': 'en_US:en', 13:15:35 INFO - 'LOGNAME': 'cltbld', 13:15:35 INFO - 'MAIL': '/var/mail/cltbld', 13:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:35 INFO - 'MOZ_NO_REMOTE': '1', 13:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:35 INFO - 'NO_EM_RESTART': '1', 13:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:35 INFO - 'PWD': '/builds/slave/test', 13:15:35 INFO - 'SHELL': '/bin/bash', 13:15:35 INFO - 'SHLVL': '1', 13:15:35 INFO - 'TERM': 'linux', 13:15:35 INFO - 'TMOUT': '86400', 13:15:35 INFO - 'USER': 'cltbld', 13:15:35 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', 13:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:35 INFO - '_': '/tools/buildbot/bin/python'} 13:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:35 INFO - Downloading/unpacking psutil>=0.7.1 13:15:35 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:15:35 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:15:35 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:15:35 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:15:35 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:15:35 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:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:15:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:15:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:15:37 INFO - Installing collected packages: psutil 13:15:37 INFO - Running setup.py install for psutil 13:15:37 INFO - building 'psutil._psutil_linux' extension 13:15:37 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:15:37 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:15:37 INFO - building 'psutil._psutil_posix' extension 13:15:37 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:15:38 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:15:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:15:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:15:38 INFO - Successfully installed psutil 13:15:38 INFO - Cleaning up... 13:15:38 INFO - Return code: 0 13:15:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:15:38 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:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:38 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:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:38 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f494bc6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d69c0>, '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 0x22d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d7d50>, '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': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', '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:15:38 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.0.0'] in /builds/slave/test/build 13:15:38 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.0.0 13:15:38 INFO - Using env: {'DISPLAY': ':0', 13:15:38 INFO - 'HOME': '/home/cltbld', 13:15:38 INFO - 'LANG': 'en_US.UTF-8', 13:15:38 INFO - 'LANGUAGE': 'en_US:en', 13:15:38 INFO - 'LOGNAME': 'cltbld', 13:15:38 INFO - 'MAIL': '/var/mail/cltbld', 13:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:38 INFO - 'MOZ_NO_REMOTE': '1', 13:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:38 INFO - 'NO_EM_RESTART': '1', 13:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:38 INFO - 'PWD': '/builds/slave/test', 13:15:38 INFO - 'SHELL': '/bin/bash', 13:15:38 INFO - 'SHLVL': '1', 13:15:38 INFO - 'TERM': 'linux', 13:15:38 INFO - 'TMOUT': '86400', 13:15:38 INFO - 'USER': 'cltbld', 13:15:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', 13:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:38 INFO - '_': '/tools/buildbot/bin/python'} 13:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:15:38 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:15:38 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:15:38 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:15:38 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:15:38 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:15:38 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:15:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:15:40 INFO - Installing collected packages: mozsystemmonitor 13:15:40 INFO - Running setup.py install for mozsystemmonitor 13:15:40 INFO - Successfully installed mozsystemmonitor 13:15:40 INFO - Cleaning up... 13:15:40 INFO - Return code: 0 13:15:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:40 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 0x7f494bc6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d69c0>, '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 0x22d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d7d50>, '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': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', '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:15:40 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:15:40 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:15:40 INFO - Using env: {'DISPLAY': ':0', 13:15:40 INFO - 'HOME': '/home/cltbld', 13:15:40 INFO - 'LANG': 'en_US.UTF-8', 13:15:40 INFO - 'LANGUAGE': 'en_US:en', 13:15:40 INFO - 'LOGNAME': 'cltbld', 13:15:40 INFO - 'MAIL': '/var/mail/cltbld', 13:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:40 INFO - 'MOZ_NO_REMOTE': '1', 13:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:40 INFO - 'NO_EM_RESTART': '1', 13:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:40 INFO - 'PWD': '/builds/slave/test', 13:15:40 INFO - 'SHELL': '/bin/bash', 13:15:40 INFO - 'SHLVL': '1', 13:15:40 INFO - 'TERM': 'linux', 13:15:40 INFO - 'TMOUT': '86400', 13:15:40 INFO - 'USER': 'cltbld', 13:15:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', 13:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:40 INFO - '_': '/tools/buildbot/bin/python'} 13:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:40 INFO - Downloading/unpacking blobuploader==1.2.4 13:15:40 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:15:40 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:15:40 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:15:40 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:15:40 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:15:40 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:15:42 INFO - Downloading blobuploader-1.2.4.tar.gz 13:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:15:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:15:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:15:43 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:15:43 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:15:43 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:15:43 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:15:43 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:15:43 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:15:43 INFO - Downloading docopt-0.6.1.tar.gz 13:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:15:43 INFO - Installing collected packages: blobuploader, requests, docopt 13:15:43 INFO - Running setup.py install for blobuploader 13:15:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:15:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:15:43 INFO - Running setup.py install for requests 13:15:43 INFO - Running setup.py install for docopt 13:15:43 INFO - Successfully installed blobuploader requests docopt 13:15:43 INFO - Cleaning up... 13:15:43 INFO - Return code: 0 13:15:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:43 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 0x7f494bc6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d69c0>, '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 0x22d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d7d50>, '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': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', '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:15:43 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:15:43 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:15:43 INFO - Using env: {'DISPLAY': ':0', 13:15:43 INFO - 'HOME': '/home/cltbld', 13:15:43 INFO - 'LANG': 'en_US.UTF-8', 13:15:44 INFO - 'LANGUAGE': 'en_US:en', 13:15:44 INFO - 'LOGNAME': 'cltbld', 13:15:44 INFO - 'MAIL': '/var/mail/cltbld', 13:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:44 INFO - 'MOZ_NO_REMOTE': '1', 13:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:44 INFO - 'NO_EM_RESTART': '1', 13:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:44 INFO - 'PWD': '/builds/slave/test', 13:15:44 INFO - 'SHELL': '/bin/bash', 13:15:44 INFO - 'SHLVL': '1', 13:15:44 INFO - 'TERM': 'linux', 13:15:44 INFO - 'TMOUT': '86400', 13:15:44 INFO - 'USER': 'cltbld', 13:15:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', 13:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:44 INFO - '_': '/tools/buildbot/bin/python'} 13:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:44 INFO - Running setup.py (path:/tmp/pip-gJ_WZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:44 INFO - Running setup.py (path:/tmp/pip-c0puaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:44 INFO - Running setup.py (path:/tmp/pip-OMtYdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:44 INFO - Running setup.py (path:/tmp/pip-Vdq7O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:44 INFO - Running setup.py (path:/tmp/pip-YRZyli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:44 INFO - Running setup.py (path:/tmp/pip-BNj5z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:44 INFO - Running setup.py (path:/tmp/pip-5MALh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:44 INFO - Running setup.py (path:/tmp/pip-kjwXsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:44 INFO - Running setup.py (path:/tmp/pip-OHNTbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:44 INFO - Running setup.py (path:/tmp/pip-bzwrfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:44 INFO - Running setup.py (path:/tmp/pip-3bjdDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:44 INFO - Running setup.py (path:/tmp/pip-isUiNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:45 INFO - Running setup.py (path:/tmp/pip-RLxvXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:45 INFO - Running setup.py (path:/tmp/pip-aTC182-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:45 INFO - Running setup.py (path:/tmp/pip-ZmfoFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:45 INFO - Running setup.py (path:/tmp/pip-quxqVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:45 INFO - Running setup.py (path:/tmp/pip-8Ihv0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:15:45 INFO - Running setup.py install for manifestparser 13:15:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:15:45 INFO - Running setup.py install for mozcrash 13:15:45 INFO - Running setup.py install for mozdebug 13:15:45 INFO - Running setup.py install for mozdevice 13:15:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:15:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:15:45 INFO - Running setup.py install for mozfile 13:15:45 INFO - Running setup.py install for mozhttpd 13:15:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:15:46 INFO - Running setup.py install for mozinfo 13:15:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:15:46 INFO - Running setup.py install for mozInstall 13:15:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:15:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:15:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:15:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:15:46 INFO - Running setup.py install for mozleak 13:15:46 INFO - Running setup.py install for mozlog 13:15:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:15:46 INFO - Running setup.py install for moznetwork 13:15:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:15:46 INFO - Running setup.py install for mozprocess 13:15:46 INFO - Running setup.py install for mozprofile 13:15:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:15:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:15:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:15:46 INFO - Running setup.py install for mozrunner 13:15:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:15:46 INFO - Running setup.py install for mozscreenshot 13:15:46 INFO - Running setup.py install for moztest 13:15:47 INFO - Running setup.py install for mozversion 13:15:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:15:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:15:47 INFO - Cleaning up... 13:15:47 INFO - Return code: 0 13:15:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:47 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 0x7f494bc6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d69c0>, '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 0x22d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d7d50>, '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': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', '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:15:47 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:15:47 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:15:47 INFO - Using env: {'DISPLAY': ':0', 13:15:47 INFO - 'HOME': '/home/cltbld', 13:15:47 INFO - 'LANG': 'en_US.UTF-8', 13:15:47 INFO - 'LANGUAGE': 'en_US:en', 13:15:47 INFO - 'LOGNAME': 'cltbld', 13:15:47 INFO - 'MAIL': '/var/mail/cltbld', 13:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:47 INFO - 'MOZ_NO_REMOTE': '1', 13:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:47 INFO - 'NO_EM_RESTART': '1', 13:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:47 INFO - 'PWD': '/builds/slave/test', 13:15:47 INFO - 'SHELL': '/bin/bash', 13:15:47 INFO - 'SHLVL': '1', 13:15:47 INFO - 'TERM': 'linux', 13:15:47 INFO - 'TMOUT': '86400', 13:15:47 INFO - 'USER': 'cltbld', 13:15:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', 13:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:47 INFO - '_': '/tools/buildbot/bin/python'} 13:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:47 INFO - Running setup.py (path:/tmp/pip-aq5bck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:47 INFO - Running setup.py (path:/tmp/pip-vjXxHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:47 INFO - Running setup.py (path:/tmp/pip-dbyKdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:47 INFO - Running setup.py (path:/tmp/pip-F2EXFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:47 INFO - Running setup.py (path:/tmp/pip-4VLYXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:47 INFO - Running setup.py (path:/tmp/pip-pYh4Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:47 INFO - Running setup.py (path:/tmp/pip-mSn0yE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:47 INFO - Running setup.py (path:/tmp/pip-k6Ldq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:47 INFO - Running setup.py (path:/tmp/pip-K8r3w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:48 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:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:48 INFO - Running setup.py (path:/tmp/pip-2brD4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:48 INFO - Running setup.py (path:/tmp/pip-doabbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:48 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:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:48 INFO - Running setup.py (path:/tmp/pip-hiKT1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:48 INFO - Running setup.py (path:/tmp/pip-ZzoEpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:48 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:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:48 INFO - Running setup.py (path:/tmp/pip-4Tgoql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:48 INFO - Running setup.py (path:/tmp/pip-JJMjjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:48 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:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:48 INFO - Running setup.py (path:/tmp/pip-idLYFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:48 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:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:48 INFO - Running setup.py (path:/tmp/pip-6fgRIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:50 INFO - Downloading blessings-1.6.tar.gz 13:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:15:50 INFO - Installing collected packages: blessings 13:15:50 INFO - Running setup.py install for blessings 13:15:50 INFO - Successfully installed blessings 13:15:50 INFO - Cleaning up... 13:15:50 INFO - Return code: 0 13:15:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:50 INFO - Reading from file tmpfile_stdout 13:15:50 INFO - Current package versions: 13:15:50 INFO - argparse == 1.2.1 13:15:50 INFO - blessings == 1.6 13:15:50 INFO - blobuploader == 1.2.4 13:15:50 INFO - docopt == 0.6.1 13:15:50 INFO - manifestparser == 1.1 13:15:50 INFO - mozInstall == 1.12 13:15:50 INFO - mozcrash == 0.17 13:15:50 INFO - mozdebug == 0.1 13:15:50 INFO - mozdevice == 0.48 13:15:50 INFO - mozfile == 1.2 13:15:50 INFO - mozhttpd == 0.7 13:15:50 INFO - mozinfo == 0.9 13:15:50 INFO - mozleak == 0.1 13:15:50 INFO - mozlog == 3.2 13:15:50 INFO - moznetwork == 0.27 13:15:50 INFO - mozprocess == 0.22 13:15:50 INFO - mozprofile == 0.28 13:15:50 INFO - mozrunner == 6.11 13:15:50 INFO - mozscreenshot == 0.1 13:15:50 INFO - mozsystemmonitor == 0.0 13:15:50 INFO - moztest == 0.7 13:15:50 INFO - mozversion == 1.4 13:15:50 INFO - psutil == 3.1.1 13:15:50 INFO - requests == 1.2.3 13:15:50 INFO - wsgiref == 0.1.2 13:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:50 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 0x7f494bc6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d69c0>, '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 0x22d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d7d50>, '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': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', '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:15:50 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:15:50 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:15:50 INFO - Using env: {'DISPLAY': ':0', 13:15:50 INFO - 'HOME': '/home/cltbld', 13:15:50 INFO - 'LANG': 'en_US.UTF-8', 13:15:50 INFO - 'LANGUAGE': 'en_US:en', 13:15:50 INFO - 'LOGNAME': 'cltbld', 13:15:50 INFO - 'MAIL': '/var/mail/cltbld', 13:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:50 INFO - 'MOZ_NO_REMOTE': '1', 13:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:50 INFO - 'NO_EM_RESTART': '1', 13:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:50 INFO - 'PWD': '/builds/slave/test', 13:15:50 INFO - 'SHELL': '/bin/bash', 13:15:50 INFO - 'SHLVL': '1', 13:15:50 INFO - 'TERM': 'linux', 13:15:50 INFO - 'TMOUT': '86400', 13:15:50 INFO - 'USER': 'cltbld', 13:15:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', 13:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:50 INFO - '_': '/tools/buildbot/bin/python'} 13:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:51 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:15:51 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:15:51 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:15:51 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:15:51 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:15:51 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:15:51 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:15:51 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:15:51 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:15:51 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:15:51 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:15:51 INFO - Cleaning up... 13:15:51 INFO - Return code: 0 13:15:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:15:51 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:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:51 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:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:51 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 0x7f494bc6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d69c0>, '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 0x22d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d7d50>, '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': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', '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:15:51 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:15:51 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:15:51 INFO - Using env: {'DISPLAY': ':0', 13:15:51 INFO - 'HOME': '/home/cltbld', 13:15:51 INFO - 'LANG': 'en_US.UTF-8', 13:15:51 INFO - 'LANGUAGE': 'en_US:en', 13:15:51 INFO - 'LOGNAME': 'cltbld', 13:15:51 INFO - 'MAIL': '/var/mail/cltbld', 13:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:51 INFO - 'MOZ_NO_REMOTE': '1', 13:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:51 INFO - 'NO_EM_RESTART': '1', 13:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:51 INFO - 'PWD': '/builds/slave/test', 13:15:51 INFO - 'SHELL': '/bin/bash', 13:15:51 INFO - 'SHLVL': '1', 13:15:51 INFO - 'TERM': 'linux', 13:15:51 INFO - 'TMOUT': '86400', 13:15:51 INFO - 'USER': 'cltbld', 13:15:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', 13:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:51 INFO - '_': '/tools/buildbot/bin/python'} 13:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:51 INFO - Downloading/unpacking jsonschema 13:15:51 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:15:51 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:15:51 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:15:51 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:15:51 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:15:51 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:15:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:15:53 INFO - Downloading/unpacking functools32 (from jsonschema) 13:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 INFO - Downloading functools32-3.2.3-2.tar.gz 13:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:15:53 INFO - warning: no files found matching '*.txt' 13:15:53 INFO - no previously-included directories found matching 'build' 13:15:53 INFO - no previously-included directories found matching 'dist' 13:15:53 INFO - no previously-included directories found matching '.git*' 13:15:53 INFO - Installing collected packages: jsonschema, functools32 13:15:53 INFO - Running setup.py install for functools32 13:15:53 INFO - warning: no files found matching '*.txt' 13:15:53 INFO - no previously-included directories found matching 'build' 13:15:53 INFO - no previously-included directories found matching 'dist' 13:15:53 INFO - no previously-included directories found matching '.git*' 13:15:53 INFO - Successfully installed jsonschema functools32 13:15:53 INFO - Cleaning up... 13:15:53 INFO - Return code: 0 13:15:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:15:53 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:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:53 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:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:53 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f494bc6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d69c0>, '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 0x22d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d7d50>, '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': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', '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:15:53 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', 'flake8'] in /builds/slave/test/build 13:15:53 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 flake8 13:15:53 INFO - Using env: {'DISPLAY': ':0', 13:15:53 INFO - 'HOME': '/home/cltbld', 13:15:53 INFO - 'LANG': 'en_US.UTF-8', 13:15:53 INFO - 'LANGUAGE': 'en_US:en', 13:15:53 INFO - 'LOGNAME': 'cltbld', 13:15:53 INFO - 'MAIL': '/var/mail/cltbld', 13:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:53 INFO - 'MOZ_NO_REMOTE': '1', 13:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:53 INFO - 'NO_EM_RESTART': '1', 13:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:53 INFO - 'PWD': '/builds/slave/test', 13:15:53 INFO - 'SHELL': '/bin/bash', 13:15:53 INFO - 'SHLVL': '1', 13:15:53 INFO - 'TERM': 'linux', 13:15:53 INFO - 'TMOUT': '86400', 13:15:53 INFO - 'USER': 'cltbld', 13:15:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', 13:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:53 INFO - '_': '/tools/buildbot/bin/python'} 13:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:53 INFO - Downloading/unpacking flake8 13:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:53 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:15:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:15:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:15:55 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:15:55 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:15:55 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:15:55 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:15:55 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:15:55 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:15:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:15:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:15:56 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:15:56 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:15:56 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:15:56 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:15:56 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:15:56 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:15:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:15:56 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:15:56 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:15:56 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:15:56 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:15:56 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:15:56 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:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:15:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:15:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:15:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:15:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:15:56 INFO - no previously-included directories found matching 'docs/_build' 13:15:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:15:56 INFO - Running setup.py install for pep8 13:15:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:15:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:15:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:15:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:15:56 INFO - no previously-included directories found matching 'docs/_build' 13:15:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:15:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:15:56 INFO - Cleaning up... 13:15:56 INFO - Return code: 0 13:15:56 INFO - Running post-action listener: _resource_record_post_action 13:15:56 INFO - Running post-action listener: _start_resource_monitoring 13:15:56 INFO - Starting resource monitoring. 13:15:56 INFO - ##### 13:15:56 INFO - ##### Finished create-virtualenv step (success) 13:15:56 INFO - ##### 13:15:56 INFO - ##### 13:15:56 INFO - ##### Running install step. 13:15:56 INFO - ##### 13:15:56 INFO - Running pre-action listener: _resource_record_pre_action 13:15:56 INFO - Running main action method: install 13:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:57 INFO - Reading from file tmpfile_stdout 13:15:57 INFO - Detecting whether we're running mozinstall >=1.0... 13:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:15:57 INFO - Reading from file tmpfile_stdout 13:15:57 INFO - Output received: 13:15:57 INFO - Usage: mozinstall [options] installer 13:15:57 INFO - Options: 13:15:57 INFO - -h, --help show this help message and exit 13:15:57 INFO - -d DEST, --destination=DEST 13:15:57 INFO - Directory to install application into. [default: 13:15:57 INFO - "/builds/slave/test"] 13:15:57 INFO - --app=APP Application being installed. [default: firefox] 13:15:57 INFO - mkdir: /builds/slave/test/build/application 13:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:16:13 INFO - Reading from file tmpfile_stdout 13:16:13 INFO - Output received: 13:16:13 INFO - /builds/slave/test/build/application/firefox/firefox 13:16:13 INFO - Running post-action listener: _resource_record_post_action 13:16:13 INFO - ##### 13:16:13 INFO - ##### Finished install step (success) 13:16:13 INFO - ##### 13:16:13 INFO - ##### 13:16:13 INFO - ##### Running run-tests step. 13:16:13 INFO - ##### 13:16:13 INFO - Running pre-action listener: _resource_record_pre_action 13:16:13 INFO - Running main action method: run_tests 13:16:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:16:13 INFO - Python 2.7.3 13:16:13 INFO - Return code: 0 13:16:13 INFO - grabbing minidump binary from tooltool 13:16: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:16:13 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 0x22d69c0>, '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 0x22d78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:16:13 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:16:13 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:16:13 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:16:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:16:13 INFO - Return code: 0 13:16:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:16:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:16:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:16:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:16:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:16:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:16:14 INFO - Return code: 0 13:16:14 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/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:16:14 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/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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:16:14 INFO - Using env: {'DISPLAY': ':0', 13:16:14 INFO - 'HOME': '/home/cltbld', 13:16:14 INFO - 'LANG': 'en_US.UTF-8', 13:16:14 INFO - 'LANGUAGE': 'en_US:en', 13:16:14 INFO - 'LOGNAME': 'cltbld', 13:16:14 INFO - 'MAIL': '/var/mail/cltbld', 13:16:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:16:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:14 INFO - 'MOZ_NO_REMOTE': '1', 13:16:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:14 INFO - 'NO_EM_RESTART': '1', 13:16:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:14 INFO - 'PWD': '/builds/slave/test', 13:16:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:16:14 INFO - 'SHELL': '/bin/bash', 13:16:14 INFO - 'SHLVL': '1', 13:16:14 INFO - 'TERM': 'linux', 13:16:14 INFO - 'TMOUT': '86400', 13:16:14 INFO - 'USER': 'cltbld', 13:16:14 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1462997719.628228-1240805168', 13:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:14 INFO - '_': '/tools/buildbot/bin/python'} 13:16:14 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/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:16:14 INFO - mozversion application_buildid: 20160511073006 13:16:14 INFO - mozversion application_changeset: 6578e218bdbaabd3b73d44e7786c3b7649053df2 13:16:14 INFO - mozversion application_display_name: Nightly 13:16:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:16:14 INFO - mozversion application_name: Firefox 13:16:14 INFO - mozversion application_remotingname: firefox 13:16:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:16:14 INFO - mozversion application_vendor: Mozilla 13:16:14 INFO - mozversion application_version: 49.0a1 13:16:14 INFO - mozversion platform_buildid: 20160511073006 13:16:14 INFO - mozversion platform_changeset: 6578e218bdbaabd3b73d44e7786c3b7649053df2 13:16:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:16:14 INFO - mozversion platform_version: 49.0a1 13:16:14 INFO - using testdate: 1462997774 13:16:14 INFO - actual date: 1462997774 13:16:14 INFO - starting webserver on 'localhost:39680' 13:16:14 INFO - SUITE-START | Running 2 tests 13:16:14 INFO - TEST-START | dromaeo_css 13:16:14 INFO - operating with platform_type : linux_ 13:16:14 INFO - Initialising browser for dromaeo_css test... 13:16:14 INFO - TEST-INFO | started process 12618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps5zBZG/profile http://localhost:39680/getInfo.html) 13:16:19 INFO - PROCESS | 12618 | __metrics Screen width/height:1600/1200 13:16:19 INFO - PROCESS | 12618 | colorDepth:24 13:16:19 INFO - PROCESS | 12618 | Browser inner width/height: 1024/697 13:16:19 INFO - PROCESS | 12618 | __metrics 13:16:20 ERROR - PROCESS | 12618 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:16:20 INFO - TEST-INFO | 12618: exit 0 13:16:20 INFO - Browser initialized. 13:16:20 INFO - Running cycle 1/1 for dromaeo_css test... 13:16:20 INFO - TEST-INFO | started process 12697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps5zBZG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:16:32 INFO - PROCESS | 12697 | RSS: Main: 152174592 13:16:32 INFO - PROCESS | 12697 | 13:17:24 INFO - PROCESS | 12697 | 1462997844318 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:19:32 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:39680/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39680/tests/dromaeo/cssquery-ext.html) 13:19:33 INFO - PROCESS | 12697 | RSS: Main: 254570496 13:19:33 INFO - PROCESS | 12697 | 13:22:35 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:39680/tests/dromaeo/cssquery-ext.html (next: http://localhost:39680/tests/dromaeo/cssquery-jquery.html) 13:22:36 INFO - PROCESS | 12697 | RSS: Main: 235073536 13:22:36 INFO - PROCESS | 12697 | 13:25:38 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:39680/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39680/tests/dromaeo/cssquery-mootools.html) 13:25:38 INFO - PROCESS | 12697 | RSS: Main: 240513024 13:25:38 INFO - PROCESS | 12697 | 13:28:40 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:39680/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39680/tests/dromaeo/cssquery-prototype.html) 13:28:41 INFO - PROCESS | 12697 | RSS: Main: 230555648 13:28:41 INFO - PROCESS | 12697 | 13:31:43 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:39680/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39680/tests/dromaeo/cssquery-yui.html) 13:31:44 INFO - PROCESS | 12697 | RSS: Main: 199671808 13:31:44 INFO - PROCESS | 12697 | 13:34:46 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:39680/tests/dromaeo/cssquery-yui.html (next: http://localhost:39680/tests/dromaeo/cssquery-dojo.html) 13:34:47 INFO - PROCESS | 12697 | RSS: Main: 267296768 13:34:47 INFO - PROCESS | 12697 | 13:34:47 INFO - PROCESS | 12697 | __start_tp_report 13:34:47 INFO - PROCESS | 12697 | _x_x_mozilla_page_load 13:34:47 INFO - PROCESS | 12697 | _x_x_mozilla_page_load_details 13:34:47 INFO - PROCESS | 12697 | |i|pagename|runs| 13:34:47 INFO - PROCESS | 12697 | |0;dojo.html;3188.633307169675;3204.407184670836;3228.4511633022385;3242.335321259142;3268.297316077043;5361.142217245241;5394.1908713692965;5455.945440545594;5480.123180291154;5542.1686746988025;5521.861953451165;5524.254225679542;5545.77816887325;5606.579506537006;5660.773569057233;4976.402831660206;4986.102501549711;5015.849524514252;5031.547160755531;5152.562032227265;5037.4710655381205;5057.848264552069;5091.719955402451;5106.66806657566;5120.001599688062;4875.049365373754;4911.75441227939;4948.183549714311;4954.380702412199;4955.702657840505;4932.235503496964;4963.305137280748;5025.69845809249;5026.195808670632;5057.216131499624;4783.330333753277;4956.107900577895;4986.052649996489;5000.499950005007;5014.6991180529285;5393.83818485446;5479.287692599936;5486.259354987065;5532.944670553283;5553;5932.762689492415;5984;6008.909866352008;6010.429009244159;6016.368281330485;5785.768569257225;5840.532757379399;6036.486898613623;6044.396631155346;6049.023598439365;5492.697901615409;5560.805371812007;5561.916571251434;5562.332520097574;5566.081596536607;6025.758969641253;6066.272047354346;6074.058520929263;6078.149059131725;6081.118237855575;5638.718064096779;5791.131330300489;5833.941660583425;5836.299644042657;5840.445157710011;6023.036314189709;6027.849303767353;6031.788887388921;6032.788852390146;6071.635701857903;5951.3751056139345;5992.970035149797;6003.759849606055;6011.6693581853415;6016.608920420159;5657.688827114466;5896.469317761336;5968.641881487125;5969.940300596939;6001.669908155093;4516.480604730433;4517.774111294422;4518.051209246095;4519.050999290186;4555.817767289338;4017.0760725033406;4033.213523362916;4037.2329257440992;4064.7561146331313;4086.2644723949975;5379.973100134553;5419.458054194549;5571.331440227118;5616.494515493625;5630;6065.332813390523;6072.848178795477;6074.3925607438905;6077.1491991121275;6093.6039157454625;5655.095184770417;5657.688827114466;5661.150827375926;5664.291963504562;5667.716614169358;4933.531314525115;5112.105381558287;5140.845774626767;5147.9227811582105;5156.767945442389;6182.6599537024995;6196.349383314777;6239.500839932794;6239.719212635442;6242.875142497215;5752.884942301214;5965.612235204698;6012.398760123952;6027.065804800263;6031.939680603138;6095.664738439428;6104.095385180791;6139.6009259398;6217.129601855653;6217.409346112112;5853.385394533512;5879.794207202727;5887.558433117619;5892.587518873637;5930.11048342752;5764.510016648632;5879.206307148651;5972.462478376967;5980.671063091398;5993.580449368676;5754.2519472469985;5804.2744656917885;5812.73842677089;5812.796552120655;5864.413558644102;5782.190493330853;5798.304203495439;5798.333191682842;5799.217105690678;5802.854928626818;5496.780128794803;5612.522935550361;5640.915386269127;5706.258186435737;5713.771449141987;5845.298564172326;5847.152162936435;5879.176915231786;5882.176495290577;5890.558208134321;5672.205891175321;5689.573282003949;5693.174489699053;5699.230603868425;5700.315962084576 13:34:47 INFO - PROCESS | 12697 | |1;ext.html;614.4592758372631;636.2524034259745;654.3783405764525;665.1519312876084;673.7439772886303;33084.66915330846;36124.63875361245;36179.27641447173;45429;46407;45841.77079114608;46081.76959115208;46187.76906115465;46313.7684311578;46329.305060424034;8857.867131993009;8999.865002024975;9004.549772511382;9007.189352958232;9007.819843603123;8831.95584022079;8884.466931984069;8938.061503542132;8941.374103812735;8949.686760963368;9018.594163262636;9030.50332231727;9031.683891063814;9042;9055.592498337557;8964;8981.14679105484;9009.95495022524;9010.369274150811;9010.999999999967;8867.423617464845;8926.553672316359;8935.374523783337;8938.910610893872;8942;42162;42313.57686423127;42450.78774606138;42485.57514424878;42504.78747606273;3432.622411534729;3616.4575313702894;4310.719803212781;4386.0569977455;4457.353683715875;32608.836955815306;32638;32898.20365268955;32926.83536582326;33368.1657958553;4241.406203131564;4292.077203401283;4325;4333.8699839004885;4396.098799746076;331796;335390;335604;335971.32014340017;336117;61092.08361874575;61131;61529.69235153795;61597.38402615916;61633.38366616366;37042.62957370446;37861;37876.81061594674;65276.347236527974;65333.673331633036;17232.569185770455;17418.51942584869;17429.477115686295;17432.564185895455;17435.73846392305;13063.608091757262;13175.275359855108;13187.076904616777;13190.47238110484;13216.273104979318;19737.50656233577;19861.900690496743;19895.701564476545;19925;19941.800581993994;7040.155181378165;7206.963965180141;7213.567185968754;7262.237465066198;7445.702171913171;1000.9399436033862;1060.2313322840878;1104.6465131158113;1158.3918442817587;1195.8624758152923;30887.90775087968;32565.18587035343;32625.51061734076;32781.34437311288;32802.67197328044;1145.9885401146048;1190.9523619055315;1199.5273682688567;1250.881166289201;1311.5212947274367;16989.320427183022;17208.483745487654;17245.937484470356;17341.82658173402;17388.65222695539;484059;487951;488510;490405;491689;59268.40731592715;60498.69750651219;60515.69742151261;60524;60663.09005364923;1275.273094336238;1308.2673702726313;1356.5998030581002;1375.3742047368423;1401.1172961034483;32667.509987349735;33479.83260083684;34060.82969585136;34230.65769342275;34370.357119786095;51023.48976510188;51782.48217517927;51805.481945180065;51807;51821;382246;383299;387935;388332;388645;25647.487050259264;28269.57595636108;28709.712902870702;28887.56668650014;28889.56665649975;46149.30776038429;47324;49285.260721088496;49573;50020;41057.65736163127;41984;42244.15511689687;42337.15325693407;42747.7862610685;41346;41944.79027604964;42139;42394.78802606091;44881.32678009898;42561.574384255764;42822;42919.78540107404;43244.78377608092;43551.346729798446;36280.818595907906;37809;37873;38231.617683822806;38544.80727596344;26252.21243362702;26330.736692633596;26677.86661066682;26748.19755407341;26855.86572067127 13:34:47 INFO - PROCESS | 12697 | |2;jquery.html;407.2750504102697;410.13052329062384;416.11367786614505;419.2830260254964;428.1864457530691;13561.593152205425;17813;19163.233470661173;19167.42497725069;19545.315913943014;17800.198991045403;18418.631627367446;18719.812801871976;18731;18782.90608546959;5456.645318054324;5627.240322556464;5631.0708733059;5633;5661.5187709044785;5528.226048353234;5585.441455854402;5585.525230355424;5587.608867379285;5592.6085174037835;4023.6781057515473;5855.560832937546;6173.228346456693;6176.752929882799;6267.498600112003;6118.541109416811;6128.938710612882;6181.845453863644;6230.470410015131;6254.249490061199;5559.805406810783;5569.944300556983;5572.916406253909;5589.74846131925;5589.888202235932;20912.895435522725;21324.147034118618;22012;22153.66769498459;22182.89262520058;2280.0993607524933;2280.5438912217624;2310.110607416157;2419.5402873454163;2666.3600735823456;13805.861941380557;14445.566633001026;14487.637809054753;14539.636509087251;14760.926195368955;1913.6986848942713;1930.5270208798793;1946.7274581558593;1992.8007199279955;2044.9161944169614;78302.60848695778;79225.60387198027;81374.59312703398;81657.59171204106;81910.18089819085;10249.33379330341;10386.42874641887;10771.461426928623;10791.83812242817;10860.185486088418;14953.476628318174;15025.098494090389;15034.248287585577;15057.322420490886;15072.924635376752;8046.637901294339;8311.085780564134;8375.329973602098;8410.705625303208;8466.111058338909;8008.759737207776;8015.599220038975;8061.072976607765;8133.674653013813;8213.38399620031;6341.397567231105;6440.806775796734;6528.706208220641;6595.406413422719;6596.340365963365;1813.7098064309912;1928.951776205578;1949.3274820187012;1955.23745739159;1966.2528239269272;925.6713866577403;1018.7962407518526;1055.8046761349176;1081.405227125078;1120;16673.749893751603;18135.36526221576;18602.534936626424;18871.90564047171;19088.14103365352;1081.2701426537055;1083.414955923808;1116.0625074937093;1132.7621199548187;1161.517970042423;10572;10891.727706807393;10936.234463587632;10958.342499450058;11010.559577616967;466180;478450;491026;492676;492930;80294.19705802984;83560;84934;85585.57207213924;87501;1042.9739256518649;1063.6277302944063;1066.4134725900724;1076.6016573867719;1077.272840832435;16380.836191638407;16543.420980266113;16669.833301667313;16739.832601674316;16847.831521685115;37488.812555937046;37633.81183094067;37735.05662358463;37884.81057594695;39372.60627393689;49756.502434975184;50785.49214507955;51142.74428627833;51581.48418515917;51641.741791292305;8468.407211495383;8523.744287671132;8617.095205003385;8879.91120088791;8924.955375223082;12629.684257893627;12769.553065642658;12898.806517902427;13189.538366157138;13296.601101966957;11336.94331528337;11409.201355905006;11796.174267801514;12095.516179352728;12363.69090772738;11277.71805704831;11513.078953683518;11555.133364997828;11804.70488237801;12034;11788.469518871843;11801.704957376134;11824.58613948542;11878.881211188123;12003.75992480163;8549.487030778173;8655.610497527752;8710.869336960077;8765.517896515752;8972.327075469235;11508.309501429942;11724.296542207494;11856.288622682667;12244.877551224374;12442.75114497723 13:34:47 INFO - PROCESS | 12697 | |3;mootools.html;1370.794380842874;1535.9078455292683;1549.8062742157229;1720.6558688262344;1847.935322263721;8368.958155209222;8611.698590549331;8624.741257762262;8801;8804.251638610725;8623.439476434027;8721.607527661256;8727.0836562161;8765.91234087659;8776.824463510742;2104.4738815296178;2311.1217737259817;2343.894524746382;2370.9051637934463;2385.9045638174453;2407.8194135439912;2414.106780491212;2414.770596793302;2416.359664688859;2424.090965887792;2357.7995870350956;2416.226807421626;2417.4319035026756;2420.056178090546;2425.708914930202;2100.3698890332917;2306.769323067688;2382;2383.13015749252;2397.568437681217;2245.5845668551206;2252.650839119939;2254.2448279826276;2276.499170182557;2335.7547457516885;9022.458652480807;9078.90921090794;9081.682141125095;9083;9084.09159084093;5250.579953603703;5406.08096623575;5412.2152287918425;5413.729313534347;5450.073487507133;3482.7736197147105;3555.466679997995;3587.587427445825;3636;3642.307961487309;1116.810142275807;1124.145649306533;1155.9711007224803;1156.2831044752224;1157.455995682028;12899.161554498927;12909.031822613248;12917.67705807353;12922.095453318365;12932.612021639367;4865.221564549655;4887.095887260868;4974.900501990012;4977.701337919736;5034.471380505068;10507.842382364272;10537.315074520131;10580.259381843198;10591.311564748421;10600.575976960989;4823.614110871122;5280.683159010395;5307.548858347083;5319.946800531945;5324.801919568066;4744.288356746516;4878.243872199815;4927.384076990376;4959.156943319572;4980.950190498049;3968.464257325282;4001.581884493133;4114.280000999813;4122.56713045132;4160.063985603215;1257.4027337015027;1295.2358108715903;1301.2842936385139;1313.7635225659474;1323.6889331007205;910.5629297936895;978.3200675530438;981.1513041219293;986.8273052215834;988.5008070924138;5880.764769409176;5928.703564821742;6006;6057.42454466825;6162.5378096642935;460.75349687916804;465.0698602794411;466.79227743653746;468.64383068867903;483.7653737937098;4049.4330793688905;4057.837686492507;4088.8160032798596;4202.859054084138;4245.596668316505;10398.116160126323;10809.945950270356;10905.454727263605;10905.618303359344;10920.781584368267;10615.734606634896;10668.199885008655;10747.946260268649;10758.354498730101;10767.89232107669;7842.764717058498;8109.9189008111525;8167.305779008851;8189.95905020483;8206.302464290482;5778.422157784188;5807.94192058074;5825.417458254141;5936.465718085393;5986.551008674454;9650.806983860424;9821.950890245504;9822.607095716092;9987.750306242111;9989.150922171406;9672.95163524206;9953.452560109263;10150.695479135638;10183.745406364604;10275.075243228146;7083.929160708327;7281.526700764433;7283.235260297804;7747.612619369122;7821.882671760042;8383.496990180609;8651.264642505457;8661.307095432476;8908.510031948046;8912.598933047899;7808.843823123392;7941.920580794118;7974.880376794469;8008.559529225949;8113.0669972953865;7780.610969451618;7871.448998570045;7898.68405263783;7922.168172341821;7987.440879138405;6865.759698410531;6918.5502942308585;6918.930810691829;6932.896006560007;7025.859482810213;4846.491118432655;4852.344933434082;4941.258811178352;4979.676321039121;5032.094223039888;5070.442251352422;5085.262636917701;5086.872828179326;5092.287079808903;5135.7432128394175 13:34:47 INFO - PROCESS | 12697 | |4;prototype.html;347.34005389759454;349.8618045871881;356.0907386651061;361.712438611304;362.1832767110168;5153.922691159631;5155.381354237492;5196.038732834423;5205.141151709963;5243;4946.356973593437;4992.925106123411;5057.721825299607;5067.746612669361;5165.251038599401;4044.939325910106;4087.773667899633;4095.815688294034;4100.63094321511;4109.260333140033;4036.4348991141264;4044.130511939932;4071.2671719090554;4075.470188875442;4155.376693495969;3922.4900762900784;4081.918221706921;4106.260873042851;4107.609777071173;4111.075008123178;3994.900127496807;4017.658499027586;4084.5915408459214;4086.0602061525865;4110.671146308303;3599.262151258986;3611.855525778966;3626.528551288342;3629.858383553716;3629.860170952134;4799.3760811094335;4960.528749768766;5004.84985450437;5007.424146223195;5007.849764507034;4604.539546045402;4641.073954308958;4648.000679853848;4664.790084446174;4670.972386075058;5429.914017196537;5435.918461223085;5441.156620723755;5442.265294185314;5444;3853.2660302863824;3879;3952.664023558001;3974.4038394241097;3993.9201215975518;5617.848341090067;5636.830895073154;5640.661560306354;5651.7739290428335;5671.432856714337;4007.8196481158416;4016.176683779818;4016.979915100464;4020.979895100506;4022.557518672944;4028.3554631259444;4036.9394459083137;4039.171969746195;4095.037666148453;4095.610916962884;4561.863144105682;4562.475315338712;4583.083383323348;4595.425571803525;4658.138244424792;5349.384820745586;5391.973040134774;5450.672959622435;5458.590605704588;5462.918056229159;1343.4559003603556;1356.186288227056;1405.7118290750373;1421.665908511499;1423.8504956979575;924.2790623313826;926.666400095965;930.5486838883136;935.2471260635253;940.247801758604;4621.630269578425;4651.86044418668;4672.439307283148;4688.343631891538;4708.741019243906;4743.66794324394;4949.356583644103;4982.850514484571;5001.499250374813;5009.474005229471;4644.95355046452;4668.533146685372;4670.486246512881;4691;4700.95299047012;2570.961435578468;2639.0631325879035;2652.880620372088;2660.4945060438454;2667.6798784146026;5089.643724939293;5102.642815002914;5103.923441148386;5145.742712864417;5148.897022059613;4954.687007942826;5013.298138260647;5020.322256495399;5057.317262169634;5066.923996140061;4758.619310455225;5063.949360506422;5079.746012699424;5098.923516147261;5123.8719032023755;4914.92627610579;4941.579965702956;4944.788526810954;4974.278729584263;4979.734220929396;4947.950520494749;4948.802047918187;4983.601311895112;4983.725895075806;4987.451380348231;4757.690750101232;5117.360329958755;5132.613334799336;5151.665141765773;5189.624749441326;3769.9811500943415;3777.20678657485;3781.1681430085337;3789.8251542022062;3798.948567773482;4993.725345106054;5029.7736601852275;5039.748012599282;5054.342935418372;5067.910399264176;4546.499885012579;4946.8763280918265;4962.975185124052;4970.478099799469;4976.353074100344;4807.61539076866;4840.596227094244;4841.782119804547;4846.345743324606;4873.6832105913;4789.95210047909;4809.398825146856;4813.7352445615825;4815.831445899376;4867.829625963074;4876.78054487556;4894.461609222912;4903.705777653352;4934.235193545006;5095.668781529189;5394.352677678704;5412.56699464034;5418.241446197614;5420.891582168413;5431.207701458588 13:34:47 INFO - PROCESS | 12697 | |5;yui.html;820.306840719592;849.0702680564781;854.4616891358444;866.6533386645341;876.6800117956948;12193.451294691738;12664;12689.746205075904;12700;12702.301373424458;13214.207147571153;13259.138156019875;13266.734665306689;13270.270135142564;13308;682.5426963934163;701.8841891087965;794.1661255681511;810.5784991804259;817.9550124743137;803.1727320859495;809.9919000810005;810.400303775208;814.3200427642926;814.6252723747084;855.700504823313;857.1599832164451;857.6440777077537;858.2833334165948;858.5063588436643;710.882704353781;844.3456321350941;862.0861886400436;865.7705707987388;865.8831057807209;629.6757170057424;631.5452873930763;634.0520921222756;634.3846468925182;635.5328833307515;12668.36658167088;12679.746405071939;12705.428255728422;12708.173968692005;12724.491020359175;13493.730125397436;13585.660358491017;13622.523211687643;13757.449702011907;13916.30418479082;11802.645920622395;12159.088068394905;12167.574134905324;12255.203411778206;12367.381630918419;4421.491528474235;4496.145732310883;4536.319552067183;4653.790579423934;4655.511171326996;55470.44529554693;55701.72149139269;57391.42608573861;57513.137302940486;57730;10143.34068285559;10375.325603835727;10388.168946484264;10389.740256493496;10450.268481206243;17105.627945661352;17551.210195541233;17572.736408953875;17582.824171758373;17837;7655.311022007934;7750.341220996278;8124.837503249902;8129.674813007414;8232.382571307056;4744.881377965578;4751.524847515221;4791.95208047922;4820.517948205152;4934.037862616827;3244.7890887092735;3344.1639590102473;3345.882894098695;3348.380549598332;3357.9496307555405;632.0803231298542;636.1221514310222;637.2066776862836;637.8150336402391;643.7425029987949;578.0923949399403;684.9691763870637;741.892425598296;747.8691229035006;756.6632848382527;9062.81874362509;9138.497382643885;9188.173064424234;9210.677626283183;9284;719.9064121664255;721.1886627544013;727.5707332673747;732.6519903046117;740.2856243724831;4165.125323682;4189.685773566995;4329.610335069796;4466;4484.977575112103;59464.405355945884;62541.68729156325;63551.36448635547;64983.67508162523;65222.67388663026;54316.72841635766;54814.72592637011;55392.16911746327;56193.15710264349;56985.43014569801;49506.25740613894;51666.74166629218;51881.481185187666;52064.739676301375;52453;8273.089960104504;8554.57227138653;8612.870806938026;8649.1350864913;8670.089640587648;32471.188220293738;32476;33103.33793324072;33114;33431;42536.361954570086;45715;47427;47652.761736191096;48498.5150148494;10926.56293748273;10933.398663073607;11009.944950275198;11124.276922000045;11227.607033753779;9353.81292374135;11710.76225344534;11733.296002239893;11926.284422934652;11977.940110299392;11597.76804463923;12313.815292770794;12474.812877806658;12709.36453177319;13037;12882.227066375672;12953.093283470067;13526.18842869431;13930.024898257025;14045.297735113409;12839.229646221256;13001.089923705249;13261.66845828862;13694.452221911011;13708.65728356799;10950.671479855617;11020.944895275472;11080.168987325822;11485;11552.42237888119;11062.612808551663;11164.553417863195;11165.274257173258;11239.157063220127;11300.49147788335 13:34:47 INFO - PROCESS | 12697 | __end_tp_report 13:34:47 INFO - PROCESS | 12697 | __start_cc_report 13:34:47 INFO - PROCESS | 12697 | _x_x_mozilla_cycle_collect,854 13:34:47 INFO - PROCESS | 12697 | __end_cc_report 13:34:47 INFO - PROCESS | 12697 | __startTimestamp1462998887230__endTimestamp 13:34:47 INFO - PROCESS | 12697 | 13:34:47 INFO - PROCESS | 12697 | ------- Summary: start ------- 13:34:47 INFO - PROCESS | 12697 | Number of tests: 6 13:34:47 INFO - PROCESS | 12697 | 13:34:47 INFO - PROCESS | 12697 | [#0] dojo.html Cycles:165 Average:5511.36 Median:5693.17 stddev:642.43 (11.3%) stddev-sans-first:618.02 13:34:47 INFO - PROCESS | 12697 | Values: 3188.6 3204.4 3228.5 3242.3 3268.3 5361.1 5394.2 5455.9 5480.1 5542.2 5521.9 5524.3 5545.8 5606.6 5660.8 4976.4 4986.1 5015.8 5031.5 5152.6 5037.5 5057.8 5091.7 5106.7 5120.0 4875.0 4911.8 4948.2 4954.4 4955.7 4932.2 4963.3 5025.7 5026.2 5057.2 4783.3 4956.1 4986.1 5000.5 5014.7 5393.8 5479.3 5486.3 5532.9 5553.0 5932.8 5984.0 6008.9 6010.4 6016.4 5785.8 5840.5 6036.5 6044.4 6049.0 5492.7 5560.8 5561.9 5562.3 5566.1 6025.8 6066.3 6074.1 6078.1 6081.1 5638.7 5791.1 5833.9 5836.3 5840.4 6023.0 6027.8 6031.8 6032.8 6071.6 5951.4 5993.0 6003.8 6011.7 6016.6 5657.7 5896.5 5968.6 5969.9 6001.7 4516.5 4517.8 4518.1 4519.1 4555.8 4017.1 4033.2 4037.2 4064.8 4086.3 5380.0 5419.5 5571.3 5616.5 5630.0 6065.3 6072.8 6074.4 6077.1 6093.6 5655.1 5657.7 5661.2 5664.3 5667.7 4933.5 5112.1 5140.8 5147.9 5156.8 6182.7 6196.3 6239.5 6239.7 6242.9 5752.9 5965.6 6012.4 6027.1 6031.9 6095.7 6104.1 6139.6 6217.1 6217.4 5853.4 5879.8 5887.6 5892.6 5930.1 5764.5 5879.2 5972.5 5980.7 5993.6 5754.3 5804.3 5812.7 5812.8 5864.4 5782.2 5798.3 5798.3 5799.2 5802.9 5496.8 5612.5 5640.9 5706.3 5713.8 5845.3 5847.2 5879.2 5882.2 5890.6 5672.2 5689.6 5693.2 5699.2 5700.3 13:34:47 INFO - PROCESS | 12697 | 13:34:47 INFO - PROCESS | 12697 | [#1] ext.html Cycles:180 Average:57207.90 Median:42325.37 stddev:107783.96 (254.7%) stddev-sans-first:108002.57 13:34:47 INFO - PROCESS | 12697 | Values: 614.5 636.3 654.4 665.2 673.7 33084.7 36124.6 36179.3 45429.0 46407.0 45841.8 46081.8 46187.8 46313.8 46329.3 8857.9 8999.9 9004.5 9007.2 9007.8 8832.0 8884.5 8938.1 8941.4 8949.7 9018.6 9030.5 9031.7 9042.0 9055.6 8964.0 8981.1 9010.0 9010.4 9011.0 8867.4 8926.6 8935.4 8938.9 8942.0 42162.0 42313.6 42450.8 42485.6 42504.8 3432.6 3616.5 4310.7 4386.1 4457.4 32608.8 32638.0 32898.2 32926.8 33368.2 4241.4 4292.1 4325.0 4333.9 4396.1 331796.0 335390.0 335604.0 335971.3 336117.0 61092.1 61131.0 61529.7 61597.4 61633.4 37042.6 37861.0 37876.8 65276.3 65333.7 17232.6 17418.5 17429.5 17432.6 17435.7 13063.6 13175.3 13187.1 13190.5 13216.3 19737.5 19861.9 19895.7 19925.0 19941.8 7040.2 7207.0 7213.6 7262.2 7445.7 1000.9 1060.2 1104.6 1158.4 1195.9 30887.9 32565.2 32625.5 32781.3 32802.7 1146.0 1191.0 1199.5 1250.9 1311.5 16989.3 17208.5 17245.9 17341.8 17388.7 484059.0 487951.0 488510.0 490405.0 491689.0 59268.4 60498.7 60515.7 60524.0 60663.1 1275.3 1308.3 1356.6 1375.4 1401.1 32667.5 33479.8 34060.8 34230.7 34370.4 51023.5 51782.5 51805.5 51807.0 51821.0 382246.0 383299.0 387935.0 388332.0 388645.0 25647.5 28269.6 28709.7 28887.6 28889.6 46149.3 47324.0 49285.3 49573.0 50020.0 41057.7 41984.0 42244.2 42337.2 42747.8 41346.0 41944.8 42139.0 42394.8 44881.3 42561.6 42822.0 42919.8 43244.8 43551.3 36280.8 37809.0 37873.0 38231.6 38544.8 26252.2 26330.7 26677.9 26748.2 26855.9 13:34:47 INFO - PROCESS | 12697 | 13:34:47 INFO - PROCESS | 12697 | [#2] jquery.html Cycles:180 Average:28363.92 Median:21668.07 stddev:79620.46 (367.5%) stddev-sans-first:79816.14 13:34:47 INFO - PROCESS | 12697 | Values: 407.3 410.1 416.1 419.3 428.2 13561.6 17813.0 19163.2 19167.4 19545.3 17800.2 18418.6 18719.8 18731.0 18782.9 5456.6 5627.2 5631.1 5633.0 5661.5 5528.2 5585.4 5585.5 5587.6 5592.6 4023.7 5855.6 6173.2 6176.8 6267.5 6118.5 6128.9 6181.8 6230.5 6254.2 5559.8 5569.9 5572.9 5589.7 5589.9 20912.9 21324.1 22012.0 22153.7 22182.9 2280.1 2280.5 2310.1 2419.5 2666.4 13805.9 14445.6 14487.6 14539.6 14760.9 1913.7 1930.5 1946.7 1992.8 2044.9 78302.6 79225.6 81374.6 81657.6 81910.2 10249.3 10386.4 10771.5 10791.8 10860.2 14953.5 15025.1 15034.2 15057.3 15072.9 8046.6 8311.1 8375.3 8410.7 8466.1 8008.8 8015.6 8061.1 8133.7 8213.4 6341.4 6440.8 6528.7 6595.4 6596.3 1813.7 1929.0 1949.3 1955.2 1966.3 925.7 1018.8 1055.8 1081.4 1120.0 16673.7 18135.4 18602.5 18871.9 19088.1 1081.3 1083.4 1116.1 1132.8 1161.5 10572.0 10891.7 10936.2 10958.3 11010.6 466180.0 478450.0 491026.0 492676.0 492930.0 80294.2 83560.0 84934.0 85585.6 87501.0 1043.0 1063.6 1066.4 1076.6 1077.3 16380.8 16543.4 16669.8 16739.8 16847.8 37488.8 37633.8 37735.1 37884.8 39372.6 49756.5 50785.5 51142.7 51581.5 51641.7 8468.4 8523.7 8617.1 8879.9 8925.0 12629.7 12769.6 12898.8 13189.5 13296.6 11336.9 11409.2 11796.2 12095.5 12363.7 11277.7 11513.1 11555.1 11804.7 12034.0 11788.5 11801.7 11824.6 11878.9 12003.8 8549.5 8655.6 8710.9 8765.5 8972.3 11508.3 11724.3 11856.3 12244.9 12442.8 13:34:47 INFO - PROCESS | 12697 | 13:34:47 INFO - PROCESS | 12697 | [#3] mootools.html Cycles:180 Average:5824.50 Median:4934.32 stddev:3327.98 (67.4%) stddev-sans-first:3320.48 13:34:47 INFO - PROCESS | 12697 | Values: 1370.8 1535.9 1549.8 1720.7 1847.9 8369.0 8611.7 8624.7 8801.0 8804.3 8623.4 8721.6 8727.1 8765.9 8776.8 2104.5 2311.1 2343.9 2370.9 2385.9 2407.8 2414.1 2414.8 2416.4 2424.1 2357.8 2416.2 2417.4 2420.1 2425.7 2100.4 2306.8 2382.0 2383.1 2397.6 2245.6 2252.7 2254.2 2276.5 2335.8 9022.5 9078.9 9081.7 9083.0 9084.1 5250.6 5406.1 5412.2 5413.7 5450.1 3482.8 3555.5 3587.6 3636.0 3642.3 1116.8 1124.1 1156.0 1156.3 1157.5 12899.2 12909.0 12917.7 12922.1 12932.6 4865.2 4887.1 4974.9 4977.7 5034.5 10507.8 10537.3 10580.3 10591.3 10600.6 4823.6 5280.7 5307.5 5319.9 5324.8 4744.3 4878.2 4927.4 4959.2 4981.0 3968.5 4001.6 4114.3 4122.6 4160.1 1257.4 1295.2 1301.3 1313.8 1323.7 910.6 978.3 981.2 986.8 988.5 5880.8 5928.7 6006.0 6057.4 6162.5 460.8 465.1 466.8 468.6 483.8 4049.4 4057.8 4088.8 4202.9 4245.6 10398.1 10809.9 10905.5 10905.6 10920.8 10615.7 10668.2 10747.9 10758.4 10767.9 7842.8 8109.9 8167.3 8190.0 8206.3 5778.4 5807.9 5825.4 5936.5 5986.6 9650.8 9822.0 9822.6 9987.8 9989.2 9673.0 9953.5 10150.7 10183.7 10275.1 7083.9 7281.5 7283.2 7747.6 7821.9 8383.5 8651.3 8661.3 8908.5 8912.6 7808.8 7941.9 7974.9 8008.6 8113.1 7780.6 7871.4 7898.7 7922.2 7987.4 6865.8 6918.6 6918.9 6932.9 7025.9 4846.5 4852.3 4941.3 4979.7 5032.1 5070.4 5085.3 5086.9 5092.3 5135.7 13:34:47 INFO - PROCESS | 12697 | 13:34:47 INFO - PROCESS | 12697 | [#4] prototype.html Cycles:180 Average:4342.30 Median:4841.19 stddev:1213.55 (25.1%) stddev-sans-first:1179.33 13:34:47 INFO - PROCESS | 12697 | Values: 347.3 349.9 356.1 361.7 362.2 5153.9 5155.4 5196.0 5205.1 5243.0 4946.4 4992.9 5057.7 5067.7 5165.3 4044.9 4087.8 4095.8 4100.6 4109.3 4036.4 4044.1 4071.3 4075.5 4155.4 3922.5 4081.9 4106.3 4107.6 4111.1 3994.9 4017.7 4084.6 4086.1 4110.7 3599.3 3611.9 3626.5 3629.9 3629.9 4799.4 4960.5 5004.8 5007.4 5007.8 4604.5 4641.1 4648.0 4664.8 4671.0 5429.9 5435.9 5441.2 5442.3 5444.0 3853.3 3879.0 3952.7 3974.4 3993.9 5617.8 5636.8 5640.7 5651.8 5671.4 4007.8 4016.2 4017.0 4021.0 4022.6 4028.4 4036.9 4039.2 4095.0 4095.6 4561.9 4562.5 4583.1 4595.4 4658.1 5349.4 5392.0 5450.7 5458.6 5462.9 1343.5 1356.2 1405.7 1421.7 1423.9 924.3 926.7 930.5 935.2 940.2 4621.6 4651.9 4672.4 4688.3 4708.7 4743.7 4949.4 4982.9 5001.5 5009.5 4645.0 4668.5 4670.5 4691.0 4701.0 2571.0 2639.1 2652.9 2660.5 2667.7 5089.6 5102.6 5103.9 5145.7 5148.9 4954.7 5013.3 5020.3 5057.3 5066.9 4758.6 5063.9 5079.7 5098.9 5123.9 4914.9 4941.6 4944.8 4974.3 4979.7 4948.0 4948.8 4983.6 4983.7 4987.5 4757.7 5117.4 5132.6 5151.7 5189.6 3770.0 3777.2 3781.2 3789.8 3798.9 4993.7 5029.8 5039.7 5054.3 5067.9 4546.5 4946.9 4963.0 4970.5 4976.4 4807.6 4840.6 4841.8 4846.3 4873.7 4790.0 4809.4 4813.7 4815.8 4867.8 4876.8 4894.5 4903.7 4934.2 5095.7 5394.4 5412.6 5418.2 5420.9 5431.2 13:34:47 INFO - PROCESS | 12697 | 13:34:47 INFO - PROCESS | 12697 | [#5] yui.html Cycles:180 Average:14778.63 Median:26041.26 stddev:17442.71 (67.0%) stddev-sans-first:17460.15 13:34:47 INFO - PROCESS | 12697 | Values: 820.3 849.1 854.5 866.7 876.7 12193.5 12664.0 12689.7 12700.0 12702.3 13214.2 13259.1 13266.7 13270.3 13308.0 682.5 701.9 794.2 810.6 818.0 803.2 810.0 810.4 814.3 814.6 855.7 857.2 857.6 858.3 858.5 710.9 844.3 862.1 865.8 865.9 629.7 631.5 634.1 634.4 635.5 12668.4 12679.7 12705.4 12708.2 12724.5 13493.7 13585.7 13622.5 13757.4 13916.3 11802.6 12159.1 12167.6 12255.2 12367.4 4421.5 4496.1 4536.3 4653.8 4655.5 55470.4 55701.7 57391.4 57513.1 57730.0 10143.3 10375.3 10388.2 10389.7 10450.3 17105.6 17551.2 17572.7 17582.8 17837.0 7655.3 7750.3 8124.8 8129.7 8232.4 4744.9 4751.5 4792.0 4820.5 4934.0 3244.8 3344.2 3345.9 3348.4 3357.9 632.1 636.1 637.2 637.8 643.7 578.1 685.0 741.9 747.9 756.7 9062.8 9138.5 9188.2 9210.7 9284.0 719.9 721.2 727.6 732.7 740.3 4165.1 4189.7 4329.6 4466.0 4485.0 59464.4 62541.7 63551.4 64983.7 65222.7 54316.7 54814.7 55392.2 56193.2 56985.4 49506.3 51666.7 51881.5 52064.7 52453.0 8273.1 8554.6 8612.9 8649.1 8670.1 32471.2 32476.0 33103.3 33114.0 33431.0 42536.4 45715.0 47427.0 47652.8 48498.5 10926.6 10933.4 11009.9 11124.3 11227.6 9353.8 11710.8 11733.3 11926.3 11977.9 11597.8 12313.8 12474.8 12709.4 13037.0 12882.2 12953.1 13526.2 13930.0 14045.3 12839.2 13001.1 13261.7 13694.5 13708.7 10950.7 11020.9 11080.2 11485.0 11552.4 11062.6 11164.6 11165.3 11239.2 11300.5 13:34:47 INFO - PROCESS | 12697 | -------- Summary: end -------- 13:34:47 INFO - PROCESS | 12697 | 13:34:47 INFO - TEST-INFO | 12697: exit 0 13:34:47 INFO - TEST-OK | dromaeo_css | took 1113063ms 13:34:47 INFO - TEST-START | kraken 13:34:47 INFO - operating with platform_type : linux_ 13:34:47 INFO - Initialising browser for kraken test... 13:34:47 INFO - TEST-INFO | started process 12878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzxM5q7/profile http://localhost:39680/getInfo.html) 13:34:52 INFO - PROCESS | 12878 | __metrics Screen width/height:1600/1200 13:34:52 INFO - PROCESS | 12878 | colorDepth:24 13:34:52 INFO - PROCESS | 12878 | Browser inner width/height: 1024/697 13:34:52 INFO - PROCESS | 12878 | __metrics 13:34:53 ERROR - PROCESS | 12878 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:34:53 INFO - TEST-INFO | 12878: exit 0 13:34:53 INFO - Browser initialized. 13:34:53 INFO - Running cycle 1/1 for kraken test... 13:34:53 INFO - TEST-INFO | started process 12960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzxM5q7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:35:05 INFO - PROCESS | 12960 | RSS: Main: 151953408 13:35:05 INFO - PROCESS | 12960 | 13:35:08 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39680/tests/kraken/driver.html?testName=audio-beat-detection) 13:35:09 INFO - PROCESS | 12960 | RSS: Main: 208224256 13:35:09 INFO - PROCESS | 12960 | 13:35:11 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39680/tests/kraken/driver.html?testName=audio-dft) 13:35:12 INFO - PROCESS | 12960 | RSS: Main: 197271552 13:35:12 INFO - PROCESS | 12960 | 13:35:15 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39680/tests/kraken/driver.html?testName=audio-fft) 13:35:16 INFO - PROCESS | 12960 | RSS: Main: 265252864 13:35:16 INFO - PROCESS | 12960 | 13:35:18 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39680/tests/kraken/driver.html?testName=audio-oscillator) 13:35:19 INFO - PROCESS | 12960 | RSS: Main: 174039040 13:35:19 INFO - PROCESS | 12960 | 13:35:21 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39680/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:35:21 INFO - PROCESS | 12960 | RSS: Main: 178761728 13:35:21 INFO - PROCESS | 12960 | 13:35:25 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39680/tests/kraken/driver.html?testName=imaging-darkroom) 13:35:25 INFO - PROCESS | 12960 | RSS: Main: 214843392 13:35:25 INFO - PROCESS | 12960 | 13:35:29 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39680/tests/kraken/driver.html?testName=imaging-desaturate) 13:35:29 INFO - PROCESS | 12960 | RSS: Main: 214790144 13:35:29 INFO - PROCESS | 12960 | 13:35:32 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39680/tests/kraken/driver.html?testName=json-parse-financial) 13:35:33 INFO - PROCESS | 12960 | RSS: Main: 214306816 13:35:33 INFO - PROCESS | 12960 | 13:35:35 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39680/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:35:35 INFO - PROCESS | 12960 | RSS: Main: 201801728 13:35:35 INFO - PROCESS | 12960 | 13:35:37 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39680/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:35:38 INFO - PROCESS | 12960 | RSS: Main: 206131200 13:35:38 INFO - PROCESS | 12960 | 13:35:40 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39680/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:35:40 INFO - PROCESS | 12960 | RSS: Main: 215289856 13:35:40 INFO - PROCESS | 12960 | 13:35:43 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:35:44 INFO - PROCESS | 12960 | RSS: Main: 223588352 13:35:44 INFO - PROCESS | 12960 | 13:35:46 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:35:47 INFO - PROCESS | 12960 | RSS: Main: 220487680 13:35:47 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | Cycle 1(1): loaded http://localhost:39680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39680/tests/kraken/driver.html?testName=ai-astar) 13:35:49 INFO - PROCESS | 12960 | RSS: Main: 265846784 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | __start_tp_report 13:35:49 INFO - PROCESS | 12960 | _x_x_mozilla_page_load 13:35:49 INFO - PROCESS | 12960 | _x_x_mozilla_page_load_details 13:35:49 INFO - PROCESS | 12960 | |i|pagename|runs| 13:35:49 INFO - PROCESS | 12960 | |0;ai-astar;112;105;111;110;110;109;110;110;110;109 13:35:49 INFO - PROCESS | 12960 | |1;audio-beat-detection;151;125;149;211;127;152;152;129;189;125 13:35:49 INFO - PROCESS | 12960 | |2;audio-dft;160;161;161;160;161;160;161;160;160;160 13:35:49 INFO - PROCESS | 12960 | |3;audio-fft;74;75;75;146;77;75;76;74;127;75 13:35:49 INFO - PROCESS | 12960 | |4;audio-oscillator;91;91;145;93;92;92;123;92;92;123 13:35:49 INFO - PROCESS | 12960 | |5;imaging-gaussian-blur;117;116;117;116;116;117;116;117;118;116 13:35:49 INFO - PROCESS | 12960 | |6;imaging-darkroom;147;147;147;146;146;146;146;146;147;145 13:35:49 INFO - PROCESS | 12960 | |7;imaging-desaturate;95;95;95;96;94;95;95;95;95;95 13:35:49 INFO - PROCESS | 12960 | |8;json-parse-financial;60;59;61;57;58;57;59;110;55;57 13:35:49 INFO - PROCESS | 12960 | |9;json-stringify-tinderbox;58;59;58;58;59;59;59;59;58;59 13:35:49 INFO - PROCESS | 12960 | |10;stanford-crypto-aes;78;80;78;78;83;80;80;80;79;79 13:35:49 INFO - PROCESS | 12960 | |11;stanford-crypto-ccm;124;126;123;122;124;130;123;132;190;132 13:35:49 INFO - PROCESS | 12960 | |12;stanford-crypto-pbkdf2;175;164;166;170;169;164;166;166;169;166 13:35:49 INFO - PROCESS | 12960 | |13;stanford-crypto-sha256-iterative;65;65;69;64;64;73;67;65;69;63 13:35:49 INFO - PROCESS | 12960 | __end_tp_report 13:35:49 INFO - PROCESS | 12960 | __start_cc_report 13:35:49 INFO - PROCESS | 12960 | _x_x_mozilla_cycle_collect,1830 13:35:49 INFO - PROCESS | 12960 | __end_cc_report 13:35:49 INFO - PROCESS | 12960 | __startTimestamp1462998949603__endTimestamp 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | ------- Summary: start ------- 13:35:49 INFO - PROCESS | 12960 | Number of tests: 14 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.84 (1.7%) stddev-sans-first:1.73 13:35:49 INFO - PROCESS | 12960 | Values: 112.0 105.0 111.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:151.50 stddev:28.79 (19.0%) stddev-sans-first:30.54 13:35:49 INFO - PROCESS | 12960 | Values: 151.0 125.0 149.0 211.0 127.0 152.0 152.0 129.0 189.0 125.0 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 13:35:49 INFO - PROCESS | 12960 | Values: 160.0 161.0 161.0 160.0 161.0 160.0 161.0 160.0 160.0 160.0 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#3] audio-fft Cycles:10 Average:87.40 Median:75.00 stddev:26.28 (35.0%) stddev-sans-first:27.42 13:35:49 INFO - PROCESS | 12960 | Values: 74.0 75.0 75.0 146.0 77.0 75.0 76.0 74.0 127.0 75.0 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:92.00 stddev:19.53 (21.2%) stddev-sans-first:20.20 13:35:49 INFO - PROCESS | 12960 | Values: 91.0 91.0 145.0 93.0 92.0 92.0 123.0 92.0 92.0 123.0 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 13:35:49 INFO - PROCESS | 12960 | Values: 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 118.0 116.0 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 13:35:49 INFO - PROCESS | 12960 | Values: 147.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 145.0 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:35:49 INFO - PROCESS | 12960 | Values: 95.0 95.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:58.50 stddev:16.50 (28.2%) stddev-sans-first:17.46 13:35:49 INFO - PROCESS | 12960 | Values: 60.0 59.0 61.0 57.0 58.0 57.0 59.0 110.0 55.0 57.0 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 13:35:49 INFO - PROCESS | 12960 | Values: 58.0 59.0 58.0 58.0 59.0 59.0 59.0 59.0 58.0 59.0 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:80.00 stddev:1.51 (1.9%) stddev-sans-first:1.50 13:35:49 INFO - PROCESS | 12960 | Values: 78.0 80.0 78.0 78.0 83.0 80.0 80.0 80.0 79.0 79.0 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:128.00 stddev:20.52 (16.0%) stddev-sans-first:21.53 13:35:49 INFO - PROCESS | 12960 | Values: 124.0 126.0 123.0 122.0 124.0 130.0 123.0 132.0 190.0 132.0 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.50 stddev:3.34 (2.0%) stddev-sans-first:2.18 13:35:49 INFO - PROCESS | 12960 | Values: 175.0 164.0 166.0 170.0 169.0 164.0 166.0 166.0 169.0 166.0 13:35:49 INFO - PROCESS | 12960 | 13:35:49 INFO - PROCESS | 12960 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:3.10 (4.7%) stddev-sans-first:3.24 13:35:49 INFO - PROCESS | 12960 | Values: 65.0 65.0 69.0 64.0 64.0 73.0 67.0 65.0 69.0 63.0 13:35:49 INFO - PROCESS | 12960 | -------- Summary: end -------- 13:35:49 INFO - PROCESS | 12960 | 13:35:50 INFO - TEST-INFO | 12960: exit 0 13:35:50 INFO - TEST-OK | kraken | took 62719ms 13:35:50 INFO - SUITE-END | took 1175s 13:35:50 INFO - Completed test suite (00:19:35) 13:35:50 INFO - javascript benchmark 13:35:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3188.633307169675, 3204.407184670836, 3228.4511633022385, 3242.335321259142, 3268.297316077043, 5361.142217245241, 5394.1908713692965, 5455.945440545594, 5480.123180291154, 5542.1686746988025, 5521.861953451165, 5524.254225679542, 5545.77816887325, 5606.579506537006, 5660.773569057233, 4976.402831660206, 4986.102501549711, 5015.849524514252, 5031.547160755531, 5152.562032227265, 5037.4710655381205, 5057.848264552069, 5091.719955402451, 5106.66806657566, 5120.001599688062, 4875.049365373754, 4911.75441227939, 4948.183549714311, 4954.380702412199, 4955.702657840505, 4932.235503496964, 4963.305137280748, 5025.69845809249, 5026.195808670632, 5057.216131499624, 4783.330333753277, 4956.107900577895, 4986.052649996489, 5000.499950005007, 5014.6991180529285, 5393.83818485446, 5479.287692599936, 5486.259354987065, 5532.944670553283, 5553.0, 5932.762689492415, 5984.0, 6008.909866352008, 6010.429009244159, 6016.368281330485, 5785.768569257225, 5840.532757379399, 6036.486898613623, 6044.396631155346, 6049.023598439365, 5492.697901615409, 5560.805371812007, 5561.916571251434, 5562.332520097574, 5566.081596536607, 6025.758969641253, 6066.272047354346, 6074.058520929263, 6078.149059131725, 6081.118237855575, 5638.718064096779, 5791.131330300489, 5833.941660583425, 5836.299644042657, 5840.445157710011, 6023.036314189709, 6027.849303767353, 6031.788887388921, 6032.788852390146, 6071.635701857903, 5951.3751056139345, 5992.970035149797, 6003.759849606055, 6011.6693581853415, 6016.608920420159, 5657.688827114466, 5896.469317761336, 5968.641881487125, 5969.940300596939, 6001.669908155093, 4516.480604730433, 4517.774111294422, 4518.051209246095, 4519.050999290186, 4555.817767289338, 4017.0760725033406, 4033.213523362916, 4037.2329257440992, 4064.7561146331313, 4086.2644723949975, 5379.973100134553, 5419.458054194549, 5571.331440227118, 5616.494515493625, 5630.0, 6065.332813390523, 6072.848178795477, 6074.3925607438905, 6077.1491991121275, 6093.6039157454625, 5655.095184770417, 5657.688827114466, 5661.150827375926, 5664.291963504562, 5667.716614169358, 4933.531314525115, 5112.105381558287, 5140.845774626767, 5147.9227811582105, 5156.767945442389, 6182.6599537024995, 6196.349383314777, 6239.500839932794, 6239.719212635442, 6242.875142497215, 5752.884942301214, 5965.612235204698, 6012.398760123952, 6027.065804800263, 6031.939680603138, 6095.664738439428, 6104.095385180791, 6139.6009259398, 6217.129601855653, 6217.409346112112, 5853.385394533512, 5879.794207202727, 5887.558433117619, 5892.587518873637, 5930.11048342752, 5764.510016648632, 5879.206307148651, 5972.462478376967, 5980.671063091398, 5993.580449368676, 5754.2519472469985, 5804.2744656917885, 5812.73842677089, 5812.796552120655, 5864.413558644102, 5782.190493330853, 5798.304203495439, 5798.333191682842, 5799.217105690678, 5802.854928626818, 5496.780128794803, 5612.522935550361, 5640.915386269127, 5706.258186435737, 5713.771449141987, 5845.298564172326, 5847.152162936435, 5879.176915231786, 5882.176495290577, 5890.558208134321, 5672.205891175321, 5689.573282003949, 5693.174489699053, 5699.230603868425, 5700.315962084576], "value": 5467.4215712267205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.4592758372631, 636.2524034259745, 654.3783405764525, 665.1519312876084, 673.7439772886303, 33084.66915330846, 36124.63875361245, 36179.27641447173, 45429.0, 46407.0, 45841.77079114608, 46081.76959115208, 46187.76906115465, 46313.7684311578, 46329.305060424034, 8857.867131993009, 8999.865002024975, 9004.549772511382, 9007.189352958232, 9007.819843603123, 8831.95584022079, 8884.466931984069, 8938.061503542132, 8941.374103812735, 8949.686760963368, 9018.594163262636, 9030.50332231727, 9031.683891063814, 9042.0, 9055.592498337557, 8964.0, 8981.14679105484, 9009.95495022524, 9010.369274150811, 9010.999999999967, 8867.423617464845, 8926.553672316359, 8935.374523783337, 8938.910610893872, 8942.0, 42162.0, 42313.57686423127, 42450.78774606138, 42485.57514424878, 42504.78747606273, 3432.622411534729, 3616.4575313702894, 4310.719803212781, 4386.0569977455, 4457.353683715875, 32608.836955815306, 32638.0, 32898.20365268955, 32926.83536582326, 33368.1657958553, 4241.406203131564, 4292.077203401283, 4325.0, 4333.8699839004885, 4396.098799746076, 331796.0, 335390.0, 335604.0, 335971.32014340017, 336117.0, 61092.08361874575, 61131.0, 61529.69235153795, 61597.38402615916, 61633.38366616366, 37042.62957370446, 37861.0, 37876.81061594674, 65276.347236527974, 65333.673331633036, 17232.569185770455, 17418.51942584869, 17429.477115686295, 17432.564185895455, 17435.73846392305, 13063.608091757262, 13175.275359855108, 13187.076904616777, 13190.47238110484, 13216.273104979318, 19737.50656233577, 19861.900690496743, 19895.701564476545, 19925.0, 19941.800581993994, 7040.155181378165, 7206.963965180141, 7213.567185968754, 7262.237465066198, 7445.702171913171, 1000.9399436033862, 1060.2313322840878, 1104.6465131158113, 1158.3918442817587, 1195.8624758152923, 30887.90775087968, 32565.18587035343, 32625.51061734076, 32781.34437311288, 32802.67197328044, 1145.9885401146048, 1190.9523619055315, 1199.5273682688567, 1250.881166289201, 1311.5212947274367, 16989.320427183022, 17208.483745487654, 17245.937484470356, 17341.82658173402, 17388.65222695539, 484059.0, 487951.0, 488510.0, 490405.0, 491689.0, 59268.40731592715, 60498.69750651219, 60515.69742151261, 60524.0, 60663.09005364923, 1275.273094336238, 1308.2673702726313, 1356.5998030581002, 1375.3742047368423, 1401.1172961034483, 32667.509987349735, 33479.83260083684, 34060.82969585136, 34230.65769342275, 34370.357119786095, 51023.48976510188, 51782.48217517927, 51805.481945180065, 51807.0, 51821.0, 382246.0, 383299.0, 387935.0, 388332.0, 388645.0, 25647.487050259264, 28269.57595636108, 28709.712902870702, 28887.56668650014, 28889.56665649975, 46149.30776038429, 47324.0, 49285.260721088496, 49573.0, 50020.0, 41057.65736163127, 41984.0, 42244.15511689687, 42337.15325693407, 42747.7862610685, 41346.0, 41944.79027604964, 42139.0, 42394.78802606091, 44881.32678009898, 42561.574384255764, 42822.0, 42919.78540107404, 43244.78377608092, 43551.346729798446, 36280.818595907906, 37809.0, 37873.0, 38231.617683822806, 38544.80727596344, 26252.21243362702, 26330.736692633596, 26677.86661066682, 26748.19755407341, 26855.86572067127], "value": 20292.021873498907, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.2750504102697, 410.13052329062384, 416.11367786614505, 419.2830260254964, 428.1864457530691, 13561.593152205425, 17813.0, 19163.233470661173, 19167.42497725069, 19545.315913943014, 17800.198991045403, 18418.631627367446, 18719.812801871976, 18731.0, 18782.90608546959, 5456.645318054324, 5627.240322556464, 5631.0708733059, 5633.0, 5661.5187709044785, 5528.226048353234, 5585.441455854402, 5585.525230355424, 5587.608867379285, 5592.6085174037835, 4023.6781057515473, 5855.560832937546, 6173.228346456693, 6176.752929882799, 6267.498600112003, 6118.541109416811, 6128.938710612882, 6181.845453863644, 6230.470410015131, 6254.249490061199, 5559.805406810783, 5569.944300556983, 5572.916406253909, 5589.74846131925, 5589.888202235932, 20912.895435522725, 21324.147034118618, 22012.0, 22153.66769498459, 22182.89262520058, 2280.0993607524933, 2280.5438912217624, 2310.110607416157, 2419.5402873454163, 2666.3600735823456, 13805.861941380557, 14445.566633001026, 14487.637809054753, 14539.636509087251, 14760.926195368955, 1913.6986848942713, 1930.5270208798793, 1946.7274581558593, 1992.8007199279955, 2044.9161944169614, 78302.60848695778, 79225.60387198027, 81374.59312703398, 81657.59171204106, 81910.18089819085, 10249.33379330341, 10386.42874641887, 10771.461426928623, 10791.83812242817, 10860.185486088418, 14953.476628318174, 15025.098494090389, 15034.248287585577, 15057.322420490886, 15072.924635376752, 8046.637901294339, 8311.085780564134, 8375.329973602098, 8410.705625303208, 8466.111058338909, 8008.759737207776, 8015.599220038975, 8061.072976607765, 8133.674653013813, 8213.38399620031, 6341.397567231105, 6440.806775796734, 6528.706208220641, 6595.406413422719, 6596.340365963365, 1813.7098064309912, 1928.951776205578, 1949.3274820187012, 1955.23745739159, 1966.2528239269272, 925.6713866577403, 1018.7962407518526, 1055.8046761349176, 1081.405227125078, 1120.0, 16673.749893751603, 18135.36526221576, 18602.534936626424, 18871.90564047171, 19088.14103365352, 1081.2701426537055, 1083.414955923808, 1116.0625074937093, 1132.7621199548187, 1161.517970042423, 10572.0, 10891.727706807393, 10936.234463587632, 10958.342499450058, 11010.559577616967, 466180.0, 478450.0, 491026.0, 492676.0, 492930.0, 80294.19705802984, 83560.0, 84934.0, 85585.57207213924, 87501.0, 1042.9739256518649, 1063.6277302944063, 1066.4134725900724, 1076.6016573867719, 1077.272840832435, 16380.836191638407, 16543.420980266113, 16669.833301667313, 16739.832601674316, 16847.831521685115, 37488.812555937046, 37633.81183094067, 37735.05662358463, 37884.81057594695, 39372.60627393689, 49756.502434975184, 50785.49214507955, 51142.74428627833, 51581.48418515917, 51641.741791292305, 8468.407211495383, 8523.744287671132, 8617.095205003385, 8879.91120088791, 8924.955375223082, 12629.684257893627, 12769.553065642658, 12898.806517902427, 13189.538366157138, 13296.601101966957, 11336.94331528337, 11409.201355905006, 11796.174267801514, 12095.516179352728, 12363.69090772738, 11277.71805704831, 11513.078953683518, 11555.133364997828, 11804.70488237801, 12034.0, 11788.469518871843, 11801.704957376134, 11824.58613948542, 11878.881211188123, 12003.75992480163, 8549.487030778173, 8655.610497527752, 8710.869336960077, 8765.517896515752, 8972.327075469235, 11508.309501429942, 11724.296542207494, 11856.288622682667, 12244.877551224374, 12442.75114497723], "value": 9332.946876585738, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.794380842874, 1535.9078455292683, 1549.8062742157229, 1720.6558688262344, 1847.935322263721, 8368.958155209222, 8611.698590549331, 8624.741257762262, 8801.0, 8804.251638610725, 8623.439476434027, 8721.607527661256, 8727.0836562161, 8765.91234087659, 8776.824463510742, 2104.4738815296178, 2311.1217737259817, 2343.894524746382, 2370.9051637934463, 2385.9045638174453, 2407.8194135439912, 2414.106780491212, 2414.770596793302, 2416.359664688859, 2424.090965887792, 2357.7995870350956, 2416.226807421626, 2417.4319035026756, 2420.056178090546, 2425.708914930202, 2100.3698890332917, 2306.769323067688, 2382.0, 2383.13015749252, 2397.568437681217, 2245.5845668551206, 2252.650839119939, 2254.2448279826276, 2276.499170182557, 2335.7547457516885, 9022.458652480807, 9078.90921090794, 9081.682141125095, 9083.0, 9084.09159084093, 5250.579953603703, 5406.08096623575, 5412.2152287918425, 5413.729313534347, 5450.073487507133, 3482.7736197147105, 3555.466679997995, 3587.587427445825, 3636.0, 3642.307961487309, 1116.810142275807, 1124.145649306533, 1155.9711007224803, 1156.2831044752224, 1157.455995682028, 12899.161554498927, 12909.031822613248, 12917.67705807353, 12922.095453318365, 12932.612021639367, 4865.221564549655, 4887.095887260868, 4974.900501990012, 4977.701337919736, 5034.471380505068, 10507.842382364272, 10537.315074520131, 10580.259381843198, 10591.311564748421, 10600.575976960989, 4823.614110871122, 5280.683159010395, 5307.548858347083, 5319.946800531945, 5324.801919568066, 4744.288356746516, 4878.243872199815, 4927.384076990376, 4959.156943319572, 4980.950190498049, 3968.464257325282, 4001.581884493133, 4114.280000999813, 4122.56713045132, 4160.063985603215, 1257.4027337015027, 1295.2358108715903, 1301.2842936385139, 1313.7635225659474, 1323.6889331007205, 910.5629297936895, 978.3200675530438, 981.1513041219293, 986.8273052215834, 988.5008070924138, 5880.764769409176, 5928.703564821742, 6006.0, 6057.42454466825, 6162.5378096642935, 460.75349687916804, 465.0698602794411, 466.79227743653746, 468.64383068867903, 483.7653737937098, 4049.4330793688905, 4057.837686492507, 4088.8160032798596, 4202.859054084138, 4245.596668316505, 10398.116160126323, 10809.945950270356, 10905.454727263605, 10905.618303359344, 10920.781584368267, 10615.734606634896, 10668.199885008655, 10747.946260268649, 10758.354498730101, 10767.89232107669, 7842.764717058498, 8109.9189008111525, 8167.305779008851, 8189.95905020483, 8206.302464290482, 5778.422157784188, 5807.94192058074, 5825.417458254141, 5936.465718085393, 5986.551008674454, 9650.806983860424, 9821.950890245504, 9822.607095716092, 9987.750306242111, 9989.150922171406, 9672.95163524206, 9953.452560109263, 10150.695479135638, 10183.745406364604, 10275.075243228146, 7083.929160708327, 7281.526700764433, 7283.235260297804, 7747.612619369122, 7821.882671760042, 8383.496990180609, 8651.264642505457, 8661.307095432476, 8908.510031948046, 8912.598933047899, 7808.843823123392, 7941.920580794118, 7974.880376794469, 8008.559529225949, 8113.0669972953865, 7780.610969451618, 7871.448998570045, 7898.68405263783, 7922.168172341821, 7987.440879138405, 6865.759698410531, 6918.5502942308585, 6918.930810691829, 6932.896006560007, 7025.859482810213, 4846.491118432655, 4852.344933434082, 4941.258811178352, 4979.676321039121, 5032.094223039888, 5070.442251352422, 5085.262636917701, 5086.872828179326, 5092.287079808903, 5135.7432128394175], "value": 4591.679184381024, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.34005389759454, 349.8618045871881, 356.0907386651061, 361.712438611304, 362.1832767110168, 5153.922691159631, 5155.381354237492, 5196.038732834423, 5205.141151709963, 5243.0, 4946.356973593437, 4992.925106123411, 5057.721825299607, 5067.746612669361, 5165.251038599401, 4044.939325910106, 4087.773667899633, 4095.815688294034, 4100.63094321511, 4109.260333140033, 4036.4348991141264, 4044.130511939932, 4071.2671719090554, 4075.470188875442, 4155.376693495969, 3922.4900762900784, 4081.918221706921, 4106.260873042851, 4107.609777071173, 4111.075008123178, 3994.900127496807, 4017.658499027586, 4084.5915408459214, 4086.0602061525865, 4110.671146308303, 3599.262151258986, 3611.855525778966, 3626.528551288342, 3629.858383553716, 3629.860170952134, 4799.3760811094335, 4960.528749768766, 5004.84985450437, 5007.424146223195, 5007.849764507034, 4604.539546045402, 4641.073954308958, 4648.000679853848, 4664.790084446174, 4670.972386075058, 5429.914017196537, 5435.918461223085, 5441.156620723755, 5442.265294185314, 5444.0, 3853.2660302863824, 3879.0, 3952.664023558001, 3974.4038394241097, 3993.9201215975518, 5617.848341090067, 5636.830895073154, 5640.661560306354, 5651.7739290428335, 5671.432856714337, 4007.8196481158416, 4016.176683779818, 4016.979915100464, 4020.979895100506, 4022.557518672944, 4028.3554631259444, 4036.9394459083137, 4039.171969746195, 4095.037666148453, 4095.610916962884, 4561.863144105682, 4562.475315338712, 4583.083383323348, 4595.425571803525, 4658.138244424792, 5349.384820745586, 5391.973040134774, 5450.672959622435, 5458.590605704588, 5462.918056229159, 1343.4559003603556, 1356.186288227056, 1405.7118290750373, 1421.665908511499, 1423.8504956979575, 924.2790623313826, 926.666400095965, 930.5486838883136, 935.2471260635253, 940.247801758604, 4621.630269578425, 4651.86044418668, 4672.439307283148, 4688.343631891538, 4708.741019243906, 4743.66794324394, 4949.356583644103, 4982.850514484571, 5001.499250374813, 5009.474005229471, 4644.95355046452, 4668.533146685372, 4670.486246512881, 4691.0, 4700.95299047012, 2570.961435578468, 2639.0631325879035, 2652.880620372088, 2660.4945060438454, 2667.6798784146026, 5089.643724939293, 5102.642815002914, 5103.923441148386, 5145.742712864417, 5148.897022059613, 4954.687007942826, 5013.298138260647, 5020.322256495399, 5057.317262169634, 5066.923996140061, 4758.619310455225, 5063.949360506422, 5079.746012699424, 5098.923516147261, 5123.8719032023755, 4914.92627610579, 4941.579965702956, 4944.788526810954, 4974.278729584263, 4979.734220929396, 4947.950520494749, 4948.802047918187, 4983.601311895112, 4983.725895075806, 4987.451380348231, 4757.690750101232, 5117.360329958755, 5132.613334799336, 5151.665141765773, 5189.624749441326, 3769.9811500943415, 3777.20678657485, 3781.1681430085337, 3789.8251542022062, 3798.948567773482, 4993.725345106054, 5029.7736601852275, 5039.748012599282, 5054.342935418372, 5067.910399264176, 4546.499885012579, 4946.8763280918265, 4962.975185124052, 4970.478099799469, 4976.353074100344, 4807.61539076866, 4840.596227094244, 4841.782119804547, 4846.345743324606, 4873.6832105913, 4789.95210047909, 4809.398825146856, 4813.7352445615825, 4815.831445899376, 4867.829625963074, 4876.78054487556, 4894.461609222912, 4903.705777653352, 4934.235193545006, 5095.668781529189, 5394.352677678704, 5412.56699464034, 5418.241446197614, 5420.891582168413, 5431.207701458588], "value": 3970.29558844904, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.306840719592, 849.0702680564781, 854.4616891358444, 866.6533386645341, 876.6800117956948, 12193.451294691738, 12664.0, 12689.746205075904, 12700.0, 12702.301373424458, 13214.207147571153, 13259.138156019875, 13266.734665306689, 13270.270135142564, 13308.0, 682.5426963934163, 701.8841891087965, 794.1661255681511, 810.5784991804259, 817.9550124743137, 803.1727320859495, 809.9919000810005, 810.400303775208, 814.3200427642926, 814.6252723747084, 855.700504823313, 857.1599832164451, 857.6440777077537, 858.2833334165948, 858.5063588436643, 710.882704353781, 844.3456321350941, 862.0861886400436, 865.7705707987388, 865.8831057807209, 629.6757170057424, 631.5452873930763, 634.0520921222756, 634.3846468925182, 635.5328833307515, 12668.36658167088, 12679.746405071939, 12705.428255728422, 12708.173968692005, 12724.491020359175, 13493.730125397436, 13585.660358491017, 13622.523211687643, 13757.449702011907, 13916.30418479082, 11802.645920622395, 12159.088068394905, 12167.574134905324, 12255.203411778206, 12367.381630918419, 4421.491528474235, 4496.145732310883, 4536.319552067183, 4653.790579423934, 4655.511171326996, 55470.44529554693, 55701.72149139269, 57391.42608573861, 57513.137302940486, 57730.0, 10143.34068285559, 10375.325603835727, 10388.168946484264, 10389.740256493496, 10450.268481206243, 17105.627945661352, 17551.210195541233, 17572.736408953875, 17582.824171758373, 17837.0, 7655.311022007934, 7750.341220996278, 8124.837503249902, 8129.674813007414, 8232.382571307056, 4744.881377965578, 4751.524847515221, 4791.95208047922, 4820.517948205152, 4934.037862616827, 3244.7890887092735, 3344.1639590102473, 3345.882894098695, 3348.380549598332, 3357.9496307555405, 632.0803231298542, 636.1221514310222, 637.2066776862836, 637.8150336402391, 643.7425029987949, 578.0923949399403, 684.9691763870637, 741.892425598296, 747.8691229035006, 756.6632848382527, 9062.81874362509, 9138.497382643885, 9188.173064424234, 9210.677626283183, 9284.0, 719.9064121664255, 721.1886627544013, 727.5707332673747, 732.6519903046117, 740.2856243724831, 4165.125323682, 4189.685773566995, 4329.610335069796, 4466.0, 4484.977575112103, 59464.405355945884, 62541.68729156325, 63551.36448635547, 64983.67508162523, 65222.67388663026, 54316.72841635766, 54814.72592637011, 55392.16911746327, 56193.15710264349, 56985.43014569801, 49506.25740613894, 51666.74166629218, 51881.481185187666, 52064.739676301375, 52453.0, 8273.089960104504, 8554.57227138653, 8612.870806938026, 8649.1350864913, 8670.089640587648, 32471.188220293738, 32476.0, 33103.33793324072, 33114.0, 33431.0, 42536.361954570086, 45715.0, 47427.0, 47652.761736191096, 48498.5150148494, 10926.56293748273, 10933.398663073607, 11009.944950275198, 11124.276922000045, 11227.607033753779, 9353.81292374135, 11710.76225344534, 11733.296002239893, 11926.284422934652, 11977.940110299392, 11597.76804463923, 12313.815292770794, 12474.812877806658, 12709.36453177319, 13037.0, 12882.227066375672, 12953.093283470067, 13526.18842869431, 13930.024898257025, 14045.297735113409, 12839.229646221256, 13001.089923705249, 13261.66845828862, 13694.452221911011, 13708.65728356799, 10950.671479855617, 11020.944895275472, 11080.168987325822, 11485.0, 11552.42237888119, 11062.612808551663, 11164.553417863195, 11165.274257173258, 11239.157063220127, 11300.49147788335], "value": 6696.990750443969, "unit": "score"}], "name": "dromaeo_css", "value": 7084.483380684855, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 149.0, 211.0, 127.0, 152.0, 152.0, 129.0, 189.0, 125.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 160.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 146.0, 77.0, 75.0, 76.0, 74.0, 127.0, 75.0], "value": 87.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 145.0, 93.0, 92.0, 92.0, 123.0, 92.0, 92.0, 123.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 118.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 61.0, 57.0, 58.0, 57.0, 59.0, 110.0, 55.0, 57.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 78.0, 78.0, 83.0, 80.0, 80.0, 80.0, 79.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 126.0, 123.0, 122.0, 124.0, 130.0, 123.0, 132.0, 190.0, 132.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 164.0, 166.0, 170.0, 169.0, 164.0, 166.0, 166.0, 169.0, 166.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 69.0, 64.0, 64.0, 73.0, 67.0, 65.0, 69.0, 63.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1537.6, "alertThreshold": 2.0}]} 13:35:50 INFO - Return code: 0 13:35:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:35:50 ERROR - # TBPL SUCCESS # 13:35:50 INFO - Running post-action listener: _resource_record_post_action 13:35:50 INFO - ##### 13:35:50 INFO - ##### Finished run-tests step (success) 13:35:50 INFO - ##### 13:35:50 INFO - Running post-run listener: _resource_record_post_run 13:35:51 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540270592; Read time: 20; Write time: 500608 13:35:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254111744; Read time: 0; Write time: 281252 13:35:51 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286105600; Read time: 20; Write time: 219340 13:35:51 INFO - Running post-run listener: _upload_blobber_files 13:35:51 INFO - Blob upload gear active. 13:35:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:35:51 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:35:51 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:35:51 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:35:52 INFO - (blobuploader) - INFO - Open directory for files ... 13:35:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:35:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:35:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:53 INFO - (blobuploader) - INFO - Done attempting. 13:35:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:35:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:35:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:54 INFO - (blobuploader) - INFO - Done attempting. 13:35:54 INFO - (blobuploader) - INFO - Iteration through files over. 13:35:54 INFO - Return code: 0 13:35:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:35:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:35:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d897d9c1629b69f2d2cb7993588deca8d611a9ff095615fa8d91186b6803761a920ec1ac29237dec50db476cc886811bc460da151ac0690a4cd3dd03ba6f5d1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/697d3ce6cb096c62d65ba6eb2d5bae9fa4f9fbe961629f2f6689a7015886d459bb9e5b366e267bbbe1aea8cb2fb6d8cbe670d24ed57f9b3f0ec624c27861184c"} 13:35:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:35:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:35:54 INFO - Contents: 13:35:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d897d9c1629b69f2d2cb7993588deca8d611a9ff095615fa8d91186b6803761a920ec1ac29237dec50db476cc886811bc460da151ac0690a4cd3dd03ba6f5d1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/697d3ce6cb096c62d65ba6eb2d5bae9fa4f9fbe961629f2f6689a7015886d459bb9e5b366e267bbbe1aea8cb2fb6d8cbe670d24ed57f9b3f0ec624c27861184c"} 13:35:54 INFO - Running post-run listener: copy_logs_to_upload_dir 13:35:54 INFO - Copying logs to upload dir... 13:35:54 INFO - mkdir: /builds/slave/test/build/upload/logs 13:35:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.089171 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-11 13:35:53.969952) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 13:35:53.974087) ========= 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=7de08804244eb36560b44971000001c3-1462997719.628228-1240805168 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/d897d9c1629b69f2d2cb7993588deca8d611a9ff095615fa8d91186b6803761a920ec1ac29237dec50db476cc886811bc460da151ac0690a4cd3dd03ba6f5d1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/697d3ce6cb096c62d65ba6eb2d5bae9fa4f9fbe961629f2f6689a7015886d459bb9e5b366e267bbbe1aea8cb2fb6d8cbe670d24ed57f9b3f0ec624c27861184c"} build_url:https://queue.taskcluster.net/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/JkF-WgmYRiWPPeh5e84sBw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d897d9c1629b69f2d2cb7993588deca8d611a9ff095615fa8d91186b6803761a920ec1ac29237dec50db476cc886811bc460da151ac0690a4cd3dd03ba6f5d1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/697d3ce6cb096c62d65ba6eb2d5bae9fa4f9fbe961629f2f6689a7015886d459bb9e5b366e267bbbe1aea8cb2fb6d8cbe670d24ed57f9b3f0ec624c27861184c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 13:35:53.999360) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:35:53.999711) ========= 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=7de08804244eb36560b44971000001c3-1462997719.628228-1240805168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004382 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 13:35:54.084548) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 13:35:54.085013) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 13:35:54.085453) ========= ========= Total master_lag: 0.17 =========