builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1464651392.93 results: success (0) buildid: 20160526140250 builduid: 01574422c30242cc92a6c0b32dab29da revision: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:32.928562) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:32.928977) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:32.929259) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.085841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.086111) ========= 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=00204705a9daa57ed339a427000001b9-1464650967.489673-82199005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 16:36:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.3M=0s 2016-05-30 16:36:33 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103796 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.210990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.211271) ========= 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=00204705a9daa57ed339a427000001b9-1464650967.489673-82199005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022777 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.274082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:36:33.274574) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2ee4473c729acb2ba7dc723e7affe79ce14bff85 --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-beta --rev 2ee4473c729acb2ba7dc723e7affe79ce14bff85 --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=00204705a9daa57ed339a427000001b9-1464650967.489673-82199005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 16:36:33,374 truncating revision to first 12 chars 2016-05-30 16:36:33,374 Setting DEBUG logging. 2016-05-30 16:36:33,374 attempt 1/10 2016-05-30 16:36:33,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2ee4473c729a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 16:36:34,295 unpacking tar archive at: mozilla-beta-2ee4473c729a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.263267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:36:34.562045) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:34.562377) ========= script_repo_revision: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:34.562806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:34.563081) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:34.572301) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-05-30 16:36:34.572603) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=00204705a9daa57ed339a427000001b9-1464650967.489673-82199005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:36:34 INFO - MultiFileLogger online at 20160530 16:36:34 in /builds/slave/test 16:36:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:36:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:36:34 INFO - {'append_to_log': False, 16:36:34 INFO - 'base_work_dir': '/builds/slave/test', 16:36:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:36:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:36:34 INFO - 'branch': 'Mozilla-Beta', 16:36:34 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:34 INFO - 'config_files': ('talos/linux_config.py',), 16:36:34 INFO - 'default_actions': ('clobber', 16:36:34 INFO - 'read-buildbot-config', 16:36:34 INFO - 'download-and-extract', 16:36:34 INFO - 'populate-webroot', 16:36:34 INFO - 'create-virtualenv', 16:36:34 INFO - 'install', 16:36:34 INFO - 'run-tests'), 16:36:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:34 INFO - 'download_minidump_stackwalk': True, 16:36:34 INFO - 'download_symbols': 'ondemand', 16:36:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:36:34 INFO - 'tooltool.py': '/tools/tooltool.py', 16:36:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:36:34 INFO - '/tools/misc-python/virtualenv.py')}, 16:36:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:34 INFO - 'installer_path': 'installer.exe', 16:36:34 INFO - 'log_level': 'info', 16:36:34 INFO - 'log_name': 'talos', 16:36:34 INFO - 'log_to_console': True, 16:36:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:36:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:36:34 INFO - 'opt_config_files': (), 16:36:34 INFO - 'pip_index': False, 16:36:34 INFO - 'sps_profile': False, 16:36:34 INFO - 'sps_profile_interval': 0, 16:36:34 INFO - 'suite': 'dromaeojs', 16:36:34 INFO - 'system_bits': '32', 16:36:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:34 INFO - 'title': 'talos-linux64-ix-016', 16:36:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:36:34 INFO - 'use_talos_json': True, 16:36:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:36:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:34 INFO - 'work_dir': 'build'} 16:36:34 INFO - ##### 16:36:34 INFO - ##### Running clobber step. 16:36:34 INFO - ##### 16:36:34 INFO - Running pre-action listener: _resource_record_pre_action 16:36:34 INFO - Running main action method: clobber 16:36:34 INFO - rmtree: /builds/slave/test/build 16:36:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:36:35 INFO - Running post-action listener: _resource_record_post_action 16:36:35 INFO - ##### 16:36:35 INFO - ##### Running read-buildbot-config step. 16:36:35 INFO - ##### 16:36:35 INFO - Running pre-action listener: _resource_record_pre_action 16:36:35 INFO - Running main action method: read_buildbot_config 16:36:35 INFO - Using buildbot properties: 16:36:35 INFO - { 16:36:35 INFO - "project": "", 16:36:35 INFO - "product": "firefox", 16:36:35 INFO - "script_repo_revision": "production", 16:36:35 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 16:36:35 INFO - "repository": "", 16:36:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 16:36:35 INFO - "buildid": "20160526140250", 16:36:35 INFO - "pgo_build": "True", 16:36:35 INFO - "basedir": "/builds/slave/test", 16:36:35 INFO - "buildnumber": 111, 16:36:35 INFO - "slavename": "talos-linux64-ix-016", 16:36:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:36:35 INFO - "platform": "ubuntu64_hw", 16:36:35 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:36:35 INFO - "branch": "mozilla-beta", 16:36:35 INFO - "repo_path": "releases/mozilla-beta", 16:36:35 INFO - "revision": "2ee4473c729acb2ba7dc723e7affe79ce14bff85", 16:36:35 INFO - "stage_platform": "linux64-pgo", 16:36:35 INFO - "builduid": "01574422c30242cc92a6c0b32dab29da", 16:36:35 INFO - "slavebuilddir": "test" 16:36:35 INFO - } 16:36:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 16:36:35 INFO - Running post-action listener: _resource_record_post_action 16:36:35 INFO - ##### 16:36:35 INFO - ##### Running download-and-extract step. 16:36:35 INFO - ##### 16:36:35 INFO - Running pre-action listener: _resource_record_pre_action 16:36:35 INFO - Running main action method: download_and_extract 16:36:35 INFO - mkdir: /builds/slave/test/build/tests 16:36: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')]} 16:36:35 INFO - https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:36:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:36:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:36:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:36:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:36:43 INFO - Downloaded 1412 bytes. 16:36:43 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:36:43 INFO - Using the following test package requirements: 16:36:43 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:36:43 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:43 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:36:43 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:43 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 16:36:43 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:43 INFO - u'jsshell-linux-x86_64.zip'], 16:36:43 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:43 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:36:43 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:36:43 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:43 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 16:36:43 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:43 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 16:36:43 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:43 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:36:43 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:36:43 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:43 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:36:43 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:43 INFO - https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:36:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:36:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:36:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:36:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:36:46 INFO - Downloaded 23434470 bytes. 16:36:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:36:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:36:48 INFO - Return code: 0 16:36:48 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:48 INFO - https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:36:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:36:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:36:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:37:18 INFO - Downloaded 23434470 bytes. 16:37:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:37:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:37:20 INFO - Return code: 0 16:37:20 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')]} 16:37:20 INFO - https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:37:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:37:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:37:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:37:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:37:20 INFO - Downloaded 10845194 bytes. 16:37:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:37:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:37:21 INFO - Return code: 0 16:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:21 INFO - https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:37:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:37:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:37:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:37:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:37:22 INFO - Downloaded 53860430 bytes. 16:37:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:37:22 INFO - mkdir: /builds/slave/test/properties 16:37:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:37:22 INFO - Writing to file /builds/slave/test/properties/build_url 16:37:22 INFO - Contents: 16:37:22 INFO - build_url:https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:37:23 INFO - Running post-action listener: _resource_record_post_action 16:37:23 INFO - Running post-action listener: set_extra_try_arguments 16:37:23 INFO - ##### 16:37:23 INFO - ##### Running populate-webroot step. 16:37:23 INFO - ##### 16:37:23 INFO - Running pre-action listener: _resource_record_pre_action 16:37:23 INFO - Running main action method: populate_webroot 16:37:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:37:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:37:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:37:23 INFO - '--tppagecycles', 16:37:23 INFO - '7'], 16:37:23 INFO - 'tests': ['tsvgm']}}, 16:37:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:37:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:37:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:37:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:37:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:37:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:37:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'talos_options': ['--e10s'], 16:37:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'tests': ['damp', 'tps']}, 16:37:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'talos_options': ['--e10s'], 16:37:23 INFO - 'tests': ['damp', 'tps']}, 16:37:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:37:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:37:23 INFO - 'other': {'tests': ['a11yr', 16:37:23 INFO - 'ts_paint', 16:37:23 INFO - 'tpaint', 16:37:23 INFO - 'sessionrestore', 16:37:23 INFO - 'sessionrestore_no_auto_restore', 16:37:23 INFO - 'tabpaint']}, 16:37:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:37:23 INFO - 'tests': ['a11yr', 16:37:23 INFO - 'ts_paint', 16:37:23 INFO - 'tpaint', 16:37:23 INFO - 'sessionrestore', 16:37:23 INFO - 'sessionrestore_no_auto_restore', 16:37:23 INFO - 'tabpaint']}, 16:37:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:37:23 INFO - 'tests': ['a11yr', 16:37:23 INFO - 'ts_paint', 16:37:23 INFO - 'tpaint', 16:37:23 INFO - 'sessionrestore', 16:37:23 INFO - 'sessionrestore_no_auto_restore', 16:37:23 INFO - 'tabpaint']}, 16:37:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:37:23 INFO - 'tests': ['a11yr', 16:37:23 INFO - 'ts_paint', 16:37:23 INFO - 'tpaint', 16:37:23 INFO - 'sessionrestore', 16:37:23 INFO - 'sessionrestore_no_auto_restore', 16:37:23 INFO - 'tabpaint']}, 16:37:23 INFO - 'other_l64': {'tests': ['a11yr', 16:37:23 INFO - 'ts_paint', 16:37:23 INFO - 'tpaint', 16:37:23 INFO - 'sessionrestore', 16:37:23 INFO - 'sessionrestore_no_auto_restore', 16:37:23 INFO - 'tabpaint']}, 16:37:23 INFO - 'other_nol64': {'tests': ['a11yr', 16:37:23 INFO - 'ts_paint', 16:37:23 INFO - 'tpaint', 16:37:23 INFO - 'sessionrestore', 16:37:23 INFO - 'sessionrestore_no_auto_restore', 16:37:23 INFO - 'tabpaint']}, 16:37:23 INFO - 'svgr': {'tests': ['tsvgx', 16:37:23 INFO - 'tsvgr_opacity', 16:37:23 INFO - 'tart', 16:37:23 INFO - 'tscrollx', 16:37:23 INFO - 'cart']}, 16:37:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:37:23 INFO - 'tests': ['tsvgx', 16:37:23 INFO - 'tsvgr_opacity', 16:37:23 INFO - 'tart', 16:37:23 INFO - 'tscrollx', 16:37:23 INFO - 'cart']}, 16:37:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'tests': ['tp5o']}, 16:37:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'talos_options': ['--e10s'], 16:37:23 INFO - 'tests': ['tp5o']}, 16:37:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'talos_options': ['--xperf_path', 16:37:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:23 INFO - 'tests': ['tp5n']}, 16:37:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'talos_options': ['--e10s', 16:37:23 INFO - '--xperf_path', 16:37:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:23 INFO - 'tests': ['tp5n']}}, 16:37:23 INFO - 'talos.zip': {'path': '', 16:37:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:37:23 INFO - Running post-action listener: _resource_record_post_action 16:37:23 INFO - ##### 16:37:23 INFO - ##### Running create-virtualenv step. 16:37:23 INFO - ##### 16:37:23 INFO - Running pre-action listener: _resource_record_pre_action 16:37:23 INFO - Running main action method: create_virtualenv 16:37:23 INFO - Creating virtualenv /builds/slave/test/build/venv 16:37:23 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 16:37:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:37:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:37:23 INFO - Using real prefix '/usr' 16:37:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:37:23 INFO - Installing distribute.............................................................................................................................................................................................done. 16:37:25 INFO - Installing pip.................done. 16:37:25 INFO - Return code: 0 16:37:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8eebc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2105160>, '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 0x2106060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21064f0>, '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': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', '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 16:37:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:37:25 INFO - Using env: {'DISPLAY': ':0', 16:37:25 INFO - 'HOME': '/home/cltbld', 16:37:25 INFO - 'LANG': 'en_US.UTF-8', 16:37:25 INFO - 'LANGUAGE': 'en_US:en', 16:37:25 INFO - 'LOGNAME': 'cltbld', 16:37:25 INFO - 'MAIL': '/var/mail/cltbld', 16:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:25 INFO - 'MOZ_NO_REMOTE': '1', 16:37:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:25 INFO - 'NO_EM_RESTART': '1', 16:37:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:25 INFO - 'PWD': '/builds/slave/test', 16:37:25 INFO - 'SHELL': '/bin/bash', 16:37:25 INFO - 'SHLVL': '1', 16:37:25 INFO - 'TERM': 'linux', 16:37:25 INFO - 'TMOUT': '86400', 16:37:25 INFO - 'USER': 'cltbld', 16:37:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', 16:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:25 INFO - '_': '/tools/buildbot/bin/python'} 16:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:26 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 16:37:26 INFO - Cleaning up... 16:37:26 INFO - Return code: 0 16:37:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:37:26 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')]} 16:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:26 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')]} 16:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:26 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 0x7ff8eebc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2105160>, '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 0x2106060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21064f0>, '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': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', '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 16:37:26 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 16:37:26 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 16:37:26 INFO - Using env: {'DISPLAY': ':0', 16:37:26 INFO - 'HOME': '/home/cltbld', 16:37:26 INFO - 'LANG': 'en_US.UTF-8', 16:37:26 INFO - 'LANGUAGE': 'en_US:en', 16:37:26 INFO - 'LOGNAME': 'cltbld', 16:37:26 INFO - 'MAIL': '/var/mail/cltbld', 16:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:26 INFO - 'MOZ_NO_REMOTE': '1', 16:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:26 INFO - 'NO_EM_RESTART': '1', 16:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:26 INFO - 'PWD': '/builds/slave/test', 16:37:26 INFO - 'SHELL': '/bin/bash', 16:37:26 INFO - 'SHLVL': '1', 16:37:26 INFO - 'TERM': 'linux', 16:37:26 INFO - 'TMOUT': '86400', 16:37:26 INFO - 'USER': 'cltbld', 16:37:26 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', 16:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:26 INFO - '_': '/tools/buildbot/bin/python'} 16:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:26 INFO - Downloading/unpacking psutil>=0.7.1 16:37:26 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 16:37:26 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 16:37:26 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 16:37:26 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 16:37:26 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 16:37:26 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 16:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:37:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:28 INFO - Installing collected packages: psutil 16:37:28 INFO - Running setup.py install for psutil 16:37:28 INFO - building 'psutil._psutil_linux' extension 16:37:28 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 16:37:28 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 16:37:28 INFO - building 'psutil._psutil_posix' extension 16:37:28 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 16:37:28 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 16:37:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:28 INFO - Successfully installed psutil 16:37:28 INFO - Cleaning up... 16:37:28 INFO - Return code: 0 16:37:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff8eebc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2105160>, '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 0x2106060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21064f0>, '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': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', '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 16:37:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:37:28 INFO - Using env: {'DISPLAY': ':0', 16:37:28 INFO - 'HOME': '/home/cltbld', 16:37:28 INFO - 'LANG': 'en_US.UTF-8', 16:37:28 INFO - 'LANGUAGE': 'en_US:en', 16:37:28 INFO - 'LOGNAME': 'cltbld', 16:37:28 INFO - 'MAIL': '/var/mail/cltbld', 16:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:28 INFO - 'MOZ_NO_REMOTE': '1', 16:37:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:28 INFO - 'NO_EM_RESTART': '1', 16:37:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:28 INFO - 'PWD': '/builds/slave/test', 16:37:28 INFO - 'SHELL': '/bin/bash', 16:37:28 INFO - 'SHLVL': '1', 16:37:28 INFO - 'TERM': 'linux', 16:37:28 INFO - 'TMOUT': '86400', 16:37:28 INFO - 'USER': 'cltbld', 16:37:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', 16:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:28 INFO - '_': '/tools/buildbot/bin/python'} 16:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:37:29 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 16:37:29 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 16:37:29 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 16:37:29 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 16:37:29 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 16:37:29 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 16:37:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:37:31 INFO - Installing collected packages: mozsystemmonitor 16:37:31 INFO - Running setup.py install for mozsystemmonitor 16:37:31 INFO - Successfully installed mozsystemmonitor 16:37:31 INFO - Cleaning up... 16:37:31 INFO - Return code: 0 16:37:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:31 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 0x7ff8eebc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2105160>, '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 0x2106060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21064f0>, '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': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', '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 16:37:31 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 16:37:31 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 16:37:31 INFO - Using env: {'DISPLAY': ':0', 16:37:31 INFO - 'HOME': '/home/cltbld', 16:37:31 INFO - 'LANG': 'en_US.UTF-8', 16:37:31 INFO - 'LANGUAGE': 'en_US:en', 16:37:31 INFO - 'LOGNAME': 'cltbld', 16:37:31 INFO - 'MAIL': '/var/mail/cltbld', 16:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:31 INFO - 'MOZ_NO_REMOTE': '1', 16:37:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:31 INFO - 'NO_EM_RESTART': '1', 16:37:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:31 INFO - 'PWD': '/builds/slave/test', 16:37:31 INFO - 'SHELL': '/bin/bash', 16:37:31 INFO - 'SHLVL': '1', 16:37:31 INFO - 'TERM': 'linux', 16:37:31 INFO - 'TMOUT': '86400', 16:37:31 INFO - 'USER': 'cltbld', 16:37:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', 16:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:31 INFO - '_': '/tools/buildbot/bin/python'} 16:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:31 INFO - Downloading/unpacking blobuploader==1.2.4 16:37:31 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 16:37:31 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 16:37:31 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 16:37:31 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 16:37:31 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 16:37:31 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 16:37:33 INFO - Downloading blobuploader-1.2.4.tar.gz 16:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:37:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:37:33 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 16:37:33 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 16:37:33 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 16:37:33 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 16:37:33 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 16:37:33 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 16:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:37:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:37:33 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 16:37:33 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 16:37:33 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 16:37:33 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 16:37:33 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 16:37:33 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 16:37:33 INFO - Downloading docopt-0.6.1.tar.gz 16:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:37:34 INFO - Installing collected packages: blobuploader, requests, docopt 16:37:34 INFO - Running setup.py install for blobuploader 16:37:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:37:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:37:34 INFO - Running setup.py install for requests 16:37:34 INFO - Running setup.py install for docopt 16:37:34 INFO - Successfully installed blobuploader requests docopt 16:37:34 INFO - Cleaning up... 16:37:34 INFO - Return code: 0 16:37:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:34 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')]} 16:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:34 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')]} 16:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:34 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 0x7ff8eebc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2105160>, '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 0x2106060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21064f0>, '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': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', '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 16:37:34 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 16:37:34 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 16:37:34 INFO - Using env: {'DISPLAY': ':0', 16:37:34 INFO - 'HOME': '/home/cltbld', 16:37:34 INFO - 'LANG': 'en_US.UTF-8', 16:37:34 INFO - 'LANGUAGE': 'en_US:en', 16:37:34 INFO - 'LOGNAME': 'cltbld', 16:37:34 INFO - 'MAIL': '/var/mail/cltbld', 16:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:34 INFO - 'MOZ_NO_REMOTE': '1', 16:37:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:34 INFO - 'NO_EM_RESTART': '1', 16:37:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:34 INFO - 'PWD': '/builds/slave/test', 16:37:34 INFO - 'SHELL': '/bin/bash', 16:37:34 INFO - 'SHLVL': '1', 16:37:34 INFO - 'TERM': 'linux', 16:37:34 INFO - 'TMOUT': '86400', 16:37:34 INFO - 'USER': 'cltbld', 16:37:34 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', 16:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:34 INFO - '_': '/tools/buildbot/bin/python'} 16:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:34 INFO - Running setup.py (path:/tmp/pip-0K5Xi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:34 INFO - Running setup.py (path:/tmp/pip-2jp61O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:35 INFO - Running setup.py (path:/tmp/pip-TW7Qb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:35 INFO - Running setup.py (path:/tmp/pip-RvNsNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:35 INFO - Running setup.py (path:/tmp/pip-WZi3Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:35 INFO - Running setup.py (path:/tmp/pip-nDauKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:35 INFO - Running setup.py (path:/tmp/pip-HFTxZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:35 INFO - Running setup.py (path:/tmp/pip-F1X8GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:35 INFO - Running setup.py (path:/tmp/pip-q4LvvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:35 INFO - Running setup.py (path:/tmp/pip-ENNsuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:35 INFO - Running setup.py (path:/tmp/pip-HegXoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:35 INFO - Running setup.py (path:/tmp/pip-p6oVFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:35 INFO - Running setup.py (path:/tmp/pip-x1VYAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:35 INFO - Running setup.py (path:/tmp/pip-IPUKz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:35 INFO - Running setup.py (path:/tmp/pip-COdWAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:35 INFO - Running setup.py (path:/tmp/pip-XNXU8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:36 INFO - Running setup.py (path:/tmp/pip-sXaV3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:37:36 INFO - Running setup.py install for manifestparser 16:37:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:37:36 INFO - Running setup.py install for mozcrash 16:37:36 INFO - Running setup.py install for mozdebug 16:37:36 INFO - Running setup.py install for mozdevice 16:37:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:37:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:37:36 INFO - Running setup.py install for mozfile 16:37:36 INFO - Running setup.py install for mozhttpd 16:37:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:37:36 INFO - Running setup.py install for mozinfo 16:37:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:37:36 INFO - Running setup.py install for mozInstall 16:37:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:37:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:37:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:37:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:37:36 INFO - Running setup.py install for mozleak 16:37:36 INFO - Running setup.py install for mozlog 16:37:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:37:37 INFO - Running setup.py install for moznetwork 16:37:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:37:37 INFO - Running setup.py install for mozprocess 16:37:37 INFO - Running setup.py install for mozprofile 16:37:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:37:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:37:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:37:37 INFO - Running setup.py install for mozrunner 16:37:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:37:37 INFO - Running setup.py install for mozscreenshot 16:37:37 INFO - Running setup.py install for moztest 16:37:37 INFO - Running setup.py install for mozversion 16:37:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:37:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:37:37 INFO - Cleaning up... 16:37:37 INFO - Return code: 0 16:37:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:37 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 0x7ff8eebc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2105160>, '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 0x2106060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21064f0>, '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': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', '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 16:37:37 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 16:37:37 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 16:37:37 INFO - Using env: {'DISPLAY': ':0', 16:37:37 INFO - 'HOME': '/home/cltbld', 16:37:37 INFO - 'LANG': 'en_US.UTF-8', 16:37:37 INFO - 'LANGUAGE': 'en_US:en', 16:37:37 INFO - 'LOGNAME': 'cltbld', 16:37:37 INFO - 'MAIL': '/var/mail/cltbld', 16:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:37 INFO - 'MOZ_NO_REMOTE': '1', 16:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:37 INFO - 'NO_EM_RESTART': '1', 16:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:37 INFO - 'PWD': '/builds/slave/test', 16:37:37 INFO - 'SHELL': '/bin/bash', 16:37:37 INFO - 'SHLVL': '1', 16:37:37 INFO - 'TERM': 'linux', 16:37:37 INFO - 'TMOUT': '86400', 16:37:37 INFO - 'USER': 'cltbld', 16:37:37 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', 16:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:37 INFO - '_': '/tools/buildbot/bin/python'} 16:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:38 INFO - Running setup.py (path:/tmp/pip-LQTUmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:38 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)) 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:38 INFO - Running setup.py (path:/tmp/pip-6vLU6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:38 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)) 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:38 INFO - Running setup.py (path:/tmp/pip-sttzzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:38 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)) 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:38 INFO - Running setup.py (path:/tmp/pip-FPp4G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:38 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)) 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:38 INFO - Running setup.py (path:/tmp/pip-jU2k3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:38 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)) 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:38 INFO - Running setup.py (path:/tmp/pip-8G9FBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:38 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)) 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:38 INFO - Running setup.py (path:/tmp/pip-SpHsYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:38 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)) 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:38 INFO - Running setup.py (path:/tmp/pip-LCzCBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:38 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)) 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:38 INFO - Running setup.py (path:/tmp/pip-t_KWf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:38 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)) 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:38 INFO - Running setup.py (path:/tmp/pip-fHtt0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:38 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)) 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:38 INFO - Running setup.py (path:/tmp/pip-ykK8S_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:38 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)) 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:38 INFO - Running setup.py (path:/tmp/pip-QL55V8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:38 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)) 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:38 INFO - Running setup.py (path:/tmp/pip-nok_qS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:39 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)) 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:39 INFO - Running setup.py (path:/tmp/pip-OccLqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:39 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)) 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:39 INFO - Running setup.py (path:/tmp/pip-a2WWlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:39 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)) 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:39 INFO - Running setup.py (path:/tmp/pip-NHhFoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:39 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)) 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:39 INFO - Running setup.py (path:/tmp/pip-j_fgLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:39 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)) 16:37:39 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)) 16:37:39 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)) 16:37:39 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)) 16:37:39 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)) 16:37:39 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)) 16:37:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:39 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 16:37:39 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 16:37:39 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 16:37:39 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 16:37:39 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 16:37:39 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 16:37:41 INFO - Downloading blessings-1.6.tar.gz 16:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:37:41 INFO - Installing collected packages: blessings 16:37:41 INFO - Running setup.py install for blessings 16:37:41 INFO - Successfully installed blessings 16:37:41 INFO - Cleaning up... 16:37:41 INFO - Return code: 0 16:37:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:41 INFO - Reading from file tmpfile_stdout 16:37:41 INFO - Current package versions: 16:37:41 INFO - argparse == 1.2.1 16:37:41 INFO - blessings == 1.6 16:37:41 INFO - blobuploader == 1.2.4 16:37:41 INFO - docopt == 0.6.1 16:37:41 INFO - manifestparser == 1.1 16:37:41 INFO - mozInstall == 1.12 16:37:41 INFO - mozcrash == 0.17 16:37:41 INFO - mozdebug == 0.1 16:37:41 INFO - mozdevice == 0.48 16:37:41 INFO - mozfile == 1.2 16:37:41 INFO - mozhttpd == 0.7 16:37:41 INFO - mozinfo == 0.9 16:37:41 INFO - mozleak == 0.1 16:37:41 INFO - mozlog == 3.1 16:37:41 INFO - moznetwork == 0.27 16:37:41 INFO - mozprocess == 0.22 16:37:41 INFO - mozprofile == 0.28 16:37:41 INFO - mozrunner == 6.11 16:37:41 INFO - mozscreenshot == 0.1 16:37:41 INFO - mozsystemmonitor == 0.0 16:37:41 INFO - moztest == 0.7 16:37:41 INFO - mozversion == 1.4 16:37:41 INFO - psutil == 3.1.1 16:37:41 INFO - requests == 1.2.3 16:37:41 INFO - wsgiref == 0.1.2 16:37:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:41 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 0x7ff8eebc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2105160>, '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 0x2106060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21064f0>, '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': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', '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 16:37:41 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 16:37:41 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 16:37:41 INFO - Using env: {'DISPLAY': ':0', 16:37:41 INFO - 'HOME': '/home/cltbld', 16:37:41 INFO - 'LANG': 'en_US.UTF-8', 16:37:41 INFO - 'LANGUAGE': 'en_US:en', 16:37:41 INFO - 'LOGNAME': 'cltbld', 16:37:41 INFO - 'MAIL': '/var/mail/cltbld', 16:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:41 INFO - 'MOZ_NO_REMOTE': '1', 16:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:41 INFO - 'NO_EM_RESTART': '1', 16:37:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:41 INFO - 'PWD': '/builds/slave/test', 16:37:41 INFO - 'SHELL': '/bin/bash', 16:37:41 INFO - 'SHLVL': '1', 16:37:41 INFO - 'TERM': 'linux', 16:37:41 INFO - 'TMOUT': '86400', 16:37:41 INFO - 'USER': 'cltbld', 16:37:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', 16:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:41 INFO - '_': '/tools/buildbot/bin/python'} 16:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:41 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)) 16:37:41 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)) 16:37:41 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)) 16:37:41 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)) 16:37:41 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)) 16:37:41 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)) 16:37:41 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)) 16:37:41 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)) 16:37:41 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)) 16:37:41 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)) 16:37:41 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)) 16:37:41 INFO - Cleaning up... 16:37:41 INFO - Return code: 0 16:37:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:41 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 0x7ff8eebc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2105160>, '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 0x2106060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21064f0>, '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': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', '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 16:37:41 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 16:37:41 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 16:37:41 INFO - Using env: {'DISPLAY': ':0', 16:37:41 INFO - 'HOME': '/home/cltbld', 16:37:41 INFO - 'LANG': 'en_US.UTF-8', 16:37:41 INFO - 'LANGUAGE': 'en_US:en', 16:37:41 INFO - 'LOGNAME': 'cltbld', 16:37:41 INFO - 'MAIL': '/var/mail/cltbld', 16:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:41 INFO - 'MOZ_NO_REMOTE': '1', 16:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:41 INFO - 'NO_EM_RESTART': '1', 16:37:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:41 INFO - 'PWD': '/builds/slave/test', 16:37:41 INFO - 'SHELL': '/bin/bash', 16:37:41 INFO - 'SHLVL': '1', 16:37:41 INFO - 'TERM': 'linux', 16:37:41 INFO - 'TMOUT': '86400', 16:37:41 INFO - 'USER': 'cltbld', 16:37:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', 16:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:41 INFO - '_': '/tools/buildbot/bin/python'} 16:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:42 INFO - Downloading/unpacking jsonschema 16:37:42 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 16:37:42 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 16:37:42 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 16:37:42 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 16:37:42 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 16:37:42 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 16:37:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:37:43 INFO - Downloading/unpacking functools32 (from jsonschema) 16:37:43 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 16:37:43 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 16:37:43 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 16:37:43 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 16:37:43 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 16:37:43 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 16:37:44 INFO - Downloading functools32-3.2.3-2.tar.gz 16:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:37:44 INFO - warning: no files found matching '*.txt' 16:37:44 INFO - no previously-included directories found matching 'build' 16:37:44 INFO - no previously-included directories found matching 'dist' 16:37:44 INFO - no previously-included directories found matching '.git*' 16:37:44 INFO - Installing collected packages: jsonschema, functools32 16:37:44 INFO - Running setup.py install for functools32 16:37:44 INFO - warning: no files found matching '*.txt' 16:37:44 INFO - no previously-included directories found matching 'build' 16:37:44 INFO - no previously-included directories found matching 'dist' 16:37:44 INFO - no previously-included directories found matching '.git*' 16:37:44 INFO - Successfully installed jsonschema functools32 16:37:44 INFO - Cleaning up... 16:37:44 INFO - Return code: 0 16:37:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8eebc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2076410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2105160>, '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 0x2106060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21064f0>, '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': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', '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 16:37: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', 'flake8'] in /builds/slave/test/build 16:37: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 flake8 16:37:44 INFO - Using env: {'DISPLAY': ':0', 16:37:44 INFO - 'HOME': '/home/cltbld', 16:37:44 INFO - 'LANG': 'en_US.UTF-8', 16:37:44 INFO - 'LANGUAGE': 'en_US:en', 16:37:44 INFO - 'LOGNAME': 'cltbld', 16:37:44 INFO - 'MAIL': '/var/mail/cltbld', 16:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:44 INFO - 'MOZ_NO_REMOTE': '1', 16:37:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:44 INFO - 'NO_EM_RESTART': '1', 16:37:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:44 INFO - 'PWD': '/builds/slave/test', 16:37:44 INFO - 'SHELL': '/bin/bash', 16:37:44 INFO - 'SHLVL': '1', 16:37:44 INFO - 'TERM': 'linux', 16:37:44 INFO - 'TMOUT': '86400', 16:37:44 INFO - 'USER': 'cltbld', 16:37:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', 16:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:44 INFO - '_': '/tools/buildbot/bin/python'} 16:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:44 INFO - Downloading/unpacking flake8 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:37:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:37:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 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 16:37:46 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 16:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:37:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:47 INFO - no previously-included directories found matching 'docs/_build' 16:37:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:37:47 INFO - Running setup.py install for pep8 16:37:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:47 INFO - no previously-included directories found matching 'docs/_build' 16:37:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:37:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:37:47 INFO - Cleaning up... 16:37:47 INFO - Return code: 0 16:37:47 INFO - Running post-action listener: _resource_record_post_action 16:37:47 INFO - Running post-action listener: _start_resource_monitoring 16:37:47 INFO - Starting resource monitoring. 16:37:47 INFO - ##### 16:37:47 INFO - ##### Running install step. 16:37:47 INFO - ##### 16:37:47 INFO - Running pre-action listener: _resource_record_pre_action 16:37:47 INFO - Running main action method: install 16:37:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:47 INFO - Reading from file tmpfile_stdout 16:37:47 INFO - Detecting whether we're running mozinstall >=1.0... 16:37:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:37:47 INFO - Reading from file tmpfile_stdout 16:37:47 INFO - Output received: 16:37:47 INFO - Usage: mozinstall [options] installer 16:37:47 INFO - Options: 16:37:47 INFO - -h, --help show this help message and exit 16:37:47 INFO - -d DEST, --destination=DEST 16:37:47 INFO - Directory to install application into. [default: 16:37:47 INFO - "/builds/slave/test"] 16:37:47 INFO - --app=APP Application being installed. [default: firefox] 16:37:47 INFO - mkdir: /builds/slave/test/build/application 16:37:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:38:00 INFO - Reading from file tmpfile_stdout 16:38:00 INFO - Output received: 16:38:00 INFO - /builds/slave/test/build/application/firefox/firefox 16:38:00 INFO - Running post-action listener: _resource_record_post_action 16:38:00 INFO - ##### 16:38:00 INFO - ##### Running run-tests step. 16:38:00 INFO - ##### 16:38:00 INFO - Running pre-action listener: _resource_record_pre_action 16:38:00 INFO - Running main action method: run_tests 16:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:38:00 INFO - Python 2.7.3 16:38:00 INFO - Return code: 0 16:38:00 INFO - grabbing minidump binary from tooltool 16:38: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')]} 16:38:00 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 0x2105160>, '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 0x2106060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21064f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:38:00 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 16:38:00 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 16:38:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:00 INFO - Return code: 0 16:38:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:38:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:38:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:38:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:38:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:38:01 INFO - Return code: 0 16:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 16:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 16:38:01 INFO - Using env: {'DISPLAY': ':0', 16:38:01 INFO - 'HOME': '/home/cltbld', 16:38:01 INFO - 'LANG': 'en_US.UTF-8', 16:38:01 INFO - 'LANGUAGE': 'en_US:en', 16:38:01 INFO - 'LOGNAME': 'cltbld', 16:38:01 INFO - 'MAIL': '/var/mail/cltbld', 16:38:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:38:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:01 INFO - 'MOZ_NO_REMOTE': '1', 16:38:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:01 INFO - 'NO_EM_RESTART': '1', 16:38:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:01 INFO - 'PWD': '/builds/slave/test', 16:38:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:38:01 INFO - 'SHELL': '/bin/bash', 16:38:01 INFO - 'SHLVL': '1', 16:38:01 INFO - 'TERM': 'linux', 16:38:01 INFO - 'TMOUT': '86400', 16:38:01 INFO - 'USER': 'cltbld', 16:38:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464650967.489673-82199005', 16:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:01 INFO - '_': '/tools/buildbot/bin/python'} 16:38:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 16:38:01 INFO - mozversion application_buildid: 20160526140250 16:38:01 INFO - mozversion application_changeset: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 16:38:01 INFO - mozversion application_display_name: Firefox 16:38:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:01 INFO - mozversion application_name: Firefox 16:38:01 INFO - mozversion application_remotingname: firefox 16:38:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:38:01 INFO - mozversion application_vendor: Mozilla 16:38:01 INFO - mozversion application_version: 47.0 16:38:01 INFO - mozversion platform_buildid: 20160526140250 16:38:01 INFO - mozversion platform_changeset: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 16:38:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:38:01 INFO - mozversion platform_version: 47.0 16:38:01 INFO - using testdate: 1464651481 16:38:01 INFO - actual date: 1464651481 16:38:01 INFO - starting webserver on 'localhost:44121' 16:38:01 INFO - SUITE-START | Running 2 tests 16:38:01 INFO - TEST-START | dromaeo_css 16:38:01 INFO - operating with platform_type : linux_ 16:38:01 INFO - Initialising browser for dromaeo_css test... 16:38:01 INFO - TEST-INFO | started process 20601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Oa5eU/profile http://localhost:44121/getInfo.html) 16:38:05 INFO - PROCESS | 20601 | __metrics Screen width/height:1600/1200 16:38:05 INFO - PROCESS | 20601 | colorDepth:24 16:38:05 INFO - PROCESS | 20601 | Browser inner width/height: 1024/697 16:38:05 INFO - PROCESS | 20601 | __metrics 16:38:06 INFO - PROCESS | 20601 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:38:07 INFO - TEST-INFO | 20601: exit 0 16:38:07 INFO - Browser initialized. 16:38:07 INFO - Running cycle 1/1 for dromaeo_css test... 16:38:07 INFO - TEST-INFO | started process 20693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Oa5eU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:19 INFO - PROCESS | 20693 | RSS: Main: 139206656 16:38:19 INFO - PROCESS | 20693 | 16:39:10 INFO - PROCESS | 20693 | 1464651550889 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] 16:41:18 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:44121/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44121/tests/dromaeo/cssquery-ext.html) 16:41:19 INFO - PROCESS | 20693 | RSS: Main: 216584192 16:41:19 INFO - PROCESS | 20693 | 16:44:20 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:44121/tests/dromaeo/cssquery-ext.html (next: http://localhost:44121/tests/dromaeo/cssquery-jquery.html) 16:44:21 INFO - PROCESS | 20693 | RSS: Main: 224952320 16:44:21 INFO - PROCESS | 20693 | 16:47:23 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:44121/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44121/tests/dromaeo/cssquery-mootools.html) 16:47:23 INFO - PROCESS | 20693 | RSS: Main: 214188032 16:47:23 INFO - PROCESS | 20693 | 16:50:25 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:44121/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44121/tests/dromaeo/cssquery-prototype.html) 16:50:26 INFO - PROCESS | 20693 | RSS: Main: 190996480 16:50:26 INFO - PROCESS | 20693 | 16:53:28 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:44121/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44121/tests/dromaeo/cssquery-yui.html) 16:53:29 INFO - PROCESS | 20693 | RSS: Main: 204738560 16:53:29 INFO - PROCESS | 20693 | 16:56:31 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:44121/tests/dromaeo/cssquery-yui.html (next: http://localhost:44121/tests/dromaeo/cssquery-dojo.html) 16:56:31 INFO - PROCESS | 20693 | RSS: Main: 248795136 16:56:31 INFO - PROCESS | 20693 | 16:56:31 INFO - PROCESS | 20693 | __start_tp_report 16:56:31 INFO - PROCESS | 20693 | _x_x_mozilla_page_load 16:56:31 INFO - PROCESS | 20693 | _x_x_mozilla_page_load_details 16:56:31 INFO - PROCESS | 20693 | |i|pagename|runs| 16:56:31 INFO - PROCESS | 20693 | |0;dojo.html;3270.2968861694735;3288.7697861149713;3328.417526932786;3355.144438168267;3368.4105281575717;5344.331958505187;5346.198070289459;5365.919511207335;5388.838334849951;5394.595405344595;5345.732713364336;5351.09031464651;5358.732063396834;5391.973040134803;5400;4783.665143439961;4867.0265946810605;4910.1898186799135;4981;4991.425986011601;4844.467108618049;4948.925766113512;4950.529699678525;4956.083124621957;4956.653034287601;4937.65436419449;4967.528084831935;4975.2039673652225;4975.751212439382;4999.4250661174065;4893.363862697862;4928.088303663833;5025.748712564394;5026.773795179226;5030.84907452777;4708.976455117737;4853.320535125085;4872.269159626049;4918.360613120307;4942.332785074005;5081.5426611605135;5146.356705411824;5148.5623721983675;5177.974110129425;5187.662801917901;5745.942540574582;5762.855928601776;5763.538916886639;5768.826935191951;5770.076787713988;5708.115242137434;5759.913601295984;5768.653880767168;5784.13238014297;5787.88424231513;5359.330083739533;5361.088614935392;5361.276227709248;5370.489803468664;5391.353037635469;5866.325372582208;5866.853328666817;5871.2073870027;5871.383504732027;5872.677002764804;5524.088525393346;5635.718214089279;5636.4927156556105;5638.069718496402;5690.146478028329;5751.051076572318;5755.85610359736;5759.395263497357;5759.395263497357;5777.711114444261;5723.685197314105;5730.968425683417;5748.626339287933;5748.798792042342;5751.338596061423;5636.520895723909;5718.542516598662;5726.4273572642405;5797.536197104221;5800.187973683687;4393.626541743924;4393.714408563433;4421.513633500313;4422.314541246112;4440.222960981815;3949;3951.9604803952166;3969.622885825842;4000.0399904022825;4010.538788039413;5459.989901868167;5550.222968784374;5598.888022239533;5619.915701264485;5635.69003704792;5734.053881109654;5767.509761670305;5773.076307790733;5783.219265399117;5783.681897495594;5463.890722185534;5483.396826349099;5524.171374293888;5532.363778165482;5536.280283563111;4988.376452943382;5032.0690672225755;5036.370453693288;5046.899062018739;5063.417706963746;6043.8489037773525;6057.666828324484;6098.969505152446;6102.9694851525455;6106.389361063947;5702.914456283076;5813.418658134322;5821.854453638693;5842.474177324061;5853.707314634336;6043.033114701627;6095.1771510845465;6110.072772100023;6112.503480924647;6143.139960405458;5662.065759149694;5684.971575142098;5702.914456283242;5704.11586204139;5704.286964129484;5669.376368599368;5819.621724588058;5844.736986835687;5846.41535846412;5881.852953676022;5673.149027645886;5680.4319568042865;5681;5693.28833895763;5715;5645.153227015816;5650.350209725934;5651.519620832275;5654.717264136859;5655.321361436654;5403.621746477709;5519.558435325084;5555.30558680165;5610.7194640268635;5626.803061892814;5548.389677135431;5595.132754423071;5660.51885589713;5668.37647858727;5702.7718891243885;5526.309211348582;5551.500364967011;5578.553715702653;5583.022970980143;5616.0733478977145 16:56:31 INFO - PROCESS | 20693 | |1;ext.html;506.7415618034801;520.9322788037555;521.1349160393747;530.2629345210157;542.972851357432;30721.23196920078;39211.60788392119;39413.60586394135;39543;39580.60419395809;41764;42292.15415691684;42382.15235695284;42458;42458.78770606143;8777.122287771204;9026.052264512196;9045.728628141167;9046.366754327168;9048.095190480932;8918.375713700043;8951.820963580725;9055.547222638874;9057.50183739894;9326.766830829216;9281.860772088425;9384.7653808655;9396.671116510923;9397.154256116948;9397.577109030075;9180.908190918106;9269.304802139866;9269.721908342726;9269.814603707888;9274.07259274074;9191.310651701082;9314.161725444743;9334.579943902541;9334.673286434941;9336.813263734755;43703.78148109271;43800;44073.11853762907;44159.33760993588;44250.55749442529;3385.779924304937;3406.9488957665653;3567.518385018015;3585.1933315004176;4169.728967617126;30999.38001239985;31098.97856639311;31154.376912461852;31593;31736.206594835316;4170.103427763045;4252.468441444819;4264.509581398148;4284.378765079077;4348.369486424483;304404;312821;313893;315077;315761.99999999773;51498.74250628723;70624.64687676632;71979.64010179916;71989.28010719825;72021.63989180021;49836.50163498391;49845.75077124664;50188.749056254484;50248.49751502511;50321.74195645065;17197;17457;17458.56353591145;17479.65040699179;17485.912570437067;14271.429142834379;14410.42358305656;14417.567472975827;14419.134851908919;14423.350949207312;16361.345546178258;16396.180190990402;16438.342466301216;16457.09485978283;16479.505614831574;6074.544409169242;6330;6397.808065758035;6448.613083215022;6471.352864713491;984.9261305402124;1008.6822650864954;1017.2574020964589;1028.8148133336072;1028.8250997330472;30666.69333306683;30752.69247307543;31031.379372412426;31200.37599248002;31466;1124.578283143821;1148.62095508482;1196.6410076976872;1233.025909531478;1247.819066235391;15597.546991075344;16038.358465661477;16101.758473622906;16344.101074440781;16426.260818263207;351782;353476;354888;355194;355401;58245.41754582485;58644.41355586475;58814.11778823321;58894.41105588889;58911.41088589059;1180.9940950295193;1343.6909510812568;1404.6418163368276;1418.1491105336922;1431.5275958933528;28148.296292592848;28917.42165156727;29550.556741648463;30398.240043999078;30499.390012200074;46568.30147547857;46671.533284668076;46734;46817;46882.06235875332;234839;235111;236720;236882;236897;29702.732939107475;33209.83395083009;34998.30003399969;35041.824790875886;35045.47431788474;40472.595274046886;41264.381034285114;42124.368134477394;52359.214611780095;53788.193177101595;39503.2099358017;39764.602353976086;39929.60070399259;40033.1993360137;41083.1783364337;38641;39284.41073383844;39471.605283946796;39501;39883.40174897321;39439.80280098696;39993.80003099966;40461.79769101136;40538;40707.38938915859;33569.328613428086;35332;35585.46621800623;35971.82014090018;36131.277374451834;27182.864085679445;27506.724932750418;27533.31166720848;27762.26326490821;27842.16473505798 16:56:31 INFO - PROCESS | 20693 | |2;jquery.html;334.17125528688854;344.45060129094117;364.1624264192357;367.164700306802;368.7990045425243;15794.526164215093;17115.657686846254;17269.48191554254;17975.64048719028;18581.72127418088;17582.736258956127;17718.557036074104;17938;17949.371771987982;17984;5289.338832645919;5461.399246082928;5494.642848214873;5693.629914055594;5727.398623144572;5650.265465489501;5700.657960522382;5738.282714660668;5738.6556806591525;5742.971285143569;5490.450954904498;5620.4660557247;5688.573356998241;5692.0323544997245;5695.288088988877;5591.329040515124;5630.239917611111;5649.322081350223;5650.63270887391;5657.3494048184575;5015;5053.216751403538;5070.619703522214;5074.771635276422;5081.187010078406;21538.138474461004;22007.889960550096;22262.22082227114;22304.88847555768;22412.55174896493;2207.7902599253043;2228.454028762947;2292.449812045114;2343.5664402085667;3161.0042836506427;14250;14304.57086287413;14463;14525.418983240657;14879.776803347959;1903.5146037760421;1965.2139144342377;1988.8309493693052;2019.0409555461185;2072;72629.2737072633;75505;75885.24114758837;76362.99999999945;78825;14966.850331496546;15478.9226053869;15560.84439155594;15626.296816643278;16025.358985640676;22685.319440416813;25062.498750024897;27413.17760467149;27449.725502744717;27464.17607471779;9328.533573321307;9508.667196648084;9633.614655413705;9695.660651877291;9756.95121524402;8371.58142092893;8400.78998025042;8437.535935523605;8497.150284971452;8503.404761666625;8025.31784798287;8052.637631306605;8085.555294458862;8095.311898488577;8175.468594541336;3001.984990075079;3083.9845800770854;3128.311771410286;3324.7672662913847;3367.3097015111844;934.9672761453317;961.8412961861354;1000.5847573257017;1054.5887104029282;1118.4854966715238;16969;17423.564410889576;17828.46514604538;17944.55138621519;18175.818241817677;1001.6344034427527;1013.9797204055877;1014.3153371474225;1035.8290882004385;1068.4123731947398;9776.41341519497;10324.122449591869;10389.532471038821;10473.423961682029;10482.121893467584;431689;432269;457463;459335;460467;68903.65548172226;73803.63098184475;74566.62716686382;74644.62677686577;75290.99999999891;1066.2429674930886;1102.9779404412027;1104.9116070714324;1109.7946879827257;1123.8314252862135;15062.849371506583;15077.321520531383;15211.011284266488;15395.230238487808;15406;35199.06405147639;35338.82330588331;36035.459468107474;36184.81907590445;37219.44170837385;50228.49771502238;51895.481045189066;51939;52259.47740522546;53044.46955530396;8238.423310368216;8498.53258070812;8579.914200858162;8727.214550690469;8784.033756286932;9562.18721408688;11722.70693232676;12683.619491415273;12835;13230.4046317914;11394.48724807369;11431.428428578703;11664.6500604982;11710.94144529272;11738.178327516991;11734.061275098142;11775.234609750682;11792.29246245228;11826.822597661214;11851.703707407383;11572.710682233012;11802.232854864405;11822.40887955616;11866.644000679993;11886.583969561023;8253.380996425172;8377.83244335122;8412.369072319723;8472.534010629475;8688.218060374344;9829.31194816356;10859.535878346407;11561.30632162073;11632.767344653228;11742.236754610924 16:56:31 INFO - PROCESS | 20693 | |3;mootools.html;1467.677111035572;1549.1789351643629;1573.3391975370344;1826.2968757028548;1955.7261983322337;7967.16344783798;8110.310623597002;8127.39044571658;8160.428769986103;8164.591770411485;8033.39749518787;8197.754067377973;8200.7949801255;8200.876986845202;8251.216134467217;2440.1215562397524;2459.7909177719916;2461.4584791345965;2461.679981602398;2463.8398504097268;2360.44529535559;2407.5666380051584;2482;2489.166129346671;2490.452100537879;2447.571674956884;2452.080469823816;2455.9754402455924;2457.299669594166;2458.1150785717127;2495.089292408276;2495.3387352351733;2496.2511246626123;2497.2008957133726;2518.3452302401324;2499.52509023285;2522.785563227128;2530.1903390914913;2533.0880882882147;2538.1877799104295;8381.539015354154;8404.453710508858;8412.327013838878;8419.536925469096;8460.534670593115;5203.60972927032;5292.391374991887;5316.415194328621;5322.0952438085615;5329.733513324357;3255.2187475006067;3275.0993476793833;3323.1525960880062;3360.5127256547908;3387.1870751019824;1050.1756121444705;1060.0618452669366;1063.6862125672944;1103.6302838549095;1108.7394462301352;12107.091968102428;12175;12187.51249950001;12189.268643881307;12201.08491863105;4812.759362031885;4815.975920120447;4855.36880205571;4858.246971719389;4881.096997055556;10513.106385957279;10538.947305263424;10540.472976351151;10544.841827372595;10547.050765431148;5345.866353341197;5360.16917377807;5397.379301380392;5403.945960540423;5404.351477822686;4270.103278311527;4620.445546534437;4707.693999889996;4727.787249573777;4915.11527924977;3831.2529056834205;3890.0858298299877;3906.2382835346834;3908.511436070491;3935.940960885589;1320.221069568959;1331.0815537279245;1345.1122259308809;1349.1500354776624;1359.4222455456588;1109.5395410904384;1114.6934592986831;1437.6046587188398;1470.7646776515705;1477.8817694584407;7886.290233878978;7915.366770658334;7921.247481489249;7927.801804954807;7937.206279372017;518.8650950752756;519.4312228110214;525.8475042237708;543.671078997209;549.1844610753028;6225.8132256032395;6245.094461303085;6258.186435763413;6292.2134733158355;6315.863144633918;10449;10629.681109566725;10658.62694805678;10848.457577121113;10870.673879783619;10405.895941040644;10445.164386849034;10480.528376223088;10570.788584228272;10662.253642245123;8000.599970001476;8004.359651227888;8011.359091272684;8061.314788243065;8111.3916456266015;7637.923620763943;7681.308682218627;7695.499792513692;7703.268189521987;7776.261255180749;9407.623695052122;9408.670696525862;9549.809003819746;9583.616655333988;9597.760055998657;9464;9775.560099795384;9845.064718851698;9983.101520863158;10028.64899728506;6672.132622759011;7105.822354440974;7283.745068922774;7540.7737767864855;7621.809454763676;8045.275925166763;8065.233802788725;8100.675972961016;8127.471714338549;8132.552709601029;7268.345848873415;7394.7781566553085;7400.259974002557;7492.063492063492;7528.661210245443;7304;7326.9267307326245;7356;7389.704411823682;7410.258974102547;7583.696652133853;7603.847923041619;7666.693332266647;7666.731664391719;7674.347680447225;6977.2638122711805;7024.051753013482;7066.823329416806;7072.434205263464;7074.221835597978;7091.539049961736;7141.535800172972;7153.535020223669;7165.068541089625;7166.319199676022 16:56:31 INFO - PROCESS | 20693 | |4;prototype.html;322.18647914017106;323.679557238334;327.2261102492605;339.4145099703014;345.7907965680765;5841.0946303323;5884.146798714184;5885.411458854112;5889.4110588941085;5935.228420305354;5806.651600903938;5809.622374545652;5810.448007439287;5814.622049566775;5819.825405237839;4335.978320108395;4380.430544029272;4466.8883277917985;4506.954930450686;4512.932306015404;4506.8422605208825;4512.706674066175;4517.616002639779;4520.886977825564;4532.4334458192725;4461.263891457922;4477.776111194444;4484.125595508877;4484.260097083978;4486;4313.82744690212;4366.2359087159775;4459.554044595547;4461.174682683714;4475.664325175592;3935.724499285051;3938.2320447512748;3940.6650434713083;3941.3299739044146;3944.9408258876138;5459.727013649302;5461.508464238198;5463.699496527689;5466.617336786387;5470.206820011116;5210.505002024802;5211.114110601206;5213.087709650834;5216.087184742655;5225.137852254374;6111.847203819895;6135.171751813493;6137.386261373871;6141.355157708465;6149.631022138686;4135.214309281257;4256.531781504032;4268.893277668052;4364.781760911942;4369.934450983238;6380.968095159541;6395.680215989182;6413.583117097421;6430.453411460032;6433.903491447632;4362.411074504901;4365.563443655673;4368.432103826546;4371.1039236956985;4374.059577190856;4416.293393057095;4420.955790442119;4421.955780442218;4424.358468022183;4429.756363400044;5136.203888397305;5140.151874940668;5140.511651393112;5142.820001299937;5146.845594632167;6032.728527216286;6219.378062193744;6221.191245138103;6221.9377806222265;6229.2524897012645;1544.536639008293;1545.211941909634;1562.1408225475943;1562.7108984837841;1566.4674010836143;992.2905122837207;1013.8276492996208;1033.5968972100886;1036.5853658536646;1043.7181960870523;6067.544934129958;6078.787242446493;6090.543209259324;6091.269047714302;6101.237345331833;6324.241091069009;6336.58812177207;6348.587341822767;6351.174347334817;6356.586821856565;6088.908666370008;6094.329623741385;6096.9390306096375;6098;6114.296855861633;3404.9829750851086;3435.4503279475166;3437.3984552703178;3437.9656203438144;3443.1220038890424;6514.9674251629385;6630.204375474974;6660.367265109807;6669.733210671616;6678.799636010927;6466.773662921775;6480.222373315232;6490.610563366213;6496.902546461807;6509.479241660656;6639.6680165992475;6643.169603799525;6652.600843949379;6653.467722582085;6656.733730650816;6311.90532142009;6335.524835637438;6340.968295158495;6342.429181373698;6343.5876668016435;6061.72722227492;6193.566450348432;6214.2853571838;6231.719572619152;6243.219597550306;6578.539502234989;6644.60132392058;6647.4682025438815;6657.600543967377;6661.4004739573675;4365.039691267916;4378.80295386702;4379.605835474823;4381.496127945327;4382.758948257876;6302.432781049728;6302.968485157545;6308;6308.243010838729;6313.589616674902;6133.355997620186;6174.845628859135;6177.1969643945995;6183.721732521957;6185.907211391923;6098.603590766586;6173.567850250619;6285.465735412358;6286.497080233662;6295.464885484785;6156.107364432221;6179.84550386226;6183.783567575113;6185.226846644169;6197.597156185014;6237.12680224778;6318.988961766096;6326.240851097898;6344.71448784815;6345.650989195454;5911.940880591139;6009.699515024144;6178.1350610913605;6182.258129024546;6204.441600255998 16:56:31 INFO - PROCESS | 20693 | |5;yui.html;683.6035099642208;724.4277021153289;775.6121939030481;795.7453614843249;814.6863457568834;13564.253966031863;13863.722725545484;14720.337584808682;14757.18835464049;14915.105093694387;12564.623061308153;13998;14080;14107.294635268247;14124.08193467424;919.1497864475367;948.2650945517211;949.03672772136;949.2500924269818;950.0831697411996;929.8279818233615;930.2790337488433;938.5401153434802;938.699616122841;938.7981583959447;806.899137607799;968.728755948332;969.4231932000483;978.6379039755301;978.765096376868;974.6101559376235;977.9853302200437;978.8972157923422;979.1285755677453;981.0140808487496;714.6855383631238;718.8849784034581;719.1154879498247;719.3777382564097;721.5165838887905;13270.336483175803;13300.667483312898;13311.267880266581;13323.200607963554;13379.531716389976;14083.718325633532;14320.785188222186;14551.126932384092;14603.634909127357;14746.926265368604;11493.42532873353;11718.23831450953;11728.589499367567;11831.467583958742;11938.403079846059;3468.549088618489;3780.1494663700723;3809.2381523695094;3866.5553461352024;3885.630865067814;49180.75409622965;50079.24881126786;50412.999999999636;50497.242541361906;51950.22074668883;10729.946350268356;11164.106871450265;11175.944120279346;11377.544898204145;11429.59996400122;19296.1316740747;19377.128029238716;19381.806181938282;19404.611907761766;19771.505712357306;7566;7755.806104847311;7821.882671759929;7887.408444366695;7889.526628402315;4500.842470513517;4509.188346097669;4558.361829343895;4598.586127248564;4648.302754586839;3431.9485207721905;3440.9311813763584;3444.844981975817;3451.87918422854;3455.6026057003264;529.2748933960422;630.6342321453546;633.8700566383881;653.7613770973655;656.1240743607242;535.9035373632705;539.1239236241108;635.4820821030845;650.4178760009764;679.7416981547079;7034;7325.560466372035;7332.9266707332245;7471.252874712485;8399.37004724648;472.5817651378486;585.9365252067483;612.537534161714;613.8342647485243;647.2653538234044;3721.181340105227;3861.092643228839;3891.3968334908136;3904.39481880309;3995.2409042281874;55790.44209557934;55853.44146558482;55870.720646396505;55994.720026399606;56120.438795611524;50913;50952.23571646428;51681.48318516842;52867.47132528702;52902;47642.5235747652;47843.521564784605;48112.75943620259;48277.275840862414;48384.75807620939;7770.378369730295;7827.373810095065;7889.250521200706;7932.484388514728;7938.285554300141;35530.46704299489;35608.643913561566;36808.26383472369;36859.44710829286;36906.44640330344;41016.38475422931;44021.33967990419;44544.554554454044;44700.77649611731;45415;10429.43265748908;10787.6224332148;10943.069839063768;10963.342199468058;11130.888691112985;11958.880411195776;12120.696982575153;12312.630621081382;13226.603201903958;14673.339699713326;11912.642620721392;11983.161178717406;12070.00784415616;12566.811497827723;12601.369931503572;12034.398280086136;12342.074344424384;12565.623031309075;12710.046746494236;12745.74508509806;10771.730706732395;11058.723531911444;11141.387223702774;11972.401379931143;12121.090918180995;9238.630454781733;9436.292278079034;10321.277510574488;10347.896521034994;10479.580816767244;10011.499425028866;10282.434466104436;10335.483225838829;10487.52806123711;10489.580416783243 16:56:31 INFO - PROCESS | 20693 | __end_tp_report 16:56:31 INFO - PROCESS | 20693 | __start_cc_report 16:56:31 INFO - PROCESS | 20693 | _x_x_mozilla_cycle_collect,691 16:56:31 INFO - PROCESS | 20693 | __end_cc_report 16:56:31 INFO - PROCESS | 20693 | __startTimestamp1464652591900__endTimestamp 16:56:31 INFO - PROCESS | 20693 | 16:56:31 INFO - PROCESS | 20693 | ------- Summary: start ------- 16:56:31 INFO - PROCESS | 20693 | Number of tests: 6 16:56:31 INFO - PROCESS | 20693 | 16:56:31 INFO - PROCESS | 20693 | [#0] dojo.html Cycles:165 Average:5373.88 Median:5598.89 stddev:588.63 (10.5%) stddev-sans-first:566.83 16:56:31 INFO - PROCESS | 20693 | Values: 3270.3 3288.8 3328.4 3355.1 3368.4 5344.3 5346.2 5365.9 5388.8 5394.6 5345.7 5351.1 5358.7 5392.0 5400.0 4783.7 4867.0 4910.2 4981.0 4991.4 4844.5 4948.9 4950.5 4956.1 4956.7 4937.7 4967.5 4975.2 4975.8 4999.4 4893.4 4928.1 5025.7 5026.8 5030.8 4709.0 4853.3 4872.3 4918.4 4942.3 5081.5 5146.4 5148.6 5178.0 5187.7 5745.9 5762.9 5763.5 5768.8 5770.1 5708.1 5759.9 5768.7 5784.1 5787.9 5359.3 5361.1 5361.3 5370.5 5391.4 5866.3 5866.9 5871.2 5871.4 5872.7 5524.1 5635.7 5636.5 5638.1 5690.1 5751.1 5755.9 5759.4 5759.4 5777.7 5723.7 5731.0 5748.6 5748.8 5751.3 5636.5 5718.5 5726.4 5797.5 5800.2 4393.6 4393.7 4421.5 4422.3 4440.2 3949.0 3952.0 3969.6 4000.0 4010.5 5460.0 5550.2 5598.9 5619.9 5635.7 5734.1 5767.5 5773.1 5783.2 5783.7 5463.9 5483.4 5524.2 5532.4 5536.3 4988.4 5032.1 5036.4 5046.9 5063.4 6043.8 6057.7 6099.0 6103.0 6106.4 5702.9 5813.4 5821.9 5842.5 5853.7 6043.0 6095.2 6110.1 6112.5 6143.1 5662.1 5685.0 5702.9 5704.1 5704.3 5669.4 5819.6 5844.7 5846.4 5881.9 5673.1 5680.4 5681.0 5693.3 5715.0 5645.2 5650.4 5651.5 5654.7 5655.3 5403.6 5519.6 5555.3 5610.7 5626.8 5548.4 5595.1 5660.5 5668.4 5702.8 5526.3 5551.5 5578.6 5583.0 5616.1 16:56:31 INFO - PROCESS | 20693 | 16:56:31 INFO - PROCESS | 20693 | [#1] ext.html Cycles:180 Average:48120.53 Median:39502.10 stddev:79761.63 (201.9%) stddev-sans-first:79905.26 16:56:31 INFO - PROCESS | 20693 | Values: 506.7 520.9 521.1 530.3 543.0 30721.2 39211.6 39413.6 39543.0 39580.6 41764.0 42292.2 42382.2 42458.0 42458.8 8777.1 9026.1 9045.7 9046.4 9048.1 8918.4 8951.8 9055.5 9057.5 9326.8 9281.9 9384.8 9396.7 9397.2 9397.6 9180.9 9269.3 9269.7 9269.8 9274.1 9191.3 9314.2 9334.6 9334.7 9336.8 43703.8 43800.0 44073.1 44159.3 44250.6 3385.8 3406.9 3567.5 3585.2 4169.7 30999.4 31099.0 31154.4 31593.0 31736.2 4170.1 4252.5 4264.5 4284.4 4348.4 304404.0 312821.0 313893.0 315077.0 315762.0 51498.7 70624.6 71979.6 71989.3 72021.6 49836.5 49845.8 50188.7 50248.5 50321.7 17197.0 17457.0 17458.6 17479.7 17485.9 14271.4 14410.4 14417.6 14419.1 14423.4 16361.3 16396.2 16438.3 16457.1 16479.5 6074.5 6330.0 6397.8 6448.6 6471.4 984.9 1008.7 1017.3 1028.8 1028.8 30666.7 30752.7 31031.4 31200.4 31466.0 1124.6 1148.6 1196.6 1233.0 1247.8 15597.5 16038.4 16101.8 16344.1 16426.3 351782.0 353476.0 354888.0 355194.0 355401.0 58245.4 58644.4 58814.1 58894.4 58911.4 1181.0 1343.7 1404.6 1418.1 1431.5 28148.3 28917.4 29550.6 30398.2 30499.4 46568.3 46671.5 46734.0 46817.0 46882.1 234839.0 235111.0 236720.0 236882.0 236897.0 29702.7 33209.8 34998.3 35041.8 35045.5 40472.6 41264.4 42124.4 52359.2 53788.2 39503.2 39764.6 39929.6 40033.2 41083.2 38641.0 39284.4 39471.6 39501.0 39883.4 39439.8 39993.8 40461.8 40538.0 40707.4 33569.3 35332.0 35585.5 35971.8 36131.3 27182.9 27506.7 27533.3 27762.3 27842.2 16:56:31 INFO - PROCESS | 20693 | 16:56:31 INFO - PROCESS | 20693 | [#2] jquery.html Cycles:180 Average:27278.46 Median:3106.15 stddev:73533.67 (2367.4%) stddev-sans-first:73712.12 16:56:31 INFO - PROCESS | 20693 | Values: 334.2 344.5 364.2 367.2 368.8 15794.5 17115.7 17269.5 17975.6 18581.7 17582.7 17718.6 17938.0 17949.4 17984.0 5289.3 5461.4 5494.6 5693.6 5727.4 5650.3 5700.7 5738.3 5738.7 5743.0 5490.5 5620.5 5688.6 5692.0 5695.3 5591.3 5630.2 5649.3 5650.6 5657.3 5015.0 5053.2 5070.6 5074.8 5081.2 21538.1 22007.9 22262.2 22304.9 22412.6 2207.8 2228.5 2292.4 2343.6 3161.0 14250.0 14304.6 14463.0 14525.4 14879.8 1903.5 1965.2 1988.8 2019.0 2072.0 72629.3 75505.0 75885.2 76363.0 78825.0 14966.9 15478.9 15560.8 15626.3 16025.4 22685.3 25062.5 27413.2 27449.7 27464.2 9328.5 9508.7 9633.6 9695.7 9757.0 8371.6 8400.8 8437.5 8497.2 8503.4 8025.3 8052.6 8085.6 8095.3 8175.5 3002.0 3084.0 3128.3 3324.8 3367.3 935.0 961.8 1000.6 1054.6 1118.5 16969.0 17423.6 17828.5 17944.6 18175.8 1001.6 1014.0 1014.3 1035.8 1068.4 9776.4 10324.1 10389.5 10473.4 10482.1 431689.0 432269.0 457463.0 459335.0 460467.0 68903.7 73803.6 74566.6 74644.6 75291.0 1066.2 1103.0 1104.9 1109.8 1123.8 15062.8 15077.3 15211.0 15395.2 15406.0 35199.1 35338.8 36035.5 36184.8 37219.4 50228.5 51895.5 51939.0 52259.5 53044.5 8238.4 8498.5 8579.9 8727.2 8784.0 9562.2 11722.7 12683.6 12835.0 13230.4 11394.5 11431.4 11664.7 11710.9 11738.2 11734.1 11775.2 11792.3 11826.8 11851.7 11572.7 11802.2 11822.4 11866.6 11886.6 8253.4 8377.8 8412.4 8472.5 8688.2 9829.3 10859.5 11561.3 11632.8 11742.2 16:56:31 INFO - PROCESS | 20693 | 16:56:31 INFO - PROCESS | 20693 | [#3] mootools.html Cycles:180 Average:5986.46 Median:5304.40 stddev:3184.88 (60.0%) stddev-sans-first:3175.70 16:56:31 INFO - PROCESS | 20693 | Values: 1467.7 1549.2 1573.3 1826.3 1955.7 7967.2 8110.3 8127.4 8160.4 8164.6 8033.4 8197.8 8200.8 8200.9 8251.2 2440.1 2459.8 2461.5 2461.7 2463.8 2360.4 2407.6 2482.0 2489.2 2490.5 2447.6 2452.1 2456.0 2457.3 2458.1 2495.1 2495.3 2496.3 2497.2 2518.3 2499.5 2522.8 2530.2 2533.1 2538.2 8381.5 8404.5 8412.3 8419.5 8460.5 5203.6 5292.4 5316.4 5322.1 5329.7 3255.2 3275.1 3323.2 3360.5 3387.2 1050.2 1060.1 1063.7 1103.6 1108.7 12107.1 12175.0 12187.5 12189.3 12201.1 4812.8 4816.0 4855.4 4858.2 4881.1 10513.1 10538.9 10540.5 10544.8 10547.1 5345.9 5360.2 5397.4 5403.9 5404.4 4270.1 4620.4 4707.7 4727.8 4915.1 3831.3 3890.1 3906.2 3908.5 3935.9 1320.2 1331.1 1345.1 1349.2 1359.4 1109.5 1114.7 1437.6 1470.8 1477.9 7886.3 7915.4 7921.2 7927.8 7937.2 518.9 519.4 525.8 543.7 549.2 6225.8 6245.1 6258.2 6292.2 6315.9 10449.0 10629.7 10658.6 10848.5 10870.7 10405.9 10445.2 10480.5 10570.8 10662.3 8000.6 8004.4 8011.4 8061.3 8111.4 7637.9 7681.3 7695.5 7703.3 7776.3 9407.6 9408.7 9549.8 9583.6 9597.8 9464.0 9775.6 9845.1 9983.1 10028.6 6672.1 7105.8 7283.7 7540.8 7621.8 8045.3 8065.2 8100.7 8127.5 8132.6 7268.3 7394.8 7400.3 7492.1 7528.7 7304.0 7326.9 7356.0 7389.7 7410.3 7583.7 7603.8 7666.7 7666.7 7674.3 6977.3 7024.1 7066.8 7072.4 7074.2 7091.5 7141.5 7153.5 7165.1 7166.3 16:56:31 INFO - PROCESS | 20693 | 16:56:31 INFO - PROCESS | 20693 | [#4] prototype.html Cycles:180 Average:5183.10 Median:6021.21 stddev:1564.99 (26.0%) stddev-sans-first:1526.26 16:56:31 INFO - PROCESS | 20693 | Values: 322.2 323.7 327.2 339.4 345.8 5841.1 5884.1 5885.4 5889.4 5935.2 5806.7 5809.6 5810.4 5814.6 5819.8 4336.0 4380.4 4466.9 4507.0 4512.9 4506.8 4512.7 4517.6 4520.9 4532.4 4461.3 4477.8 4484.1 4484.3 4486.0 4313.8 4366.2 4459.6 4461.2 4475.7 3935.7 3938.2 3940.7 3941.3 3944.9 5459.7 5461.5 5463.7 5466.6 5470.2 5210.5 5211.1 5213.1 5216.1 5225.1 6111.8 6135.2 6137.4 6141.4 6149.6 4135.2 4256.5 4268.9 4364.8 4369.9 6381.0 6395.7 6413.6 6430.5 6433.9 4362.4 4365.6 4368.4 4371.1 4374.1 4416.3 4421.0 4422.0 4424.4 4429.8 5136.2 5140.2 5140.5 5142.8 5146.8 6032.7 6219.4 6221.2 6221.9 6229.3 1544.5 1545.2 1562.1 1562.7 1566.5 992.3 1013.8 1033.6 1036.6 1043.7 6067.5 6078.8 6090.5 6091.3 6101.2 6324.2 6336.6 6348.6 6351.2 6356.6 6088.9 6094.3 6096.9 6098.0 6114.3 3405.0 3435.5 3437.4 3438.0 3443.1 6515.0 6630.2 6660.4 6669.7 6678.8 6466.8 6480.2 6490.6 6496.9 6509.5 6639.7 6643.2 6652.6 6653.5 6656.7 6311.9 6335.5 6341.0 6342.4 6343.6 6061.7 6193.6 6214.3 6231.7 6243.2 6578.5 6644.6 6647.5 6657.6 6661.4 4365.0 4378.8 4379.6 4381.5 4382.8 6302.4 6303.0 6308.0 6308.2 6313.6 6133.4 6174.8 6177.2 6183.7 6185.9 6098.6 6173.6 6285.5 6286.5 6295.5 6156.1 6179.8 6183.8 6185.2 6197.6 6237.1 6319.0 6326.2 6344.7 6345.7 5911.9 6009.7 6178.1 6182.3 6204.4 16:56:31 INFO - PROCESS | 20693 | 16:56:31 INFO - PROCESS | 20693 | [#5] yui.html Cycles:180 Average:14190.18 Median:44622.67 stddev:16094.53 (36.1%) stddev-sans-first:16107.72 16:56:31 INFO - PROCESS | 20693 | Values: 683.6 724.4 775.6 795.7 814.7 13564.3 13863.7 14720.3 14757.2 14915.1 12564.6 13998.0 14080.0 14107.3 14124.1 919.1 948.3 949.0 949.3 950.1 929.8 930.3 938.5 938.7 938.8 806.9 968.7 969.4 978.6 978.8 974.6 978.0 978.9 979.1 981.0 714.7 718.9 719.1 719.4 721.5 13270.3 13300.7 13311.3 13323.2 13379.5 14083.7 14320.8 14551.1 14603.6 14746.9 11493.4 11718.2 11728.6 11831.5 11938.4 3468.5 3780.1 3809.2 3866.6 3885.6 49180.8 50079.2 50413.0 50497.2 51950.2 10729.9 11164.1 11175.9 11377.5 11429.6 19296.1 19377.1 19381.8 19404.6 19771.5 7566.0 7755.8 7821.9 7887.4 7889.5 4500.8 4509.2 4558.4 4598.6 4648.3 3431.9 3440.9 3444.8 3451.9 3455.6 529.3 630.6 633.9 653.8 656.1 535.9 539.1 635.5 650.4 679.7 7034.0 7325.6 7332.9 7471.3 8399.4 472.6 585.9 612.5 613.8 647.3 3721.2 3861.1 3891.4 3904.4 3995.2 55790.4 55853.4 55870.7 55994.7 56120.4 50913.0 50952.2 51681.5 52867.5 52902.0 47642.5 47843.5 48112.8 48277.3 48384.8 7770.4 7827.4 7889.3 7932.5 7938.3 35530.5 35608.6 36808.3 36859.4 36906.4 41016.4 44021.3 44544.6 44700.8 45415.0 10429.4 10787.6 10943.1 10963.3 11130.9 11958.9 12120.7 12312.6 13226.6 14673.3 11912.6 11983.2 12070.0 12566.8 12601.4 12034.4 12342.1 12565.6 12710.0 12745.7 10771.7 11058.7 11141.4 11972.4 12121.1 9238.6 9436.3 10321.3 10347.9 10479.6 10011.5 10282.4 10335.5 10487.5 10489.6 16:56:31 INFO - PROCESS | 20693 | -------- Summary: end -------- 16:56:31 INFO - PROCESS | 20693 | 16:56:32 INFO - TEST-INFO | 20693: exit 0 16:56:32 INFO - TEST-OK | dromaeo_css | took 1110834ms 16:56:32 INFO - TEST-START | kraken 16:56:32 INFO - operating with platform_type : linux_ 16:56:32 INFO - Initialising browser for kraken test... 16:56:32 INFO - TEST-INFO | started process 20893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXwDvMR/profile http://localhost:44121/getInfo.html) 16:56:36 INFO - PROCESS | 20893 | __metrics Screen width/height:1600/1200 16:56:36 INFO - PROCESS | 20893 | colorDepth:24 16:56:36 INFO - PROCESS | 20893 | Browser inner width/height: 1024/697 16:56:36 INFO - PROCESS | 20893 | __metrics 16:56:37 INFO - PROCESS | 20893 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:56:38 INFO - TEST-INFO | 20893: exit 0 16:56:38 INFO - Browser initialized. 16:56:38 INFO - Running cycle 1/1 for kraken test... 16:56:38 INFO - TEST-INFO | started process 20983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXwDvMR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:50 INFO - PROCESS | 20983 | RSS: Main: 139468800 16:56:50 INFO - PROCESS | 20983 | 16:56:52 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44121/tests/kraken/driver.html?testName=audio-beat-detection) 16:56:53 INFO - PROCESS | 20983 | RSS: Main: 183349248 16:56:53 INFO - PROCESS | 20983 | 16:56:55 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44121/tests/kraken/driver.html?testName=audio-dft) 16:56:56 INFO - PROCESS | 20983 | RSS: Main: 175616000 16:56:56 INFO - PROCESS | 20983 | 16:56:59 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44121/tests/kraken/driver.html?testName=audio-fft) 16:56:59 INFO - PROCESS | 20983 | RSS: Main: 175452160 16:56:59 INFO - PROCESS | 20983 | 16:57:01 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44121/tests/kraken/driver.html?testName=audio-oscillator) 16:57:02 INFO - PROCESS | 20983 | RSS: Main: 176222208 16:57:02 INFO - PROCESS | 20983 | 16:57:04 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44121/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:05 INFO - PROCESS | 20983 | RSS: Main: 174628864 16:57:05 INFO - PROCESS | 20983 | 16:57:08 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44121/tests/kraken/driver.html?testName=imaging-darkroom) 16:57:08 INFO - PROCESS | 20983 | RSS: Main: 174505984 16:57:08 INFO - PROCESS | 20983 | 16:57:12 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44121/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:12 INFO - PROCESS | 20983 | RSS: Main: 174338048 16:57:12 INFO - PROCESS | 20983 | 16:57:15 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44121/tests/kraken/driver.html?testName=json-parse-financial) 16:57:16 INFO - PROCESS | 20983 | RSS: Main: 175116288 16:57:16 INFO - PROCESS | 20983 | 16:57:17 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44121/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:18 INFO - PROCESS | 20983 | RSS: Main: 184201216 16:57:18 INFO - PROCESS | 20983 | 16:57:20 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:57:20 INFO - PROCESS | 20983 | RSS: Main: 183271424 16:57:20 INFO - PROCESS | 20983 | 16:57:22 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:57:23 INFO - PROCESS | 20983 | RSS: Main: 184934400 16:57:23 INFO - PROCESS | 20983 | 16:57:25 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:57:26 INFO - PROCESS | 20983 | RSS: Main: 188850176 16:57:26 INFO - PROCESS | 20983 | 16:57:28 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:57:29 INFO - PROCESS | 20983 | RSS: Main: 185008128 16:57:29 INFO - PROCESS | 20983 | 16:57:30 INFO - PROCESS | 20983 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44121/tests/kraken/driver.html?testName=ai-astar) 16:57:31 INFO - PROCESS | 20983 | RSS: Main: 246751232 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | __start_tp_report 16:57:31 INFO - PROCESS | 20983 | _x_x_mozilla_page_load 16:57:31 INFO - PROCESS | 20983 | _x_x_mozilla_page_load_details 16:57:31 INFO - PROCESS | 20983 | |i|pagename|runs| 16:57:31 INFO - PROCESS | 20983 | |0;ai-astar;111;110;112;110;110;111;110;111;110;123 16:57:31 INFO - PROCESS | 20983 | |1;audio-beat-detection;159;129;157;171;126;149;152;127;169;126 16:57:31 INFO - PROCESS | 20983 | |2;audio-dft;162;160;161;161;161;161;161;161;162;159 16:57:31 INFO - PROCESS | 20983 | |3;audio-fft;74;76;76;162;78;74;76;75;165;76 16:57:31 INFO - PROCESS | 20983 | |4;audio-oscillator;95;96;136;95;93;93;142;93;93;144 16:57:31 INFO - PROCESS | 20983 | |5;imaging-gaussian-blur;116;117;117;116;117;117;118;116;116;116 16:57:31 INFO - PROCESS | 20983 | |6;imaging-darkroom;147;145;145;145;146;145;146;147;146;146 16:57:31 INFO - PROCESS | 20983 | |7;imaging-desaturate;95;95;95;96;96;96;96;96;96;96 16:57:31 INFO - PROCESS | 20983 | |8;json-parse-financial;53;62;54;53;54;54;53;60;67;52 16:57:31 INFO - PROCESS | 20983 | |9;json-stringify-tinderbox;65;65;65;65;64;65;66;65;65;66 16:57:31 INFO - PROCESS | 20983 | |10;stanford-crypto-aes;79;80;80;81;81;81;80;85;80;88 16:57:31 INFO - PROCESS | 20983 | |11;stanford-crypto-ccm;114;123;124;113;113;116;118;114;116;113 16:57:31 INFO - PROCESS | 20983 | |12;stanford-crypto-pbkdf2;144;137;147;147;143;135;134;143;147;149 16:57:31 INFO - PROCESS | 20983 | |13;stanford-crypto-sha256-iterative;69;69;70;69;67;69;66;66;69;65 16:57:31 INFO - PROCESS | 20983 | __end_tp_report 16:57:31 INFO - PROCESS | 20983 | __start_cc_report 16:57:31 INFO - PROCESS | 20983 | _x_x_mozilla_cycle_collect,1058 16:57:31 INFO - PROCESS | 20983 | __end_cc_report 16:57:31 INFO - PROCESS | 20983 | __startTimestamp1464652651170__endTimestamp 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | ------- Summary: start ------- 16:57:31 INFO - PROCESS | 20983 | Number of tests: 14 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.00 stddev:3.99 (3.6%) stddev-sans-first:4.23 16:57:31 INFO - PROCESS | 20983 | Values: 111.0 110.0 112.0 110.0 110.0 111.0 110.0 111.0 110.0 123.0 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:154.50 stddev:18.06 (11.7%) stddev-sans-first:18.58 16:57:31 INFO - PROCESS | 20983 | Values: 159.0 129.0 157.0 171.0 126.0 149.0 152.0 127.0 169.0 126.0 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.83 16:57:31 INFO - PROCESS | 20983 | Values: 162.0 160.0 161.0 161.0 161.0 161.0 161.0 161.0 162.0 159.0 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.00 stddev:37.08 (48.8%) stddev-sans-first:38.67 16:57:31 INFO - PROCESS | 20983 | Values: 74.0 76.0 76.0 162.0 78.0 74.0 76.0 75.0 165.0 76.0 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:93.00 stddev:22.65 (24.4%) stddev-sans-first:23.53 16:57:31 INFO - PROCESS | 20983 | Values: 95.0 96.0 136.0 95.0 93.0 93.0 142.0 93.0 93.0 144.0 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 16:57:31 INFO - PROCESS | 20983 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 118.0 116.0 116.0 116.0 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 16:57:31 INFO - PROCESS | 20983 | Values: 147.0 145.0 145.0 145.0 146.0 145.0 146.0 147.0 146.0 146.0 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 16:57:31 INFO - PROCESS | 20983 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:54.00 stddev:5.03 (9.3%) stddev-sans-first:5.20 16:57:31 INFO - PROCESS | 20983 | Values: 53.0 62.0 54.0 53.0 54.0 54.0 53.0 60.0 67.0 52.0 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 16:57:31 INFO - PROCESS | 20983 | Values: 65.0 65.0 65.0 65.0 64.0 65.0 66.0 65.0 65.0 66.0 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:2.80 (3.5%) stddev-sans-first:2.82 16:57:31 INFO - PROCESS | 20983 | Values: 79.0 80.0 80.0 81.0 81.0 81.0 80.0 85.0 80.0 88.0 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#11] stanford-crypto-ccm Cycles:10 Average:116.40 Median:116.00 stddev:4.09 (3.5%) stddev-sans-first:4.24 16:57:31 INFO - PROCESS | 20983 | Values: 114.0 123.0 124.0 113.0 113.0 116.0 118.0 114.0 116.0 113.0 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.60 Median:145.50 stddev:5.42 (3.7%) stddev-sans-first:5.73 16:57:31 INFO - PROCESS | 20983 | Values: 144.0 137.0 147.0 147.0 143.0 135.0 134.0 143.0 147.0 149.0 16:57:31 INFO - PROCESS | 20983 | 16:57:31 INFO - PROCESS | 20983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:69.00 stddev:1.73 (2.5%) stddev-sans-first:1.79 16:57:31 INFO - PROCESS | 20983 | Values: 69.0 69.0 70.0 69.0 67.0 69.0 66.0 66.0 69.0 65.0 16:57:31 INFO - PROCESS | 20983 | -------- Summary: end -------- 16:57:31 INFO - PROCESS | 20983 | 16:57:32 INFO - TEST-INFO | 20983: exit 0 16:57:32 INFO - TEST-OK | kraken | took 59442ms 16:57:32 INFO - SUITE-END | took 1170s 16:57:32 INFO - Completed test suite (00:19:30) 16:57:32 INFO - javascript benchmark 16:57:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3270.2968861694735, 3288.7697861149713, 3328.417526932786, 3355.144438168267, 3368.4105281575717, 5344.331958505187, 5346.198070289459, 5365.919511207335, 5388.838334849951, 5394.595405344595, 5345.732713364336, 5351.09031464651, 5358.732063396834, 5391.973040134803, 5400.0, 4783.665143439961, 4867.0265946810605, 4910.1898186799135, 4981.0, 4991.425986011601, 4844.467108618049, 4948.925766113512, 4950.529699678525, 4956.083124621957, 4956.653034287601, 4937.65436419449, 4967.528084831935, 4975.2039673652225, 4975.751212439382, 4999.4250661174065, 4893.363862697862, 4928.088303663833, 5025.748712564394, 5026.773795179226, 5030.84907452777, 4708.976455117737, 4853.320535125085, 4872.269159626049, 4918.360613120307, 4942.332785074005, 5081.5426611605135, 5146.356705411824, 5148.5623721983675, 5177.974110129425, 5187.662801917901, 5745.942540574582, 5762.855928601776, 5763.538916886639, 5768.826935191951, 5770.076787713988, 5708.115242137434, 5759.913601295984, 5768.653880767168, 5784.13238014297, 5787.88424231513, 5359.330083739533, 5361.088614935392, 5361.276227709248, 5370.489803468664, 5391.353037635469, 5866.325372582208, 5866.853328666817, 5871.2073870027, 5871.383504732027, 5872.677002764804, 5524.088525393346, 5635.718214089279, 5636.4927156556105, 5638.069718496402, 5690.146478028329, 5751.051076572318, 5755.85610359736, 5759.395263497357, 5759.395263497357, 5777.711114444261, 5723.685197314105, 5730.968425683417, 5748.626339287933, 5748.798792042342, 5751.338596061423, 5636.520895723909, 5718.542516598662, 5726.4273572642405, 5797.536197104221, 5800.187973683687, 4393.626541743924, 4393.714408563433, 4421.513633500313, 4422.314541246112, 4440.222960981815, 3949.0, 3951.9604803952166, 3969.622885825842, 4000.0399904022825, 4010.538788039413, 5459.989901868167, 5550.222968784374, 5598.888022239533, 5619.915701264485, 5635.69003704792, 5734.053881109654, 5767.509761670305, 5773.076307790733, 5783.219265399117, 5783.681897495594, 5463.890722185534, 5483.396826349099, 5524.171374293888, 5532.363778165482, 5536.280283563111, 4988.376452943382, 5032.0690672225755, 5036.370453693288, 5046.899062018739, 5063.417706963746, 6043.8489037773525, 6057.666828324484, 6098.969505152446, 6102.9694851525455, 6106.389361063947, 5702.914456283076, 5813.418658134322, 5821.854453638693, 5842.474177324061, 5853.707314634336, 6043.033114701627, 6095.1771510845465, 6110.072772100023, 6112.503480924647, 6143.139960405458, 5662.065759149694, 5684.971575142098, 5702.914456283242, 5704.11586204139, 5704.286964129484, 5669.376368599368, 5819.621724588058, 5844.736986835687, 5846.41535846412, 5881.852953676022, 5673.149027645886, 5680.4319568042865, 5681.0, 5693.28833895763, 5715.0, 5645.153227015816, 5650.350209725934, 5651.519620832275, 5654.717264136859, 5655.321361436654, 5403.621746477709, 5519.558435325084, 5555.30558680165, 5610.7194640268635, 5626.803061892814, 5548.389677135431, 5595.132754423071, 5660.51885589713, 5668.37647858727, 5702.7718891243885, 5526.309211348582, 5551.500364967011, 5578.553715702653, 5583.022970980143, 5616.0733478977145], "unit": "score", "name": "dojo.html", "value": 5336.612388183842}, {"lowerIsBetter": false, "replicates": [506.7415618034801, 520.9322788037555, 521.1349160393747, 530.2629345210157, 542.972851357432, 30721.23196920078, 39211.60788392119, 39413.60586394135, 39543.0, 39580.60419395809, 41764.0, 42292.15415691684, 42382.15235695284, 42458.0, 42458.78770606143, 8777.122287771204, 9026.052264512196, 9045.728628141167, 9046.366754327168, 9048.095190480932, 8918.375713700043, 8951.820963580725, 9055.547222638874, 9057.50183739894, 9326.766830829216, 9281.860772088425, 9384.7653808655, 9396.671116510923, 9397.154256116948, 9397.577109030075, 9180.908190918106, 9269.304802139866, 9269.721908342726, 9269.814603707888, 9274.07259274074, 9191.310651701082, 9314.161725444743, 9334.579943902541, 9334.673286434941, 9336.813263734755, 43703.78148109271, 43800.0, 44073.11853762907, 44159.33760993588, 44250.55749442529, 3385.779924304937, 3406.9488957665653, 3567.518385018015, 3585.1933315004176, 4169.728967617126, 30999.38001239985, 31098.97856639311, 31154.376912461852, 31593.0, 31736.206594835316, 4170.103427763045, 4252.468441444819, 4264.509581398148, 4284.378765079077, 4348.369486424483, 304404.0, 312821.0, 313893.0, 315077.0, 315761.99999999773, 51498.74250628723, 70624.64687676632, 71979.64010179916, 71989.28010719825, 72021.63989180021, 49836.50163498391, 49845.75077124664, 50188.749056254484, 50248.49751502511, 50321.74195645065, 17197.0, 17457.0, 17458.56353591145, 17479.65040699179, 17485.912570437067, 14271.429142834379, 14410.42358305656, 14417.567472975827, 14419.134851908919, 14423.350949207312, 16361.345546178258, 16396.180190990402, 16438.342466301216, 16457.09485978283, 16479.505614831574, 6074.544409169242, 6330.0, 6397.808065758035, 6448.613083215022, 6471.352864713491, 984.9261305402124, 1008.6822650864954, 1017.2574020964589, 1028.8148133336072, 1028.8250997330472, 30666.69333306683, 30752.69247307543, 31031.379372412426, 31200.37599248002, 31466.0, 1124.578283143821, 1148.62095508482, 1196.6410076976872, 1233.025909531478, 1247.819066235391, 15597.546991075344, 16038.358465661477, 16101.758473622906, 16344.101074440781, 16426.260818263207, 351782.0, 353476.0, 354888.0, 355194.0, 355401.0, 58245.41754582485, 58644.41355586475, 58814.11778823321, 58894.41105588889, 58911.41088589059, 1180.9940950295193, 1343.6909510812568, 1404.6418163368276, 1418.1491105336922, 1431.5275958933528, 28148.296292592848, 28917.42165156727, 29550.556741648463, 30398.240043999078, 30499.390012200074, 46568.30147547857, 46671.533284668076, 46734.0, 46817.0, 46882.06235875332, 234839.0, 235111.0, 236720.0, 236882.0, 236897.0, 29702.732939107475, 33209.83395083009, 34998.30003399969, 35041.824790875886, 35045.47431788474, 40472.595274046886, 41264.381034285114, 42124.368134477394, 52359.214611780095, 53788.193177101595, 39503.2099358017, 39764.602353976086, 39929.60070399259, 40033.1993360137, 41083.1783364337, 38641.0, 39284.41073383844, 39471.605283946796, 39501.0, 39883.40174897321, 39439.80280098696, 39993.80003099966, 40461.79769101136, 40538.0, 40707.38938915859, 33569.328613428086, 35332.0, 35585.46621800623, 35971.82014090018, 36131.277374451834, 27182.864085679445, 27506.724932750418, 27533.31166720848, 27762.26326490821, 27842.16473505798], "unit": "score", "name": "ext.html", "value": 19242.57379553482}, {"lowerIsBetter": false, "replicates": [334.17125528688854, 344.45060129094117, 364.1624264192357, 367.164700306802, 368.7990045425243, 15794.526164215093, 17115.657686846254, 17269.48191554254, 17975.64048719028, 18581.72127418088, 17582.736258956127, 17718.557036074104, 17938.0, 17949.371771987982, 17984.0, 5289.338832645919, 5461.399246082928, 5494.642848214873, 5693.629914055594, 5727.398623144572, 5650.265465489501, 5700.657960522382, 5738.282714660668, 5738.6556806591525, 5742.971285143569, 5490.450954904498, 5620.4660557247, 5688.573356998241, 5692.0323544997245, 5695.288088988877, 5591.329040515124, 5630.239917611111, 5649.322081350223, 5650.63270887391, 5657.3494048184575, 5015.0, 5053.216751403538, 5070.619703522214, 5074.771635276422, 5081.187010078406, 21538.138474461004, 22007.889960550096, 22262.22082227114, 22304.88847555768, 22412.55174896493, 2207.7902599253043, 2228.454028762947, 2292.449812045114, 2343.5664402085667, 3161.0042836506427, 14250.0, 14304.57086287413, 14463.0, 14525.418983240657, 14879.776803347959, 1903.5146037760421, 1965.2139144342377, 1988.8309493693052, 2019.0409555461185, 2072.0, 72629.2737072633, 75505.0, 75885.24114758837, 76362.99999999945, 78825.0, 14966.850331496546, 15478.9226053869, 15560.84439155594, 15626.296816643278, 16025.358985640676, 22685.319440416813, 25062.498750024897, 27413.17760467149, 27449.725502744717, 27464.17607471779, 9328.533573321307, 9508.667196648084, 9633.614655413705, 9695.660651877291, 9756.95121524402, 8371.58142092893, 8400.78998025042, 8437.535935523605, 8497.150284971452, 8503.404761666625, 8025.31784798287, 8052.637631306605, 8085.555294458862, 8095.311898488577, 8175.468594541336, 3001.984990075079, 3083.9845800770854, 3128.311771410286, 3324.7672662913847, 3367.3097015111844, 934.9672761453317, 961.8412961861354, 1000.5847573257017, 1054.5887104029282, 1118.4854966715238, 16969.0, 17423.564410889576, 17828.46514604538, 17944.55138621519, 18175.818241817677, 1001.6344034427527, 1013.9797204055877, 1014.3153371474225, 1035.8290882004385, 1068.4123731947398, 9776.41341519497, 10324.122449591869, 10389.532471038821, 10473.423961682029, 10482.121893467584, 431689.0, 432269.0, 457463.0, 459335.0, 460467.0, 68903.65548172226, 73803.63098184475, 74566.62716686382, 74644.62677686577, 75290.99999999891, 1066.2429674930886, 1102.9779404412027, 1104.9116070714324, 1109.7946879827257, 1123.8314252862135, 15062.849371506583, 15077.321520531383, 15211.011284266488, 15395.230238487808, 15406.0, 35199.06405147639, 35338.82330588331, 36035.459468107474, 36184.81907590445, 37219.44170837385, 50228.49771502238, 51895.481045189066, 51939.0, 52259.47740522546, 53044.46955530396, 8238.423310368216, 8498.53258070812, 8579.914200858162, 8727.214550690469, 8784.033756286932, 9562.18721408688, 11722.70693232676, 12683.619491415273, 12835.0, 13230.4046317914, 11394.48724807369, 11431.428428578703, 11664.6500604982, 11710.94144529272, 11738.178327516991, 11734.061275098142, 11775.234609750682, 11792.29246245228, 11826.822597661214, 11851.703707407383, 11572.710682233012, 11802.232854864405, 11822.40887955616, 11866.644000679993, 11886.583969561023, 8253.380996425172, 8377.83244335122, 8412.369072319723, 8472.534010629475, 8688.218060374344, 9829.31194816356, 10859.535878346407, 11561.30632162073, 11632.767344653228, 11742.236754610924], "unit": "score", "name": "jquery.html", "value": 9519.616959495244}, {"lowerIsBetter": false, "replicates": [1467.677111035572, 1549.1789351643629, 1573.3391975370344, 1826.2968757028548, 1955.7261983322337, 7967.16344783798, 8110.310623597002, 8127.39044571658, 8160.428769986103, 8164.591770411485, 8033.39749518787, 8197.754067377973, 8200.7949801255, 8200.876986845202, 8251.216134467217, 2440.1215562397524, 2459.7909177719916, 2461.4584791345965, 2461.679981602398, 2463.8398504097268, 2360.44529535559, 2407.5666380051584, 2482.0, 2489.166129346671, 2490.452100537879, 2447.571674956884, 2452.080469823816, 2455.9754402455924, 2457.299669594166, 2458.1150785717127, 2495.089292408276, 2495.3387352351733, 2496.2511246626123, 2497.2008957133726, 2518.3452302401324, 2499.52509023285, 2522.785563227128, 2530.1903390914913, 2533.0880882882147, 2538.1877799104295, 8381.539015354154, 8404.453710508858, 8412.327013838878, 8419.536925469096, 8460.534670593115, 5203.60972927032, 5292.391374991887, 5316.415194328621, 5322.0952438085615, 5329.733513324357, 3255.2187475006067, 3275.0993476793833, 3323.1525960880062, 3360.5127256547908, 3387.1870751019824, 1050.1756121444705, 1060.0618452669366, 1063.6862125672944, 1103.6302838549095, 1108.7394462301352, 12107.091968102428, 12175.0, 12187.51249950001, 12189.268643881307, 12201.08491863105, 4812.759362031885, 4815.975920120447, 4855.36880205571, 4858.246971719389, 4881.096997055556, 10513.106385957279, 10538.947305263424, 10540.472976351151, 10544.841827372595, 10547.050765431148, 5345.866353341197, 5360.16917377807, 5397.379301380392, 5403.945960540423, 5404.351477822686, 4270.103278311527, 4620.445546534437, 4707.693999889996, 4727.787249573777, 4915.11527924977, 3831.2529056834205, 3890.0858298299877, 3906.2382835346834, 3908.511436070491, 3935.940960885589, 1320.221069568959, 1331.0815537279245, 1345.1122259308809, 1349.1500354776624, 1359.4222455456588, 1109.5395410904384, 1114.6934592986831, 1437.6046587188398, 1470.7646776515705, 1477.8817694584407, 7886.290233878978, 7915.366770658334, 7921.247481489249, 7927.801804954807, 7937.206279372017, 518.8650950752756, 519.4312228110214, 525.8475042237708, 543.671078997209, 549.1844610753028, 6225.8132256032395, 6245.094461303085, 6258.186435763413, 6292.2134733158355, 6315.863144633918, 10449.0, 10629.681109566725, 10658.62694805678, 10848.457577121113, 10870.673879783619, 10405.895941040644, 10445.164386849034, 10480.528376223088, 10570.788584228272, 10662.253642245123, 8000.599970001476, 8004.359651227888, 8011.359091272684, 8061.314788243065, 8111.3916456266015, 7637.923620763943, 7681.308682218627, 7695.499792513692, 7703.268189521987, 7776.261255180749, 9407.623695052122, 9408.670696525862, 9549.809003819746, 9583.616655333988, 9597.760055998657, 9464.0, 9775.560099795384, 9845.064718851698, 9983.101520863158, 10028.64899728506, 6672.132622759011, 7105.822354440974, 7283.745068922774, 7540.7737767864855, 7621.809454763676, 8045.275925166763, 8065.233802788725, 8100.675972961016, 8127.471714338549, 8132.552709601029, 7268.345848873415, 7394.7781566553085, 7400.259974002557, 7492.063492063492, 7528.661210245443, 7304.0, 7326.9267307326245, 7356.0, 7389.704411823682, 7410.258974102547, 7583.696652133853, 7603.847923041619, 7666.693332266647, 7666.731664391719, 7674.347680447225, 6977.2638122711805, 7024.051753013482, 7066.823329416806, 7072.434205263464, 7074.221835597978, 7091.539049961736, 7141.535800172972, 7153.535020223669, 7165.068541089625, 7166.319199676022], "unit": "score", "name": "mootools.html", "value": 4814.622092313767}, {"lowerIsBetter": false, "replicates": [322.18647914017106, 323.679557238334, 327.2261102492605, 339.4145099703014, 345.7907965680765, 5841.0946303323, 5884.146798714184, 5885.411458854112, 5889.4110588941085, 5935.228420305354, 5806.651600903938, 5809.622374545652, 5810.448007439287, 5814.622049566775, 5819.825405237839, 4335.978320108395, 4380.430544029272, 4466.8883277917985, 4506.954930450686, 4512.932306015404, 4506.8422605208825, 4512.706674066175, 4517.616002639779, 4520.886977825564, 4532.4334458192725, 4461.263891457922, 4477.776111194444, 4484.125595508877, 4484.260097083978, 4486.0, 4313.82744690212, 4366.2359087159775, 4459.554044595547, 4461.174682683714, 4475.664325175592, 3935.724499285051, 3938.2320447512748, 3940.6650434713083, 3941.3299739044146, 3944.9408258876138, 5459.727013649302, 5461.508464238198, 5463.699496527689, 5466.617336786387, 5470.206820011116, 5210.505002024802, 5211.114110601206, 5213.087709650834, 5216.087184742655, 5225.137852254374, 6111.847203819895, 6135.171751813493, 6137.386261373871, 6141.355157708465, 6149.631022138686, 4135.214309281257, 4256.531781504032, 4268.893277668052, 4364.781760911942, 4369.934450983238, 6380.968095159541, 6395.680215989182, 6413.583117097421, 6430.453411460032, 6433.903491447632, 4362.411074504901, 4365.563443655673, 4368.432103826546, 4371.1039236956985, 4374.059577190856, 4416.293393057095, 4420.955790442119, 4421.955780442218, 4424.358468022183, 4429.756363400044, 5136.203888397305, 5140.151874940668, 5140.511651393112, 5142.820001299937, 5146.845594632167, 6032.728527216286, 6219.378062193744, 6221.191245138103, 6221.9377806222265, 6229.2524897012645, 1544.536639008293, 1545.211941909634, 1562.1408225475943, 1562.7108984837841, 1566.4674010836143, 992.2905122837207, 1013.8276492996208, 1033.5968972100886, 1036.5853658536646, 1043.7181960870523, 6067.544934129958, 6078.787242446493, 6090.543209259324, 6091.269047714302, 6101.237345331833, 6324.241091069009, 6336.58812177207, 6348.587341822767, 6351.174347334817, 6356.586821856565, 6088.908666370008, 6094.329623741385, 6096.9390306096375, 6098.0, 6114.296855861633, 3404.9829750851086, 3435.4503279475166, 3437.3984552703178, 3437.9656203438144, 3443.1220038890424, 6514.9674251629385, 6630.204375474974, 6660.367265109807, 6669.733210671616, 6678.799636010927, 6466.773662921775, 6480.222373315232, 6490.610563366213, 6496.902546461807, 6509.479241660656, 6639.6680165992475, 6643.169603799525, 6652.600843949379, 6653.467722582085, 6656.733730650816, 6311.90532142009, 6335.524835637438, 6340.968295158495, 6342.429181373698, 6343.5876668016435, 6061.72722227492, 6193.566450348432, 6214.2853571838, 6231.719572619152, 6243.219597550306, 6578.539502234989, 6644.60132392058, 6647.4682025438815, 6657.600543967377, 6661.4004739573675, 4365.039691267916, 4378.80295386702, 4379.605835474823, 4381.496127945327, 4382.758948257876, 6302.432781049728, 6302.968485157545, 6308.0, 6308.243010838729, 6313.589616674902, 6133.355997620186, 6174.845628859135, 6177.1969643945995, 6183.721732521957, 6185.907211391923, 6098.603590766586, 6173.567850250619, 6285.465735412358, 6286.497080233662, 6295.464885484785, 6156.107364432221, 6179.84550386226, 6183.783567575113, 6185.226846644169, 6197.597156185014, 6237.12680224778, 6318.988961766096, 6326.240851097898, 6344.71448784815, 6345.650989195454, 5911.940880591139, 6009.699515024144, 6178.1350610913605, 6182.258129024546, 6204.441600255998], "unit": "score", "name": "prototype.html", "value": 4672.414186204226}, {"lowerIsBetter": false, "replicates": [683.6035099642208, 724.4277021153289, 775.6121939030481, 795.7453614843249, 814.6863457568834, 13564.253966031863, 13863.722725545484, 14720.337584808682, 14757.18835464049, 14915.105093694387, 12564.623061308153, 13998.0, 14080.0, 14107.294635268247, 14124.08193467424, 919.1497864475367, 948.2650945517211, 949.03672772136, 949.2500924269818, 950.0831697411996, 929.8279818233615, 930.2790337488433, 938.5401153434802, 938.699616122841, 938.7981583959447, 806.899137607799, 968.728755948332, 969.4231932000483, 978.6379039755301, 978.765096376868, 974.6101559376235, 977.9853302200437, 978.8972157923422, 979.1285755677453, 981.0140808487496, 714.6855383631238, 718.8849784034581, 719.1154879498247, 719.3777382564097, 721.5165838887905, 13270.336483175803, 13300.667483312898, 13311.267880266581, 13323.200607963554, 13379.531716389976, 14083.718325633532, 14320.785188222186, 14551.126932384092, 14603.634909127357, 14746.926265368604, 11493.42532873353, 11718.23831450953, 11728.589499367567, 11831.467583958742, 11938.403079846059, 3468.549088618489, 3780.1494663700723, 3809.2381523695094, 3866.5553461352024, 3885.630865067814, 49180.75409622965, 50079.24881126786, 50412.999999999636, 50497.242541361906, 51950.22074668883, 10729.946350268356, 11164.106871450265, 11175.944120279346, 11377.544898204145, 11429.59996400122, 19296.1316740747, 19377.128029238716, 19381.806181938282, 19404.611907761766, 19771.505712357306, 7566.0, 7755.806104847311, 7821.882671759929, 7887.408444366695, 7889.526628402315, 4500.842470513517, 4509.188346097669, 4558.361829343895, 4598.586127248564, 4648.302754586839, 3431.9485207721905, 3440.9311813763584, 3444.844981975817, 3451.87918422854, 3455.6026057003264, 529.2748933960422, 630.6342321453546, 633.8700566383881, 653.7613770973655, 656.1240743607242, 535.9035373632705, 539.1239236241108, 635.4820821030845, 650.4178760009764, 679.7416981547079, 7034.0, 7325.560466372035, 7332.9266707332245, 7471.252874712485, 8399.37004724648, 472.5817651378486, 585.9365252067483, 612.537534161714, 613.8342647485243, 647.2653538234044, 3721.181340105227, 3861.092643228839, 3891.3968334908136, 3904.39481880309, 3995.2409042281874, 55790.44209557934, 55853.44146558482, 55870.720646396505, 55994.720026399606, 56120.438795611524, 50913.0, 50952.23571646428, 51681.48318516842, 52867.47132528702, 52902.0, 47642.5235747652, 47843.521564784605, 48112.75943620259, 48277.275840862414, 48384.75807620939, 7770.378369730295, 7827.373810095065, 7889.250521200706, 7932.484388514728, 7938.285554300141, 35530.46704299489, 35608.643913561566, 36808.26383472369, 36859.44710829286, 36906.44640330344, 41016.38475422931, 44021.33967990419, 44544.554554454044, 44700.77649611731, 45415.0, 10429.43265748908, 10787.6224332148, 10943.069839063768, 10963.342199468058, 11130.888691112985, 11958.880411195776, 12120.696982575153, 12312.630621081382, 13226.603201903958, 14673.339699713326, 11912.642620721392, 11983.161178717406, 12070.00784415616, 12566.811497827723, 12601.369931503572, 12034.398280086136, 12342.074344424384, 12565.623031309075, 12710.046746494236, 12745.74508509806, 10771.730706732395, 11058.723531911444, 11141.387223702774, 11972.401379931143, 12121.090918180995, 9238.630454781733, 9436.292278079034, 10321.277510574488, 10347.896521034994, 10479.580816767244, 10011.499425028866, 10282.434466104436, 10335.483225838829, 10487.52806123711, 10489.580416783243], "unit": "score", "name": "yui.html", "value": 6579.082249108179}], "name": "dromaeo_css", "value": 7245.628115255419}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 112.0, 110.0, 110.0, 111.0, 110.0, 111.0, 110.0, 123.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [159.0, 129.0, 157.0, 171.0, 126.0, 149.0, 152.0, 127.0, 169.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 76.0, 162.0, 78.0, 74.0, 76.0, 75.0, 165.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 136.0, 95.0, 93.0, 93.0, 142.0, 93.0, 93.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 116.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [53.0, 62.0, 54.0, 53.0, 54.0, 54.0, 53.0, 60.0, 67.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 80.0, 81.0, 81.0, 81.0, 80.0, 85.0, 80.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.5}, {"lowerIsBetter": true, "replicates": [114.0, 123.0, 124.0, 113.0, 113.0, 116.0, 118.0, 114.0, 116.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.4}, {"lowerIsBetter": true, "replicates": [144.0, 137.0, 147.0, 147.0, 143.0, 135.0, 134.0, 143.0, 147.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 67.0, 69.0, 66.0, 66.0, 69.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1508.2000000000003}]} 16:57:32 INFO - Return code: 0 16:57:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:57:32 INFO - # TBPL SUCCESS # 16:57:32 INFO - Running post-action listener: _resource_record_post_action 16:57:32 INFO - Running post-run listener: _resource_record_post_run 16:57:33 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 16384; Write bytes: 449732608; Read time: 36; Write time: 329736 16:57:33 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 234151936; Read time: 0; Write time: 225404 16:57:33 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 211185664; Read time: 36; Write time: 104012 16:57:33 INFO - Running post-run listener: _upload_blobber_files 16:57:33 INFO - Blob upload gear active. 16:57:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:57:33 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 16:57:33 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:57:33 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:57:33 INFO - (blobuploader) - INFO - Open directory for files ... 16:57:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:57:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:57:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:34 INFO - (blobuploader) - INFO - Done attempting. 16:57:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:57:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:57:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:35 INFO - (blobuploader) - INFO - Done attempting. 16:57:35 INFO - (blobuploader) - INFO - Iteration through files over. 16:57:35 INFO - Return code: 0 16:57:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:57:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:57:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b05f61908541c4771865a35c5d44a38ccbe91b422b189e7bf84a4ac14bad114d63f54685d15dad5d609fd7b63c19c82151df06094bc03cbec64b405edaa7f353", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e45e17d208a8d355aba093ef791ccf8953b4e2874b2af6ded5d9f1a957e4fa14546c7f46d4ccb957e736a96c2bd01cff904490b6061eb64b4d31897095ffa23c"} 16:57:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:57:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:57:35 INFO - Contents: 16:57:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b05f61908541c4771865a35c5d44a38ccbe91b422b189e7bf84a4ac14bad114d63f54685d15dad5d609fd7b63c19c82151df06094bc03cbec64b405edaa7f353", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e45e17d208a8d355aba093ef791ccf8953b4e2874b2af6ded5d9f1a957e4fa14546c7f46d4ccb957e736a96c2bd01cff904490b6061eb64b4d31897095ffa23c"} 16:57:35 INFO - Running post-run listener: copy_logs_to_upload_dir 16:57:35 INFO - Copying logs to upload dir... 16:57:35 INFO - mkdir: /builds/slave/test/build/upload/logs 16:57:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.099482 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-05-30 16:57:35.695160) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:35.698890) ========= 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=00204705a9daa57ed339a427000001b9-1464650967.489673-82199005 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-Beta/sha512/b05f61908541c4771865a35c5d44a38ccbe91b422b189e7bf84a4ac14bad114d63f54685d15dad5d609fd7b63c19c82151df06094bc03cbec64b405edaa7f353", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e45e17d208a8d355aba093ef791ccf8953b4e2874b2af6ded5d9f1a957e4fa14546c7f46d4ccb957e736a96c2bd01cff904490b6061eb64b4d31897095ffa23c"} build_url:https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b05f61908541c4771865a35c5d44a38ccbe91b422b189e7bf84a4ac14bad114d63f54685d15dad5d609fd7b63c19c82151df06094bc03cbec64b405edaa7f353", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e45e17d208a8d355aba093ef791ccf8953b4e2874b2af6ded5d9f1a957e4fa14546c7f46d4ccb957e736a96c2bd01cff904490b6061eb64b4d31897095ffa23c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:35.725617) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:35.725956) ========= 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=00204705a9daa57ed339a427000001b9-1464650967.489673-82199005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:35.810422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:57:35.810752) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:57:35.811069) ========= ========= Total master_lag: 0.20 =========