builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1462986688.43 results: success (0) buildid: 20160511072717 builduid: d3ed638dc3064df2abaab28c4379cbdd revision: 6485fbf9000cadac47e1c50eabf51f7fa6b37dfc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 10:11:28.434389) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 10:11:28.434882) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 10:11:28.435170) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 10:11:28.451780) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 10:11:28.452150) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 10:11:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.7M=0s 2016-05-11 10:11:28 (88.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118663 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 10:11:28.584616) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 10:11:28.584964) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020973 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 10:11:28.635414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 10:11:28.635783) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6485fbf9000cadac47e1c50eabf51f7fa6b37dfc --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 6485fbf9000cadac47e1c50eabf51f7fa6b37dfc --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=edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 10:11:28,869 truncating revision to first 12 chars 2016-05-11 10:11:28,870 Setting DEBUG logging. 2016-05-11 10:11:28,870 attempt 1/10 2016-05-11 10:11:28,870 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6485fbf9000c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 10:11:29,833 unpacking tar archive at: mozilla-aurora-6485fbf9000c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.225698 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 10:11:29.875936) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 10:11:29.876286) ========= script_repo_revision: 6485fbf9000cadac47e1c50eabf51f7fa6b37dfc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 10:11:29.876711) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 10:11:29.876974) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 10:11:29.887021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-11 10:11:29.887376) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:11:30 INFO - MultiFileLogger online at 20160511 10:11:30 in /builds/slave/test 10:11:30 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 10:11:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:11:30 INFO - {'append_to_log': False, 10:11:30 INFO - 'base_work_dir': '/builds/slave/test', 10:11:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:11:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:11:30 INFO - 'branch': 'Mozilla-Aurora', 10:11:30 INFO - 'buildbot_json_path': 'buildprops.json', 10:11:30 INFO - 'config_files': ('talos/linux_config.py',), 10:11:30 INFO - 'default_actions': ('clobber', 10:11:30 INFO - 'read-buildbot-config', 10:11:30 INFO - 'download-and-extract', 10:11:30 INFO - 'populate-webroot', 10:11:30 INFO - 'create-virtualenv', 10:11:30 INFO - 'install', 10:11:30 INFO - 'run-tests'), 10:11:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:11:30 INFO - 'download_minidump_stackwalk': True, 10:11:30 INFO - 'download_symbols': 'ondemand', 10:11:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:11:30 INFO - 'tooltool.py': '/tools/tooltool.py', 10:11:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:11:30 INFO - '/tools/misc-python/virtualenv.py')}, 10:11:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:11:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:11:30 INFO - 'installer_path': 'installer.exe', 10:11:30 INFO - 'log_level': 'info', 10:11:30 INFO - 'log_name': 'talos', 10:11:30 INFO - 'log_to_console': True, 10:11:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:11:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:11:30 INFO - 'opt_config_files': (), 10:11:30 INFO - 'pip_index': False, 10:11:30 INFO - 'sps_profile': False, 10:11:30 INFO - 'sps_profile_interval': 0, 10:11:30 INFO - 'suite': 'dromaeojs', 10:11:30 INFO - 'system_bits': '32', 10:11:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:11:30 INFO - 'title': 'talos-linux64-ix-033', 10:11:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:11:30 INFO - 'use_talos_json': True, 10:11:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:11:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:11:30 INFO - 'work_dir': 'build'} 10:11:30 INFO - ##### 10:11:30 INFO - ##### Running clobber step. 10:11:30 INFO - ##### 10:11:30 INFO - Running pre-action listener: _resource_record_pre_action 10:11:30 INFO - Running main action method: clobber 10:11:30 INFO - rmtree: /builds/slave/test/build 10:11:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:11:30 INFO - Running post-action listener: _resource_record_post_action 10:11:30 INFO - ##### 10:11:30 INFO - ##### Running read-buildbot-config step. 10:11:30 INFO - ##### 10:11:30 INFO - Running pre-action listener: _resource_record_pre_action 10:11:30 INFO - Running main action method: read_buildbot_config 10:11:30 INFO - Using buildbot properties: 10:11:30 INFO - { 10:11:30 INFO - "project": "", 10:11:30 INFO - "product": "firefox", 10:11:30 INFO - "script_repo_revision": "production", 10:11:30 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:11:30 INFO - "repository": "", 10:11:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:11:30 INFO - "buildid": "20160511072717", 10:11:30 INFO - "pgo_build": "True", 10:11:30 INFO - "basedir": "/builds/slave/test", 10:11:30 INFO - "buildnumber": 324, 10:11:30 INFO - "slavename": "talos-linux64-ix-033", 10:11:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:11:30 INFO - "platform": "ubuntu64_hw", 10:11:30 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:11:30 INFO - "branch": "mozilla-aurora", 10:11:30 INFO - "repo_path": "releases/mozilla-aurora", 10:11:30 INFO - "revision": "6485fbf9000cadac47e1c50eabf51f7fa6b37dfc", 10:11:30 INFO - "stage_platform": "linux64-pgo", 10:11:30 INFO - "builduid": "d3ed638dc3064df2abaab28c4379cbdd", 10:11:30 INFO - "slavebuilddir": "test" 10:11:30 INFO - } 10:11:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 10:11:30 INFO - Running post-action listener: _resource_record_post_action 10:11:30 INFO - ##### 10:11:30 INFO - ##### Running download-and-extract step. 10:11:30 INFO - ##### 10:11:30 INFO - Running pre-action listener: _resource_record_pre_action 10:11:30 INFO - Running main action method: download_and_extract 10:11:30 INFO - mkdir: /builds/slave/test/build/tests 10:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:30 INFO - https://queue.taskcluster.net/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:11:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:11:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:11:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/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 10:11:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/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 10:11:31 INFO - Downloaded 1361 bytes. 10:11:31 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:11:31 INFO - Using the following test package requirements: 10:11:31 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:11:31 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:11:31 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:11:31 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:31 INFO - u'jsshell-linux-x86_64.zip'], 10:11:31 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:11:31 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:11:31 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:11:31 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:11:31 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:11:31 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:11:31 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:11:31 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')]} 10:11:31 INFO - https://queue.taskcluster.net/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:11:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:11:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/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 10:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/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 10:11:34 INFO - Downloaded 23799188 bytes. 10:11:34 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'] 10:11:34 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 10:11:35 INFO - Return code: 0 10:11:35 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 10:11: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')]} 10:11:35 INFO - https://queue.taskcluster.net/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/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 10:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/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 10:11:36 INFO - Downloaded 23799188 bytes. 10:11:36 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'] 10:11:36 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 10:11:38 INFO - Return code: 0 10:11: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')]} 10:11:38 INFO - https://queue.taskcluster.net/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:11:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:11:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:11:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/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 10:11:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/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 10:11:39 INFO - Downloaded 10840145 bytes. 10:11:39 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'] 10:11:39 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 10:11:39 INFO - Return code: 0 10:11:39 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')]} 10:11:39 INFO - https://queue.taskcluster.net/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:11:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:11:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:11:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/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 10:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/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 10:11:40 INFO - Downloaded 62734786 bytes. 10:11:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:11:40 INFO - mkdir: /builds/slave/test/properties 10:11:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:11:40 INFO - Writing to file /builds/slave/test/properties/build_url 10:11:40 INFO - Contents: 10:11:40 INFO - build_url:https://queue.taskcluster.net/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:11:41 INFO - Running post-action listener: _resource_record_post_action 10:11:41 INFO - Running post-action listener: set_extra_try_arguments 10:11:41 INFO - ##### 10:11:41 INFO - ##### Running populate-webroot step. 10:11:41 INFO - ##### 10:11:41 INFO - Running pre-action listener: _resource_record_pre_action 10:11:41 INFO - Running main action method: populate_webroot 10:11:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:11:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:11:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:11:41 INFO - '--tppagecycles', 10:11:41 INFO - '7'], 10:11:41 INFO - 'tests': ['tsvgm']}}, 10:11:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:11:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:11:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:11:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:11:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:11:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:11:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:41 INFO - 'talos_options': ['--disable-e10s'], 10:11:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:41 INFO - 'talos_options': ['--disable-e10s'], 10:11:41 INFO - 'tests': ['damp', 'tps']}, 10:11:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:41 INFO - 'tests': ['damp', 'tps']}, 10:11:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:11:41 INFO - 'tests': ['dromaeo_dom']}, 10:11:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:11:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:11:41 INFO - 'tests': ['a11yr', 10:11:41 INFO - 'ts_paint', 10:11:41 INFO - 'tpaint', 10:11:41 INFO - 'sessionrestore', 10:11:41 INFO - 'sessionrestore_no_auto_restore', 10:11:41 INFO - 'tabpaint']}, 10:11:41 INFO - 'other-e10s': {'tests': ['a11yr', 10:11:41 INFO - 'ts_paint', 10:11:41 INFO - 'tpaint', 10:11:41 INFO - 'sessionrestore', 10:11:41 INFO - 'sessionrestore_no_auto_restore', 10:11:41 INFO - 'tabpaint']}, 10:11:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:11:41 INFO - 'ts_paint', 10:11:41 INFO - 'tpaint', 10:11:41 INFO - 'sessionrestore', 10:11:41 INFO - 'sessionrestore_no_auto_restore', 10:11:41 INFO - 'tabpaint']}, 10:11:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:11:41 INFO - 'ts_paint', 10:11:41 INFO - 'tpaint', 10:11:41 INFO - 'sessionrestore', 10:11:41 INFO - 'sessionrestore_no_auto_restore', 10:11:41 INFO - 'tabpaint']}, 10:11:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:11:41 INFO - 'tests': ['a11yr', 10:11:41 INFO - 'ts_paint', 10:11:41 INFO - 'tpaint', 10:11:41 INFO - 'sessionrestore', 10:11:41 INFO - 'sessionrestore_no_auto_restore', 10:11:41 INFO - 'tabpaint']}, 10:11:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:11:41 INFO - 'tests': ['a11yr', 10:11:41 INFO - 'ts_paint', 10:11:41 INFO - 'tpaint', 10:11:41 INFO - 'sessionrestore', 10:11:41 INFO - 'sessionrestore_no_auto_restore', 10:11:41 INFO - 'tabpaint']}, 10:11:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:11:41 INFO - 'tests': ['tsvgx', 10:11:41 INFO - 'tsvgr_opacity', 10:11:41 INFO - 'tart', 10:11:41 INFO - 'tscrollx', 10:11:41 INFO - 'cart']}, 10:11:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:11:41 INFO - 'tsvgr_opacity', 10:11:41 INFO - 'tart', 10:11:41 INFO - 'tscrollx', 10:11:41 INFO - 'cart']}, 10:11:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:41 INFO - 'talos_options': ['--disable-e10s'], 10:11:41 INFO - 'tests': ['tp5o']}, 10:11:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:41 INFO - 'tests': ['tp5o']}, 10:11:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:41 INFO - 'talos_options': ['--disable-e10s', 10:11:41 INFO - '--xperf_path', 10:11:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:41 INFO - 'tests': ['tp5n']}, 10:11:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:41 INFO - 'talos_options': ['--xperf_path', 10:11:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:41 INFO - 'tests': ['tp5n']}}, 10:11:41 INFO - 'talos.zip': {'path': '', 10:11:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:11:41 INFO - Running post-action listener: _resource_record_post_action 10:11:41 INFO - ##### 10:11:41 INFO - ##### Running create-virtualenv step. 10:11:41 INFO - ##### 10:11:41 INFO - Running pre-action listener: _resource_record_pre_action 10:11:41 INFO - Running main action method: create_virtualenv 10:11:41 INFO - Creating virtualenv /builds/slave/test/build/venv 10:11:41 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 10:11:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:11:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:11:41 INFO - Using real prefix '/usr' 10:11:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:11:42 INFO - Installing distribute.............................................................................................................................................................................................done. 10:11:44 INFO - Installing pip.................done. 10:11:44 INFO - Return code: 0 10:11:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:11:44 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')]} 10:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:44 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')]} 10:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:44 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 0x7f5ed4f08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d410>, '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 0x106e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', '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 10:11:44 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 10:11:44 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 10:11:44 INFO - Using env: {'DISPLAY': ':0', 10:11:44 INFO - 'HOME': '/home/cltbld', 10:11:44 INFO - 'LANG': 'en_US.UTF-8', 10:11:44 INFO - 'LANGUAGE': 'en_US:en', 10:11:44 INFO - 'LOGNAME': 'cltbld', 10:11:44 INFO - 'MAIL': '/var/mail/cltbld', 10:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:44 INFO - 'MOZ_NO_REMOTE': '1', 10:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:44 INFO - 'NO_EM_RESTART': '1', 10:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:44 INFO - 'PWD': '/builds/slave/test', 10:11:44 INFO - 'SHELL': '/bin/bash', 10:11:44 INFO - 'SHLVL': '1', 10:11:44 INFO - 'TERM': 'linux', 10:11:44 INFO - 'TMOUT': '86400', 10:11:44 INFO - 'USER': 'cltbld', 10:11:44 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', 10:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:44 INFO - '_': '/tools/buildbot/bin/python'} 10:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:44 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 10:11:44 INFO - Cleaning up... 10:11:44 INFO - Return code: 0 10:11:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:11:44 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')]} 10:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:44 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')]} 10:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:44 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 0x7f5ed4f08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d410>, '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 0x106e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', '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 10:11:44 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 10:11:44 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 10:11:44 INFO - Using env: {'DISPLAY': ':0', 10:11:44 INFO - 'HOME': '/home/cltbld', 10:11:44 INFO - 'LANG': 'en_US.UTF-8', 10:11:44 INFO - 'LANGUAGE': 'en_US:en', 10:11:44 INFO - 'LOGNAME': 'cltbld', 10:11:44 INFO - 'MAIL': '/var/mail/cltbld', 10:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:44 INFO - 'MOZ_NO_REMOTE': '1', 10:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:44 INFO - 'NO_EM_RESTART': '1', 10:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:44 INFO - 'PWD': '/builds/slave/test', 10:11:44 INFO - 'SHELL': '/bin/bash', 10:11:44 INFO - 'SHLVL': '1', 10:11:44 INFO - 'TERM': 'linux', 10:11:44 INFO - 'TMOUT': '86400', 10:11:44 INFO - 'USER': 'cltbld', 10:11:44 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', 10:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:44 INFO - '_': '/tools/buildbot/bin/python'} 10:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:44 INFO - Downloading/unpacking psutil>=0.7.1 10:11:44 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 10:11:44 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 10:11:44 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 10:11:44 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 10:11:44 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 10:11:44 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 10:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:11:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:46 INFO - Installing collected packages: psutil 10:11:46 INFO - Running setup.py install for psutil 10:11:46 INFO - building 'psutil._psutil_linux' extension 10:11:46 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 10:11:46 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 10:11:46 INFO - building 'psutil._psutil_posix' extension 10:11:46 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 10:11:46 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 10:11:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:46 INFO - Successfully installed psutil 10:11:46 INFO - Cleaning up... 10:11:47 INFO - Return code: 0 10:11:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:11: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')]} 10:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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')]} 10:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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', '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 0x7f5ed4f08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d410>, '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 0x106e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', '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 10:11: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:11: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 mozsystemmonitor==0.0.0 10:11:47 INFO - Using env: {'DISPLAY': ':0', 10:11:47 INFO - 'HOME': '/home/cltbld', 10:11:47 INFO - 'LANG': 'en_US.UTF-8', 10:11:47 INFO - 'LANGUAGE': 'en_US:en', 10:11:47 INFO - 'LOGNAME': 'cltbld', 10:11:47 INFO - 'MAIL': '/var/mail/cltbld', 10:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:47 INFO - 'MOZ_NO_REMOTE': '1', 10:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:47 INFO - 'NO_EM_RESTART': '1', 10:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:47 INFO - 'PWD': '/builds/slave/test', 10:11:47 INFO - 'SHELL': '/bin/bash', 10:11:47 INFO - 'SHLVL': '1', 10:11:47 INFO - 'TERM': 'linux', 10:11:47 INFO - 'TMOUT': '86400', 10:11:47 INFO - 'USER': 'cltbld', 10:11:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', 10:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:47 INFO - '_': '/tools/buildbot/bin/python'} 10:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:11:49 INFO - Installing collected packages: mozsystemmonitor 10:11:49 INFO - Running setup.py install for mozsystemmonitor 10:11:49 INFO - Successfully installed mozsystemmonitor 10:11:49 INFO - Cleaning up... 10:11:49 INFO - Return code: 0 10:11:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:11:49 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')]} 10:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:49 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')]} 10:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:49 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 0x7f5ed4f08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d410>, '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 0x106e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', '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 10:11:49 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 10:11:49 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 10:11:49 INFO - Using env: {'DISPLAY': ':0', 10:11:49 INFO - 'HOME': '/home/cltbld', 10:11:49 INFO - 'LANG': 'en_US.UTF-8', 10:11:49 INFO - 'LANGUAGE': 'en_US:en', 10:11:49 INFO - 'LOGNAME': 'cltbld', 10:11:49 INFO - 'MAIL': '/var/mail/cltbld', 10:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:49 INFO - 'MOZ_NO_REMOTE': '1', 10:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:49 INFO - 'NO_EM_RESTART': '1', 10:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:49 INFO - 'PWD': '/builds/slave/test', 10:11:49 INFO - 'SHELL': '/bin/bash', 10:11:49 INFO - 'SHLVL': '1', 10:11:49 INFO - 'TERM': 'linux', 10:11:49 INFO - 'TMOUT': '86400', 10:11:49 INFO - 'USER': 'cltbld', 10:11:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', 10:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:49 INFO - '_': '/tools/buildbot/bin/python'} 10:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:49 INFO - Downloading/unpacking blobuploader==1.2.4 10:11:49 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 10:11:49 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 10:11:49 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 10:11:49 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 10:11:49 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 10:11:49 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 10:11:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:11:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:11:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:52 INFO - Downloading docopt-0.6.1.tar.gz 10:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:11:52 INFO - Installing collected packages: blobuploader, requests, docopt 10:11:52 INFO - Running setup.py install for blobuploader 10:11:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:11:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:11:52 INFO - Running setup.py install for requests 10:11:52 INFO - Running setup.py install for docopt 10:11:52 INFO - Successfully installed blobuploader requests docopt 10:11:52 INFO - Cleaning up... 10:11:52 INFO - Return code: 0 10:11:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11: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')]} 10:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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')]} 10:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:52 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 0x7f5ed4f08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d410>, '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 0x106e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', '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 10:11:52 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 10:11:52 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 10:11:52 INFO - Using env: {'DISPLAY': ':0', 10:11:52 INFO - 'HOME': '/home/cltbld', 10:11:52 INFO - 'LANG': 'en_US.UTF-8', 10:11:52 INFO - 'LANGUAGE': 'en_US:en', 10:11:52 INFO - 'LOGNAME': 'cltbld', 10:11:52 INFO - 'MAIL': '/var/mail/cltbld', 10:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:52 INFO - 'MOZ_NO_REMOTE': '1', 10:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:52 INFO - 'NO_EM_RESTART': '1', 10:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:52 INFO - 'PWD': '/builds/slave/test', 10:11:52 INFO - 'SHELL': '/bin/bash', 10:11:52 INFO - 'SHLVL': '1', 10:11:52 INFO - 'TERM': 'linux', 10:11:52 INFO - 'TMOUT': '86400', 10:11:52 INFO - 'USER': 'cltbld', 10:11:52 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', 10:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:52 INFO - '_': '/tools/buildbot/bin/python'} 10:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:11:53 INFO - Running setup.py (path:/tmp/pip-UGRm6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:11:53 INFO - Running setup.py (path:/tmp/pip-F3MJuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:11:53 INFO - Running setup.py (path:/tmp/pip-tN8miy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:11:53 INFO - Running setup.py (path:/tmp/pip-KrlqCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:11:53 INFO - Running setup.py (path:/tmp/pip-q_dzf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:11:53 INFO - Running setup.py (path:/tmp/pip-w_xBN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:11:53 INFO - Running setup.py (path:/tmp/pip-Bg3DAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:11:53 INFO - Running setup.py (path:/tmp/pip-8_qUAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:11:53 INFO - Running setup.py (path:/tmp/pip-DdquTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:11:53 INFO - Running setup.py (path:/tmp/pip-FPAyBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:11:53 INFO - Running setup.py (path:/tmp/pip-29Kqfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:11:53 INFO - Running setup.py (path:/tmp/pip-JLn1O7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:11:53 INFO - Running setup.py (path:/tmp/pip-H46kSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:11:53 INFO - Running setup.py (path:/tmp/pip-w8EKm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:54 INFO - Running setup.py (path:/tmp/pip-CquvpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:11:54 INFO - Running setup.py (path:/tmp/pip-PlEAsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:11:54 INFO - Running setup.py (path:/tmp/pip-EvE27w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:11:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:11:54 INFO - Running setup.py install for manifestparser 10:11:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:11:54 INFO - Running setup.py install for mozcrash 10:11:54 INFO - Running setup.py install for mozdebug 10:11:54 INFO - Running setup.py install for mozdevice 10:11:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:11:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:11:54 INFO - Running setup.py install for mozfile 10:11:54 INFO - Running setup.py install for mozhttpd 10:11:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:11:54 INFO - Running setup.py install for mozinfo 10:11:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozInstall 10:11:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozleak 10:11:55 INFO - Running setup.py install for mozlog 10:11:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for moznetwork 10:11:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozprocess 10:11:55 INFO - Running setup.py install for mozprofile 10:11:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozrunner 10:11:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozscreenshot 10:11:55 INFO - Running setup.py install for moztest 10:11:55 INFO - Running setup.py install for mozversion 10:11:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:11:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:11:56 INFO - Cleaning up... 10:11:56 INFO - Return code: 0 10:11:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:56 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')]} 10:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:56 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')]} 10:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:56 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 0x7f5ed4f08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d410>, '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 0x106e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', '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 10:11:56 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 10:11:56 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 10:11:56 INFO - Using env: {'DISPLAY': ':0', 10:11:56 INFO - 'HOME': '/home/cltbld', 10:11:56 INFO - 'LANG': 'en_US.UTF-8', 10:11:56 INFO - 'LANGUAGE': 'en_US:en', 10:11:56 INFO - 'LOGNAME': 'cltbld', 10:11:56 INFO - 'MAIL': '/var/mail/cltbld', 10:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:56 INFO - 'MOZ_NO_REMOTE': '1', 10:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:56 INFO - 'NO_EM_RESTART': '1', 10:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:56 INFO - 'PWD': '/builds/slave/test', 10:11:56 INFO - 'SHELL': '/bin/bash', 10:11:56 INFO - 'SHLVL': '1', 10:11:56 INFO - 'TERM': 'linux', 10:11:56 INFO - 'TMOUT': '86400', 10:11:56 INFO - 'USER': 'cltbld', 10:11:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', 10:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:56 INFO - '_': '/tools/buildbot/bin/python'} 10:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:11:56 INFO - Running setup.py (path:/tmp/pip-y98NuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:11:56 INFO - Running setup.py (path:/tmp/pip-vhXKdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:11:56 INFO - Running setup.py (path:/tmp/pip-yIaPow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:11:56 INFO - Running setup.py (path:/tmp/pip-RNRHam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:11:56 INFO - Running setup.py (path:/tmp/pip-sfeZA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:11:56 INFO - Running setup.py (path:/tmp/pip-J1RUXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:11:56 INFO - Running setup.py (path:/tmp/pip-c_E57K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:11:56 INFO - Running setup.py (path:/tmp/pip-jwwgOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:11:56 INFO - Running setup.py (path:/tmp/pip-Oy6Wqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:11:56 INFO - Running setup.py (path:/tmp/pip-CF1O1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:11:57 INFO - Running setup.py (path:/tmp/pip-baPWI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:11:57 INFO - Running setup.py (path:/tmp/pip-oqJwD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:11:57 INFO - Running setup.py (path:/tmp/pip-5ntVgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:11:57 INFO - Running setup.py (path:/tmp/pip-ubQLBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:57 INFO - Running setup.py (path:/tmp/pip-siKY82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:11:57 INFO - Running setup.py (path:/tmp/pip-cWlCyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:11:57 INFO - Running setup.py (path:/tmp/pip-DaqpZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:11:57 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)) 10:11:57 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)) 10:11:57 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)) 10:11:57 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)) 10:11:57 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)) 10:11:57 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)) 10:11:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:11:57 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 10:11:57 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 10:11:57 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 10:11:57 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 10:11:57 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 10:11:57 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 10:11:59 INFO - Downloading blessings-1.6.tar.gz 10:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:11:59 INFO - Installing collected packages: blessings 10:11:59 INFO - Running setup.py install for blessings 10:11:59 INFO - Successfully installed blessings 10:11:59 INFO - Cleaning up... 10:11:59 INFO - Return code: 0 10:11:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:11:59 INFO - Reading from file tmpfile_stdout 10:11:59 INFO - Current package versions: 10:11:59 INFO - argparse == 1.2.1 10:11:59 INFO - blessings == 1.6 10:11:59 INFO - blobuploader == 1.2.4 10:11:59 INFO - docopt == 0.6.1 10:11:59 INFO - manifestparser == 1.1 10:11:59 INFO - mozInstall == 1.12 10:11:59 INFO - mozcrash == 0.17 10:11:59 INFO - mozdebug == 0.1 10:11:59 INFO - mozdevice == 0.48 10:11:59 INFO - mozfile == 1.2 10:11:59 INFO - mozhttpd == 0.7 10:11:59 INFO - mozinfo == 0.9 10:11:59 INFO - mozleak == 0.1 10:11:59 INFO - mozlog == 3.1 10:11:59 INFO - moznetwork == 0.27 10:11:59 INFO - mozprocess == 0.22 10:11:59 INFO - mozprofile == 0.28 10:11:59 INFO - mozrunner == 6.11 10:11:59 INFO - mozscreenshot == 0.1 10:11:59 INFO - mozsystemmonitor == 0.0 10:11:59 INFO - moztest == 0.7 10:11:59 INFO - mozversion == 1.4 10:11:59 INFO - psutil == 3.1.1 10:11:59 INFO - requests == 1.2.3 10:11:59 INFO - wsgiref == 0.1.2 10:11:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:59 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 0x7f5ed4f08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d410>, '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 0x106e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', '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 10:11:59 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 10:11:59 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 10:11:59 INFO - Using env: {'DISPLAY': ':0', 10:11:59 INFO - 'HOME': '/home/cltbld', 10:11:59 INFO - 'LANG': 'en_US.UTF-8', 10:11:59 INFO - 'LANGUAGE': 'en_US:en', 10:11:59 INFO - 'LOGNAME': 'cltbld', 10:11:59 INFO - 'MAIL': '/var/mail/cltbld', 10:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:59 INFO - 'MOZ_NO_REMOTE': '1', 10:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:59 INFO - 'NO_EM_RESTART': '1', 10:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:59 INFO - 'PWD': '/builds/slave/test', 10:11:59 INFO - 'SHELL': '/bin/bash', 10:11:59 INFO - 'SHLVL': '1', 10:11:59 INFO - 'TERM': 'linux', 10:11:59 INFO - 'TMOUT': '86400', 10:11:59 INFO - 'USER': 'cltbld', 10:11:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', 10:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:59 INFO - '_': '/tools/buildbot/bin/python'} 10:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 INFO - Cleaning up... 10:12:00 INFO - Return code: 0 10:12:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ed4f08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d410>, '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 0x106e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', '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 10:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:12:00 INFO - Using env: {'DISPLAY': ':0', 10:12:00 INFO - 'HOME': '/home/cltbld', 10:12:00 INFO - 'LANG': 'en_US.UTF-8', 10:12:00 INFO - 'LANGUAGE': 'en_US:en', 10:12:00 INFO - 'LOGNAME': 'cltbld', 10:12:00 INFO - 'MAIL': '/var/mail/cltbld', 10:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:00 INFO - 'MOZ_NO_REMOTE': '1', 10:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:00 INFO - 'NO_EM_RESTART': '1', 10:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:00 INFO - 'PWD': '/builds/slave/test', 10:12:00 INFO - 'SHELL': '/bin/bash', 10:12:00 INFO - 'SHLVL': '1', 10:12:00 INFO - 'TERM': 'linux', 10:12:00 INFO - 'TMOUT': '86400', 10:12:00 INFO - 'USER': 'cltbld', 10:12:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', 10:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:00 INFO - '_': '/tools/buildbot/bin/python'} 10:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:00 INFO - Downloading/unpacking jsonschema 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:12:02 INFO - Downloading/unpacking functools32 (from jsonschema) 10:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:02 INFO - Downloading functools32-3.2.3-2.tar.gz 10:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:12:02 INFO - warning: no files found matching '*.txt' 10:12:02 INFO - no previously-included directories found matching 'build' 10:12:02 INFO - no previously-included directories found matching 'dist' 10:12:02 INFO - no previously-included directories found matching '.git*' 10:12:02 INFO - Installing collected packages: jsonschema, functools32 10:12:02 INFO - Running setup.py install for functools32 10:12:02 INFO - warning: no files found matching '*.txt' 10:12:02 INFO - no previously-included directories found matching 'build' 10:12:02 INFO - no previously-included directories found matching 'dist' 10:12:02 INFO - no previously-included directories found matching '.git*' 10:12:02 INFO - Successfully installed jsonschema functools32 10:12:02 INFO - Cleaning up... 10:12:02 INFO - Return code: 0 10:12:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ed4f08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d410>, '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 0x106e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', '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 10:12: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', 'flake8'] in /builds/slave/test/build 10:12: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 flake8 10:12:02 INFO - Using env: {'DISPLAY': ':0', 10:12:02 INFO - 'HOME': '/home/cltbld', 10:12:02 INFO - 'LANG': 'en_US.UTF-8', 10:12:02 INFO - 'LANGUAGE': 'en_US:en', 10:12:02 INFO - 'LOGNAME': 'cltbld', 10:12:02 INFO - 'MAIL': '/var/mail/cltbld', 10:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:02 INFO - 'MOZ_NO_REMOTE': '1', 10:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:02 INFO - 'NO_EM_RESTART': '1', 10:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:02 INFO - 'PWD': '/builds/slave/test', 10:12:02 INFO - 'SHELL': '/bin/bash', 10:12:02 INFO - 'SHLVL': '1', 10:12:02 INFO - 'TERM': 'linux', 10:12:02 INFO - 'TMOUT': '86400', 10:12:02 INFO - 'USER': 'cltbld', 10:12:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', 10:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:02 INFO - '_': '/tools/buildbot/bin/python'} 10:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:02 INFO - Downloading/unpacking flake8 10:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:12:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:12:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 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 10:12:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:12:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:05 INFO - no previously-included directories found matching 'docs/_build' 10:12:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:12:05 INFO - Running setup.py install for pep8 10:12:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:05 INFO - no previously-included directories found matching 'docs/_build' 10:12:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:12:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:12:05 INFO - Cleaning up... 10:12:05 INFO - Return code: 0 10:12:05 INFO - Running post-action listener: _resource_record_post_action 10:12:05 INFO - Running post-action listener: _start_resource_monitoring 10:12:05 INFO - Starting resource monitoring. 10:12:05 INFO - ##### 10:12:05 INFO - ##### Running install step. 10:12:05 INFO - ##### 10:12:05 INFO - Running pre-action listener: _resource_record_pre_action 10:12:05 INFO - Running main action method: install 10:12:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:05 INFO - Reading from file tmpfile_stdout 10:12:05 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:06 INFO - Reading from file tmpfile_stdout 10:12:06 INFO - Output received: 10:12:06 INFO - Usage: mozinstall [options] installer 10:12:06 INFO - Options: 10:12:06 INFO - -h, --help show this help message and exit 10:12:06 INFO - -d DEST, --destination=DEST 10:12:06 INFO - Directory to install application into. [default: 10:12:06 INFO - "/builds/slave/test"] 10:12:06 INFO - --app=APP Application being installed. [default: firefox] 10:12:06 INFO - mkdir: /builds/slave/test/build/application 10:12:06 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'] 10:12:06 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 10:12:21 INFO - Reading from file tmpfile_stdout 10:12:21 INFO - Output received: 10:12:21 INFO - /builds/slave/test/build/application/firefox/firefox 10:12:21 INFO - Running post-action listener: _resource_record_post_action 10:12:21 INFO - ##### 10:12:21 INFO - ##### Running run-tests step. 10:12:21 INFO - ##### 10:12:21 INFO - Running pre-action listener: _resource_record_pre_action 10:12:21 INFO - Running main action method: run_tests 10:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:12:21 INFO - Python 2.7.3 10:12:21 INFO - Return code: 0 10:12:21 INFO - grabbing minidump binary from tooltool 10:12:22 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')]} 10:12:22 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 0x106d410>, '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 0x106e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:12:22 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 10:12:22 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 10:12:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:12:22 INFO - Return code: 0 10:12:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:12:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:12:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:12:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:12:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:12:22 INFO - Return code: 0 10:12:22 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/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 10:12:22 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/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 10:12:22 INFO - Using env: {'DISPLAY': ':0', 10:12:22 INFO - 'HOME': '/home/cltbld', 10:12:22 INFO - 'LANG': 'en_US.UTF-8', 10:12:22 INFO - 'LANGUAGE': 'en_US:en', 10:12:22 INFO - 'LOGNAME': 'cltbld', 10:12:22 INFO - 'MAIL': '/var/mail/cltbld', 10:12:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:12:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:23 INFO - 'MOZ_NO_REMOTE': '1', 10:12:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:23 INFO - 'NO_EM_RESTART': '1', 10:12:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:23 INFO - 'PWD': '/builds/slave/test', 10:12:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:12:23 INFO - 'SHELL': '/bin/bash', 10:12:23 INFO - 'SHLVL': '1', 10:12:23 INFO - 'TERM': 'linux', 10:12:23 INFO - 'TMOUT': '86400', 10:12:23 INFO - 'USER': 'cltbld', 10:12:23 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936', 10:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:23 INFO - '_': '/tools/buildbot/bin/python'} 10:12:23 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/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 10:12:23 INFO - mozversion application_buildid: 20160511072717 10:12:23 INFO - mozversion application_changeset: 6485fbf9000cadac47e1c50eabf51f7fa6b37dfc 10:12:23 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:12:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:12:23 INFO - mozversion application_name: Firefox 10:12:23 INFO - mozversion application_remotingname: firefox-dev 10:12:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:12:23 INFO - mozversion application_vendor: Mozilla 10:12:23 INFO - mozversion application_version: 48.0a2 10:12:23 INFO - mozversion platform_buildid: 20160511072717 10:12:23 INFO - mozversion platform_changeset: 6485fbf9000cadac47e1c50eabf51f7fa6b37dfc 10:12:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:12:23 INFO - mozversion platform_version: 48.0a2 10:12:23 INFO - using testdate: 1462986743 10:12:23 INFO - actual date: 1462986743 10:12:23 INFO - starting webserver on 'localhost:48962' 10:12:23 INFO - SUITE-START | Running 2 tests 10:12:23 INFO - TEST-START | dromaeo_css 10:12:23 INFO - operating with platform_type : linux_ 10:12:23 INFO - Initialising browser for dromaeo_css test... 10:12:23 INFO - TEST-INFO | started process 18918 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzdFyTp/profile http://localhost:48962/getInfo.html) 10:12:27 INFO - PROCESS | 18918 | __metrics Screen width/height:1600/1200 10:12:27 INFO - PROCESS | 18918 | colorDepth:24 10:12:27 INFO - PROCESS | 18918 | Browser inner width/height: 1024/697 10:12:27 INFO - PROCESS | 18918 | __metrics 10:12:29 ERROR - PROCESS | 18918 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:12:29 INFO - TEST-INFO | 18918: exit 0 10:12:29 INFO - Browser initialized. 10:12:29 INFO - Running cycle 1/1 for dromaeo_css test... 10:12:29 INFO - TEST-INFO | started process 19010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzdFyTp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:41 INFO - PROCESS | 19010 | RSS: Main: 142016512 10:12:41 INFO - PROCESS | 19010 | 10:13:32 INFO - PROCESS | 19010 | 1462986812736 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] 10:15:40 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:48962/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48962/tests/dromaeo/cssquery-ext.html) 10:15:41 INFO - PROCESS | 19010 | RSS: Main: 249860096 10:15:41 INFO - PROCESS | 19010 | 10:18:43 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:48962/tests/dromaeo/cssquery-ext.html (next: http://localhost:48962/tests/dromaeo/cssquery-jquery.html) 10:18:44 INFO - PROCESS | 19010 | RSS: Main: 222191616 10:18:44 INFO - PROCESS | 19010 | 10:21:46 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:48962/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48962/tests/dromaeo/cssquery-mootools.html) 10:21:46 INFO - PROCESS | 19010 | RSS: Main: 224403456 10:21:46 INFO - PROCESS | 19010 | 10:24:48 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:48962/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48962/tests/dromaeo/cssquery-prototype.html) 10:24:49 INFO - PROCESS | 19010 | RSS: Main: 218443776 10:24:49 INFO - PROCESS | 19010 | 10:27:51 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:48962/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48962/tests/dromaeo/cssquery-yui.html) 10:27:52 INFO - PROCESS | 19010 | RSS: Main: 213032960 10:27:52 INFO - PROCESS | 19010 | 10:30:54 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:48962/tests/dromaeo/cssquery-yui.html (next: http://localhost:48962/tests/dromaeo/cssquery-dojo.html) 10:30:55 INFO - PROCESS | 19010 | RSS: Main: 252555264 10:30:55 INFO - PROCESS | 19010 | 10:30:55 INFO - PROCESS | 19010 | __start_tp_report 10:30:55 INFO - PROCESS | 19010 | _x_x_mozilla_page_load 10:30:55 INFO - PROCESS | 19010 | _x_x_mozilla_page_load_details 10:30:55 INFO - PROCESS | 19010 | |i|pagename|runs| 10:30:55 INFO - PROCESS | 19010 | |0;dojo.html;3255.8046517208963;3331.550240717502;3366.9326613467733;3385.3737058644138;3408.863645454182;5416.970775552647;5441.5102640762325;5458.263134476844;5471.015217260897;5483.287172667548;5434.619576629638;5496.258005169301;5508.338999320087;5514.862128446791;5537.723113844312;4852.733099679516;4928.359313289267;5008.874778130539;5028.572571331441;5108.4636113208135;4913.950860491403;5007.32401125847;5012.172991456424;5013.573846223076;5018.071656743496;4947.8268260610885;4991.026749783794;4998.875028124289;5004.9749751251375;5005.774740136702;4937.432195297551;4962.851114466572;4980.950190498121;4982.252662100677;5011.799528018875;4781.450133234688;4874.220124780054;4906.067847109038;4923.975380123113;4952.034353301107;5337.546308563777;5372.516473517363;5391.29913111293;5394.487523685244;5398.325209348832;5777.451142141532;5850.941490585083;5859.003969325182;5860.179574859523;5865.85335366615;5853.678047707374;5869.50109240715;5886.293644762613;5945.16767652529;5949.25634295713;5481.5340696040885;5488.231647569343;5527.474889885495;5531.695756733378;5532.640378375393;5642.774289028393;5987.13186587951;5991.940080599225;6006.4594186522545;6009.789657361971;5636.323641163087;5681.57388195887;5696;5715.885682286331;5737.8565535861935;5701.71491425427;5707.800226992035;5720.427957204246;5732.742026608729;5735.541156707453;5570.470805273492;5692.459216374438;5702.429757024347;5702.54379649627;5826.941730582725;5787.5080618147085;5798.739056742373;5814.941850581525;5819.301683797971;5860.501857342088;4463.263561512379;4483.574060464251;4488.775561221991;4494.842680506166;4510.255807791677;3963.980180099081;3990.86031988879;4010.21800748857;4053.5541090480024;4054.533728621246;5505.834824955257;5525.557955363642;5539;5544.972275138599;5562.666240025612;5787.739551720183;5791.507721843606;5795.594308398456;5799.82600521985;5804.361520232771;5431.5926305526455;5502.724863756796;5539.612227144061;5545.1682247663175;5630.18362337467;5017.071841709296;5026.949730502722;5031.245313202976;5036.194208926554;5041.143005689041;6127.601705889103;6149.7847575334645;6167.814965551041;6183.474404675563;6193.102000209944;5694.629849059964;5874.324452687995;5893.705314734246;5953.017752070859;5953.7023148843255;5991.850203744942;6003.549733769897;6004;6009.36901625323;6014.699265036818;5650.943490565206;5652.88694226105;5653;5653.85865353353;5669.518090962314;5760.740766665426;5854.736536855767;5909.645421274738;5929.703514824328;5938.138969849261;5575.0522411191005;5597.972010139923;5602.691851948182;5603.719814009365;5606.719664016864;5530.91703624454;5575.358833734011;5584.050711379156;5597.44025597437;5603.831885043455;5625.381208067191;5656.095024796013;5685.630434021776;5686.829395118153;5711.7429715662065;5718.313802343579;5719.399463056486;5751.252337196138;5754.56840736938;5757.395473475225;5457.69982650958;5630.493255607015;5631.324241091095;5635.380108188014;5645.943540564542 10:30:55 INFO - PROCESS | 19010 | |1;ext.html;658.1772784019975;665.4676258992805;674.7941877727293;730.4156674660267;738.8780851159557;32707.67292327079;33641.32717345655;40501;41143;41225.38161927574;43893.341599876025;44663;44670.32994505077;44688;44707.55292447074;7972.481788683746;8700.26047785939;8887.377883548153;8902.376833621649;10284.280100392976;10329.225308101884;10507.422091784949;10508.369497830156;10518.684439466828;10525.894741052607;10545.68362949109;10605.893941060607;10609.946950265277;10614.257002009863;10630.255882088257;10474.633387831427;10490.213234007404;10505.107065899409;10533.683989480289;10536.157107431387;10400.635977740743;10467.895321046768;10524.105451036594;10840.945795271053;10855.67432977012;34199.82900085508;44638.553614463766;45064.3240351395;45151.54848451539;45170.774146129384;3841.9231615367817;3855.479510266134;3885.941710874339;3954.387070004154;4063.6952228582677;31621.525677114863;32166.839165804256;32259;32362.514562281583;33988.49017264743;4313.09425020746;4364.738115713068;4382.320740285261;4396.89007774805;4453.487848897385;371660;379281;379288;379505.99999999726;379767;41227.1754564913;62574.37425625685;62901.28240381898;63048.36951630425;63310;41329;41479.37780933289;41583.37624935628;41588.168236635705;41605.375919361235;16574;17511.299548017938;17683.381081662337;17811.73282400765;17813.821861781475;15127.092374457348;15458.227088645523;15466.767998480032;15479.5356139316;15498.147601882005;9568.712938611852;9604.711858644252;9610.855837162448;9660.130588247092;9663.613455461702;3713.9814300928324;3772.1701225730294;3791.981040094837;3799.2401519696173;3824.254270417242;1136.8351589019546;1161.8315344275034;1162.8255761635653;1209.383214560563;1277.9680507987189;33828.66171338255;33934.66065339364;34411.13972150716;34768.30463390718;35929.46105808415;1214.942999590362;1218.129037738004;1240.1504969096197;1322.4049177869997;1345.9461621535029;17167.828321716872;17210.39763608268;17274.740878886827;17337.913310433367;17416.044403625743;460495;462750;463551;463929;464357;61270.38729612736;62350;62365.68817155885;62370.688146558976;62401.37598623956;1380.2684577174114;1432.4198699526708;1443.8050863133553;1540.1913995152634;1638.4511188751662;33335.49996750002;35301.47047794234;35917.46123808093;36947.26105477822;38248.426273605364;59741.701291493264;60521.69739151276;60746.69626651838;60806.69596651988;60808;426660;429299;429319;430162;431847;28916.855415722788;30786;31427.37145257036;31605.5259171108;31648.841755791073;48093.27860082032;48253.276200856315;48744;49530;49841;39444.40833387559;40139.59860401358;40201.79899100603;40352.1929561413;41580.58419415767;39368;40140.99647508719;40188.7990560057;40344.3948340781;40358;41690.79154604208;42170;42323.7883810579;42804.78597606992;43005.56994430016;34359.828200858836;36109.63890361063;36257;36343.273134536634;36590.26819463543;27928;28179;28449.715502845535;28603.14190574286;28677.85661071681 10:30:55 INFO - PROCESS | 19010 | |2;jquery.html;413.1097484919998;413.3345314044389;415.54705371145445;427.68137737385655;428.3702956653719;13813.51652692156;18935.71596426053;19537.316193933217;19538.609227815454;21205.681914771292;15509.457168999088;18387.816121838776;19665.213391464324;20295.797042029575;20588.48528786781;5664.235328230698;5854.18041474194;5859.8535036624;5868.559858010645;5890.499307558841;5896.204012458327;5979.402059794029;5999.640021598696;6004.639721616717;6006.8498287542725;4296.548862369453;4448.666350023745;6196.16351792509;6442.742290308382;6470.644114573696;6195.535334849859;6376.904346434807;6423.197100362478;6428.614283143003;6434.613923164602;5698.458646428624;5760.711964401763;5768.97115514424;5772.855678608026;5774.191613174159;22142.22502212431;22211.001009909025;22661.051162558975;22914.198003069978;22914.770852291596;2617.2802479318148;2666.520026395248;2708.2010806812036;2921.4887394705843;3126.030930411557;13797.724045519033;14467.92766036163;15034.624134396618;15268.694626107415;15481.612959676098;2016.2842191022269;2073.6163809695254;2130.968035479469;2196.8132708719777;2209.0832304593573;77560.61219693921;78640.21359786444;79166;80502.99999999942;81790;10491.527881245362;10880.292780969212;10903.34579925207;11045.171612129123;11125.94437027826;15359.539213823604;15577.14325712074;15585.766213506806;15594.688106237812;15619.219039048003;8151.918480815235;8378.329733621418;8576.957115214384;8845.469271843709;8992;8503.74488765338;8520;8527.465056289804;8548.957255213683;9204.493752843524;4718.693284936468;5108.033516497148;5154.3814742230425;5170.560502357266;5259.552938000313;1947.8052194780691;1988.582397696471;2073.2225415469197;2082.791720827905;2124.7131637228777;1020.7958408318366;1077.2297807067828;1080.3787822002223;1111.822108462642;1118.0943435817014;19200;19263.22947082129;19541.8843604161;19608.607827843363;19992;1045.2735348932572;1051.8579991701022;1061.7120106171176;1073.3720773347522;1095.950682219302;10949.178811589163;11105;11159.38623375722;11180.496877640526;11203.663890083311;459907;471650;487924;489125;491524;94937.52531237438;100817.49591252144;100843;101133;101745;1078.347599702169;1083.766990097117;1089.5478376473834;1106.5629076514892;1106.9557217711201;17293.74059389085;17663.470095897144;17695.823041769418;17748.556286092433;17993.370232041816;41349.586504134575;41493.585064148974;41820.16359672729;41830.79084604557;41843.372349414174;59413.40586594251;61399.69300153471;61913;62190;62352;9116.680916167903;9287.210587100171;12501.749965000467;13253.403596838358;13704.931475342559;10132.898671013196;12744.4265008073;14060.718785624435;14070.577882663536;14662.193579353238;12474.376281185723;12612.621621351374;12685.619431417072;12772.744545109232;13281.203127812361;12506.93746531298;12508.732360631655;12567.937160314506;12663;13001.15492492985;12909.096363254857;13031.674208144872;13121.409536571067;13677.179369237878;13827.654308642364;13410.597682069554;13499.392527336096;13510.392032358372;13630.568790276879;13651.931740341235;12965.870341296844;12985.220886746825;13013.089083764045;13190.274534900289;13344.199348039148 10:30:55 INFO - PROCESS | 19010 | |3;mootools.html;1435.3397437178896;1498.2284123676309;1509.667873067925;1723.6121872578672;1903.7905830358666;8420.873686894694;8602.956985215082;8608.268297194738;8623.22390984812;8639.611217495212;8135.633896474658;8290.461120027208;8298.377621678383;8302.54336011519;8308.459950103239;2150.3763908466526;2343.0510643189536;2370.395549134968;2408.590539608271;2486.589712697403;2416.5770990076753;2477.4797292568583;2485.825992180548;2487.5398051360557;2488.2410864686262;2407.4944261704977;2434.0628857889665;2434.720007199177;2435.7807797298237;2440;2174.402039439151;2321.8374713770045;2375.964360534593;2376.821738369612;2386.0098059305456;2237.1387015998794;2267.489814791675;2325.6627788970673;2330.0912644068826;2330.883455827202;8580.485170889704;8608.784780380478;8622.482651040958;8623.13768623139;8631.956840215758;5446.836594902159;5518;5566.860828479321;5568.359638641527;5609.158626206061;3489.476578513218;3556.8399422025814;3583.2654305867236;3615.837287322077;3622.855085796565;1054.978900421995;1063.4842101580728;1080.1358912869673;1103.1615971861363;1182.4915286426833;12592.307423091726;12625.431855566521;12634.431450584745;12653.367331633473;12667.619971400873;4718.103560323528;4740.14677358072;4810.903781924412;4825.276208568743;4856.611471082305;10701.09040731531;10706.036456718934;10708.30396024256;10713.678589642323;10714.41070741101;4893.657443978887;5519.503244707916;5547.084731019418;5549.861253468695;5550.944490555124;4810.6632535722165;4826.493218212107;4832;4884.096442158212;4899.5590396863745;4177.143685544456;4188.727732697365;4202.936955945664;4258.488981322261;4259.680523960716;1329.6609364611961;1346.0846624295573;1353.5668586052368;1355.830521184852;1373.0937581196363;937.6202637931649;1000.7748256642197;1005.1707341443339;1068.8289873620183;1076.7954088723275;5851.61964472308;5897.469227769521;5970.85072873173;6141.877162456726;6169.629822210592;941.1858742188095;992.0674565908023;1041.2971244409994;1046.9738256543494;1063.7819247054335;3877.418387241936;4022.7586344819406;4023.839046438168;4038.919221615551;4076.8776936691947;10502.369857808402;10934.726631834268;10975.780484390267;10985.61550345734;10991.285566438157;10970.341779493256;11112.16658750597;11122.777544449065;11124.110071194285;11131.888681113085;7826.178251283533;8015.919840801634;8128.796780080427;8140.715074972348;8153.47002444851;5843.707814609167;6061.515078793774;6115.816525504242;6118.20463339763;6178;9425.05749425052;9574.617015319309;9629.903700963181;9641.469719165232;9888.406695598287;9769.951150244204;9783.168430683472;9798.363106398061;9965.850512242178;10499.790004200026;7125.3230943060325;7494.5128566643;7742.651580678996;7933.087694915159;8049.154838741848;8428.199321064489;8448.957755211184;8468.195521425454;8486.151384861465;8510.063892971892;7187.2453392393045;7349.30181632744;7374;7457.515261507984;7519.060117485315;7207.459440541876;7252.673629686782;7315.195328513965;7409.8147546311775;7423.257674232534;7137.250588688113;7191.568505889663;7277.090363704537;7343.192248852729;7348;5223.660462069954;5224.085784987688;5288.894222115613;5418.07892658257;5485.807996720096;5308.708021058879;5357.464253574612;5414.756335964812;5415.810446634349;5436.755346009518 10:30:55 INFO - PROCESS | 19010 | |4;prototype.html;350.57755404737287;353.82662495377275;356.25542615932704;357.8228776755508;359.51106495166584;6145.170401995735;6180.75276988921;6191.380861913806;6199.070139479075;6209.813705588828;6083;6171.259448866131;6185.226846644169;6185.752569897199;6189.845253868655;4507.4140361752925;4616.676832621718;4707.105649926503;4710.670253082286;4716.646251531131;4666.929996050062;4697.295405689157;4708.552687494683;4725.763711814396;4726.881827954294;4519.774011299438;4730.787114579852;4732.432108147027;4734.597559207472;4735.3133795599615;4564.79033056237;4653.046125544272;4662.650301227404;4692.178868697998;4738.407699037621;4171.270027745163;4177.4569305990335;4184.079502509443;4190.434291370657;4191.7484950903045;5940.940590594082;5945.197398351211;5946.405359464062;5951.107333899907;5952.553558483131;5509.696966666832;5516.586256030814;5519.254900588449;5521.779128834842;5526.281583394133;6376.681165941684;6482.773102941422;6490.902636460457;6491.448226900719;6507.804765857032;4596.218642830727;4649.325847752091;4649.883752906205;4654.534546545352;4655.441347038377;6650.20197576294;6821.55659882111;6825;6830.897536536956;6837.726490940357;4702.905941881211;4706.1999460091865;4710.69380490267;4715.174844402216;4718.669693121448;4759.785809638505;4762.476127625959;4766.76166191689;4769.046190761862;4773.307870358779;5453.809116680897;5470.288862447936;5471.5896307777075;5484.095124304525;5485.753141108659;6354.968225158845;6532.738690452424;6588.538802283794;6592.241892182365;6593.703283352261;1685.7555654430284;1694.898306101638;1704.8891822031528;1707.39387517432;1708.3764425984425;1061.310148403544;1129.2603344809163;1134.3477500437116;1138.8234823602354;1156.1791128298835;6273.372662733781;6437.903431448532;6457.870842583122;6461.64460954652;6474.320196379406;6779.49153813466;6805.2173999989645;6808.148981377328;6808.931910680929;6819.795406137824;6437.5815571988605;6445.2587952386075;6447.2263328400895;6448.903266451007;6452.838679032968;3615.2769446110883;3640.2901434220603;3653.104989277644;3665.725070619714;3666.834992425347;6880.483963702743;7070.116235470567;7150.7497237596435;7191.496595238283;7206.459515536356;6965.930340696528;6967.79096627102;6972.629306035972;6988.231294557595;6991.685374158175;7166.355028047501;7177;7185.89221161683;7188.640567971581;7193.676284567207;6802.897956530755;6811.761588344582;6814.420774234246;6825.590464572141;6826.488013398915;6559.836004099936;6710.228323742636;6800.115984921928;6807.761728339485;6810.455163586802;7166.426685865223;7179.8564028720175;7184.856302874018;7185.784426467214;7192.676329565287;4578.5650363215445;4610.769461526843;4619.076184762994;4622.4684161321875;4622.491525932078;6731.427828634621;6739.090222820053;6740.292269311848;6755.966220168868;6760.797176084725;6386.712597933197;6588.110605068446;6607;6608.7356505739235;6614.173228346457;6549.901751473827;6561.868762624817;6601.504887133388;6607.07500949877;6650.168728908887;6492.74029038852;6497.8700425992165;6503.2196136462035;6505.934940650533;6507.707153178024;6648.16897887764;6651.16860392451;6654;6655.434288085567;6657.7669781557415;6365.777197798055;6457.61254324742;6475.708593113227;6476.773312934025;6480.513961452815 10:30:55 INFO - PROCESS | 19010 | |5;yui.html;823.9093699693035;835.7576302872168;855.0210009539078;876.6493402638945;894.7494701483582;12946.74106517869;13313.800292995613;13354.7329053419;13376.464941402344;13380.264085475295;13705.725885482309;13723.382447789849;13813.240271785047;13815.1020183688;13829.202203713503;753.6118898767126;888.9777755556098;903.2638399704252;909.3952521573179;909.3997961345514;900.860366643168;905.995470022649;906.8866391701038;908.3550679017873;910.658503061352;779.7933547609888;947.9763005924838;950.9476978766165;951.586060063871;951.7477868364889;791.711025475703;915.7573243090586;936.892257390402;939.9671011514564;940.1444685336311;690.9274526174729;691.025653828105;691.7855464805926;692.2696555134331;692.6155983429195;13555.796663050061;13563.982701297442;13578.321083945762;13619.795703064461;13651.726965460735;14494.42022319106;14646.853531464656;14752.704945901021;14833.258337083103;14929.850701492955;11708.648740537797;12130.090243231705;12275.324857132855;12279.754404911851;12343;3993.101552150772;4033.253848038122;4036.8788936331957;4115.9588404115875;4149.211649786531;50999.235011474855;52039;52075.47924520744;52133.218001730005;53229.46770532284;11182.664520064249;11434.085273178125;11563.826542601868;11770.293782373084;12010.099242556844;21019.68470472944;21121.155153793676;21133.577328453346;21166.47083822886;21176.894115529325;8758.912410875937;8828.602712877935;9075.727728168165;9097.317701172438;9240.168384845396;5046.646734728607;5073.898522029613;5138.30632864566;5146.150885103991;5176.275321454999;3439.724822014233;3480.3735327641266;3482.6169121396624;3487.9651203488147;3490.528778614905;614.1034090228317;614.4347200575481;614.744880874441;615.1080932647678;637.0921436952325;705.4885208224099;723.706898706025;783.4280974888363;817.9836403271901;851.1701091435924;9021.729348119567;9777.853332200022;9864.556094975744;9930.453825039693;9943.552540135712;726.7783326085595;730.7405870915749;736.5065406177873;745.9515131516434;748.4424104042523;4544.250198717241;4672.509386514435;4690.859274221779;4722.173619616553;4762.690425122425;61064;61788.38211617826;61830.381696183365;62485.375146248865;62716.68641656762;50451;50550.24174637383;50558.49441505611;53130.40608781743;53229.73385133049;47851.76074119607;48015;48142.27786583204;48235.276470852965;48512.757436212596;9840.3603765755;10094.041066098709;10121.291509594552;10153.746156345855;10213.285070045025;35747.28505429929;36070.63929360673;36976.63023369732;37596;38519.80740096394;43008.78495607627;46374.53625463837;48173.27740083972;48294;49574.25638615496;11852.525898963944;12195.512179513074;12276.324802135969;12475.688107797378;12941.805872911726;13093.869061309266;13294.734105317646;13296.468141274627;13511.932440337736;13766.724665506834;11439.942800285946;13167.53913613019;13322.666933326744;13391.86608133945;13544.59366219015;12066.155369124428;12904.612861614167;12916.547920822726;13031;13712.451501939811;13126.14680045794;13583.796243056164;13728.862711372758;13748.312584370942;14494.492692755703;9876.45679487635;10042.297039207186;10042.748931276776;10083.647072352433;10206.846897296398;10836.187285953427;11388.715282118013;11409.429528523375;11562;11657.417129143678 10:30:55 INFO - PROCESS | 19010 | __end_tp_report 10:30:55 INFO - PROCESS | 19010 | __start_cc_report 10:30:55 INFO - PROCESS | 19010 | _x_x_mozilla_cycle_collect,814 10:30:55 INFO - PROCESS | 19010 | __end_cc_report 10:30:55 INFO - PROCESS | 19010 | __startTimestamp1462987855099__endTimestamp 10:30:55 INFO - PROCESS | 19010 | 10:30:55 INFO - PROCESS | 19010 | ------- Summary: start ------- 10:30:55 INFO - PROCESS | 19010 | Number of tests: 6 10:30:55 INFO - PROCESS | 19010 | 10:30:55 INFO - PROCESS | 19010 | [#0] dojo.html Cycles:165 Average:5417.72 Median:5602.69 stddev:586.21 (10.5%) stddev-sans-first:562.94 10:30:55 INFO - PROCESS | 19010 | Values: 3255.8 3331.6 3366.9 3385.4 3408.9 5417.0 5441.5 5458.3 5471.0 5483.3 5434.6 5496.3 5508.3 5514.9 5537.7 4852.7 4928.4 5008.9 5028.6 5108.5 4914.0 5007.3 5012.2 5013.6 5018.1 4947.8 4991.0 4998.9 5005.0 5005.8 4937.4 4962.9 4981.0 4982.3 5011.8 4781.5 4874.2 4906.1 4924.0 4952.0 5337.5 5372.5 5391.3 5394.5 5398.3 5777.5 5850.9 5859.0 5860.2 5865.9 5853.7 5869.5 5886.3 5945.2 5949.3 5481.5 5488.2 5527.5 5531.7 5532.6 5642.8 5987.1 5991.9 6006.5 6009.8 5636.3 5681.6 5696.0 5715.9 5737.9 5701.7 5707.8 5720.4 5732.7 5735.5 5570.5 5692.5 5702.4 5702.5 5826.9 5787.5 5798.7 5814.9 5819.3 5860.5 4463.3 4483.6 4488.8 4494.8 4510.3 3964.0 3990.9 4010.2 4053.6 4054.5 5505.8 5525.6 5539.0 5545.0 5562.7 5787.7 5791.5 5795.6 5799.8 5804.4 5431.6 5502.7 5539.6 5545.2 5630.2 5017.1 5026.9 5031.2 5036.2 5041.1 6127.6 6149.8 6167.8 6183.5 6193.1 5694.6 5874.3 5893.7 5953.0 5953.7 5991.9 6003.5 6004.0 6009.4 6014.7 5650.9 5652.9 5653.0 5653.9 5669.5 5760.7 5854.7 5909.6 5929.7 5938.1 5575.1 5598.0 5602.7 5603.7 5606.7 5530.9 5575.4 5584.1 5597.4 5603.8 5625.4 5656.1 5685.6 5686.8 5711.7 5718.3 5719.4 5751.3 5754.6 5757.4 5457.7 5630.5 5631.3 5635.4 5645.9 10:30:55 INFO - PROCESS | 19010 | 10:30:55 INFO - PROCESS | 19010 | [#1] ext.html Cycles:180 Average:58776.45 Median:191783.12 stddev:112221.57 (58.5%) stddev-sans-first:112451.55 10:30:55 INFO - PROCESS | 19010 | Values: 658.2 665.5 674.8 730.4 738.9 32707.7 33641.3 40501.0 41143.0 41225.4 43893.3 44663.0 44670.3 44688.0 44707.6 7972.5 8700.3 8887.4 8902.4 10284.3 10329.2 10507.4 10508.4 10518.7 10525.9 10545.7 10605.9 10609.9 10614.3 10630.3 10474.6 10490.2 10505.1 10533.7 10536.2 10400.6 10467.9 10524.1 10840.9 10855.7 34199.8 44638.6 45064.3 45151.5 45170.8 3841.9 3855.5 3885.9 3954.4 4063.7 31621.5 32166.8 32259.0 32362.5 33988.5 4313.1 4364.7 4382.3 4396.9 4453.5 371660.0 379281.0 379288.0 379506.0 379767.0 41227.2 62574.4 62901.3 63048.4 63310.0 41329.0 41479.4 41583.4 41588.2 41605.4 16574.0 17511.3 17683.4 17811.7 17813.8 15127.1 15458.2 15466.8 15479.5 15498.1 9568.7 9604.7 9610.9 9660.1 9663.6 3714.0 3772.2 3792.0 3799.2 3824.3 1136.8 1161.8 1162.8 1209.4 1278.0 33828.7 33934.7 34411.1 34768.3 35929.5 1214.9 1218.1 1240.2 1322.4 1345.9 17167.8 17210.4 17274.7 17337.9 17416.0 460495.0 462750.0 463551.0 463929.0 464357.0 61270.4 62350.0 62365.7 62370.7 62401.4 1380.3 1432.4 1443.8 1540.2 1638.5 33335.5 35301.5 35917.5 36947.3 38248.4 59741.7 60521.7 60746.7 60806.7 60808.0 426660.0 429299.0 429319.0 430162.0 431847.0 28916.9 30786.0 31427.4 31605.5 31648.8 48093.3 48253.3 48744.0 49530.0 49841.0 39444.4 40139.6 40201.8 40352.2 41580.6 39368.0 40141.0 40188.8 40344.4 40358.0 41690.8 42170.0 42323.8 42804.8 43005.6 34359.8 36109.6 36257.0 36343.3 36590.3 27928.0 28179.0 28449.7 28603.1 28677.9 10:30:55 INFO - PROCESS | 19010 | 10:30:55 INFO - PROCESS | 19010 | [#2] jquery.html Cycles:180 Average:29576.43 Median:11004.14 stddev:79289.66 (720.5%) stddev-sans-first:79481.85 10:30:55 INFO - PROCESS | 19010 | Values: 413.1 413.3 415.5 427.7 428.4 13813.5 18935.7 19537.3 19538.6 21205.7 15509.5 18387.8 19665.2 20295.8 20588.5 5664.2 5854.2 5859.9 5868.6 5890.5 5896.2 5979.4 5999.6 6004.6 6006.8 4296.5 4448.7 6196.2 6442.7 6470.6 6195.5 6376.9 6423.2 6428.6 6434.6 5698.5 5760.7 5769.0 5772.9 5774.2 22142.2 22211.0 22661.1 22914.2 22914.8 2617.3 2666.5 2708.2 2921.5 3126.0 13797.7 14467.9 15034.6 15268.7 15481.6 2016.3 2073.6 2131.0 2196.8 2209.1 77560.6 78640.2 79166.0 80503.0 81790.0 10491.5 10880.3 10903.3 11045.2 11125.9 15359.5 15577.1 15585.8 15594.7 15619.2 8151.9 8378.3 8577.0 8845.5 8992.0 8503.7 8520.0 8527.5 8549.0 9204.5 4718.7 5108.0 5154.4 5170.6 5259.6 1947.8 1988.6 2073.2 2082.8 2124.7 1020.8 1077.2 1080.4 1111.8 1118.1 19200.0 19263.2 19541.9 19608.6 19992.0 1045.3 1051.9 1061.7 1073.4 1096.0 10949.2 11105.0 11159.4 11180.5 11203.7 459907.0 471650.0 487924.0 489125.0 491524.0 94937.5 100817.5 100843.0 101133.0 101745.0 1078.3 1083.8 1089.5 1106.6 1107.0 17293.7 17663.5 17695.8 17748.6 17993.4 41349.6 41493.6 41820.2 41830.8 41843.4 59413.4 61399.7 61913.0 62190.0 62352.0 9116.7 9287.2 12501.7 13253.4 13704.9 10132.9 12744.4 14060.7 14070.6 14662.2 12474.4 12612.6 12685.6 12772.7 13281.2 12506.9 12508.7 12567.9 12663.0 13001.2 12909.1 13031.7 13121.4 13677.2 13827.7 13410.6 13499.4 13510.4 13630.6 13651.9 12965.9 12985.2 13013.1 13190.3 13344.2 10:30:55 INFO - PROCESS | 19010 | 10:30:55 INFO - PROCESS | 19010 | [#3] mootools.html Cycles:180 Average:5824.21 Median:4870.35 stddev:3251.87 (66.8%) stddev-sans-first:3244.26 10:30:55 INFO - PROCESS | 19010 | Values: 1435.3 1498.2 1509.7 1723.6 1903.8 8420.9 8603.0 8608.3 8623.2 8639.6 8135.6 8290.5 8298.4 8302.5 8308.5 2150.4 2343.1 2370.4 2408.6 2486.6 2416.6 2477.5 2485.8 2487.5 2488.2 2407.5 2434.1 2434.7 2435.8 2440.0 2174.4 2321.8 2376.0 2376.8 2386.0 2237.1 2267.5 2325.7 2330.1 2330.9 8580.5 8608.8 8622.5 8623.1 8632.0 5446.8 5518.0 5566.9 5568.4 5609.2 3489.5 3556.8 3583.3 3615.8 3622.9 1055.0 1063.5 1080.1 1103.2 1182.5 12592.3 12625.4 12634.4 12653.4 12667.6 4718.1 4740.1 4810.9 4825.3 4856.6 10701.1 10706.0 10708.3 10713.7 10714.4 4893.7 5519.5 5547.1 5549.9 5550.9 4810.7 4826.5 4832.0 4884.1 4899.6 4177.1 4188.7 4202.9 4258.5 4259.7 1329.7 1346.1 1353.6 1355.8 1373.1 937.6 1000.8 1005.2 1068.8 1076.8 5851.6 5897.5 5970.9 6141.9 6169.6 941.2 992.1 1041.3 1047.0 1063.8 3877.4 4022.8 4023.8 4038.9 4076.9 10502.4 10934.7 10975.8 10985.6 10991.3 10970.3 11112.2 11122.8 11124.1 11131.9 7826.2 8015.9 8128.8 8140.7 8153.5 5843.7 6061.5 6115.8 6118.2 6178.0 9425.1 9574.6 9629.9 9641.5 9888.4 9770.0 9783.2 9798.4 9965.9 10499.8 7125.3 7494.5 7742.7 7933.1 8049.2 8428.2 8449.0 8468.2 8486.2 8510.1 7187.2 7349.3 7374.0 7457.5 7519.1 7207.5 7252.7 7315.2 7409.8 7423.3 7137.3 7191.6 7277.1 7343.2 7348.0 5223.7 5224.1 5288.9 5418.1 5485.8 5308.7 5357.5 5414.8 5415.8 5436.8 10:30:55 INFO - PROCESS | 19010 | 10:30:55 INFO - PROCESS | 19010 | [#4] prototype.html Cycles:180 Average:5519.61 Median:6314.17 stddev:1668.73 (26.4%) stddev-sans-first:1627.68 10:30:55 INFO - PROCESS | 19010 | Values: 350.6 353.8 356.3 357.8 359.5 6145.2 6180.8 6191.4 6199.1 6209.8 6083.0 6171.3 6185.2 6185.8 6189.8 4507.4 4616.7 4707.1 4710.7 4716.6 4666.9 4697.3 4708.6 4725.8 4726.9 4519.8 4730.8 4732.4 4734.6 4735.3 4564.8 4653.0 4662.7 4692.2 4738.4 4171.3 4177.5 4184.1 4190.4 4191.7 5940.9 5945.2 5946.4 5951.1 5952.6 5509.7 5516.6 5519.3 5521.8 5526.3 6376.7 6482.8 6490.9 6491.4 6507.8 4596.2 4649.3 4649.9 4654.5 4655.4 6650.2 6821.6 6825.0 6830.9 6837.7 4702.9 4706.2 4710.7 4715.2 4718.7 4759.8 4762.5 4766.8 4769.0 4773.3 5453.8 5470.3 5471.6 5484.1 5485.8 6355.0 6532.7 6588.5 6592.2 6593.7 1685.8 1694.9 1704.9 1707.4 1708.4 1061.3 1129.3 1134.3 1138.8 1156.2 6273.4 6437.9 6457.9 6461.6 6474.3 6779.5 6805.2 6808.1 6808.9 6819.8 6437.6 6445.3 6447.2 6448.9 6452.8 3615.3 3640.3 3653.1 3665.7 3666.8 6880.5 7070.1 7150.7 7191.5 7206.5 6965.9 6967.8 6972.6 6988.2 6991.7 7166.4 7177.0 7185.9 7188.6 7193.7 6802.9 6811.8 6814.4 6825.6 6826.5 6559.8 6710.2 6800.1 6807.8 6810.5 7166.4 7179.9 7184.9 7185.8 7192.7 4578.6 4610.8 4619.1 4622.5 4622.5 6731.4 6739.1 6740.3 6756.0 6760.8 6386.7 6588.1 6607.0 6608.7 6614.2 6549.9 6561.9 6601.5 6607.1 6650.2 6492.7 6497.9 6503.2 6505.9 6507.7 6648.2 6651.2 6654.0 6655.4 6657.8 6365.8 6457.6 6475.7 6476.8 6480.5 10:30:55 INFO - PROCESS | 19010 | 10:30:55 INFO - PROCESS | 19010 | [#5] yui.html Cycles:180 Average:14953.47 Median:25523.52 stddev:16731.29 (65.6%) stddev-sans-first:16744.58 10:30:55 INFO - PROCESS | 19010 | Values: 823.9 835.8 855.0 876.6 894.7 12946.7 13313.8 13354.7 13376.5 13380.3 13705.7 13723.4 13813.2 13815.1 13829.2 753.6 889.0 903.3 909.4 909.4 900.9 906.0 906.9 908.4 910.7 779.8 948.0 950.9 951.6 951.7 791.7 915.8 936.9 940.0 940.1 690.9 691.0 691.8 692.3 692.6 13555.8 13564.0 13578.3 13619.8 13651.7 14494.4 14646.9 14752.7 14833.3 14929.9 11708.6 12130.1 12275.3 12279.8 12343.0 3993.1 4033.3 4036.9 4116.0 4149.2 50999.2 52039.0 52075.5 52133.2 53229.5 11182.7 11434.1 11563.8 11770.3 12010.1 21019.7 21121.2 21133.6 21166.5 21176.9 8758.9 8828.6 9075.7 9097.3 9240.2 5046.6 5073.9 5138.3 5146.2 5176.3 3439.7 3480.4 3482.6 3488.0 3490.5 614.1 614.4 614.7 615.1 637.1 705.5 723.7 783.4 818.0 851.2 9021.7 9777.9 9864.6 9930.5 9943.6 726.8 730.7 736.5 746.0 748.4 4544.3 4672.5 4690.9 4722.2 4762.7 61064.0 61788.4 61830.4 62485.4 62716.7 50451.0 50550.2 50558.5 53130.4 53229.7 47851.8 48015.0 48142.3 48235.3 48512.8 9840.4 10094.0 10121.3 10153.7 10213.3 35747.3 36070.6 36976.6 37596.0 38519.8 43008.8 46374.5 48173.3 48294.0 49574.3 11852.5 12195.5 12276.3 12475.7 12941.8 13093.9 13294.7 13296.5 13511.9 13766.7 11439.9 13167.5 13322.7 13391.9 13544.6 12066.2 12904.6 12916.5 13031.0 13712.5 13126.1 13583.8 13728.9 13748.3 14494.5 9876.5 10042.3 10042.7 10083.6 10206.8 10836.2 11388.7 11409.4 11562.0 11657.4 10:30:55 INFO - PROCESS | 19010 | -------- Summary: end -------- 10:30:55 INFO - PROCESS | 19010 | 10:30:55 INFO - TEST-INFO | 19010: exit 0 10:30:55 INFO - TEST-OK | dromaeo_css | took 1112675ms 10:30:55 INFO - TEST-START | kraken 10:30:55 INFO - operating with platform_type : linux_ 10:30:55 INFO - Initialising browser for kraken test... 10:30:55 INFO - TEST-INFO | started process 19206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI51ius/profile http://localhost:48962/getInfo.html) 10:31:00 INFO - PROCESS | 19206 | __metrics Screen width/height:1600/1200 10:31:00 INFO - PROCESS | 19206 | colorDepth:24 10:31:00 INFO - PROCESS | 19206 | Browser inner width/height: 1024/697 10:31:00 INFO - PROCESS | 19206 | __metrics 10:31:01 ERROR - PROCESS | 19206 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:31:02 INFO - TEST-INFO | 19206: exit 0 10:31:02 INFO - Browser initialized. 10:31:02 INFO - Running cycle 1/1 for kraken test... 10:31:02 INFO - TEST-INFO | started process 19298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI51ius/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:14 INFO - PROCESS | 19298 | RSS: Main: 141893632 10:31:14 INFO - PROCESS | 19298 | 10:31:16 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48962/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:17 INFO - PROCESS | 19298 | RSS: Main: 196648960 10:31:17 INFO - PROCESS | 19298 | 10:31:20 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48962/tests/kraken/driver.html?testName=audio-dft) 10:31:21 INFO - PROCESS | 19298 | RSS: Main: 182226944 10:31:21 INFO - PROCESS | 19298 | 10:31:23 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48962/tests/kraken/driver.html?testName=audio-fft) 10:31:24 INFO - PROCESS | 19298 | RSS: Main: 273199104 10:31:24 INFO - PROCESS | 19298 | 10:31:26 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48962/tests/kraken/driver.html?testName=audio-oscillator) 10:31:27 INFO - PROCESS | 19298 | RSS: Main: 178552832 10:31:27 INFO - PROCESS | 19298 | 10:31:29 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48962/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:31:29 INFO - PROCESS | 19298 | RSS: Main: 176586752 10:31:29 INFO - PROCESS | 19298 | 10:31:32 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48962/tests/kraken/driver.html?testName=imaging-darkroom) 10:31:33 INFO - PROCESS | 19298 | RSS: Main: 211947520 10:31:33 INFO - PROCESS | 19298 | 10:31:36 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48962/tests/kraken/driver.html?testName=imaging-desaturate) 10:31:37 INFO - PROCESS | 19298 | RSS: Main: 212434944 10:31:37 INFO - PROCESS | 19298 | 10:31:40 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48962/tests/kraken/driver.html?testName=json-parse-financial) 10:31:40 INFO - PROCESS | 19298 | RSS: Main: 212566016 10:31:40 INFO - PROCESS | 19298 | 10:31:42 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48962/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:31:42 INFO - PROCESS | 19298 | RSS: Main: 191213568 10:31:42 INFO - PROCESS | 19298 | 10:31:44 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48962/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:31:45 INFO - PROCESS | 19298 | RSS: Main: 196575232 10:31:45 INFO - PROCESS | 19298 | 10:31:47 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48962/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:31:47 INFO - PROCESS | 19298 | RSS: Main: 210358272 10:31:47 INFO - PROCESS | 19298 | 10:31:50 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:31:50 INFO - PROCESS | 19298 | RSS: Main: 209580032 10:31:50 INFO - PROCESS | 19298 | 10:31:53 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:31:54 INFO - PROCESS | 19298 | RSS: Main: 208809984 10:31:54 INFO - PROCESS | 19298 | 10:31:55 INFO - PROCESS | 19298 | Cycle 1(1): loaded http://localhost:48962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48962/tests/kraken/driver.html?testName=ai-astar) 10:31:56 INFO - PROCESS | 19298 | RSS: Main: 272351232 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | __start_tp_report 10:31:56 INFO - PROCESS | 19298 | _x_x_mozilla_page_load 10:31:56 INFO - PROCESS | 19298 | _x_x_mozilla_page_load_details 10:31:56 INFO - PROCESS | 19298 | |i|pagename|runs| 10:31:56 INFO - PROCESS | 19298 | |0;ai-astar;112;112;111;111;111;110;106;112;111;110 10:31:56 INFO - PROCESS | 19298 | |1;audio-beat-detection;160;126;154;175;126;159;156;129;194;134 10:31:56 INFO - PROCESS | 19298 | |2;audio-dft;161;160;161;162;162;161;160;160;159;161 10:31:56 INFO - PROCESS | 19298 | |3;audio-fft;72;76;75;172;73;77;76;77;156;76 10:31:56 INFO - PROCESS | 19298 | |4;audio-oscillator;92;91;156;92;91;92;138;92;92;150 10:31:56 INFO - PROCESS | 19298 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 10:31:56 INFO - PROCESS | 19298 | |6;imaging-darkroom;145;145;146;144;145;146;145;144;146;146 10:31:56 INFO - PROCESS | 19298 | |7;imaging-desaturate;95;96;95;94;95;95;95;95;95;95 10:31:56 INFO - PROCESS | 19298 | |8;json-parse-financial;54;54;53;53;55;54;55;71;53;52 10:31:56 INFO - PROCESS | 19298 | |9;json-stringify-tinderbox;60;58;58;58;57;57;57;58;58;57 10:31:56 INFO - PROCESS | 19298 | |10;stanford-crypto-aes;74;72;73;74;76;75;75;74;74;77 10:31:56 INFO - PROCESS | 19298 | |11;stanford-crypto-ccm;116;115;113;110;113;113;126;112;172;113 10:31:56 INFO - PROCESS | 19298 | |12;stanford-crypto-pbkdf2;160;158;157;156;155;155;155;160;163;161 10:31:56 INFO - PROCESS | 19298 | |13;stanford-crypto-sha256-iterative;66;67;67;65;68;66;67;64;64;67 10:31:56 INFO - PROCESS | 19298 | __end_tp_report 10:31:56 INFO - PROCESS | 19298 | __start_cc_report 10:31:56 INFO - PROCESS | 19298 | _x_x_mozilla_cycle_collect,1608 10:31:56 INFO - PROCESS | 19298 | __end_cc_report 10:31:56 INFO - PROCESS | 19298 | __startTimestamp1462987916018__endTimestamp 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | ------- Summary: start ------- 10:31:56 INFO - PROCESS | 19298 | Number of tests: 14 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.78 (1.6%) stddev-sans-first:1.81 10:31:56 INFO - PROCESS | 19298 | Values: 112.0 112.0 111.0 111.0 111.0 110.0 106.0 112.0 111.0 110.0 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:157.50 stddev:22.67 (14.4%) stddev-sans-first:23.83 10:31:56 INFO - PROCESS | 19298 | Values: 160.0 126.0 154.0 175.0 126.0 159.0 156.0 129.0 194.0 134.0 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 10:31:56 INFO - PROCESS | 19298 | Values: 161.0 160.0 161.0 162.0 162.0 161.0 160.0 160.0 159.0 161.0 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.00 stddev:37.64 (49.5%) stddev-sans-first:39.15 10:31:56 INFO - PROCESS | 19298 | Values: 72.0 76.0 75.0 172.0 73.0 77.0 76.0 77.0 156.0 76.0 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:92.00 stddev:27.53 (29.9%) stddev-sans-first:28.54 10:31:56 INFO - PROCESS | 19298 | Values: 92.0 91.0 156.0 92.0 91.0 92.0 138.0 92.0 92.0 150.0 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:31:56 INFO - PROCESS | 19298 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 10:31:56 INFO - PROCESS | 19298 | Values: 145.0 145.0 146.0 144.0 145.0 146.0 145.0 144.0 146.0 146.0 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:31:56 INFO - PROCESS | 19298 | Values: 95.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.00 stddev:5.56 (10.3%) stddev-sans-first:5.88 10:31:56 INFO - PROCESS | 19298 | Values: 54.0 54.0 53.0 53.0 55.0 54.0 55.0 71.0 53.0 52.0 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.92 (1.6%) stddev-sans-first:0.53 10:31:56 INFO - PROCESS | 19298 | Values: 60.0 58.0 58.0 58.0 57.0 57.0 57.0 58.0 58.0 57.0 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.50 stddev:1.43 (1.9%) stddev-sans-first:1.51 10:31:56 INFO - PROCESS | 19298 | Values: 74.0 72.0 73.0 74.0 76.0 75.0 75.0 74.0 74.0 77.0 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:114.00 stddev:18.68 (16.4%) stddev-sans-first:19.75 10:31:56 INFO - PROCESS | 19298 | Values: 116.0 115.0 113.0 110.0 113.0 113.0 126.0 112.0 172.0 113.0 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:159.00 stddev:2.87 (1.8%) stddev-sans-first:2.95 10:31:56 INFO - PROCESS | 19298 | Values: 160.0 158.0 157.0 156.0 155.0 155.0 155.0 160.0 163.0 161.0 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - PROCESS | 19298 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:67.00 stddev:1.37 (2.0%) stddev-sans-first:1.45 10:31:56 INFO - PROCESS | 19298 | Values: 66.0 67.0 67.0 65.0 68.0 66.0 67.0 64.0 64.0 67.0 10:31:56 INFO - PROCESS | 19298 | -------- Summary: end -------- 10:31:56 INFO - PROCESS | 19298 | 10:31:56 INFO - TEST-INFO | 19298: exit 0 10:31:56 INFO - TEST-OK | kraken | took 61047ms 10:31:56 INFO - SUITE-END | took 1173s 10:31:57 INFO - Completed test suite (00:19:33) 10:31:57 INFO - javascript benchmark 10:31:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3255.8046517208963, 3331.550240717502, 3366.9326613467733, 3385.3737058644138, 3408.863645454182, 5416.970775552647, 5441.5102640762325, 5458.263134476844, 5471.015217260897, 5483.287172667548, 5434.619576629638, 5496.258005169301, 5508.338999320087, 5514.862128446791, 5537.723113844312, 4852.733099679516, 4928.359313289267, 5008.874778130539, 5028.572571331441, 5108.4636113208135, 4913.950860491403, 5007.32401125847, 5012.172991456424, 5013.573846223076, 5018.071656743496, 4947.8268260610885, 4991.026749783794, 4998.875028124289, 5004.9749751251375, 5005.774740136702, 4937.432195297551, 4962.851114466572, 4980.950190498121, 4982.252662100677, 5011.799528018875, 4781.450133234688, 4874.220124780054, 4906.067847109038, 4923.975380123113, 4952.034353301107, 5337.546308563777, 5372.516473517363, 5391.29913111293, 5394.487523685244, 5398.325209348832, 5777.451142141532, 5850.941490585083, 5859.003969325182, 5860.179574859523, 5865.85335366615, 5853.678047707374, 5869.50109240715, 5886.293644762613, 5945.16767652529, 5949.25634295713, 5481.5340696040885, 5488.231647569343, 5527.474889885495, 5531.695756733378, 5532.640378375393, 5642.774289028393, 5987.13186587951, 5991.940080599225, 6006.4594186522545, 6009.789657361971, 5636.323641163087, 5681.57388195887, 5696.0, 5715.885682286331, 5737.8565535861935, 5701.71491425427, 5707.800226992035, 5720.427957204246, 5732.742026608729, 5735.541156707453, 5570.470805273492, 5692.459216374438, 5702.429757024347, 5702.54379649627, 5826.941730582725, 5787.5080618147085, 5798.739056742373, 5814.941850581525, 5819.301683797971, 5860.501857342088, 4463.263561512379, 4483.574060464251, 4488.775561221991, 4494.842680506166, 4510.255807791677, 3963.980180099081, 3990.86031988879, 4010.21800748857, 4053.5541090480024, 4054.533728621246, 5505.834824955257, 5525.557955363642, 5539.0, 5544.972275138599, 5562.666240025612, 5787.739551720183, 5791.507721843606, 5795.594308398456, 5799.82600521985, 5804.361520232771, 5431.5926305526455, 5502.724863756796, 5539.612227144061, 5545.1682247663175, 5630.18362337467, 5017.071841709296, 5026.949730502722, 5031.245313202976, 5036.194208926554, 5041.143005689041, 6127.601705889103, 6149.7847575334645, 6167.814965551041, 6183.474404675563, 6193.102000209944, 5694.629849059964, 5874.324452687995, 5893.705314734246, 5953.017752070859, 5953.7023148843255, 5991.850203744942, 6003.549733769897, 6004.0, 6009.36901625323, 6014.699265036818, 5650.943490565206, 5652.88694226105, 5653.0, 5653.85865353353, 5669.518090962314, 5760.740766665426, 5854.736536855767, 5909.645421274738, 5929.703514824328, 5938.138969849261, 5575.0522411191005, 5597.972010139923, 5602.691851948182, 5603.719814009365, 5606.719664016864, 5530.91703624454, 5575.358833734011, 5584.050711379156, 5597.44025597437, 5603.831885043455, 5625.381208067191, 5656.095024796013, 5685.630434021776, 5686.829395118153, 5711.7429715662065, 5718.313802343579, 5719.399463056486, 5751.252337196138, 5754.56840736938, 5757.395473475225, 5457.69982650958, 5630.493255607015, 5631.324241091095, 5635.380108188014, 5645.943540564542], "value": 5380.994624423939, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.1772784019975, 665.4676258992805, 674.7941877727293, 730.4156674660267, 738.8780851159557, 32707.67292327079, 33641.32717345655, 40501.0, 41143.0, 41225.38161927574, 43893.341599876025, 44663.0, 44670.32994505077, 44688.0, 44707.55292447074, 7972.481788683746, 8700.26047785939, 8887.377883548153, 8902.376833621649, 10284.280100392976, 10329.225308101884, 10507.422091784949, 10508.369497830156, 10518.684439466828, 10525.894741052607, 10545.68362949109, 10605.893941060607, 10609.946950265277, 10614.257002009863, 10630.255882088257, 10474.633387831427, 10490.213234007404, 10505.107065899409, 10533.683989480289, 10536.157107431387, 10400.635977740743, 10467.895321046768, 10524.105451036594, 10840.945795271053, 10855.67432977012, 34199.82900085508, 44638.553614463766, 45064.3240351395, 45151.54848451539, 45170.774146129384, 3841.9231615367817, 3855.479510266134, 3885.941710874339, 3954.387070004154, 4063.6952228582677, 31621.525677114863, 32166.839165804256, 32259.0, 32362.514562281583, 33988.49017264743, 4313.09425020746, 4364.738115713068, 4382.320740285261, 4396.89007774805, 4453.487848897385, 371660.0, 379281.0, 379288.0, 379505.99999999726, 379767.0, 41227.1754564913, 62574.37425625685, 62901.28240381898, 63048.36951630425, 63310.0, 41329.0, 41479.37780933289, 41583.37624935628, 41588.168236635705, 41605.375919361235, 16574.0, 17511.299548017938, 17683.381081662337, 17811.73282400765, 17813.821861781475, 15127.092374457348, 15458.227088645523, 15466.767998480032, 15479.5356139316, 15498.147601882005, 9568.712938611852, 9604.711858644252, 9610.855837162448, 9660.130588247092, 9663.613455461702, 3713.9814300928324, 3772.1701225730294, 3791.981040094837, 3799.2401519696173, 3824.254270417242, 1136.8351589019546, 1161.8315344275034, 1162.8255761635653, 1209.383214560563, 1277.9680507987189, 33828.66171338255, 33934.66065339364, 34411.13972150716, 34768.30463390718, 35929.46105808415, 1214.942999590362, 1218.129037738004, 1240.1504969096197, 1322.4049177869997, 1345.9461621535029, 17167.828321716872, 17210.39763608268, 17274.740878886827, 17337.913310433367, 17416.044403625743, 460495.0, 462750.0, 463551.0, 463929.0, 464357.0, 61270.38729612736, 62350.0, 62365.68817155885, 62370.688146558976, 62401.37598623956, 1380.2684577174114, 1432.4198699526708, 1443.8050863133553, 1540.1913995152634, 1638.4511188751662, 33335.49996750002, 35301.47047794234, 35917.46123808093, 36947.26105477822, 38248.426273605364, 59741.701291493264, 60521.69739151276, 60746.69626651838, 60806.69596651988, 60808.0, 426660.0, 429299.0, 429319.0, 430162.0, 431847.0, 28916.855415722788, 30786.0, 31427.37145257036, 31605.5259171108, 31648.841755791073, 48093.27860082032, 48253.276200856315, 48744.0, 49530.0, 49841.0, 39444.40833387559, 40139.59860401358, 40201.79899100603, 40352.1929561413, 41580.58419415767, 39368.0, 40140.99647508719, 40188.7990560057, 40344.3948340781, 40358.0, 41690.79154604208, 42170.0, 42323.7883810579, 42804.78597606992, 43005.56994430016, 34359.828200858836, 36109.63890361063, 36257.0, 36343.273134536634, 36590.26819463543, 27928.0, 28179.0, 28449.715502845535, 28603.14190574286, 28677.85661071681], "value": 20245.219943837197, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.1097484919998, 413.3345314044389, 415.54705371145445, 427.68137737385655, 428.3702956653719, 13813.51652692156, 18935.71596426053, 19537.316193933217, 19538.609227815454, 21205.681914771292, 15509.457168999088, 18387.816121838776, 19665.213391464324, 20295.797042029575, 20588.48528786781, 5664.235328230698, 5854.18041474194, 5859.8535036624, 5868.559858010645, 5890.499307558841, 5896.204012458327, 5979.402059794029, 5999.640021598696, 6004.639721616717, 6006.8498287542725, 4296.548862369453, 4448.666350023745, 6196.16351792509, 6442.742290308382, 6470.644114573696, 6195.535334849859, 6376.904346434807, 6423.197100362478, 6428.614283143003, 6434.613923164602, 5698.458646428624, 5760.711964401763, 5768.97115514424, 5772.855678608026, 5774.191613174159, 22142.22502212431, 22211.001009909025, 22661.051162558975, 22914.198003069978, 22914.770852291596, 2617.2802479318148, 2666.520026395248, 2708.2010806812036, 2921.4887394705843, 3126.030930411557, 13797.724045519033, 14467.92766036163, 15034.624134396618, 15268.694626107415, 15481.612959676098, 2016.2842191022269, 2073.6163809695254, 2130.968035479469, 2196.8132708719777, 2209.0832304593573, 77560.61219693921, 78640.21359786444, 79166.0, 80502.99999999942, 81790.0, 10491.527881245362, 10880.292780969212, 10903.34579925207, 11045.171612129123, 11125.94437027826, 15359.539213823604, 15577.14325712074, 15585.766213506806, 15594.688106237812, 15619.219039048003, 8151.918480815235, 8378.329733621418, 8576.957115214384, 8845.469271843709, 8992.0, 8503.74488765338, 8520.0, 8527.465056289804, 8548.957255213683, 9204.493752843524, 4718.693284936468, 5108.033516497148, 5154.3814742230425, 5170.560502357266, 5259.552938000313, 1947.8052194780691, 1988.582397696471, 2073.2225415469197, 2082.791720827905, 2124.7131637228777, 1020.7958408318366, 1077.2297807067828, 1080.3787822002223, 1111.822108462642, 1118.0943435817014, 19200.0, 19263.22947082129, 19541.8843604161, 19608.607827843363, 19992.0, 1045.2735348932572, 1051.8579991701022, 1061.7120106171176, 1073.3720773347522, 1095.950682219302, 10949.178811589163, 11105.0, 11159.38623375722, 11180.496877640526, 11203.663890083311, 459907.0, 471650.0, 487924.0, 489125.0, 491524.0, 94937.52531237438, 100817.49591252144, 100843.0, 101133.0, 101745.0, 1078.347599702169, 1083.766990097117, 1089.5478376473834, 1106.5629076514892, 1106.9557217711201, 17293.74059389085, 17663.470095897144, 17695.823041769418, 17748.556286092433, 17993.370232041816, 41349.586504134575, 41493.585064148974, 41820.16359672729, 41830.79084604557, 41843.372349414174, 59413.40586594251, 61399.69300153471, 61913.0, 62190.0, 62352.0, 9116.680916167903, 9287.210587100171, 12501.749965000467, 13253.403596838358, 13704.931475342559, 10132.898671013196, 12744.4265008073, 14060.718785624435, 14070.577882663536, 14662.193579353238, 12474.376281185723, 12612.621621351374, 12685.619431417072, 12772.744545109232, 13281.203127812361, 12506.93746531298, 12508.732360631655, 12567.937160314506, 12663.0, 13001.15492492985, 12909.096363254857, 13031.674208144872, 13121.409536571067, 13677.179369237878, 13827.654308642364, 13410.597682069554, 13499.392527336096, 13510.392032358372, 13630.568790276879, 13651.931740341235, 12965.870341296844, 12985.220886746825, 13013.089083764045, 13190.274534900289, 13344.199348039148], "value": 9921.581385918318, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.3397437178896, 1498.2284123676309, 1509.667873067925, 1723.6121872578672, 1903.7905830358666, 8420.873686894694, 8602.956985215082, 8608.268297194738, 8623.22390984812, 8639.611217495212, 8135.633896474658, 8290.461120027208, 8298.377621678383, 8302.54336011519, 8308.459950103239, 2150.3763908466526, 2343.0510643189536, 2370.395549134968, 2408.590539608271, 2486.589712697403, 2416.5770990076753, 2477.4797292568583, 2485.825992180548, 2487.5398051360557, 2488.2410864686262, 2407.4944261704977, 2434.0628857889665, 2434.720007199177, 2435.7807797298237, 2440.0, 2174.402039439151, 2321.8374713770045, 2375.964360534593, 2376.821738369612, 2386.0098059305456, 2237.1387015998794, 2267.489814791675, 2325.6627788970673, 2330.0912644068826, 2330.883455827202, 8580.485170889704, 8608.784780380478, 8622.482651040958, 8623.13768623139, 8631.956840215758, 5446.836594902159, 5518.0, 5566.860828479321, 5568.359638641527, 5609.158626206061, 3489.476578513218, 3556.8399422025814, 3583.2654305867236, 3615.837287322077, 3622.855085796565, 1054.978900421995, 1063.4842101580728, 1080.1358912869673, 1103.1615971861363, 1182.4915286426833, 12592.307423091726, 12625.431855566521, 12634.431450584745, 12653.367331633473, 12667.619971400873, 4718.103560323528, 4740.14677358072, 4810.903781924412, 4825.276208568743, 4856.611471082305, 10701.09040731531, 10706.036456718934, 10708.30396024256, 10713.678589642323, 10714.41070741101, 4893.657443978887, 5519.503244707916, 5547.084731019418, 5549.861253468695, 5550.944490555124, 4810.6632535722165, 4826.493218212107, 4832.0, 4884.096442158212, 4899.5590396863745, 4177.143685544456, 4188.727732697365, 4202.936955945664, 4258.488981322261, 4259.680523960716, 1329.6609364611961, 1346.0846624295573, 1353.5668586052368, 1355.830521184852, 1373.0937581196363, 937.6202637931649, 1000.7748256642197, 1005.1707341443339, 1068.8289873620183, 1076.7954088723275, 5851.61964472308, 5897.469227769521, 5970.85072873173, 6141.877162456726, 6169.629822210592, 941.1858742188095, 992.0674565908023, 1041.2971244409994, 1046.9738256543494, 1063.7819247054335, 3877.418387241936, 4022.7586344819406, 4023.839046438168, 4038.919221615551, 4076.8776936691947, 10502.369857808402, 10934.726631834268, 10975.780484390267, 10985.61550345734, 10991.285566438157, 10970.341779493256, 11112.16658750597, 11122.777544449065, 11124.110071194285, 11131.888681113085, 7826.178251283533, 8015.919840801634, 8128.796780080427, 8140.715074972348, 8153.47002444851, 5843.707814609167, 6061.515078793774, 6115.816525504242, 6118.20463339763, 6178.0, 9425.05749425052, 9574.617015319309, 9629.903700963181, 9641.469719165232, 9888.406695598287, 9769.951150244204, 9783.168430683472, 9798.363106398061, 9965.850512242178, 10499.790004200026, 7125.3230943060325, 7494.5128566643, 7742.651580678996, 7933.087694915159, 8049.154838741848, 8428.199321064489, 8448.957755211184, 8468.195521425454, 8486.151384861465, 8510.063892971892, 7187.2453392393045, 7349.30181632744, 7374.0, 7457.515261507984, 7519.060117485315, 7207.459440541876, 7252.673629686782, 7315.195328513965, 7409.8147546311775, 7423.257674232534, 7137.250588688113, 7191.568505889663, 7277.090363704537, 7343.192248852729, 7348.0, 5223.660462069954, 5224.085784987688, 5288.894222115613, 5418.07892658257, 5485.807996720096, 5308.708021058879, 5357.464253574612, 5414.756335964812, 5415.810446634349, 5436.755346009518], "value": 4704.2414553761155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.57755404737287, 353.82662495377275, 356.25542615932704, 357.8228776755508, 359.51106495166584, 6145.170401995735, 6180.75276988921, 6191.380861913806, 6199.070139479075, 6209.813705588828, 6083.0, 6171.259448866131, 6185.226846644169, 6185.752569897199, 6189.845253868655, 4507.4140361752925, 4616.676832621718, 4707.105649926503, 4710.670253082286, 4716.646251531131, 4666.929996050062, 4697.295405689157, 4708.552687494683, 4725.763711814396, 4726.881827954294, 4519.774011299438, 4730.787114579852, 4732.432108147027, 4734.597559207472, 4735.3133795599615, 4564.79033056237, 4653.046125544272, 4662.650301227404, 4692.178868697998, 4738.407699037621, 4171.270027745163, 4177.4569305990335, 4184.079502509443, 4190.434291370657, 4191.7484950903045, 5940.940590594082, 5945.197398351211, 5946.405359464062, 5951.107333899907, 5952.553558483131, 5509.696966666832, 5516.586256030814, 5519.254900588449, 5521.779128834842, 5526.281583394133, 6376.681165941684, 6482.773102941422, 6490.902636460457, 6491.448226900719, 6507.804765857032, 4596.218642830727, 4649.325847752091, 4649.883752906205, 4654.534546545352, 4655.441347038377, 6650.20197576294, 6821.55659882111, 6825.0, 6830.897536536956, 6837.726490940357, 4702.905941881211, 4706.1999460091865, 4710.69380490267, 4715.174844402216, 4718.669693121448, 4759.785809638505, 4762.476127625959, 4766.76166191689, 4769.046190761862, 4773.307870358779, 5453.809116680897, 5470.288862447936, 5471.5896307777075, 5484.095124304525, 5485.753141108659, 6354.968225158845, 6532.738690452424, 6588.538802283794, 6592.241892182365, 6593.703283352261, 1685.7555654430284, 1694.898306101638, 1704.8891822031528, 1707.39387517432, 1708.3764425984425, 1061.310148403544, 1129.2603344809163, 1134.3477500437116, 1138.8234823602354, 1156.1791128298835, 6273.372662733781, 6437.903431448532, 6457.870842583122, 6461.64460954652, 6474.320196379406, 6779.49153813466, 6805.2173999989645, 6808.148981377328, 6808.931910680929, 6819.795406137824, 6437.5815571988605, 6445.2587952386075, 6447.2263328400895, 6448.903266451007, 6452.838679032968, 3615.2769446110883, 3640.2901434220603, 3653.104989277644, 3665.725070619714, 3666.834992425347, 6880.483963702743, 7070.116235470567, 7150.7497237596435, 7191.496595238283, 7206.459515536356, 6965.930340696528, 6967.79096627102, 6972.629306035972, 6988.231294557595, 6991.685374158175, 7166.355028047501, 7177.0, 7185.89221161683, 7188.640567971581, 7193.676284567207, 6802.897956530755, 6811.761588344582, 6814.420774234246, 6825.590464572141, 6826.488013398915, 6559.836004099936, 6710.228323742636, 6800.115984921928, 6807.761728339485, 6810.455163586802, 7166.426685865223, 7179.8564028720175, 7184.856302874018, 7185.784426467214, 7192.676329565287, 4578.5650363215445, 4610.769461526843, 4619.076184762994, 4622.4684161321875, 4622.491525932078, 6731.427828634621, 6739.090222820053, 6740.292269311848, 6755.966220168868, 6760.797176084725, 6386.712597933197, 6588.110605068446, 6607.0, 6608.7356505739235, 6614.173228346457, 6549.901751473827, 6561.868762624817, 6601.504887133388, 6607.07500949877, 6650.168728908887, 6492.74029038852, 6497.8700425992165, 6503.2196136462035, 6505.934940650533, 6507.707153178024, 6648.16897887764, 6651.16860392451, 6654.0, 6655.434288085567, 6657.7669781557415, 6365.777197798055, 6457.61254324742, 6475.708593113227, 6476.773312934025, 6480.513961452815], "value": 4980.648105290041, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.9093699693035, 835.7576302872168, 855.0210009539078, 876.6493402638945, 894.7494701483582, 12946.74106517869, 13313.800292995613, 13354.7329053419, 13376.464941402344, 13380.264085475295, 13705.725885482309, 13723.382447789849, 13813.240271785047, 13815.1020183688, 13829.202203713503, 753.6118898767126, 888.9777755556098, 903.2638399704252, 909.3952521573179, 909.3997961345514, 900.860366643168, 905.995470022649, 906.8866391701038, 908.3550679017873, 910.658503061352, 779.7933547609888, 947.9763005924838, 950.9476978766165, 951.586060063871, 951.7477868364889, 791.711025475703, 915.7573243090586, 936.892257390402, 939.9671011514564, 940.1444685336311, 690.9274526174729, 691.025653828105, 691.7855464805926, 692.2696555134331, 692.6155983429195, 13555.796663050061, 13563.982701297442, 13578.321083945762, 13619.795703064461, 13651.726965460735, 14494.42022319106, 14646.853531464656, 14752.704945901021, 14833.258337083103, 14929.850701492955, 11708.648740537797, 12130.090243231705, 12275.324857132855, 12279.754404911851, 12343.0, 3993.101552150772, 4033.253848038122, 4036.8788936331957, 4115.9588404115875, 4149.211649786531, 50999.235011474855, 52039.0, 52075.47924520744, 52133.218001730005, 53229.46770532284, 11182.664520064249, 11434.085273178125, 11563.826542601868, 11770.293782373084, 12010.099242556844, 21019.68470472944, 21121.155153793676, 21133.577328453346, 21166.47083822886, 21176.894115529325, 8758.912410875937, 8828.602712877935, 9075.727728168165, 9097.317701172438, 9240.168384845396, 5046.646734728607, 5073.898522029613, 5138.30632864566, 5146.150885103991, 5176.275321454999, 3439.724822014233, 3480.3735327641266, 3482.6169121396624, 3487.9651203488147, 3490.528778614905, 614.1034090228317, 614.4347200575481, 614.744880874441, 615.1080932647678, 637.0921436952325, 705.4885208224099, 723.706898706025, 783.4280974888363, 817.9836403271901, 851.1701091435924, 9021.729348119567, 9777.853332200022, 9864.556094975744, 9930.453825039693, 9943.552540135712, 726.7783326085595, 730.7405870915749, 736.5065406177873, 745.9515131516434, 748.4424104042523, 4544.250198717241, 4672.509386514435, 4690.859274221779, 4722.173619616553, 4762.690425122425, 61064.0, 61788.38211617826, 61830.381696183365, 62485.375146248865, 62716.68641656762, 50451.0, 50550.24174637383, 50558.49441505611, 53130.40608781743, 53229.73385133049, 47851.76074119607, 48015.0, 48142.27786583204, 48235.276470852965, 48512.757436212596, 9840.3603765755, 10094.041066098709, 10121.291509594552, 10153.746156345855, 10213.285070045025, 35747.28505429929, 36070.63929360673, 36976.63023369732, 37596.0, 38519.80740096394, 43008.78495607627, 46374.53625463837, 48173.27740083972, 48294.0, 49574.25638615496, 11852.525898963944, 12195.512179513074, 12276.324802135969, 12475.688107797378, 12941.805872911726, 13093.869061309266, 13294.734105317646, 13296.468141274627, 13511.932440337736, 13766.724665506834, 11439.942800285946, 13167.53913613019, 13322.666933326744, 13391.86608133945, 13544.59366219015, 12066.155369124428, 12904.612861614167, 12916.547920822726, 13031.0, 13712.451501939811, 13126.14680045794, 13583.796243056164, 13728.862711372758, 13748.312584370942, 14494.492692755703, 9876.45679487635, 10042.297039207186, 10042.748931276776, 10083.647072352433, 10206.846897296398, 10836.187285953427, 11388.715282118013, 11409.429528523375, 11562.0, 11657.417129143678], "value": 7006.882206912889, "unit": "score"}], "name": "dromaeo_css", "value": 7496.369913245306, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 111.0, 111.0, 111.0, 110.0, 106.0, 112.0, 111.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 126.0, 154.0, 175.0, 126.0, 159.0, 156.0, 129.0, 194.0, 134.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 162.0, 162.0, 161.0, 160.0, 160.0, 159.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 75.0, 172.0, 73.0, 77.0, 76.0, 77.0, 156.0, 76.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 156.0, 92.0, 91.0, 92.0, 138.0, 92.0, 92.0, 150.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 144.0, 145.0, 146.0, 145.0, 144.0, 146.0, 146.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 55.0, 54.0, 55.0, 71.0, 53.0, 52.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 58.0, 58.0, 57.0, 57.0, 57.0, 58.0, 58.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 73.0, 74.0, 76.0, 75.0, 75.0, 74.0, 74.0, 77.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 113.0, 110.0, 113.0, 113.0, 126.0, 112.0, 172.0, 113.0], "value": 120.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 157.0, 156.0, 155.0, 155.0, 155.0, 160.0, 163.0, 161.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 65.0, 68.0, 66.0, 67.0, 64.0, 64.0, 67.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1513.3, "alertThreshold": 2.0}]} 10:31:57 INFO - Return code: 0 10:31:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:31:57 ERROR - # TBPL SUCCESS # 10:31:57 INFO - Running post-action listener: _resource_record_post_action 10:31:57 INFO - Running post-run listener: _resource_record_post_run 10:31:58 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 262144; Write bytes: 496664576; Read time: 12; Write time: 1361468 10:31:58 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 248766464; Read time: 0; Write time: 720260 10:31:58 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247898112; Read time: 12; Write time: 641208 10:31:58 INFO - Running post-run listener: _upload_blobber_files 10:31:58 INFO - Blob upload gear active. 10:31:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:31: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 10:31: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'] 10:31: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 10:31:58 INFO - (blobuploader) - INFO - Open directory for files ... 10:31:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:31:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:31:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:59 INFO - (blobuploader) - INFO - Done attempting. 10:31:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:31:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:32:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:00 INFO - (blobuploader) - INFO - Done attempting. 10:32:00 INFO - (blobuploader) - INFO - Iteration through files over. 10:32:00 INFO - Return code: 0 10:32:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:32:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:32:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/403476cdb5c896f2e9843b75ff6c9013cd0b0f60a3b6911a4d6b7fbfc8cfbcdff6f24bca040c07674f6046fc157f8de27ae5570316ba3784d8777a05fadeaadb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f20c46eb905822d39dc73488f24669e6b5eb505fe9c47ae1c996a422a5d74a37ab9f004a88e2fa53a2d1c214b4bbec096090e4e87a0a073fcc60157220f6a749"} 10:32:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:32:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:32:00 INFO - Contents: 10:32:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/403476cdb5c896f2e9843b75ff6c9013cd0b0f60a3b6911a4d6b7fbfc8cfbcdff6f24bca040c07674f6046fc157f8de27ae5570316ba3784d8777a05fadeaadb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f20c46eb905822d39dc73488f24669e6b5eb505fe9c47ae1c996a422a5d74a37ab9f004a88e2fa53a2d1c214b4bbec096090e4e87a0a073fcc60157220f6a749"} 10:32:00 INFO - Running post-run listener: copy_logs_to_upload_dir 10:32:00 INFO - Copying logs to upload dir... 10:32:00 INFO - mkdir: /builds/slave/test/build/upload/logs 10:32:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.302259 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-11 10:32:00.218153) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 10:32:00.222019) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936 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/403476cdb5c896f2e9843b75ff6c9013cd0b0f60a3b6911a4d6b7fbfc8cfbcdff6f24bca040c07674f6046fc157f8de27ae5570316ba3784d8777a05fadeaadb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f20c46eb905822d39dc73488f24669e6b5eb505fe9c47ae1c996a422a5d74a37ab9f004a88e2fa53a2d1c214b4bbec096090e4e87a0a073fcc60157220f6a749"} build_url:https://queue.taskcluster.net/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/QMMqA1sgRPWU5PIH2Uos0Q/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/403476cdb5c896f2e9843b75ff6c9013cd0b0f60a3b6911a4d6b7fbfc8cfbcdff6f24bca040c07674f6046fc157f8de27ae5570316ba3784d8777a05fadeaadb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f20c46eb905822d39dc73488f24669e6b5eb505fe9c47ae1c996a422a5d74a37ab9f004a88e2fa53a2d1c214b4bbec096090e4e87a0a073fcc60157220f6a749"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 10:32:00.247052) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 10:32:00.247422) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462986687.849358-122910936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004353 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 10:32:00.330383) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 10:32:00.330747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 10:32:00.331112) ========= ========= Total master_lag: 0.18 =========