builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1462537112.42 results: success (0) buildid: 20160506013122 builduid: edd2de8de4ca48969474bf5b1f92b92a revision: b14d8e23323e95c5db3bc4cca69738edeee44302 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:32.419168) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:32.419842) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:32.420215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:32.437020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:32.437370) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 05:18:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.6M=0s 2016-05-06 05:18:33 (23.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106719 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:32.559171) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:32.559568) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019430 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:32.610509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:32.610873) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 05:18:33,963 truncating revision to first 12 chars 2016-05-06 05:18:33,963 Setting DEBUG logging. 2016-05-06 05:18:33,963 attempt 1/10 2016-05-06 05:18:33,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b14d8e23323e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 05:18:34,624 unpacking tar archive at: mozilla-aurora-b14d8e23323e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.944873 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:33.568768) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:33.569100) ========= script_repo_revision: b14d8e23323e95c5db3bc4cca69738edeee44302 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:33.569531) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:33.569795) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 05:18:33.578403) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-06 05:18:33.578823) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:18:35 INFO - MultiFileLogger online at 20160506 05:18:35 in /builds/slave/test 05:18:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:18:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:18:35 INFO - {'append_to_log': False, 05:18:35 INFO - 'base_work_dir': '/builds/slave/test', 05:18:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:18:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:18:35 INFO - 'branch': 'Mozilla-Aurora', 05:18:35 INFO - 'buildbot_json_path': 'buildprops.json', 05:18:35 INFO - 'config_files': ('talos/linux_config.py',), 05:18:35 INFO - 'default_actions': ('clobber', 05:18:35 INFO - 'read-buildbot-config', 05:18:35 INFO - 'download-and-extract', 05:18:35 INFO - 'populate-webroot', 05:18:35 INFO - 'create-virtualenv', 05:18:35 INFO - 'install', 05:18:35 INFO - 'run-tests'), 05:18:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:18:35 INFO - 'download_minidump_stackwalk': True, 05:18:35 INFO - 'download_symbols': 'ondemand', 05:18:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:18:35 INFO - 'tooltool.py': '/tools/tooltool.py', 05:18:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:18:35 INFO - '/tools/misc-python/virtualenv.py')}, 05:18:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:18:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:18:35 INFO - 'installer_path': 'installer.exe', 05:18:35 INFO - 'log_level': 'info', 05:18:35 INFO - 'log_name': 'talos', 05:18:35 INFO - 'log_to_console': True, 05:18:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:18:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:18:35 INFO - 'opt_config_files': (), 05:18:35 INFO - 'pip_index': False, 05:18:35 INFO - 'sps_profile': False, 05:18:35 INFO - 'sps_profile_interval': 0, 05:18:35 INFO - 'suite': 'dromaeojs', 05:18:35 INFO - 'system_bits': '32', 05:18:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:18:35 INFO - 'title': 'talos-linux64-ix-067', 05:18:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:18:35 INFO - 'use_talos_json': True, 05:18:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:18:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:18:35 INFO - 'work_dir': 'build'} 05:18:35 INFO - ##### 05:18:35 INFO - ##### Running clobber step. 05:18:35 INFO - ##### 05:18:35 INFO - Running pre-action listener: _resource_record_pre_action 05:18:35 INFO - Running main action method: clobber 05:18:35 INFO - rmtree: /builds/slave/test/build 05:18:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:18:35 INFO - Running post-action listener: _resource_record_post_action 05:18:35 INFO - ##### 05:18:35 INFO - ##### Running read-buildbot-config step. 05:18:35 INFO - ##### 05:18:35 INFO - Running pre-action listener: _resource_record_pre_action 05:18:35 INFO - Running main action method: read_buildbot_config 05:18:35 INFO - Using buildbot properties: 05:18:35 INFO - { 05:18:35 INFO - "project": "", 05:18:35 INFO - "product": "firefox", 05:18:35 INFO - "script_repo_revision": "production", 05:18:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:18:35 INFO - "repository": "", 05:18:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:18:35 INFO - "buildid": "20160506013122", 05:18:35 INFO - "pgo_build": "True", 05:18:35 INFO - "basedir": "/builds/slave/test", 05:18:35 INFO - "buildnumber": 309, 05:18:35 INFO - "slavename": "talos-linux64-ix-067", 05:18:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:18:35 INFO - "platform": "ubuntu64_hw", 05:18:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:18:35 INFO - "branch": "mozilla-aurora", 05:18:35 INFO - "repo_path": "releases/mozilla-aurora", 05:18:35 INFO - "revision": "b14d8e23323e95c5db3bc4cca69738edeee44302", 05:18:35 INFO - "stage_platform": "linux64-pgo", 05:18:35 INFO - "builduid": "edd2de8de4ca48969474bf5b1f92b92a", 05:18:35 INFO - "slavebuilddir": "test" 05:18:35 INFO - } 05:18:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 05:18:35 INFO - Running post-action listener: _resource_record_post_action 05:18:35 INFO - ##### 05:18:35 INFO - ##### Running download-and-extract step. 05:18:35 INFO - ##### 05:18:35 INFO - Running pre-action listener: _resource_record_pre_action 05:18:35 INFO - Running main action method: download_and_extract 05:18:35 INFO - mkdir: /builds/slave/test/build/tests 05:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:35 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:18:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:18:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:18:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:18:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:18:36 INFO - Downloaded 1361 bytes. 05:18:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:18:36 INFO - Using the following test package requirements: 05:18:36 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:18:36 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:18:36 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:18:36 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:36 INFO - u'jsshell-linux-x86_64.zip'], 05:18:36 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:18:36 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:18:36 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:18:36 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:18:36 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:18:36 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:18:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:18:36 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:18:36 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:36 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:18:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:18:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:18:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:18:37 INFO - Downloaded 23822984 bytes. 05:18:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:18:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:18:38 INFO - Return code: 0 05:18:38 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:38 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:18:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:18:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:18:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:18:39 INFO - Downloaded 23822984 bytes. 05:18:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:18:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:18:41 INFO - Return code: 0 05:18:41 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:41 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:18:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:18:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:18:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:18:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:18:42 INFO - Downloaded 10840145 bytes. 05:18:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:18:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:18:42 INFO - Return code: 0 05:18:42 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:42 INFO - https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:18:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:18:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:18:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:18:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:18:43 INFO - Downloaded 62693495 bytes. 05:18:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:18:43 INFO - mkdir: /builds/slave/test/properties 05:18:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:18:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:18:43 INFO - Contents: 05:18:43 INFO - build_url:https://queue.taskcluster.net/v1/task/JKZx2dolTVCc5-zzaL5gVQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:18:44 INFO - Running post-action listener: _resource_record_post_action 05:18:44 INFO - Running post-action listener: set_extra_try_arguments 05:18:44 INFO - ##### 05:18:44 INFO - ##### Running populate-webroot step. 05:18:44 INFO - ##### 05:18:44 INFO - Running pre-action listener: _resource_record_pre_action 05:18:44 INFO - Running main action method: populate_webroot 05:18:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:18:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:18:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:18:44 INFO - '--tppagecycles', 05:18:44 INFO - '7'], 05:18:44 INFO - 'tests': ['tsvgm']}}, 05:18:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:18:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:18:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:18:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:18:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:18:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:18:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:44 INFO - 'talos_options': ['--disable-e10s'], 05:18:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:44 INFO - 'talos_options': ['--disable-e10s'], 05:18:44 INFO - 'tests': ['damp', 'tps']}, 05:18:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:44 INFO - 'tests': ['damp', 'tps']}, 05:18:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:18:44 INFO - 'tests': ['dromaeo_dom']}, 05:18:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:18:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:18:44 INFO - 'tests': ['a11yr', 05:18:44 INFO - 'ts_paint', 05:18:44 INFO - 'tpaint', 05:18:44 INFO - 'sessionrestore', 05:18:44 INFO - 'sessionrestore_no_auto_restore', 05:18:44 INFO - 'tabpaint']}, 05:18:44 INFO - 'other-e10s': {'tests': ['a11yr', 05:18:44 INFO - 'ts_paint', 05:18:44 INFO - 'tpaint', 05:18:44 INFO - 'sessionrestore', 05:18:44 INFO - 'sessionrestore_no_auto_restore', 05:18:44 INFO - 'tabpaint']}, 05:18:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:18:44 INFO - 'ts_paint', 05:18:44 INFO - 'tpaint', 05:18:44 INFO - 'sessionrestore', 05:18:44 INFO - 'sessionrestore_no_auto_restore', 05:18:44 INFO - 'tabpaint']}, 05:18:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:18:44 INFO - 'ts_paint', 05:18:44 INFO - 'tpaint', 05:18:44 INFO - 'sessionrestore', 05:18:44 INFO - 'sessionrestore_no_auto_restore', 05:18:44 INFO - 'tabpaint']}, 05:18:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:18:44 INFO - 'tests': ['a11yr', 05:18:44 INFO - 'ts_paint', 05:18:44 INFO - 'tpaint', 05:18:44 INFO - 'sessionrestore', 05:18:44 INFO - 'sessionrestore_no_auto_restore', 05:18:44 INFO - 'tabpaint']}, 05:18:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:18:44 INFO - 'tests': ['a11yr', 05:18:44 INFO - 'ts_paint', 05:18:44 INFO - 'tpaint', 05:18:44 INFO - 'sessionrestore', 05:18:44 INFO - 'sessionrestore_no_auto_restore', 05:18:44 INFO - 'tabpaint']}, 05:18:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:18:44 INFO - 'tests': ['tsvgx', 05:18:44 INFO - 'tsvgr_opacity', 05:18:44 INFO - 'tart', 05:18:44 INFO - 'tscrollx', 05:18:44 INFO - 'cart']}, 05:18:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:18:44 INFO - 'tsvgr_opacity', 05:18:44 INFO - 'tart', 05:18:44 INFO - 'tscrollx', 05:18:44 INFO - 'cart']}, 05:18:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:44 INFO - 'talos_options': ['--disable-e10s'], 05:18:44 INFO - 'tests': ['tp5o']}, 05:18:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:44 INFO - 'tests': ['tp5o']}, 05:18:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:44 INFO - 'talos_options': ['--disable-e10s', 05:18:44 INFO - '--xperf_path', 05:18:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:44 INFO - 'tests': ['tp5n']}, 05:18:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:44 INFO - 'talos_options': ['--xperf_path', 05:18:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:44 INFO - 'tests': ['tp5n']}}, 05:18:44 INFO - 'talos.zip': {'path': '', 05:18:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:18:44 INFO - Running post-action listener: _resource_record_post_action 05:18:44 INFO - ##### 05:18:44 INFO - ##### Running create-virtualenv step. 05:18:44 INFO - ##### 05:18:44 INFO - Running pre-action listener: _resource_record_pre_action 05:18:44 INFO - Running main action method: create_virtualenv 05:18:44 INFO - Creating virtualenv /builds/slave/test/build/venv 05:18:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:18:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:18:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:18:44 INFO - Using real prefix '/usr' 05:18:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:18:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:18:47 INFO - Installing pip.................done. 05:18:47 INFO - Return code: 0 05:18:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:47 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 0x7f2b87b75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb5410>, '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 0x1fb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', '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:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:18:47 INFO - Using env: {'DISPLAY': ':0', 05:18:47 INFO - 'HOME': '/home/cltbld', 05:18:47 INFO - 'LANG': 'en_US.UTF-8', 05:18:47 INFO - 'LANGUAGE': 'en_US:en', 05:18:47 INFO - 'LOGNAME': 'cltbld', 05:18:47 INFO - 'MAIL': '/var/mail/cltbld', 05:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:47 INFO - 'MOZ_NO_REMOTE': '1', 05:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:47 INFO - 'NO_EM_RESTART': '1', 05:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:47 INFO - 'PWD': '/builds/slave/test', 05:18:47 INFO - 'SHELL': '/bin/bash', 05:18:47 INFO - 'SHLVL': '1', 05:18:47 INFO - 'TERM': 'linux', 05:18:47 INFO - 'TMOUT': '86400', 05:18:47 INFO - 'USER': 'cltbld', 05:18:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 05:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:47 INFO - '_': '/tools/buildbot/bin/python'} 05:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:18:47 INFO - Cleaning up... 05:18:47 INFO - Return code: 0 05:18:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:47 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 0x7f2b87b75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb5410>, '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 0x1fb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', '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:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:18:47 INFO - Using env: {'DISPLAY': ':0', 05:18:47 INFO - 'HOME': '/home/cltbld', 05:18:47 INFO - 'LANG': 'en_US.UTF-8', 05:18:47 INFO - 'LANGUAGE': 'en_US:en', 05:18:47 INFO - 'LOGNAME': 'cltbld', 05:18:47 INFO - 'MAIL': '/var/mail/cltbld', 05:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:47 INFO - 'MOZ_NO_REMOTE': '1', 05:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:47 INFO - 'NO_EM_RESTART': '1', 05:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:47 INFO - 'PWD': '/builds/slave/test', 05:18:47 INFO - 'SHELL': '/bin/bash', 05:18:47 INFO - 'SHLVL': '1', 05:18:47 INFO - 'TERM': 'linux', 05:18:47 INFO - 'TMOUT': '86400', 05:18:47 INFO - 'USER': 'cltbld', 05:18:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 05:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:47 INFO - '_': '/tools/buildbot/bin/python'} 05:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:47 INFO - Downloading/unpacking psutil>=0.7.1 05:18:47 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:47 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:47 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:47 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:47 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:47 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:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:18:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:49 INFO - Installing collected packages: psutil 05:18:49 INFO - Running setup.py install for psutil 05:18:49 INFO - building 'psutil._psutil_linux' extension 05:18:49 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:49 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:49 INFO - building 'psutil._psutil_posix' extension 05:18:49 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:49 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:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:49 INFO - Successfully installed psutil 05:18:49 INFO - Cleaning up... 05:18:50 INFO - Return code: 0 05:18:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:50 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 0x7f2b87b75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb5410>, '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 0x1fb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', '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:50 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:50 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:50 INFO - Using env: {'DISPLAY': ':0', 05:18:50 INFO - 'HOME': '/home/cltbld', 05:18:50 INFO - 'LANG': 'en_US.UTF-8', 05:18:50 INFO - 'LANGUAGE': 'en_US:en', 05:18:50 INFO - 'LOGNAME': 'cltbld', 05:18:50 INFO - 'MAIL': '/var/mail/cltbld', 05:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:50 INFO - 'MOZ_NO_REMOTE': '1', 05:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:50 INFO - 'NO_EM_RESTART': '1', 05:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:50 INFO - 'PWD': '/builds/slave/test', 05:18:50 INFO - 'SHELL': '/bin/bash', 05:18:50 INFO - 'SHLVL': '1', 05:18:50 INFO - 'TERM': 'linux', 05:18:50 INFO - 'TMOUT': '86400', 05:18:50 INFO - 'USER': 'cltbld', 05:18:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 05:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:50 INFO - '_': '/tools/buildbot/bin/python'} 05:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:18:50 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:50 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:50 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:50 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:50 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:50 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:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:18:52 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:52 INFO - Installing collected packages: mozsystemmonitor 05:18:52 INFO - Running setup.py install for mozsystemmonitor 05:18:52 INFO - Successfully installed mozsystemmonitor 05:18:52 INFO - Cleaning up... 05:18:52 INFO - Return code: 0 05:18:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:18:52 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:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:52 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:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:52 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 0x7f2b87b75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb5410>, '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 0x1fb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 05:18:52 INFO - 'HOME': '/home/cltbld', 05:18:52 INFO - 'LANG': 'en_US.UTF-8', 05:18:52 INFO - 'LANGUAGE': 'en_US:en', 05:18:52 INFO - 'LOGNAME': 'cltbld', 05:18:52 INFO - 'MAIL': '/var/mail/cltbld', 05:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:52 INFO - 'MOZ_NO_REMOTE': '1', 05:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:52 INFO - 'NO_EM_RESTART': '1', 05:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:52 INFO - 'PWD': '/builds/slave/test', 05:18:52 INFO - 'SHELL': '/bin/bash', 05:18:52 INFO - 'SHLVL': '1', 05:18:52 INFO - 'TERM': 'linux', 05:18:52 INFO - 'TMOUT': '86400', 05:18:52 INFO - 'USER': 'cltbld', 05:18:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 05:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:52 INFO - '_': '/tools/buildbot/bin/python'} 05:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:18:52 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:52 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:52 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:52 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:52 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:52 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:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:18:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:18:54 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:54 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:54 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:54 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:54 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:54 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:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:18:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:18:54 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:54 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:54 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:54 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:54 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:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:55 INFO - Downloading docopt-0.6.1.tar.gz 05:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:18:55 INFO - Installing collected packages: blobuploader, requests, docopt 05:18:55 INFO - Running setup.py install for blobuploader 05:18:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:18:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:18:55 INFO - Running setup.py install for requests 05:18:55 INFO - Running setup.py install for docopt 05:18:55 INFO - Successfully installed blobuploader requests docopt 05:18:55 INFO - Cleaning up... 05:18:55 INFO - Return code: 0 05:18:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f2b87b75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb5410>, '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 0x1fb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 05:18:55 INFO - 'HOME': '/home/cltbld', 05:18:55 INFO - 'LANG': 'en_US.UTF-8', 05:18:55 INFO - 'LANGUAGE': 'en_US:en', 05:18:55 INFO - 'LOGNAME': 'cltbld', 05:18:55 INFO - 'MAIL': '/var/mail/cltbld', 05:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:55 INFO - 'MOZ_NO_REMOTE': '1', 05:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:55 INFO - 'NO_EM_RESTART': '1', 05:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:55 INFO - 'PWD': '/builds/slave/test', 05:18:55 INFO - 'SHELL': '/bin/bash', 05:18:55 INFO - 'SHLVL': '1', 05:18:55 INFO - 'TERM': 'linux', 05:18:55 INFO - 'TMOUT': '86400', 05:18:55 INFO - 'USER': 'cltbld', 05:18:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 05:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:55 INFO - '_': '/tools/buildbot/bin/python'} 05:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:55 INFO - Running setup.py (path:/tmp/pip-kW8Vtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:56 INFO - Running setup.py (path:/tmp/pip-MYwpQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:56 INFO - Running setup.py (path:/tmp/pip-JU6oY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:56 INFO - Running setup.py (path:/tmp/pip-XvoZJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:56 INFO - Running setup.py (path:/tmp/pip-amgzBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:56 INFO - Running setup.py (path:/tmp/pip-Bn15wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:56 INFO - Running setup.py (path:/tmp/pip-CyaRAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:56 INFO - Running setup.py (path:/tmp/pip-AkhDWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:56 INFO - Running setup.py (path:/tmp/pip-14Yj30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:56 INFO - Running setup.py (path:/tmp/pip-K8BVzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:56 INFO - Running setup.py (path:/tmp/pip-gyhnjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:56 INFO - Running setup.py (path:/tmp/pip-BZOXeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:56 INFO - Running setup.py (path:/tmp/pip-YR1VoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:56 INFO - Running setup.py (path:/tmp/pip-EiwauG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:56 INFO - Running setup.py (path:/tmp/pip-40J0ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:57 INFO - Running setup.py (path:/tmp/pip-zSdydk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:57 INFO - Running setup.py (path:/tmp/pip-TIfD5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:18:57 INFO - Running setup.py install for manifestparser 05:18:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Running setup.py install for mozcrash 05:18:57 INFO - Running setup.py install for mozdebug 05:18:57 INFO - Running setup.py install for mozdevice 05:18:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Running setup.py install for mozfile 05:18:57 INFO - Running setup.py install for mozhttpd 05:18:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Running setup.py install for mozinfo 05:18:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Running setup.py install for mozInstall 05:18:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Running setup.py install for mozleak 05:18:58 INFO - Running setup.py install for mozlog 05:18:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:18:58 INFO - Running setup.py install for moznetwork 05:18:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:18:58 INFO - Running setup.py install for mozprocess 05:18:58 INFO - Running setup.py install for mozprofile 05:18:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:18:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:18:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:18:58 INFO - Running setup.py install for mozrunner 05:18:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:18:58 INFO - Running setup.py install for mozscreenshot 05:18:58 INFO - Running setup.py install for moztest 05:18:58 INFO - Running setup.py install for mozversion 05:18:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:18:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:18:58 INFO - Cleaning up... 05:18:58 INFO - Return code: 0 05:18:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-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 0x7f2b87b75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb5410>, '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 0x1fb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-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:58 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:58 INFO - Using env: {'DISPLAY': ':0', 05:18:58 INFO - 'HOME': '/home/cltbld', 05:18:58 INFO - 'LANG': 'en_US.UTF-8', 05:18:58 INFO - 'LANGUAGE': 'en_US:en', 05:18:58 INFO - 'LOGNAME': 'cltbld', 05:18:58 INFO - 'MAIL': '/var/mail/cltbld', 05:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:58 INFO - 'MOZ_NO_REMOTE': '1', 05:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:58 INFO - 'NO_EM_RESTART': '1', 05:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:58 INFO - 'PWD': '/builds/slave/test', 05:18:58 INFO - 'SHELL': '/bin/bash', 05:18:58 INFO - 'SHLVL': '1', 05:18:58 INFO - 'TERM': 'linux', 05:18:58 INFO - 'TMOUT': '86400', 05:18:58 INFO - 'USER': 'cltbld', 05:18:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 05:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:58 INFO - '_': '/tools/buildbot/bin/python'} 05:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:59 INFO - Running setup.py (path:/tmp/pip-dZ_HUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:59 INFO - Running setup.py (path:/tmp/pip-crj6E8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:59 INFO - Running setup.py (path:/tmp/pip-RKMXlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:59 INFO - Running setup.py (path:/tmp/pip-WaXCKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:59 INFO - Running setup.py (path:/tmp/pip-FwZ0U9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:59 INFO - Running setup.py (path:/tmp/pip-9iHjps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:59 INFO - Running setup.py (path:/tmp/pip-GCGECC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:59 INFO - Running setup.py (path:/tmp/pip-a8YGm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:59 INFO - Running setup.py (path:/tmp/pip-tiDfjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:59 INFO - Running setup.py (path:/tmp/pip-swraEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:59 INFO - Running setup.py (path:/tmp/pip-Lvf3YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:59 INFO - Running setup.py (path:/tmp/pip-7ehlyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:19:00 INFO - Running setup.py (path:/tmp/pip-Ckkr5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:19:00 INFO - Running setup.py (path:/tmp/pip-AvANHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:00 INFO - Running setup.py (path:/tmp/pip-2GDqNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:19:00 INFO - Running setup.py (path:/tmp/pip-_Ud6hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:19:00 INFO - Running setup.py (path:/tmp/pip-NEOY7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:19:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:02 INFO - Downloading blessings-1.6.tar.gz 05:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:19:02 INFO - Installing collected packages: blessings 05:19:02 INFO - Running setup.py install for blessings 05:19:02 INFO - Successfully installed blessings 05:19:02 INFO - Cleaning up... 05:19:02 INFO - Return code: 0 05:19:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:19:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:02 INFO - Reading from file tmpfile_stdout 05:19:02 INFO - Current package versions: 05:19:02 INFO - argparse == 1.2.1 05:19:02 INFO - blessings == 1.6 05:19:02 INFO - blobuploader == 1.2.4 05:19:02 INFO - docopt == 0.6.1 05:19:02 INFO - manifestparser == 1.1 05:19:02 INFO - mozInstall == 1.12 05:19:02 INFO - mozcrash == 0.17 05:19:02 INFO - mozdebug == 0.1 05:19:02 INFO - mozdevice == 0.48 05:19:02 INFO - mozfile == 1.2 05:19:02 INFO - mozhttpd == 0.7 05:19:02 INFO - mozinfo == 0.9 05:19:02 INFO - mozleak == 0.1 05:19:02 INFO - mozlog == 3.1 05:19:02 INFO - moznetwork == 0.27 05:19:02 INFO - mozprocess == 0.22 05:19:02 INFO - mozprofile == 0.28 05:19:02 INFO - mozrunner == 6.11 05:19:02 INFO - mozscreenshot == 0.1 05:19:02 INFO - mozsystemmonitor == 0.0 05:19:02 INFO - moztest == 0.7 05:19:02 INFO - mozversion == 1.4 05:19:02 INFO - psutil == 3.1.1 05:19:02 INFO - requests == 1.2.3 05:19:02 INFO - wsgiref == 0.1.2 05:19:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:02 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 0x7f2b87b75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb5410>, '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 0x1fb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:19:02 INFO - Using env: {'DISPLAY': ':0', 05:19:02 INFO - 'HOME': '/home/cltbld', 05:19:02 INFO - 'LANG': 'en_US.UTF-8', 05:19:02 INFO - 'LANGUAGE': 'en_US:en', 05:19:02 INFO - 'LOGNAME': 'cltbld', 05:19:02 INFO - 'MAIL': '/var/mail/cltbld', 05:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:02 INFO - 'MOZ_NO_REMOTE': '1', 05:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:02 INFO - 'NO_EM_RESTART': '1', 05:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:02 INFO - 'PWD': '/builds/slave/test', 05:19:02 INFO - 'SHELL': '/bin/bash', 05:19:02 INFO - 'SHLVL': '1', 05:19:02 INFO - 'TERM': 'linux', 05:19:02 INFO - 'TMOUT': '86400', 05:19:02 INFO - 'USER': 'cltbld', 05:19:02 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 05:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:02 INFO - '_': '/tools/buildbot/bin/python'} 05:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:19:02 INFO - Cleaning up... 05:19:02 INFO - Return code: 0 05:19:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:02 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 0x7f2b87b75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb5410>, '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 0x1fb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:19:02 INFO - Using env: {'DISPLAY': ':0', 05:19:02 INFO - 'HOME': '/home/cltbld', 05:19:02 INFO - 'LANG': 'en_US.UTF-8', 05:19:02 INFO - 'LANGUAGE': 'en_US:en', 05:19:02 INFO - 'LOGNAME': 'cltbld', 05:19:02 INFO - 'MAIL': '/var/mail/cltbld', 05:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:02 INFO - 'MOZ_NO_REMOTE': '1', 05:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:02 INFO - 'NO_EM_RESTART': '1', 05:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:02 INFO - 'PWD': '/builds/slave/test', 05:19:02 INFO - 'SHELL': '/bin/bash', 05:19:02 INFO - 'SHLVL': '1', 05:19:02 INFO - 'TERM': 'linux', 05:19:02 INFO - 'TMOUT': '86400', 05:19:02 INFO - 'USER': 'cltbld', 05:19:02 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 05:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:02 INFO - '_': '/tools/buildbot/bin/python'} 05:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:03 INFO - Downloading/unpacking jsonschema 05:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:19:05 INFO - Downloading/unpacking functools32 (from jsonschema) 05:19: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:19: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:19: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:19: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:19: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:19: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:19:05 INFO - Downloading functools32-3.2.3-2.tar.gz 05:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:19:05 INFO - warning: no files found matching '*.txt' 05:19:05 INFO - no previously-included directories found matching 'build' 05:19:05 INFO - no previously-included directories found matching 'dist' 05:19:05 INFO - no previously-included directories found matching '.git*' 05:19:05 INFO - Installing collected packages: jsonschema, functools32 05:19:05 INFO - Running setup.py install for functools32 05:19:05 INFO - warning: no files found matching '*.txt' 05:19:05 INFO - no previously-included directories found matching 'build' 05:19:05 INFO - no previously-included directories found matching 'dist' 05:19:05 INFO - no previously-included directories found matching '.git*' 05:19:05 INFO - Successfully installed jsonschema functools32 05:19:05 INFO - Cleaning up... 05:19:05 INFO - Return code: 0 05:19:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:19: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:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b87b75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb5410>, '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 0x1fb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:19: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', 'flake8'] in /builds/slave/test/build 05:19: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 flake8 05:19:05 INFO - Using env: {'DISPLAY': ':0', 05:19:05 INFO - 'HOME': '/home/cltbld', 05:19:05 INFO - 'LANG': 'en_US.UTF-8', 05:19:05 INFO - 'LANGUAGE': 'en_US:en', 05:19:05 INFO - 'LOGNAME': 'cltbld', 05:19:05 INFO - 'MAIL': '/var/mail/cltbld', 05:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:05 INFO - 'MOZ_NO_REMOTE': '1', 05:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:05 INFO - 'NO_EM_RESTART': '1', 05:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:05 INFO - 'PWD': '/builds/slave/test', 05:19:05 INFO - 'SHELL': '/bin/bash', 05:19:05 INFO - 'SHLVL': '1', 05:19:05 INFO - 'TERM': 'linux', 05:19:05 INFO - 'TMOUT': '86400', 05:19:05 INFO - 'USER': 'cltbld', 05:19:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 05:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:05 INFO - '_': '/tools/buildbot/bin/python'} 05:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:05 INFO - Downloading/unpacking flake8 05:19: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:19: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:19: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:19: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:19: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:19: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:19:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:19:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:19: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:19: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:19: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:19: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:19: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:19: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:19:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:19:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:19: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:19: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:19: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:19: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:19: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:19: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:19:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:19:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:19:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:19:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:19:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:19:08 INFO - no previously-included directories found matching 'docs/_build' 05:19:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:19:08 INFO - Running setup.py install for pep8 05:19:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:19:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:19:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:19:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:19:08 INFO - no previously-included directories found matching 'docs/_build' 05:19:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:19:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:19:08 INFO - Cleaning up... 05:19:08 INFO - Return code: 0 05:19:08 INFO - Running post-action listener: _resource_record_post_action 05:19:08 INFO - Running post-action listener: _start_resource_monitoring 05:19:08 INFO - Starting resource monitoring. 05:19:08 INFO - ##### 05:19:08 INFO - ##### Running install step. 05:19:08 INFO - ##### 05:19:08 INFO - Running pre-action listener: _resource_record_pre_action 05:19:08 INFO - Running main action method: install 05:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:08 INFO - Reading from file tmpfile_stdout 05:19:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:19:08 INFO - Reading from file tmpfile_stdout 05:19:08 INFO - Output received: 05:19:08 INFO - Usage: mozinstall [options] installer 05:19:08 INFO - Options: 05:19:08 INFO - -h, --help show this help message and exit 05:19:08 INFO - -d DEST, --destination=DEST 05:19:08 INFO - Directory to install application into. [default: 05:19:08 INFO - "/builds/slave/test"] 05:19:08 INFO - --app=APP Application being installed. [default: firefox] 05:19:08 INFO - mkdir: /builds/slave/test/build/application 05:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:19:24 INFO - Reading from file tmpfile_stdout 05:19:24 INFO - Output received: 05:19:24 INFO - /builds/slave/test/build/application/firefox/firefox 05:19:24 INFO - Running post-action listener: _resource_record_post_action 05:19:24 INFO - ##### 05:19:24 INFO - ##### Running run-tests step. 05:19:24 INFO - ##### 05:19:24 INFO - Running pre-action listener: _resource_record_pre_action 05:19:24 INFO - Running main action method: run_tests 05:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:19:24 INFO - Python 2.7.3 05:19:24 INFO - Return code: 0 05:19:24 INFO - grabbing minidump binary from tooltool 05:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:24 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 0x1fb5410>, '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 0x1fb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:19:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:19:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:19:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:19:24 INFO - Return code: 0 05:19:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:19:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:19:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:19:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:19:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:19:25 INFO - Return code: 0 05:19:25 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-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:19:25 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-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:19:25 INFO - Using env: {'DISPLAY': ':0', 05:19:25 INFO - 'HOME': '/home/cltbld', 05:19:25 INFO - 'LANG': 'en_US.UTF-8', 05:19:25 INFO - 'LANGUAGE': 'en_US:en', 05:19:25 INFO - 'LOGNAME': 'cltbld', 05:19:25 INFO - 'MAIL': '/var/mail/cltbld', 05:19:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:19:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:25 INFO - 'MOZ_NO_REMOTE': '1', 05:19:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:25 INFO - 'NO_EM_RESTART': '1', 05:19:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:25 INFO - 'PWD': '/builds/slave/test', 05:19:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:19:25 INFO - 'SHELL': '/bin/bash', 05:19:25 INFO - 'SHLVL': '1', 05:19:25 INFO - 'TERM': 'linux', 05:19:25 INFO - 'TMOUT': '86400', 05:19:25 INFO - 'USER': 'cltbld', 05:19:25 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323', 05:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:25 INFO - '_': '/tools/buildbot/bin/python'} 05:19:25 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-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:19:25 INFO - mozversion application_buildid: 20160506013122 05:19:25 INFO - mozversion application_changeset: b14d8e23323e95c5db3bc4cca69738edeee44302 05:19:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:19:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:19:25 INFO - mozversion application_name: Firefox 05:19:25 INFO - mozversion application_remotingname: firefox-dev 05:19:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:19:25 INFO - mozversion application_vendor: Mozilla 05:19:25 INFO - mozversion application_version: 48.0a2 05:19:25 INFO - mozversion platform_buildid: 20160506013122 05:19:25 INFO - mozversion platform_changeset: b14d8e23323e95c5db3bc4cca69738edeee44302 05:19:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:19:25 INFO - mozversion platform_version: 48.0a2 05:19:25 INFO - using testdate: 1462537165 05:19:25 INFO - actual date: 1462537165 05:19:25 INFO - starting webserver on 'localhost:51348' 05:19:25 INFO - SUITE-START | Running 2 tests 05:19:25 INFO - TEST-START | dromaeo_css 05:19:25 INFO - operating with platform_type : linux_ 05:19:25 INFO - Initialising browser for dromaeo_css test... 05:19:25 INFO - TEST-INFO | started process 19959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpySCB61/profile http://localhost:51348/getInfo.html) 05:19:29 INFO - PROCESS | 19959 | __metrics Screen width/height:1600/1200 05:19:29 INFO - PROCESS | 19959 | colorDepth:24 05:19:29 INFO - PROCESS | 19959 | Browser inner width/height: 1024/697 05:19:29 INFO - PROCESS | 19959 | __metrics 05:19:29 ERROR - PROCESS | 19959 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:19:30 INFO - TEST-INFO | 19959: exit 0 05:19:30 INFO - Browser initialized. 05:19:30 INFO - Running cycle 1/1 for dromaeo_css test... 05:19:30 INFO - TEST-INFO | started process 20051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpySCB61/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:42 INFO - PROCESS | 20051 | RSS: Main: 142344192 05:19:42 INFO - PROCESS | 20051 | 05:20:33 INFO - PROCESS | 20051 | 1462537233221 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:22:41 INFO - PROCESS | 20051 | Cycle 1(1): loaded http://localhost:51348/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51348/tests/dromaeo/cssquery-ext.html) 05:22:42 INFO - PROCESS | 20051 | RSS: Main: 268767232 05:22:42 INFO - PROCESS | 20051 | 05:25:44 INFO - PROCESS | 20051 | Cycle 1(1): loaded http://localhost:51348/tests/dromaeo/cssquery-ext.html (next: http://localhost:51348/tests/dromaeo/cssquery-jquery.html) 05:25:45 INFO - PROCESS | 20051 | RSS: Main: 227368960 05:25:45 INFO - PROCESS | 20051 | 05:28:47 INFO - PROCESS | 20051 | Cycle 1(1): loaded http://localhost:51348/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51348/tests/dromaeo/cssquery-mootools.html) 05:28:47 INFO - PROCESS | 20051 | RSS: Main: 229998592 05:28:47 INFO - PROCESS | 20051 | 05:31:49 INFO - PROCESS | 20051 | Cycle 1(1): loaded http://localhost:51348/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51348/tests/dromaeo/cssquery-prototype.html) 05:31:50 INFO - PROCESS | 20051 | RSS: Main: 222261248 05:31:50 INFO - PROCESS | 20051 | 05:34:52 INFO - PROCESS | 20051 | Cycle 1(1): loaded http://localhost:51348/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51348/tests/dromaeo/cssquery-yui.html) 05:34:53 INFO - PROCESS | 20051 | RSS: Main: 217112576 05:34:53 INFO - PROCESS | 20051 | 05:37:55 INFO - PROCESS | 20051 | Cycle 1(1): loaded http://localhost:51348/tests/dromaeo/cssquery-yui.html (next: http://localhost:51348/tests/dromaeo/cssquery-dojo.html) 05:37:56 INFO - PROCESS | 20051 | RSS: Main: 254074880 05:37:56 INFO - PROCESS | 20051 | 05:37:56 INFO - PROCESS | 20051 | __start_tp_report 05:37:56 INFO - PROCESS | 20051 | _x_x_mozilla_page_load 05:37:56 INFO - PROCESS | 20051 | _x_x_mozilla_page_load_details 05:37:56 INFO - PROCESS | 20051 | |i|pagename|runs| 05:37:56 INFO - PROCESS | 20051 | |0;dojo.html;3288.457404528253;3363.7645364824457;3371.51113088602;3392.6268110507854;3417.3336199441105;5558.194061861028;5590.524805391541;5591.4688104630095;5602.07565751651;5618.269624948751;5589.8602534936645;5593.636413633111;5606.859828504289;5614.775408983646;5639.2668953036155;4923.409190897098;4971.179755340382;5055.191169412886;5057.468965758598;5113.411957624883;4928.531789480012;5017.5484206421415;5053.9241911371355;5103.132467480518;5103.923441148386;5107;5143.382794064718;5148.3564554430695;5148.794048238066;5159.045576568328;5079.3650793650795;5079.873003174913;5146.047981123485;5151.5878729701535;5170.431252562215;4803.902079525222;4850.975745121287;4961.950380496185;4965.255211718271;4968.527989840959;5290.894182116374;5305.018571564273;5314.3091398117995;5316.867078323035;5327.813526526592;5882.852928676774;6004.369541198155;6056.72744726484;6060.909086363708;6065.4844338231305;6029.547783916224;6059.575829691923;6060.787872424488;6089.908651370233;6109.541784366146;5396.244525766396;5674.687892165888;5674.943250567524;5686.630369026041;5687.232223649837;6063.423974722395;6155.969220153871;6160.784372546939;6163.013917773134;6165.414285642857;5902.2622172228475;5913.70431478433;5914.408559144051;5915.852103697356;5917.881642367129;5807.88384232313;5947.791827286024;5987.760489580455;5999.100134979788;6011.458968692751;5885.234919460443;5890.705464726747;5908.172855800191;5908.911366329508;5924.496417804535;5868.09044598088;5868.970655146697;5873.618214816023;5874.32445268791;5882.794102206402;4414.823407063745;4459.152760975404;4494.393256910275;4494.977525112354;4512.05246898155;4041.6362527372676;4054.959450405458;4061.1674606705556;4073.06319546506;4081.3265811140827;5723.284589426322;5729.770809167587;5733.369329373765;5738.799142030009;5768.711564421762;5824.970875145682;5844.620099693507;5920.911186332209;5939.792107276225;6004.309504406961;5636.943630563642;5645.4072322405555;5692.174634677948;5692.6015178937905;5716.5998380113;5068.949310506921;5074;5077.746112694351;5080.364954380702;5109.770060347293;5899.823005309848;6088.208532890696;6196.597221180518;6198.783042593487;6200.162977997912;6037.803726410103;6059.878802424015;6060.939390606214;6064.605800622945;6098.26820781509;5926.970365148147;6189.133521306931;6263.498920086291;6267.529935254783;6286;5893.734781934738;5936.940630593639;5939.2575928009;5963.254593175853;5982.970085149546;5915.733791979285;5935.584509084495;5959.374265702038;5972.611780234271;5973.790917317873;5643.238162848127;5771.307443106854;5857.824265272048;5873.853153671193;5874.089516125007;5890;5900.881982360414;5903.144044113666;5903.91144132847;5929.792457263975;5808.912866307093;5814.098814683731;5819.563532734977;5821.039528477754;5823.970880145572;5735.770569177186;5856.4143585641095;5910.202122713378;5914.142449344735;5929.822105336847;5524.558035357242;5619.7752089917585;5660.660360378391;5726.455986681259;5758.337791154071 05:37:56 INFO - PROCESS | 20051 | |1;ext.html;667.3093348384423;678.9355011273927;680.078493641116;687.9587224766515;751.6054071612406;40625.3906191407;42420.36369454453;42445;42445.78777106114;42536.787316063455;44284.33573496392;45143.322850157274;45204.77397613016;45231.321530177076;45243.32135017977;7849.882251766228;8059.274665280123;8839.999999999984;9027.322950778685;10460.11089057431;10529.262951593391;10577.576896924114;10634.20243481742;10684.358938463678;10692;10670.62652807152;10750.569977200903;10768.569257229701;10786.676399708022;10788.08301294391;7871.685132594718;10463.424511651818;10698.893011069867;10708.625198118107;10709.089727373183;10619.25665203436;10724.249302548824;10766.838497422545;10773.515191816308;10774.676759697144;41315.586844131474;41599.168016639494;41716;41748;42039;3228.6932741389533;3481.5125882376487;3486.092451609698;3548.449990251515;3592.263585964871;33818.830905845556;34383.828080859435;34448.82775586131;34664.82667586671;34915;4080.469538959946;4193.895152621179;4226.218149642326;4282.357646353041;4329.480462344507;248291;249233;249385;250951;326717;35655.82172089123;66060.66969665121;67438.32561674419;67533;67626.66186669035;37952.240955181296;37962.62037379646;38054;38148.80925595354;38168;12955.611331660066;14493.420263189355;14681.19253441071;14699.706005879823;14731.410743570352;11677.416129193507;11862.88137118635;11863.347515886537;11903.761924761457;11910.642680719593;9459.52702364879;9522.95238523803;9562.95218523903;9603.615855365846;9604;3521.542199514047;3550.857965681344;3554.697850682721;3615.367310720613;3619.113317237294;1109.9778004440027;1154.3535620052796;1157.8726340102583;1224.0965298960025;1308.2935214983802;34783.30433391318;35236.64763352385;35734.28531429357;35845.46231806525;35908.64091359053;1197.6407077876602;1226.4113225651558;1240.9379531023412;1247.357610830423;1352.4184600621827;18655.90672046631;18837.434876953714;18945.90527047356;19030.90484547596;19122.904385477985;537257;543878;544926;545496;548079;62428;63151.368486314546;63232.68383658144;63251.36748632547;63294.683526582994;1355.0988592586018;1495.2000679636342;1498.4455751371845;1571.3714514194185;1575.9606009849617;31452.52821207638;32705.509417358284;34474.482882756274;34581.860310166994;34971.47542786809;53160.73419632877;53367.33163341895;53433;53438.19842702441;53517.19724204218;325704;326435;327910;328671;329075;24373.39066523351;28953.56569651499;29001.419971600873;29211.70788292175;29287;45001.54998449974;46147.76926115348;46375.76812115918;46753.53246467492;47019;39673.801630991664;42584.57415425806;43273.56726432696;43366.566334336254;44389.77805110954;41576.376354355314;42099;42329;42784.14431711286;43907;43196.352054719835;44589.777051114535;44647;44755.55244447644;45043.54956450524;36751.816240918626;37493;37895.81052094722;38198.8090059559;38224.23551529009;29840.80523281882;29945.320358953453;30066.248343790707;30318.696813031587;30454.695453045188 05:37:56 INFO - PROCESS | 20051 | |2;jquery.html;439.46165946715297;439.8075593168057;440.16808232440695;441.08254829953694;454.114476770298;19327.420177394684;19609.313674021396;19832.70250946237;19917.203311867506;19967;17965.64068718625;19524.21903123877;19735.1119199636;20394.592108157827;20416.489587760312;5886.293644762613;6005.879882402372;6011.699415029231;6026;6041.24484439445;5742.885142297151;5925.525957923377;5946.286445626531;5984.5511586630955;5993.430624090726;5846.9707651461895;5855.648661080328;5856.092305692625;5858.355580886099;5889.941100588982;5669.149627555879;5825.708714564276;5973.880522389528;5974.133750606181;5975.880482390371;5736;5790.36306006339;5801.216835727165;5802.564807639402;5834.27071616048;13121.147125436815;13267.535636252685;13290;13295.069345145843;13349.86650133496;2425.987870060638;2432.6959130108735;2717.714639962795;3037.4988126959024;3174.8888788892277;10787.892121078845;10809.135269178447;11054.447277636085;13440.86559134406;14143.85856141446;2011.4971257185703;2088.905999230023;2102.6543012471875;2121.8514703970573;2139.6576547752443;73097;75841;84193;86497;94632.52683736537;11565.653030409101;11646.70883227926;11742.354170520703;11827.645170644895;11870.228435151688;13520.526781562598;17066.317347306216;17071.829281707272;17072.061036643103;17080.743788843178;7902.68389264423;8287.95856020728;8332.458390204618;8433.620487078097;8445.535495547681;7846.9215307847335;7848.529088254723;7913.485623434458;7961.6019199040975;7975.720849770346;5053.9747301264;5122.257272695439;5147.819826306136;5166.638335316567;5175.430702622709;2017.535966727661;2034.4710375302527;2098.6537221358612;2104.400245929933;2123.936281911514;1043.843423486483;1081.329575663094;1099.6536091131268;1159.8492196014465;1182.467889449751;19286.4214073578;19955.60088798245;20221.49446263855;20296.188152473736;20415.591688166154;1030.1655658916152;1038.7143535527791;1045.8849526552074;1062.2404980438869;1069.7058308965097;10794.514246858911;11361;11371.374574398322;11474.827877581843;11586.76826463466;523380;534777;539047;561294;564002;98578;99583;99678;100755.49622251988;104542.47728761307;1079.7570546626946;1092.306385445232;1095.5289225633055;1095.7863216672831;1104.6630777612904;17668.91165544164;17741.645167096845;17811;17870.106494674954;18202.271909123487;38099.238015240095;39456;41627.583724162374;41648.58351416447;41791.58208417877;56306.436935631755;58398;59007;59151;59417.405825942915;8559.186877246651;8656.740297791077;8683.305335573014;8812.471251724917;9016.59425325875;9699.70900872975;12822.935885320514;12944.223346599234;12973.740525189633;13035.15271507349;11192;11363.659090227306;11543.538258469567;11603.593874214363;12128.9083982442;11441.370724610226;11699.2980421175;11732.589359372381;11817.940910295394;11957.521699131938;11868.703282418008;12247.877521224673;12376.257424554555;12394.690132746753;12405.875941240833;8515.318774497902;8586.923622723334;8666.739997800076;8772.561371931506;8984.59569319369;9039.548022598976;11311.830322545004;11883.227590206609;11940.283582985048;12058.216215945935 05:37:56 INFO - PROCESS | 20051 | |3;mootools.html;1417.1072224498564;1612.2180742339967;1612.4275882061866;1862.3947217154428;1936.5642730385657;8288.254057134856;8671.609777560008;8673.999999999993;8677.91322086779;8703;8508.191721786436;8658.480491170534;8687.86968195476;8695;8705.520061589528;2098.171222367164;2174.3803016140405;2177.031221106608;2386.713594368678;2418.093215044358;2406.1939250351065;2516.3457501049675;2519.1686743374644;2519.7858182054547;2520.760527749861;2366.7988221001237;2395.7604239576076;2401.6637670726113;2402.3633737059695;2404.0984630763464;2064.669652855536;2298.6207275799475;2298.643710224918;2319.234652564658;2366.9408264793346;2390.760923907613;2412.203972689026;2414.3360575841607;2415.6376543518436;2418.3712234819072;8367.748967530923;8504;8506.957465212696;8508.149185081504;8513.489190648581;5024.397072351305;5181.559567436772;5183.637145399824;5185.611079169077;5191.6884986900905;3279.7868138570916;3368.9051058406117;3457.0665920201404;3475.2528206435736;3504.912377190565;1091.939943303118;1098.0337303173237;1103.9337639741561;1129.7853407852565;1152.982705259422;12290.815637765441;12306;12350.567730129402;12350.950169235626;12356.567520136841;4836.250381190921;4844.32179494871;4869.123557759566;4926.064047830901;4932.284818701268;10374.17006639467;10450.68647940563;10468.947655261827;10472.842907356397;10473;5273.129933560919;5277.287566178594;5285.524302812765;5285.762140703678;5288.2596436498925;4179;4517.164324599959;4731.101090792738;4759.50025247351;4816.253480710496;4093.5087789465456;4178.484953303331;4235.767032813224;4263.55232700562;4268.103698223408;1318.9340532973313;1341.4298922957898;1352.5198554513006;1354.7493713663005;1355.105630284008;802.1978021978022;939.3987847777428;1018.8267994440963;1022.3405903192399;1041.234692501011;5909.349971503131;5930.703464826742;6040.728167232485;6105.511559075263;6142.324344322121;442.1400376268128;450.09980039920157;452.29667866467304;457.5973143633581;458.7706146926537;4137.089840235143;4149;4281.571842815693;4317.136572685476;4473.686841921034;10326.741831454274;10520.368777873198;10615.84076238857;10659.253852230424;10691.305065170895;10382.532786024647;10471.68584942453;10533.052025317758;10549.156067514581;10564.577416903237;7952.443328966917;8169.019717633922;8169.550674713067;8170.223828736261;8172.918270817335;5850.268716410449;5934.083504886754;6212.596181248205;6320.494360451061;6326.588771729823;9784.119429251401;9864.408135511892;10060.195184385379;10081;10171.64399246023;10198.796024079329;10230.846537301797;10262;10313.9484302581;10423.583056677648;6729.158855143107;7377.077865266841;7579.848403032019;7652.196519365387;7706.537607743553;8327.084020757833;8338.416310858182;8387.622556985072;8408.915910840813;8421.70524031656;7283.599402032939;7420.517666351886;7457.216992215739;7499.287567681062;7581.203973582695;7368.778936631909;7389.076365454318;7397;7470.3276705096805;7490.138634056935;6945.340192681687;6977.476689248429;7009.088818453569;7023.086998690342;7024.402925751164;5180.663256888291;5291.365036195682;5382.192671099367;5437.891242175214;5454;5207.843764687065;5277.630565860353;5299.428708401478;5299.8410047698635;5391.32608423947 05:37:56 INFO - PROCESS | 20051 | |4;prototype.html;349.3519521288011;360.12130401819564;360.8087713511839;365.0745360511105;365.3952708267814;5430.864228394287;5523;5533.3083364579425;5571.554275657948;5573.191887176367;5149.510796474338;5290.285811415468;5425.294711687475;5468.371137319209;5485.807996720116;4224.943764058985;4250.893727656818;4261.829526818923;4266.97866510667;4275.486941567016;4240.660747140237;4263.4031235627035;4265.274903266437;4275.935860962072;4281.272183728774;4048.0487085535024;4150.4682143892205;4228.682848786338;4277.465316835395;4284.143171365724;4223.725457845261;4247.702660813759;4257.680673949466;4261.957380426187;4262.147570485915;3824.139568597071;3837.347650899354;3842.6541611254843;3850.8074596270076;3861.3242682530727;5122.76947537358;5151.17581187012;5174.490372169495;5176.378834539842;5307.787688492455;4878.609711223094;4901.534354236342;4924.482929292409;4935.470004298679;4938.530839570235;5661.688607126606;5664.49019588239;5708.600397972144;5735.483806457439;5763.711814409263;4149.502059752849;4194.580541945811;4247.8300867965245;4261.74429534229;4267;5882.911756323616;5907.793227237026;5909.143174239711;5951.613145145595;5968.37332080134;4296.548862369469;4324.891877703019;4336.696431249846;4339.934900976488;4352.107817897323;4036.1524079942956;4280.743155410685;4292.527821939584;4294.742315461082;4378.912421751547;4874.293227481995;4874.440179142711;4884.9511504884495;4890;4892.266160075946;5767.250257466502;5771.326315368496;5804.65172089676;5819.73811178498;5841.153032810304;1463.524354584743;1486.9628259293604;1508.1554329575472;1533.1184568872943;1554.7095910394346;1045.534737042009;1055.6780182044397;1063.1016790811752;1077.6314081116936;1084.9945750271356;5936.881262374728;5946.732397042144;5948.988671925783;5967.910481342783;5981.192539007178;6236.594621349598;6248.687565621701;6252.562320637512;6263.6241825490615;6274.403931626488;5743.655380677173;5937.2578427696535;5951.404859514014;5956.855532008473;5963.135345374896;3349.3301339731665;3355.899323020313;3356.798592084434;3358.882439114619;3373.37592545375;6384.201974753156;6389.52078594098;6470.191226096738;6519.119918810899;6544.149260596092;6352.904706429407;6385.83900969014;6405.551611387158;6421.068945002949;6428;6263.778563180227;6528.771492997817;6541.2150541934325;6554.70503827329;6581.506387020992;6217.129601855653;6253.937460625336;6281.842953926189;6286.811395658137;6327.209098862642;6110.877782444415;6115.388461153849;6128.816135515942;6171.290301615371;6224.719887604978;6288.245410550763;6447.129637499065;6497.18785151856;6498.252700939453;6500.707468164039;4485.887852803706;4494.303382975644;4495.820167193407;4503.729776213438;4510.6617003725505;6123.357047510125;6282.623042617275;6306.117143599991;6308.810735677937;6322.8735425290315;6086.178365920721;6110.877782444415;6126.387361263838;6136.417040381157;6160.168377269011;6100.176476175837;6102.4812890902995;6108.816735497942;6117.755289788359;6139.293981192041;5858.619189752652;6037.939620603914;6044.365341639064;6049.395060494091;6050.273967123797;6047.909281360695;6102.877942441215;6113.144159817718;6153.784617538365;6212.285587157535;5846.707664616667;6061.575689701678;6065.907261994605;6073.939260607514;6097.451229389376 05:37:56 INFO - PROCESS | 20051 | |5;yui.html;669.6250099944031;690.3165865792861;718.9604571748555;750.3696894608531;752.0711920777838;13756.587302380933;13979;14023.92988035061;14084.08453450525;14085.577432677022;15284.465043723472;15581.532554023397;15599.22003899806;15618.062916225035;15641.217939103057;738.6343759838887;891.3003292415456;895.9059298773633;897.0267260022883;897.9236764874994;880.5025160784169;907.4419232172232;909.7680091576639;910.3400034974657;910.9498977556232;969.0406497567393;969.1326262994615;969.190725744001;971.1502435369052;973.3770386952356;766.5324152267112;904.2449554621899;959.5490119643756;961.1589858873485;961.2406199102735;682.2188594059774;686.3102581905204;687.8108520156946;688.4836372720459;689.2349492063805;13561.932190339085;13563.186208827501;13590.048696591242;13592.524261650893;13596.252206128658;13935.58193254204;14502.637434064232;14742.189179595118;14844;14852.70294594102;10965.50655220517;11119.944400278027;11138.007276937917;11232.269902456314;11433.371164586028;3855.556610989744;3866.1881004988704;3903.941440878389;3958.3666613342016;3986.1031267964768;60476.09285860715;60588.69705651487;60666.69666651683;60998;61335.69332153311;10720.517576709066;10968.561257549769;11342.432878356049;11444.656660300205;11592.942035289769;20945;21620.13519459204;21654.566908662055;21671.67492487614;21742.673859892115;8089.191080891864;8332.125126861714;8341.124181960928;8459.238668519863;8658.350623703247;4548.226801443762;4795.544423279783;4804.543568361;4824.179889418807;4852.733099679481;3443.2424866529823;3499.8600055997986;3520.8063556504126;3527.5766907971206;3528.2237907660788;691.2879733874117;701.3267263427167;703.3739971425435;711.6228398948462;713.0908092182509;514.8815772372375;665.6339013542532;677.5088061155722;688.8002479280952;704.3344039882262;9188;9432.434053956784;9446;9474.289428292906;9485.241180705527;668.5587512241897;694.1184695436767;695.1172011545309;695.1553862057624;700.7722490190708;4349.586789255016;4463.575960283768;4522.773861306921;4559.863204103882;4573.108243892409;62215;62859;63403.68298158572;63583.36416635867;63652.68173659102;53313.2003019955;54694;55266.026057655006;55347;56506.86986260334;49732.50267497351;50045.49954500408;50359;50695.999999999265;50829;8746.169113934166;8817.691380801642;8910.287177025952;8955.686550970684;9047.68333108338;32485.35029299448;33759.49360759542;33811.15472113217;33898.322033558696;34519.827400862836;43076.78461607797;44458.333125003795;44808;45521.31718024166;46152.7692361536;11646.417679116179;11648.534058637559;12801.29592872401;12983.35083245815;12994.545190918272;12775.105742597929;12983.675408114872;13080.542181023618;13681.247531385869;13864.306784660524;12118.454669539715;12276.140670153003;12640.304783236643;12670.493180273055;13215.867841321464;12162.939185304016;12256.14207005501;12325.815112773136;12484;12569.308688022247;12295.139340246455;12946.741065178832;12978.545750898673;13066.150700204456;13462.86537134616;10621;10840.403777791982;10948.124150067817;10952.945235273774;11019.83470247963;10518.842217366593;10787.352758834495;10993.780124397626;11012.944935275273;11020.393878336768 05:37:56 INFO - PROCESS | 20051 | __end_tp_report 05:37:56 INFO - PROCESS | 20051 | __start_cc_report 05:37:56 INFO - PROCESS | 20051 | _x_x_mozilla_cycle_collect,1012 05:37:56 INFO - PROCESS | 20051 | __end_cc_report 05:37:56 INFO - PROCESS | 20051 | __startTimestamp1462538276192__endTimestamp 05:37:56 INFO - PROCESS | 20051 | 05:37:56 INFO - PROCESS | 20051 | ------- Summary: start ------- 05:37:56 INFO - PROCESS | 20051 | Number of tests: 6 05:37:56 INFO - PROCESS | 20051 | 05:37:56 INFO - PROCESS | 20051 | [#0] dojo.html Cycles:165 Average:5541.52 Median:5771.31 stddev:630.41 (10.9%) stddev-sans-first:607.06 05:37:56 INFO - PROCESS | 20051 | Values: 3288.5 3363.8 3371.5 3392.6 3417.3 5558.2 5590.5 5591.5 5602.1 5618.3 5589.9 5593.6 5606.9 5614.8 5639.3 4923.4 4971.2 5055.2 5057.5 5113.4 4928.5 5017.5 5053.9 5103.1 5103.9 5107.0 5143.4 5148.4 5148.8 5159.0 5079.4 5079.9 5146.0 5151.6 5170.4 4803.9 4851.0 4962.0 4965.3 4968.5 5290.9 5305.0 5314.3 5316.9 5327.8 5882.9 6004.4 6056.7 6060.9 6065.5 6029.5 6059.6 6060.8 6089.9 6109.5 5396.2 5674.7 5674.9 5686.6 5687.2 6063.4 6156.0 6160.8 6163.0 6165.4 5902.3 5913.7 5914.4 5915.9 5917.9 5807.9 5947.8 5987.8 5999.1 6011.5 5885.2 5890.7 5908.2 5908.9 5924.5 5868.1 5869.0 5873.6 5874.3 5882.8 4414.8 4459.2 4494.4 4495.0 4512.1 4041.6 4055.0 4061.2 4073.1 4081.3 5723.3 5729.8 5733.4 5738.8 5768.7 5825.0 5844.6 5920.9 5939.8 6004.3 5636.9 5645.4 5692.2 5692.6 5716.6 5068.9 5074.0 5077.7 5080.4 5109.8 5899.8 6088.2 6196.6 6198.8 6200.2 6037.8 6059.9 6060.9 6064.6 6098.3 5927.0 6189.1 6263.5 6267.5 6286.0 5893.7 5936.9 5939.3 5963.3 5983.0 5915.7 5935.6 5959.4 5972.6 5973.8 5643.2 5771.3 5857.8 5873.9 5874.1 5890.0 5900.9 5903.1 5903.9 5929.8 5808.9 5814.1 5819.6 5821.0 5824.0 5735.8 5856.4 5910.2 5914.1 5929.8 5524.6 5619.8 5660.7 5726.5 5758.3 05:37:56 INFO - PROCESS | 20051 | 05:37:56 INFO - PROCESS | 20051 | [#1] ext.html Cycles:180 Average:54934.35 Median:35789.87 stddev:105592.78 (295.0%) stddev-sans-first:105810.39 05:37:56 INFO - PROCESS | 20051 | Values: 667.3 678.9 680.1 688.0 751.6 40625.4 42420.4 42445.0 42445.8 42536.8 44284.3 45143.3 45204.8 45231.3 45243.3 7849.9 8059.3 8840.0 9027.3 10460.1 10529.3 10577.6 10634.2 10684.4 10692.0 10670.6 10750.6 10768.6 10786.7 10788.1 7871.7 10463.4 10698.9 10708.6 10709.1 10619.3 10724.2 10766.8 10773.5 10774.7 41315.6 41599.2 41716.0 41748.0 42039.0 3228.7 3481.5 3486.1 3548.4 3592.3 33818.8 34383.8 34448.8 34664.8 34915.0 4080.5 4193.9 4226.2 4282.4 4329.5 248291.0 249233.0 249385.0 250951.0 326717.0 35655.8 66060.7 67438.3 67533.0 67626.7 37952.2 37962.6 38054.0 38148.8 38168.0 12955.6 14493.4 14681.2 14699.7 14731.4 11677.4 11862.9 11863.3 11903.8 11910.6 9459.5 9523.0 9563.0 9603.6 9604.0 3521.5 3550.9 3554.7 3615.4 3619.1 1110.0 1154.4 1157.9 1224.1 1308.3 34783.3 35236.6 35734.3 35845.5 35908.6 1197.6 1226.4 1240.9 1247.4 1352.4 18655.9 18837.4 18945.9 19030.9 19122.9 537257.0 543878.0 544926.0 545496.0 548079.0 62428.0 63151.4 63232.7 63251.4 63294.7 1355.1 1495.2 1498.4 1571.4 1576.0 31452.5 32705.5 34474.5 34581.9 34971.5 53160.7 53367.3 53433.0 53438.2 53517.2 325704.0 326435.0 327910.0 328671.0 329075.0 24373.4 28953.6 29001.4 29211.7 29287.0 45001.5 46147.8 46375.8 46753.5 47019.0 39673.8 42584.6 43273.6 43366.6 44389.8 41576.4 42099.0 42329.0 42784.1 43907.0 43196.4 44589.8 44647.0 44755.6 45043.5 36751.8 37493.0 37895.8 38198.8 38224.2 29840.8 29945.3 30066.2 30318.7 30454.7 05:37:56 INFO - PROCESS | 20051 | 05:37:56 INFO - PROCESS | 20051 | [#2] jquery.html Cycles:180 Average:30746.15 Median:2103.53 stddev:89750.11 (4266.6%) stddev-sans-first:89973.04 05:37:56 INFO - PROCESS | 20051 | Values: 439.5 439.8 440.2 441.1 454.1 19327.4 19609.3 19832.7 19917.2 19967.0 17965.6 19524.2 19735.1 20394.6 20416.5 5886.3 6005.9 6011.7 6026.0 6041.2 5742.9 5925.5 5946.3 5984.6 5993.4 5847.0 5855.6 5856.1 5858.4 5889.9 5669.1 5825.7 5973.9 5974.1 5975.9 5736.0 5790.4 5801.2 5802.6 5834.3 13121.1 13267.5 13290.0 13295.1 13349.9 2426.0 2432.7 2717.7 3037.5 3174.9 10787.9 10809.1 11054.4 13440.9 14143.9 2011.5 2088.9 2102.7 2121.9 2139.7 73097.0 75841.0 84193.0 86497.0 94632.5 11565.7 11646.7 11742.4 11827.6 11870.2 13520.5 17066.3 17071.8 17072.1 17080.7 7902.7 8288.0 8332.5 8433.6 8445.5 7846.9 7848.5 7913.5 7961.6 7975.7 5054.0 5122.3 5147.8 5166.6 5175.4 2017.5 2034.5 2098.7 2104.4 2123.9 1043.8 1081.3 1099.7 1159.8 1182.5 19286.4 19955.6 20221.5 20296.2 20415.6 1030.2 1038.7 1045.9 1062.2 1069.7 10794.5 11361.0 11371.4 11474.8 11586.8 523380.0 534777.0 539047.0 561294.0 564002.0 98578.0 99583.0 99678.0 100755.5 104542.5 1079.8 1092.3 1095.5 1095.8 1104.7 17668.9 17741.6 17811.0 17870.1 18202.3 38099.2 39456.0 41627.6 41648.6 41791.6 56306.4 58398.0 59007.0 59151.0 59417.4 8559.2 8656.7 8683.3 8812.5 9016.6 9699.7 12822.9 12944.2 12973.7 13035.2 11192.0 11363.7 11543.5 11603.6 12128.9 11441.4 11699.3 11732.6 11817.9 11957.5 11868.7 12247.9 12376.3 12394.7 12405.9 8515.3 8586.9 8666.7 8772.6 8984.6 9039.5 11311.8 11883.2 11940.3 12058.2 05:37:56 INFO - PROCESS | 20051 | 05:37:56 INFO - PROCESS | 20051 | [#3] mootools.html Cycles:180 Average:5767.60 Median:454.95 stddev:3239.17 (712.0%) stddev-sans-first:3231.75 05:37:56 INFO - PROCESS | 20051 | Values: 1417.1 1612.2 1612.4 1862.4 1936.6 8288.3 8671.6 8674.0 8677.9 8703.0 8508.2 8658.5 8687.9 8695.0 8705.5 2098.2 2174.4 2177.0 2386.7 2418.1 2406.2 2516.3 2519.2 2519.8 2520.8 2366.8 2395.8 2401.7 2402.4 2404.1 2064.7 2298.6 2298.6 2319.2 2366.9 2390.8 2412.2 2414.3 2415.6 2418.4 8367.7 8504.0 8507.0 8508.1 8513.5 5024.4 5181.6 5183.6 5185.6 5191.7 3279.8 3368.9 3457.1 3475.3 3504.9 1091.9 1098.0 1103.9 1129.8 1153.0 12290.8 12306.0 12350.6 12351.0 12356.6 4836.3 4844.3 4869.1 4926.1 4932.3 10374.2 10450.7 10468.9 10472.8 10473.0 5273.1 5277.3 5285.5 5285.8 5288.3 4179.0 4517.2 4731.1 4759.5 4816.3 4093.5 4178.5 4235.8 4263.6 4268.1 1318.9 1341.4 1352.5 1354.7 1355.1 802.2 939.4 1018.8 1022.3 1041.2 5909.3 5930.7 6040.7 6105.5 6142.3 442.1 450.1 452.3 457.6 458.8 4137.1 4149.0 4281.6 4317.1 4473.7 10326.7 10520.4 10615.8 10659.3 10691.3 10382.5 10471.7 10533.1 10549.2 10564.6 7952.4 8169.0 8169.6 8170.2 8172.9 5850.3 5934.1 6212.6 6320.5 6326.6 9784.1 9864.4 10060.2 10081.0 10171.6 10198.8 10230.8 10262.0 10313.9 10423.6 6729.2 7377.1 7579.8 7652.2 7706.5 8327.1 8338.4 8387.6 8408.9 8421.7 7283.6 7420.5 7457.2 7499.3 7581.2 7368.8 7389.1 7397.0 7470.3 7490.1 6945.3 6977.5 7009.1 7023.1 7024.4 5180.7 5291.4 5382.2 5437.9 5454.0 5207.8 5277.6 5299.4 5299.8 5391.3 05:37:56 INFO - PROCESS | 20051 | 05:37:56 INFO - PROCESS | 20051 | [#4] prototype.html Cycles:180 Average:5020.51 Median:5663.09 stddev:1514.11 (26.7%) stddev-sans-first:1477.20 05:37:56 INFO - PROCESS | 20051 | Values: 349.4 360.1 360.8 365.1 365.4 5430.9 5523.0 5533.3 5571.6 5573.2 5149.5 5290.3 5425.3 5468.4 5485.8 4224.9 4250.9 4261.8 4267.0 4275.5 4240.7 4263.4 4265.3 4275.9 4281.3 4048.0 4150.5 4228.7 4277.5 4284.1 4223.7 4247.7 4257.7 4262.0 4262.1 3824.1 3837.3 3842.7 3850.8 3861.3 5122.8 5151.2 5174.5 5176.4 5307.8 4878.6 4901.5 4924.5 4935.5 4938.5 5661.7 5664.5 5708.6 5735.5 5763.7 4149.5 4194.6 4247.8 4261.7 4267.0 5882.9 5907.8 5909.1 5951.6 5968.4 4296.5 4324.9 4336.7 4339.9 4352.1 4036.2 4280.7 4292.5 4294.7 4378.9 4874.3 4874.4 4885.0 4890.0 4892.3 5767.3 5771.3 5804.7 5819.7 5841.2 1463.5 1487.0 1508.2 1533.1 1554.7 1045.5 1055.7 1063.1 1077.6 1085.0 5936.9 5946.7 5949.0 5967.9 5981.2 6236.6 6248.7 6252.6 6263.6 6274.4 5743.7 5937.3 5951.4 5956.9 5963.1 3349.3 3355.9 3356.8 3358.9 3373.4 6384.2 6389.5 6470.2 6519.1 6544.1 6352.9 6385.8 6405.6 6421.1 6428.0 6263.8 6528.8 6541.2 6554.7 6581.5 6217.1 6253.9 6281.8 6286.8 6327.2 6110.9 6115.4 6128.8 6171.3 6224.7 6288.2 6447.1 6497.2 6498.3 6500.7 4485.9 4494.3 4495.8 4503.7 4510.7 6123.4 6282.6 6306.1 6308.8 6322.9 6086.2 6110.9 6126.4 6136.4 6160.2 6100.2 6102.5 6108.8 6117.8 6139.3 5858.6 6037.9 6044.4 6049.4 6050.3 6047.9 6102.9 6113.1 6153.8 6212.3 5846.7 6061.6 6065.9 6073.9 6097.5 05:37:56 INFO - PROCESS | 20051 | 05:37:56 INFO - PROCESS | 20051 | [#5] yui.html Cycles:180 Average:15144.35 Median:4535.50 stddev:17564.55 (387.3%) stddev-sans-first:17580.19 05:37:56 INFO - PROCESS | 20051 | Values: 669.6 690.3 719.0 750.4 752.1 13756.6 13979.0 14023.9 14084.1 14085.6 15284.5 15581.5 15599.2 15618.1 15641.2 738.6 891.3 895.9 897.0 897.9 880.5 907.4 909.8 910.3 910.9 969.0 969.1 969.2 971.2 973.4 766.5 904.2 959.5 961.2 961.2 682.2 686.3 687.8 688.5 689.2 13561.9 13563.2 13590.0 13592.5 13596.3 13935.6 14502.6 14742.2 14844.0 14852.7 10965.5 11119.9 11138.0 11232.3 11433.4 3855.6 3866.2 3903.9 3958.4 3986.1 60476.1 60588.7 60666.7 60998.0 61335.7 10720.5 10968.6 11342.4 11444.7 11592.9 20945.0 21620.1 21654.6 21671.7 21742.7 8089.2 8332.1 8341.1 8459.2 8658.4 4548.2 4795.5 4804.5 4824.2 4852.7 3443.2 3499.9 3520.8 3527.6 3528.2 691.3 701.3 703.4 711.6 713.1 514.9 665.6 677.5 688.8 704.3 9188.0 9432.4 9446.0 9474.3 9485.2 668.6 694.1 695.1 695.2 700.8 4349.6 4463.6 4522.8 4559.9 4573.1 62215.0 62859.0 63403.7 63583.4 63652.7 53313.2 54694.0 55266.0 55347.0 56506.9 49732.5 50045.5 50359.0 50696.0 50829.0 8746.2 8817.7 8910.3 8955.7 9047.7 32485.4 33759.5 33811.2 33898.3 34519.8 43076.8 44458.3 44808.0 45521.3 46152.8 11646.4 11648.5 12801.3 12983.4 12994.5 12775.1 12983.7 13080.5 13681.2 13864.3 12118.5 12276.1 12640.3 12670.5 13215.9 12162.9 12256.1 12325.8 12484.0 12569.3 12295.1 12946.7 12978.5 13066.2 13462.9 10621.0 10840.4 10948.1 10952.9 11019.8 10518.8 10787.4 10993.8 11012.9 11020.4 05:37:56 INFO - PROCESS | 20051 | -------- Summary: end -------- 05:37:56 INFO - PROCESS | 20051 | 05:37:56 INFO - TEST-INFO | 20051: exit 0 05:37:56 INFO - TEST-OK | dromaeo_css | took 1111187ms 05:37:56 INFO - TEST-START | kraken 05:37:56 INFO - operating with platform_type : linux_ 05:37:56 INFO - Initialising browser for kraken test... 05:37:56 INFO - TEST-INFO | started process 20242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXNF231/profile http://localhost:51348/getInfo.html) 05:38:00 INFO - PROCESS | 20242 | __metrics Screen width/height:1600/1200 05:38:00 INFO - PROCESS | 20242 | colorDepth:24 05:38:00 INFO - PROCESS | 20242 | Browser inner width/height: 1024/697 05:38:00 INFO - PROCESS | 20242 | __metrics 05:38:01 ERROR - PROCESS | 20242 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:38:02 INFO - TEST-INFO | 20242: exit 0 05:38:02 INFO - Browser initialized. 05:38:02 INFO - Running cycle 1/1 for kraken test... 05:38:02 INFO - TEST-INFO | started process 20333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXNF231/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:14 INFO - PROCESS | 20333 | RSS: Main: 141996032 05:38:14 INFO - PROCESS | 20333 | 05:38:16 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51348/tests/kraken/driver.html?testName=audio-beat-detection) 05:38:17 INFO - PROCESS | 20333 | RSS: Main: 196558848 05:38:17 INFO - PROCESS | 20333 | 05:38:20 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51348/tests/kraken/driver.html?testName=audio-dft) 05:38:20 INFO - PROCESS | 20333 | RSS: Main: 182231040 05:38:20 INFO - PROCESS | 20333 | 05:38:23 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51348/tests/kraken/driver.html?testName=audio-fft) 05:38:24 INFO - PROCESS | 20333 | RSS: Main: 273608704 05:38:24 INFO - PROCESS | 20333 | 05:38:26 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51348/tests/kraken/driver.html?testName=audio-oscillator) 05:38:26 INFO - PROCESS | 20333 | RSS: Main: 178831360 05:38:26 INFO - PROCESS | 20333 | 05:38:28 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51348/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:38:29 INFO - PROCESS | 20333 | RSS: Main: 177676288 05:38:29 INFO - PROCESS | 20333 | 05:38:32 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51348/tests/kraken/driver.html?testName=imaging-darkroom) 05:38:33 INFO - PROCESS | 20333 | RSS: Main: 212996096 05:38:33 INFO - PROCESS | 20333 | 05:38:36 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51348/tests/kraken/driver.html?testName=imaging-desaturate) 05:38:36 INFO - PROCESS | 20333 | RSS: Main: 212807680 05:38:36 INFO - PROCESS | 20333 | 05:38:39 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51348/tests/kraken/driver.html?testName=json-parse-financial) 05:38:40 INFO - PROCESS | 20333 | RSS: Main: 212668416 05:38:40 INFO - PROCESS | 20333 | 05:38:41 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51348/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:38:42 INFO - PROCESS | 20333 | RSS: Main: 193634304 05:38:42 INFO - PROCESS | 20333 | 05:38:44 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51348/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:44 INFO - PROCESS | 20333 | RSS: Main: 196009984 05:38:44 INFO - PROCESS | 20333 | 05:38:46 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51348/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:47 INFO - PROCESS | 20333 | RSS: Main: 207409152 05:38:47 INFO - PROCESS | 20333 | 05:38:49 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:38:50 INFO - PROCESS | 20333 | RSS: Main: 215134208 05:38:50 INFO - PROCESS | 20333 | 05:38:53 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:38:53 INFO - PROCESS | 20333 | RSS: Main: 209887232 05:38:53 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | Cycle 1(1): loaded http://localhost:51348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51348/tests/kraken/driver.html?testName=ai-astar) 05:38:55 INFO - PROCESS | 20333 | RSS: Main: 274362368 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | __start_tp_report 05:38:55 INFO - PROCESS | 20333 | _x_x_mozilla_page_load 05:38:55 INFO - PROCESS | 20333 | _x_x_mozilla_page_load_details 05:38:55 INFO - PROCESS | 20333 | |i|pagename|runs| 05:38:55 INFO - PROCESS | 20333 | |0;ai-astar;111;110;111;110;110;110;105;111;111;108 05:38:55 INFO - PROCESS | 20333 | |1;audio-beat-detection;151;134;157;176;129;153;156;128;174;124 05:38:55 INFO - PROCESS | 20333 | |2;audio-dft;164;162;160;162;161;161;163;162;164;161 05:38:55 INFO - PROCESS | 20333 | |3;audio-fft;74;76;76;171;77;76;76;76;162;77 05:38:55 INFO - PROCESS | 20333 | |4;audio-oscillator;93;92;155;92;93;92;142;93;92;154 05:38:55 INFO - PROCESS | 20333 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 05:38:55 INFO - PROCESS | 20333 | |6;imaging-darkroom;145;146;147;147;145;145;146;145;146;145 05:38:55 INFO - PROCESS | 20333 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;94;94 05:38:55 INFO - PROCESS | 20333 | |8;json-parse-financial;53;54;54;55;55;54;55;74;55;52 05:38:55 INFO - PROCESS | 20333 | |9;json-stringify-tinderbox;59;58;57;58;58;57;58;58;58;58 05:38:55 INFO - PROCESS | 20333 | |10;stanford-crypto-aes;81;71;72;72;73;72;73;73;73;73 05:38:55 INFO - PROCESS | 20333 | |11;stanford-crypto-ccm;119;120;119;122;116;116;123;129;149;123 05:38:55 INFO - PROCESS | 20333 | |12;stanford-crypto-pbkdf2;159;159;158;158;161;166;158;167;162;158 05:38:55 INFO - PROCESS | 20333 | |13;stanford-crypto-sha256-iterative;67;67;68;66;66;66;67;68;66;64 05:38:55 INFO - PROCESS | 20333 | __end_tp_report 05:38:55 INFO - PROCESS | 20333 | __start_cc_report 05:38:55 INFO - PROCESS | 20333 | _x_x_mozilla_cycle_collect,1595 05:38:55 INFO - PROCESS | 20333 | __end_cc_report 05:38:55 INFO - PROCESS | 20333 | __startTimestamp1462538335694__endTimestamp 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | ------- Summary: start ------- 05:38:55 INFO - PROCESS | 20333 | Number of tests: 14 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:1.89 (1.7%) stddev-sans-first:1.94 05:38:55 INFO - PROCESS | 20333 | Values: 111.0 110.0 111.0 110.0 110.0 110.0 105.0 111.0 111.0 108.0 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:154.50 stddev:18.77 (12.2%) stddev-sans-first:19.88 05:38:55 INFO - PROCESS | 20333 | Values: 151.0 134.0 157.0 176.0 129.0 153.0 156.0 128.0 174.0 124.0 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.33 (0.8%) stddev-sans-first:1.20 05:38:55 INFO - PROCESS | 20333 | Values: 164.0 162.0 160.0 162.0 161.0 161.0 163.0 162.0 164.0 161.0 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:38.23 (50.3%) stddev-sans-first:39.85 05:38:55 INFO - PROCESS | 20333 | Values: 74.0 76.0 76.0 171.0 77.0 76.0 76.0 76.0 162.0 77.0 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.00 stddev:28.18 (30.6%) stddev-sans-first:29.23 05:38:55 INFO - PROCESS | 20333 | Values: 93.0 92.0 155.0 92.0 93.0 92.0 142.0 93.0 92.0 154.0 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:38:55 INFO - PROCESS | 20333 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 05:38:55 INFO - PROCESS | 20333 | Values: 145.0 146.0 147.0 147.0 145.0 145.0 146.0 145.0 146.0 145.0 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:38:55 INFO - PROCESS | 20333 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:6.37 (11.6%) stddev-sans-first:6.65 05:38:55 INFO - PROCESS | 20333 | Values: 53.0 54.0 54.0 55.0 55.0 54.0 55.0 74.0 55.0 52.0 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 05:38:55 INFO - PROCESS | 20333 | Values: 59.0 58.0 57.0 58.0 58.0 57.0 58.0 58.0 58.0 58.0 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.00 stddev:2.79 (3.8%) stddev-sans-first:0.73 05:38:55 INFO - PROCESS | 20333 | Values: 81.0 71.0 72.0 72.0 73.0 72.0 73.0 73.0 73.0 73.0 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:122.50 stddev:9.71 (7.9%) stddev-sans-first:10.15 05:38:55 INFO - PROCESS | 20333 | Values: 119.0 120.0 119.0 122.0 116.0 116.0 123.0 129.0 149.0 123.0 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:160.00 stddev:3.41 (2.1%) stddev-sans-first:3.56 05:38:55 INFO - PROCESS | 20333 | Values: 159.0 159.0 158.0 158.0 161.0 166.0 158.0 167.0 162.0 158.0 05:38:55 INFO - PROCESS | 20333 | 05:38:55 INFO - PROCESS | 20333 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 05:38:55 INFO - PROCESS | 20333 | Values: 67.0 67.0 68.0 66.0 66.0 66.0 67.0 68.0 66.0 64.0 05:38:55 INFO - PROCESS | 20333 | -------- Summary: end -------- 05:38:55 INFO - PROCESS | 20333 | 05:38:56 INFO - TEST-INFO | 20333: exit 0 05:38:56 INFO - TEST-OK | kraken | took 59856ms 05:38:56 INFO - SUITE-END | took 1171s 05:38:56 INFO - Completed test suite (00:19:31) 05:38:56 INFO - javascript benchmark 05:38:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3288.457404528253, 3363.7645364824457, 3371.51113088602, 3392.6268110507854, 3417.3336199441105, 5558.194061861028, 5590.524805391541, 5591.4688104630095, 5602.07565751651, 5618.269624948751, 5589.8602534936645, 5593.636413633111, 5606.859828504289, 5614.775408983646, 5639.2668953036155, 4923.409190897098, 4971.179755340382, 5055.191169412886, 5057.468965758598, 5113.411957624883, 4928.531789480012, 5017.5484206421415, 5053.9241911371355, 5103.132467480518, 5103.923441148386, 5107.0, 5143.382794064718, 5148.3564554430695, 5148.794048238066, 5159.045576568328, 5079.3650793650795, 5079.873003174913, 5146.047981123485, 5151.5878729701535, 5170.431252562215, 4803.902079525222, 4850.975745121287, 4961.950380496185, 4965.255211718271, 4968.527989840959, 5290.894182116374, 5305.018571564273, 5314.3091398117995, 5316.867078323035, 5327.813526526592, 5882.852928676774, 6004.369541198155, 6056.72744726484, 6060.909086363708, 6065.4844338231305, 6029.547783916224, 6059.575829691923, 6060.787872424488, 6089.908651370233, 6109.541784366146, 5396.244525766396, 5674.687892165888, 5674.943250567524, 5686.630369026041, 5687.232223649837, 6063.423974722395, 6155.969220153871, 6160.784372546939, 6163.013917773134, 6165.414285642857, 5902.2622172228475, 5913.70431478433, 5914.408559144051, 5915.852103697356, 5917.881642367129, 5807.88384232313, 5947.791827286024, 5987.760489580455, 5999.100134979788, 6011.458968692751, 5885.234919460443, 5890.705464726747, 5908.172855800191, 5908.911366329508, 5924.496417804535, 5868.09044598088, 5868.970655146697, 5873.618214816023, 5874.32445268791, 5882.794102206402, 4414.823407063745, 4459.152760975404, 4494.393256910275, 4494.977525112354, 4512.05246898155, 4041.6362527372676, 4054.959450405458, 4061.1674606705556, 4073.06319546506, 4081.3265811140827, 5723.284589426322, 5729.770809167587, 5733.369329373765, 5738.799142030009, 5768.711564421762, 5824.970875145682, 5844.620099693507, 5920.911186332209, 5939.792107276225, 6004.309504406961, 5636.943630563642, 5645.4072322405555, 5692.174634677948, 5692.6015178937905, 5716.5998380113, 5068.949310506921, 5074.0, 5077.746112694351, 5080.364954380702, 5109.770060347293, 5899.823005309848, 6088.208532890696, 6196.597221180518, 6198.783042593487, 6200.162977997912, 6037.803726410103, 6059.878802424015, 6060.939390606214, 6064.605800622945, 6098.26820781509, 5926.970365148147, 6189.133521306931, 6263.498920086291, 6267.529935254783, 6286.0, 5893.734781934738, 5936.940630593639, 5939.2575928009, 5963.254593175853, 5982.970085149546, 5915.733791979285, 5935.584509084495, 5959.374265702038, 5972.611780234271, 5973.790917317873, 5643.238162848127, 5771.307443106854, 5857.824265272048, 5873.853153671193, 5874.089516125007, 5890.0, 5900.881982360414, 5903.144044113666, 5903.91144132847, 5929.792457263975, 5808.912866307093, 5814.098814683731, 5819.563532734977, 5821.039528477754, 5823.970880145572, 5735.770569177186, 5856.4143585641095, 5910.202122713378, 5914.142449344735, 5929.822105336847, 5524.558035357242, 5619.7752089917585, 5660.660360378391, 5726.455986681259, 5758.337791154071], "value": 5499.903991102129, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.3093348384423, 678.9355011273927, 680.078493641116, 687.9587224766515, 751.6054071612406, 40625.3906191407, 42420.36369454453, 42445.0, 42445.78777106114, 42536.787316063455, 44284.33573496392, 45143.322850157274, 45204.77397613016, 45231.321530177076, 45243.32135017977, 7849.882251766228, 8059.274665280123, 8839.999999999984, 9027.322950778685, 10460.11089057431, 10529.262951593391, 10577.576896924114, 10634.20243481742, 10684.358938463678, 10692.0, 10670.62652807152, 10750.569977200903, 10768.569257229701, 10786.676399708022, 10788.08301294391, 7871.685132594718, 10463.424511651818, 10698.893011069867, 10708.625198118107, 10709.089727373183, 10619.25665203436, 10724.249302548824, 10766.838497422545, 10773.515191816308, 10774.676759697144, 41315.586844131474, 41599.168016639494, 41716.0, 41748.0, 42039.0, 3228.6932741389533, 3481.5125882376487, 3486.092451609698, 3548.449990251515, 3592.263585964871, 33818.830905845556, 34383.828080859435, 34448.82775586131, 34664.82667586671, 34915.0, 4080.469538959946, 4193.895152621179, 4226.218149642326, 4282.357646353041, 4329.480462344507, 248291.0, 249233.0, 249385.0, 250951.0, 326717.0, 35655.82172089123, 66060.66969665121, 67438.32561674419, 67533.0, 67626.66186669035, 37952.240955181296, 37962.62037379646, 38054.0, 38148.80925595354, 38168.0, 12955.611331660066, 14493.420263189355, 14681.19253441071, 14699.706005879823, 14731.410743570352, 11677.416129193507, 11862.88137118635, 11863.347515886537, 11903.761924761457, 11910.642680719593, 9459.52702364879, 9522.95238523803, 9562.95218523903, 9603.615855365846, 9604.0, 3521.542199514047, 3550.857965681344, 3554.697850682721, 3615.367310720613, 3619.113317237294, 1109.9778004440027, 1154.3535620052796, 1157.8726340102583, 1224.0965298960025, 1308.2935214983802, 34783.30433391318, 35236.64763352385, 35734.28531429357, 35845.46231806525, 35908.64091359053, 1197.6407077876602, 1226.4113225651558, 1240.9379531023412, 1247.357610830423, 1352.4184600621827, 18655.90672046631, 18837.434876953714, 18945.90527047356, 19030.90484547596, 19122.904385477985, 537257.0, 543878.0, 544926.0, 545496.0, 548079.0, 62428.0, 63151.368486314546, 63232.68383658144, 63251.36748632547, 63294.683526582994, 1355.0988592586018, 1495.2000679636342, 1498.4455751371845, 1571.3714514194185, 1575.9606009849617, 31452.52821207638, 32705.509417358284, 34474.482882756274, 34581.860310166994, 34971.47542786809, 53160.73419632877, 53367.33163341895, 53433.0, 53438.19842702441, 53517.19724204218, 325704.0, 326435.0, 327910.0, 328671.0, 329075.0, 24373.39066523351, 28953.56569651499, 29001.419971600873, 29211.70788292175, 29287.0, 45001.54998449974, 46147.76926115348, 46375.76812115918, 46753.53246467492, 47019.0, 39673.801630991664, 42584.57415425806, 43273.56726432696, 43366.566334336254, 44389.77805110954, 41576.376354355314, 42099.0, 42329.0, 42784.14431711286, 43907.0, 43196.352054719835, 44589.777051114535, 44647.0, 44755.55244447644, 45043.54956450524, 36751.816240918626, 37493.0, 37895.81052094722, 38198.8090059559, 38224.23551529009, 29840.80523281882, 29945.320358953453, 30066.248343790707, 30318.696813031587, 30454.695453045188], "value": 19687.425204859148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.46165946715297, 439.8075593168057, 440.16808232440695, 441.08254829953694, 454.114476770298, 19327.420177394684, 19609.313674021396, 19832.70250946237, 19917.203311867506, 19967.0, 17965.64068718625, 19524.21903123877, 19735.1119199636, 20394.592108157827, 20416.489587760312, 5886.293644762613, 6005.879882402372, 6011.699415029231, 6026.0, 6041.24484439445, 5742.885142297151, 5925.525957923377, 5946.286445626531, 5984.5511586630955, 5993.430624090726, 5846.9707651461895, 5855.648661080328, 5856.092305692625, 5858.355580886099, 5889.941100588982, 5669.149627555879, 5825.708714564276, 5973.880522389528, 5974.133750606181, 5975.880482390371, 5736.0, 5790.36306006339, 5801.216835727165, 5802.564807639402, 5834.27071616048, 13121.147125436815, 13267.535636252685, 13290.0, 13295.069345145843, 13349.86650133496, 2425.987870060638, 2432.6959130108735, 2717.714639962795, 3037.4988126959024, 3174.8888788892277, 10787.892121078845, 10809.135269178447, 11054.447277636085, 13440.86559134406, 14143.85856141446, 2011.4971257185703, 2088.905999230023, 2102.6543012471875, 2121.8514703970573, 2139.6576547752443, 73097.0, 75841.0, 84193.0, 86497.0, 94632.52683736537, 11565.653030409101, 11646.70883227926, 11742.354170520703, 11827.645170644895, 11870.228435151688, 13520.526781562598, 17066.317347306216, 17071.829281707272, 17072.061036643103, 17080.743788843178, 7902.68389264423, 8287.95856020728, 8332.458390204618, 8433.620487078097, 8445.535495547681, 7846.9215307847335, 7848.529088254723, 7913.485623434458, 7961.6019199040975, 7975.720849770346, 5053.9747301264, 5122.257272695439, 5147.819826306136, 5166.638335316567, 5175.430702622709, 2017.535966727661, 2034.4710375302527, 2098.6537221358612, 2104.400245929933, 2123.936281911514, 1043.843423486483, 1081.329575663094, 1099.6536091131268, 1159.8492196014465, 1182.467889449751, 19286.4214073578, 19955.60088798245, 20221.49446263855, 20296.188152473736, 20415.591688166154, 1030.1655658916152, 1038.7143535527791, 1045.8849526552074, 1062.2404980438869, 1069.7058308965097, 10794.514246858911, 11361.0, 11371.374574398322, 11474.827877581843, 11586.76826463466, 523380.0, 534777.0, 539047.0, 561294.0, 564002.0, 98578.0, 99583.0, 99678.0, 100755.49622251988, 104542.47728761307, 1079.7570546626946, 1092.306385445232, 1095.5289225633055, 1095.7863216672831, 1104.6630777612904, 17668.91165544164, 17741.645167096845, 17811.0, 17870.106494674954, 18202.271909123487, 38099.238015240095, 39456.0, 41627.583724162374, 41648.58351416447, 41791.58208417877, 56306.436935631755, 58398.0, 59007.0, 59151.0, 59417.405825942915, 8559.186877246651, 8656.740297791077, 8683.305335573014, 8812.471251724917, 9016.59425325875, 9699.70900872975, 12822.935885320514, 12944.223346599234, 12973.740525189633, 13035.15271507349, 11192.0, 11363.659090227306, 11543.538258469567, 11603.593874214363, 12128.9083982442, 11441.370724610226, 11699.2980421175, 11732.589359372381, 11817.940910295394, 11957.521699131938, 11868.703282418008, 12247.877521224673, 12376.257424554555, 12394.690132746753, 12405.875941240833, 8515.318774497902, 8586.923622723334, 8666.739997800076, 8772.561371931506, 8984.59569319369, 9039.548022598976, 11311.830322545004, 11883.227590206609, 11940.283582985048, 12058.216215945935], "value": 9481.21929555811, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.1072224498564, 1612.2180742339967, 1612.4275882061866, 1862.3947217154428, 1936.5642730385657, 8288.254057134856, 8671.609777560008, 8673.999999999993, 8677.91322086779, 8703.0, 8508.191721786436, 8658.480491170534, 8687.86968195476, 8695.0, 8705.520061589528, 2098.171222367164, 2174.3803016140405, 2177.031221106608, 2386.713594368678, 2418.093215044358, 2406.1939250351065, 2516.3457501049675, 2519.1686743374644, 2519.7858182054547, 2520.760527749861, 2366.7988221001237, 2395.7604239576076, 2401.6637670726113, 2402.3633737059695, 2404.0984630763464, 2064.669652855536, 2298.6207275799475, 2298.643710224918, 2319.234652564658, 2366.9408264793346, 2390.760923907613, 2412.203972689026, 2414.3360575841607, 2415.6376543518436, 2418.3712234819072, 8367.748967530923, 8504.0, 8506.957465212696, 8508.149185081504, 8513.489190648581, 5024.397072351305, 5181.559567436772, 5183.637145399824, 5185.611079169077, 5191.6884986900905, 3279.7868138570916, 3368.9051058406117, 3457.0665920201404, 3475.2528206435736, 3504.912377190565, 1091.939943303118, 1098.0337303173237, 1103.9337639741561, 1129.7853407852565, 1152.982705259422, 12290.815637765441, 12306.0, 12350.567730129402, 12350.950169235626, 12356.567520136841, 4836.250381190921, 4844.32179494871, 4869.123557759566, 4926.064047830901, 4932.284818701268, 10374.17006639467, 10450.68647940563, 10468.947655261827, 10472.842907356397, 10473.0, 5273.129933560919, 5277.287566178594, 5285.524302812765, 5285.762140703678, 5288.2596436498925, 4179.0, 4517.164324599959, 4731.101090792738, 4759.50025247351, 4816.253480710496, 4093.5087789465456, 4178.484953303331, 4235.767032813224, 4263.55232700562, 4268.103698223408, 1318.9340532973313, 1341.4298922957898, 1352.5198554513006, 1354.7493713663005, 1355.105630284008, 802.1978021978022, 939.3987847777428, 1018.8267994440963, 1022.3405903192399, 1041.234692501011, 5909.349971503131, 5930.703464826742, 6040.728167232485, 6105.511559075263, 6142.324344322121, 442.1400376268128, 450.09980039920157, 452.29667866467304, 457.5973143633581, 458.7706146926537, 4137.089840235143, 4149.0, 4281.571842815693, 4317.136572685476, 4473.686841921034, 10326.741831454274, 10520.368777873198, 10615.84076238857, 10659.253852230424, 10691.305065170895, 10382.532786024647, 10471.68584942453, 10533.052025317758, 10549.156067514581, 10564.577416903237, 7952.443328966917, 8169.019717633922, 8169.550674713067, 8170.223828736261, 8172.918270817335, 5850.268716410449, 5934.083504886754, 6212.596181248205, 6320.494360451061, 6326.588771729823, 9784.119429251401, 9864.408135511892, 10060.195184385379, 10081.0, 10171.64399246023, 10198.796024079329, 10230.846537301797, 10262.0, 10313.9484302581, 10423.583056677648, 6729.158855143107, 7377.077865266841, 7579.848403032019, 7652.196519365387, 7706.537607743553, 8327.084020757833, 8338.416310858182, 8387.622556985072, 8408.915910840813, 8421.70524031656, 7283.599402032939, 7420.517666351886, 7457.216992215739, 7499.287567681062, 7581.203973582695, 7368.778936631909, 7389.076365454318, 7397.0, 7470.3276705096805, 7490.138634056935, 6945.340192681687, 6977.476689248429, 7009.088818453569, 7023.086998690342, 7024.402925751164, 5180.663256888291, 5291.365036195682, 5382.192671099367, 5437.891242175214, 5454.0, 5207.843764687065, 5277.630565860353, 5299.428708401478, 5299.8410047698635, 5391.32608423947], "value": 4571.760966101193, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.3519521288011, 360.12130401819564, 360.8087713511839, 365.0745360511105, 365.3952708267814, 5430.864228394287, 5523.0, 5533.3083364579425, 5571.554275657948, 5573.191887176367, 5149.510796474338, 5290.285811415468, 5425.294711687475, 5468.371137319209, 5485.807996720116, 4224.943764058985, 4250.893727656818, 4261.829526818923, 4266.97866510667, 4275.486941567016, 4240.660747140237, 4263.4031235627035, 4265.274903266437, 4275.935860962072, 4281.272183728774, 4048.0487085535024, 4150.4682143892205, 4228.682848786338, 4277.465316835395, 4284.143171365724, 4223.725457845261, 4247.702660813759, 4257.680673949466, 4261.957380426187, 4262.147570485915, 3824.139568597071, 3837.347650899354, 3842.6541611254843, 3850.8074596270076, 3861.3242682530727, 5122.76947537358, 5151.17581187012, 5174.490372169495, 5176.378834539842, 5307.787688492455, 4878.609711223094, 4901.534354236342, 4924.482929292409, 4935.470004298679, 4938.530839570235, 5661.688607126606, 5664.49019588239, 5708.600397972144, 5735.483806457439, 5763.711814409263, 4149.502059752849, 4194.580541945811, 4247.8300867965245, 4261.74429534229, 4267.0, 5882.911756323616, 5907.793227237026, 5909.143174239711, 5951.613145145595, 5968.37332080134, 4296.548862369469, 4324.891877703019, 4336.696431249846, 4339.934900976488, 4352.107817897323, 4036.1524079942956, 4280.743155410685, 4292.527821939584, 4294.742315461082, 4378.912421751547, 4874.293227481995, 4874.440179142711, 4884.9511504884495, 4890.0, 4892.266160075946, 5767.250257466502, 5771.326315368496, 5804.65172089676, 5819.73811178498, 5841.153032810304, 1463.524354584743, 1486.9628259293604, 1508.1554329575472, 1533.1184568872943, 1554.7095910394346, 1045.534737042009, 1055.6780182044397, 1063.1016790811752, 1077.6314081116936, 1084.9945750271356, 5936.881262374728, 5946.732397042144, 5948.988671925783, 5967.910481342783, 5981.192539007178, 6236.594621349598, 6248.687565621701, 6252.562320637512, 6263.6241825490615, 6274.403931626488, 5743.655380677173, 5937.2578427696535, 5951.404859514014, 5956.855532008473, 5963.135345374896, 3349.3301339731665, 3355.899323020313, 3356.798592084434, 3358.882439114619, 3373.37592545375, 6384.201974753156, 6389.52078594098, 6470.191226096738, 6519.119918810899, 6544.149260596092, 6352.904706429407, 6385.83900969014, 6405.551611387158, 6421.068945002949, 6428.0, 6263.778563180227, 6528.771492997817, 6541.2150541934325, 6554.70503827329, 6581.506387020992, 6217.129601855653, 6253.937460625336, 6281.842953926189, 6286.811395658137, 6327.209098862642, 6110.877782444415, 6115.388461153849, 6128.816135515942, 6171.290301615371, 6224.719887604978, 6288.245410550763, 6447.129637499065, 6497.18785151856, 6498.252700939453, 6500.707468164039, 4485.887852803706, 4494.303382975644, 4495.820167193407, 4503.729776213438, 4510.6617003725505, 6123.357047510125, 6282.623042617275, 6306.117143599991, 6308.810735677937, 6322.8735425290315, 6086.178365920721, 6110.877782444415, 6126.387361263838, 6136.417040381157, 6160.168377269011, 6100.176476175837, 6102.4812890902995, 6108.816735497942, 6117.755289788359, 6139.293981192041, 5858.619189752652, 6037.939620603914, 6044.365341639064, 6049.395060494091, 6050.273967123797, 6047.909281360695, 6102.877942441215, 6113.144159817718, 6153.784617538365, 6212.285587157535, 5846.707664616667, 6061.575689701678, 6065.907261994605, 6073.939260607514, 6097.451229389376], "value": 4545.6218994205165, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.6250099944031, 690.3165865792861, 718.9604571748555, 750.3696894608531, 752.0711920777838, 13756.587302380933, 13979.0, 14023.92988035061, 14084.08453450525, 14085.577432677022, 15284.465043723472, 15581.532554023397, 15599.22003899806, 15618.062916225035, 15641.217939103057, 738.6343759838887, 891.3003292415456, 895.9059298773633, 897.0267260022883, 897.9236764874994, 880.5025160784169, 907.4419232172232, 909.7680091576639, 910.3400034974657, 910.9498977556232, 969.0406497567393, 969.1326262994615, 969.190725744001, 971.1502435369052, 973.3770386952356, 766.5324152267112, 904.2449554621899, 959.5490119643756, 961.1589858873485, 961.2406199102735, 682.2188594059774, 686.3102581905204, 687.8108520156946, 688.4836372720459, 689.2349492063805, 13561.932190339085, 13563.186208827501, 13590.048696591242, 13592.524261650893, 13596.252206128658, 13935.58193254204, 14502.637434064232, 14742.189179595118, 14844.0, 14852.70294594102, 10965.50655220517, 11119.944400278027, 11138.007276937917, 11232.269902456314, 11433.371164586028, 3855.556610989744, 3866.1881004988704, 3903.941440878389, 3958.3666613342016, 3986.1031267964768, 60476.09285860715, 60588.69705651487, 60666.69666651683, 60998.0, 61335.69332153311, 10720.517576709066, 10968.561257549769, 11342.432878356049, 11444.656660300205, 11592.942035289769, 20945.0, 21620.13519459204, 21654.566908662055, 21671.67492487614, 21742.673859892115, 8089.191080891864, 8332.125126861714, 8341.124181960928, 8459.238668519863, 8658.350623703247, 4548.226801443762, 4795.544423279783, 4804.543568361, 4824.179889418807, 4852.733099679481, 3443.2424866529823, 3499.8600055997986, 3520.8063556504126, 3527.5766907971206, 3528.2237907660788, 691.2879733874117, 701.3267263427167, 703.3739971425435, 711.6228398948462, 713.0908092182509, 514.8815772372375, 665.6339013542532, 677.5088061155722, 688.8002479280952, 704.3344039882262, 9188.0, 9432.434053956784, 9446.0, 9474.289428292906, 9485.241180705527, 668.5587512241897, 694.1184695436767, 695.1172011545309, 695.1553862057624, 700.7722490190708, 4349.586789255016, 4463.575960283768, 4522.773861306921, 4559.863204103882, 4573.108243892409, 62215.0, 62859.0, 63403.68298158572, 63583.36416635867, 63652.68173659102, 53313.2003019955, 54694.0, 55266.026057655006, 55347.0, 56506.86986260334, 49732.50267497351, 50045.49954500408, 50359.0, 50695.999999999265, 50829.0, 8746.169113934166, 8817.691380801642, 8910.287177025952, 8955.686550970684, 9047.68333108338, 32485.35029299448, 33759.49360759542, 33811.15472113217, 33898.322033558696, 34519.827400862836, 43076.78461607797, 44458.333125003795, 44808.0, 45521.31718024166, 46152.7692361536, 11646.417679116179, 11648.534058637559, 12801.29592872401, 12983.35083245815, 12994.545190918272, 12775.105742597929, 12983.675408114872, 13080.542181023618, 13681.247531385869, 13864.306784660524, 12118.454669539715, 12276.140670153003, 12640.304783236643, 12670.493180273055, 13215.867841321464, 12162.939185304016, 12256.14207005501, 12325.815112773136, 12484.0, 12569.308688022247, 12295.139340246455, 12946.741065178832, 12978.545750898673, 13066.150700204456, 13462.86537134616, 10621.0, 10840.403777791982, 10948.124150067817, 10952.945235273774, 11019.83470247963, 10518.842217366593, 10787.352758834495, 10993.780124397626, 11012.944935275273, 11020.393878336768], "value": 6906.120078009201, "unit": "score"}], "name": "dromaeo_css", "value": 7267.641192356147, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 105.0, 111.0, 111.0, 108.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 134.0, 157.0, 176.0, 129.0, 153.0, 156.0, 128.0, 174.0, 124.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 160.0, 162.0, 161.0, 161.0, 163.0, 162.0, 164.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 171.0, 77.0, 76.0, 76.0, 76.0, 162.0, 77.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 155.0, 92.0, 93.0, 92.0, 142.0, 93.0, 92.0, 154.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 147.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 55.0, 55.0, 54.0, 55.0, 74.0, 55.0, 52.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 57.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 71.0, 72.0, 72.0, 73.0, 72.0, 73.0, 73.0, 73.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 119.0, 122.0, 116.0, 116.0, 123.0, 129.0, 149.0, 123.0], "value": 123.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 158.0, 158.0, 161.0, 166.0, 158.0, 167.0, 162.0, 158.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 66.0, 66.0, 67.0, 68.0, 66.0, 64.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1518.8999999999999, "alertThreshold": 2.0}]} 05:38:56 INFO - Return code: 0 05:38:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:38:56 ERROR - # TBPL SUCCESS # 05:38:56 INFO - Running post-action listener: _resource_record_post_action 05:38:56 INFO - Running post-run listener: _resource_record_post_run 05:38:58 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 500293632; Read time: 4; Write time: 339720 05:38:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 249016320; Read time: 0; Write time: 197684 05:38:58 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251277312; Read time: 4; Write time: 142036 05:38:58 INFO - Running post-run listener: _upload_blobber_files 05:38:58 INFO - Blob upload gear active. 05:38:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:38:58 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:58 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:58 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:58 INFO - (blobuploader) - INFO - Open directory for files ... 05:38:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:38:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:38:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:59 INFO - (blobuploader) - INFO - Done attempting. 05:38:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:38:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:00 INFO - (blobuploader) - INFO - Done attempting. 05:39:00 INFO - (blobuploader) - INFO - Iteration through files over. 05:39:00 INFO - Return code: 0 05:39:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:39:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:39:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19b1bc25681299c2727685e73dc3b90a209dd3814b43e51cf1d4407bed0cd5876d68a6d916e2d96f61e7d38c0c16f171a0bdeea99c0376c95782182e1826d801", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ac5fb390f34b9fc74ba683ed0cb96889e6092da8033a8324ff7df70b6aec1c12a1c64a28fe56cc7060582d64aaf1eb000ce7613bb1d2edd7bf9dbc4061c220e"} 05:39:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:39:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:39:00 INFO - Contents: 05:39:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19b1bc25681299c2727685e73dc3b90a209dd3814b43e51cf1d4407bed0cd5876d68a6d916e2d96f61e7d38c0c16f171a0bdeea99c0376c95782182e1826d801", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ac5fb390f34b9fc74ba683ed0cb96889e6092da8033a8324ff7df70b6aec1c12a1c64a28fe56cc7060582d64aaf1eb000ce7613bb1d2edd7bf9dbc4061c220e"} 05:39:00 INFO - Running post-run listener: copy_logs_to_upload_dir 05:39:00 INFO - Copying logs to upload dir... 05:39:00 INFO - mkdir: /builds/slave/test/build/upload/logs 05:39:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.217711 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-06 05:38:58.796754) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 05:38:58.799930) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323 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/19b1bc25681299c2727685e73dc3b90a209dd3814b43e51cf1d4407bed0cd5876d68a6d916e2d96f61e7d38c0c16f171a0bdeea99c0376c95782182e1826d801", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ac5fb390f34b9fc74ba683ed0cb96889e6092da8033a8324ff7df70b6aec1c12a1c64a28fe56cc7060582d64aaf1eb000ce7613bb1d2edd7bf9dbc4061c220e"} 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.011332 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/19b1bc25681299c2727685e73dc3b90a209dd3814b43e51cf1d4407bed0cd5876d68a6d916e2d96f61e7d38c0c16f171a0bdeea99c0376c95782182e1826d801", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ac5fb390f34b9fc74ba683ed0cb96889e6092da8033a8324ff7df70b6aec1c12a1c64a28fe56cc7060582d64aaf1eb000ce7613bb1d2edd7bf9dbc4061c220e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 05:38:58.824913) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:38:58.825238) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462537113.82243-1983119323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:38:58.911404) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 05:38:58.912030) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 05:38:58.912592) ========= ========= Total master_lag: 0.16 =========