builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1462532804.64 results: success (0) buildid: 20160506013122 builduid: edd2de8de4ca48969474bf5b1f92b92a revision: b14d8e23323e95c5db3bc4cca69738edeee44302 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:44.635887) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:44.636596) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:44.637079) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:44.655742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:44.656330) ========= 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=aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 04:06:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 138M=0s 2016-05-06 04:06:44 (138 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094464 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:44.765257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:44.765602) ========= 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=aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017616 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:44.815333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:44.815700) ========= 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=aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 04:06:45,050 truncating revision to first 12 chars 2016-05-06 04:06:45,050 Setting DEBUG logging. 2016-05-06 04:06:45,050 attempt 1/10 2016-05-06 04:06:45,050 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 04:06:45,343 unpacking tar archive at: mozilla-aurora-b14d8e23323e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613889 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:45.440094) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:45.440434) ========= script_repo_revision: b14d8e23323e95c5db3bc4cca69738edeee44302 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:45.440840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:45.441121) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 04:06:45.449480) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-06 04:06:45.449801) ========= /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=aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:06:45 INFO - MultiFileLogger online at 20160506 04:06:45 in /builds/slave/test 04:06:45 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 04:06:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:06:45 INFO - {'append_to_log': False, 04:06:45 INFO - 'base_work_dir': '/builds/slave/test', 04:06:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:06:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:06:45 INFO - 'branch': 'Mozilla-Aurora', 04:06:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:06:45 INFO - 'config_files': ('talos/linux_config.py',), 04:06:45 INFO - 'default_actions': ('clobber', 04:06:45 INFO - 'read-buildbot-config', 04:06:45 INFO - 'download-and-extract', 04:06:45 INFO - 'populate-webroot', 04:06:45 INFO - 'create-virtualenv', 04:06:45 INFO - 'install', 04:06:45 INFO - 'run-tests'), 04:06:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:06:45 INFO - 'download_minidump_stackwalk': True, 04:06:45 INFO - 'download_symbols': 'ondemand', 04:06:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:06:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:06:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:06:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:06:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:06:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:06:45 INFO - 'installer_path': 'installer.exe', 04:06:45 INFO - 'log_level': 'info', 04:06:45 INFO - 'log_name': 'talos', 04:06:45 INFO - 'log_to_console': True, 04:06:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:06:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:06:45 INFO - 'opt_config_files': (), 04:06:45 INFO - 'pip_index': False, 04:06:45 INFO - 'sps_profile': False, 04:06:45 INFO - 'sps_profile_interval': 0, 04:06:45 INFO - 'suite': 'dromaeojs', 04:06:45 INFO - 'system_bits': '32', 04:06:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:45 INFO - 'title': 'talos-linux64-ix-037', 04:06:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:06:45 INFO - 'use_talos_json': True, 04:06:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:06:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:06:45 INFO - 'work_dir': 'build'} 04:06:45 INFO - ##### 04:06:45 INFO - ##### Running clobber step. 04:06:45 INFO - ##### 04:06:45 INFO - Running pre-action listener: _resource_record_pre_action 04:06:45 INFO - Running main action method: clobber 04:06:45 INFO - rmtree: /builds/slave/test/build 04:06:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:06:46 INFO - Running post-action listener: _resource_record_post_action 04:06:46 INFO - ##### 04:06:46 INFO - ##### Running read-buildbot-config step. 04:06:46 INFO - ##### 04:06:46 INFO - Running pre-action listener: _resource_record_pre_action 04:06:46 INFO - Running main action method: read_buildbot_config 04:06:46 INFO - Using buildbot properties: 04:06:46 INFO - { 04:06:46 INFO - "project": "", 04:06:46 INFO - "product": "firefox", 04:06:46 INFO - "script_repo_revision": "production", 04:06:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:06:46 INFO - "repository": "", 04:06:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:06:46 INFO - "buildid": "20160506013122", 04:06:46 INFO - "pgo_build": "True", 04:06:46 INFO - "basedir": "/builds/slave/test", 04:06:46 INFO - "buildnumber": 306, 04:06:46 INFO - "slavename": "talos-linux64-ix-037", 04:06:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:06:46 INFO - "platform": "ubuntu64_hw", 04:06:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:06:46 INFO - "branch": "mozilla-aurora", 04:06:46 INFO - "repo_path": "releases/mozilla-aurora", 04:06:46 INFO - "revision": "b14d8e23323e95c5db3bc4cca69738edeee44302", 04:06:46 INFO - "stage_platform": "linux64-pgo", 04:06:46 INFO - "builduid": "edd2de8de4ca48969474bf5b1f92b92a", 04:06:46 INFO - "slavebuilddir": "test" 04:06:46 INFO - } 04:06:46 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. 04:06:46 INFO - Running post-action listener: _resource_record_post_action 04:06:46 INFO - ##### 04:06:46 INFO - ##### Running download-and-extract step. 04:06:46 INFO - ##### 04:06:46 INFO - Running pre-action listener: _resource_record_pre_action 04:06:46 INFO - Running main action method: download_and_extract 04:06:46 INFO - mkdir: /builds/slave/test/build/tests 04:06: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')]} 04:06:46 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 04:06: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.test_packages.json 04:06: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.test_packages.json 04:06: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.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:06:46 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 04:06:46 INFO - Downloaded 1361 bytes. 04:06:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:06:46 INFO - Using the following test package requirements: 04:06:46 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:06:46 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:06:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:06:46 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:06:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:06:46 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:06:46 INFO - u'jsshell-linux-x86_64.zip'], 04:06:46 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:06:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:06:46 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:06:46 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:06:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:06:46 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:06:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:06:46 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:06:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:06:46 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:06:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:06:46 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:06: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')]} 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:50 INFO - Downloaded 23822984 bytes. 04:06:50 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'] 04:06:50 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 04:06:51 INFO - Return code: 0 04:06:51 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 04:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:51 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 04:06:51 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 04:06:51 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 04:06:51 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 04:06:51 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 04:06:55 INFO - Downloaded 23822984 bytes. 04:06:55 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'] 04:06:55 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 04:06:57 INFO - Return code: 0 04:06:57 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')]} 04:06:57 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 04:06:57 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 04:06:57 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 04:06:57 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 04:06:57 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 04:06:58 INFO - Downloaded 10840145 bytes. 04:06:58 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'] 04:06:58 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 04:06:58 INFO - Return code: 0 04:06: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')]} 04:06:58 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 04:06:58 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 04:06:58 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 04:06:58 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 04:06:58 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 04:07:06 INFO - Downloaded 62693495 bytes. 04:07:06 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 04:07:06 INFO - mkdir: /builds/slave/test/properties 04:07:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:07:06 INFO - Writing to file /builds/slave/test/properties/build_url 04:07:06 INFO - Contents: 04:07:06 INFO - build_url:https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:07:07 INFO - Running post-action listener: _resource_record_post_action 04:07:07 INFO - Running post-action listener: set_extra_try_arguments 04:07:07 INFO - ##### 04:07:07 INFO - ##### Running populate-webroot step. 04:07:07 INFO - ##### 04:07:07 INFO - Running pre-action listener: _resource_record_pre_action 04:07:07 INFO - Running main action method: populate_webroot 04:07:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:07:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:07:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:07:07 INFO - '--tppagecycles', 04:07:07 INFO - '7'], 04:07:07 INFO - 'tests': ['tsvgm']}}, 04:07:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:07:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:07:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:07:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:07:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:07:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:07:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:07 INFO - 'talos_options': ['--disable-e10s'], 04:07:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:07 INFO - 'talos_options': ['--disable-e10s'], 04:07:07 INFO - 'tests': ['damp', 'tps']}, 04:07:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:07 INFO - 'tests': ['damp', 'tps']}, 04:07:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:07:07 INFO - 'tests': ['dromaeo_dom']}, 04:07:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:07:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:07:07 INFO - 'tests': ['a11yr', 04:07:07 INFO - 'ts_paint', 04:07:07 INFO - 'tpaint', 04:07:07 INFO - 'sessionrestore', 04:07:07 INFO - 'sessionrestore_no_auto_restore', 04:07:07 INFO - 'tabpaint']}, 04:07:07 INFO - 'other-e10s': {'tests': ['a11yr', 04:07:07 INFO - 'ts_paint', 04:07:07 INFO - 'tpaint', 04:07:07 INFO - 'sessionrestore', 04:07:07 INFO - 'sessionrestore_no_auto_restore', 04:07:07 INFO - 'tabpaint']}, 04:07:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:07:07 INFO - 'ts_paint', 04:07:07 INFO - 'tpaint', 04:07:07 INFO - 'sessionrestore', 04:07:07 INFO - 'sessionrestore_no_auto_restore', 04:07:07 INFO - 'tabpaint']}, 04:07:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:07:07 INFO - 'ts_paint', 04:07:07 INFO - 'tpaint', 04:07:07 INFO - 'sessionrestore', 04:07:07 INFO - 'sessionrestore_no_auto_restore', 04:07:07 INFO - 'tabpaint']}, 04:07:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:07:07 INFO - 'tests': ['a11yr', 04:07:07 INFO - 'ts_paint', 04:07:07 INFO - 'tpaint', 04:07:07 INFO - 'sessionrestore', 04:07:07 INFO - 'sessionrestore_no_auto_restore', 04:07:07 INFO - 'tabpaint']}, 04:07:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:07:07 INFO - 'tests': ['a11yr', 04:07:07 INFO - 'ts_paint', 04:07:07 INFO - 'tpaint', 04:07:07 INFO - 'sessionrestore', 04:07:07 INFO - 'sessionrestore_no_auto_restore', 04:07:07 INFO - 'tabpaint']}, 04:07:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:07:07 INFO - 'tests': ['tsvgx', 04:07:07 INFO - 'tsvgr_opacity', 04:07:07 INFO - 'tart', 04:07:07 INFO - 'tscrollx', 04:07:07 INFO - 'cart']}, 04:07:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:07:07 INFO - 'tsvgr_opacity', 04:07:07 INFO - 'tart', 04:07:07 INFO - 'tscrollx', 04:07:07 INFO - 'cart']}, 04:07:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:07 INFO - 'talos_options': ['--disable-e10s'], 04:07:07 INFO - 'tests': ['tp5o']}, 04:07:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:07 INFO - 'tests': ['tp5o']}, 04:07:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:07 INFO - 'talos_options': ['--disable-e10s', 04:07:07 INFO - '--xperf_path', 04:07:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:07 INFO - 'tests': ['tp5n']}, 04:07:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:07 INFO - 'talos_options': ['--xperf_path', 04:07:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:07 INFO - 'tests': ['tp5n']}}, 04:07:07 INFO - 'talos.zip': {'path': '', 04:07:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:07:07 INFO - Running post-action listener: _resource_record_post_action 04:07:07 INFO - ##### 04:07:07 INFO - ##### Running create-virtualenv step. 04:07:07 INFO - ##### 04:07:07 INFO - Running pre-action listener: _resource_record_pre_action 04:07:07 INFO - Running main action method: create_virtualenv 04:07:07 INFO - Creating virtualenv /builds/slave/test/build/venv 04:07:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:07:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:07:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:07:07 INFO - Using real prefix '/usr' 04:07:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:07:07 INFO - Installing distribute.............................................................................................................................................................................................done. 04:07:09 INFO - Installing pip.................done. 04:07:09 INFO - Return code: 0 04:07:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:09 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 0x7f95e2649f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d41640>, '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 0x1d42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d429d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', '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 04:07:09 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 04:07:09 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 04:07:09 INFO - Using env: {'DISPLAY': ':0', 04:07:09 INFO - 'HOME': '/home/cltbld', 04:07:09 INFO - 'LANG': 'en_US.UTF-8', 04:07:09 INFO - 'LANGUAGE': 'en_US:en', 04:07:09 INFO - 'LOGNAME': 'cltbld', 04:07:09 INFO - 'MAIL': '/var/mail/cltbld', 04:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:09 INFO - 'MOZ_NO_REMOTE': '1', 04:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:09 INFO - 'NO_EM_RESTART': '1', 04:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:09 INFO - 'PWD': '/builds/slave/test', 04:07:09 INFO - 'SHELL': '/bin/bash', 04:07:09 INFO - 'SHLVL': '1', 04:07:09 INFO - 'TERM': 'linux', 04:07:09 INFO - 'TMOUT': '86400', 04:07:09 INFO - 'USER': 'cltbld', 04:07:09 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', 04:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:09 INFO - '_': '/tools/buildbot/bin/python'} 04:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:09 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 04:07:09 INFO - Cleaning up... 04:07:09 INFO - Return code: 0 04:07:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:09 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 0x7f95e2649f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d41640>, '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 0x1d42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d429d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', '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 04:07:09 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 04:07:09 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 04:07:09 INFO - Using env: {'DISPLAY': ':0', 04:07:09 INFO - 'HOME': '/home/cltbld', 04:07:09 INFO - 'LANG': 'en_US.UTF-8', 04:07:09 INFO - 'LANGUAGE': 'en_US:en', 04:07:09 INFO - 'LOGNAME': 'cltbld', 04:07:09 INFO - 'MAIL': '/var/mail/cltbld', 04:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:09 INFO - 'MOZ_NO_REMOTE': '1', 04:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:09 INFO - 'NO_EM_RESTART': '1', 04:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:09 INFO - 'PWD': '/builds/slave/test', 04:07:09 INFO - 'SHELL': '/bin/bash', 04:07:09 INFO - 'SHLVL': '1', 04:07:09 INFO - 'TERM': 'linux', 04:07:09 INFO - 'TMOUT': '86400', 04:07:09 INFO - 'USER': 'cltbld', 04:07:09 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', 04:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:09 INFO - '_': '/tools/buildbot/bin/python'} 04:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:10 INFO - Downloading/unpacking psutil>=0.7.1 04:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:07:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:12 INFO - Installing collected packages: psutil 04:07:12 INFO - Running setup.py install for psutil 04:07:12 INFO - building 'psutil._psutil_linux' extension 04:07:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:07:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:07:12 INFO - building 'psutil._psutil_posix' extension 04:07:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:07:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:07:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:12 INFO - Successfully installed psutil 04:07:12 INFO - Cleaning up... 04:07:12 INFO - Return code: 0 04:07:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:07:12 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')]} 04:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:12 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')]} 04:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:12 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 0x7f95e2649f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d41640>, '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 0x1d42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d429d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', '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 04:07:12 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 04:07:12 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 04:07:12 INFO - Using env: {'DISPLAY': ':0', 04:07:12 INFO - 'HOME': '/home/cltbld', 04:07:12 INFO - 'LANG': 'en_US.UTF-8', 04:07:12 INFO - 'LANGUAGE': 'en_US:en', 04:07:12 INFO - 'LOGNAME': 'cltbld', 04:07:12 INFO - 'MAIL': '/var/mail/cltbld', 04:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:12 INFO - 'MOZ_NO_REMOTE': '1', 04:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:12 INFO - 'NO_EM_RESTART': '1', 04:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:12 INFO - 'PWD': '/builds/slave/test', 04:07:12 INFO - 'SHELL': '/bin/bash', 04:07:12 INFO - 'SHLVL': '1', 04:07:12 INFO - 'TERM': 'linux', 04:07:12 INFO - 'TMOUT': '86400', 04:07:12 INFO - 'USER': 'cltbld', 04:07:12 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', 04:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:12 INFO - '_': '/tools/buildbot/bin/python'} 04:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:07:12 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 04:07:12 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 04:07:12 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 04:07:12 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 04:07:12 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 04:07:12 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 04:07:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:07:14 INFO - Installing collected packages: mozsystemmonitor 04:07:14 INFO - Running setup.py install for mozsystemmonitor 04:07:14 INFO - Successfully installed mozsystemmonitor 04:07:14 INFO - Cleaning up... 04:07:14 INFO - Return code: 0 04:07:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f95e2649f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d41640>, '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 0x1d42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d429d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', '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 04:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:07:14 INFO - Using env: {'DISPLAY': ':0', 04:07:14 INFO - 'HOME': '/home/cltbld', 04:07:14 INFO - 'LANG': 'en_US.UTF-8', 04:07:14 INFO - 'LANGUAGE': 'en_US:en', 04:07:14 INFO - 'LOGNAME': 'cltbld', 04:07:14 INFO - 'MAIL': '/var/mail/cltbld', 04:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:14 INFO - 'MOZ_NO_REMOTE': '1', 04:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:14 INFO - 'NO_EM_RESTART': '1', 04:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:14 INFO - 'PWD': '/builds/slave/test', 04:07:14 INFO - 'SHELL': '/bin/bash', 04:07:14 INFO - 'SHLVL': '1', 04:07:14 INFO - 'TERM': 'linux', 04:07:14 INFO - 'TMOUT': '86400', 04:07:14 INFO - 'USER': 'cltbld', 04:07:14 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', 04:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:14 INFO - '_': '/tools/buildbot/bin/python'} 04:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:15 INFO - Downloading/unpacking blobuploader==1.2.4 04:07: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 04:07: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 04:07: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 04:07: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 04:07: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 04:07: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 04:07:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:07:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:07:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:17 INFO - Downloading docopt-0.6.1.tar.gz 04:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:07:17 INFO - Installing collected packages: blobuploader, requests, docopt 04:07:17 INFO - Running setup.py install for blobuploader 04:07:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:07:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:07:17 INFO - Running setup.py install for requests 04:07:18 INFO - Running setup.py install for docopt 04:07:18 INFO - Successfully installed blobuploader requests docopt 04:07:18 INFO - Cleaning up... 04:07:18 INFO - Return code: 0 04:07:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:18 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 0x7f95e2649f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d41640>, '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 0x1d42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d429d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', '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 04:07:18 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 04:07:18 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 04:07:18 INFO - Using env: {'DISPLAY': ':0', 04:07:18 INFO - 'HOME': '/home/cltbld', 04:07:18 INFO - 'LANG': 'en_US.UTF-8', 04:07:18 INFO - 'LANGUAGE': 'en_US:en', 04:07:18 INFO - 'LOGNAME': 'cltbld', 04:07:18 INFO - 'MAIL': '/var/mail/cltbld', 04:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:18 INFO - 'MOZ_NO_REMOTE': '1', 04:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:18 INFO - 'NO_EM_RESTART': '1', 04:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:18 INFO - 'PWD': '/builds/slave/test', 04:07:18 INFO - 'SHELL': '/bin/bash', 04:07:18 INFO - 'SHLVL': '1', 04:07:18 INFO - 'TERM': 'linux', 04:07:18 INFO - 'TMOUT': '86400', 04:07:18 INFO - 'USER': 'cltbld', 04:07:18 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', 04:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:18 INFO - '_': '/tools/buildbot/bin/python'} 04:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:18 INFO - Running setup.py (path:/tmp/pip-TPzS1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:18 INFO - Running setup.py (path:/tmp/pip-Zk_er_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:18 INFO - Running setup.py (path:/tmp/pip-9AvBBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:18 INFO - Running setup.py (path:/tmp/pip-qGr3AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:18 INFO - Running setup.py (path:/tmp/pip-yO8mNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:18 INFO - Running setup.py (path:/tmp/pip-JHOnub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:18 INFO - Running setup.py (path:/tmp/pip-0pV9_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:19 INFO - Running setup.py (path:/tmp/pip-92t53n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:19 INFO - Running setup.py (path:/tmp/pip-bNjgIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:19 INFO - Running setup.py (path:/tmp/pip-3DD65g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:19 INFO - Running setup.py (path:/tmp/pip-92D6QA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:19 INFO - Running setup.py (path:/tmp/pip-mBtshy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:19 INFO - Running setup.py (path:/tmp/pip-B66l7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:19 INFO - Running setup.py (path:/tmp/pip-wkwVHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:19 INFO - Running setup.py (path:/tmp/pip-sCUWzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:19 INFO - Running setup.py (path:/tmp/pip-hpmX0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:19 INFO - Running setup.py (path:/tmp/pip-uzUfve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:07:19 INFO - Running setup.py install for manifestparser 04:07:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:07:19 INFO - Running setup.py install for mozcrash 04:07:19 INFO - Running setup.py install for mozdebug 04:07:20 INFO - Running setup.py install for mozdevice 04:07:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:07:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:07:20 INFO - Running setup.py install for mozfile 04:07:20 INFO - Running setup.py install for mozhttpd 04:07:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:07:20 INFO - Running setup.py install for mozinfo 04:07:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:07:20 INFO - Running setup.py install for mozInstall 04:07:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:07:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:07:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:07:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:07:20 INFO - Running setup.py install for mozleak 04:07:20 INFO - Running setup.py install for mozlog 04:07:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:07:20 INFO - Running setup.py install for moznetwork 04:07:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:07:20 INFO - Running setup.py install for mozprocess 04:07:21 INFO - Running setup.py install for mozprofile 04:07:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:07:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:07:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:07:21 INFO - Running setup.py install for mozrunner 04:07:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:07:21 INFO - Running setup.py install for mozscreenshot 04:07:21 INFO - Running setup.py install for moztest 04:07:21 INFO - Running setup.py install for mozversion 04:07:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:07:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:07:21 INFO - Cleaning up... 04:07:21 INFO - Return code: 0 04:07:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:21 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 0x7f95e2649f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d41640>, '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 0x1d42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d429d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', '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 04:07:21 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 04:07:21 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 04:07:21 INFO - Using env: {'DISPLAY': ':0', 04:07:21 INFO - 'HOME': '/home/cltbld', 04:07:21 INFO - 'LANG': 'en_US.UTF-8', 04:07:21 INFO - 'LANGUAGE': 'en_US:en', 04:07:21 INFO - 'LOGNAME': 'cltbld', 04:07:21 INFO - 'MAIL': '/var/mail/cltbld', 04:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:21 INFO - 'MOZ_NO_REMOTE': '1', 04:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:21 INFO - 'NO_EM_RESTART': '1', 04:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:21 INFO - 'PWD': '/builds/slave/test', 04:07:21 INFO - 'SHELL': '/bin/bash', 04:07:21 INFO - 'SHLVL': '1', 04:07:21 INFO - 'TERM': 'linux', 04:07:21 INFO - 'TMOUT': '86400', 04:07:21 INFO - 'USER': 'cltbld', 04:07:21 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', 04:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:21 INFO - '_': '/tools/buildbot/bin/python'} 04:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:21 INFO - Running setup.py (path:/tmp/pip-miZO_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:21 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)) 04:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:21 INFO - Running setup.py (path:/tmp/pip-ezy48C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:21 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)) 04:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:21 INFO - Running setup.py (path:/tmp/pip-GFFrp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:21 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)) 04:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:21 INFO - Running setup.py (path:/tmp/pip-VOWZt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:22 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)) 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:22 INFO - Running setup.py (path:/tmp/pip-r337UP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:22 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)) 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:22 INFO - Running setup.py (path:/tmp/pip-J8qfqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:22 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)) 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:22 INFO - Running setup.py (path:/tmp/pip-qiawup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:22 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)) 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:22 INFO - Running setup.py (path:/tmp/pip-RyAl7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:22 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)) 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:22 INFO - Running setup.py (path:/tmp/pip-Sqpelw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:22 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)) 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:22 INFO - Running setup.py (path:/tmp/pip-jGhVEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:22 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)) 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:22 INFO - Running setup.py (path:/tmp/pip-tVGznL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:22 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)) 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:22 INFO - Running setup.py (path:/tmp/pip-n711yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:22 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)) 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:22 INFO - Running setup.py (path:/tmp/pip-Q_biI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:22 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)) 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:22 INFO - Running setup.py (path:/tmp/pip-aGC2PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:22 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)) 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:22 INFO - Running setup.py (path:/tmp/pip-_BH3g9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:22 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)) 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:22 INFO - Running setup.py (path:/tmp/pip-mIWiDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:22 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)) 04:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:22 INFO - Running setup.py (path:/tmp/pip-xaX04N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:22 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)) 04:07:22 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)) 04:07:22 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)) 04:07:22 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)) 04:07:22 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)) 04:07:22 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)) 04:07:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:24 INFO - Downloading blessings-1.6.tar.gz 04:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:24 INFO - Installing collected packages: blessings 04:07:24 INFO - Running setup.py install for blessings 04:07:25 INFO - Successfully installed blessings 04:07:25 INFO - Cleaning up... 04:07:25 INFO - Return code: 0 04:07:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:07:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:25 INFO - Reading from file tmpfile_stdout 04:07:25 INFO - Current package versions: 04:07:25 INFO - argparse == 1.2.1 04:07:25 INFO - blessings == 1.6 04:07:25 INFO - blobuploader == 1.2.4 04:07:25 INFO - docopt == 0.6.1 04:07:25 INFO - manifestparser == 1.1 04:07:25 INFO - mozInstall == 1.12 04:07:25 INFO - mozcrash == 0.17 04:07:25 INFO - mozdebug == 0.1 04:07:25 INFO - mozdevice == 0.48 04:07:25 INFO - mozfile == 1.2 04:07:25 INFO - mozhttpd == 0.7 04:07:25 INFO - mozinfo == 0.9 04:07:25 INFO - mozleak == 0.1 04:07:25 INFO - mozlog == 3.1 04:07:25 INFO - moznetwork == 0.27 04:07:25 INFO - mozprocess == 0.22 04:07:25 INFO - mozprofile == 0.28 04:07:25 INFO - mozrunner == 6.11 04:07:25 INFO - mozscreenshot == 0.1 04:07:25 INFO - mozsystemmonitor == 0.0 04:07:25 INFO - moztest == 0.7 04:07:25 INFO - mozversion == 1.4 04:07:25 INFO - psutil == 3.1.1 04:07:25 INFO - requests == 1.2.3 04:07:25 INFO - wsgiref == 0.1.2 04:07:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:25 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 0x7f95e2649f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d41640>, '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 0x1d42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d429d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', '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 04:07:25 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 04:07:25 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 04:07:25 INFO - Using env: {'DISPLAY': ':0', 04:07:25 INFO - 'HOME': '/home/cltbld', 04:07:25 INFO - 'LANG': 'en_US.UTF-8', 04:07:25 INFO - 'LANGUAGE': 'en_US:en', 04:07:25 INFO - 'LOGNAME': 'cltbld', 04:07:25 INFO - 'MAIL': '/var/mail/cltbld', 04:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:25 INFO - 'MOZ_NO_REMOTE': '1', 04:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:25 INFO - 'NO_EM_RESTART': '1', 04:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:25 INFO - 'PWD': '/builds/slave/test', 04:07:25 INFO - 'SHELL': '/bin/bash', 04:07:25 INFO - 'SHLVL': '1', 04:07:25 INFO - 'TERM': 'linux', 04:07:25 INFO - 'TMOUT': '86400', 04:07:25 INFO - 'USER': 'cltbld', 04:07:25 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', 04:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:25 INFO - '_': '/tools/buildbot/bin/python'} 04:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:25 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)) 04:07:25 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)) 04:07:25 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)) 04:07:25 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)) 04:07:25 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)) 04:07:25 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)) 04:07:25 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)) 04:07:25 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)) 04:07:25 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)) 04:07:25 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)) 04:07:25 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)) 04:07:25 INFO - Cleaning up... 04:07:25 INFO - Return code: 0 04:07:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:25 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 0x7f95e2649f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d41640>, '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 0x1d42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d429d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', '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 04:07:25 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 04:07:25 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 04:07:25 INFO - Using env: {'DISPLAY': ':0', 04:07:25 INFO - 'HOME': '/home/cltbld', 04:07:25 INFO - 'LANG': 'en_US.UTF-8', 04:07:25 INFO - 'LANGUAGE': 'en_US:en', 04:07:25 INFO - 'LOGNAME': 'cltbld', 04:07:25 INFO - 'MAIL': '/var/mail/cltbld', 04:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:25 INFO - 'MOZ_NO_REMOTE': '1', 04:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:25 INFO - 'NO_EM_RESTART': '1', 04:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:25 INFO - 'PWD': '/builds/slave/test', 04:07:25 INFO - 'SHELL': '/bin/bash', 04:07:25 INFO - 'SHLVL': '1', 04:07:25 INFO - 'TERM': 'linux', 04:07:25 INFO - 'TMOUT': '86400', 04:07:25 INFO - 'USER': 'cltbld', 04:07:25 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', 04:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:25 INFO - '_': '/tools/buildbot/bin/python'} 04:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:25 INFO - Downloading/unpacking jsonschema 04:07:25 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 04:07:25 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 04:07:25 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 04:07:25 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 04:07:25 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 04:07:25 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 04:07:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:07:27 INFO - Downloading/unpacking functools32 (from jsonschema) 04:07:27 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 04:07:27 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 04:07:27 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 04:07:27 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 04:07:27 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 04:07:27 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 04:07:27 INFO - Downloading functools32-3.2.3-2.tar.gz 04:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:07:27 INFO - warning: no files found matching '*.txt' 04:07:27 INFO - no previously-included directories found matching 'build' 04:07:27 INFO - no previously-included directories found matching 'dist' 04:07:27 INFO - no previously-included directories found matching '.git*' 04:07:27 INFO - Installing collected packages: jsonschema, functools32 04:07:27 INFO - Running setup.py install for functools32 04:07:28 INFO - warning: no files found matching '*.txt' 04:07:28 INFO - no previously-included directories found matching 'build' 04:07:28 INFO - no previously-included directories found matching 'dist' 04:07:28 INFO - no previously-included directories found matching '.git*' 04:07:28 INFO - Successfully installed jsonschema functools32 04:07:28 INFO - Cleaning up... 04:07:28 INFO - Return code: 0 04:07:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:28 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 0x7f95e2649f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d41640>, '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 0x1d42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d429d0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', '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 04:07:28 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 04:07:28 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 04:07:28 INFO - Using env: {'DISPLAY': ':0', 04:07:28 INFO - 'HOME': '/home/cltbld', 04:07:28 INFO - 'LANG': 'en_US.UTF-8', 04:07:28 INFO - 'LANGUAGE': 'en_US:en', 04:07:28 INFO - 'LOGNAME': 'cltbld', 04:07:28 INFO - 'MAIL': '/var/mail/cltbld', 04:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:28 INFO - 'MOZ_NO_REMOTE': '1', 04:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:28 INFO - 'NO_EM_RESTART': '1', 04:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:28 INFO - 'PWD': '/builds/slave/test', 04:07:28 INFO - 'SHELL': '/bin/bash', 04:07:28 INFO - 'SHLVL': '1', 04:07:28 INFO - 'TERM': 'linux', 04:07:28 INFO - 'TMOUT': '86400', 04:07:28 INFO - 'USER': 'cltbld', 04:07:28 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', 04:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:28 INFO - '_': '/tools/buildbot/bin/python'} 04:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:28 INFO - Downloading/unpacking flake8 04:07:28 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 04:07:28 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 04:07:28 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 04:07:28 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 04:07:28 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 04:07:28 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 04:07:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:07:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:07:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:07:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:30 INFO - no previously-included directories found matching 'docs/_build' 04:07:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:07:31 INFO - Running setup.py install for pep8 04:07:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:31 INFO - no previously-included directories found matching 'docs/_build' 04:07:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:07:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:07:31 INFO - Cleaning up... 04:07:31 INFO - Return code: 0 04:07:31 INFO - Running post-action listener: _resource_record_post_action 04:07:31 INFO - Running post-action listener: _start_resource_monitoring 04:07:31 INFO - Starting resource monitoring. 04:07:31 INFO - ##### 04:07:31 INFO - ##### Running install step. 04:07:31 INFO - ##### 04:07:31 INFO - Running pre-action listener: _resource_record_pre_action 04:07:31 INFO - Running main action method: install 04:07:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:31 INFO - Reading from file tmpfile_stdout 04:07:31 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:07:31 INFO - Reading from file tmpfile_stdout 04:07:31 INFO - Output received: 04:07:31 INFO - Usage: mozinstall [options] installer 04:07:31 INFO - Options: 04:07:31 INFO - -h, --help show this help message and exit 04:07:31 INFO - -d DEST, --destination=DEST 04:07:31 INFO - Directory to install application into. [default: 04:07:31 INFO - "/builds/slave/test"] 04:07:31 INFO - --app=APP Application being installed. [default: firefox] 04:07:31 INFO - mkdir: /builds/slave/test/build/application 04:07:31 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'] 04:07:31 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 04:07:47 INFO - Reading from file tmpfile_stdout 04:07:47 INFO - Output received: 04:07:47 INFO - /builds/slave/test/build/application/firefox/firefox 04:07:47 INFO - Running post-action listener: _resource_record_post_action 04:07:47 INFO - ##### 04:07:47 INFO - ##### Running run-tests step. 04:07:47 INFO - ##### 04:07:47 INFO - Running pre-action listener: _resource_record_pre_action 04:07:47 INFO - Running main action method: run_tests 04:07:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:07:47 INFO - Python 2.7.3 04:07:47 INFO - Return code: 0 04:07:47 INFO - grabbing minidump binary from tooltool 04:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:47 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 0x1d41640>, '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 0x1d42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d429d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:07:47 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 04:07:47 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 04:07:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:47 INFO - Return code: 0 04:07:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:07:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:07:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:07:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:07:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:07:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:07:48 INFO - Return code: 0 04:07:48 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-037', '--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 04:07:48 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-037 --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 04:07:48 INFO - Using env: {'DISPLAY': ':0', 04:07:48 INFO - 'HOME': '/home/cltbld', 04:07:48 INFO - 'LANG': 'en_US.UTF-8', 04:07:48 INFO - 'LANGUAGE': 'en_US:en', 04:07:48 INFO - 'LOGNAME': 'cltbld', 04:07:48 INFO - 'MAIL': '/var/mail/cltbld', 04:07:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:48 INFO - 'MOZ_NO_REMOTE': '1', 04:07:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:48 INFO - 'NO_EM_RESTART': '1', 04:07:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:48 INFO - 'PWD': '/builds/slave/test', 04:07:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:48 INFO - 'SHELL': '/bin/bash', 04:07:48 INFO - 'SHLVL': '1', 04:07:48 INFO - 'TERM': 'linux', 04:07:48 INFO - 'TMOUT': '86400', 04:07:48 INFO - 'USER': 'cltbld', 04:07:48 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346', 04:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:48 INFO - '_': '/tools/buildbot/bin/python'} 04:07:48 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-037', '--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 04:07:48 INFO - mozversion application_buildid: 20160506013122 04:07:48 INFO - mozversion application_changeset: b14d8e23323e95c5db3bc4cca69738edeee44302 04:07:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:07:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:48 INFO - mozversion application_name: Firefox 04:07:48 INFO - mozversion application_remotingname: firefox-dev 04:07:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:07:48 INFO - mozversion application_vendor: Mozilla 04:07:48 INFO - mozversion application_version: 48.0a2 04:07:48 INFO - mozversion platform_buildid: 20160506013122 04:07:48 INFO - mozversion platform_changeset: b14d8e23323e95c5db3bc4cca69738edeee44302 04:07:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:07:48 INFO - mozversion platform_version: 48.0a2 04:07:48 INFO - using testdate: 1462532868 04:07:48 INFO - actual date: 1462532868 04:07:48 INFO - starting webserver on 'localhost:44842' 04:07:48 INFO - SUITE-START | Running 2 tests 04:07:48 INFO - TEST-START | dromaeo_css 04:07:48 INFO - operating with platform_type : linux_ 04:07:48 INFO - Initialising browser for dromaeo_css test... 04:07:48 INFO - TEST-INFO | started process 23543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbc0fEV/profile http://localhost:44842/getInfo.html) 04:07:52 INFO - PROCESS | 23543 | __metrics Screen width/height:1600/1200 04:07:52 INFO - PROCESS | 23543 | colorDepth:24 04:07:52 INFO - PROCESS | 23543 | Browser inner width/height: 1024/697 04:07:52 INFO - PROCESS | 23543 | __metrics 04:07:53 ERROR - PROCESS | 23543 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:07:54 INFO - TEST-INFO | 23543: exit 0 04:07:54 INFO - Browser initialized. 04:07:54 INFO - Running cycle 1/1 for dromaeo_css test... 04:07:54 INFO - TEST-INFO | started process 23635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbc0fEV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:06 INFO - PROCESS | 23635 | RSS: Main: 141946880 04:08:06 INFO - PROCESS | 23635 | 04:08:57 INFO - PROCESS | 23635 | 1462532937285 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] 04:11:05 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:44842/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44842/tests/dromaeo/cssquery-ext.html) 04:11:06 INFO - PROCESS | 23635 | RSS: Main: 250638336 04:11:06 INFO - PROCESS | 23635 | 04:14:08 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:44842/tests/dromaeo/cssquery-ext.html (next: http://localhost:44842/tests/dromaeo/cssquery-jquery.html) 04:14:09 INFO - PROCESS | 23635 | RSS: Main: 223088640 04:14:09 INFO - PROCESS | 23635 | 04:17:11 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:44842/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44842/tests/dromaeo/cssquery-mootools.html) 04:17:11 INFO - PROCESS | 23635 | RSS: Main: 219172864 04:17:11 INFO - PROCESS | 23635 | 04:20:13 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:44842/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44842/tests/dromaeo/cssquery-prototype.html) 04:20:14 INFO - PROCESS | 23635 | RSS: Main: 216190976 04:20:14 INFO - PROCESS | 23635 | 04:23:16 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:44842/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44842/tests/dromaeo/cssquery-yui.html) 04:23:17 INFO - PROCESS | 23635 | RSS: Main: 213180416 04:23:17 INFO - PROCESS | 23635 | 04:26:19 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:44842/tests/dromaeo/cssquery-yui.html (next: http://localhost:44842/tests/dromaeo/cssquery-dojo.html) 04:26:19 INFO - PROCESS | 23635 | RSS: Main: 250118144 04:26:19 INFO - PROCESS | 23635 | 04:26:19 INFO - PROCESS | 23635 | __start_tp_report 04:26:19 INFO - PROCESS | 23635 | _x_x_mozilla_page_load 04:26:19 INFO - PROCESS | 23635 | _x_x_mozilla_page_load_details 04:26:19 INFO - PROCESS | 23635 | |i|pagename|runs| 04:26:19 INFO - PROCESS | 23635 | |0;dojo.html;3314.4696848504236;3350.698437140657;3368.0737797105776;3368.88208912688;3393.6267010628826;5521.365043020054;5530.419305972875;5532.806351777688;5550.056490396632;5569.777208911639;5559.305086864142;5565;5572.108462645978;5582.246396736449;5616.52259557937;4931.531504507084;5021.723805190713;5029.245613158028;5085.440601533828;5106.106431374513;4949.950500495003;5032.949670503303;5034.09386310464;5036.722980236085;5040.36995375578;5030.2957585938;5057.140286151363;5146.536811686948;5163.3545806774155;5169.560587350061;5147.819826306061;5156.92264616031;5172.198309262033;5176.948230517703;5207.583393328525;4885.218365061609;4973.776180071869;5079.060373830853;5086.567641750456;5087.364079490064;5478.205660179252;5481.150421684645;5492.313460817398;5529.778808847641;5530.557555395599;5955.464008239279;5956.374580669054;5962.791302304398;5968.880622387528;5985.25184351956;5964.1650168976375;6008.699565021775;6029.909551356734;6046.3349031606485;6082.087686847009;5544.085225937715;5608.355039170507;5613.719314034322;5633.2395126657375;5640.266765320482;5881;6065.575409721366;6066.332703402622;6077.4226448487325;6086.60437071589;5838.299404071454;5947.1376650385455;5959.433853783884;5966.582339236212;5991.370906054889;6003.189569408161;6021.608595441282;6024.698765061729;6027.57806953509;6046.606970546901;5758.884822303614;5866.589338746332;5981.312149102821;5991.310999235144;5999.490043346277;5979.641221526722;5981.222441082631;5998.130271110752;6006.819795406145;6020.458158765732;4550.908981820345;4553;4557.111363284128;4558.407407037064;4585.335126406652;3969.305371560023;4014.136960553495;4086.468759061303;4087.3664581989838;4136.172765446862;5728.656280623176;5745.224394706661;5749.85625359361;5755.539556835443;5767.336756272998;6062.514998800086;6075.392460753889;6085.421884920926;6088.573799833969;6088.8782224356155;5551.333839939233;5662.716864156776;5688.829335119953;5776.913346299809;5783.826485205451;5189.247559103909;5193.506616871391;5197.558207552324;5199.428062913076;5202.3497062867145;6281.96859015702;6297.275813281532;6300.810975670737;6306.905396419057;6316.589421687576;5756.366799652119;5927.2590926134235;5994.730237139252;6014.0678194879865;6020.036794112921;6273.592216505913;6298.1812364392335;6308.71610777507;6309.652969086745;6317.336679648754;5752.856178595569;5937.287525496968;5940.198073260054;5940.673262970578;5987.401259873977;5940.702964851654;5999.040153575407;5999.760009599567;6003.249593800775;6046.606970547076;5851.941480585139;5879.853003674943;5895.41045895407;5899.321578018583;5903.321118071477;5697.4587414195585;5806.303243610625;5810.302763668218;5845.09401042839;5861.9706901465215;5787.160861675117;5832.533397328289;5835.766569337179;5840.357560668238;5877.559183061373;5915.171875937286;5925.644461332334;5937.643741375531;5944.732487038007;5959.106134079922;5604.439556044363;5767.8558036049435;5840.883182336244;5847.678377689268;5871.324797648154 04:26:19 INFO - PROCESS | 23635 | |1;ext.html;668.1314291421154;679.6805501414335;679.694137638063;735.8749012667846;751.4852326156587;31326.060218193463;40546.391804122926;41713;41764.99999999996;41848.58151418485;42908.78545607268;43893.341599875945;43895.56104438955;43958.78020609893;43987.78006109973;7901.920980790204;8797.824043519126;9013.233875120623;10493.527791249375;10782.5686972521;10485.161187105052;10646.041856232938;10653.307535010199;10654.147668186526;10655.413952232624;10680.145588352912;10787.298825576352;10793.136549076095;10801.83797243042;10806.621768238114;7938.24586664266;10441.895581044168;10658.413787241698;10689.946550267277;10691.144708423308;10566.947165264124;10707.464626768708;10709.303895246861;10710.571577136905;10725.249232553724;44838.32742508865;45692.54307456916;45695;45715.771421143014;45770.54229457696;3358.714509266691;3602.189507360849;3620.1673615068416;3645.343838109139;3654.5797233317976;34315.313693725984;34443;34787;34876.82561587201;36014.45978310327;4320.330348795942;4332.783360831977;4334.783260836977;4334.934975975363;4435.068635586531;309105;313349;316366;316401;333267;69414.65292673606;70454;70570.64714676393;70653;70838;63856.68071659612;64690.67654661697;64944.67527662331;65219.34780652133;65483.67258163678;14251.78622320666;15277.388904443698;15385.153816540198;15388.30752616135;15400.845991540165;11661.825072623917;11826.881731182579;11827.231229970024;11832.467538960595;11883.287002779687;21088.156473741186;21308.680369794467;21414.78585214159;21422.89288553547;21560.676589851166;7989.760307190793;8223.835523289501;8291.543965081979;8303.8339233215;8431.156884311642;1074.6775967209962;1078.9406582637873;1175.535663412947;1199.9340036297913;1282.205032879602;33286.334273314395;33735.83132084324;33736.49395259073;34080.82959585236;34410.586644985124;1187.673389817807;1236.1964722930168;1263.6714454241962;1269.771441140585;1325.2975922760952;18155.36456224026;18289.817101829078;18344.633107338046;18404.35584754554;18428.631427371376;510605;518059;518954;519117;519509;62993.685031575464;63510.682446587474;63847.68076159682;63940.68029659822;63955;1373.491808031035;1463.0855715178013;1484.2875419798556;1489.977650335246;1499.8500149985132;30800;31847.840760796047;33067.338653227285;33835;34980.82509587436;52283.477165229386;52404.73797630987;52644.473555263954;52691.209631854785;52699;273355;273427;273698;274173;274731;26158.73841261563;29475.852620736758;29683.703162968093;29936.25159370946;30179.698203017688;45269.32096018628;45799.542004579525;49608.255876161165;50333;50703.49296507135;38386.260434307;39432.6056739429;39577.2084558313;42474.36288455738;43180.352294714976;38423.423648645854;39785.403218951156;39791.40312895251;40044.59955400409;40147;40445.59554404536;41836.163276733685;41953.370699440144;42350;42442.5755742451;36147.45778813267;37986;38338.42492362561;38903.2219355617;39090.80454597709;29492;29758.55362169526;29763.70236297609;29783.25541861384;30076.54885176768 04:26:19 INFO - PROCESS | 23635 | |2;jquery.html;425.3683280328712;434.0884143299072;434.5669213215596;436.4958472963728;437.68049323993483;19478;19966.50083747907;20010;21328.040238189278;21330.46673833151;17157.227924743383;19175.23299068039;19219.519512012208;20049.79950200501;20113.094910729014;5182.093133701606;5296.8146114885985;5345.091334473149;5350.30446042014;5364.7317634118335;4005.439238506611;4295.033617436067;5254.605904557155;5298.072837253465;6674.032265321525;6464.838379040514;6586.110875031881;6614.107095542113;6614.669266536678;6618.801435956929;6054.4550990410635;6059.484943779784;6063.423974722395;6208.410201030895;6550.574212676161;3923.2545816295096;4090.0388408724225;5619.831405057855;5696.174054762037;5849.64902105875;14475.638109047253;14504.854951450456;14585.781213281809;17027.744583831252;24049.557026578463;2755.4489102179446;2816.2114607909816;2820.1539538138477;2863.155369166101;3181.8568164432427;10389.324693894949;10844.349339039683;11088.778224435466;11092.279001864934;11459.484323205392;1973.190991693399;1980.6236815005102;2028.3509277031355;2068.893142168932;2071.461420030803;88978;92212.53893730555;92987;93553;93980.53009734977;11003.724906877233;11872.940635296942;12005.939970300267;12056.156069075256;12093.697657558456;16935.745963810554;17196.31214751396;17204.569885752957;17212.31150753981;17237.31050757981;8110.270075693216;8342.791430214293;8387.454815436977;8428.747137585882;8452.830943381221;7732.381409487228;7746.225377462321;7785.338246249133;7791.0650721913735;7913.129555748863;5098.668586541863;5125.769340379692;5146.742662866842;5242.266082748418;5265.973670131625;2012.2353505668045;2069.9379018629465;2126.5534237809925;2129.7976692214215;2159.4493404181835;1020.1736593359254;1087.782443511301;1120.5797825815318;1133.2463911498926;1214.0409076829383;19266.518337041685;19445.708314375297;19540.31608893682;19898.204071836964;19962.60074798525;1065.4938904020528;1074.4412905289205;1095.775366049958;1096.2600244834705;1133.2010932292715;10760.784784304271;11139.16456265767;11254.268472549258;11285;11310.660680179608;506738;541727;542270;548243;566311;62942.68528657419;82932.58533707414;100426.49786751019;108917;109700;1063.500154927183;1109.290054365207;1112.365951407706;1119.6025410979148;1121.971950701239;17589.29642814273;17704.2033108513;17948.641027179645;18051.909740451214;18321;43928.34107488326;44706.55293447024;44736.10527789491;45770;46427.303590445496;63540.682296588224;64211;64428.67785661229;64959.675201623686;65209.43533952578;8540.14598540141;8765.211130998241;8767.430117042371;9203.263738900738;9330.813383732424;10266;13440.126391784503;13648.181109133484;13894.652633684238;14384.352704128549;12116.878831211576;12277.113696834675;12669.493220271455;12988.675283117998;13420.127691700009;12553.372331383576;12618.49526018949;12721.427535760728;12749.808752868528;12947.546835861076;12631.494740210655;12739.55411560591;12773;12946.093773435769;13122.212667239995;9374.062593740571;9421.104995025462;9536.284778641491;9549.188318992963;9744.12302892743;12831.101822872683;12930.418131184308;12967.35163241853;13053.151545149914;13140.0801943863 04:26:19 INFO - PROCESS | 23635 | |3;mootools.html;1430.778229374446;1593.9760903586441;1605.5022942887701;1842.9815701842986;1925.6437559051567;8278.75163745087;8577.44246623969;8596.69911553095;8600.096989816073;8606.268467180289;8292.253697167254;8315.960504936882;8416.57917104144;8499.575021248944;8501.489910605353;2131.818795402393;2380.642903564462;2401.2796161151673;2408.4701365699516;2471.616899380599;2349.6475528670667;2352.4001379648166;2364.2788949370433;2365.5032443186865;2368.12379419615;2383.7616238376195;2443.51129774045;2444.5966415541416;2448.461338505526;2449.0448724997264;2047.3550831488108;2356.752540983198;2413.8672373019476;2414.69816272965;2420.9394765130837;2267.161150374372;2281.840271181018;2316.62933930572;2327.522857814144;2328.732195797471;8565;8571.314294856396;8601.913980860174;8622.956885215533;8642;5093.821716239914;5281.392639846428;5290.259363689048;5291.523762861322;5325.653832500875;3422.863085476603;3520.2431477232262;3604.6034936157002;3611.602723700391;3621.5654121505586;1134.6936327191695;1140.1904647700144;1147.833564133196;1149.2587281203578;1179.1451197881554;11528;11567.710807229718;11613.76772464546;11618.128640352008;11624;4433.933490997638;4532.138893610204;4562.703424277478;4576.610988065985;4695.694779839299;9446.38598491096;9535.332526723201;9551.044895510393;9582.28132890036;9586.856197157049;4606.378138951266;5089.6691715038405;5141.871453213625;5183.326167598264;5185.585153187736;4616.492185859553;4714.952850471452;4754.809807607726;4760.833370832004;4770.809167633256;3873.8063096845044;3916.706247031484;3996.080901392696;4015.19696060789;4120.608542188487;1198.9400529973466;1216.30670517804;1236.0111910471587;1237.418413345726;1247.0086281406304;819.2105879480379;903.2367649336301;951.528993148396;986.5856340336932;992.0922356044139;6086.239220097488;6175.876482470326;6268.059791031382;6347.5556711029785;6494.545381823322;949.6733004139885;1020.7754294055296;1021.213665477578;1047.0890325416935;1075.693427373195;4186.602272784081;4331.913361732748;4365.388845561624;4379.9781001095425;4387.078713470143;10413.42726150069;10842.837357439645;10892.945535272273;10970.835437468444;10971;10724.785504290026;10873.184511161537;10878.292910960763;10884;10894.509747061402;7891.092524359772;8311.750647480585;8318.45930014547;8437.789055273668;8513.531755753369;6056.273247210187;6204.13142160089;6244.843878902882;6281.277653069956;6286.874262514632;9889.752756181153;10086.798264034825;10332;10373.429461379697;10382.221333399873;9616;9664.806703865743;9962.850557241502;10025.849612255675;10074.848877266993;7408.518446300973;7619.771406857803;7622.8094297643;7961.681532738626;8121.390895682729;7695.461317707706;7898.84202315939;8042;8048.356131509348;8049.195080491904;7169.533980291264;7227.1327440707455;7567.205443428361;7636.236376362319;7691.30778229962;6998.75504357345;7162.713491460283;7182.425405967615;7221.711131554679;7259.963700181676;6686.297938716365;6692.364225398579;6726.091977583159;6738.865222695421;6754.628495432798;4987.725675087905;5033.144365457808;5070.8225212117395;5091.745412729423;5194.844154675366;5275.393329766973;5394.730263486888;5396.055690254111;5407.432219616883;5452.236686863763 04:26:19 INFO - PROCESS | 23635 | |4;prototype.html;358.86183819229586;361.9981900090499;362.8077119126863;366.6058986589416;371.14821484692646;5478.0413427650155;5508.779648814043;5532.893421315733;5579.944200557993;5617.382087970325;5443.891122177554;5486.1222204447295;5489.149181876805;5509.228707980886;5523.558115350772;4162.440099338915;4322.524522302544;4332.805023773922;4350.303951367781;4360.454943132108;4265.978670106645;4283.593058659422;4300.612944834964;4313.029568347112;4323.935140972888;4256.787160641971;4283.785810709468;4284.378765079077;4287.164003019412;4301.462317210348;4216.219999300124;4279.165562715271;4297.376880352332;4314.266574682296;4317.179735850178;3787.7159213058853;3790.4124860646643;3792.222594368148;3792.658660720521;3797.164623782791;5300.92048619271;5314.176302673091;5331.2003199519995;5343.278657381243;5386.353637563518;4679.3916790816975;4914.7788349524;4931.408231012266;4937.284093806414;4954.653174277802;5732.484076433099;5735.787958743117;5757.68332741699;5774.5091667208335;5783.681897495636;4166.979165104185;4178.22702799983;4187.97906010468;4191.093052661032;4203.3064544350145;5702.971485142548;5800.4199580042505;5912.113183022538;5984.491318237911;5984.581079324449;4257.127288905767;4259.8083086261195;4291.763952982554;4294.699371044059;4306.892327691833;4343.391925130484;4344.283193273138;4369.890752731144;4370.125974805052;4379.211741886427;4650.325702773147;4760.857174284777;4884.902301954012;4913.31213630092;4928.48250933654;5777.931082749705;5817.7091145442555;5821.679807610537;5824.825255242349;5838.591298609056;1507.1936513965195;1556.4552406657579;1572.874170066392;1579.1630435869008;1581.9762703559456;1012.8987101289812;1014.6803756816579;1015.2132097624252;1021.1983592879554;1032.2258306270298;6018.21763170785;6051.304100028553;6055.848603784941;6060.969695151496;6080.331163572004;6374.58565193261;6380.7128679209545;6405.42351188386;6422.454091402283;6432.549721519449;5884.499817515473;6061.939380606137;6071.969640151771;6078.209832721806;6090.451859332681;3407.6421975692197;3409.4715319125576;3418.162550175223;3425.6916877481144;3433.3476639438427;6455.285933309744;6635.369639884203;6637.535372523974;6655.6339401332425;6659.4006539411685;6468.870622587522;6476.514261430411;6480.416762491398;6482.379405148713;6502.512311576651;5997.940020599825;6616.470682345401;6627.469802415795;6634.635095069818;6647.268800431949;6049.546284028804;6050.848728781815;6062.575619706578;6066.666333351708;6071.148299768613;5669.688167150846;5839.386864379179;5974.163617093697;5989.431004054608;5996.340402555803;6167.167432396748;6179.536534759821;6230.127782110599;6261.68691565429;6297.748090076346;4130;4142.668586513011;4183.330667093251;4184.623383895464;4199.559046300216;5837.628157383097;5975.820725378246;6019.578629495893;6052.394760523913;6075.422834830684;5827.708614569339;5842.393341831031;5876.294844618502;5883.2057672215415;5886.911696324644;5612.326520817528;5833.154192641959;5863.618864773776;5869.119632055226;5875.441833025856;5787.884242315215;5789.507891829242;5798.275215598051;5807.883842323045;5833.416658334133;5921.763129474945;5934;5940.851348785151;5950.315713692808;5951.184888609016;5574.303212098488;5772.220750198838;5793.710314484175;5798.420157984167;5809.82570522885 04:26:19 INFO - PROCESS | 23635 | |5;yui.html;730.4229658569731;746.3805041815287;769.2230846844685;770.4106358635645;776.1578687124471;14139.29303534823;14170.858291417082;14289.499867504614;14331.570052898416;14335.498257560988;13181.538646147386;13231.073824832265;13255.668608284797;13368.598942031731;13368.732625347488;720.8450183210622;864.6930339729399;900.7658008917696;903.4985583001431;904.4482865452069;895.2837729816121;898.6001229452896;899.5142622983581;901.4546199549277;902.2962089570145;768.4543973778624;942.853857652065;946.5551190940247;948.4451595816456;949.2880339745191;770.5415277909663;782.3271986091956;920.5903372998985;943.104051151402;945.6831961292975;683.7743544630309;684.2575805251308;684.4763755726873;687.5496549759865;689.6069240532898;12889.291088990101;12942.547010854669;12993;12997.090203685746;13005;13514.662133446742;13751.793723094162;13807.378667959865;13923.860761392358;13983.860161398357;10712.196585256137;10814.243002989793;10971.23201375904;11064.834027489595;11284.379359135244;4644.303354496818;4673.065386922595;4675.812967481331;4685.508021657745;4772.308015337757;54059;54677.726611367085;54858.72570637161;54888.72555637196;55178.72410637961;10569.207309451667;10628.734281643021;10790.73023174427;10808.243422960317;10887.51006204707;20093.698594521094;20265;20319.593608127754;20329;20329.593408131754;8427.915720842835;8547.401681882333;8639.308855291561;8669.349798764992;8759.60581773809;4710.128626204163;4770.069836381872;4827.806887724522;4869;4927.0884886295435;3405.9829700851833;3506.474028895635;3521.9823900880842;3523.7533372663665;3524;631.9399657032575;644.1786721929577;644.9000404937242;645.6900687669945;650.905618685288;585.7012923409092;599.9670018149044;620.6183197333607;631.4254028833831;631.7504585688628;9249.537523123952;9572.617095316109;9596.223652958588;9627.229821614254;9668.70993870185;604.380509977268;653.3564439027554;683.2143035509204;687.5530904911748;693.0643631098078;4222.4299719538085;4236.4704411948505;4273.87178384649;4340;4410.6030457259;61557.38442615606;64008.67995660085;64049;64159.67920160369;65665;54217.45782542124;55060.17409738857;55626.443735562934;55733.442665572824;56834.7158264206;52262.738686307086;52867;53392.199117013275;53488.73255633697;54214;8026.8795968061695;8112.310453611273;8166.550839703873;8309.501429914224;8497.957510212656;33591.32817343689;33673;33892.32215355728;34324;34533.65466345405;43322.78338608287;44959.77520112378;45318.77340613276;45471.54528454673;45498.31752523781;10755.731106722395;10828.891711082788;10866.402347870942;11120.666380008613;11148.503580023935;11779.52881884715;11790.818698540797;12304.630861074182;12356.567520137112;12516.624501264612;11244.606438774603;11462.083033357478;11550.422478876191;11561.479733412185;11564.94217528907;11394.202405831513;11396.145289103184;11412.372319522507;11459.911308425686;11540.480678369326;10935.45322733876;10974.122070234522;12322.445489953154;12394.256344619353;12741.745165096461;9871.753206169904;10018.599256029676;10080.89919100829;10233.283670143019;10306.48467576633;10251.641192558523;10321;10437.16502679799;10511.474426278808;10791.244612877023 04:26:19 INFO - PROCESS | 23635 | __end_tp_report 04:26:19 INFO - PROCESS | 23635 | __start_cc_report 04:26:19 INFO - PROCESS | 23635 | _x_x_mozilla_cycle_collect,902 04:26:19 INFO - PROCESS | 23635 | __end_cc_report 04:26:19 INFO - PROCESS | 23635 | __startTimestamp1462533979784__endTimestamp 04:26:19 INFO - PROCESS | 23635 | 04:26:19 INFO - PROCESS | 23635 | ------- Summary: start ------- 04:26:19 INFO - PROCESS | 23635 | Number of tests: 6 04:26:19 INFO - PROCESS | 23635 | 04:26:19 INFO - PROCESS | 23635 | [#0] dojo.html Cycles:165 Average:5572.75 Median:5806.30 stddev:632.59 (10.9%) stddev-sans-first:609.22 04:26:19 INFO - PROCESS | 23635 | Values: 3314.5 3350.7 3368.1 3368.9 3393.6 5521.4 5530.4 5532.8 5550.1 5569.8 5559.3 5565.0 5572.1 5582.2 5616.5 4931.5 5021.7 5029.2 5085.4 5106.1 4950.0 5032.9 5034.1 5036.7 5040.4 5030.3 5057.1 5146.5 5163.4 5169.6 5147.8 5156.9 5172.2 5176.9 5207.6 4885.2 4973.8 5079.1 5086.6 5087.4 5478.2 5481.2 5492.3 5529.8 5530.6 5955.5 5956.4 5962.8 5968.9 5985.3 5964.2 6008.7 6029.9 6046.3 6082.1 5544.1 5608.4 5613.7 5633.2 5640.3 5881.0 6065.6 6066.3 6077.4 6086.6 5838.3 5947.1 5959.4 5966.6 5991.4 6003.2 6021.6 6024.7 6027.6 6046.6 5758.9 5866.6 5981.3 5991.3 5999.5 5979.6 5981.2 5998.1 6006.8 6020.5 4550.9 4553.0 4557.1 4558.4 4585.3 3969.3 4014.1 4086.5 4087.4 4136.2 5728.7 5745.2 5749.9 5755.5 5767.3 6062.5 6075.4 6085.4 6088.6 6088.9 5551.3 5662.7 5688.8 5776.9 5783.8 5189.2 5193.5 5197.6 5199.4 5202.3 6282.0 6297.3 6300.8 6306.9 6316.6 5756.4 5927.3 5994.7 6014.1 6020.0 6273.6 6298.2 6308.7 6309.7 6317.3 5752.9 5937.3 5940.2 5940.7 5987.4 5940.7 5999.0 5999.8 6003.2 6046.6 5851.9 5879.9 5895.4 5899.3 5903.3 5697.5 5806.3 5810.3 5845.1 5862.0 5787.2 5832.5 5835.8 5840.4 5877.6 5915.2 5925.6 5937.6 5944.7 5959.1 5604.4 5767.9 5840.9 5847.7 5871.3 04:26:19 INFO - PROCESS | 23635 | 04:26:19 INFO - PROCESS | 23635 | [#1] ext.html Cycles:180 Average:55469.37 Median:34928.83 stddev:101673.31 (291.1%) stddev-sans-first:101875.27 04:26:19 INFO - PROCESS | 23635 | Values: 668.1 679.7 679.7 735.9 751.5 31326.1 40546.4 41713.0 41765.0 41848.6 42908.8 43893.3 43895.6 43958.8 43987.8 7901.9 8797.8 9013.2 10493.5 10782.6 10485.2 10646.0 10653.3 10654.1 10655.4 10680.1 10787.3 10793.1 10801.8 10806.6 7938.2 10441.9 10658.4 10689.9 10691.1 10566.9 10707.5 10709.3 10710.6 10725.2 44838.3 45692.5 45695.0 45715.8 45770.5 3358.7 3602.2 3620.2 3645.3 3654.6 34315.3 34443.0 34787.0 34876.8 36014.5 4320.3 4332.8 4334.8 4334.9 4435.1 309105.0 313349.0 316366.0 316401.0 333267.0 69414.7 70454.0 70570.6 70653.0 70838.0 63856.7 64690.7 64944.7 65219.3 65483.7 14251.8 15277.4 15385.2 15388.3 15400.8 11661.8 11826.9 11827.2 11832.5 11883.3 21088.2 21308.7 21414.8 21422.9 21560.7 7989.8 8223.8 8291.5 8303.8 8431.2 1074.7 1078.9 1175.5 1199.9 1282.2 33286.3 33735.8 33736.5 34080.8 34410.6 1187.7 1236.2 1263.7 1269.8 1325.3 18155.4 18289.8 18344.6 18404.4 18428.6 510605.0 518059.0 518954.0 519117.0 519509.0 62993.7 63510.7 63847.7 63940.7 63955.0 1373.5 1463.1 1484.3 1490.0 1499.9 30800.0 31847.8 33067.3 33835.0 34980.8 52283.5 52404.7 52644.5 52691.2 52699.0 273355.0 273427.0 273698.0 274173.0 274731.0 26158.7 29475.9 29683.7 29936.3 30179.7 45269.3 45799.5 49608.3 50333.0 50703.5 38386.3 39432.6 39577.2 42474.4 43180.4 38423.4 39785.4 39791.4 40044.6 40147.0 40445.6 41836.2 41953.4 42350.0 42442.6 36147.5 37986.0 38338.4 38903.2 39090.8 29492.0 29758.6 29763.7 29783.3 30076.5 04:26:19 INFO - PROCESS | 23635 | 04:26:19 INFO - PROCESS | 23635 | [#2] jquery.html Cycles:180 Average:31227.69 Median:2070.70 stddev:89303.91 (4312.7%) stddev-sans-first:89524.48 04:26:19 INFO - PROCESS | 23635 | Values: 425.4 434.1 434.6 436.5 437.7 19478.0 19966.5 20010.0 21328.0 21330.5 17157.2 19175.2 19219.5 20049.8 20113.1 5182.1 5296.8 5345.1 5350.3 5364.7 4005.4 4295.0 5254.6 5298.1 6674.0 6464.8 6586.1 6614.1 6614.7 6618.8 6054.5 6059.5 6063.4 6208.4 6550.6 3923.3 4090.0 5619.8 5696.2 5849.6 14475.6 14504.9 14585.8 17027.7 24049.6 2755.4 2816.2 2820.2 2863.2 3181.9 10389.3 10844.3 11088.8 11092.3 11459.5 1973.2 1980.6 2028.4 2068.9 2071.5 88978.0 92212.5 92987.0 93553.0 93980.5 11003.7 11872.9 12005.9 12056.2 12093.7 16935.7 17196.3 17204.6 17212.3 17237.3 8110.3 8342.8 8387.5 8428.7 8452.8 7732.4 7746.2 7785.3 7791.1 7913.1 5098.7 5125.8 5146.7 5242.3 5266.0 2012.2 2069.9 2126.6 2129.8 2159.4 1020.2 1087.8 1120.6 1133.2 1214.0 19266.5 19445.7 19540.3 19898.2 19962.6 1065.5 1074.4 1095.8 1096.3 1133.2 10760.8 11139.2 11254.3 11285.0 11310.7 506738.0 541727.0 542270.0 548243.0 566311.0 62942.7 82932.6 100426.5 108917.0 109700.0 1063.5 1109.3 1112.4 1119.6 1122.0 17589.3 17704.2 17948.6 18051.9 18321.0 43928.3 44706.6 44736.1 45770.0 46427.3 63540.7 64211.0 64428.7 64959.7 65209.4 8540.1 8765.2 8767.4 9203.3 9330.8 10266.0 13440.1 13648.2 13894.7 14384.4 12116.9 12277.1 12669.5 12988.7 13420.1 12553.4 12618.5 12721.4 12749.8 12947.5 12631.5 12739.6 12773.0 12946.1 13122.2 9374.1 9421.1 9536.3 9549.2 9744.1 12831.1 12930.4 12967.4 13053.2 13140.1 04:26:19 INFO - PROCESS | 23635 | 04:26:19 INFO - PROCESS | 23635 | [#3] mootools.html Cycles:180 Average:5720.87 Median:4879.27 stddev:3158.64 (64.7%) stddev-sans-first:3151.04 04:26:19 INFO - PROCESS | 23635 | Values: 1430.8 1594.0 1605.5 1843.0 1925.6 8278.8 8577.4 8596.7 8600.1 8606.3 8292.3 8316.0 8416.6 8499.6 8501.5 2131.8 2380.6 2401.3 2408.5 2471.6 2349.6 2352.4 2364.3 2365.5 2368.1 2383.8 2443.5 2444.6 2448.5 2449.0 2047.4 2356.8 2413.9 2414.7 2420.9 2267.2 2281.8 2316.6 2327.5 2328.7 8565.0 8571.3 8601.9 8623.0 8642.0 5093.8 5281.4 5290.3 5291.5 5325.7 3422.9 3520.2 3604.6 3611.6 3621.6 1134.7 1140.2 1147.8 1149.3 1179.1 11528.0 11567.7 11613.8 11618.1 11624.0 4433.9 4532.1 4562.7 4576.6 4695.7 9446.4 9535.3 9551.0 9582.3 9586.9 4606.4 5089.7 5141.9 5183.3 5185.6 4616.5 4715.0 4754.8 4760.8 4770.8 3873.8 3916.7 3996.1 4015.2 4120.6 1198.9 1216.3 1236.0 1237.4 1247.0 819.2 903.2 951.5 986.6 992.1 6086.2 6175.9 6268.1 6347.6 6494.5 949.7 1020.8 1021.2 1047.1 1075.7 4186.6 4331.9 4365.4 4380.0 4387.1 10413.4 10842.8 10892.9 10970.8 10971.0 10724.8 10873.2 10878.3 10884.0 10894.5 7891.1 8311.8 8318.5 8437.8 8513.5 6056.3 6204.1 6244.8 6281.3 6286.9 9889.8 10086.8 10332.0 10373.4 10382.2 9616.0 9664.8 9962.9 10025.8 10074.8 7408.5 7619.8 7622.8 7961.7 8121.4 7695.5 7898.8 8042.0 8048.4 8049.2 7169.5 7227.1 7567.2 7636.2 7691.3 6998.8 7162.7 7182.4 7221.7 7260.0 6686.3 6692.4 6726.1 6738.9 6754.6 4987.7 5033.1 5070.8 5091.7 5194.8 5275.4 5394.7 5396.1 5407.4 5452.2 04:26:19 INFO - PROCESS | 23635 | 04:26:19 INFO - PROCESS | 23635 | [#4] prototype.html Cycles:180 Average:4980.03 Median:5614.85 stddev:1489.04 (26.5%) stddev-sans-first:1452.26 04:26:19 INFO - PROCESS | 23635 | Values: 358.9 362.0 362.8 366.6 371.1 5478.0 5508.8 5532.9 5579.9 5617.4 5443.9 5486.1 5489.1 5509.2 5523.6 4162.4 4322.5 4332.8 4350.3 4360.5 4266.0 4283.6 4300.6 4313.0 4323.9 4256.8 4283.8 4284.4 4287.2 4301.5 4216.2 4279.2 4297.4 4314.3 4317.2 3787.7 3790.4 3792.2 3792.7 3797.2 5300.9 5314.2 5331.2 5343.3 5386.4 4679.4 4914.8 4931.4 4937.3 4954.7 5732.5 5735.8 5757.7 5774.5 5783.7 4167.0 4178.2 4188.0 4191.1 4203.3 5703.0 5800.4 5912.1 5984.5 5984.6 4257.1 4259.8 4291.8 4294.7 4306.9 4343.4 4344.3 4369.9 4370.1 4379.2 4650.3 4760.9 4884.9 4913.3 4928.5 5777.9 5817.7 5821.7 5824.8 5838.6 1507.2 1556.5 1572.9 1579.2 1582.0 1012.9 1014.7 1015.2 1021.2 1032.2 6018.2 6051.3 6055.8 6061.0 6080.3 6374.6 6380.7 6405.4 6422.5 6432.5 5884.5 6061.9 6072.0 6078.2 6090.5 3407.6 3409.5 3418.2 3425.7 3433.3 6455.3 6635.4 6637.5 6655.6 6659.4 6468.9 6476.5 6480.4 6482.4 6502.5 5997.9 6616.5 6627.5 6634.6 6647.3 6049.5 6050.8 6062.6 6066.7 6071.1 5669.7 5839.4 5974.2 5989.4 5996.3 6167.2 6179.5 6230.1 6261.7 6297.7 4130.0 4142.7 4183.3 4184.6 4199.6 5837.6 5975.8 6019.6 6052.4 6075.4 5827.7 5842.4 5876.3 5883.2 5886.9 5612.3 5833.2 5863.6 5869.1 5875.4 5787.9 5789.5 5798.3 5807.9 5833.4 5921.8 5934.0 5940.9 5950.3 5951.2 5574.3 5772.2 5793.7 5798.4 5809.8 04:26:19 INFO - PROCESS | 23635 | 04:26:19 INFO - PROCESS | 23635 | [#5] yui.html Cycles:180 Average:14766.18 Median:4674.44 stddev:17450.51 (373.3%) stddev-sans-first:17467.63 04:26:19 INFO - PROCESS | 23635 | Values: 730.4 746.4 769.2 770.4 776.2 14139.3 14170.9 14289.5 14331.6 14335.5 13181.5 13231.1 13255.7 13368.6 13368.7 720.8 864.7 900.8 903.5 904.4 895.3 898.6 899.5 901.5 902.3 768.5 942.9 946.6 948.4 949.3 770.5 782.3 920.6 943.1 945.7 683.8 684.3 684.5 687.5 689.6 12889.3 12942.5 12993.0 12997.1 13005.0 13514.7 13751.8 13807.4 13923.9 13983.9 10712.2 10814.2 10971.2 11064.8 11284.4 4644.3 4673.1 4675.8 4685.5 4772.3 54059.0 54677.7 54858.7 54888.7 55178.7 10569.2 10628.7 10790.7 10808.2 10887.5 20093.7 20265.0 20319.6 20329.0 20329.6 8427.9 8547.4 8639.3 8669.3 8759.6 4710.1 4770.1 4827.8 4869.0 4927.1 3406.0 3506.5 3522.0 3523.8 3524.0 631.9 644.2 644.9 645.7 650.9 585.7 600.0 620.6 631.4 631.8 9249.5 9572.6 9596.2 9627.2 9668.7 604.4 653.4 683.2 687.6 693.1 4222.4 4236.5 4273.9 4340.0 4410.6 61557.4 64008.7 64049.0 64159.7 65665.0 54217.5 55060.2 55626.4 55733.4 56834.7 52262.7 52867.0 53392.2 53488.7 54214.0 8026.9 8112.3 8166.6 8309.5 8498.0 33591.3 33673.0 33892.3 34324.0 34533.7 43322.8 44959.8 45318.8 45471.5 45498.3 10755.7 10828.9 10866.4 11120.7 11148.5 11779.5 11790.8 12304.6 12356.6 12516.6 11244.6 11462.1 11550.4 11561.5 11564.9 11394.2 11396.1 11412.4 11459.9 11540.5 10935.5 10974.1 12322.4 12394.3 12741.7 9871.8 10018.6 10080.9 10233.3 10306.5 10251.6 10321.0 10437.2 10511.5 10791.2 04:26:19 INFO - PROCESS | 23635 | -------- Summary: end -------- 04:26:19 INFO - PROCESS | 23635 | 04:26:20 INFO - TEST-INFO | 23635: exit 0 04:26:20 INFO - TEST-OK | dromaeo_css | took 1112112ms 04:26:20 INFO - TEST-START | kraken 04:26:20 INFO - operating with platform_type : linux_ 04:26:20 INFO - Initialising browser for kraken test... 04:26:20 INFO - TEST-INFO | started process 23825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNYYhsq/profile http://localhost:44842/getInfo.html) 04:26:24 INFO - PROCESS | 23825 | __metrics Screen width/height:1600/1200 04:26:24 INFO - PROCESS | 23825 | colorDepth:24 04:26:24 INFO - PROCESS | 23825 | Browser inner width/height: 1024/697 04:26:24 INFO - PROCESS | 23825 | __metrics 04:26:25 ERROR - PROCESS | 23825 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:26:26 INFO - TEST-INFO | 23825: exit 0 04:26:26 INFO - Browser initialized. 04:26:26 INFO - Running cycle 1/1 for kraken test... 04:26:26 INFO - TEST-INFO | started process 23916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNYYhsq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:38 INFO - PROCESS | 23916 | RSS: Main: 141950976 04:26:38 INFO - PROCESS | 23916 | 04:26:40 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44842/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:41 INFO - PROCESS | 23916 | RSS: Main: 197124096 04:26:41 INFO - PROCESS | 23916 | 04:26:44 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44842/tests/kraken/driver.html?testName=audio-dft) 04:26:44 INFO - PROCESS | 23916 | RSS: Main: 182005760 04:26:44 INFO - PROCESS | 23916 | 04:26:47 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44842/tests/kraken/driver.html?testName=audio-fft) 04:26:48 INFO - PROCESS | 23916 | RSS: Main: 273272832 04:26:48 INFO - PROCESS | 23916 | 04:26:50 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44842/tests/kraken/driver.html?testName=audio-oscillator) 04:26:50 INFO - PROCESS | 23916 | RSS: Main: 178937856 04:26:50 INFO - PROCESS | 23916 | 04:26:53 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44842/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:53 INFO - PROCESS | 23916 | RSS: Main: 177545216 04:26:53 INFO - PROCESS | 23916 | 04:26:56 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44842/tests/kraken/driver.html?testName=imaging-darkroom) 04:26:57 INFO - PROCESS | 23916 | RSS: Main: 212115456 04:26:57 INFO - PROCESS | 23916 | 04:27:00 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44842/tests/kraken/driver.html?testName=imaging-desaturate) 04:27:01 INFO - PROCESS | 23916 | RSS: Main: 212955136 04:27:01 INFO - PROCESS | 23916 | 04:27:03 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44842/tests/kraken/driver.html?testName=json-parse-financial) 04:27:04 INFO - PROCESS | 23916 | RSS: Main: 212070400 04:27:04 INFO - PROCESS | 23916 | 04:27:05 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44842/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:27:06 INFO - PROCESS | 23916 | RSS: Main: 193953792 04:27:06 INFO - PROCESS | 23916 | 04:27:08 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44842/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:27:08 INFO - PROCESS | 23916 | RSS: Main: 193937408 04:27:08 INFO - PROCESS | 23916 | 04:27:10 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44842/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:27:11 INFO - PROCESS | 23916 | RSS: Main: 206532608 04:27:11 INFO - PROCESS | 23916 | 04:27:13 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:27:14 INFO - PROCESS | 23916 | RSS: Main: 213749760 04:27:14 INFO - PROCESS | 23916 | 04:27:17 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:27:17 INFO - PROCESS | 23916 | RSS: Main: 210984960 04:27:17 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | Cycle 1(1): loaded http://localhost:44842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44842/tests/kraken/driver.html?testName=ai-astar) 04:27:19 INFO - PROCESS | 23916 | RSS: Main: 275030016 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | __start_tp_report 04:27:19 INFO - PROCESS | 23916 | _x_x_mozilla_page_load 04:27:19 INFO - PROCESS | 23916 | _x_x_mozilla_page_load_details 04:27:19 INFO - PROCESS | 23916 | |i|pagename|runs| 04:27:19 INFO - PROCESS | 23916 | |0;ai-astar;110;111;110;111;110;111;104;110;109;109 04:27:19 INFO - PROCESS | 23916 | |1;audio-beat-detection;161;124;152;182;128;149;163;126;178;131 04:27:19 INFO - PROCESS | 23916 | |2;audio-dft;161;161;161;164;161;160;160;161;162;159 04:27:19 INFO - PROCESS | 23916 | |3;audio-fft;76;76;76;167;77;76;75;76;169;75 04:27:19 INFO - PROCESS | 23916 | |4;audio-oscillator;93;94;150;92;93;92;150;92;91;154 04:27:19 INFO - PROCESS | 23916 | |5;imaging-gaussian-blur;116;117;117;116;116;117;117;117;116;116 04:27:19 INFO - PROCESS | 23916 | |6;imaging-darkroom;146;145;145;145;145;144;145;145;145;147 04:27:19 INFO - PROCESS | 23916 | |7;imaging-desaturate;95;95;96;94;95;94;94;94;95;95 04:27:19 INFO - PROCESS | 23916 | |8;json-parse-financial;53;55;55;53;53;54;55;78;64;53 04:27:19 INFO - PROCESS | 23916 | |9;json-stringify-tinderbox;58;58;58;58;59;58;57;58;58;58 04:27:19 INFO - PROCESS | 23916 | |10;stanford-crypto-aes;72;73;74;72;73;73;73;73;72;72 04:27:19 INFO - PROCESS | 23916 | |11;stanford-crypto-ccm;120;128;116;117;128;115;124;119;156;119 04:27:19 INFO - PROCESS | 23916 | |12;stanford-crypto-pbkdf2;161;160;164;160;165;160;158;160;163;165 04:27:19 INFO - PROCESS | 23916 | |13;stanford-crypto-sha256-iterative;66;67;67;65;64;65;65;66;67;65 04:27:19 INFO - PROCESS | 23916 | __end_tp_report 04:27:19 INFO - PROCESS | 23916 | __start_cc_report 04:27:19 INFO - PROCESS | 23916 | _x_x_mozilla_cycle_collect,1605 04:27:19 INFO - PROCESS | 23916 | __end_cc_report 04:27:19 INFO - PROCESS | 23916 | __startTimestamp1462534039739__endTimestamp 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | ------- Summary: start ------- 04:27:19 INFO - PROCESS | 23916 | Number of tests: 14 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.07 (1.9%) stddev-sans-first:2.19 04:27:19 INFO - PROCESS | 23916 | Values: 110.0 111.0 110.0 111.0 110.0 111.0 104.0 110.0 109.0 109.0 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:156.50 stddev:21.59 (13.8%) stddev-sans-first:22.49 04:27:19 INFO - PROCESS | 23916 | Values: 161.0 124.0 152.0 182.0 128.0 149.0 163.0 126.0 178.0 131.0 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.33 (0.8%) stddev-sans-first:1.41 04:27:19 INFO - PROCESS | 23916 | Values: 161.0 161.0 161.0 164.0 161.0 160.0 160.0 161.0 162.0 159.0 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:38.85 (51.1%) stddev-sans-first:40.64 04:27:19 INFO - PROCESS | 23916 | Values: 76.0 76.0 76.0 167.0 77.0 76.0 75.0 76.0 169.0 75.0 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:92.00 stddev:28.49 (31.0%) stddev-sans-first:29.53 04:27:19 INFO - PROCESS | 23916 | Values: 93.0 94.0 150.0 92.0 93.0 92.0 150.0 92.0 91.0 154.0 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:27:19 INFO - PROCESS | 23916 | Values: 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 04:27:19 INFO - PROCESS | 23916 | Values: 146.0 145.0 145.0 145.0 145.0 144.0 145.0 145.0 145.0 147.0 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:27:19 INFO - PROCESS | 23916 | Values: 95.0 95.0 96.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:55.00 stddev:7.99 (14.5%) stddev-sans-first:8.32 04:27:19 INFO - PROCESS | 23916 | Values: 53.0 55.0 55.0 53.0 53.0 54.0 55.0 78.0 64.0 53.0 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 04:27:19 INFO - PROCESS | 23916 | Values: 58.0 58.0 58.0 58.0 59.0 58.0 57.0 58.0 58.0 58.0 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:73.00 stddev:0.67 (0.9%) stddev-sans-first:0.67 04:27:19 INFO - PROCESS | 23916 | Values: 72.0 73.0 74.0 72.0 73.0 73.0 73.0 73.0 72.0 72.0 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:122.00 stddev:12.09 (9.9%) stddev-sans-first:12.73 04:27:19 INFO - PROCESS | 23916 | Values: 120.0 128.0 116.0 117.0 128.0 115.0 124.0 119.0 156.0 119.0 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:162.00 stddev:2.46 (1.5%) stddev-sans-first:2.60 04:27:19 INFO - PROCESS | 23916 | Values: 161.0 160.0 164.0 160.0 165.0 160.0 158.0 160.0 163.0 165.0 04:27:19 INFO - PROCESS | 23916 | 04:27:19 INFO - PROCESS | 23916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 04:27:19 INFO - PROCESS | 23916 | Values: 66.0 67.0 67.0 65.0 64.0 65.0 65.0 66.0 67.0 65.0 04:27:19 INFO - PROCESS | 23916 | -------- Summary: end -------- 04:27:19 INFO - PROCESS | 23916 | 04:27:20 INFO - TEST-INFO | 23916: exit 0 04:27:20 INFO - TEST-OK | kraken | took 60246ms 04:27:20 INFO - SUITE-END | took 1172s 04:27:20 INFO - Completed test suite (00:19:32) 04:27:20 INFO - javascript benchmark 04:27:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.4696848504236, 3350.698437140657, 3368.0737797105776, 3368.88208912688, 3393.6267010628826, 5521.365043020054, 5530.419305972875, 5532.806351777688, 5550.056490396632, 5569.777208911639, 5559.305086864142, 5565.0, 5572.108462645978, 5582.246396736449, 5616.52259557937, 4931.531504507084, 5021.723805190713, 5029.245613158028, 5085.440601533828, 5106.106431374513, 4949.950500495003, 5032.949670503303, 5034.09386310464, 5036.722980236085, 5040.36995375578, 5030.2957585938, 5057.140286151363, 5146.536811686948, 5163.3545806774155, 5169.560587350061, 5147.819826306061, 5156.92264616031, 5172.198309262033, 5176.948230517703, 5207.583393328525, 4885.218365061609, 4973.776180071869, 5079.060373830853, 5086.567641750456, 5087.364079490064, 5478.205660179252, 5481.150421684645, 5492.313460817398, 5529.778808847641, 5530.557555395599, 5955.464008239279, 5956.374580669054, 5962.791302304398, 5968.880622387528, 5985.25184351956, 5964.1650168976375, 6008.699565021775, 6029.909551356734, 6046.3349031606485, 6082.087686847009, 5544.085225937715, 5608.355039170507, 5613.719314034322, 5633.2395126657375, 5640.266765320482, 5881.0, 6065.575409721366, 6066.332703402622, 6077.4226448487325, 6086.60437071589, 5838.299404071454, 5947.1376650385455, 5959.433853783884, 5966.582339236212, 5991.370906054889, 6003.189569408161, 6021.608595441282, 6024.698765061729, 6027.57806953509, 6046.606970546901, 5758.884822303614, 5866.589338746332, 5981.312149102821, 5991.310999235144, 5999.490043346277, 5979.641221526722, 5981.222441082631, 5998.130271110752, 6006.819795406145, 6020.458158765732, 4550.908981820345, 4553.0, 4557.111363284128, 4558.407407037064, 4585.335126406652, 3969.305371560023, 4014.136960553495, 4086.468759061303, 4087.3664581989838, 4136.172765446862, 5728.656280623176, 5745.224394706661, 5749.85625359361, 5755.539556835443, 5767.336756272998, 6062.514998800086, 6075.392460753889, 6085.421884920926, 6088.573799833969, 6088.8782224356155, 5551.333839939233, 5662.716864156776, 5688.829335119953, 5776.913346299809, 5783.826485205451, 5189.247559103909, 5193.506616871391, 5197.558207552324, 5199.428062913076, 5202.3497062867145, 6281.96859015702, 6297.275813281532, 6300.810975670737, 6306.905396419057, 6316.589421687576, 5756.366799652119, 5927.2590926134235, 5994.730237139252, 6014.0678194879865, 6020.036794112921, 6273.592216505913, 6298.1812364392335, 6308.71610777507, 6309.652969086745, 6317.336679648754, 5752.856178595569, 5937.287525496968, 5940.198073260054, 5940.673262970578, 5987.401259873977, 5940.702964851654, 5999.040153575407, 5999.760009599567, 6003.249593800775, 6046.606970547076, 5851.941480585139, 5879.853003674943, 5895.41045895407, 5899.321578018583, 5903.321118071477, 5697.4587414195585, 5806.303243610625, 5810.302763668218, 5845.09401042839, 5861.9706901465215, 5787.160861675117, 5832.533397328289, 5835.766569337179, 5840.357560668238, 5877.559183061373, 5915.171875937286, 5925.644461332334, 5937.643741375531, 5944.732487038007, 5959.106134079922, 5604.439556044363, 5767.8558036049435, 5840.883182336244, 5847.678377689268, 5871.324797648154], "value": 5530.829666709677, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.1314291421154, 679.6805501414335, 679.694137638063, 735.8749012667846, 751.4852326156587, 31326.060218193463, 40546.391804122926, 41713.0, 41764.99999999996, 41848.58151418485, 42908.78545607268, 43893.341599875945, 43895.56104438955, 43958.78020609893, 43987.78006109973, 7901.920980790204, 8797.824043519126, 9013.233875120623, 10493.527791249375, 10782.5686972521, 10485.161187105052, 10646.041856232938, 10653.307535010199, 10654.147668186526, 10655.413952232624, 10680.145588352912, 10787.298825576352, 10793.136549076095, 10801.83797243042, 10806.621768238114, 7938.24586664266, 10441.895581044168, 10658.413787241698, 10689.946550267277, 10691.144708423308, 10566.947165264124, 10707.464626768708, 10709.303895246861, 10710.571577136905, 10725.249232553724, 44838.32742508865, 45692.54307456916, 45695.0, 45715.771421143014, 45770.54229457696, 3358.714509266691, 3602.189507360849, 3620.1673615068416, 3645.343838109139, 3654.5797233317976, 34315.313693725984, 34443.0, 34787.0, 34876.82561587201, 36014.45978310327, 4320.330348795942, 4332.783360831977, 4334.783260836977, 4334.934975975363, 4435.068635586531, 309105.0, 313349.0, 316366.0, 316401.0, 333267.0, 69414.65292673606, 70454.0, 70570.64714676393, 70653.0, 70838.0, 63856.68071659612, 64690.67654661697, 64944.67527662331, 65219.34780652133, 65483.67258163678, 14251.78622320666, 15277.388904443698, 15385.153816540198, 15388.30752616135, 15400.845991540165, 11661.825072623917, 11826.881731182579, 11827.231229970024, 11832.467538960595, 11883.287002779687, 21088.156473741186, 21308.680369794467, 21414.78585214159, 21422.89288553547, 21560.676589851166, 7989.760307190793, 8223.835523289501, 8291.543965081979, 8303.8339233215, 8431.156884311642, 1074.6775967209962, 1078.9406582637873, 1175.535663412947, 1199.9340036297913, 1282.205032879602, 33286.334273314395, 33735.83132084324, 33736.49395259073, 34080.82959585236, 34410.586644985124, 1187.673389817807, 1236.1964722930168, 1263.6714454241962, 1269.771441140585, 1325.2975922760952, 18155.36456224026, 18289.817101829078, 18344.633107338046, 18404.35584754554, 18428.631427371376, 510605.0, 518059.0, 518954.0, 519117.0, 519509.0, 62993.685031575464, 63510.682446587474, 63847.68076159682, 63940.68029659822, 63955.0, 1373.491808031035, 1463.0855715178013, 1484.2875419798556, 1489.977650335246, 1499.8500149985132, 30800.0, 31847.840760796047, 33067.338653227285, 33835.0, 34980.82509587436, 52283.477165229386, 52404.73797630987, 52644.473555263954, 52691.209631854785, 52699.0, 273355.0, 273427.0, 273698.0, 274173.0, 274731.0, 26158.73841261563, 29475.852620736758, 29683.703162968093, 29936.25159370946, 30179.698203017688, 45269.32096018628, 45799.542004579525, 49608.255876161165, 50333.0, 50703.49296507135, 38386.260434307, 39432.6056739429, 39577.2084558313, 42474.36288455738, 43180.352294714976, 38423.423648645854, 39785.403218951156, 39791.40312895251, 40044.59955400409, 40147.0, 40445.59554404536, 41836.163276733685, 41953.370699440144, 42350.0, 42442.5755742451, 36147.45778813267, 37986.0, 38338.42492362561, 38903.2219355617, 39090.80454597709, 29492.0, 29758.55362169526, 29763.70236297609, 29783.25541861384, 30076.54885176768], "value": 20929.65874932536, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.3683280328712, 434.0884143299072, 434.5669213215596, 436.4958472963728, 437.68049323993483, 19478.0, 19966.50083747907, 20010.0, 21328.040238189278, 21330.46673833151, 17157.227924743383, 19175.23299068039, 19219.519512012208, 20049.79950200501, 20113.094910729014, 5182.093133701606, 5296.8146114885985, 5345.091334473149, 5350.30446042014, 5364.7317634118335, 4005.439238506611, 4295.033617436067, 5254.605904557155, 5298.072837253465, 6674.032265321525, 6464.838379040514, 6586.110875031881, 6614.107095542113, 6614.669266536678, 6618.801435956929, 6054.4550990410635, 6059.484943779784, 6063.423974722395, 6208.410201030895, 6550.574212676161, 3923.2545816295096, 4090.0388408724225, 5619.831405057855, 5696.174054762037, 5849.64902105875, 14475.638109047253, 14504.854951450456, 14585.781213281809, 17027.744583831252, 24049.557026578463, 2755.4489102179446, 2816.2114607909816, 2820.1539538138477, 2863.155369166101, 3181.8568164432427, 10389.324693894949, 10844.349339039683, 11088.778224435466, 11092.279001864934, 11459.484323205392, 1973.190991693399, 1980.6236815005102, 2028.3509277031355, 2068.893142168932, 2071.461420030803, 88978.0, 92212.53893730555, 92987.0, 93553.0, 93980.53009734977, 11003.724906877233, 11872.940635296942, 12005.939970300267, 12056.156069075256, 12093.697657558456, 16935.745963810554, 17196.31214751396, 17204.569885752957, 17212.31150753981, 17237.31050757981, 8110.270075693216, 8342.791430214293, 8387.454815436977, 8428.747137585882, 8452.830943381221, 7732.381409487228, 7746.225377462321, 7785.338246249133, 7791.0650721913735, 7913.129555748863, 5098.668586541863, 5125.769340379692, 5146.742662866842, 5242.266082748418, 5265.973670131625, 2012.2353505668045, 2069.9379018629465, 2126.5534237809925, 2129.7976692214215, 2159.4493404181835, 1020.1736593359254, 1087.782443511301, 1120.5797825815318, 1133.2463911498926, 1214.0409076829383, 19266.518337041685, 19445.708314375297, 19540.31608893682, 19898.204071836964, 19962.60074798525, 1065.4938904020528, 1074.4412905289205, 1095.775366049958, 1096.2600244834705, 1133.2010932292715, 10760.784784304271, 11139.16456265767, 11254.268472549258, 11285.0, 11310.660680179608, 506738.0, 541727.0, 542270.0, 548243.0, 566311.0, 62942.68528657419, 82932.58533707414, 100426.49786751019, 108917.0, 109700.0, 1063.500154927183, 1109.290054365207, 1112.365951407706, 1119.6025410979148, 1121.971950701239, 17589.29642814273, 17704.2033108513, 17948.641027179645, 18051.909740451214, 18321.0, 43928.34107488326, 44706.55293447024, 44736.10527789491, 45770.0, 46427.303590445496, 63540.682296588224, 64211.0, 64428.67785661229, 64959.675201623686, 65209.43533952578, 8540.14598540141, 8765.211130998241, 8767.430117042371, 9203.263738900738, 9330.813383732424, 10266.0, 13440.126391784503, 13648.181109133484, 13894.652633684238, 14384.352704128549, 12116.878831211576, 12277.113696834675, 12669.493220271455, 12988.675283117998, 13420.127691700009, 12553.372331383576, 12618.49526018949, 12721.427535760728, 12749.808752868528, 12947.546835861076, 12631.494740210655, 12739.55411560591, 12773.0, 12946.093773435769, 13122.212667239995, 9374.062593740571, 9421.104995025462, 9536.284778641491, 9549.188318992963, 9744.12302892743, 12831.101822872683, 12930.418131184308, 12967.35163241853, 13053.151545149914, 13140.0801943863], "value": 9684.69207328266, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.778229374446, 1593.9760903586441, 1605.5022942887701, 1842.9815701842986, 1925.6437559051567, 8278.75163745087, 8577.44246623969, 8596.69911553095, 8600.096989816073, 8606.268467180289, 8292.253697167254, 8315.960504936882, 8416.57917104144, 8499.575021248944, 8501.489910605353, 2131.818795402393, 2380.642903564462, 2401.2796161151673, 2408.4701365699516, 2471.616899380599, 2349.6475528670667, 2352.4001379648166, 2364.2788949370433, 2365.5032443186865, 2368.12379419615, 2383.7616238376195, 2443.51129774045, 2444.5966415541416, 2448.461338505526, 2449.0448724997264, 2047.3550831488108, 2356.752540983198, 2413.8672373019476, 2414.69816272965, 2420.9394765130837, 2267.161150374372, 2281.840271181018, 2316.62933930572, 2327.522857814144, 2328.732195797471, 8565.0, 8571.314294856396, 8601.913980860174, 8622.956885215533, 8642.0, 5093.821716239914, 5281.392639846428, 5290.259363689048, 5291.523762861322, 5325.653832500875, 3422.863085476603, 3520.2431477232262, 3604.6034936157002, 3611.602723700391, 3621.5654121505586, 1134.6936327191695, 1140.1904647700144, 1147.833564133196, 1149.2587281203578, 1179.1451197881554, 11528.0, 11567.710807229718, 11613.76772464546, 11618.128640352008, 11624.0, 4433.933490997638, 4532.138893610204, 4562.703424277478, 4576.610988065985, 4695.694779839299, 9446.38598491096, 9535.332526723201, 9551.044895510393, 9582.28132890036, 9586.856197157049, 4606.378138951266, 5089.6691715038405, 5141.871453213625, 5183.326167598264, 5185.585153187736, 4616.492185859553, 4714.952850471452, 4754.809807607726, 4760.833370832004, 4770.809167633256, 3873.8063096845044, 3916.706247031484, 3996.080901392696, 4015.19696060789, 4120.608542188487, 1198.9400529973466, 1216.30670517804, 1236.0111910471587, 1237.418413345726, 1247.0086281406304, 819.2105879480379, 903.2367649336301, 951.528993148396, 986.5856340336932, 992.0922356044139, 6086.239220097488, 6175.876482470326, 6268.059791031382, 6347.5556711029785, 6494.545381823322, 949.6733004139885, 1020.7754294055296, 1021.213665477578, 1047.0890325416935, 1075.693427373195, 4186.602272784081, 4331.913361732748, 4365.388845561624, 4379.9781001095425, 4387.078713470143, 10413.42726150069, 10842.837357439645, 10892.945535272273, 10970.835437468444, 10971.0, 10724.785504290026, 10873.184511161537, 10878.292910960763, 10884.0, 10894.509747061402, 7891.092524359772, 8311.750647480585, 8318.45930014547, 8437.789055273668, 8513.531755753369, 6056.273247210187, 6204.13142160089, 6244.843878902882, 6281.277653069956, 6286.874262514632, 9889.752756181153, 10086.798264034825, 10332.0, 10373.429461379697, 10382.221333399873, 9616.0, 9664.806703865743, 9962.850557241502, 10025.849612255675, 10074.848877266993, 7408.518446300973, 7619.771406857803, 7622.8094297643, 7961.681532738626, 8121.390895682729, 7695.461317707706, 7898.84202315939, 8042.0, 8048.356131509348, 8049.195080491904, 7169.533980291264, 7227.1327440707455, 7567.205443428361, 7636.236376362319, 7691.30778229962, 6998.75504357345, 7162.713491460283, 7182.425405967615, 7221.711131554679, 7259.963700181676, 6686.297938716365, 6692.364225398579, 6726.091977583159, 6738.865222695421, 6754.628495432798, 4987.725675087905, 5033.144365457808, 5070.8225212117395, 5091.745412729423, 5194.844154675366, 5275.393329766973, 5394.730263486888, 5396.055690254111, 5407.432219616883, 5452.236686863763], "value": 4629.366693941513, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.86183819229586, 361.9981900090499, 362.8077119126863, 366.6058986589416, 371.14821484692646, 5478.0413427650155, 5508.779648814043, 5532.893421315733, 5579.944200557993, 5617.382087970325, 5443.891122177554, 5486.1222204447295, 5489.149181876805, 5509.228707980886, 5523.558115350772, 4162.440099338915, 4322.524522302544, 4332.805023773922, 4350.303951367781, 4360.454943132108, 4265.978670106645, 4283.593058659422, 4300.612944834964, 4313.029568347112, 4323.935140972888, 4256.787160641971, 4283.785810709468, 4284.378765079077, 4287.164003019412, 4301.462317210348, 4216.219999300124, 4279.165562715271, 4297.376880352332, 4314.266574682296, 4317.179735850178, 3787.7159213058853, 3790.4124860646643, 3792.222594368148, 3792.658660720521, 3797.164623782791, 5300.92048619271, 5314.176302673091, 5331.2003199519995, 5343.278657381243, 5386.353637563518, 4679.3916790816975, 4914.7788349524, 4931.408231012266, 4937.284093806414, 4954.653174277802, 5732.484076433099, 5735.787958743117, 5757.68332741699, 5774.5091667208335, 5783.681897495636, 4166.979165104185, 4178.22702799983, 4187.97906010468, 4191.093052661032, 4203.3064544350145, 5702.971485142548, 5800.4199580042505, 5912.113183022538, 5984.491318237911, 5984.581079324449, 4257.127288905767, 4259.8083086261195, 4291.763952982554, 4294.699371044059, 4306.892327691833, 4343.391925130484, 4344.283193273138, 4369.890752731144, 4370.125974805052, 4379.211741886427, 4650.325702773147, 4760.857174284777, 4884.902301954012, 4913.31213630092, 4928.48250933654, 5777.931082749705, 5817.7091145442555, 5821.679807610537, 5824.825255242349, 5838.591298609056, 1507.1936513965195, 1556.4552406657579, 1572.874170066392, 1579.1630435869008, 1581.9762703559456, 1012.8987101289812, 1014.6803756816579, 1015.2132097624252, 1021.1983592879554, 1032.2258306270298, 6018.21763170785, 6051.304100028553, 6055.848603784941, 6060.969695151496, 6080.331163572004, 6374.58565193261, 6380.7128679209545, 6405.42351188386, 6422.454091402283, 6432.549721519449, 5884.499817515473, 6061.939380606137, 6071.969640151771, 6078.209832721806, 6090.451859332681, 3407.6421975692197, 3409.4715319125576, 3418.162550175223, 3425.6916877481144, 3433.3476639438427, 6455.285933309744, 6635.369639884203, 6637.535372523974, 6655.6339401332425, 6659.4006539411685, 6468.870622587522, 6476.514261430411, 6480.416762491398, 6482.379405148713, 6502.512311576651, 5997.940020599825, 6616.470682345401, 6627.469802415795, 6634.635095069818, 6647.268800431949, 6049.546284028804, 6050.848728781815, 6062.575619706578, 6066.666333351708, 6071.148299768613, 5669.688167150846, 5839.386864379179, 5974.163617093697, 5989.431004054608, 5996.340402555803, 6167.167432396748, 6179.536534759821, 6230.127782110599, 6261.68691565429, 6297.748090076346, 4130.0, 4142.668586513011, 4183.330667093251, 4184.623383895464, 4199.559046300216, 5837.628157383097, 5975.820725378246, 6019.578629495893, 6052.394760523913, 6075.422834830684, 5827.708614569339, 5842.393341831031, 5876.294844618502, 5883.2057672215415, 5886.911696324644, 5612.326520817528, 5833.154192641959, 5863.618864773776, 5869.119632055226, 5875.441833025856, 5787.884242315215, 5789.507891829242, 5798.275215598051, 5807.883842323045, 5833.416658334133, 5921.763129474945, 5934.0, 5940.851348785151, 5950.315713692808, 5951.184888609016, 5574.303212098488, 5772.220750198838, 5793.710314484175, 5798.420157984167, 5809.82570522885], "value": 4514.517680677841, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.4229658569731, 746.3805041815287, 769.2230846844685, 770.4106358635645, 776.1578687124471, 14139.29303534823, 14170.858291417082, 14289.499867504614, 14331.570052898416, 14335.498257560988, 13181.538646147386, 13231.073824832265, 13255.668608284797, 13368.598942031731, 13368.732625347488, 720.8450183210622, 864.6930339729399, 900.7658008917696, 903.4985583001431, 904.4482865452069, 895.2837729816121, 898.6001229452896, 899.5142622983581, 901.4546199549277, 902.2962089570145, 768.4543973778624, 942.853857652065, 946.5551190940247, 948.4451595816456, 949.2880339745191, 770.5415277909663, 782.3271986091956, 920.5903372998985, 943.104051151402, 945.6831961292975, 683.7743544630309, 684.2575805251308, 684.4763755726873, 687.5496549759865, 689.6069240532898, 12889.291088990101, 12942.547010854669, 12993.0, 12997.090203685746, 13005.0, 13514.662133446742, 13751.793723094162, 13807.378667959865, 13923.860761392358, 13983.860161398357, 10712.196585256137, 10814.243002989793, 10971.23201375904, 11064.834027489595, 11284.379359135244, 4644.303354496818, 4673.065386922595, 4675.812967481331, 4685.508021657745, 4772.308015337757, 54059.0, 54677.726611367085, 54858.72570637161, 54888.72555637196, 55178.72410637961, 10569.207309451667, 10628.734281643021, 10790.73023174427, 10808.243422960317, 10887.51006204707, 20093.698594521094, 20265.0, 20319.593608127754, 20329.0, 20329.593408131754, 8427.915720842835, 8547.401681882333, 8639.308855291561, 8669.349798764992, 8759.60581773809, 4710.128626204163, 4770.069836381872, 4827.806887724522, 4869.0, 4927.0884886295435, 3405.9829700851833, 3506.474028895635, 3521.9823900880842, 3523.7533372663665, 3524.0, 631.9399657032575, 644.1786721929577, 644.9000404937242, 645.6900687669945, 650.905618685288, 585.7012923409092, 599.9670018149044, 620.6183197333607, 631.4254028833831, 631.7504585688628, 9249.537523123952, 9572.617095316109, 9596.223652958588, 9627.229821614254, 9668.70993870185, 604.380509977268, 653.3564439027554, 683.2143035509204, 687.5530904911748, 693.0643631098078, 4222.4299719538085, 4236.4704411948505, 4273.87178384649, 4340.0, 4410.6030457259, 61557.38442615606, 64008.67995660085, 64049.0, 64159.67920160369, 65665.0, 54217.45782542124, 55060.17409738857, 55626.443735562934, 55733.442665572824, 56834.7158264206, 52262.738686307086, 52867.0, 53392.199117013275, 53488.73255633697, 54214.0, 8026.8795968061695, 8112.310453611273, 8166.550839703873, 8309.501429914224, 8497.957510212656, 33591.32817343689, 33673.0, 33892.32215355728, 34324.0, 34533.65466345405, 43322.78338608287, 44959.77520112378, 45318.77340613276, 45471.54528454673, 45498.31752523781, 10755.731106722395, 10828.891711082788, 10866.402347870942, 11120.666380008613, 11148.503580023935, 11779.52881884715, 11790.818698540797, 12304.630861074182, 12356.567520137112, 12516.624501264612, 11244.606438774603, 11462.083033357478, 11550.422478876191, 11561.479733412185, 11564.94217528907, 11394.202405831513, 11396.145289103184, 11412.372319522507, 11459.911308425686, 11540.480678369326, 10935.45322733876, 10974.122070234522, 12322.445489953154, 12394.256344619353, 12741.745165096461, 9871.753206169904, 10018.599256029676, 10080.89919100829, 10233.283670143019, 10306.48467576633, 10251.641192558523, 10321.0, 10437.16502679799, 10511.474426278808, 10791.244612877023], "value": 6698.181075082663, "unit": "score"}], "name": "dromaeo_css", "value": 7344.496687636836, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 110.0, 111.0, 110.0, 111.0, 104.0, 110.0, 109.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 124.0, 152.0, 182.0, 128.0, 149.0, 163.0, 126.0, 178.0, 131.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 164.0, 161.0, 160.0, 160.0, 161.0, 162.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 167.0, 77.0, 76.0, 75.0, 76.0, 169.0, 75.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 150.0, 92.0, 93.0, 92.0, 150.0, 92.0, 91.0, 154.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 147.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 53.0, 53.0, 54.0, 55.0, 78.0, 64.0, 53.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 59.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 74.0, 72.0, 73.0, 73.0, 73.0, 73.0, 72.0, 72.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 128.0, 116.0, 117.0, 128.0, 115.0, 124.0, 119.0, 156.0, 119.0], "value": 124.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 164.0, 160.0, 165.0, 160.0, 158.0, 160.0, 163.0, 165.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 65.0, 64.0, 65.0, 65.0, 66.0, 67.0, 65.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1520.2, "alertThreshold": 2.0}]} 04:27:21 INFO - Return code: 0 04:27:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:27:21 ERROR - # TBPL SUCCESS # 04:27:21 INFO - Running post-action listener: _resource_record_post_action 04:27:21 INFO - Running post-run listener: _resource_record_post_run 04:27:22 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 373858304; Read time: 28; Write time: 257408 04:27:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 129384448; Read time: 0; Write time: 115800 04:27:22 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 244473856; Read time: 28; Write time: 141608 04:27:22 INFO - Running post-run listener: _upload_blobber_files 04:27:22 INFO - Blob upload gear active. 04:27:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:27:22 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 04:27:22 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'] 04:27:22 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 04:27:22 INFO - (blobuploader) - INFO - Open directory for files ... 04:27:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:27:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:27:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:23 INFO - (blobuploader) - INFO - Done attempting. 04:27:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:27:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:27:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:24 INFO - (blobuploader) - INFO - Done attempting. 04:27:24 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:24 INFO - Return code: 0 04:27:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47d0a24ee89251fa91069a7690fd7a1d84d6e2d9589ad3db746dc44f68ee85a289a78275633dd37a9648267cda32f8c7844d50dabf0ce548b9bfbfc13479104b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91f170145420d989d0e99ed96ae98c9435c31e4e5d31dccd6cfaf44f858922fa909b0ce0e7fd5063b9cf6707a8731735bba6e699d44dd32d7222ad06a9bbdf86"} 04:27:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:24 INFO - Contents: 04:27:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47d0a24ee89251fa91069a7690fd7a1d84d6e2d9589ad3db746dc44f68ee85a289a78275633dd37a9648267cda32f8c7844d50dabf0ce548b9bfbfc13479104b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91f170145420d989d0e99ed96ae98c9435c31e4e5d31dccd6cfaf44f858922fa909b0ce0e7fd5063b9cf6707a8731735bba6e699d44dd32d7222ad06a9bbdf86"} 04:27:24 INFO - Running post-run listener: copy_logs_to_upload_dir 04:27:24 INFO - Copying logs to upload dir... 04:27:24 INFO - mkdir: /builds/slave/test/build/upload/logs 04:27:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.133721 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-06 04:27:24.605550) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 04:27:24.608970) ========= 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=aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346 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/47d0a24ee89251fa91069a7690fd7a1d84d6e2d9589ad3db746dc44f68ee85a289a78275633dd37a9648267cda32f8c7844d50dabf0ce548b9bfbfc13479104b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91f170145420d989d0e99ed96ae98c9435c31e4e5d31dccd6cfaf44f858922fa909b0ce0e7fd5063b9cf6707a8731735bba6e699d44dd32d7222ad06a9bbdf86"} 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.011474 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/47d0a24ee89251fa91069a7690fd7a1d84d6e2d9589ad3db746dc44f68ee85a289a78275633dd37a9648267cda32f8c7844d50dabf0ce548b9bfbfc13479104b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91f170145420d989d0e99ed96ae98c9435c31e4e5d31dccd6cfaf44f858922fa909b0ce0e7fd5063b9cf6707a8731735bba6e699d44dd32d7222ad06a9bbdf86"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 04:27:24.638240) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:27:24.639029) ========= 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=aa08bb06ff6271ef470a76a4000001be-1462532804.86798-66727346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004681 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:27:24.721280) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 04:27:24.721736) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 04:27:24.722099) ========= ========= Total master_lag: 0.17 =========