builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1462537121.66 results: success (0) buildid: 20160506013122 builduid: edd2de8de4ca48969474bf5b1f92b92a revision: b14d8e23323e95c5db3bc4cca69738edeee44302 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:41.659873) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:41.660390) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:41.660693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:41.678106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:41.678524) ========= 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=920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 05:18:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-05-06 05:18:42 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087189 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:41.781920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:41.782270) ========= 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=920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019337 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:41.835887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:41.836307) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b14d8e23323e95c5db3bc4cca69738edeee44302 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b14d8e23323e95c5db3bc4cca69738edeee44302 --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=920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 05:18:42,133 truncating revision to first 12 chars 2016-05-06 05:18:42,134 Setting DEBUG logging. 2016-05-06 05:18:42,134 attempt 1/10 2016-05-06 05:18:42,134 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b14d8e23323e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 05:18:42,383 unpacking tar archive at: mozilla-aurora-b14d8e23323e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527911 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:42.420095) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:42.420415) ========= script_repo_revision: b14d8e23323e95c5db3bc4cca69738edeee44302 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:42.420828) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:42.421089) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:42.431153) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-06 05:18:42.431542) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:18:42 INFO - MultiFileLogger online at 20160506 05:18:42 in /builds/slave/test 05:18:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:18:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:18:42 INFO - {'append_to_log': False, 05:18:42 INFO - 'base_work_dir': '/builds/slave/test', 05:18:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:18:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:18:42 INFO - 'branch': 'Mozilla-Aurora', 05:18:42 INFO - 'buildbot_json_path': 'buildprops.json', 05:18:42 INFO - 'config_files': ('talos/linux_config.py',), 05:18:42 INFO - 'default_actions': ('clobber', 05:18:42 INFO - 'read-buildbot-config', 05:18:42 INFO - 'download-and-extract', 05:18:42 INFO - 'populate-webroot', 05:18:42 INFO - 'create-virtualenv', 05:18:42 INFO - 'install', 05:18:42 INFO - 'run-tests'), 05:18:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:18:42 INFO - 'download_minidump_stackwalk': True, 05:18:42 INFO - 'download_symbols': 'ondemand', 05:18:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:18:42 INFO - 'tooltool.py': '/tools/tooltool.py', 05:18:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:18:42 INFO - '/tools/misc-python/virtualenv.py')}, 05:18:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:18:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:18:42 INFO - 'installer_path': 'installer.exe', 05:18:42 INFO - 'log_level': 'info', 05:18:42 INFO - 'log_name': 'talos', 05:18:42 INFO - 'log_to_console': True, 05:18:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:18:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:18:42 INFO - 'opt_config_files': (), 05:18:42 INFO - 'pip_index': False, 05:18:42 INFO - 'sps_profile': False, 05:18:42 INFO - 'sps_profile_interval': 0, 05:18:42 INFO - 'suite': 'dromaeojs', 05:18:42 INFO - 'system_bits': '32', 05:18:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:18:42 INFO - 'title': 'talos-linux64-ix-053', 05:18:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:18:42 INFO - 'use_talos_json': True, 05:18:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:18:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:18:42 INFO - 'work_dir': 'build'} 05:18:42 INFO - ##### 05:18:42 INFO - ##### Running clobber step. 05:18:42 INFO - ##### 05:18:42 INFO - Running pre-action listener: _resource_record_pre_action 05:18:42 INFO - Running main action method: clobber 05:18:42 INFO - rmtree: /builds/slave/test/build 05:18:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:18:43 INFO - Running post-action listener: _resource_record_post_action 05:18:43 INFO - ##### 05:18:43 INFO - ##### Running read-buildbot-config step. 05:18:43 INFO - ##### 05:18:43 INFO - Running pre-action listener: _resource_record_pre_action 05:18:43 INFO - Running main action method: read_buildbot_config 05:18:43 INFO - Using buildbot properties: 05:18:43 INFO - { 05:18:43 INFO - "project": "", 05:18:43 INFO - "product": "firefox", 05:18:43 INFO - "script_repo_revision": "production", 05:18:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:18:43 INFO - "repository": "", 05:18:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:18:43 INFO - "buildid": "20160506013122", 05:18:43 INFO - "pgo_build": "True", 05:18:43 INFO - "basedir": "/builds/slave/test", 05:18:43 INFO - "buildnumber": 310, 05:18:43 INFO - "slavename": "talos-linux64-ix-053", 05:18:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:18:43 INFO - "platform": "ubuntu64_hw", 05:18:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:18:43 INFO - "branch": "mozilla-aurora", 05:18:43 INFO - "repo_path": "releases/mozilla-aurora", 05:18:43 INFO - "revision": "b14d8e23323e95c5db3bc4cca69738edeee44302", 05:18:43 INFO - "stage_platform": "linux64-pgo", 05:18:43 INFO - "builduid": "edd2de8de4ca48969474bf5b1f92b92a", 05:18:43 INFO - "slavebuilddir": "test" 05:18:43 INFO - } 05:18:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 05:18:43 INFO - Running post-action listener: _resource_record_post_action 05:18:43 INFO - ##### 05:18:43 INFO - ##### Running download-and-extract step. 05:18:43 INFO - ##### 05:18:43 INFO - Running pre-action listener: _resource_record_pre_action 05:18:43 INFO - Running main action method: download_and_extract 05:18:43 INFO - mkdir: /builds/slave/test/build/tests 05:18: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')]} 05:18:43 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:18:43 INFO - Downloaded 1361 bytes. 05:18:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:18:43 INFO - Using the following test package requirements: 05:18:43 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:18:43 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:18:43 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:18:43 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:43 INFO - u'jsshell-linux-x86_64.zip'], 05:18:43 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:18:43 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:18:43 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:18:43 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:18:43 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:18:43 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:18:43 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:18: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')]} 05:18:43 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:18:45 INFO - Downloaded 23822984 bytes. 05:18:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:18:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:18:46 INFO - Return code: 0 05:18:46 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:46 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:18:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:18:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:18:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:18:47 INFO - Downloaded 23822984 bytes. 05:18:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:18:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:18:48 INFO - Return code: 0 05:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:48 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:18:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:18:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:18:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:18:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:18:49 INFO - Downloaded 10840145 bytes. 05:18:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:18:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:18:50 INFO - Return code: 0 05:18: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')]} 05:18:50 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:18:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:18:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:18:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:18:51 INFO - Downloaded 62693495 bytes. 05:18:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:18:51 INFO - mkdir: /builds/slave/test/properties 05:18:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:18:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:18:51 INFO - Contents: 05:18:51 INFO - build_url:https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:18:52 INFO - Running post-action listener: _resource_record_post_action 05:18:52 INFO - Running post-action listener: set_extra_try_arguments 05:18:52 INFO - ##### 05:18:52 INFO - ##### Running populate-webroot step. 05:18:52 INFO - ##### 05:18:52 INFO - Running pre-action listener: _resource_record_pre_action 05:18:52 INFO - Running main action method: populate_webroot 05:18:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:18:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:18:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:18:52 INFO - '--tppagecycles', 05:18:52 INFO - '7'], 05:18:52 INFO - 'tests': ['tsvgm']}}, 05:18:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:18:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:18:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:18:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:18:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:18:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:18:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:52 INFO - 'talos_options': ['--disable-e10s'], 05:18:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:52 INFO - 'talos_options': ['--disable-e10s'], 05:18:52 INFO - 'tests': ['damp', 'tps']}, 05:18:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:52 INFO - 'tests': ['damp', 'tps']}, 05:18:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:18:52 INFO - 'tests': ['dromaeo_dom']}, 05:18:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:18:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:18:52 INFO - 'tests': ['a11yr', 05:18:52 INFO - 'ts_paint', 05:18:52 INFO - 'tpaint', 05:18:52 INFO - 'sessionrestore', 05:18:52 INFO - 'sessionrestore_no_auto_restore', 05:18:52 INFO - 'tabpaint']}, 05:18:52 INFO - 'other-e10s': {'tests': ['a11yr', 05:18:52 INFO - 'ts_paint', 05:18:52 INFO - 'tpaint', 05:18:52 INFO - 'sessionrestore', 05:18:52 INFO - 'sessionrestore_no_auto_restore', 05:18:52 INFO - 'tabpaint']}, 05:18:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:18:52 INFO - 'ts_paint', 05:18:52 INFO - 'tpaint', 05:18:52 INFO - 'sessionrestore', 05:18:52 INFO - 'sessionrestore_no_auto_restore', 05:18:52 INFO - 'tabpaint']}, 05:18:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:18:52 INFO - 'ts_paint', 05:18:52 INFO - 'tpaint', 05:18:52 INFO - 'sessionrestore', 05:18:52 INFO - 'sessionrestore_no_auto_restore', 05:18:52 INFO - 'tabpaint']}, 05:18:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:18:52 INFO - 'tests': ['a11yr', 05:18:52 INFO - 'ts_paint', 05:18:52 INFO - 'tpaint', 05:18:52 INFO - 'sessionrestore', 05:18:52 INFO - 'sessionrestore_no_auto_restore', 05:18:52 INFO - 'tabpaint']}, 05:18:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:18:52 INFO - 'tests': ['a11yr', 05:18:52 INFO - 'ts_paint', 05:18:52 INFO - 'tpaint', 05:18:52 INFO - 'sessionrestore', 05:18:52 INFO - 'sessionrestore_no_auto_restore', 05:18:52 INFO - 'tabpaint']}, 05:18:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:18:52 INFO - 'tests': ['tsvgx', 05:18:52 INFO - 'tsvgr_opacity', 05:18:52 INFO - 'tart', 05:18:52 INFO - 'tscrollx', 05:18:52 INFO - 'cart']}, 05:18:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:18:52 INFO - 'tsvgr_opacity', 05:18:52 INFO - 'tart', 05:18:52 INFO - 'tscrollx', 05:18:52 INFO - 'cart']}, 05:18:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:52 INFO - 'talos_options': ['--disable-e10s'], 05:18:52 INFO - 'tests': ['tp5o']}, 05:18:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:52 INFO - 'tests': ['tp5o']}, 05:18:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:52 INFO - 'talos_options': ['--disable-e10s', 05:18:52 INFO - '--xperf_path', 05:18:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:52 INFO - 'tests': ['tp5n']}, 05:18:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:52 INFO - 'talos_options': ['--xperf_path', 05:18:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:52 INFO - 'tests': ['tp5n']}}, 05:18:52 INFO - 'talos.zip': {'path': '', 05:18:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:18:52 INFO - Running post-action listener: _resource_record_post_action 05:18:52 INFO - ##### 05:18:52 INFO - ##### Running create-virtualenv step. 05:18:52 INFO - ##### 05:18:52 INFO - Running pre-action listener: _resource_record_pre_action 05:18:52 INFO - Running main action method: create_virtualenv 05:18:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:18:52 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 05:18:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:18:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:18:52 INFO - Using real prefix '/usr' 05:18:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:18:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:18:55 INFO - Installing pip.................done. 05:18:55 INFO - Return code: 0 05:18:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:18:55 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')]} 05:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:55 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')]} 05:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:55 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 0x7faf73e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', '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 05:18:55 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 05:18:55 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 05:18:55 INFO - Using env: {'DISPLAY': ':0', 05:18:55 INFO - 'HOME': '/home/cltbld', 05:18:55 INFO - 'LANG': 'en_US.UTF-8', 05:18:55 INFO - 'LANGUAGE': 'en_US:en', 05:18:55 INFO - 'LOGNAME': 'cltbld', 05:18:55 INFO - 'MAIL': '/var/mail/cltbld', 05:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:55 INFO - 'MOZ_NO_REMOTE': '1', 05:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:55 INFO - 'NO_EM_RESTART': '1', 05:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:55 INFO - 'PWD': '/builds/slave/test', 05:18:55 INFO - 'SHELL': '/bin/bash', 05:18:55 INFO - 'SHLVL': '1', 05:18:55 INFO - 'TERM': 'linux', 05:18:55 INFO - 'TMOUT': '86400', 05:18:55 INFO - 'USER': 'cltbld', 05:18:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', 05:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:55 INFO - '_': '/tools/buildbot/bin/python'} 05:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:55 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 05:18:55 INFO - Cleaning up... 05:18:55 INFO - Return code: 0 05:18:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:18:55 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')]} 05:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:55 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')]} 05:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:55 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 0x7faf73e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', '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 05:18:55 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 05:18:55 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 05:18:55 INFO - Using env: {'DISPLAY': ':0', 05:18:55 INFO - 'HOME': '/home/cltbld', 05:18:55 INFO - 'LANG': 'en_US.UTF-8', 05:18:55 INFO - 'LANGUAGE': 'en_US:en', 05:18:55 INFO - 'LOGNAME': 'cltbld', 05:18:55 INFO - 'MAIL': '/var/mail/cltbld', 05:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:55 INFO - 'MOZ_NO_REMOTE': '1', 05:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:55 INFO - 'NO_EM_RESTART': '1', 05:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:55 INFO - 'PWD': '/builds/slave/test', 05:18:55 INFO - 'SHELL': '/bin/bash', 05:18:55 INFO - 'SHLVL': '1', 05:18:55 INFO - 'TERM': 'linux', 05:18:55 INFO - 'TMOUT': '86400', 05:18:55 INFO - 'USER': 'cltbld', 05:18:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', 05:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:55 INFO - '_': '/tools/buildbot/bin/python'} 05:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:55 INFO - Downloading/unpacking psutil>=0.7.1 05:18: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 05:18: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 05:18: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 05:18: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 05:18: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 05:18: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 05:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:18:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:57 INFO - Installing collected packages: psutil 05:18:57 INFO - Running setup.py install for psutil 05:18:57 INFO - building 'psutil._psutil_linux' extension 05:18:57 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 05:18:57 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 05:18:57 INFO - building 'psutil._psutil_posix' extension 05:18:57 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 05:18:58 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 05:18:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:58 INFO - Successfully installed psutil 05:18:58 INFO - Cleaning up... 05:18:58 INFO - Return code: 0 05:18:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:58 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 0x7faf73e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', '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 05:18:58 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 05:18:58 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 05:18:58 INFO - Using env: {'DISPLAY': ':0', 05:18:58 INFO - 'HOME': '/home/cltbld', 05:18:58 INFO - 'LANG': 'en_US.UTF-8', 05:18:58 INFO - 'LANGUAGE': 'en_US:en', 05:18:58 INFO - 'LOGNAME': 'cltbld', 05:18:58 INFO - 'MAIL': '/var/mail/cltbld', 05:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:58 INFO - 'MOZ_NO_REMOTE': '1', 05:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:58 INFO - 'NO_EM_RESTART': '1', 05:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:58 INFO - 'PWD': '/builds/slave/test', 05:18:58 INFO - 'SHELL': '/bin/bash', 05:18:58 INFO - 'SHLVL': '1', 05:18:58 INFO - 'TERM': 'linux', 05:18:58 INFO - 'TMOUT': '86400', 05:18:58 INFO - 'USER': 'cltbld', 05:18:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', 05:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:58 INFO - '_': '/tools/buildbot/bin/python'} 05:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:18:58 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 05:18:58 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 05:18:58 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 05:18:58 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 05:18:58 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 05:18:58 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 05:19:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:19:00 INFO - Installing collected packages: mozsystemmonitor 05:19:00 INFO - Running setup.py install for mozsystemmonitor 05:19:00 INFO - Successfully installed mozsystemmonitor 05:19:00 INFO - Cleaning up... 05:19:00 INFO - Return code: 0 05:19:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:19:00 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')]} 05:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:00 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')]} 05:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:00 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 0x7faf73e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', '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 05:19:00 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 05:19:00 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 05:19:00 INFO - Using env: {'DISPLAY': ':0', 05:19:00 INFO - 'HOME': '/home/cltbld', 05:19:00 INFO - 'LANG': 'en_US.UTF-8', 05:19:00 INFO - 'LANGUAGE': 'en_US:en', 05:19:00 INFO - 'LOGNAME': 'cltbld', 05:19:00 INFO - 'MAIL': '/var/mail/cltbld', 05:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:00 INFO - 'MOZ_NO_REMOTE': '1', 05:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:00 INFO - 'NO_EM_RESTART': '1', 05:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:00 INFO - 'PWD': '/builds/slave/test', 05:19:00 INFO - 'SHELL': '/bin/bash', 05:19:00 INFO - 'SHLVL': '1', 05:19:00 INFO - 'TERM': 'linux', 05:19:00 INFO - 'TMOUT': '86400', 05:19:00 INFO - 'USER': 'cltbld', 05:19:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', 05:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:00 INFO - '_': '/tools/buildbot/bin/python'} 05:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:19:00 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 05:19:00 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 05:19:00 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 05:19:00 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 05:19:00 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 05:19:00 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 05:19:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:19:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:19:02 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 05:19:02 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 05:19:02 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 05:19:02 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 05:19:02 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 05:19:02 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 05:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:19:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:19:03 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 05:19:03 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 05:19:03 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 05:19:03 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 05:19:03 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 05:19:03 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 05:19:03 INFO - Downloading docopt-0.6.1.tar.gz 05:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:19:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:19:03 INFO - Running setup.py install for blobuploader 05:19:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:19:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:19:03 INFO - Running setup.py install for requests 05:19:03 INFO - Running setup.py install for docopt 05:19:03 INFO - Successfully installed blobuploader requests docopt 05:19:03 INFO - Cleaning up... 05:19:03 INFO - Return code: 0 05:19:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:03 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 0x7faf73e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', '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 05:19:03 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 05:19:03 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 05:19:03 INFO - Using env: {'DISPLAY': ':0', 05:19:03 INFO - 'HOME': '/home/cltbld', 05:19:03 INFO - 'LANG': 'en_US.UTF-8', 05:19:03 INFO - 'LANGUAGE': 'en_US:en', 05:19:03 INFO - 'LOGNAME': 'cltbld', 05:19:03 INFO - 'MAIL': '/var/mail/cltbld', 05:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:03 INFO - 'MOZ_NO_REMOTE': '1', 05:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:03 INFO - 'NO_EM_RESTART': '1', 05:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:03 INFO - 'PWD': '/builds/slave/test', 05:19:03 INFO - 'SHELL': '/bin/bash', 05:19:03 INFO - 'SHLVL': '1', 05:19:03 INFO - 'TERM': 'linux', 05:19:03 INFO - 'TMOUT': '86400', 05:19:03 INFO - 'USER': 'cltbld', 05:19:03 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', 05:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:03 INFO - '_': '/tools/buildbot/bin/python'} 05:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:19:04 INFO - Running setup.py (path:/tmp/pip-9J_Hy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:19:04 INFO - Running setup.py (path:/tmp/pip-uXWTef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:19:04 INFO - Running setup.py (path:/tmp/pip-7NWC0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:19:04 INFO - Running setup.py (path:/tmp/pip-QeOt47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:19:04 INFO - Running setup.py (path:/tmp/pip-ZPT8dW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:19:04 INFO - Running setup.py (path:/tmp/pip-gpAf5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:19:04 INFO - Running setup.py (path:/tmp/pip-z6k0NW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:19:04 INFO - Running setup.py (path:/tmp/pip-CMsAoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:19:04 INFO - Running setup.py (path:/tmp/pip-Z6bNPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:19:04 INFO - Running setup.py (path:/tmp/pip-MLNOgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:19:04 INFO - Running setup.py (path:/tmp/pip-xWTyqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:19:04 INFO - Running setup.py (path:/tmp/pip-dnsMhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:19:04 INFO - Running setup.py (path:/tmp/pip-WCLp61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:19:05 INFO - Running setup.py (path:/tmp/pip-z1J4DX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:05 INFO - Running setup.py (path:/tmp/pip-oQYfl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:19:05 INFO - Running setup.py (path:/tmp/pip-Wq62uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:19:05 INFO - Running setup.py (path:/tmp/pip-KcXVue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:19:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:19:05 INFO - Running setup.py install for manifestparser 05:19:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:19:05 INFO - Running setup.py install for mozcrash 05:19:05 INFO - Running setup.py install for mozdebug 05:19:05 INFO - Running setup.py install for mozdevice 05:19:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:19:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:19:05 INFO - Running setup.py install for mozfile 05:19:05 INFO - Running setup.py install for mozhttpd 05:19:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:19:05 INFO - Running setup.py install for mozinfo 05:19:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:19:06 INFO - Running setup.py install for mozInstall 05:19:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:19:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:19:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:19:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:19:06 INFO - Running setup.py install for mozleak 05:19:06 INFO - Running setup.py install for mozlog 05:19:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:19:06 INFO - Running setup.py install for moznetwork 05:19:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:19:06 INFO - Running setup.py install for mozprocess 05:19:06 INFO - Running setup.py install for mozprofile 05:19:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:19:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:19:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:19:06 INFO - Running setup.py install for mozrunner 05:19:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:19:06 INFO - Running setup.py install for mozscreenshot 05:19:06 INFO - Running setup.py install for moztest 05:19:06 INFO - Running setup.py install for mozversion 05:19:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:19:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:19:07 INFO - Cleaning up... 05:19:07 INFO - Return code: 0 05:19:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:07 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')]} 05:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:07 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')]} 05:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:07 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 0x7faf73e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', '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 05:19:07 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 05:19:07 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 05:19:07 INFO - Using env: {'DISPLAY': ':0', 05:19:07 INFO - 'HOME': '/home/cltbld', 05:19:07 INFO - 'LANG': 'en_US.UTF-8', 05:19:07 INFO - 'LANGUAGE': 'en_US:en', 05:19:07 INFO - 'LOGNAME': 'cltbld', 05:19:07 INFO - 'MAIL': '/var/mail/cltbld', 05:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:07 INFO - 'MOZ_NO_REMOTE': '1', 05:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:07 INFO - 'NO_EM_RESTART': '1', 05:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:07 INFO - 'PWD': '/builds/slave/test', 05:19:07 INFO - 'SHELL': '/bin/bash', 05:19:07 INFO - 'SHLVL': '1', 05:19:07 INFO - 'TERM': 'linux', 05:19:07 INFO - 'TMOUT': '86400', 05:19:07 INFO - 'USER': 'cltbld', 05:19:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', 05:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:07 INFO - '_': '/tools/buildbot/bin/python'} 05:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:19:07 INFO - Running setup.py (path:/tmp/pip-VpOqHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:19:07 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)) 05:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:19:07 INFO - Running setup.py (path:/tmp/pip-J1pT3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:19:07 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)) 05:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:19:07 INFO - Running setup.py (path:/tmp/pip-ESieIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:19:07 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)) 05:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:19:07 INFO - Running setup.py (path:/tmp/pip-mMJRHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:19:07 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)) 05:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:19:07 INFO - Running setup.py (path:/tmp/pip-CBTXTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:19:07 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)) 05:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:19:07 INFO - Running setup.py (path:/tmp/pip-HBiS37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:19:07 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)) 05:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:19:07 INFO - Running setup.py (path:/tmp/pip-8MqgFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:19:07 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)) 05:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:19:07 INFO - Running setup.py (path:/tmp/pip-DXRMkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:19:07 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)) 05:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:19:07 INFO - Running setup.py (path:/tmp/pip-bmSOmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:19:07 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)) 05:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:19:07 INFO - Running setup.py (path:/tmp/pip-O1oTpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 05:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:19:08 INFO - Running setup.py (path:/tmp/pip-tz1jaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:19:08 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)) 05:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:19:08 INFO - Running setup.py (path:/tmp/pip-LXhjEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:19:08 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)) 05:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:19:08 INFO - Running setup.py (path:/tmp/pip-qR42hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:19:08 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)) 05:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:19:08 INFO - Running setup.py (path:/tmp/pip-oCArRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:19:08 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)) 05:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:08 INFO - Running setup.py (path:/tmp/pip-Pch1gY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:08 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)) 05:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:19:08 INFO - Running setup.py (path:/tmp/pip-5megG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:19:08 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)) 05:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:19:08 INFO - Running setup.py (path:/tmp/pip-8fgPsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:19:08 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)) 05:19:08 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)) 05:19:08 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)) 05:19:08 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)) 05:19:08 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)) 05:19:08 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)) 05:19:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:19:08 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 05:19:08 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 05:19:08 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 05:19:08 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 05:19:08 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 05:19:08 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 05:19:10 INFO - Downloading blessings-1.6.tar.gz 05:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:19:10 INFO - Installing collected packages: blessings 05:19:10 INFO - Running setup.py install for blessings 05:19:10 INFO - Successfully installed blessings 05:19:10 INFO - Cleaning up... 05:19:10 INFO - Return code: 0 05:19:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:11 INFO - Reading from file tmpfile_stdout 05:19:11 INFO - Current package versions: 05:19:11 INFO - argparse == 1.2.1 05:19:11 INFO - blessings == 1.6 05:19:11 INFO - blobuploader == 1.2.4 05:19:11 INFO - docopt == 0.6.1 05:19:11 INFO - manifestparser == 1.1 05:19:11 INFO - mozInstall == 1.12 05:19:11 INFO - mozcrash == 0.17 05:19:11 INFO - mozdebug == 0.1 05:19:11 INFO - mozdevice == 0.48 05:19:11 INFO - mozfile == 1.2 05:19:11 INFO - mozhttpd == 0.7 05:19:11 INFO - mozinfo == 0.9 05:19:11 INFO - mozleak == 0.1 05:19:11 INFO - mozlog == 3.1 05:19:11 INFO - moznetwork == 0.27 05:19:11 INFO - mozprocess == 0.22 05:19:11 INFO - mozprofile == 0.28 05:19:11 INFO - mozrunner == 6.11 05:19:11 INFO - mozscreenshot == 0.1 05:19:11 INFO - mozsystemmonitor == 0.0 05:19:11 INFO - moztest == 0.7 05:19:11 INFO - mozversion == 1.4 05:19:11 INFO - psutil == 3.1.1 05:19:11 INFO - requests == 1.2.3 05:19:11 INFO - wsgiref == 0.1.2 05:19:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:11 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')]} 05:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:11 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')]} 05:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:11 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 0x7faf73e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', '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 05:19:11 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 05:19:11 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 05:19:11 INFO - Using env: {'DISPLAY': ':0', 05:19:11 INFO - 'HOME': '/home/cltbld', 05:19:11 INFO - 'LANG': 'en_US.UTF-8', 05:19:11 INFO - 'LANGUAGE': 'en_US:en', 05:19:11 INFO - 'LOGNAME': 'cltbld', 05:19:11 INFO - 'MAIL': '/var/mail/cltbld', 05:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:11 INFO - 'MOZ_NO_REMOTE': '1', 05:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:11 INFO - 'NO_EM_RESTART': '1', 05:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:11 INFO - 'PWD': '/builds/slave/test', 05:19:11 INFO - 'SHELL': '/bin/bash', 05:19:11 INFO - 'SHLVL': '1', 05:19:11 INFO - 'TERM': 'linux', 05:19:11 INFO - 'TMOUT': '86400', 05:19:11 INFO - 'USER': 'cltbld', 05:19:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', 05:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:11 INFO - '_': '/tools/buildbot/bin/python'} 05:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:11 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)) 05:19:11 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)) 05:19:11 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)) 05:19:11 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)) 05:19:11 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)) 05:19:11 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)) 05:19:11 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)) 05:19:11 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)) 05:19:11 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)) 05:19:11 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)) 05:19:11 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)) 05:19:11 INFO - Cleaning up... 05:19:11 INFO - Return code: 0 05:19:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:19:11 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')]} 05:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:11 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')]} 05:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:11 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 0x7faf73e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', '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 05:19:11 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 05:19:11 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 05:19:11 INFO - Using env: {'DISPLAY': ':0', 05:19:11 INFO - 'HOME': '/home/cltbld', 05:19:11 INFO - 'LANG': 'en_US.UTF-8', 05:19:11 INFO - 'LANGUAGE': 'en_US:en', 05:19:11 INFO - 'LOGNAME': 'cltbld', 05:19:11 INFO - 'MAIL': '/var/mail/cltbld', 05:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:11 INFO - 'MOZ_NO_REMOTE': '1', 05:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:11 INFO - 'NO_EM_RESTART': '1', 05:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:11 INFO - 'PWD': '/builds/slave/test', 05:19:11 INFO - 'SHELL': '/bin/bash', 05:19:11 INFO - 'SHLVL': '1', 05:19:11 INFO - 'TERM': 'linux', 05:19:11 INFO - 'TMOUT': '86400', 05:19:11 INFO - 'USER': 'cltbld', 05:19:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', 05:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:11 INFO - '_': '/tools/buildbot/bin/python'} 05:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:11 INFO - Downloading/unpacking jsonschema 05:19:11 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 05:19:11 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 05:19:11 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 05:19:11 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 05:19:11 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 05:19:11 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 05:19:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:19:13 INFO - Downloading/unpacking functools32 (from jsonschema) 05:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:19:13 INFO - warning: no files found matching '*.txt' 05:19:13 INFO - no previously-included directories found matching 'build' 05:19:13 INFO - no previously-included directories found matching 'dist' 05:19:13 INFO - no previously-included directories found matching '.git*' 05:19:13 INFO - Installing collected packages: jsonschema, functools32 05:19:13 INFO - Running setup.py install for functools32 05:19:13 INFO - warning: no files found matching '*.txt' 05:19:13 INFO - no previously-included directories found matching 'build' 05:19:13 INFO - no previously-included directories found matching 'dist' 05:19:13 INFO - no previously-included directories found matching '.git*' 05:19:13 INFO - Successfully installed jsonschema functools32 05:19:13 INFO - Cleaning up... 05:19:13 INFO - Return code: 0 05:19:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:19: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')]} 05:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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')]} 05:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf73e43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', '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 05:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:19:13 INFO - Using env: {'DISPLAY': ':0', 05:19:13 INFO - 'HOME': '/home/cltbld', 05:19:13 INFO - 'LANG': 'en_US.UTF-8', 05:19:13 INFO - 'LANGUAGE': 'en_US:en', 05:19:13 INFO - 'LOGNAME': 'cltbld', 05:19:13 INFO - 'MAIL': '/var/mail/cltbld', 05:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:13 INFO - 'MOZ_NO_REMOTE': '1', 05:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:13 INFO - 'NO_EM_RESTART': '1', 05:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:13 INFO - 'PWD': '/builds/slave/test', 05:19:13 INFO - 'SHELL': '/bin/bash', 05:19:13 INFO - 'SHLVL': '1', 05:19:13 INFO - 'TERM': 'linux', 05:19:13 INFO - 'TMOUT': '86400', 05:19:13 INFO - 'USER': 'cltbld', 05:19:13 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', 05:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:13 INFO - '_': '/tools/buildbot/bin/python'} 05:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:14 INFO - Downloading/unpacking flake8 05:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:19:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:19:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:19:16 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 05:19:16 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 05:19:16 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 05:19:16 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 05:19:16 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 05:19:16 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 05:19:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:19:16 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 05:19:16 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 05:19:16 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 05:19:16 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 05:19:16 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 05:19:16 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 05:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:19:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:19:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:19:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:19:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:19:16 INFO - no previously-included directories found matching 'docs/_build' 05:19:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:19:16 INFO - Running setup.py install for pep8 05:19:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:19:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:19:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:19:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:19:16 INFO - no previously-included directories found matching 'docs/_build' 05:19:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:19:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:19:16 INFO - Cleaning up... 05:19:16 INFO - Return code: 0 05:19:16 INFO - Running post-action listener: _resource_record_post_action 05:19:16 INFO - Running post-action listener: _start_resource_monitoring 05:19:16 INFO - Starting resource monitoring. 05:19:16 INFO - ##### 05:19:16 INFO - ##### Running install step. 05:19:16 INFO - ##### 05:19:16 INFO - Running pre-action listener: _resource_record_pre_action 05:19:16 INFO - Running main action method: install 05:19:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:17 INFO - Reading from file tmpfile_stdout 05:19:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:19:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:19:17 INFO - Reading from file tmpfile_stdout 05:19:17 INFO - Output received: 05:19:17 INFO - Usage: mozinstall [options] installer 05:19:17 INFO - Options: 05:19:17 INFO - -h, --help show this help message and exit 05:19:17 INFO - -d DEST, --destination=DEST 05:19:17 INFO - Directory to install application into. [default: 05:19:17 INFO - "/builds/slave/test"] 05:19:17 INFO - --app=APP Application being installed. [default: firefox] 05:19:17 INFO - mkdir: /builds/slave/test/build/application 05:19:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:19:32 INFO - Reading from file tmpfile_stdout 05:19:32 INFO - Output received: 05:19:32 INFO - /builds/slave/test/build/application/firefox/firefox 05:19:32 INFO - Running post-action listener: _resource_record_post_action 05:19:32 INFO - ##### 05:19:32 INFO - ##### Running run-tests step. 05:19:32 INFO - ##### 05:19:32 INFO - Running pre-action listener: _resource_record_pre_action 05:19:32 INFO - Running main action method: run_tests 05:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:19:32 INFO - Python 2.7.3 05:19:32 INFO - Return code: 0 05:19:32 INFO - grabbing minidump binary from tooltool 05:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:32 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:19:32 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 05:19:32 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 05:19:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:19:32 INFO - Return code: 0 05:19:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:19:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:19:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:19:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:19:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:19:33 INFO - Return code: 0 05:19:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 05:19:33 INFO - Using env: {'DISPLAY': ':0', 05:19:33 INFO - 'HOME': '/home/cltbld', 05:19:33 INFO - 'LANG': 'en_US.UTF-8', 05:19:33 INFO - 'LANGUAGE': 'en_US:en', 05:19:33 INFO - 'LOGNAME': 'cltbld', 05:19:33 INFO - 'MAIL': '/var/mail/cltbld', 05:19:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:19:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:33 INFO - 'MOZ_NO_REMOTE': '1', 05:19:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:33 INFO - 'NO_EM_RESTART': '1', 05:19:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:33 INFO - 'PWD': '/builds/slave/test', 05:19:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:19:33 INFO - 'SHELL': '/bin/bash', 05:19:33 INFO - 'SHLVL': '1', 05:19:33 INFO - 'TERM': 'linux', 05:19:33 INFO - 'TMOUT': '86400', 05:19:33 INFO - 'USER': 'cltbld', 05:19:33 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563', 05:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:33 INFO - '_': '/tools/buildbot/bin/python'} 05:19:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:19:34 INFO - mozversion application_buildid: 20160506013122 05:19:34 INFO - mozversion application_changeset: b14d8e23323e95c5db3bc4cca69738edeee44302 05:19:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:19:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:19:34 INFO - mozversion application_name: Firefox 05:19:34 INFO - mozversion application_remotingname: firefox-dev 05:19:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:19:34 INFO - mozversion application_vendor: Mozilla 05:19:34 INFO - mozversion application_version: 48.0a2 05:19:34 INFO - mozversion platform_buildid: 20160506013122 05:19:34 INFO - mozversion platform_changeset: b14d8e23323e95c5db3bc4cca69738edeee44302 05:19:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:19:34 INFO - mozversion platform_version: 48.0a2 05:19:34 INFO - using testdate: 1462537174 05:19:34 INFO - actual date: 1462537174 05:19:34 INFO - starting webserver on 'localhost:39521' 05:19:34 INFO - SUITE-START | Running 2 tests 05:19:34 INFO - TEST-START | dromaeo_css 05:19:34 INFO - operating with platform_type : linux_ 05:19:34 INFO - Initialising browser for dromaeo_css test... 05:19:34 INFO - TEST-INFO | started process 31316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwYFlbd/profile http://localhost:39521/getInfo.html) 05:19:38 INFO - PROCESS | 31316 | __metrics Screen width/height:1600/1200 05:19:38 INFO - PROCESS | 31316 | colorDepth:24 05:19:38 INFO - PROCESS | 31316 | Browser inner width/height: 1024/697 05:19:38 INFO - PROCESS | 31316 | __metrics 05:19:39 ERROR - PROCESS | 31316 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:19:39 INFO - TEST-INFO | 31316: exit 0 05:19:39 INFO - Browser initialized. 05:19:39 INFO - Running cycle 1/1 for dromaeo_css test... 05:19:39 INFO - TEST-INFO | started process 31410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwYFlbd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:51 INFO - PROCESS | 31410 | RSS: Main: 142155776 05:19:51 INFO - PROCESS | 31410 | 05:20:42 INFO - PROCESS | 31410 | 1462537242949 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] 05:22:50 INFO - PROCESS | 31410 | Cycle 1(1): loaded http://localhost:39521/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39521/tests/dromaeo/cssquery-ext.html) 05:22:51 INFO - PROCESS | 31410 | RSS: Main: 251604992 05:22:51 INFO - PROCESS | 31410 | 05:25:54 INFO - PROCESS | 31410 | Cycle 1(1): loaded http://localhost:39521/tests/dromaeo/cssquery-ext.html (next: http://localhost:39521/tests/dromaeo/cssquery-jquery.html) 05:25:54 INFO - PROCESS | 31410 | RSS: Main: 224772096 05:25:54 INFO - PROCESS | 31410 | 05:28:56 INFO - PROCESS | 31410 | Cycle 1(1): loaded http://localhost:39521/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39521/tests/dromaeo/cssquery-mootools.html) 05:28:57 INFO - PROCESS | 31410 | RSS: Main: 223535104 05:28:57 INFO - PROCESS | 31410 | 05:31:58 INFO - PROCESS | 31410 | Cycle 1(1): loaded http://localhost:39521/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39521/tests/dromaeo/cssquery-prototype.html) 05:31:59 INFO - PROCESS | 31410 | RSS: Main: 221241344 05:31:59 INFO - PROCESS | 31410 | 05:35:01 INFO - PROCESS | 31410 | Cycle 1(1): loaded http://localhost:39521/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39521/tests/dromaeo/cssquery-yui.html) 05:35:02 INFO - PROCESS | 31410 | RSS: Main: 201216000 05:35:02 INFO - PROCESS | 31410 | 05:38:04 INFO - PROCESS | 31410 | Cycle 1(1): loaded http://localhost:39521/tests/dromaeo/cssquery-yui.html (next: http://localhost:39521/tests/dromaeo/cssquery-dojo.html) 05:38:05 INFO - PROCESS | 31410 | RSS: Main: 252260352 05:38:05 INFO - PROCESS | 31410 | 05:38:05 INFO - PROCESS | 31410 | __start_tp_report 05:38:05 INFO - PROCESS | 31410 | _x_x_mozilla_page_load 05:38:05 INFO - PROCESS | 31410 | _x_x_mozilla_page_load_details 05:38:05 INFO - PROCESS | 31410 | |i|pagename|runs| 05:38:05 INFO - PROCESS | 31410 | |0;dojo.html;3329.8834540791067;3345.514900339452;3345.8828940987064;3382.27281134556;3383.8984830455097;5524.033294173519;5528.336599608047;5542.584306177043;5544.251526043978;5555.3611334696525;5535.58483113766;5556.6943818089985;5561.4716601922855;5570.742151517419;5595.832125036245;4924.507549245065;5072;5085.23721441783;5133.974330128362;5164.328637277167;4945.060438516688;5023.346964894558;5025.346704928373;5027.472115427882;5031.371078615173;4937.382827146606;4984.950150498485;5058.291839142523;5068.06240845443;5082.313887625179;5074.416442109149;5084.694918304914;5094.490550944876;5098.286239926413;5125.513076257749;4887.828925987609;4952.430470495903;5001.049800537922;5021.39743230811;5050.494950504957;5381.327334083239;5415.350157981067;5424.620276580641;5430.5927055471;5457.781688732485;5913.142594323799;5972.313183983811;5972.581919265654;5973.074173503114;5978.760849566012;5903.409659034105;5961.850953726148;6007.60950538218;6025.698715064229;6026.276846778414;5628.32460104786;5648.519875810561;5654.85862853432;5676.971615141939;5682.801101961411;5892.292924849045;6169;6177.81466556004;6190.133381326528;6193.194884664965;5804.970975145182;5881.558883083786;5884.970130227193;5888.146218798251;5893.469587737039;5956.16613674086;5960.970195148997;5963.165156878041;5963.403659634002;5964.582479226499;5725.484706376446;5870.618409803349;5911;5920.822375328747;5924.6149000314845;5907.261592300963;5956.791512297049;5962.5826192167;5970.194023806817;5999.910001349983;4526.117407105583;4531.320301954733;4532;4536.500984891659;4562.794674239667;3904.4533765272886;3987.7009224308295;4056.411820286042;4069.593040695907;4095.2014357200655;5683;5698.031334673115;5700.743466544015;5704.771809127671;5727.599068065196;5960.433758792908;5960.910586341209;5965.880682386328;5966.910496342558;6007.128966299862;5531.806386776443;5593.608447408642;5621.606487545914;5706.115552089433;5720.656760594377;5101.464346243665;5108.463611320758;5111.923321150186;5114.872128196825;5116.590672746172;6118.724657390339;6125.846853828601;6140.232470941132;6142.57002009855;6154.015357542772;5714.257146570919;5949.910751338647;6027.246594175728;6065.72704228302;6067.878642427215;6171.660558669317;6181.061601561009;6208.534359922934;6215.627062376272;6219.626822390671;5733.483986441241;5879.735411906389;5883.882322353615;5896.49879760208;5924.11138329254;5967.134765458897;5996.8800623988145;6009.969950150221;6016.759329626766;6052.061930400795;5787.160861675117;5820.039693450533;5822.76708931655;5824.796132135355;5832.12518122285;5650.378458369494;5741.45456181662;5767.077267637158;5790.015697331548;5806.535477161901;5732.025555655465;5751.223584816164;5757.251557297524;5763.7982670606325;5801.158831969426;5866.120081987736;5866.882662346815;5876.794312199224;5886.381929897299;5889.175515427929;5594.244776955059;5759.337676167127;5760.279965004374;5787.971060144672;5862.179294898803 05:38:05 INFO - PROCESS | 31410 | |1;ext.html;667.1094089390663;677.5223467455445;685.8833998220302;693.7017082654459;754.4680999895074;31056.223594410123;31782.682173178262;31827.204319891986;39550.406743898864;40189.39715904264;42865.35701964473;43760.562394376044;43772.3434148488;43795.343069853974;43901.78049109758;7965.6813727450835;8849.33629977751;9058.139476749731;9062.77343066422;9064.637414503444;8149.877751833727;10284.177265818716;10534.894651053468;10548.472576371189;10554.788904221949;10717.946410267978;10827.83758243627;10838.295510791813;10853.023227909487;10856.402897840655;7978.162292959214;10534.104601108838;10693.358398496077;10835.349879007206;10842.837357439605;10656.467176641137;10801.783964320748;10811.513481893255;10818.188635852342;10841.024307812257;41641;42343.36484952728;42354.78822605898;42357.78821105906;42391;3490.110021944388;3529.7352698547456;3542.2384187399834;3566.144125409883;3584.8386822592784;33101;35234;35286;35533.82233088844;36186.63813361886;4160.313548264533;4225.345071513921;4236.491621005499;4244.816387709218;4339.132173565268;358804;360046;362324.9999999974;363543;363750.1812490947;36870.63129368672;37532.81233593814;68900.65549672219;70662;70753;38522.422163667565;38738;38789.806050969564;38874.22251555009;38881.80559097186;14775.40898364075;15016;15023.549293521211;15038.624034399227;15046.774298385533;10923.781524369628;11831.408429578487;12126.818097728541;12226.083043771752;12407.93796031014;9476.715698529055;9498;9546.18857397129;9615.711528654152;9630.422174669542;3654.6162652921594;3692.1508053147927;3701.446002258433;3725.3666876631037;3740.233252183296;1150.453534571072;1151.642990672894;1173.1084375874398;1215.5867005218092;1271.8219449277108;31845.52231716526;32833.34333313368;34378;34487;35190.824045880116;1186.258588382261;1193.6240084373394;1238.6160290310033;1309.4696647857634;1355.3968484024515;18429.26282948694;18488.352907648437;18578.44264672035;18578.907105464386;18639;539873;552119;553372;554217;554927;60546.394536054075;61185;61231.38768612346;61263.69368153131;61307;1351.1217708489364;1397.3781667158016;1522.9695406092037;1557.6183834960507;1615.878809089323;30858.074257772303;33393.66606333906;33505.162370940925;33817.661823382434;33912.83043584766;48747.5125248743;48852;49434.505654942994;49441.50558494513;49466.50533494619;301361;303557;303678;304012;304148;25813.225603231935;28597.42805143927;29145.7085429143;29192.70807291985;31204.687953121087;45160.32259516044;45164.77417612891;45585.54414455813;46516.30225546687;46673;37559.43660845144;38026.809865951596;38479.23041539098;38499.807500963434;38820.41769373518;37896.81051594725;38211.42682859815;38555.22889542249;38782.80608596939;39573.80213099031;39077.80461097676;39802;39844.80077599594;40587;40862.182756345304;30780.692193078678;31547.369052619277;31549.684503155593;31940.5208921871;34376.48435273523;29233.269168270963;29257.122286331443;29307.26731831636;29321.12036638904;29713.40573188481 05:38:05 INFO - PROCESS | 31410 | |2;jquery.html;435.44480786996553;438.05817492391355;441.28876151565333;448.32750873689486;450.3829753238064;19378.12798424071;19500;19759.1108400122;19759.5060123497;19984.400467985964;18731.719024214646;19059;19550.60898782027;19730.802691973076;19802.30691925783;5738.626989245696;5991.790287339944;6024.2168518092585;6025.638461692291;6040.214772079624;5682.460166284196;5916.704164791765;5978.282606087254;5979.1629171915965;5980.132880732292;5871.972404829159;5923.05231163014;5931.843290558343;5949.613275137124;5958.106284057383;5751.482366587006;6503.187101612299;6525.3800888915475;6542;6548.083268342436;5709.172170035363;5721.284839395075;5794.246747922743;5832.708364581754;5835.766569337221;13599.184048957095;13611.52359667407;13780.242086685228;13785.448582056706;17389.913050434792;2466.3217615155795;2532.202356257773;2554.3869471326934;2575.1115865026723;2587.159173268695;10648.733781655443;10760.3543787373;11238.943805281004;11314.208005439623;13164.802527962089;2038.3171637501455;2058.3516192399497;2149.183310342076;2164.9134034638596;2220.7779222077825;80699;82108.58945705234;82399.58800205961;83001.58499207525;83417.16582834216;10986.835197472044;11251.662450126509;11339.319640821412;11390;11570.826437603442;15845.683086338438;16021.839781602268;16033.759493607606;16064.919675401781;16065.839341606434;8019.278264956182;8120.228578285053;8194.385421093322;8244.917550824415;8262.586870656443;7703.34521565662;7736.187700291501;7837.49056311338;7915.485493442908;7916.525008499509;4676.392069031004;4720.622350212044;4777.95222047782;4808.35087263222;4923.606111511071;2027.9797202027792;2040.20611364157;2056.8354531637433;2118.7563430205414;2125.107454868959;997.9700608981742;1016.19278968174;1063.0963680871198;1095.1786160379716;1100.862392200975;18653.44039678812;19148.425547233604;19301.710474342897;19446.611067778565;19573.412797616093;1031.7008067660295;1060.9522571484147;1064.414571985405;1068.647346375694;1093.9179561532758;10249.795004099877;10784.352938823695;10915.257618833888;10929.344239345664;10934.617288395028;531483.7683927343;544423;548309;553158;564573;92968.53515732379;93745.5312723432;94632.52683736537;95383.52308238554;97564;1041.3699711674478;1057.1965306367217;1061.1086687182649;1068.7274744940146;1073.4042606353548;16471.423500177436;16986.660266794843;17270;17423.30306787765;17532.73700894462;28445.288867778472;39409.605903940595;39953.20093598054;40584.391234132105;41321;56523.15215271856;57722.134167986675;57776.71111644415;57887.710561446926;57945;8321.209485098905;8416.284615807725;8483.74548763538;8620.741377758677;8650.091740367423;12130.514779409077;13742.725145497234;13759.449622015007;13844.515441959886;13866.791998119834;11896.940515297369;12185.817212741993;12249.448774804978;12372.876271237532;12480.126391152533;7429.591372474566;9947.104760571294;11786.116041296766;11865.881341186823;11874.525018999144;11688.94155529217;11725.472353744273;12087.758244834878;12163;12246.387680615755;8581.914180858112;8591.914080859111;8644.956775216084;8788.912110879066;8828.690995815372;11818.704532386415;12214.389280536116;12304.200226985216;12382.133250672727;12389.442475088823 05:38:05 INFO - PROCESS | 31410 | |3;mootools.html;1373.4712135827704;1561.4691005058282;1581.2963231362046;1777.3246166456745;1855.2300795169997;8257.380696447768;8555.78610534737;8567.485950842954;8623.137686231381;8627.180417860292;8423.073461919184;8581.485110893334;8604.39769216155;8608.483490990546;8610.095939926312;2113.651247544161;2316.235642238066;2401.891914863835;2422.1764600036026;2466.0135945621714;2446.522928029035;2463.0394146282965;2483.0316176691103;2489.0790407549234;2492.0405643827075;2420.092465325503;2429.1983645396976;2433.197044975163;2436.4030812450887;2438.573249681299;2038.6432374334506;2338.8362814602983;2410.0480310277517;2422.842515236504;2428.2836563213896;2314.8148148148107;2324.140068174769;2324.779145981129;2350.5416443793465;2386.4033991502124;8556.144385561456;8622.913770862273;8624.482531048094;8626.309895208367;8647.913520864773;4974.577160941324;5177.637565370425;5241.580673546107;5246.317978662788;5249.816256431007;3350.229447227127;3420.3672320620763;3471.5139880416764;3472.635373285794;3500.6674365935196;1067.2689207892618;1071.9088877445427;1112.249231768553;1113.0539041814393;1140.1391949078393;12070.21543599672;12070.818937715942;12092.637220883387;12096.576619818265;12110.697232569257;4648.883777905512;4679.064187162581;4738.0523895221095;4780.139574876486;4781.235002399669;10296.38221706685;10300.484975751333;10315.948420258;10319.74200644975;10320.48397580118;4595.724256544551;5158.174692049329;5188.299579556711;5191;5196.090684130338;4615.930761038587;4724.858254252378;4727.858164255078;4745.691530050535;4757.381540399726;4048.3117869962175;4083.265012297815;4155.21051000315;4166.354215096665;4176.519700234451;1269.60642200918;1285.807128930668;1296.9481220751254;1298.4222021200476;1305.8824705776335;900.230303090861;920.4339331311329;1007.37039350406;1049.884512703602;1051.9526621301907;5895.852603684943;6040.879182416327;6116.021436570217;6158.969205153946;6168.167297414791;467.25706127257826;476.10492274523676;476.98092076317255;484.6801111266547;486.1298276085767;4045.7370270932297;4100.34394496879;4130.442390277334;4165.500139983222;4192.11965487245;10420.32267902584;10834.891651083546;10932.344059356305;10939.343639381663;10987.450627468595;10413.323133996266;10744.516496757664;10872.347659140476;10875.673729788119;10877.945610271898;8091.109977902426;8289.212524810133;8322.417430779788;8348.582570871433;8352.958235208907;5927.525797936069;6010.939890601038;6095.299040610386;6162.599431036968;6170.53720970938;9813.509324533887;9880.258980576342;9894.703158905244;9908.256880734118;9932.25508086882;10110.432882903162;10400.687979360631;10420.270581059252;10421.270511064457;10497.580096796042;6661.367170118831;6868.862622747617;7419.369353605004;7745.845083098194;7887.881681774663;8183.713570025258;8187.71343002992;8239.876401853857;8251.669933202606;8270.421070525006;7054.541454805421;7241.239669834592;7290.781276561712;7336.1930187678245;7373.115226172894;7328.853422931618;7376.852462950604;7384.261573842573;7385.593792341473;7473.775786726407;6943.65281735901;6955.965220174069;6987.895181572382;7009.474289428212;7016.982537531927;5140.177571588528;5291.497307755757;5321.5476684482255;5355.678659280456;5455.045367060828;5120.231965205249;5154.226865970135;5178.663386879841;5261.237120617566;5303.443138470405 05:38:05 INFO - PROCESS | 31410 | |4;prototype.html;362.3803296363219;362.945558166275;363.3115246607679;365.1765269317688;369.7725898572379;5423.891522169554;5513.038265560992;5516.862078448041;5545.306836645419;5593.57363872212;5350.250964864922;5394.244805727191;5425.891482170354;5441.2654291670615;5449.700266485342;4083.1629515949157;4162.916741665165;4200.495940487146;4201.684873634475;4227.175700738358;4193.874183774492;4243.151369726067;4244.469441319835;4247.723897946639;4286.97856510717;4225.492940847087;4228.619424251817;4229.746215227096;4234.491860976687;4235.390551590392;4148.606811145514;4201.516825565069;4238.766867822269;4253.8723838284905;4256.616904478612;3711.350513660099;3722.1389305347325;3722.8138593070507;3734.7572407793405;3742.419924911643;5255.448177941299;5266.526012658841;5321.042212401805;5330.893382132335;5341;4627.375304333906;4891.706497610119;4901.338319326881;4908.386451693538;4974.129527332702;5698.40166782486;5728.398518155617;5736.8852622947725;5743.913841292384;5756.481916627482;4152.107296931144;4153.127843152942;4165.10450253194;4185.66514678828;4201.495820501559;5741.856453588652;5911.793087241969;5920.851978700523;5955.13650520672;5957.344692083867;4193.035601811539;4202.285611446062;4205.453291072141;4206.927233555485;4217;4267.338562522814;4269.167512335127;4270.274053410928;4271.722338048017;4293.69944103916;4733.2900064989835;4822.445418776815;4848;4860.4896485869185;4893.975530122398;5707.800226992118;5720.227769251181;5721.313442386941;5723.885522289531;5760.596758226968;1522.3149582687836;1529.6940611877446;1536.5928029072304;1545.3741234799925;1549.1092621742544;1037.7457522906784;1045.5817672930737;1049.7795462952713;1068.695421804782;1082.2640604389092;6013.609115407485;6031.728572214261;6033.456988871023;6052.547388626698;6061.515078793686;6338.334474880164;6354.523410744213;6369.904451433232;6379.202599675041;6387.01001344783;5807.332156801937;5951.315598706205;5976.372480889444;5983.76876486701;5988.850278743066;3318.4192766265805;3363.428217203081;3372.4772660237704;3376.298960831325;3397.4224381855142;6409.583377080568;6454.773103279361;6519.380658837403;6539.50953678476;6557.803265902031;5688.687122208318;5818.185454036438;6312.926802443596;6361.809145725543;6365.108884756138;6061.272647282354;6063.878722425527;6110.816675499742;6125.908111378333;6136.447719705248;5641.8589535261945;5771.711414429178;5885.882282354243;5894.764209431574;5943.257092863392;5829.5336373090895;5848.444397782204;5854.677992710272;5874.853128671817;5876.147958545901;5783.884322313615;6086.452219300284;6096.359882212304;6127.6936153193055;6168.784092556739;4274.081072569413;4292.527821939647;4323.848665296699;4324.200022995756;4335.588119128678;5819.534437244925;5821.534277257894;5842.88985092831;5857.832601937311;5877.617954832922;5588.3573389060775;5716.942830571641;5722.055860782924;5761.164631128547;5771.134329850556;5616.466435688603;5653.180288858175;5663.461971112738;5666.405027472056;5670.716464176857;5560.331900429936;5577.944220557904;5578.330600327987;5593.804216852391;5618;5530.446955304437;5565.443455654402;5712.914306285492;5730.799422020376;5731.025725626737;5557.138643510262;5572.832815015556;5582.302212223472;5595.608307418442;5613.88772224545 05:38:05 INFO - PROCESS | 31410 | |5;yui.html;771.6141929035479;778.346189201071;784.6155383861908;792.405695728204;800.0559339978827;13699.589012329634;14193.219372934485;14199.574012779633;14270.857291427095;14272.143671379712;13150.408231629575;13198.670033249173;13224.140430871987;13232.404541795619;13256.668583285422;727.8835386338187;874.1782724239226;900.6892622045384;904.0778406025883;909.7316291693933;894.6019021535387;900.7117722328858;903.661127077346;905.8369493491169;905.868649045888;949.7910459698855;954.1126752120525;957.3824882950493;957.6456711016933;957.9329446938717;759.1573353577525;931.329442801182;959.52023988006;959.7840485890689;960.2989817433313;701.6491754122939;705.9964700176517;706.0397858911875;706.6996526476279;706.8480276740526;13537.59387218385;13563.796543051862;13577.117487363388;13586.320683965761;13595.660108497268;13589.388477518436;14523.854761452356;14769.556913292618;14903.105813651217;14936;10561.524731387106;10732.839007414896;10748.086412654933;10924.126069914388;10931.453427328603;4605.125026245037;4619.607333376667;4621.4685311189305;4636.675432719711;4713.6464765142755;53133.734331328094;53229;53343.46656533424;53595.73202134003;54249.728751356386;10388.168946484264;10578.259521833397;10723.892761072446;10770.407627580558;10804.13566914645;19717.507062323555;20056.69914951277;20089.799102009085;20107.798922010592;20140.697889531668;8150.796230094295;8156.143604921516;8200.179982001751;8250.257476827115;8328.958355208306;4705.576498115186;4767.213409787346;4823.397075365579;4883.633727470454;4940.036692844933;3675.320065787838;3729.850805967731;3753.3619284721663;3756.0609847538117;3762.680172185395;587.9412058794172;649.4382359259207;655.9278479367266;663.4559661077869;683.0198664915763;577.2582231832075;601.3054921565512;633.1673848888788;685.9245482996866;693.6185098196073;8820.8676869847;9094.590743416562;9158.587863546156;9209.58441041954;9356.298277629205;603.242930122702;612.935641757618;628.9654069026155;658.6574981009944;662.7713438863584;4343.782810859508;4557.840475583405;4611.515790841913;4612.067897410482;4668.719876807402;66550.33449665441;67737;71079.64460177666;72635;73027.63486182535;58688;60789.69605151946;61128;61888;64145.679271603345;46623.76688116538;47957.52042479531;48552.5144748548;52447.47552524502;52503.47496525062;9533.666321678707;9606.375585586915;9663.46850923206;9848.507574621384;9865.852012219679;33993;34847.47728784121;35660.28679426449;35982.64017359898;36408.81795591005;42971.14057718765;44242.115157696026;46391;47193.52806472029;48725.512744872096;13056.241738983894;13159.73680526365;13239.271840048505;13381.330933453482;13764.449422023006;13516.79724804109;13596.524121655695;13635.454581817014;13972.860271397563;14222.502212422516;12356.876431235572;12529.874701252871;12779.04157188196;13138.737225255632;13263.20420774718;12690.555830545887;12906.354682266037;13057.412416441473;13072.869271307165;13110.410031548412;12610.747785044432;12815.102942793916;12919.289439080942;12948.611541653765;13010.869891300967;10725.356478611307;10773.138148948223;10774.24580279373;10903.127749780157;10964.232503724663;9511.904880951102;9611;9615.5672994714;9694.75763105928;9956.402615843073 05:38:05 INFO - PROCESS | 31410 | __end_tp_report 05:38:05 INFO - PROCESS | 31410 | __start_cc_report 05:38:05 INFO - PROCESS | 31410 | _x_x_mozilla_cycle_collect,908 05:38:05 INFO - PROCESS | 31410 | __end_cc_report 05:38:05 INFO - PROCESS | 31410 | __startTimestamp1462538285201__endTimestamp 05:38:05 INFO - PROCESS | 31410 | 05:38:05 INFO - PROCESS | 31410 | ------- Summary: start ------- 05:38:05 INFO - PROCESS | 31410 | Number of tests: 6 05:38:05 INFO - PROCESS | 31410 | 05:38:05 INFO - PROCESS | 31410 | [#0] dojo.html Cycles:165 Average:5532.67 Median:5751.22 stddev:624.00 (10.8%) stddev-sans-first:601.51 05:38:05 INFO - PROCESS | 31410 | Values: 3329.9 3345.5 3345.9 3382.3 3383.9 5524.0 5528.3 5542.6 5544.3 5555.4 5535.6 5556.7 5561.5 5570.7 5595.8 4924.5 5072.0 5085.2 5134.0 5164.3 4945.1 5023.3 5025.3 5027.5 5031.4 4937.4 4985.0 5058.3 5068.1 5082.3 5074.4 5084.7 5094.5 5098.3 5125.5 4887.8 4952.4 5001.0 5021.4 5050.5 5381.3 5415.4 5424.6 5430.6 5457.8 5913.1 5972.3 5972.6 5973.1 5978.8 5903.4 5961.9 6007.6 6025.7 6026.3 5628.3 5648.5 5654.9 5677.0 5682.8 5892.3 6169.0 6177.8 6190.1 6193.2 5805.0 5881.6 5885.0 5888.1 5893.5 5956.2 5961.0 5963.2 5963.4 5964.6 5725.5 5870.6 5911.0 5920.8 5924.6 5907.3 5956.8 5962.6 5970.2 5999.9 4526.1 4531.3 4532.0 4536.5 4562.8 3904.5 3987.7 4056.4 4069.6 4095.2 5683.0 5698.0 5700.7 5704.8 5727.6 5960.4 5960.9 5965.9 5966.9 6007.1 5531.8 5593.6 5621.6 5706.1 5720.7 5101.5 5108.5 5111.9 5114.9 5116.6 6118.7 6125.8 6140.2 6142.6 6154.0 5714.3 5949.9 6027.2 6065.7 6067.9 6171.7 6181.1 6208.5 6215.6 6219.6 5733.5 5879.7 5883.9 5896.5 5924.1 5967.1 5996.9 6010.0 6016.8 6052.1 5787.2 5820.0 5822.8 5824.8 5832.1 5650.4 5741.5 5767.1 5790.0 5806.5 5732.0 5751.2 5757.3 5763.8 5801.2 5866.1 5866.9 5876.8 5886.4 5889.2 5594.2 5759.3 5760.3 5788.0 5862.2 05:38:05 INFO - PROCESS | 31410 | 05:38:05 INFO - PROCESS | 31410 | [#1] ext.html Cycles:180 Average:56089.03 Median:359425.00 stddev:111291.69 (31.0%) stddev-sans-first:111526.10 05:38:05 INFO - PROCESS | 31410 | Values: 667.1 677.5 685.9 693.7 754.5 31056.2 31782.7 31827.2 39550.4 40189.4 42865.4 43760.6 43772.3 43795.3 43901.8 7965.7 8849.3 9058.1 9062.8 9064.6 8149.9 10284.2 10534.9 10548.5 10554.8 10717.9 10827.8 10838.3 10853.0 10856.4 7978.2 10534.1 10693.4 10835.3 10842.8 10656.5 10801.8 10811.5 10818.2 10841.0 41641.0 42343.4 42354.8 42357.8 42391.0 3490.1 3529.7 3542.2 3566.1 3584.8 33101.0 35234.0 35286.0 35533.8 36186.6 4160.3 4225.3 4236.5 4244.8 4339.1 358804.0 360046.0 362325.0 363543.0 363750.2 36870.6 37532.8 68900.7 70662.0 70753.0 38522.4 38738.0 38789.8 38874.2 38881.8 14775.4 15016.0 15023.5 15038.6 15046.8 10923.8 11831.4 12126.8 12226.1 12407.9 9476.7 9498.0 9546.2 9615.7 9630.4 3654.6 3692.2 3701.4 3725.4 3740.2 1150.5 1151.6 1173.1 1215.6 1271.8 31845.5 32833.3 34378.0 34487.0 35190.8 1186.3 1193.6 1238.6 1309.5 1355.4 18429.3 18488.4 18578.4 18578.9 18639.0 539873.0 552119.0 553372.0 554217.0 554927.0 60546.4 61185.0 61231.4 61263.7 61307.0 1351.1 1397.4 1523.0 1557.6 1615.9 30858.1 33393.7 33505.2 33817.7 33912.8 48747.5 48852.0 49434.5 49441.5 49466.5 301361.0 303557.0 303678.0 304012.0 304148.0 25813.2 28597.4 29145.7 29192.7 31204.7 45160.3 45164.8 45585.5 46516.3 46673.0 37559.4 38026.8 38479.2 38499.8 38820.4 37896.8 38211.4 38555.2 38782.8 39573.8 39077.8 39802.0 39844.8 40587.0 40862.2 30780.7 31547.4 31549.7 31940.5 34376.5 29233.3 29257.1 29307.3 29321.1 29713.4 05:38:05 INFO - PROCESS | 31410 | 05:38:05 INFO - PROCESS | 31410 | [#2] jquery.html Cycles:180 Average:30533.30 Median:2192.85 stddev:90211.91 (4113.9%) stddev-sans-first:90436.67 05:38:05 INFO - PROCESS | 31410 | Values: 435.4 438.1 441.3 448.3 450.4 19378.1 19500.0 19759.1 19759.5 19984.4 18731.7 19059.0 19550.6 19730.8 19802.3 5738.6 5991.8 6024.2 6025.6 6040.2 5682.5 5916.7 5978.3 5979.2 5980.1 5872.0 5923.1 5931.8 5949.6 5958.1 5751.5 6503.2 6525.4 6542.0 6548.1 5709.2 5721.3 5794.2 5832.7 5835.8 13599.2 13611.5 13780.2 13785.4 17389.9 2466.3 2532.2 2554.4 2575.1 2587.2 10648.7 10760.4 11238.9 11314.2 13164.8 2038.3 2058.4 2149.2 2164.9 2220.8 80699.0 82108.6 82399.6 83001.6 83417.2 10986.8 11251.7 11339.3 11390.0 11570.8 15845.7 16021.8 16033.8 16064.9 16065.8 8019.3 8120.2 8194.4 8244.9 8262.6 7703.3 7736.2 7837.5 7915.5 7916.5 4676.4 4720.6 4778.0 4808.4 4923.6 2028.0 2040.2 2056.8 2118.8 2125.1 998.0 1016.2 1063.1 1095.2 1100.9 18653.4 19148.4 19301.7 19446.6 19573.4 1031.7 1061.0 1064.4 1068.6 1093.9 10249.8 10784.4 10915.3 10929.3 10934.6 531483.8 544423.0 548309.0 553158.0 564573.0 92968.5 93745.5 94632.5 95383.5 97564.0 1041.4 1057.2 1061.1 1068.7 1073.4 16471.4 16986.7 17270.0 17423.3 17532.7 28445.3 39409.6 39953.2 40584.4 41321.0 56523.2 57722.1 57776.7 57887.7 57945.0 8321.2 8416.3 8483.7 8620.7 8650.1 12130.5 13742.7 13759.4 13844.5 13866.8 11896.9 12185.8 12249.4 12372.9 12480.1 7429.6 9947.1 11786.1 11865.9 11874.5 11688.9 11725.5 12087.8 12163.0 12246.4 8581.9 8591.9 8645.0 8788.9 8828.7 11818.7 12214.4 12304.2 12382.1 12389.4 05:38:05 INFO - PROCESS | 31410 | 05:38:05 INFO - PROCESS | 31410 | [#3] mootools.html Cycles:180 Average:5745.75 Median:4741.87 stddev:3240.63 (68.3%) stddev-sans-first:3233.06 05:38:05 INFO - PROCESS | 31410 | Values: 1373.5 1561.5 1581.3 1777.3 1855.2 8257.4 8555.8 8567.5 8623.1 8627.2 8423.1 8581.5 8604.4 8608.5 8610.1 2113.7 2316.2 2401.9 2422.2 2466.0 2446.5 2463.0 2483.0 2489.1 2492.0 2420.1 2429.2 2433.2 2436.4 2438.6 2038.6 2338.8 2410.0 2422.8 2428.3 2314.8 2324.1 2324.8 2350.5 2386.4 8556.1 8622.9 8624.5 8626.3 8647.9 4974.6 5177.6 5241.6 5246.3 5249.8 3350.2 3420.4 3471.5 3472.6 3500.7 1067.3 1071.9 1112.2 1113.1 1140.1 12070.2 12070.8 12092.6 12096.6 12110.7 4648.9 4679.1 4738.1 4780.1 4781.2 10296.4 10300.5 10315.9 10319.7 10320.5 4595.7 5158.2 5188.3 5191.0 5196.1 4615.9 4724.9 4727.9 4745.7 4757.4 4048.3 4083.3 4155.2 4166.4 4176.5 1269.6 1285.8 1296.9 1298.4 1305.9 900.2 920.4 1007.4 1049.9 1052.0 5895.9 6040.9 6116.0 6159.0 6168.2 467.3 476.1 477.0 484.7 486.1 4045.7 4100.3 4130.4 4165.5 4192.1 10420.3 10834.9 10932.3 10939.3 10987.5 10413.3 10744.5 10872.3 10875.7 10877.9 8091.1 8289.2 8322.4 8348.6 8353.0 5927.5 6010.9 6095.3 6162.6 6170.5 9813.5 9880.3 9894.7 9908.3 9932.3 10110.4 10400.7 10420.3 10421.3 10497.6 6661.4 6868.9 7419.4 7745.8 7887.9 8183.7 8187.7 8239.9 8251.7 8270.4 7054.5 7241.2 7290.8 7336.2 7373.1 7328.9 7376.9 7384.3 7385.6 7473.8 6943.7 6956.0 6987.9 7009.5 7017.0 5140.2 5291.5 5321.5 5355.7 5455.0 5120.2 5154.2 5178.7 5261.2 5303.4 05:38:05 INFO - PROCESS | 31410 | 05:38:05 INFO - PROCESS | 31410 | [#4] prototype.html Cycles:180 Average:4888.48 Median:5558.74 stddev:1438.41 (25.9%) stddev-sans-first:1401.75 05:38:05 INFO - PROCESS | 31410 | Values: 362.4 362.9 363.3 365.2 369.8 5423.9 5513.0 5516.9 5545.3 5593.6 5350.3 5394.2 5425.9 5441.3 5449.7 4083.2 4162.9 4200.5 4201.7 4227.2 4193.9 4243.2 4244.5 4247.7 4287.0 4225.5 4228.6 4229.7 4234.5 4235.4 4148.6 4201.5 4238.8 4253.9 4256.6 3711.4 3722.1 3722.8 3734.8 3742.4 5255.4 5266.5 5321.0 5330.9 5341.0 4627.4 4891.7 4901.3 4908.4 4974.1 5698.4 5728.4 5736.9 5743.9 5756.5 4152.1 4153.1 4165.1 4185.7 4201.5 5741.9 5911.8 5920.9 5955.1 5957.3 4193.0 4202.3 4205.5 4206.9 4217.0 4267.3 4269.2 4270.3 4271.7 4293.7 4733.3 4822.4 4848.0 4860.5 4894.0 5707.8 5720.2 5721.3 5723.9 5760.6 1522.3 1529.7 1536.6 1545.4 1549.1 1037.7 1045.6 1049.8 1068.7 1082.3 6013.6 6031.7 6033.5 6052.5 6061.5 6338.3 6354.5 6369.9 6379.2 6387.0 5807.3 5951.3 5976.4 5983.8 5988.9 3318.4 3363.4 3372.5 3376.3 3397.4 6409.6 6454.8 6519.4 6539.5 6557.8 5688.7 5818.2 6312.9 6361.8 6365.1 6061.3 6063.9 6110.8 6125.9 6136.4 5641.9 5771.7 5885.9 5894.8 5943.3 5829.5 5848.4 5854.7 5874.9 5876.1 5783.9 6086.5 6096.4 6127.7 6168.8 4274.1 4292.5 4323.8 4324.2 4335.6 5819.5 5821.5 5842.9 5857.8 5877.6 5588.4 5716.9 5722.1 5761.2 5771.1 5616.5 5653.2 5663.5 5666.4 5670.7 5560.3 5577.9 5578.3 5593.8 5618.0 5530.4 5565.4 5712.9 5730.8 5731.0 5557.1 5572.8 5582.3 5595.6 5613.9 05:38:05 INFO - PROCESS | 31410 | 05:38:05 INFO - PROCESS | 31410 | [#5] yui.html Cycles:180 Average:15304.55 Median:25980.37 stddev:18132.32 (69.8%) stddev-sans-first:18150.34 05:38:05 INFO - PROCESS | 31410 | Values: 771.6 778.3 784.6 792.4 800.1 13699.6 14193.2 14199.6 14270.9 14272.1 13150.4 13198.7 13224.1 13232.4 13256.7 727.9 874.2 900.7 904.1 909.7 894.6 900.7 903.7 905.8 905.9 949.8 954.1 957.4 957.6 957.9 759.2 931.3 959.5 959.8 960.3 701.6 706.0 706.0 706.7 706.8 13537.6 13563.8 13577.1 13586.3 13595.7 13589.4 14523.9 14769.6 14903.1 14936.0 10561.5 10732.8 10748.1 10924.1 10931.5 4605.1 4619.6 4621.5 4636.7 4713.6 53133.7 53229.0 53343.5 53595.7 54249.7 10388.2 10578.3 10723.9 10770.4 10804.1 19717.5 20056.7 20089.8 20107.8 20140.7 8150.8 8156.1 8200.2 8250.3 8329.0 4705.6 4767.2 4823.4 4883.6 4940.0 3675.3 3729.9 3753.4 3756.1 3762.7 587.9 649.4 655.9 663.5 683.0 577.3 601.3 633.2 685.9 693.6 8820.9 9094.6 9158.6 9209.6 9356.3 603.2 612.9 629.0 658.7 662.8 4343.8 4557.8 4611.5 4612.1 4668.7 66550.3 67737.0 71079.6 72635.0 73027.6 58688.0 60789.7 61128.0 61888.0 64145.7 46623.8 47957.5 48552.5 52447.5 52503.5 9533.7 9606.4 9663.5 9848.5 9865.9 33993.0 34847.5 35660.3 35982.6 36408.8 42971.1 44242.1 46391.0 47193.5 48725.5 13056.2 13159.7 13239.3 13381.3 13764.4 13516.8 13596.5 13635.5 13972.9 14222.5 12356.9 12529.9 12779.0 13138.7 13263.2 12690.6 12906.4 13057.4 13072.9 13110.4 12610.7 12815.1 12919.3 12948.6 13010.9 10725.4 10773.1 10774.2 10903.1 10964.2 9511.9 9611.0 9615.6 9694.8 9956.4 05:38:05 INFO - PROCESS | 31410 | -------- Summary: end -------- 05:38:05 INFO - PROCESS | 31410 | 05:38:05 INFO - TEST-INFO | 31410: exit 0 05:38:05 INFO - TEST-OK | dromaeo_css | took 1111821ms 05:38:05 INFO - TEST-START | kraken 05:38:05 INFO - operating with platform_type : linux_ 05:38:05 INFO - Initialising browser for kraken test... 05:38:05 INFO - TEST-INFO | started process 31598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp337vRp/profile http://localhost:39521/getInfo.html) 05:38:09 INFO - PROCESS | 31598 | __metrics Screen width/height:1600/1200 05:38:09 INFO - PROCESS | 31598 | colorDepth:24 05:38:09 INFO - PROCESS | 31598 | Browser inner width/height: 1024/697 05:38:09 INFO - PROCESS | 31598 | __metrics 05:38:11 ERROR - PROCESS | 31598 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:38:11 INFO - TEST-INFO | 31598: exit 0 05:38:11 INFO - Browser initialized. 05:38:11 INFO - Running cycle 1/1 for kraken test... 05:38:11 INFO - TEST-INFO | started process 31689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp337vRp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:23 INFO - PROCESS | 31689 | RSS: Main: 142438400 05:38:23 INFO - PROCESS | 31689 | 05:38:26 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39521/tests/kraken/driver.html?testName=audio-beat-detection) 05:38:26 INFO - PROCESS | 31689 | RSS: Main: 197160960 05:38:26 INFO - PROCESS | 31689 | 05:38:29 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39521/tests/kraken/driver.html?testName=audio-dft) 05:38:30 INFO - PROCESS | 31689 | RSS: Main: 182407168 05:38:30 INFO - PROCESS | 31689 | 05:38:32 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39521/tests/kraken/driver.html?testName=audio-fft) 05:38:33 INFO - PROCESS | 31689 | RSS: Main: 273264640 05:38:33 INFO - PROCESS | 31689 | 05:38:35 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39521/tests/kraken/driver.html?testName=audio-oscillator) 05:38:36 INFO - PROCESS | 31689 | RSS: Main: 179499008 05:38:36 INFO - PROCESS | 31689 | 05:38:38 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39521/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:38:39 INFO - PROCESS | 31689 | RSS: Main: 177790976 05:38:39 INFO - PROCESS | 31689 | 05:38:41 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39521/tests/kraken/driver.html?testName=imaging-darkroom) 05:38:42 INFO - PROCESS | 31689 | RSS: Main: 212402176 05:38:42 INFO - PROCESS | 31689 | 05:38:45 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39521/tests/kraken/driver.html?testName=imaging-desaturate) 05:38:46 INFO - PROCESS | 31689 | RSS: Main: 212942848 05:38:46 INFO - PROCESS | 31689 | 05:38:49 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39521/tests/kraken/driver.html?testName=json-parse-financial) 05:38:49 INFO - PROCESS | 31689 | RSS: Main: 212389888 05:38:49 INFO - PROCESS | 31689 | 05:38:51 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39521/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:38:51 INFO - PROCESS | 31689 | RSS: Main: 193703936 05:38:51 INFO - PROCESS | 31689 | 05:38:53 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39521/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:54 INFO - PROCESS | 31689 | RSS: Main: 197005312 05:38:54 INFO - PROCESS | 31689 | 05:38:56 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39521/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:56 INFO - PROCESS | 31689 | RSS: Main: 209199104 05:38:56 INFO - PROCESS | 31689 | 05:38:59 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:38:59 INFO - PROCESS | 31689 | RSS: Main: 214245376 05:38:59 INFO - PROCESS | 31689 | 05:39:02 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:39:03 INFO - PROCESS | 31689 | RSS: Main: 207900672 05:39:03 INFO - PROCESS | 31689 | 05:39:04 INFO - PROCESS | 31689 | Cycle 1(1): loaded http://localhost:39521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39521/tests/kraken/driver.html?testName=ai-astar) 05:39:05 INFO - PROCESS | 31689 | RSS: Main: 271458304 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | __start_tp_report 05:39:05 INFO - PROCESS | 31689 | _x_x_mozilla_page_load 05:39:05 INFO - PROCESS | 31689 | _x_x_mozilla_page_load_details 05:39:05 INFO - PROCESS | 31689 | |i|pagename|runs| 05:39:05 INFO - PROCESS | 31689 | |0;ai-astar;110;110;111;109;111;110;105;108;109;109 05:39:05 INFO - PROCESS | 31689 | |1;audio-beat-detection;148;126;160;176;137;156;151;129;187;124 05:39:05 INFO - PROCESS | 31689 | |2;audio-dft;163;159;159;160;161;159;159;160;161;160 05:39:05 INFO - PROCESS | 31689 | |3;audio-fft;74;75;76;176;75;77;74;76;170;76 05:39:05 INFO - PROCESS | 31689 | |4;audio-oscillator;92;91;144;91;91;92;141;92;91;145 05:39:05 INFO - PROCESS | 31689 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;116;117;116 05:39:05 INFO - PROCESS | 31689 | |6;imaging-darkroom;144;146;145;145;145;145;145;145;145;145 05:39:05 INFO - PROCESS | 31689 | |7;imaging-desaturate;94;94;95;94;94;94;94;94;95;94 05:39:05 INFO - PROCESS | 31689 | |8;json-parse-financial;55;54;53;53;54;57;54;76;54;51 05:39:05 INFO - PROCESS | 31689 | |9;json-stringify-tinderbox;59;60;58;58;58;57;62;58;57;58 05:39:05 INFO - PROCESS | 31689 | |10;stanford-crypto-aes;72;72;73;72;73;75;72;73;74;72 05:39:05 INFO - PROCESS | 31689 | |11;stanford-crypto-ccm;120;117;117;116;115;119;117;125;163;121 05:39:05 INFO - PROCESS | 31689 | |12;stanford-crypto-pbkdf2;164;168;163;157;159;164;155;164;161;159 05:39:05 INFO - PROCESS | 31689 | |13;stanford-crypto-sha256-iterative;66;67;67;66;66;65;66;66;64;64 05:39:05 INFO - PROCESS | 31689 | __end_tp_report 05:39:05 INFO - PROCESS | 31689 | __start_cc_report 05:39:05 INFO - PROCESS | 31689 | _x_x_mozilla_cycle_collect,1654 05:39:05 INFO - PROCESS | 31689 | __end_cc_report 05:39:05 INFO - PROCESS | 31689 | __startTimestamp1462538345138__endTimestamp 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | ------- Summary: start ------- 05:39:05 INFO - PROCESS | 31689 | Number of tests: 14 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:1.75 (1.6%) stddev-sans-first:1.83 05:39:05 INFO - PROCESS | 31689 | Values: 110.0 110.0 111.0 109.0 111.0 110.0 105.0 108.0 109.0 109.0 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:153.50 stddev:21.20 (13.8%) stddev-sans-first:22.48 05:39:05 INFO - PROCESS | 31689 | Values: 148.0 126.0 160.0 176.0 137.0 156.0 151.0 129.0 187.0 124.0 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.29 (0.8%) stddev-sans-first:0.83 05:39:05 INFO - PROCESS | 31689 | Values: 163.0 159.0 159.0 160.0 161.0 159.0 159.0 160.0 161.0 160.0 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.50 stddev:41.20 (54.6%) stddev-sans-first:43.00 05:39:05 INFO - PROCESS | 31689 | Values: 74.0 75.0 76.0 176.0 75.0 77.0 74.0 76.0 170.0 76.0 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#4] audio-oscillator Cycles:10 Average:107.00 Median:91.00 stddev:25.10 (27.6%) stddev-sans-first:26.02 05:39:05 INFO - PROCESS | 31689 | Values: 92.0 91.0 144.0 91.0 91.0 92.0 141.0 92.0 91.0 145.0 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:39:05 INFO - PROCESS | 31689 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 05:39:05 INFO - PROCESS | 31689 | Values: 144.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:39:05 INFO - PROCESS | 31689 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:54.00 stddev:7.16 (13.3%) stddev-sans-first:7.58 05:39:05 INFO - PROCESS | 31689 | Values: 55.0 54.0 53.0 53.0 54.0 57.0 54.0 76.0 54.0 51.0 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.00 stddev:1.51 (2.6%) stddev-sans-first:1.59 05:39:05 INFO - PROCESS | 31689 | Values: 59.0 60.0 58.0 58.0 58.0 57.0 62.0 58.0 57.0 58.0 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:73.00 stddev:1.03 (1.4%) stddev-sans-first:1.05 05:39:05 INFO - PROCESS | 31689 | Values: 72.0 72.0 73.0 72.0 73.0 75.0 72.0 73.0 74.0 72.0 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:119.50 stddev:14.35 (12.0%) stddev-sans-first:15.18 05:39:05 INFO - PROCESS | 31689 | Values: 120.0 117.0 117.0 116.0 115.0 119.0 117.0 125.0 163.0 121.0 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:163.50 stddev:3.92 (2.4%) stddev-sans-first:4.04 05:39:05 INFO - PROCESS | 31689 | Values: 164.0 168.0 163.0 157.0 159.0 164.0 155.0 164.0 161.0 159.0 05:39:05 INFO - PROCESS | 31689 | 05:39:05 INFO - PROCESS | 31689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 05:39:05 INFO - PROCESS | 31689 | Values: 66.0 67.0 67.0 66.0 66.0 65.0 66.0 66.0 64.0 64.0 05:39:05 INFO - PROCESS | 31689 | -------- Summary: end -------- 05:39:05 INFO - PROCESS | 31689 | 05:39:06 INFO - TEST-INFO | 31689: exit 0 05:39:06 INFO - TEST-OK | kraken | took 60241ms 05:39:06 INFO - SUITE-END | took 1172s 05:39:06 INFO - Completed test suite (00:19:32) 05:39:06 INFO - javascript benchmark 05:39:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.8834540791067, 3345.514900339452, 3345.8828940987064, 3382.27281134556, 3383.8984830455097, 5524.033294173519, 5528.336599608047, 5542.584306177043, 5544.251526043978, 5555.3611334696525, 5535.58483113766, 5556.6943818089985, 5561.4716601922855, 5570.742151517419, 5595.832125036245, 4924.507549245065, 5072.0, 5085.23721441783, 5133.974330128362, 5164.328637277167, 4945.060438516688, 5023.346964894558, 5025.346704928373, 5027.472115427882, 5031.371078615173, 4937.382827146606, 4984.950150498485, 5058.291839142523, 5068.06240845443, 5082.313887625179, 5074.416442109149, 5084.694918304914, 5094.490550944876, 5098.286239926413, 5125.513076257749, 4887.828925987609, 4952.430470495903, 5001.049800537922, 5021.39743230811, 5050.494950504957, 5381.327334083239, 5415.350157981067, 5424.620276580641, 5430.5927055471, 5457.781688732485, 5913.142594323799, 5972.313183983811, 5972.581919265654, 5973.074173503114, 5978.760849566012, 5903.409659034105, 5961.850953726148, 6007.60950538218, 6025.698715064229, 6026.276846778414, 5628.32460104786, 5648.519875810561, 5654.85862853432, 5676.971615141939, 5682.801101961411, 5892.292924849045, 6169.0, 6177.81466556004, 6190.133381326528, 6193.194884664965, 5804.970975145182, 5881.558883083786, 5884.970130227193, 5888.146218798251, 5893.469587737039, 5956.16613674086, 5960.970195148997, 5963.165156878041, 5963.403659634002, 5964.582479226499, 5725.484706376446, 5870.618409803349, 5911.0, 5920.822375328747, 5924.6149000314845, 5907.261592300963, 5956.791512297049, 5962.5826192167, 5970.194023806817, 5999.910001349983, 4526.117407105583, 4531.320301954733, 4532.0, 4536.500984891659, 4562.794674239667, 3904.4533765272886, 3987.7009224308295, 4056.411820286042, 4069.593040695907, 4095.2014357200655, 5683.0, 5698.031334673115, 5700.743466544015, 5704.771809127671, 5727.599068065196, 5960.433758792908, 5960.910586341209, 5965.880682386328, 5966.910496342558, 6007.128966299862, 5531.806386776443, 5593.608447408642, 5621.606487545914, 5706.115552089433, 5720.656760594377, 5101.464346243665, 5108.463611320758, 5111.923321150186, 5114.872128196825, 5116.590672746172, 6118.724657390339, 6125.846853828601, 6140.232470941132, 6142.57002009855, 6154.015357542772, 5714.257146570919, 5949.910751338647, 6027.246594175728, 6065.72704228302, 6067.878642427215, 6171.660558669317, 6181.061601561009, 6208.534359922934, 6215.627062376272, 6219.626822390671, 5733.483986441241, 5879.735411906389, 5883.882322353615, 5896.49879760208, 5924.11138329254, 5967.134765458897, 5996.8800623988145, 6009.969950150221, 6016.759329626766, 6052.061930400795, 5787.160861675117, 5820.039693450533, 5822.76708931655, 5824.796132135355, 5832.12518122285, 5650.378458369494, 5741.45456181662, 5767.077267637158, 5790.015697331548, 5806.535477161901, 5732.025555655465, 5751.223584816164, 5757.251557297524, 5763.7982670606325, 5801.158831969426, 5866.120081987736, 5866.882662346815, 5876.794312199224, 5886.381929897299, 5889.175515427929, 5594.244776955059, 5759.337676167127, 5760.279965004374, 5787.971060144672, 5862.179294898803], "value": 5491.644547704448, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.1094089390663, 677.5223467455445, 685.8833998220302, 693.7017082654459, 754.4680999895074, 31056.223594410123, 31782.682173178262, 31827.204319891986, 39550.406743898864, 40189.39715904264, 42865.35701964473, 43760.562394376044, 43772.3434148488, 43795.343069853974, 43901.78049109758, 7965.6813727450835, 8849.33629977751, 9058.139476749731, 9062.77343066422, 9064.637414503444, 8149.877751833727, 10284.177265818716, 10534.894651053468, 10548.472576371189, 10554.788904221949, 10717.946410267978, 10827.83758243627, 10838.295510791813, 10853.023227909487, 10856.402897840655, 7978.162292959214, 10534.104601108838, 10693.358398496077, 10835.349879007206, 10842.837357439605, 10656.467176641137, 10801.783964320748, 10811.513481893255, 10818.188635852342, 10841.024307812257, 41641.0, 42343.36484952728, 42354.78822605898, 42357.78821105906, 42391.0, 3490.110021944388, 3529.7352698547456, 3542.2384187399834, 3566.144125409883, 3584.8386822592784, 33101.0, 35234.0, 35286.0, 35533.82233088844, 36186.63813361886, 4160.313548264533, 4225.345071513921, 4236.491621005499, 4244.816387709218, 4339.132173565268, 358804.0, 360046.0, 362324.9999999974, 363543.0, 363750.1812490947, 36870.63129368672, 37532.81233593814, 68900.65549672219, 70662.0, 70753.0, 38522.422163667565, 38738.0, 38789.806050969564, 38874.22251555009, 38881.80559097186, 14775.40898364075, 15016.0, 15023.549293521211, 15038.624034399227, 15046.774298385533, 10923.781524369628, 11831.408429578487, 12126.818097728541, 12226.083043771752, 12407.93796031014, 9476.715698529055, 9498.0, 9546.18857397129, 9615.711528654152, 9630.422174669542, 3654.6162652921594, 3692.1508053147927, 3701.446002258433, 3725.3666876631037, 3740.233252183296, 1150.453534571072, 1151.642990672894, 1173.1084375874398, 1215.5867005218092, 1271.8219449277108, 31845.52231716526, 32833.34333313368, 34378.0, 34487.0, 35190.824045880116, 1186.258588382261, 1193.6240084373394, 1238.6160290310033, 1309.4696647857634, 1355.3968484024515, 18429.26282948694, 18488.352907648437, 18578.44264672035, 18578.907105464386, 18639.0, 539873.0, 552119.0, 553372.0, 554217.0, 554927.0, 60546.394536054075, 61185.0, 61231.38768612346, 61263.69368153131, 61307.0, 1351.1217708489364, 1397.3781667158016, 1522.9695406092037, 1557.6183834960507, 1615.878809089323, 30858.074257772303, 33393.66606333906, 33505.162370940925, 33817.661823382434, 33912.83043584766, 48747.5125248743, 48852.0, 49434.505654942994, 49441.50558494513, 49466.50533494619, 301361.0, 303557.0, 303678.0, 304012.0, 304148.0, 25813.225603231935, 28597.42805143927, 29145.7085429143, 29192.70807291985, 31204.687953121087, 45160.32259516044, 45164.77417612891, 45585.54414455813, 46516.30225546687, 46673.0, 37559.43660845144, 38026.809865951596, 38479.23041539098, 38499.807500963434, 38820.41769373518, 37896.81051594725, 38211.42682859815, 38555.22889542249, 38782.80608596939, 39573.80213099031, 39077.80461097676, 39802.0, 39844.80077599594, 40587.0, 40862.182756345304, 30780.692193078678, 31547.369052619277, 31549.684503155593, 31940.5208921871, 34376.48435273523, 29233.269168270963, 29257.122286331443, 29307.26731831636, 29321.12036638904, 29713.40573188481], "value": 19358.08221172269, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.44480786996553, 438.05817492391355, 441.28876151565333, 448.32750873689486, 450.3829753238064, 19378.12798424071, 19500.0, 19759.1108400122, 19759.5060123497, 19984.400467985964, 18731.719024214646, 19059.0, 19550.60898782027, 19730.802691973076, 19802.30691925783, 5738.626989245696, 5991.790287339944, 6024.2168518092585, 6025.638461692291, 6040.214772079624, 5682.460166284196, 5916.704164791765, 5978.282606087254, 5979.1629171915965, 5980.132880732292, 5871.972404829159, 5923.05231163014, 5931.843290558343, 5949.613275137124, 5958.106284057383, 5751.482366587006, 6503.187101612299, 6525.3800888915475, 6542.0, 6548.083268342436, 5709.172170035363, 5721.284839395075, 5794.246747922743, 5832.708364581754, 5835.766569337221, 13599.184048957095, 13611.52359667407, 13780.242086685228, 13785.448582056706, 17389.913050434792, 2466.3217615155795, 2532.202356257773, 2554.3869471326934, 2575.1115865026723, 2587.159173268695, 10648.733781655443, 10760.3543787373, 11238.943805281004, 11314.208005439623, 13164.802527962089, 2038.3171637501455, 2058.3516192399497, 2149.183310342076, 2164.9134034638596, 2220.7779222077825, 80699.0, 82108.58945705234, 82399.58800205961, 83001.58499207525, 83417.16582834216, 10986.835197472044, 11251.662450126509, 11339.319640821412, 11390.0, 11570.826437603442, 15845.683086338438, 16021.839781602268, 16033.759493607606, 16064.919675401781, 16065.839341606434, 8019.278264956182, 8120.228578285053, 8194.385421093322, 8244.917550824415, 8262.586870656443, 7703.34521565662, 7736.187700291501, 7837.49056311338, 7915.485493442908, 7916.525008499509, 4676.392069031004, 4720.622350212044, 4777.95222047782, 4808.35087263222, 4923.606111511071, 2027.9797202027792, 2040.20611364157, 2056.8354531637433, 2118.7563430205414, 2125.107454868959, 997.9700608981742, 1016.19278968174, 1063.0963680871198, 1095.1786160379716, 1100.862392200975, 18653.44039678812, 19148.425547233604, 19301.710474342897, 19446.611067778565, 19573.412797616093, 1031.7008067660295, 1060.9522571484147, 1064.414571985405, 1068.647346375694, 1093.9179561532758, 10249.795004099877, 10784.352938823695, 10915.257618833888, 10929.344239345664, 10934.617288395028, 531483.7683927343, 544423.0, 548309.0, 553158.0, 564573.0, 92968.53515732379, 93745.5312723432, 94632.52683736537, 95383.52308238554, 97564.0, 1041.3699711674478, 1057.1965306367217, 1061.1086687182649, 1068.7274744940146, 1073.4042606353548, 16471.423500177436, 16986.660266794843, 17270.0, 17423.30306787765, 17532.73700894462, 28445.288867778472, 39409.605903940595, 39953.20093598054, 40584.391234132105, 41321.0, 56523.15215271856, 57722.134167986675, 57776.71111644415, 57887.710561446926, 57945.0, 8321.209485098905, 8416.284615807725, 8483.74548763538, 8620.741377758677, 8650.091740367423, 12130.514779409077, 13742.725145497234, 13759.449622015007, 13844.515441959886, 13866.791998119834, 11896.940515297369, 12185.817212741993, 12249.448774804978, 12372.876271237532, 12480.126391152533, 7429.591372474566, 9947.104760571294, 11786.116041296766, 11865.881341186823, 11874.525018999144, 11688.94155529217, 11725.472353744273, 12087.758244834878, 12163.0, 12246.387680615755, 8581.914180858112, 8591.914080859111, 8644.956775216084, 8788.912110879066, 8828.690995815372, 11818.704532386415, 12214.389280536116, 12304.200226985216, 12382.133250672727, 12389.442475088823], "value": 9378.51933431077, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.4712135827704, 1561.4691005058282, 1581.2963231362046, 1777.3246166456745, 1855.2300795169997, 8257.380696447768, 8555.78610534737, 8567.485950842954, 8623.137686231381, 8627.180417860292, 8423.073461919184, 8581.485110893334, 8604.39769216155, 8608.483490990546, 8610.095939926312, 2113.651247544161, 2316.235642238066, 2401.891914863835, 2422.1764600036026, 2466.0135945621714, 2446.522928029035, 2463.0394146282965, 2483.0316176691103, 2489.0790407549234, 2492.0405643827075, 2420.092465325503, 2429.1983645396976, 2433.197044975163, 2436.4030812450887, 2438.573249681299, 2038.6432374334506, 2338.8362814602983, 2410.0480310277517, 2422.842515236504, 2428.2836563213896, 2314.8148148148107, 2324.140068174769, 2324.779145981129, 2350.5416443793465, 2386.4033991502124, 8556.144385561456, 8622.913770862273, 8624.482531048094, 8626.309895208367, 8647.913520864773, 4974.577160941324, 5177.637565370425, 5241.580673546107, 5246.317978662788, 5249.816256431007, 3350.229447227127, 3420.3672320620763, 3471.5139880416764, 3472.635373285794, 3500.6674365935196, 1067.2689207892618, 1071.9088877445427, 1112.249231768553, 1113.0539041814393, 1140.1391949078393, 12070.21543599672, 12070.818937715942, 12092.637220883387, 12096.576619818265, 12110.697232569257, 4648.883777905512, 4679.064187162581, 4738.0523895221095, 4780.139574876486, 4781.235002399669, 10296.38221706685, 10300.484975751333, 10315.948420258, 10319.74200644975, 10320.48397580118, 4595.724256544551, 5158.174692049329, 5188.299579556711, 5191.0, 5196.090684130338, 4615.930761038587, 4724.858254252378, 4727.858164255078, 4745.691530050535, 4757.381540399726, 4048.3117869962175, 4083.265012297815, 4155.21051000315, 4166.354215096665, 4176.519700234451, 1269.60642200918, 1285.807128930668, 1296.9481220751254, 1298.4222021200476, 1305.8824705776335, 900.230303090861, 920.4339331311329, 1007.37039350406, 1049.884512703602, 1051.9526621301907, 5895.852603684943, 6040.879182416327, 6116.021436570217, 6158.969205153946, 6168.167297414791, 467.25706127257826, 476.10492274523676, 476.98092076317255, 484.6801111266547, 486.1298276085767, 4045.7370270932297, 4100.34394496879, 4130.442390277334, 4165.500139983222, 4192.11965487245, 10420.32267902584, 10834.891651083546, 10932.344059356305, 10939.343639381663, 10987.450627468595, 10413.323133996266, 10744.516496757664, 10872.347659140476, 10875.673729788119, 10877.945610271898, 8091.109977902426, 8289.212524810133, 8322.417430779788, 8348.582570871433, 8352.958235208907, 5927.525797936069, 6010.939890601038, 6095.299040610386, 6162.599431036968, 6170.53720970938, 9813.509324533887, 9880.258980576342, 9894.703158905244, 9908.256880734118, 9932.25508086882, 10110.432882903162, 10400.687979360631, 10420.270581059252, 10421.270511064457, 10497.580096796042, 6661.367170118831, 6868.862622747617, 7419.369353605004, 7745.845083098194, 7887.881681774663, 8183.713570025258, 8187.71343002992, 8239.876401853857, 8251.669933202606, 8270.421070525006, 7054.541454805421, 7241.239669834592, 7290.781276561712, 7336.1930187678245, 7373.115226172894, 7328.853422931618, 7376.852462950604, 7384.261573842573, 7385.593792341473, 7473.775786726407, 6943.65281735901, 6955.965220174069, 6987.895181572382, 7009.474289428212, 7016.982537531927, 5140.177571588528, 5291.497307755757, 5321.5476684482255, 5355.678659280456, 5455.045367060828, 5120.231965205249, 5154.226865970135, 5178.663386879841, 5261.237120617566, 5303.443138470405], "value": 4556.688450130018, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.3803296363219, 362.945558166275, 363.3115246607679, 365.1765269317688, 369.7725898572379, 5423.891522169554, 5513.038265560992, 5516.862078448041, 5545.306836645419, 5593.57363872212, 5350.250964864922, 5394.244805727191, 5425.891482170354, 5441.2654291670615, 5449.700266485342, 4083.1629515949157, 4162.916741665165, 4200.495940487146, 4201.684873634475, 4227.175700738358, 4193.874183774492, 4243.151369726067, 4244.469441319835, 4247.723897946639, 4286.97856510717, 4225.492940847087, 4228.619424251817, 4229.746215227096, 4234.491860976687, 4235.390551590392, 4148.606811145514, 4201.516825565069, 4238.766867822269, 4253.8723838284905, 4256.616904478612, 3711.350513660099, 3722.1389305347325, 3722.8138593070507, 3734.7572407793405, 3742.419924911643, 5255.448177941299, 5266.526012658841, 5321.042212401805, 5330.893382132335, 5341.0, 4627.375304333906, 4891.706497610119, 4901.338319326881, 4908.386451693538, 4974.129527332702, 5698.40166782486, 5728.398518155617, 5736.8852622947725, 5743.913841292384, 5756.481916627482, 4152.107296931144, 4153.127843152942, 4165.10450253194, 4185.66514678828, 4201.495820501559, 5741.856453588652, 5911.793087241969, 5920.851978700523, 5955.13650520672, 5957.344692083867, 4193.035601811539, 4202.285611446062, 4205.453291072141, 4206.927233555485, 4217.0, 4267.338562522814, 4269.167512335127, 4270.274053410928, 4271.722338048017, 4293.69944103916, 4733.2900064989835, 4822.445418776815, 4848.0, 4860.4896485869185, 4893.975530122398, 5707.800226992118, 5720.227769251181, 5721.313442386941, 5723.885522289531, 5760.596758226968, 1522.3149582687836, 1529.6940611877446, 1536.5928029072304, 1545.3741234799925, 1549.1092621742544, 1037.7457522906784, 1045.5817672930737, 1049.7795462952713, 1068.695421804782, 1082.2640604389092, 6013.609115407485, 6031.728572214261, 6033.456988871023, 6052.547388626698, 6061.515078793686, 6338.334474880164, 6354.523410744213, 6369.904451433232, 6379.202599675041, 6387.01001344783, 5807.332156801937, 5951.315598706205, 5976.372480889444, 5983.76876486701, 5988.850278743066, 3318.4192766265805, 3363.428217203081, 3372.4772660237704, 3376.298960831325, 3397.4224381855142, 6409.583377080568, 6454.773103279361, 6519.380658837403, 6539.50953678476, 6557.803265902031, 5688.687122208318, 5818.185454036438, 6312.926802443596, 6361.809145725543, 6365.108884756138, 6061.272647282354, 6063.878722425527, 6110.816675499742, 6125.908111378333, 6136.447719705248, 5641.8589535261945, 5771.711414429178, 5885.882282354243, 5894.764209431574, 5943.257092863392, 5829.5336373090895, 5848.444397782204, 5854.677992710272, 5874.853128671817, 5876.147958545901, 5783.884322313615, 6086.452219300284, 6096.359882212304, 6127.6936153193055, 6168.784092556739, 4274.081072569413, 4292.527821939647, 4323.848665296699, 4324.200022995756, 4335.588119128678, 5819.534437244925, 5821.534277257894, 5842.88985092831, 5857.832601937311, 5877.617954832922, 5588.3573389060775, 5716.942830571641, 5722.055860782924, 5761.164631128547, 5771.134329850556, 5616.466435688603, 5653.180288858175, 5663.461971112738, 5666.405027472056, 5670.716464176857, 5560.331900429936, 5577.944220557904, 5578.330600327987, 5593.804216852391, 5618.0, 5530.446955304437, 5565.443455654402, 5712.914306285492, 5730.799422020376, 5731.025725626737, 5557.138643510262, 5572.832815015556, 5582.302212223472, 5595.608307418442, 5613.88772224545], "value": 4443.756924176205, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.6141929035479, 778.346189201071, 784.6155383861908, 792.405695728204, 800.0559339978827, 13699.589012329634, 14193.219372934485, 14199.574012779633, 14270.857291427095, 14272.143671379712, 13150.408231629575, 13198.670033249173, 13224.140430871987, 13232.404541795619, 13256.668583285422, 727.8835386338187, 874.1782724239226, 900.6892622045384, 904.0778406025883, 909.7316291693933, 894.6019021535387, 900.7117722328858, 903.661127077346, 905.8369493491169, 905.868649045888, 949.7910459698855, 954.1126752120525, 957.3824882950493, 957.6456711016933, 957.9329446938717, 759.1573353577525, 931.329442801182, 959.52023988006, 959.7840485890689, 960.2989817433313, 701.6491754122939, 705.9964700176517, 706.0397858911875, 706.6996526476279, 706.8480276740526, 13537.59387218385, 13563.796543051862, 13577.117487363388, 13586.320683965761, 13595.660108497268, 13589.388477518436, 14523.854761452356, 14769.556913292618, 14903.105813651217, 14936.0, 10561.524731387106, 10732.839007414896, 10748.086412654933, 10924.126069914388, 10931.453427328603, 4605.125026245037, 4619.607333376667, 4621.4685311189305, 4636.675432719711, 4713.6464765142755, 53133.734331328094, 53229.0, 53343.46656533424, 53595.73202134003, 54249.728751356386, 10388.168946484264, 10578.259521833397, 10723.892761072446, 10770.407627580558, 10804.13566914645, 19717.507062323555, 20056.69914951277, 20089.799102009085, 20107.798922010592, 20140.697889531668, 8150.796230094295, 8156.143604921516, 8200.179982001751, 8250.257476827115, 8328.958355208306, 4705.576498115186, 4767.213409787346, 4823.397075365579, 4883.633727470454, 4940.036692844933, 3675.320065787838, 3729.850805967731, 3753.3619284721663, 3756.0609847538117, 3762.680172185395, 587.9412058794172, 649.4382359259207, 655.9278479367266, 663.4559661077869, 683.0198664915763, 577.2582231832075, 601.3054921565512, 633.1673848888788, 685.9245482996866, 693.6185098196073, 8820.8676869847, 9094.590743416562, 9158.587863546156, 9209.58441041954, 9356.298277629205, 603.242930122702, 612.935641757618, 628.9654069026155, 658.6574981009944, 662.7713438863584, 4343.782810859508, 4557.840475583405, 4611.515790841913, 4612.067897410482, 4668.719876807402, 66550.33449665441, 67737.0, 71079.64460177666, 72635.0, 73027.63486182535, 58688.0, 60789.69605151946, 61128.0, 61888.0, 64145.679271603345, 46623.76688116538, 47957.52042479531, 48552.5144748548, 52447.47552524502, 52503.47496525062, 9533.666321678707, 9606.375585586915, 9663.46850923206, 9848.507574621384, 9865.852012219679, 33993.0, 34847.47728784121, 35660.28679426449, 35982.64017359898, 36408.81795591005, 42971.14057718765, 44242.115157696026, 46391.0, 47193.52806472029, 48725.512744872096, 13056.241738983894, 13159.73680526365, 13239.271840048505, 13381.330933453482, 13764.449422023006, 13516.79724804109, 13596.524121655695, 13635.454581817014, 13972.860271397563, 14222.502212422516, 12356.876431235572, 12529.874701252871, 12779.04157188196, 13138.737225255632, 13263.20420774718, 12690.555830545887, 12906.354682266037, 13057.412416441473, 13072.869271307165, 13110.410031548412, 12610.747785044432, 12815.102942793916, 12919.289439080942, 12948.611541653765, 13010.869891300967, 10725.356478611307, 10773.138148948223, 10774.24580279373, 10903.127749780157, 10964.232503724663, 9511.904880951102, 9611.0, 9615.5672994714, 9694.75763105928, 9956.402615843073], "value": 6923.68032647823, "unit": "score"}], "name": "dromaeo_css", "value": 7204.097634444292, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 111.0, 109.0, 111.0, 110.0, 105.0, 108.0, 109.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 126.0, 160.0, 176.0, 137.0, 156.0, 151.0, 129.0, 187.0, 124.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 159.0, 160.0, 161.0, 159.0, 159.0, 160.0, 161.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 176.0, 75.0, 77.0, 74.0, 76.0, 170.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 144.0, 91.0, 91.0, 92.0, 141.0, 92.0, 91.0, 145.0], "value": 107.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 53.0, 54.0, 57.0, 54.0, 76.0, 54.0, 51.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 58.0, 58.0, 57.0, 62.0, 58.0, 57.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 72.0, 73.0, 75.0, 72.0, 73.0, 74.0, 72.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 117.0, 116.0, 115.0, 119.0, 117.0, 125.0, 163.0, 121.0], "value": 123.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 163.0, 157.0, 159.0, 164.0, 155.0, 164.0, 161.0, 159.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0, 64.0, 64.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1513.8000000000002, "alertThreshold": 2.0}]} 05:39:06 INFO - Return code: 0 05:39:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:39:06 ERROR - # TBPL SUCCESS # 05:39:06 INFO - Running post-action listener: _resource_record_post_action 05:39:06 INFO - Running post-run listener: _resource_record_post_run 05:39:07 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 20480; Write bytes: 499232768; Read time: 44; Write time: 473280 05:39:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 255254528; Read time: 0; Write time: 284376 05:39:07 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 20480; Write bytes: 243978240; Read time: 44; Write time: 188904 05:39:07 INFO - Running post-run listener: _upload_blobber_files 05:39:07 INFO - Blob upload gear active. 05:39:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:39:07 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 05:39:07 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:39:07 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:39:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:39:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:39:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:39:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:08 INFO - (blobuploader) - INFO - Done attempting. 05:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:39:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:09 INFO - (blobuploader) - INFO - Done attempting. 05:39:09 INFO - (blobuploader) - INFO - Iteration through files over. 05:39:09 INFO - Return code: 0 05:39:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:39:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:39:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c319218cf0361f6c4c9e53d4c9df25b15812dcd3c644d3762cf5944409bd7c02bb9453dc3b1aa1f14271b0c33baa1d3b56916307b6af8ed0523558eaf340b2fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52bff0712683f0baf2a0d4ff786492bfe0687af95820fd91c562b24198f7820c65902c50b891a63746013e1795dc5ff7dc39b6631463350c98104960c96fc551"} 05:39:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:39:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:39:09 INFO - Contents: 05:39:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c319218cf0361f6c4c9e53d4c9df25b15812dcd3c644d3762cf5944409bd7c02bb9453dc3b1aa1f14271b0c33baa1d3b56916307b6af8ed0523558eaf340b2fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52bff0712683f0baf2a0d4ff786492bfe0687af95820fd91c562b24198f7820c65902c50b891a63746013e1795dc5ff7dc39b6631463350c98104960c96fc551"} 05:39:09 INFO - Running post-run listener: copy_logs_to_upload_dir 05:39:09 INFO - Copying logs to upload dir... 05:39:09 INFO - mkdir: /builds/slave/test/build/upload/logs 05:39:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.938171 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-06 05:39:09.377886) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 05:39:09.381890) ========= 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=920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563 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-Aurora/sha512/c319218cf0361f6c4c9e53d4c9df25b15812dcd3c644d3762cf5944409bd7c02bb9453dc3b1aa1f14271b0c33baa1d3b56916307b6af8ed0523558eaf340b2fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52bff0712683f0baf2a0d4ff786492bfe0687af95820fd91c562b24198f7820c65902c50b891a63746013e1795dc5ff7dc39b6631463350c98104960c96fc551"} build_url:https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c319218cf0361f6c4c9e53d4c9df25b15812dcd3c644d3762cf5944409bd7c02bb9453dc3b1aa1f14271b0c33baa1d3b56916307b6af8ed0523558eaf340b2fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52bff0712683f0baf2a0d4ff786492bfe0687af95820fd91c562b24198f7820c65902c50b891a63746013e1795dc5ff7dc39b6631463350c98104960c96fc551"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 05:39:09.406994) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:39:09.407322) ========= 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=920470bf432669ad7e3a5387000001ca-1462537121.292653-1158507563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:39:09.490002) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 05:39:09.490316) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 05:39:09.490646) ========= ========= Total master_lag: 0.21 =========