builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1462537025.37 results: success (0) buildid: 20160506013122 builduid: edd2de8de4ca48969474bf5b1f92b92a revision: b14d8e23323e95c5db3bc4cca69738edeee44302 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:05.374985) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:05.375434) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:05.375742) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:05.421589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:05.421844) ========= 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=ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 05:17:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-05-06 05:17:05 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166319 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:05.637947) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:05.638262) ========= 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=ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.135589 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:05.785129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:05.785506) ========= 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=ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 05:17:05,800 truncating revision to first 12 chars 2016-05-06 05:17:05,800 Setting DEBUG logging. 2016-05-06 05:17:05,800 attempt 1/10 2016-05-06 05:17:05,800 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b14d8e23323e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 05:17:06,381 unpacking tar archive at: mozilla-aurora-b14d8e23323e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.865450 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:06.663206) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:06.663521) ========= script_repo_revision: b14d8e23323e95c5db3bc4cca69738edeee44302 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:06.663931) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:06.664429) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 05:17:06.673131) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-05-06 05:17:06.673415) ========= /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=ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:17:06 INFO - MultiFileLogger online at 20160506 05:17:06 in /builds/slave/test 05:17:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:17:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:17:06 INFO - {'append_to_log': False, 05:17:06 INFO - 'base_work_dir': '/builds/slave/test', 05:17:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:17:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:17:06 INFO - 'branch': 'Mozilla-Aurora', 05:17:06 INFO - 'buildbot_json_path': 'buildprops.json', 05:17:06 INFO - 'config_files': ('talos/linux_config.py',), 05:17:06 INFO - 'default_actions': ('clobber', 05:17:06 INFO - 'read-buildbot-config', 05:17:06 INFO - 'download-and-extract', 05:17:06 INFO - 'populate-webroot', 05:17:06 INFO - 'create-virtualenv', 05:17:06 INFO - 'install', 05:17:06 INFO - 'run-tests'), 05:17:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:17:06 INFO - 'download_minidump_stackwalk': True, 05:17:06 INFO - 'download_symbols': 'ondemand', 05:17:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:17:06 INFO - 'tooltool.py': '/tools/tooltool.py', 05:17:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:17:06 INFO - '/tools/misc-python/virtualenv.py')}, 05:17:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:17:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:17:06 INFO - 'installer_path': 'installer.exe', 05:17:06 INFO - 'log_level': 'info', 05:17:06 INFO - 'log_name': 'talos', 05:17:06 INFO - 'log_to_console': True, 05:17:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:17:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:17:06 INFO - 'opt_config_files': (), 05:17:06 INFO - 'pip_index': False, 05:17:06 INFO - 'sps_profile': False, 05:17:06 INFO - 'sps_profile_interval': 0, 05:17:06 INFO - 'suite': 'dromaeojs', 05:17:06 INFO - 'system_bits': '32', 05:17:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:17:06 INFO - 'title': 'talos-linux64-ix-035', 05:17:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:17:06 INFO - 'use_talos_json': True, 05:17:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:17:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:17:06 INFO - 'work_dir': 'build'} 05:17:06 INFO - ##### 05:17:06 INFO - ##### Running clobber step. 05:17:06 INFO - ##### 05:17:06 INFO - Running pre-action listener: _resource_record_pre_action 05:17:06 INFO - Running main action method: clobber 05:17:06 INFO - rmtree: /builds/slave/test/build 05:17:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:17:08 INFO - Running post-action listener: _resource_record_post_action 05:17:08 INFO - ##### 05:17:08 INFO - ##### Running read-buildbot-config step. 05:17:08 INFO - ##### 05:17:08 INFO - Running pre-action listener: _resource_record_pre_action 05:17:08 INFO - Running main action method: read_buildbot_config 05:17:08 INFO - Using buildbot properties: 05:17:08 INFO - { 05:17:08 INFO - "project": "", 05:17:08 INFO - "product": "firefox", 05:17:08 INFO - "script_repo_revision": "production", 05:17:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:17:08 INFO - "repository": "", 05:17:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:17:08 INFO - "buildid": "20160506013122", 05:17:08 INFO - "pgo_build": "True", 05:17:08 INFO - "basedir": "/builds/slave/test", 05:17:08 INFO - "buildnumber": 223, 05:17:08 INFO - "slavename": "talos-linux64-ix-035", 05:17:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:17:08 INFO - "platform": "ubuntu64_hw", 05:17:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:17:08 INFO - "branch": "mozilla-aurora", 05:17:08 INFO - "repo_path": "releases/mozilla-aurora", 05:17:08 INFO - "revision": "b14d8e23323e95c5db3bc4cca69738edeee44302", 05:17:08 INFO - "stage_platform": "linux64-pgo", 05:17:08 INFO - "builduid": "edd2de8de4ca48969474bf5b1f92b92a", 05:17:08 INFO - "slavebuilddir": "test" 05:17:08 INFO - } 05:17:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 05:17:08 INFO - Running post-action listener: _resource_record_post_action 05:17:08 INFO - ##### 05:17:08 INFO - ##### Running download-and-extract step. 05:17:08 INFO - ##### 05:17:08 INFO - Running pre-action listener: _resource_record_pre_action 05:17:08 INFO - Running main action method: download_and_extract 05:17:08 INFO - mkdir: /builds/slave/test/build/tests 05:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:08 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:17:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:17:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:17:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:17:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:17:19 INFO - Downloaded 1361 bytes. 05:17:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:17:19 INFO - Using the following test package requirements: 05:17:19 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:17:19 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:17:19 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:17:19 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:19 INFO - u'jsshell-linux-x86_64.zip'], 05:17:19 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:17:19 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:17:19 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:17:19 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:17:19 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:17:19 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:17:19 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:19 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:17:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:17:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:17:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:17:41 INFO - Downloaded 23822984 bytes. 05:17:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:17:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:17:43 INFO - Return code: 0 05:17:43 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:43 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:17:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:17:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:17:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:17:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:17:49 INFO - Downloaded 23822984 bytes. 05:17:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:17:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:17:50 INFO - Return code: 0 05:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:50 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:17:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:17:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:17:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:17:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:17:51 INFO - Downloaded 10840145 bytes. 05:17:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:17:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:17:51 INFO - Return code: 0 05:17: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')]} 05:17:51 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:17: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.tar.bz2 05:17: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.tar.bz2 05:17: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.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:17:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:17:55 INFO - Downloaded 62693495 bytes. 05:17:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:17:55 INFO - mkdir: /builds/slave/test/properties 05:17:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:17:55 INFO - Writing to file /builds/slave/test/properties/build_url 05:17:55 INFO - Contents: 05:17:55 INFO - build_url:https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:17:55 INFO - Running post-action listener: _resource_record_post_action 05:17:55 INFO - Running post-action listener: set_extra_try_arguments 05:17:55 INFO - ##### 05:17:55 INFO - ##### Running populate-webroot step. 05:17:55 INFO - ##### 05:17:55 INFO - Running pre-action listener: _resource_record_pre_action 05:17:55 INFO - Running main action method: populate_webroot 05:17:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:17:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:17:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:17:55 INFO - '--tppagecycles', 05:17:55 INFO - '7'], 05:17:55 INFO - 'tests': ['tsvgm']}}, 05:17:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:17:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:17:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:17:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:17:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:17:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:17:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:55 INFO - 'talos_options': ['--disable-e10s'], 05:17:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:55 INFO - 'talos_options': ['--disable-e10s'], 05:17:55 INFO - 'tests': ['damp', 'tps']}, 05:17:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:55 INFO - 'tests': ['damp', 'tps']}, 05:17:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:17:55 INFO - 'tests': ['dromaeo_dom']}, 05:17:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:17:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:17:55 INFO - 'tests': ['a11yr', 05:17:55 INFO - 'ts_paint', 05:17:55 INFO - 'tpaint', 05:17:55 INFO - 'sessionrestore', 05:17:55 INFO - 'sessionrestore_no_auto_restore', 05:17:55 INFO - 'tabpaint']}, 05:17:55 INFO - 'other-e10s': {'tests': ['a11yr', 05:17:55 INFO - 'ts_paint', 05:17:55 INFO - 'tpaint', 05:17:55 INFO - 'sessionrestore', 05:17:55 INFO - 'sessionrestore_no_auto_restore', 05:17:55 INFO - 'tabpaint']}, 05:17:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:17:55 INFO - 'ts_paint', 05:17:55 INFO - 'tpaint', 05:17:55 INFO - 'sessionrestore', 05:17:55 INFO - 'sessionrestore_no_auto_restore', 05:17:55 INFO - 'tabpaint']}, 05:17:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:17:55 INFO - 'ts_paint', 05:17:55 INFO - 'tpaint', 05:17:55 INFO - 'sessionrestore', 05:17:55 INFO - 'sessionrestore_no_auto_restore', 05:17:55 INFO - 'tabpaint']}, 05:17:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:17:55 INFO - 'tests': ['a11yr', 05:17:55 INFO - 'ts_paint', 05:17:55 INFO - 'tpaint', 05:17:55 INFO - 'sessionrestore', 05:17:55 INFO - 'sessionrestore_no_auto_restore', 05:17:55 INFO - 'tabpaint']}, 05:17:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:17:55 INFO - 'tests': ['a11yr', 05:17:55 INFO - 'ts_paint', 05:17:55 INFO - 'tpaint', 05:17:55 INFO - 'sessionrestore', 05:17:55 INFO - 'sessionrestore_no_auto_restore', 05:17:55 INFO - 'tabpaint']}, 05:17:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:17:55 INFO - 'tests': ['tsvgx', 05:17:55 INFO - 'tsvgr_opacity', 05:17:55 INFO - 'tart', 05:17:55 INFO - 'tscrollx', 05:17:55 INFO - 'cart']}, 05:17:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:17:55 INFO - 'tsvgr_opacity', 05:17:55 INFO - 'tart', 05:17:55 INFO - 'tscrollx', 05:17:55 INFO - 'cart']}, 05:17:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:55 INFO - 'talos_options': ['--disable-e10s'], 05:17:55 INFO - 'tests': ['tp5o']}, 05:17:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:55 INFO - 'tests': ['tp5o']}, 05:17:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:55 INFO - 'talos_options': ['--disable-e10s', 05:17:55 INFO - '--xperf_path', 05:17:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:55 INFO - 'tests': ['tp5n']}, 05:17:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:55 INFO - 'talos_options': ['--xperf_path', 05:17:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:55 INFO - 'tests': ['tp5n']}}, 05:17:55 INFO - 'talos.zip': {'path': '', 05:17:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:17:55 INFO - Running post-action listener: _resource_record_post_action 05:17:55 INFO - ##### 05:17:55 INFO - ##### Running create-virtualenv step. 05:17:55 INFO - ##### 05:17:55 INFO - Running pre-action listener: _resource_record_pre_action 05:17:55 INFO - Running main action method: create_virtualenv 05:17:55 INFO - Creating virtualenv /builds/slave/test/build/venv 05:17:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:17:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:17:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:17:56 INFO - Using real prefix '/usr' 05:17:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:17:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:17:58 INFO - Installing pip.................done. 05:17:58 INFO - Return code: 0 05:17:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfaf2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8640>, '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 0x19c9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c99d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:17:58 INFO - Using env: {'DISPLAY': ':0', 05:17:58 INFO - 'HOME': '/home/cltbld', 05:17:58 INFO - 'LANG': 'en_US.UTF-8', 05:17:58 INFO - 'LANGUAGE': 'en_US:en', 05:17:58 INFO - 'LOGNAME': 'cltbld', 05:17:58 INFO - 'MAIL': '/var/mail/cltbld', 05:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:58 INFO - 'MOZ_NO_REMOTE': '1', 05:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:58 INFO - 'NO_EM_RESTART': '1', 05:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:58 INFO - 'PWD': '/builds/slave/test', 05:17:58 INFO - 'SHELL': '/bin/bash', 05:17:58 INFO - 'SHLVL': '1', 05:17:58 INFO - 'TERM': 'linux', 05:17:58 INFO - 'TMOUT': '86400', 05:17:58 INFO - 'USER': 'cltbld', 05:17:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 05:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:58 INFO - '_': '/tools/buildbot/bin/python'} 05:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:17:59 INFO - Cleaning up... 05:17:59 INFO - Return code: 0 05:17:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:59 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 0x7fbfaf2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8640>, '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 0x19c9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c99d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:17:59 INFO - Using env: {'DISPLAY': ':0', 05:17:59 INFO - 'HOME': '/home/cltbld', 05:17:59 INFO - 'LANG': 'en_US.UTF-8', 05:17:59 INFO - 'LANGUAGE': 'en_US:en', 05:17:59 INFO - 'LOGNAME': 'cltbld', 05:17:59 INFO - 'MAIL': '/var/mail/cltbld', 05:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:59 INFO - 'MOZ_NO_REMOTE': '1', 05:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:59 INFO - 'NO_EM_RESTART': '1', 05:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:59 INFO - 'PWD': '/builds/slave/test', 05:17:59 INFO - 'SHELL': '/bin/bash', 05:17:59 INFO - 'SHLVL': '1', 05:17:59 INFO - 'TERM': 'linux', 05:17:59 INFO - 'TMOUT': '86400', 05:17:59 INFO - 'USER': 'cltbld', 05:17:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 05:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:59 INFO - '_': '/tools/buildbot/bin/python'} 05:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:59 INFO - Downloading/unpacking psutil>=0.7.1 05:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:18:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:01 INFO - Installing collected packages: psutil 05:18:01 INFO - Running setup.py install for psutil 05:18:01 INFO - building 'psutil._psutil_linux' extension 05:18:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:18:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:18:03 INFO - building 'psutil._psutil_posix' extension 05:18:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:18:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:18:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:03 INFO - Successfully installed psutil 05:18:03 INFO - Cleaning up... 05:18:03 INFO - Return code: 0 05:18:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:03 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 0x7fbfaf2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8640>, '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 0x19c9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c99d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:18:03 INFO - Using env: {'DISPLAY': ':0', 05:18:03 INFO - 'HOME': '/home/cltbld', 05:18:03 INFO - 'LANG': 'en_US.UTF-8', 05:18:03 INFO - 'LANGUAGE': 'en_US:en', 05:18:03 INFO - 'LOGNAME': 'cltbld', 05:18:03 INFO - 'MAIL': '/var/mail/cltbld', 05:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:03 INFO - 'MOZ_NO_REMOTE': '1', 05:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:03 INFO - 'NO_EM_RESTART': '1', 05:18:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:03 INFO - 'PWD': '/builds/slave/test', 05:18:03 INFO - 'SHELL': '/bin/bash', 05:18:03 INFO - 'SHLVL': '1', 05:18:03 INFO - 'TERM': 'linux', 05:18:03 INFO - 'TMOUT': '86400', 05:18:03 INFO - 'USER': 'cltbld', 05:18:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 05:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:03 INFO - '_': '/tools/buildbot/bin/python'} 05:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:18:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:18:05 INFO - Installing collected packages: mozsystemmonitor 05:18:05 INFO - Running setup.py install for mozsystemmonitor 05:18:05 INFO - Successfully installed mozsystemmonitor 05:18:05 INFO - Cleaning up... 05:18:05 INFO - Return code: 0 05:18:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:05 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 0x7fbfaf2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8640>, '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 0x19c9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c99d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:18:05 INFO - Using env: {'DISPLAY': ':0', 05:18:05 INFO - 'HOME': '/home/cltbld', 05:18:05 INFO - 'LANG': 'en_US.UTF-8', 05:18:05 INFO - 'LANGUAGE': 'en_US:en', 05:18:05 INFO - 'LOGNAME': 'cltbld', 05:18:05 INFO - 'MAIL': '/var/mail/cltbld', 05:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:05 INFO - 'MOZ_NO_REMOTE': '1', 05:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:05 INFO - 'NO_EM_RESTART': '1', 05:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:05 INFO - 'PWD': '/builds/slave/test', 05:18:05 INFO - 'SHELL': '/bin/bash', 05:18:05 INFO - 'SHLVL': '1', 05:18:05 INFO - 'TERM': 'linux', 05:18:05 INFO - 'TMOUT': '86400', 05:18:05 INFO - 'USER': 'cltbld', 05:18:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 05:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:05 INFO - '_': '/tools/buildbot/bin/python'} 05:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:05 INFO - Downloading/unpacking blobuploader==1.2.4 05:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:07 INFO - Downloading blobuploader-1.2.4.tar.gz 05:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:18:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:18:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:08 INFO - Downloading docopt-0.6.1.tar.gz 05:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:18:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:18:08 INFO - Running setup.py install for blobuploader 05:18:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:18:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:18:08 INFO - Running setup.py install for requests 05:18:08 INFO - Running setup.py install for docopt 05:18:08 INFO - Successfully installed blobuploader requests docopt 05:18:08 INFO - Cleaning up... 05:18:09 INFO - Return code: 0 05:18:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18: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')]} 05:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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')]} 05:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:09 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 0x7fbfaf2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8640>, '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 0x19c9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c99d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:18:09 INFO - Using env: {'DISPLAY': ':0', 05:18:09 INFO - 'HOME': '/home/cltbld', 05:18:09 INFO - 'LANG': 'en_US.UTF-8', 05:18:09 INFO - 'LANGUAGE': 'en_US:en', 05:18:09 INFO - 'LOGNAME': 'cltbld', 05:18:09 INFO - 'MAIL': '/var/mail/cltbld', 05:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:09 INFO - 'MOZ_NO_REMOTE': '1', 05:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:09 INFO - 'NO_EM_RESTART': '1', 05:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:09 INFO - 'PWD': '/builds/slave/test', 05:18:09 INFO - 'SHELL': '/bin/bash', 05:18:09 INFO - 'SHLVL': '1', 05:18:09 INFO - 'TERM': 'linux', 05:18:09 INFO - 'TMOUT': '86400', 05:18:09 INFO - 'USER': 'cltbld', 05:18:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 05:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:09 INFO - '_': '/tools/buildbot/bin/python'} 05:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:09 INFO - Running setup.py (path:/tmp/pip-Eja0y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:09 INFO - Running setup.py (path:/tmp/pip-hwClVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:09 INFO - Running setup.py (path:/tmp/pip-hfyTc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:09 INFO - Running setup.py (path:/tmp/pip-cKWaDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:09 INFO - Running setup.py (path:/tmp/pip-fxNqnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:09 INFO - Running setup.py (path:/tmp/pip-Zm7Bny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:09 INFO - Running setup.py (path:/tmp/pip-1DXFrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:09 INFO - Running setup.py (path:/tmp/pip-VT3IrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:09 INFO - Running setup.py (path:/tmp/pip-5Ao5Mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:09 INFO - Running setup.py (path:/tmp/pip-UgYQ02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:09 INFO - Running setup.py (path:/tmp/pip-yXcRUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:10 INFO - Running setup.py (path:/tmp/pip-hcNnYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:10 INFO - Running setup.py (path:/tmp/pip-qVVwYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:10 INFO - Running setup.py (path:/tmp/pip-YGBSbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:10 INFO - Running setup.py (path:/tmp/pip-YCwtO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:10 INFO - Running setup.py (path:/tmp/pip-uF5yeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:10 INFO - Running setup.py (path:/tmp/pip-HskMZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:18:10 INFO - Running setup.py install for manifestparser 05:18:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:18:10 INFO - Running setup.py install for mozcrash 05:18:10 INFO - Running setup.py install for mozdebug 05:18:10 INFO - Running setup.py install for mozdevice 05:18:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:18:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:18:10 INFO - Running setup.py install for mozfile 05:18:10 INFO - Running setup.py install for mozhttpd 05:18:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Running setup.py install for mozinfo 05:18:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Running setup.py install for mozInstall 05:18:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Running setup.py install for mozleak 05:18:11 INFO - Running setup.py install for mozlog 05:18:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Running setup.py install for moznetwork 05:18:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Running setup.py install for mozprocess 05:18:11 INFO - Running setup.py install for mozprofile 05:18:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Running setup.py install for mozrunner 05:18:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:18:11 INFO - Running setup.py install for mozscreenshot 05:18:12 INFO - Running setup.py install for moztest 05:18:12 INFO - Running setup.py install for mozversion 05:18:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:18:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:18:12 INFO - Cleaning up... 05:18:12 INFO - Return code: 0 05:18:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18: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')]} 05:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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')]} 05:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:12 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 0x7fbfaf2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8640>, '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 0x19c9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c99d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:18:12 INFO - Using env: {'DISPLAY': ':0', 05:18:12 INFO - 'HOME': '/home/cltbld', 05:18:12 INFO - 'LANG': 'en_US.UTF-8', 05:18:12 INFO - 'LANGUAGE': 'en_US:en', 05:18:12 INFO - 'LOGNAME': 'cltbld', 05:18:12 INFO - 'MAIL': '/var/mail/cltbld', 05:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:12 INFO - 'MOZ_NO_REMOTE': '1', 05:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:12 INFO - 'NO_EM_RESTART': '1', 05:18:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:12 INFO - 'PWD': '/builds/slave/test', 05:18:12 INFO - 'SHELL': '/bin/bash', 05:18:12 INFO - 'SHLVL': '1', 05:18:12 INFO - 'TERM': 'linux', 05:18:12 INFO - 'TMOUT': '86400', 05:18:12 INFO - 'USER': 'cltbld', 05:18:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 05:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:12 INFO - '_': '/tools/buildbot/bin/python'} 05:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:12 INFO - Running setup.py (path:/tmp/pip-VBxV85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:12 INFO - Running setup.py (path:/tmp/pip-PvW92J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:12 INFO - Running setup.py (path:/tmp/pip-IzMbFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:12 INFO - Running setup.py (path:/tmp/pip-2Gvisn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:12 INFO - Running setup.py (path:/tmp/pip-9Y4F1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:12 INFO - Running setup.py (path:/tmp/pip-FLUxfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:12 INFO - Running setup.py (path:/tmp/pip-ceI2mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:12 INFO - Running setup.py (path:/tmp/pip-UPM_qS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:13 INFO - Running setup.py (path:/tmp/pip-2rV0PE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:13 INFO - Running setup.py (path:/tmp/pip-51pjTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:13 INFO - Running setup.py (path:/tmp/pip-bdbKH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:13 INFO - Running setup.py (path:/tmp/pip-mhOFCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:13 INFO - Running setup.py (path:/tmp/pip-TzoUzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:13 INFO - Running setup.py (path:/tmp/pip-GlMsyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:13 INFO - Running setup.py (path:/tmp/pip-trHsI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:13 INFO - Running setup.py (path:/tmp/pip-xu2_O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:13 INFO - Running setup.py (path:/tmp/pip-80KdLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:15 INFO - Downloading blessings-1.6.tar.gz 05:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:18:15 INFO - Installing collected packages: blessings 05:18:15 INFO - Running setup.py install for blessings 05:18:15 INFO - Successfully installed blessings 05:18:15 INFO - Cleaning up... 05:18:15 INFO - Return code: 0 05:18:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:18:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:16 INFO - Reading from file tmpfile_stdout 05:18:16 INFO - Current package versions: 05:18:16 INFO - argparse == 1.2.1 05:18:16 INFO - blessings == 1.6 05:18:16 INFO - blobuploader == 1.2.4 05:18:16 INFO - docopt == 0.6.1 05:18:16 INFO - manifestparser == 1.1 05:18:16 INFO - mozInstall == 1.12 05:18:16 INFO - mozcrash == 0.17 05:18:16 INFO - mozdebug == 0.1 05:18:16 INFO - mozdevice == 0.48 05:18:16 INFO - mozfile == 1.2 05:18:16 INFO - mozhttpd == 0.7 05:18:16 INFO - mozinfo == 0.9 05:18:16 INFO - mozleak == 0.1 05:18:16 INFO - mozlog == 3.1 05:18:16 INFO - moznetwork == 0.27 05:18:16 INFO - mozprocess == 0.22 05:18:16 INFO - mozprofile == 0.28 05:18:16 INFO - mozrunner == 6.11 05:18:16 INFO - mozscreenshot == 0.1 05:18:16 INFO - mozsystemmonitor == 0.0 05:18:16 INFO - moztest == 0.7 05:18:16 INFO - mozversion == 1.4 05:18:16 INFO - psutil == 3.1.1 05:18:16 INFO - requests == 1.2.3 05:18:16 INFO - wsgiref == 0.1.2 05:18:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:16 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 0x7fbfaf2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8640>, '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 0x19c9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c99d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:18:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:18:16 INFO - Using env: {'DISPLAY': ':0', 05:18:16 INFO - 'HOME': '/home/cltbld', 05:18:16 INFO - 'LANG': 'en_US.UTF-8', 05:18:16 INFO - 'LANGUAGE': 'en_US:en', 05:18:16 INFO - 'LOGNAME': 'cltbld', 05:18:16 INFO - 'MAIL': '/var/mail/cltbld', 05:18:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:16 INFO - 'MOZ_NO_REMOTE': '1', 05:18:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:16 INFO - 'NO_EM_RESTART': '1', 05:18:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:16 INFO - 'PWD': '/builds/slave/test', 05:18:16 INFO - 'SHELL': '/bin/bash', 05:18:16 INFO - 'SHLVL': '1', 05:18:16 INFO - 'TERM': 'linux', 05:18:16 INFO - 'TMOUT': '86400', 05:18:16 INFO - 'USER': 'cltbld', 05:18:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 05:18:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:16 INFO - '_': '/tools/buildbot/bin/python'} 05:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:18:16 INFO - Cleaning up... 05:18:16 INFO - Return code: 0 05:18:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfaf2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8640>, '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 0x19c9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c99d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:18:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:18:16 INFO - Using env: {'DISPLAY': ':0', 05:18:16 INFO - 'HOME': '/home/cltbld', 05:18:16 INFO - 'LANG': 'en_US.UTF-8', 05:18:16 INFO - 'LANGUAGE': 'en_US:en', 05:18:16 INFO - 'LOGNAME': 'cltbld', 05:18:16 INFO - 'MAIL': '/var/mail/cltbld', 05:18:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:16 INFO - 'MOZ_NO_REMOTE': '1', 05:18:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:16 INFO - 'NO_EM_RESTART': '1', 05:18:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:16 INFO - 'PWD': '/builds/slave/test', 05:18:16 INFO - 'SHELL': '/bin/bash', 05:18:16 INFO - 'SHLVL': '1', 05:18:16 INFO - 'TERM': 'linux', 05:18:16 INFO - 'TMOUT': '86400', 05:18:16 INFO - 'USER': 'cltbld', 05:18:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 05:18:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:16 INFO - '_': '/tools/buildbot/bin/python'} 05:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:16 INFO - Downloading/unpacking jsonschema 05:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:18:18 INFO - Downloading/unpacking functools32 (from jsonschema) 05:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:18 INFO - Downloading functools32-3.2.3-2.tar.gz 05:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:18:18 INFO - warning: no files found matching '*.txt' 05:18:18 INFO - no previously-included directories found matching 'build' 05:18:18 INFO - no previously-included directories found matching 'dist' 05:18:18 INFO - no previously-included directories found matching '.git*' 05:18:18 INFO - Installing collected packages: jsonschema, functools32 05:18:18 INFO - Running setup.py install for functools32 05:18:18 INFO - warning: no files found matching '*.txt' 05:18:18 INFO - no previously-included directories found matching 'build' 05:18:18 INFO - no previously-included directories found matching 'dist' 05:18:18 INFO - no previously-included directories found matching '.git*' 05:18:18 INFO - Successfully installed jsonschema functools32 05:18:18 INFO - Cleaning up... 05:18:18 INFO - Return code: 0 05:18:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:18: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')]} 05:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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')]} 05:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfaf2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19397d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c8640>, '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 0x19c9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c99d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:18:18 INFO - Using env: {'DISPLAY': ':0', 05:18:18 INFO - 'HOME': '/home/cltbld', 05:18:18 INFO - 'LANG': 'en_US.UTF-8', 05:18:18 INFO - 'LANGUAGE': 'en_US:en', 05:18:18 INFO - 'LOGNAME': 'cltbld', 05:18:18 INFO - 'MAIL': '/var/mail/cltbld', 05:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:18 INFO - 'MOZ_NO_REMOTE': '1', 05:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:18 INFO - 'NO_EM_RESTART': '1', 05:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:18 INFO - 'PWD': '/builds/slave/test', 05:18:18 INFO - 'SHELL': '/bin/bash', 05:18:18 INFO - 'SHLVL': '1', 05:18:18 INFO - 'TERM': 'linux', 05:18:18 INFO - 'TMOUT': '86400', 05:18:18 INFO - 'USER': 'cltbld', 05:18:18 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 05:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:18 INFO - '_': '/tools/buildbot/bin/python'} 05:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:19 INFO - Downloading/unpacking flake8 05:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:18:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:18:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:18:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:21 INFO - no previously-included directories found matching 'docs/_build' 05:18:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:18:21 INFO - Running setup.py install for pep8 05:18:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:21 INFO - no previously-included directories found matching 'docs/_build' 05:18:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:18:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:18:21 INFO - Cleaning up... 05:18:21 INFO - Return code: 0 05:18:21 INFO - Running post-action listener: _resource_record_post_action 05:18:21 INFO - Running post-action listener: _start_resource_monitoring 05:18:21 INFO - Starting resource monitoring. 05:18:21 INFO - ##### 05:18:21 INFO - ##### Running install step. 05:18:21 INFO - ##### 05:18:21 INFO - Running pre-action listener: _resource_record_pre_action 05:18:21 INFO - Running main action method: install 05:18:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:22 INFO - Reading from file tmpfile_stdout 05:18:22 INFO - Detecting whether we're running mozinstall >=1.0... 05:18:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:18:22 INFO - Reading from file tmpfile_stdout 05:18:22 INFO - Output received: 05:18:22 INFO - Usage: mozinstall [options] installer 05:18:22 INFO - Options: 05:18:22 INFO - -h, --help show this help message and exit 05:18:22 INFO - -d DEST, --destination=DEST 05:18:22 INFO - Directory to install application into. [default: 05:18:22 INFO - "/builds/slave/test"] 05:18:22 INFO - --app=APP Application being installed. [default: firefox] 05:18:22 INFO - mkdir: /builds/slave/test/build/application 05:18:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:18:37 INFO - Reading from file tmpfile_stdout 05:18:37 INFO - Output received: 05:18:37 INFO - /builds/slave/test/build/application/firefox/firefox 05:18:37 INFO - Running post-action listener: _resource_record_post_action 05:18:37 INFO - ##### 05:18:37 INFO - ##### Running run-tests step. 05:18:37 INFO - ##### 05:18:37 INFO - Running pre-action listener: _resource_record_pre_action 05:18:37 INFO - Running main action method: run_tests 05:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:18:37 INFO - Python 2.7.3 05:18:37 INFO - Return code: 0 05:18:37 INFO - grabbing minidump binary from tooltool 05:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:37 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 0x19c8640>, '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 0x19c9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c99d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:18:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:18:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:18:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:18:37 INFO - Return code: 0 05:18:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:18:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:18:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:18:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:18:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:18:38 INFO - Return code: 0 05:18:38 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-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:18:38 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-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:18:38 INFO - Using env: {'DISPLAY': ':0', 05:18:38 INFO - 'HOME': '/home/cltbld', 05:18:38 INFO - 'LANG': 'en_US.UTF-8', 05:18:38 INFO - 'LANGUAGE': 'en_US:en', 05:18:38 INFO - 'LOGNAME': 'cltbld', 05:18:38 INFO - 'MAIL': '/var/mail/cltbld', 05:18:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:18:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:38 INFO - 'MOZ_NO_REMOTE': '1', 05:18:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:38 INFO - 'NO_EM_RESTART': '1', 05:18:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:38 INFO - 'PWD': '/builds/slave/test', 05:18:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:18:38 INFO - 'SHELL': '/bin/bash', 05:18:38 INFO - 'SHLVL': '1', 05:18:38 INFO - 'TERM': 'linux', 05:18:38 INFO - 'TMOUT': '86400', 05:18:38 INFO - 'USER': 'cltbld', 05:18:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889', 05:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:38 INFO - '_': '/tools/buildbot/bin/python'} 05:18:38 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-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:18:39 INFO - mozversion application_buildid: 20160506013122 05:18:39 INFO - mozversion application_changeset: b14d8e23323e95c5db3bc4cca69738edeee44302 05:18:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:18:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:18:39 INFO - mozversion application_name: Firefox 05:18:39 INFO - mozversion application_remotingname: firefox-dev 05:18:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:18:39 INFO - mozversion application_vendor: Mozilla 05:18:39 INFO - mozversion application_version: 48.0a2 05:18:39 INFO - mozversion platform_buildid: 20160506013122 05:18:39 INFO - mozversion platform_changeset: b14d8e23323e95c5db3bc4cca69738edeee44302 05:18:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:18:39 INFO - mozversion platform_version: 48.0a2 05:18:39 INFO - using testdate: 1462537119 05:18:39 INFO - actual date: 1462537119 05:18:39 INFO - starting webserver on 'localhost:60942' 05:18:39 INFO - SUITE-START | Running 2 tests 05:18:39 INFO - TEST-START | dromaeo_css 05:18:39 INFO - operating with platform_type : linux_ 05:18:39 INFO - Initialising browser for dromaeo_css test... 05:18:39 INFO - TEST-INFO | started process 3279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMfBRoe/profile http://localhost:60942/getInfo.html) 05:18:44 INFO - PROCESS | 3279 | __metrics Screen width/height:1600/1200 05:18:44 INFO - PROCESS | 3279 | colorDepth:24 05:18:44 INFO - PROCESS | 3279 | Browser inner width/height: 1024/697 05:18:44 INFO - PROCESS | 3279 | __metrics 05:18:45 ERROR - PROCESS | 3279 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:18:46 INFO - TEST-INFO | 3279: exit 0 05:18:46 INFO - Browser initialized. 05:18:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:18:46 INFO - TEST-INFO | started process 3370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMfBRoe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:58 INFO - PROCESS | 3370 | RSS: Main: 141983744 05:18:58 INFO - PROCESS | 3370 | 05:19:49 INFO - PROCESS | 3370 | 1462537189336 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:21:57 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:60942/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60942/tests/dromaeo/cssquery-ext.html) 05:21:58 INFO - PROCESS | 3370 | RSS: Main: 215924736 05:21:58 INFO - PROCESS | 3370 | 05:25:00 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:60942/tests/dromaeo/cssquery-ext.html (next: http://localhost:60942/tests/dromaeo/cssquery-jquery.html) 05:25:01 INFO - PROCESS | 3370 | RSS: Main: 225030144 05:25:01 INFO - PROCESS | 3370 | 05:28:03 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:60942/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60942/tests/dromaeo/cssquery-mootools.html) 05:28:03 INFO - PROCESS | 3370 | RSS: Main: 219246592 05:28:03 INFO - PROCESS | 3370 | 05:31:05 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:60942/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60942/tests/dromaeo/cssquery-prototype.html) 05:31:05 INFO - PROCESS | 3370 | RSS: Main: 218136576 05:31:05 INFO - PROCESS | 3370 | 05:34:08 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:60942/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60942/tests/dromaeo/cssquery-yui.html) 05:34:09 INFO - PROCESS | 3370 | RSS: Main: 193130496 05:34:09 INFO - PROCESS | 3370 | 05:37:11 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:60942/tests/dromaeo/cssquery-yui.html (next: http://localhost:60942/tests/dromaeo/cssquery-dojo.html) 05:37:11 INFO - PROCESS | 3370 | RSS: Main: 257376256 05:37:11 INFO - PROCESS | 3370 | 05:37:11 INFO - PROCESS | 3370 | __start_tp_report 05:37:11 INFO - PROCESS | 3370 | _x_x_mozilla_page_load 05:37:11 INFO - PROCESS | 3370 | _x_x_mozilla_page_load_details 05:37:11 INFO - PROCESS | 3370 | |i|pagename|runs| 05:37:11 INFO - PROCESS | 3370 | |0;dojo.html;3271.5092736089587;3313.668633136685;3344.799312041277;3354.09439451348;3371.915702107447;5415;5423.457654234575;5423.484768946953;5426.375966763819;5441.374241962166;5427.267318911946;5437.510624043835;5444.128939369702;5445.047116754562;5480.6437581557275;4890.24201248807;4922.335484709563;4939.110960027194;4980.203167493201;5036.647434679574;4905.288733133693;4972.751362431882;4973.975130124344;4975.8258460953875;4983.551480366767;5012.398512178544;5033.899322013557;5095.9745201273945;5100.515451032146;5137.717425541594;5132.28148059272;5167.121589329823;5176.404713457963;5177.508136727042;5203.245529398235;4867.805287788484;4957.5786058185095;4979.57673597741;5094.745262736886;5097.872553186163;5497.202905578709;5549.805756798492;5551.861203469905;5554;5558.499735023867;5879.559033072494;5938.168656388109;5941.613795103348;5942.524598032147;5943.4056594340655;5797.101449275369;5938.524918006592;5964.314103878066;5983.1025346197985;6034.034554471307;5553.0837411827;5561.58288128392;5588.441155884379;5590;5612.831615051555;6072.210612620331;6074.54440916933;6075.939240607538;6083.969580152071;6086.087086936995;5637.069883469264;5752.626079304831;5759.913601295984;5805.477507024304;5861;5915.40845915405;5919.348871624118;5930.11048342752;5951.166836642873;5967.910481342783;5872.7357268923;5874.265716785402;5887.0580707086665;5887.705614719247;5891.469767720926;5667.348254950651;5746.569007324468;5894.17481552583;5911.733971971272;5988.850278743066;4519.07358991406;4520.864374068783;4523.819047238074;4548.727076375428;4557.043020965634;4025.2150830587752;4058.0463591056077;4059.167870586523;4060.5330387005283;4083.305838007546;5545.667259964415;5698.059820129715;5710.829279997591;5718.170865224519;5860.560457965669;6014.188084608521;6030.728617212236;6031.909521357183;6033.456988871023;6035.155078289043;5701.71491425427;5711.942880571224;5734.598578099493;5753.280839895013;5754.856128596819;5004.174311238605;5097.362829646294;5142.588592912558;5157.6647517911215;5202.609804264695;6129.3870612939245;6129.754809807558;6139.84650383744;6157.353477884758;6181.196444462281;5891;5918.082697181943;5923.229980102559;5929.940700592939;5934.881302374015;5972;6038.426349496966;6114.084479019511;6135.508280839814;6181.072839074175;5861;5873.50075243592;5885.676287804212;5886.264216972879;5896.145058966512;5705.343885453226;5976.820695379146;5982.521398288213;5982.760689572368;5988.371221021905;5767.826965191051;5849.064149736022;5877.559183061202;5885.47030767233;5906.0255057914965;5829.47534721877;5836.066229403275;5859.589828711949;5865.090910908816;5866.090755932837;5615.831525054255;5650.773969041193;5732.799352022659;5749.568782341257;5783.537317014545;5697.772089116389;5783.913241301299;5838.5621078418435;5894.911576326444;5945.256842894638;5762.049261871744;5817.534597232296;5818.330891947311;5822.039363504974;5854.063349864001 05:37:11 INFO - PROCESS | 3370 | |1;ext.html;672.9259781424042;677.3565113142516;688.0539258519535;739.9899137677071;751.9360105450787;31770;39750;40432.39351409724;40463.190736185294;40498.7975060125;43912.121757564826;44236.55763442365;44548.3317750234;44756.1048779025;44775.32837007447;7824.256695613936;8778.912210877905;8971.506567138806;8997.505137217451;10360.119389851872;10486;10663.893361066368;10665.626703065394;10666.679999600025;10667.359958402481;10544.894551054505;10692.625758098467;10696.839547406795;10698.411587362692;10702.678919632424;7819.6481158348015;10521.158307335394;10548.736281592945;10699.83950240747;10763.730906727316;10754.462276886203;10827.133829293638;10899.618513352074;10902.890971090346;10929.289596176222;41612.79193604043;42425.78787106045;42452;42455.57544424547;42485.362719559234;3517.859285628572;3765.5293088363956;4059.472268605092;4096.160287141129;4119.443875076856;35058.298834023175;35826;35975.64024359749;36059.4591081134;36089.45865812015;4130.318497447947;4171.499420069581;4223.345381465878;4255.17024180285;4300.65594752419;359363;362436;362628;362704.9999999974;363467;37938;68865.3113468859;70490;70529;70579.29420705728;39137.80431097826;39165.41251881224;39211;39357.80321098433;39394.409083863764;13993.3702983366;14301.28493575317;14308.785368219485;14324.14055156694;14357.066790658573;10257;11139.554417823196;11355.716107097389;11369;11373.545058197746;9344.065593440602;9466.574004169828;9484;9536.61853525865;9541.761455963517;3620.87326943561;3786.5645450772963;3793.1275806564645;3802.049487628093;3805.5813860475328;1102.0594239955556;1108.711734948919;1142.2404101272728;1176.4999875053068;1196.1567095197865;32776.50835237473;33318.83340583282;33575.328493429995;33648;33662.3267534648;1206.1135065726685;1221.194011952125;1232.4084439469104;1282.5062350994933;1323.2854258700386;17397.913010434866;17871.374501892373;17873.821261787474;18164.1826117825;18234.36179733703;554212;555946;556983;558270;559917;62091;63601.681991590674;63720.36279637237;63780.68109659422;63836.68081659562;1458.795768592398;1479.7780332950144;1500.1074360755333;1526.175865032892;1540.530138307827;30620;33538;33906.49140262947;33940.83029584836;34630.653693462744;49458.25812612742;49641.25538116859;49774.25338619996;49848;49888.75055624699;315959;323290;323713;324256;324476;26257.474850503266;29233.85383073071;29349.85325073361;29380;29720.405591887607;45994;46387.76806116083;46640;47726;47806.5219347816;41565.79217103895;42066.369004464344;42665.36001959911;43507.347389789815;43889.78055109704;40338.798306008284;41680.791596041825;42174.578254217064;42768.35847462353;42919.7854010728;43347;43535.346969794846;44263;44295;44659.10681786281;35392.11519712028;37034.629653703116;37589.248215036096;37676.81161594175;37703.81148094242;26920;27826;29385.412291754474;29435.11694649164;29648.258793530335 05:37:11 INFO - PROCESS | 3370 | |2;jquery.html;435.9978200108999;439.9032212913159;441.62461907378724;448.44840845759694;456.74194080344625;19340.51648708781;19669.803301966975;20111.59776804465;20474.795252047476;20581.176752929903;17948.82051179488;19367.22531098758;20464.590708185828;20508;20524.38426847193;5821.155932389812;5932.644041357532;5973.313068997078;5982;5982.581219314649;5717.542596592262;5856.795012174574;5868.149118377833;5926.555508336871;5935.465808077272;5860.179574859501;5869.060950247961;5877.764889404419;5880.029795083806;5919.200907877446;5671.404502527237;5906.645601263938;5922.97038514809;5934.080217566284;5936.2579677540525;5251.658642188284;5255.185446255837;5325.334333208349;5341.385740639837;5343.759530821122;24196.15313464038;24197.274081777574;24614.261572152864;24942.50114997708;24976.625350619754;2568.9229323120335;2642.8017898657677;2690.166048524944;2899.246195989037;2954.689757575445;14892.776608350776;15820.129892855888;15835.920820395824;15884.920575397166;15982.600434989103;2036.256766280312;2106.9894650526803;2135.81845543129;2136.5406437615834;2188.835837312192;56022;61546.38453615496;83895;84631;86711.13288867094;11006.174536909764;11439.485223164978;11560.421978901022;11714.355710435837;11717.707057323634;16506.504804855875;16564.337426502803;16643.3342666292;16643.750343744854;16679.16604169811;6974.197967233732;7916.84166316682;8038.316743076904;8226.917730822735;8356.164383561716;7734.883976740353;7808.297253247235;7842.921570784333;7894.64474098667;7980.122186559473;7115.82210444743;7251.1661158966335;7291;7367.484276100621;7405;1984.8440978843707;2055.743032120985;2091.98954005229;2093.895305234732;2119.6184686756224;1011.5700827148432;1115.9497822597841;1176.599956014959;1177.7526719388852;1188.9121453869786;17421.390251341396;18086.90956545209;20542.38372848817;20666.380008599765;20757.273495427587;1063.5852017713098;1090.3621381491757;1104.0836106031975;1106.3527836215742;1179.1981452612135;11526.654200374001;11606.353495117635;11826.52693892252;11879.109066820023;12072.215306005257;457885;478113;499062;541253;544916;51899.48100519022;77816.61091694619;90131.54934225418;90515;90941.54529227312;1118.8545489086366;1127.8646562412398;1130.6721050895312;1139.920205585601;1158.0561842098493;17932.19305131246;17945.461636150416;18250.167464832004;18285.725714114033;18445.72331415003;39630.80184599059;40146.59853401429;41053.79473102615;41054.178916422105;41426.585734142274;53903;54070.729646351516;54494;55929.440705592424;56092;8575.571221439028;8711.782205444915;8739.475631462132;8773.298136148966;8850.247728943112;11122.388268645302;11897.881021189678;12071.336076515525;12147.210431321935;13075.934620326838;10843.837342439712;10992.28550144238;11212.775744485229;11248.83126753083;11368.033717134136;10958.232923695583;11165;11174.329540227613;11299.661010169708;11387.089032877184;10524.94737526338;11403.771924561628;11630.666746444896;11748.29510229389;11780.352080635646;8617.569121544024;8803.647854085764;8833.469991800512;8858.15847494487;8950.82098358016;8963.05887881763;10853.021438619138;11929.940350298193;12083.879161208275;12425.19236249641 05:37:11 INFO - PROCESS | 3370 | |3;mootools.html;1317.354496296815;1477.5198060630294;1551.7362048451762;1703.2846204594077;1875.0905810681825;8255.711050113247;8647.308215342773;8649.091845356226;8652.91347086529;8661.61022753976;8392.454490458116;8582.098879617644;8585.957070214656;8588.785280367994;8595.097514760939;2406.1578447543307;2439.499902519988;2441.951160976779;2442.05980697431;2443.1448992852447;2329.1149363241943;2396.1733202045352;2414.6860908082012;2437.402836305108;2440.3411079008656;2338.824588155895;2366.0299277296313;2367.621180611103;2411.67442395277;2427.757224277576;2342.629561706404;2371.1463873005705;2380.821438392119;2381.0356805493802;2391.4021494626345;2265.0713207584813;2319.223060274793;2325.802306803907;2325.813934885205;2326.4532834783813;7614.505057171266;8343.707970221014;8764.474131552128;8814.735557933273;8833.558322083934;4969.378827646544;5132.461091585405;5136.64043516954;5168.508991645787;5180.481951804827;3329.5505106810515;3356.5468661730843;3432.485127230935;3465.3935561276676;3473.1317170707325;1103.4648195625116;1133.4162906103363;1134.33641319828;1146.60442147459;1149.2242736153064;11838.230515016496;12263.448144833505;12338.691532711664;12352.938235308766;12362;4791.377120974321;4814.759262036884;4816.133096042746;4851.830185943475;4874.658773885794;10439.269251152498;10449.268551201343;10455.581776728997;10456.16350691958;10470.057694807503;5143.202803565453;5229;5259.368875734936;5267.236250743621;5267.657602255841;4682.41469816273;4752.5485078917445;4821.927671084936;4843.346148270009;4849.830255941025;4007.9599204007586;4057.5130984281486;4069.91860162801;4074.8166332515107;4156.750594964312;1226.3929354969168;1230.6492649594823;1238.3560548514722;1242.521629172775;1247.9376031198585;860.5224100624089;970.3159272712861;1040.0514541275418;1045.289203341735;1065.898739619735;6028.698565071729;6062.939370606326;6177;6225.595336303126;6311.317689981739;434.5676052327954;445.77265594546367;447.8701176658798;449.94150760400936;451.91413631409927;4368.890777730582;4372.366006929041;4375.081232941055;4396.142752163298;4405.9559404405545;10359.533820978075;10698.358098514114;10862.674119776419;10874.728131796768;10932.180086493387;10766.515506802212;10774.245802793886;10799.406032668121;10799.83800242997;10814;7937.444378893422;8146.714864979697;8172.060213075453;8216.26053655174;8221.095679475253;6069.241344831896;6251.968740156452;6264.123022776724;6283.7800676976085;6427.132337134427;9418.434893906388;9872.062154095636;9897.752556186153;9980.451075190935;10001;10169.9491502542;10207.795844082928;10262.076413122855;10446.268761186948;10557.894421055691;7487.588182650006;7537.660805263667;7804.375649947877;7844.686212551434;7855.175206603453;8296.460730052528;8340.457870238415;8395.412321137463;8402;8427.789305267417;7290.781276561712;7435.299267313512;7633.351165151024;7699;7723.304902558797;7490.850182996201;7595.392368610608;7620.276073772982;7707.730229441942;7714.845703086019;6903.1716194055025;6908.654567271717;6966.024756534191;6976.407005404394;6979.336962988508;5144.254083157996;5176.534111929945;5224.843254702365;5264;5363.329583802025;5282.154855223146;5337.626366154332;5400.108982017923;5500.009998200202;5524.088525393426 05:37:11 INFO - PROCESS | 3370 | |4;prototype.html;336.62466350019736;350.2312424228818;351.98768043118486;352.9011876674532;356.6576086956523;5373.7044462554595;5388.464287678013;5418.783248670058;5424.864378390542;5436.293281873361;4988.226824842146;5193.143131383326;5284.603654725901;5295.232191332255;5336.17289320155;4189.937150942731;4240.342746874239;4252.617264446199;4263.424437700917;4266.552012038738;4262.744235345874;4273.358996150571;4279.443672322594;4279.87160385189;4286.807093680776;3980;4036.414719865618;4208.621224089831;4215.515215750182;4225.366195070733;4172.3532852407925;4180.498340199196;4198.958010419918;4200.642945349634;4213.915721685565;3763.1344790698295;3767.17122233111;3767.3595488766973;3778.6977041836863;3786.091338078869;5127.230915362688;5155.664881782672;5178.197379406198;5182.378114626231;5260.815871444519;4778.139934811733;4795.976020119912;4813;4813.205821039524;4822.493638168012;5575.107982722786;5580.274564306615;5593.804216852432;5623.409541998072;5640.2667653205235;3895.8636447724193;4118.629323360912;4121.505419349667;4135.6898232632375;4155.812988415499;5842.4741773240185;5870.823875283749;5876.97061514694;5897.970510147465;5902.97048514759;4253.149370125987;4264.701470897007;4268.231718290675;4270;4275.187714334266;4159.646430053479;4242.130363275521;4270.252705776476;4292.82828686849;4303.505096913832;4769.308450274691;4783.306420568998;4828.179209534387;4841.225403935354;4846.951530484721;5603.411641777636;5619.831405057855;5624.746886390122;5642.830715078554;5682.346530149003;1510.9924450377678;1544.4671588302017;1547.3114464063608;1553.0914415067086;1553.712563175816;1001.84972254161;1002.834532302162;1007.7128018514688;1008.0876806490138;1017.1151098544314;5947.167396564484;5958.85102872423;5963.850903727442;5965.194698715704;5983.23056474427;6259.342769009279;6259.843503912348;6263.71813268404;6272;6292.685365731695;5772.365039845614;5925.496332811673;5932.79235226765;5958.672273025025;5998.670073145931;3310.702036816698;3316.6185888623118;3317.0546394278;3317.286783341593;3326.550915626408;6227.1282020517165;6303.464205542488;6393.840153996094;6397.52018598607;6416.743330266737;6257.9687101564205;6279.811605651837;6281.214848143982;6322.462590679844;6328.462080723098;6221.4089661482085;6413.454856337264;6429.067785171124;6449.580777249464;6482.67586620667;6156.938430615636;6197.380261973766;6211.223597050369;6251.499880009679;6254.249490061222;6064.151018857276;6090.269167699727;6115;6147.538934579835;6154.476869466145;6243.562950593415;6408;6419;6420.678966051585;6425.518086143651;3905.258000979805;4073.7982295223574;4208.873733787991;4428.269335559597;4439.356293337512;5781.971090144522;5784.739686714192;5799.884002320015;5823.94176058234;5827.24245848037;5634.74643641029;5684.857878553069;5693.5160511357;5700.800471983461;5708.543316534584;5514.779408823602;5559.33288005442;5575.076598573486;5584.553235741212;5665.971670141623;5498.862528436661;5515.862103447446;5522.91715624274;5548.805791797267;5551.111822108443;5458.325420543984;5658.688772117408;5682.522544138471;5697.259356283656;5698.601097923106;5510.862228444161;5527.695976721158;5579.721013949205;5592.161175823659;5592.356878958972 05:37:11 INFO - PROCESS | 3370 | |5;yui.html;733.4315905173492;774.4491506442959;802.2819576479052;803.0250261207023;821;14033.578992630224;14453.710925781492;14463.638409039779;14474.203918784462;14509.564713058598;12410.255384676902;12442.315672638024;12474.438650260738;12477.438515266813;12487.875121248784;727.9818004549888;868.3660927522913;893.5041052216018;899.3120262998812;899.8650202469616;901.1844280925773;904.2268860124598;913.954302284883;914.6661468563992;914.8993610702818;778.264540009691;947.9668211612595;957.3155194036262;959.8176346494143;960.1166926427703;797.5334429358832;800.2797482265948;918.5728636184207;948.6063283737241;948.9003654616234;691.920429150649;691.937725604698;696.3245651717825;696.8815301398774;697.0206859362553;12656.936715316457;12667.683307917376;12766.17019893704;12796.872031279661;12800.679983000406;13094.607161785161;13394.330283485786;13445.932770336183;13508;13742.799618311145;11068;11102.222844400896;11239.60661376848;11310.151738619636;11423.94288028563;3921.784301863396;3929.135590170158;3964.207158568269;4033.1530378620523;4048.67610591152;56553.71723141358;56558;56885.71557142229;57114.428855711325;57275.42724572701;10708.19688523364;10877.401742904058;10918.72703182411;11020.118390528738;11132.276402033842;20179.596408071757;20203;20211.292604758764;20231.190752370036;20242.190312387338;7806.4925779824125;7991.640376183086;8240.381971352173;8316.334693224528;8320.334373250125;4740.620750339965;4827.637927155477;4900;4901.142300097468;4901.926471102936;3607.296577167427;3657.0674478007936;3658.926821463609;3668.321360548307;3674.614165512636;630.2594451519446;658.8122385120314;667.1760375935716;693.8126705789408;701.9333163349473;567.5069944491661;582.5543459253674;643.8519140597689;662.8342914271432;709.0675761373777;9081.45511269326;9344.065593440602;9388.295877809192;9460.90539094614;9491.145796878314;643.9291677915426;695.6278391060758;713.4934196720386;718.7089228862319;733.2850470790936;4391.560843915583;4494.258447356149;4623.190941585209;4655.255159174516;4703.882402939954;64933.67533162304;66607.33392666109;67201;67218.99171512431;67407.32592674109;51314;55970;57246;59172.11241831376;59197.40802591919;48641.75679121582;50117.74941125271;50913;51234.743826281374;51418.74290628523;8996.55017249148;9305.906940930505;9408.717738467856;9481.194098501705;9646.517674116407;34266.45800938914;34990.12524686903;35099;35375.64624353724;36750;43200.783996079816;45485.54514454813;46816.53183468258;47447.52552474569;47742.761286193345;12942.676433089247;12974.740505189655;13104.475820967054;13274.80087798703;13402.93298533501;12369.93815030919;12597.622071337875;12891.097623166288;13051.608451746462;13315.201087934754;12473.87526124727;12545.623631291075;12609.87390126087;12769.361531923552;13015.154014988995;12186.086043546948;12293.44679489443;12364.938175309066;12380.938095309466;12447.751044979232;12275.324857132586;12280.631581052583;12332.630021099381;12360.072994525626;12362.567310144103;10513.684589462327;10594.788104238027;10625.574977001143;10693.09108725767;10914.236003479999;10322.48387580633;10667.679969600924;10736.946315268373;10759.623413180501;10800.567977280822 05:37:11 INFO - PROCESS | 3370 | __end_tp_report 05:37:11 INFO - PROCESS | 3370 | __start_cc_report 05:37:11 INFO - PROCESS | 3370 | _x_x_mozilla_cycle_collect,1022 05:37:11 INFO - PROCESS | 3370 | __end_cc_report 05:37:11 INFO - PROCESS | 3370 | __startTimestamp1462538231634__endTimestamp 05:37:11 INFO - PROCESS | 3370 | 05:37:11 INFO - PROCESS | 3370 | ------- Summary: start ------- 05:37:11 INFO - PROCESS | 3370 | Number of tests: 6 05:37:11 INFO - PROCESS | 3370 | 05:37:11 INFO - PROCESS | 3370 | [#0] dojo.html Cycles:165 Average:5517.26 Median:5753.28 stddev:616.67 (10.7%) stddev-sans-first:592.86 05:37:11 INFO - PROCESS | 3370 | Values: 3271.5 3313.7 3344.8 3354.1 3371.9 5415.0 5423.5 5423.5 5426.4 5441.4 5427.3 5437.5 5444.1 5445.0 5480.6 4890.2 4922.3 4939.1 4980.2 5036.6 4905.3 4972.8 4974.0 4975.8 4983.6 5012.4 5033.9 5096.0 5100.5 5137.7 5132.3 5167.1 5176.4 5177.5 5203.2 4867.8 4957.6 4979.6 5094.7 5097.9 5497.2 5549.8 5551.9 5554.0 5558.5 5879.6 5938.2 5941.6 5942.5 5943.4 5797.1 5938.5 5964.3 5983.1 6034.0 5553.1 5561.6 5588.4 5590.0 5612.8 6072.2 6074.5 6075.9 6084.0 6086.1 5637.1 5752.6 5759.9 5805.5 5861.0 5915.4 5919.3 5930.1 5951.2 5967.9 5872.7 5874.3 5887.1 5887.7 5891.5 5667.3 5746.6 5894.2 5911.7 5988.9 4519.1 4520.9 4523.8 4548.7 4557.0 4025.2 4058.0 4059.2 4060.5 4083.3 5545.7 5698.1 5710.8 5718.2 5860.6 6014.2 6030.7 6031.9 6033.5 6035.2 5701.7 5711.9 5734.6 5753.3 5754.9 5004.2 5097.4 5142.6 5157.7 5202.6 6129.4 6129.8 6139.8 6157.4 6181.2 5891.0 5918.1 5923.2 5929.9 5934.9 5972.0 6038.4 6114.1 6135.5 6181.1 5861.0 5873.5 5885.7 5886.3 5896.1 5705.3 5976.8 5982.5 5982.8 5988.4 5767.8 5849.1 5877.6 5885.5 5906.0 5829.5 5836.1 5859.6 5865.1 5866.1 5615.8 5650.8 5732.8 5749.6 5783.5 5697.8 5783.9 5838.6 5894.9 5945.3 5762.0 5817.5 5818.3 5822.0 5854.1 05:37:11 INFO - PROCESS | 3370 | 05:37:11 INFO - PROCESS | 3370 | [#1] ext.html Cycles:180 Average:57667.59 Median:20677.39 stddev:113200.87 (547.5%) stddev-sans-first:113437.54 05:37:11 INFO - PROCESS | 3370 | Values: 672.9 677.4 688.1 740.0 751.9 31770.0 39750.0 40432.4 40463.2 40498.8 43912.1 44236.6 44548.3 44756.1 44775.3 7824.3 8778.9 8971.5 8997.5 10360.1 10486.0 10663.9 10665.6 10666.7 10667.4 10544.9 10692.6 10696.8 10698.4 10702.7 7819.6 10521.2 10548.7 10699.8 10763.7 10754.5 10827.1 10899.6 10902.9 10929.3 41612.8 42425.8 42452.0 42455.6 42485.4 3517.9 3765.5 4059.5 4096.2 4119.4 35058.3 35826.0 35975.6 36059.5 36089.5 4130.3 4171.5 4223.3 4255.2 4300.7 359363.0 362436.0 362628.0 362705.0 363467.0 37938.0 68865.3 70490.0 70529.0 70579.3 39137.8 39165.4 39211.0 39357.8 39394.4 13993.4 14301.3 14308.8 14324.1 14357.1 10257.0 11139.6 11355.7 11369.0 11373.5 9344.1 9466.6 9484.0 9536.6 9541.8 3620.9 3786.6 3793.1 3802.0 3805.6 1102.1 1108.7 1142.2 1176.5 1196.2 32776.5 33318.8 33575.3 33648.0 33662.3 1206.1 1221.2 1232.4 1282.5 1323.3 17397.9 17871.4 17873.8 18164.2 18234.4 554212.0 555946.0 556983.0 558270.0 559917.0 62091.0 63601.7 63720.4 63780.7 63836.7 1458.8 1479.8 1500.1 1526.2 1540.5 30620.0 33538.0 33906.5 33940.8 34630.7 49458.3 49641.3 49774.3 49848.0 49888.8 315959.0 323290.0 323713.0 324256.0 324476.0 26257.5 29233.9 29349.9 29380.0 29720.4 45994.0 46387.8 46640.0 47726.0 47806.5 41565.8 42066.4 42665.4 43507.3 43889.8 40338.8 41680.8 42174.6 42768.4 42919.8 43347.0 43535.3 44263.0 44295.0 44659.1 35392.1 37034.6 37589.2 37676.8 37703.8 26920.0 27826.0 29385.4 29435.1 29648.3 05:37:11 INFO - PROCESS | 3370 | 05:37:11 INFO - PROCESS | 3370 | [#2] jquery.html Cycles:180 Average:29152.94 Median:24405.77 stddev:82891.98 (339.6%) stddev-sans-first:83096.47 05:37:11 INFO - PROCESS | 3370 | Values: 436.0 439.9 441.6 448.4 456.7 19340.5 19669.8 20111.6 20474.8 20581.2 17948.8 19367.2 20464.6 20508.0 20524.4 5821.2 5932.6 5973.3 5982.0 5982.6 5717.5 5856.8 5868.1 5926.6 5935.5 5860.2 5869.1 5877.8 5880.0 5919.2 5671.4 5906.6 5923.0 5934.1 5936.3 5251.7 5255.2 5325.3 5341.4 5343.8 24196.2 24197.3 24614.3 24942.5 24976.6 2568.9 2642.8 2690.2 2899.2 2954.7 14892.8 15820.1 15835.9 15884.9 15982.6 2036.3 2107.0 2135.8 2136.5 2188.8 56022.0 61546.4 83895.0 84631.0 86711.1 11006.2 11439.5 11560.4 11714.4 11717.7 16506.5 16564.3 16643.3 16643.8 16679.2 6974.2 7916.8 8038.3 8226.9 8356.2 7734.9 7808.3 7842.9 7894.6 7980.1 7115.8 7251.2 7291.0 7367.5 7405.0 1984.8 2055.7 2092.0 2093.9 2119.6 1011.6 1115.9 1176.6 1177.8 1188.9 17421.4 18086.9 20542.4 20666.4 20757.3 1063.6 1090.4 1104.1 1106.4 1179.2 11526.7 11606.4 11826.5 11879.1 12072.2 457885.0 478113.0 499062.0 541253.0 544916.0 51899.5 77816.6 90131.5 90515.0 90941.5 1118.9 1127.9 1130.7 1139.9 1158.1 17932.2 17945.5 18250.2 18285.7 18445.7 39630.8 40146.6 41053.8 41054.2 41426.6 53903.0 54070.7 54494.0 55929.4 56092.0 8575.6 8711.8 8739.5 8773.3 8850.2 11122.4 11897.9 12071.3 12147.2 13075.9 10843.8 10992.3 11212.8 11248.8 11368.0 10958.2 11165.0 11174.3 11299.7 11387.1 10524.9 11403.8 11630.7 11748.3 11780.4 8617.6 8803.6 8833.5 8858.2 8950.8 8963.1 10853.0 11929.9 12083.9 12425.2 05:37:11 INFO - PROCESS | 3370 | 05:37:11 INFO - PROCESS | 3370 | [#3] mootools.html Cycles:180 Average:5792.60 Median:4771.96 stddev:3259.70 (68.3%) stddev-sans-first:3251.49 05:37:11 INFO - PROCESS | 3370 | Values: 1317.4 1477.5 1551.7 1703.3 1875.1 8255.7 8647.3 8649.1 8652.9 8661.6 8392.5 8582.1 8586.0 8588.8 8595.1 2406.2 2439.5 2442.0 2442.1 2443.1 2329.1 2396.2 2414.7 2437.4 2440.3 2338.8 2366.0 2367.6 2411.7 2427.8 2342.6 2371.1 2380.8 2381.0 2391.4 2265.1 2319.2 2325.8 2325.8 2326.5 7614.5 8343.7 8764.5 8814.7 8833.6 4969.4 5132.5 5136.6 5168.5 5180.5 3329.6 3356.5 3432.5 3465.4 3473.1 1103.5 1133.4 1134.3 1146.6 1149.2 11838.2 12263.4 12338.7 12352.9 12362.0 4791.4 4814.8 4816.1 4851.8 4874.7 10439.3 10449.3 10455.6 10456.2 10470.1 5143.2 5229.0 5259.4 5267.2 5267.7 4682.4 4752.5 4821.9 4843.3 4849.8 4008.0 4057.5 4069.9 4074.8 4156.8 1226.4 1230.6 1238.4 1242.5 1247.9 860.5 970.3 1040.1 1045.3 1065.9 6028.7 6062.9 6177.0 6225.6 6311.3 434.6 445.8 447.9 449.9 451.9 4368.9 4372.4 4375.1 4396.1 4406.0 10359.5 10698.4 10862.7 10874.7 10932.2 10766.5 10774.2 10799.4 10799.8 10814.0 7937.4 8146.7 8172.1 8216.3 8221.1 6069.2 6252.0 6264.1 6283.8 6427.1 9418.4 9872.1 9897.8 9980.5 10001.0 10169.9 10207.8 10262.1 10446.3 10557.9 7487.6 7537.7 7804.4 7844.7 7855.2 8296.5 8340.5 8395.4 8402.0 8427.8 7290.8 7435.3 7633.4 7699.0 7723.3 7490.9 7595.4 7620.3 7707.7 7714.8 6903.2 6908.7 6966.0 6976.4 6979.3 5144.3 5176.5 5224.8 5264.0 5363.3 5282.2 5337.6 5400.1 5500.0 5524.1 05:37:11 INFO - PROCESS | 3370 | 05:37:11 INFO - PROCESS | 3370 | [#4] prototype.html Cycles:180 Average:4885.91 Median:5478.59 stddev:1460.32 (26.7%) stddev-sans-first:1423.93 05:37:11 INFO - PROCESS | 3370 | Values: 336.6 350.2 352.0 352.9 356.7 5373.7 5388.5 5418.8 5424.9 5436.3 4988.2 5193.1 5284.6 5295.2 5336.2 4189.9 4240.3 4252.6 4263.4 4266.6 4262.7 4273.4 4279.4 4279.9 4286.8 3980.0 4036.4 4208.6 4215.5 4225.4 4172.4 4180.5 4199.0 4200.6 4213.9 3763.1 3767.2 3767.4 3778.7 3786.1 5127.2 5155.7 5178.2 5182.4 5260.8 4778.1 4796.0 4813.0 4813.2 4822.5 5575.1 5580.3 5593.8 5623.4 5640.3 3895.9 4118.6 4121.5 4135.7 4155.8 5842.5 5870.8 5877.0 5898.0 5903.0 4253.1 4264.7 4268.2 4270.0 4275.2 4159.6 4242.1 4270.3 4292.8 4303.5 4769.3 4783.3 4828.2 4841.2 4847.0 5603.4 5619.8 5624.7 5642.8 5682.3 1511.0 1544.5 1547.3 1553.1 1553.7 1001.8 1002.8 1007.7 1008.1 1017.1 5947.2 5958.9 5963.9 5965.2 5983.2 6259.3 6259.8 6263.7 6272.0 6292.7 5772.4 5925.5 5932.8 5958.7 5998.7 3310.7 3316.6 3317.1 3317.3 3326.6 6227.1 6303.5 6393.8 6397.5 6416.7 6258.0 6279.8 6281.2 6322.5 6328.5 6221.4 6413.5 6429.1 6449.6 6482.7 6156.9 6197.4 6211.2 6251.5 6254.2 6064.2 6090.3 6115.0 6147.5 6154.5 6243.6 6408.0 6419.0 6420.7 6425.5 3905.3 4073.8 4208.9 4428.3 4439.4 5782.0 5784.7 5799.9 5823.9 5827.2 5634.7 5684.9 5693.5 5700.8 5708.5 5514.8 5559.3 5575.1 5584.6 5666.0 5498.9 5515.9 5522.9 5548.8 5551.1 5458.3 5658.7 5682.5 5697.3 5698.6 5510.9 5527.7 5579.7 5592.2 5592.4 05:37:11 INFO - PROCESS | 3370 | 05:37:11 INFO - PROCESS | 3370 | [#5] yui.html Cycles:180 Average:15084.70 Median:25735.89 stddev:17794.11 (69.1%) stddev-sans-first:17811.39 05:37:11 INFO - PROCESS | 3370 | Values: 733.4 774.4 802.3 803.0 821.0 14033.6 14453.7 14463.6 14474.2 14509.6 12410.3 12442.3 12474.4 12477.4 12487.9 728.0 868.4 893.5 899.3 899.9 901.2 904.2 914.0 914.7 914.9 778.3 948.0 957.3 959.8 960.1 797.5 800.3 918.6 948.6 948.9 691.9 691.9 696.3 696.9 697.0 12656.9 12667.7 12766.2 12796.9 12800.7 13094.6 13394.3 13445.9 13508.0 13742.8 11068.0 11102.2 11239.6 11310.2 11423.9 3921.8 3929.1 3964.2 4033.2 4048.7 56553.7 56558.0 56885.7 57114.4 57275.4 10708.2 10877.4 10918.7 11020.1 11132.3 20179.6 20203.0 20211.3 20231.2 20242.2 7806.5 7991.6 8240.4 8316.3 8320.3 4740.6 4827.6 4900.0 4901.1 4901.9 3607.3 3657.1 3658.9 3668.3 3674.6 630.3 658.8 667.2 693.8 701.9 567.5 582.6 643.9 662.8 709.1 9081.5 9344.1 9388.3 9460.9 9491.1 643.9 695.6 713.5 718.7 733.3 4391.6 4494.3 4623.2 4655.3 4703.9 64933.7 66607.3 67201.0 67219.0 67407.3 51314.0 55970.0 57246.0 59172.1 59197.4 48641.8 50117.7 50913.0 51234.7 51418.7 8996.6 9305.9 9408.7 9481.2 9646.5 34266.5 34990.1 35099.0 35375.6 36750.0 43200.8 45485.5 46816.5 47447.5 47742.8 12942.7 12974.7 13104.5 13274.8 13402.9 12369.9 12597.6 12891.1 13051.6 13315.2 12473.9 12545.6 12609.9 12769.4 13015.2 12186.1 12293.4 12364.9 12380.9 12447.8 12275.3 12280.6 12332.6 12360.1 12362.6 10513.7 10594.8 10625.6 10693.1 10914.2 10322.5 10667.7 10736.9 10759.6 10800.6 05:37:11 INFO - PROCESS | 3370 | -------- Summary: end -------- 05:37:11 INFO - PROCESS | 3370 | 05:37:12 INFO - TEST-INFO | 3370: exit 0 05:37:12 INFO - TEST-OK | dromaeo_css | took 1113166ms 05:37:12 INFO - TEST-START | kraken 05:37:12 INFO - operating with platform_type : linux_ 05:37:12 INFO - Initialising browser for kraken test... 05:37:12 INFO - TEST-INFO | started process 3564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpekdmGU/profile http://localhost:60942/getInfo.html) 05:37:15 INFO - PROCESS | 3564 | __metrics Screen width/height:1600/1200 05:37:15 INFO - PROCESS | 3564 | colorDepth:24 05:37:15 INFO - PROCESS | 3564 | Browser inner width/height: 1024/697 05:37:15 INFO - PROCESS | 3564 | __metrics 05:37:16 ERROR - PROCESS | 3564 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:37:17 INFO - TEST-INFO | 3564: exit 0 05:37:17 INFO - Browser initialized. 05:37:17 INFO - Running cycle 1/1 for kraken test... 05:37:17 INFO - TEST-INFO | started process 3656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpekdmGU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:29 INFO - PROCESS | 3656 | RSS: Main: 141836288 05:37:29 INFO - PROCESS | 3656 | 05:37:31 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60942/tests/kraken/driver.html?testName=audio-beat-detection) 05:37:32 INFO - PROCESS | 3656 | RSS: Main: 197120000 05:37:32 INFO - PROCESS | 3656 | 05:37:35 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60942/tests/kraken/driver.html?testName=audio-dft) 05:37:36 INFO - PROCESS | 3656 | RSS: Main: 181190656 05:37:36 INFO - PROCESS | 3656 | 05:37:38 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60942/tests/kraken/driver.html?testName=audio-fft) 05:37:39 INFO - PROCESS | 3656 | RSS: Main: 272678912 05:37:39 INFO - PROCESS | 3656 | 05:37:41 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60942/tests/kraken/driver.html?testName=audio-oscillator) 05:37:42 INFO - PROCESS | 3656 | RSS: Main: 179036160 05:37:42 INFO - PROCESS | 3656 | 05:37:44 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60942/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:37:44 INFO - PROCESS | 3656 | RSS: Main: 177512448 05:37:44 INFO - PROCESS | 3656 | 05:37:47 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60942/tests/kraken/driver.html?testName=imaging-darkroom) 05:37:48 INFO - PROCESS | 3656 | RSS: Main: 212594688 05:37:48 INFO - PROCESS | 3656 | 05:37:51 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60942/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:52 INFO - PROCESS | 3656 | RSS: Main: 211238912 05:37:52 INFO - PROCESS | 3656 | 05:37:55 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60942/tests/kraken/driver.html?testName=json-parse-financial) 05:37:55 INFO - PROCESS | 3656 | RSS: Main: 211447808 05:37:55 INFO - PROCESS | 3656 | 05:37:57 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60942/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:57 INFO - PROCESS | 3656 | RSS: Main: 194519040 05:37:57 INFO - PROCESS | 3656 | 05:37:59 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60942/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:00 INFO - PROCESS | 3656 | RSS: Main: 196538368 05:38:00 INFO - PROCESS | 3656 | 05:38:02 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60942/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:02 INFO - PROCESS | 3656 | RSS: Main: 207970304 05:38:02 INFO - PROCESS | 3656 | 05:38:05 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:38:06 INFO - PROCESS | 3656 | RSS: Main: 210731008 05:38:06 INFO - PROCESS | 3656 | 05:38:08 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:38:09 INFO - PROCESS | 3656 | RSS: Main: 209174528 05:38:09 INFO - PROCESS | 3656 | 05:38:10 INFO - PROCESS | 3656 | Cycle 1(1): loaded http://localhost:60942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60942/tests/kraken/driver.html?testName=ai-astar) 05:38:11 INFO - PROCESS | 3656 | RSS: Main: 273334272 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | __start_tp_report 05:38:11 INFO - PROCESS | 3656 | _x_x_mozilla_page_load 05:38:11 INFO - PROCESS | 3656 | _x_x_mozilla_page_load_details 05:38:11 INFO - PROCESS | 3656 | |i|pagename|runs| 05:38:11 INFO - PROCESS | 3656 | |0;ai-astar;110;111;111;110;110;112;105;110;109;109 05:38:11 INFO - PROCESS | 3656 | |1;audio-beat-detection;166;126;160;183;128;154;161;135;180;126 05:38:11 INFO - PROCESS | 3656 | |2;audio-dft;162;161;160;160;161;162;162;158;158;158 05:38:11 INFO - PROCESS | 3656 | |3;audio-fft;74;76;75;171;76;76;73;75;165;76 05:38:11 INFO - PROCESS | 3656 | |4;audio-oscillator;95;92;153;91;92;91;144;93;92;137 05:38:11 INFO - PROCESS | 3656 | |5;imaging-gaussian-blur;116;117;116;116;116;116;117;117;116;117 05:38:11 INFO - PROCESS | 3656 | |6;imaging-darkroom;145;145;146;145;146;145;145;146;146;145 05:38:11 INFO - PROCESS | 3656 | |7;imaging-desaturate;94;94;94;94;95;94;94;94;94;94 05:38:11 INFO - PROCESS | 3656 | |8;json-parse-financial;53;55;55;53;56;55;55;73;54;52 05:38:11 INFO - PROCESS | 3656 | |9;json-stringify-tinderbox;57;58;58;57;58;57;62;57;58;58 05:38:11 INFO - PROCESS | 3656 | |10;stanford-crypto-aes;72;78;72;79;77;73;81;73;73;72 05:38:11 INFO - PROCESS | 3656 | |11;stanford-crypto-ccm;134;122;118;118;119;125;118;116;207;139 05:38:11 INFO - PROCESS | 3656 | |12;stanford-crypto-pbkdf2;160;160;160;159;161;165;161;165;161;160 05:38:11 INFO - PROCESS | 3656 | |13;stanford-crypto-sha256-iterative;70;66;66;67;66;67;67;66;67;64 05:38:11 INFO - PROCESS | 3656 | __end_tp_report 05:38:11 INFO - PROCESS | 3656 | __start_cc_report 05:38:11 INFO - PROCESS | 3656 | _x_x_mozilla_cycle_collect,1613 05:38:11 INFO - PROCESS | 3656 | __end_cc_report 05:38:11 INFO - PROCESS | 3656 | __startTimestamp1462538291247__endTimestamp 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | ------- Summary: start ------- 05:38:11 INFO - PROCESS | 3656 | Number of tests: 14 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:1.89 (1.7%) stddev-sans-first:2.00 05:38:11 INFO - PROCESS | 3656 | Values: 110.0 111.0 111.0 110.0 110.0 112.0 105.0 110.0 109.0 109.0 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:160.50 stddev:21.88 (13.6%) stddev-sans-first:22.60 05:38:11 INFO - PROCESS | 3656 | Values: 166.0 126.0 160.0 183.0 128.0 154.0 161.0 135.0 180.0 126.0 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#2] audio-dft Cycles:10 Average:160.20 Median:161.00 stddev:1.69 (1.0%) stddev-sans-first:1.66 05:38:11 INFO - PROCESS | 3656 | Values: 162.0 161.0 160.0 160.0 161.0 162.0 162.0 158.0 158.0 158.0 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.50 stddev:39.20 (51.9%) stddev-sans-first:40.92 05:38:11 INFO - PROCESS | 3656 | Values: 74.0 76.0 75.0 171.0 76.0 76.0 73.0 75.0 165.0 76.0 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:92.00 stddev:25.61 (27.8%) stddev-sans-first:26.73 05:38:11 INFO - PROCESS | 3656 | Values: 95.0 92.0 153.0 91.0 92.0 91.0 144.0 93.0 92.0 137.0 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:38:11 INFO - PROCESS | 3656 | Values: 116.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:38:11 INFO - PROCESS | 3656 | Values: 145.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:38:11 INFO - PROCESS | 3656 | Values: 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:6.06 (11.0%) stddev-sans-first:6.33 05:38:11 INFO - PROCESS | 3656 | Values: 53.0 55.0 55.0 53.0 56.0 55.0 55.0 73.0 54.0 52.0 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:1.49 (2.6%) stddev-sans-first:1.54 05:38:11 INFO - PROCESS | 3656 | Values: 57.0 58.0 58.0 57.0 58.0 57.0 62.0 57.0 58.0 58.0 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:3.40 (4.5%) stddev-sans-first:3.43 05:38:11 INFO - PROCESS | 3656 | Values: 72.0 78.0 72.0 79.0 77.0 73.0 81.0 73.0 73.0 72.0 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:123.50 stddev:27.56 (22.3%) stddev-sans-first:29.22 05:38:11 INFO - PROCESS | 3656 | Values: 134.0 122.0 118.0 118.0 119.0 125.0 118.0 116.0 207.0 139.0 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:161.00 stddev:2.10 (1.3%) stddev-sans-first:2.18 05:38:11 INFO - PROCESS | 3656 | Values: 160.0 160.0 160.0 159.0 161.0 165.0 161.0 165.0 161.0 160.0 05:38:11 INFO - PROCESS | 3656 | 05:38:11 INFO - PROCESS | 3656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.51 (2.2%) stddev-sans-first:0.97 05:38:11 INFO - PROCESS | 3656 | Values: 70.0 66.0 66.0 67.0 66.0 67.0 67.0 66.0 67.0 64.0 05:38:11 INFO - PROCESS | 3656 | -------- Summary: end -------- 05:38:11 INFO - PROCESS | 3656 | 05:38:12 INFO - TEST-INFO | 3656: exit 0 05:38:12 INFO - TEST-OK | kraken | took 59811ms 05:38:12 INFO - SUITE-END | took 1172s 05:38:12 INFO - Completed test suite (00:19:33) 05:38:12 INFO - javascript benchmark 05:38:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3271.5092736089587, 3313.668633136685, 3344.799312041277, 3354.09439451348, 3371.915702107447, 5415.0, 5423.457654234575, 5423.484768946953, 5426.375966763819, 5441.374241962166, 5427.267318911946, 5437.510624043835, 5444.128939369702, 5445.047116754562, 5480.6437581557275, 4890.24201248807, 4922.335484709563, 4939.110960027194, 4980.203167493201, 5036.647434679574, 4905.288733133693, 4972.751362431882, 4973.975130124344, 4975.8258460953875, 4983.551480366767, 5012.398512178544, 5033.899322013557, 5095.9745201273945, 5100.515451032146, 5137.717425541594, 5132.28148059272, 5167.121589329823, 5176.404713457963, 5177.508136727042, 5203.245529398235, 4867.805287788484, 4957.5786058185095, 4979.57673597741, 5094.745262736886, 5097.872553186163, 5497.202905578709, 5549.805756798492, 5551.861203469905, 5554.0, 5558.499735023867, 5879.559033072494, 5938.168656388109, 5941.613795103348, 5942.524598032147, 5943.4056594340655, 5797.101449275369, 5938.524918006592, 5964.314103878066, 5983.1025346197985, 6034.034554471307, 5553.0837411827, 5561.58288128392, 5588.441155884379, 5590.0, 5612.831615051555, 6072.210612620331, 6074.54440916933, 6075.939240607538, 6083.969580152071, 6086.087086936995, 5637.069883469264, 5752.626079304831, 5759.913601295984, 5805.477507024304, 5861.0, 5915.40845915405, 5919.348871624118, 5930.11048342752, 5951.166836642873, 5967.910481342783, 5872.7357268923, 5874.265716785402, 5887.0580707086665, 5887.705614719247, 5891.469767720926, 5667.348254950651, 5746.569007324468, 5894.17481552583, 5911.733971971272, 5988.850278743066, 4519.07358991406, 4520.864374068783, 4523.819047238074, 4548.727076375428, 4557.043020965634, 4025.2150830587752, 4058.0463591056077, 4059.167870586523, 4060.5330387005283, 4083.305838007546, 5545.667259964415, 5698.059820129715, 5710.829279997591, 5718.170865224519, 5860.560457965669, 6014.188084608521, 6030.728617212236, 6031.909521357183, 6033.456988871023, 6035.155078289043, 5701.71491425427, 5711.942880571224, 5734.598578099493, 5753.280839895013, 5754.856128596819, 5004.174311238605, 5097.362829646294, 5142.588592912558, 5157.6647517911215, 5202.609804264695, 6129.3870612939245, 6129.754809807558, 6139.84650383744, 6157.353477884758, 6181.196444462281, 5891.0, 5918.082697181943, 5923.229980102559, 5929.940700592939, 5934.881302374015, 5972.0, 6038.426349496966, 6114.084479019511, 6135.508280839814, 6181.072839074175, 5861.0, 5873.50075243592, 5885.676287804212, 5886.264216972879, 5896.145058966512, 5705.343885453226, 5976.820695379146, 5982.521398288213, 5982.760689572368, 5988.371221021905, 5767.826965191051, 5849.064149736022, 5877.559183061202, 5885.47030767233, 5906.0255057914965, 5829.47534721877, 5836.066229403275, 5859.589828711949, 5865.090910908816, 5866.090755932837, 5615.831525054255, 5650.773969041193, 5732.799352022659, 5749.568782341257, 5783.537317014545, 5697.772089116389, 5783.913241301299, 5838.5621078418435, 5894.911576326444, 5945.256842894638, 5762.049261871744, 5817.534597232296, 5818.330891947311, 5822.039363504974, 5854.063349864001], "value": 5476.965643326986, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.9259781424042, 677.3565113142516, 688.0539258519535, 739.9899137677071, 751.9360105450787, 31770.0, 39750.0, 40432.39351409724, 40463.190736185294, 40498.7975060125, 43912.121757564826, 44236.55763442365, 44548.3317750234, 44756.1048779025, 44775.32837007447, 7824.256695613936, 8778.912210877905, 8971.506567138806, 8997.505137217451, 10360.119389851872, 10486.0, 10663.893361066368, 10665.626703065394, 10666.679999600025, 10667.359958402481, 10544.894551054505, 10692.625758098467, 10696.839547406795, 10698.411587362692, 10702.678919632424, 7819.6481158348015, 10521.158307335394, 10548.736281592945, 10699.83950240747, 10763.730906727316, 10754.462276886203, 10827.133829293638, 10899.618513352074, 10902.890971090346, 10929.289596176222, 41612.79193604043, 42425.78787106045, 42452.0, 42455.57544424547, 42485.362719559234, 3517.859285628572, 3765.5293088363956, 4059.472268605092, 4096.160287141129, 4119.443875076856, 35058.298834023175, 35826.0, 35975.64024359749, 36059.4591081134, 36089.45865812015, 4130.318497447947, 4171.499420069581, 4223.345381465878, 4255.17024180285, 4300.65594752419, 359363.0, 362436.0, 362628.0, 362704.9999999974, 363467.0, 37938.0, 68865.3113468859, 70490.0, 70529.0, 70579.29420705728, 39137.80431097826, 39165.41251881224, 39211.0, 39357.80321098433, 39394.409083863764, 13993.3702983366, 14301.28493575317, 14308.785368219485, 14324.14055156694, 14357.066790658573, 10257.0, 11139.554417823196, 11355.716107097389, 11369.0, 11373.545058197746, 9344.065593440602, 9466.574004169828, 9484.0, 9536.61853525865, 9541.761455963517, 3620.87326943561, 3786.5645450772963, 3793.1275806564645, 3802.049487628093, 3805.5813860475328, 1102.0594239955556, 1108.711734948919, 1142.2404101272728, 1176.4999875053068, 1196.1567095197865, 32776.50835237473, 33318.83340583282, 33575.328493429995, 33648.0, 33662.3267534648, 1206.1135065726685, 1221.194011952125, 1232.4084439469104, 1282.5062350994933, 1323.2854258700386, 17397.913010434866, 17871.374501892373, 17873.821261787474, 18164.1826117825, 18234.36179733703, 554212.0, 555946.0, 556983.0, 558270.0, 559917.0, 62091.0, 63601.681991590674, 63720.36279637237, 63780.68109659422, 63836.68081659562, 1458.795768592398, 1479.7780332950144, 1500.1074360755333, 1526.175865032892, 1540.530138307827, 30620.0, 33538.0, 33906.49140262947, 33940.83029584836, 34630.653693462744, 49458.25812612742, 49641.25538116859, 49774.25338619996, 49848.0, 49888.75055624699, 315959.0, 323290.0, 323713.0, 324256.0, 324476.0, 26257.474850503266, 29233.85383073071, 29349.85325073361, 29380.0, 29720.405591887607, 45994.0, 46387.76806116083, 46640.0, 47726.0, 47806.5219347816, 41565.79217103895, 42066.369004464344, 42665.36001959911, 43507.347389789815, 43889.78055109704, 40338.798306008284, 41680.791596041825, 42174.578254217064, 42768.35847462353, 42919.7854010728, 43347.0, 43535.346969794846, 44263.0, 44295.0, 44659.10681786281, 35392.11519712028, 37034.629653703116, 37589.248215036096, 37676.81161594175, 37703.81148094242, 26920.0, 27826.0, 29385.412291754474, 29435.11694649164, 29648.258793530335], "value": 19796.410300303964, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.9978200108999, 439.9032212913159, 441.62461907378724, 448.44840845759694, 456.74194080344625, 19340.51648708781, 19669.803301966975, 20111.59776804465, 20474.795252047476, 20581.176752929903, 17948.82051179488, 19367.22531098758, 20464.590708185828, 20508.0, 20524.38426847193, 5821.155932389812, 5932.644041357532, 5973.313068997078, 5982.0, 5982.581219314649, 5717.542596592262, 5856.795012174574, 5868.149118377833, 5926.555508336871, 5935.465808077272, 5860.179574859501, 5869.060950247961, 5877.764889404419, 5880.029795083806, 5919.200907877446, 5671.404502527237, 5906.645601263938, 5922.97038514809, 5934.080217566284, 5936.2579677540525, 5251.658642188284, 5255.185446255837, 5325.334333208349, 5341.385740639837, 5343.759530821122, 24196.15313464038, 24197.274081777574, 24614.261572152864, 24942.50114997708, 24976.625350619754, 2568.9229323120335, 2642.8017898657677, 2690.166048524944, 2899.246195989037, 2954.689757575445, 14892.776608350776, 15820.129892855888, 15835.920820395824, 15884.920575397166, 15982.600434989103, 2036.256766280312, 2106.9894650526803, 2135.81845543129, 2136.5406437615834, 2188.835837312192, 56022.0, 61546.38453615496, 83895.0, 84631.0, 86711.13288867094, 11006.174536909764, 11439.485223164978, 11560.421978901022, 11714.355710435837, 11717.707057323634, 16506.504804855875, 16564.337426502803, 16643.3342666292, 16643.750343744854, 16679.16604169811, 6974.197967233732, 7916.84166316682, 8038.316743076904, 8226.917730822735, 8356.164383561716, 7734.883976740353, 7808.297253247235, 7842.921570784333, 7894.64474098667, 7980.122186559473, 7115.82210444743, 7251.1661158966335, 7291.0, 7367.484276100621, 7405.0, 1984.8440978843707, 2055.743032120985, 2091.98954005229, 2093.895305234732, 2119.6184686756224, 1011.5700827148432, 1115.9497822597841, 1176.599956014959, 1177.7526719388852, 1188.9121453869786, 17421.390251341396, 18086.90956545209, 20542.38372848817, 20666.380008599765, 20757.273495427587, 1063.5852017713098, 1090.3621381491757, 1104.0836106031975, 1106.3527836215742, 1179.1981452612135, 11526.654200374001, 11606.353495117635, 11826.52693892252, 11879.109066820023, 12072.215306005257, 457885.0, 478113.0, 499062.0, 541253.0, 544916.0, 51899.48100519022, 77816.61091694619, 90131.54934225418, 90515.0, 90941.54529227312, 1118.8545489086366, 1127.8646562412398, 1130.6721050895312, 1139.920205585601, 1158.0561842098493, 17932.19305131246, 17945.461636150416, 18250.167464832004, 18285.725714114033, 18445.72331415003, 39630.80184599059, 40146.59853401429, 41053.79473102615, 41054.178916422105, 41426.585734142274, 53903.0, 54070.729646351516, 54494.0, 55929.440705592424, 56092.0, 8575.571221439028, 8711.782205444915, 8739.475631462132, 8773.298136148966, 8850.247728943112, 11122.388268645302, 11897.881021189678, 12071.336076515525, 12147.210431321935, 13075.934620326838, 10843.837342439712, 10992.28550144238, 11212.775744485229, 11248.83126753083, 11368.033717134136, 10958.232923695583, 11165.0, 11174.329540227613, 11299.661010169708, 11387.089032877184, 10524.94737526338, 11403.771924561628, 11630.666746444896, 11748.29510229389, 11780.352080635646, 8617.569121544024, 8803.647854085764, 8833.469991800512, 8858.15847494487, 8950.82098358016, 8963.05887881763, 10853.021438619138, 11929.940350298193, 12083.879161208275, 12425.19236249641], "value": 9642.993011487673, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.354496296815, 1477.5198060630294, 1551.7362048451762, 1703.2846204594077, 1875.0905810681825, 8255.711050113247, 8647.308215342773, 8649.091845356226, 8652.91347086529, 8661.61022753976, 8392.454490458116, 8582.098879617644, 8585.957070214656, 8588.785280367994, 8595.097514760939, 2406.1578447543307, 2439.499902519988, 2441.951160976779, 2442.05980697431, 2443.1448992852447, 2329.1149363241943, 2396.1733202045352, 2414.6860908082012, 2437.402836305108, 2440.3411079008656, 2338.824588155895, 2366.0299277296313, 2367.621180611103, 2411.67442395277, 2427.757224277576, 2342.629561706404, 2371.1463873005705, 2380.821438392119, 2381.0356805493802, 2391.4021494626345, 2265.0713207584813, 2319.223060274793, 2325.802306803907, 2325.813934885205, 2326.4532834783813, 7614.505057171266, 8343.707970221014, 8764.474131552128, 8814.735557933273, 8833.558322083934, 4969.378827646544, 5132.461091585405, 5136.64043516954, 5168.508991645787, 5180.481951804827, 3329.5505106810515, 3356.5468661730843, 3432.485127230935, 3465.3935561276676, 3473.1317170707325, 1103.4648195625116, 1133.4162906103363, 1134.33641319828, 1146.60442147459, 1149.2242736153064, 11838.230515016496, 12263.448144833505, 12338.691532711664, 12352.938235308766, 12362.0, 4791.377120974321, 4814.759262036884, 4816.133096042746, 4851.830185943475, 4874.658773885794, 10439.269251152498, 10449.268551201343, 10455.581776728997, 10456.16350691958, 10470.057694807503, 5143.202803565453, 5229.0, 5259.368875734936, 5267.236250743621, 5267.657602255841, 4682.41469816273, 4752.5485078917445, 4821.927671084936, 4843.346148270009, 4849.830255941025, 4007.9599204007586, 4057.5130984281486, 4069.91860162801, 4074.8166332515107, 4156.750594964312, 1226.3929354969168, 1230.6492649594823, 1238.3560548514722, 1242.521629172775, 1247.9376031198585, 860.5224100624089, 970.3159272712861, 1040.0514541275418, 1045.289203341735, 1065.898739619735, 6028.698565071729, 6062.939370606326, 6177.0, 6225.595336303126, 6311.317689981739, 434.5676052327954, 445.77265594546367, 447.8701176658798, 449.94150760400936, 451.91413631409927, 4368.890777730582, 4372.366006929041, 4375.081232941055, 4396.142752163298, 4405.9559404405545, 10359.533820978075, 10698.358098514114, 10862.674119776419, 10874.728131796768, 10932.180086493387, 10766.515506802212, 10774.245802793886, 10799.406032668121, 10799.83800242997, 10814.0, 7937.444378893422, 8146.714864979697, 8172.060213075453, 8216.26053655174, 8221.095679475253, 6069.241344831896, 6251.968740156452, 6264.123022776724, 6283.7800676976085, 6427.132337134427, 9418.434893906388, 9872.062154095636, 9897.752556186153, 9980.451075190935, 10001.0, 10169.9491502542, 10207.795844082928, 10262.076413122855, 10446.268761186948, 10557.894421055691, 7487.588182650006, 7537.660805263667, 7804.375649947877, 7844.686212551434, 7855.175206603453, 8296.460730052528, 8340.457870238415, 8395.412321137463, 8402.0, 8427.789305267417, 7290.781276561712, 7435.299267313512, 7633.351165151024, 7699.0, 7723.304902558797, 7490.850182996201, 7595.392368610608, 7620.276073772982, 7707.730229441942, 7714.845703086019, 6903.1716194055025, 6908.654567271717, 6966.024756534191, 6976.407005404394, 6979.336962988508, 5144.254083157996, 5176.534111929945, 5224.843254702365, 5264.0, 5363.329583802025, 5282.154855223146, 5337.626366154332, 5400.108982017923, 5500.009998200202, 5524.088525393426], "value": 4579.239980321537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.62466350019736, 350.2312424228818, 351.98768043118486, 352.9011876674532, 356.6576086956523, 5373.7044462554595, 5388.464287678013, 5418.783248670058, 5424.864378390542, 5436.293281873361, 4988.226824842146, 5193.143131383326, 5284.603654725901, 5295.232191332255, 5336.17289320155, 4189.937150942731, 4240.342746874239, 4252.617264446199, 4263.424437700917, 4266.552012038738, 4262.744235345874, 4273.358996150571, 4279.443672322594, 4279.87160385189, 4286.807093680776, 3980.0, 4036.414719865618, 4208.621224089831, 4215.515215750182, 4225.366195070733, 4172.3532852407925, 4180.498340199196, 4198.958010419918, 4200.642945349634, 4213.915721685565, 3763.1344790698295, 3767.17122233111, 3767.3595488766973, 3778.6977041836863, 3786.091338078869, 5127.230915362688, 5155.664881782672, 5178.197379406198, 5182.378114626231, 5260.815871444519, 4778.139934811733, 4795.976020119912, 4813.0, 4813.205821039524, 4822.493638168012, 5575.107982722786, 5580.274564306615, 5593.804216852432, 5623.409541998072, 5640.2667653205235, 3895.8636447724193, 4118.629323360912, 4121.505419349667, 4135.6898232632375, 4155.812988415499, 5842.4741773240185, 5870.823875283749, 5876.97061514694, 5897.970510147465, 5902.97048514759, 4253.149370125987, 4264.701470897007, 4268.231718290675, 4270.0, 4275.187714334266, 4159.646430053479, 4242.130363275521, 4270.252705776476, 4292.82828686849, 4303.505096913832, 4769.308450274691, 4783.306420568998, 4828.179209534387, 4841.225403935354, 4846.951530484721, 5603.411641777636, 5619.831405057855, 5624.746886390122, 5642.830715078554, 5682.346530149003, 1510.9924450377678, 1544.4671588302017, 1547.3114464063608, 1553.0914415067086, 1553.712563175816, 1001.84972254161, 1002.834532302162, 1007.7128018514688, 1008.0876806490138, 1017.1151098544314, 5947.167396564484, 5958.85102872423, 5963.850903727442, 5965.194698715704, 5983.23056474427, 6259.342769009279, 6259.843503912348, 6263.71813268404, 6272.0, 6292.685365731695, 5772.365039845614, 5925.496332811673, 5932.79235226765, 5958.672273025025, 5998.670073145931, 3310.702036816698, 3316.6185888623118, 3317.0546394278, 3317.286783341593, 3326.550915626408, 6227.1282020517165, 6303.464205542488, 6393.840153996094, 6397.52018598607, 6416.743330266737, 6257.9687101564205, 6279.811605651837, 6281.214848143982, 6322.462590679844, 6328.462080723098, 6221.4089661482085, 6413.454856337264, 6429.067785171124, 6449.580777249464, 6482.67586620667, 6156.938430615636, 6197.380261973766, 6211.223597050369, 6251.499880009679, 6254.249490061222, 6064.151018857276, 6090.269167699727, 6115.0, 6147.538934579835, 6154.476869466145, 6243.562950593415, 6408.0, 6419.0, 6420.678966051585, 6425.518086143651, 3905.258000979805, 4073.7982295223574, 4208.873733787991, 4428.269335559597, 4439.356293337512, 5781.971090144522, 5784.739686714192, 5799.884002320015, 5823.94176058234, 5827.24245848037, 5634.74643641029, 5684.857878553069, 5693.5160511357, 5700.800471983461, 5708.543316534584, 5514.779408823602, 5559.33288005442, 5575.076598573486, 5584.553235741212, 5665.971670141623, 5498.862528436661, 5515.862103447446, 5522.91715624274, 5548.805791797267, 5551.111822108443, 5458.325420543984, 5658.688772117408, 5682.522544138471, 5697.259356283656, 5698.601097923106, 5510.862228444161, 5527.695976721158, 5579.721013949205, 5592.161175823659, 5592.356878958972], "value": 4428.333561992855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.4315905173492, 774.4491506442959, 802.2819576479052, 803.0250261207023, 821.0, 14033.578992630224, 14453.710925781492, 14463.638409039779, 14474.203918784462, 14509.564713058598, 12410.255384676902, 12442.315672638024, 12474.438650260738, 12477.438515266813, 12487.875121248784, 727.9818004549888, 868.3660927522913, 893.5041052216018, 899.3120262998812, 899.8650202469616, 901.1844280925773, 904.2268860124598, 913.954302284883, 914.6661468563992, 914.8993610702818, 778.264540009691, 947.9668211612595, 957.3155194036262, 959.8176346494143, 960.1166926427703, 797.5334429358832, 800.2797482265948, 918.5728636184207, 948.6063283737241, 948.9003654616234, 691.920429150649, 691.937725604698, 696.3245651717825, 696.8815301398774, 697.0206859362553, 12656.936715316457, 12667.683307917376, 12766.17019893704, 12796.872031279661, 12800.679983000406, 13094.607161785161, 13394.330283485786, 13445.932770336183, 13508.0, 13742.799618311145, 11068.0, 11102.222844400896, 11239.60661376848, 11310.151738619636, 11423.94288028563, 3921.784301863396, 3929.135590170158, 3964.207158568269, 4033.1530378620523, 4048.67610591152, 56553.71723141358, 56558.0, 56885.71557142229, 57114.428855711325, 57275.42724572701, 10708.19688523364, 10877.401742904058, 10918.72703182411, 11020.118390528738, 11132.276402033842, 20179.596408071757, 20203.0, 20211.292604758764, 20231.190752370036, 20242.190312387338, 7806.4925779824125, 7991.640376183086, 8240.381971352173, 8316.334693224528, 8320.334373250125, 4740.620750339965, 4827.637927155477, 4900.0, 4901.142300097468, 4901.926471102936, 3607.296577167427, 3657.0674478007936, 3658.926821463609, 3668.321360548307, 3674.614165512636, 630.2594451519446, 658.8122385120314, 667.1760375935716, 693.8126705789408, 701.9333163349473, 567.5069944491661, 582.5543459253674, 643.8519140597689, 662.8342914271432, 709.0675761373777, 9081.45511269326, 9344.065593440602, 9388.295877809192, 9460.90539094614, 9491.145796878314, 643.9291677915426, 695.6278391060758, 713.4934196720386, 718.7089228862319, 733.2850470790936, 4391.560843915583, 4494.258447356149, 4623.190941585209, 4655.255159174516, 4703.882402939954, 64933.67533162304, 66607.33392666109, 67201.0, 67218.99171512431, 67407.32592674109, 51314.0, 55970.0, 57246.0, 59172.11241831376, 59197.40802591919, 48641.75679121582, 50117.74941125271, 50913.0, 51234.743826281374, 51418.74290628523, 8996.55017249148, 9305.906940930505, 9408.717738467856, 9481.194098501705, 9646.517674116407, 34266.45800938914, 34990.12524686903, 35099.0, 35375.64624353724, 36750.0, 43200.783996079816, 45485.54514454813, 46816.53183468258, 47447.52552474569, 47742.761286193345, 12942.676433089247, 12974.740505189655, 13104.475820967054, 13274.80087798703, 13402.93298533501, 12369.93815030919, 12597.622071337875, 12891.097623166288, 13051.608451746462, 13315.201087934754, 12473.87526124727, 12545.623631291075, 12609.87390126087, 12769.361531923552, 13015.154014988995, 12186.086043546948, 12293.44679489443, 12364.938175309066, 12380.938095309466, 12447.751044979232, 12275.324857132586, 12280.631581052583, 12332.630021099381, 12360.072994525626, 12362.567310144103, 10513.684589462327, 10594.788104238027, 10625.574977001143, 10693.09108725767, 10914.236003479999, 10322.48387580633, 10667.679969600924, 10736.946315268373, 10759.623413180501, 10800.567977280822], "value": 6845.800112295733, "unit": "score"}], "name": "dromaeo_css", "value": 7249.475245197519, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 110.0, 110.0, 112.0, 105.0, 110.0, 109.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 126.0, 160.0, 183.0, 128.0, 154.0, 161.0, 135.0, 180.0, 126.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 160.0, 161.0, 162.0, 162.0, 158.0, 158.0, 158.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 171.0, 76.0, 76.0, 73.0, 75.0, 165.0, 76.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 92.0, 153.0, 91.0, 92.0, 91.0, 144.0, 93.0, 92.0, 137.0], "value": 108.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 53.0, 56.0, 55.0, 55.0, 73.0, 54.0, 52.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 57.0, 58.0, 57.0, 62.0, 57.0, 58.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 78.0, 72.0, 79.0, 77.0, 73.0, 81.0, 73.0, 73.0, 72.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 122.0, 118.0, 118.0, 119.0, 125.0, 118.0, 116.0, 207.0, 139.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 161.0, 165.0, 161.0, 165.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 67.0, 64.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1527.8999999999999, "alertThreshold": 2.0}]} 05:38:12 INFO - Return code: 0 05:38:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:38:12 ERROR - # TBPL SUCCESS # 05:38:12 INFO - Running post-action listener: _resource_record_post_action 05:38:12 INFO - Running post-run listener: _resource_record_post_run 05:38:13 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 7925760; Write bytes: 374939648; Read time: 1292; Write time: 286420 05:38:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1044480; Read time: 0; Write time: 220 05:38:13 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 6189056; Write bytes: 373895168; Read time: 1248; Write time: 286200 05:38:13 INFO - Running post-run listener: _upload_blobber_files 05:38:13 INFO - Blob upload gear active. 05:38:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:38:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:38:14 INFO - (blobuploader) - INFO - Open directory for files ... 05:38:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:38:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:38:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:14 INFO - (blobuploader) - INFO - Done attempting. 05:38:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:38:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:38:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:15 INFO - (blobuploader) - INFO - Done attempting. 05:38:15 INFO - (blobuploader) - INFO - Iteration through files over. 05:38:15 INFO - Return code: 0 05:38:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:38:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:38:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90e927796ce2951f4dde7c80024740a9cb32a06fffa93f987314b766a5c3befad034c3f6e7da42c614d5ce24cd87b96f0a1e80b1800c7aa62b30013f93a150b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d782202ec8c3e012c17f968de3a62a4cb0340d6965bbb40ff6ac1f82b28518664d6fd70f20a0723474d5cecc80425ac2794b2eeda0abaaccc477fecd237bf64"} 05:38:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:38:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:38:15 INFO - Contents: 05:38:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90e927796ce2951f4dde7c80024740a9cb32a06fffa93f987314b766a5c3befad034c3f6e7da42c614d5ce24cd87b96f0a1e80b1800c7aa62b30013f93a150b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d782202ec8c3e012c17f968de3a62a4cb0340d6965bbb40ff6ac1f82b28518664d6fd70f20a0723474d5cecc80425ac2794b2eeda0abaaccc477fecd237bf64"} 05:38:15 INFO - Running post-run listener: copy_logs_to_upload_dir 05:38:15 INFO - Copying logs to upload dir... 05:38:15 INFO - mkdir: /builds/slave/test/build/upload/logs 05:38:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.031583 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-05-06 05:38:15.715417) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 05:38:15.718916) ========= 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=ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889 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/90e927796ce2951f4dde7c80024740a9cb32a06fffa93f987314b766a5c3befad034c3f6e7da42c614d5ce24cd87b96f0a1e80b1800c7aa62b30013f93a150b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d782202ec8c3e012c17f968de3a62a4cb0340d6965bbb40ff6ac1f82b28518664d6fd70f20a0723474d5cecc80425ac2794b2eeda0abaaccc477fecd237bf64"} 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.011344 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/90e927796ce2951f4dde7c80024740a9cb32a06fffa93f987314b766a5c3befad034c3f6e7da42c614d5ce24cd87b96f0a1e80b1800c7aa62b30013f93a150b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d782202ec8c3e012c17f968de3a62a4cb0340d6965bbb40ff6ac1f82b28518664d6fd70f20a0723474d5cecc80425ac2794b2eeda0abaaccc477fecd237bf64"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 05:38:15.744291) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:38:15.744606) ========= 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=ed14279e38b05397cf4aa391000001a4-1462535955.767086-18655889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:38:15.828277) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 05:38:15.828606) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 05:38:15.828907) ========= ========= Total master_lag: 0.18 =========