builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1464651392.96 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.958031) ========= 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.958484) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:32.958779) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.088691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.088946) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600 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% 112M=0s 2016-05-30 16:36:33 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108391 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.214991) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.215281) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019580 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.278388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:36:33.278768) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 16:36:33,319 truncating revision to first 12 chars 2016-05-30 16:36:33,319 Setting DEBUG logging. 2016-05-30 16:36:33,319 attempt 1/10 2016-05-30 16:36:33,319 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,737 unpacking tar archive at: mozilla-beta-2ee4473c729a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.769801 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:36:35.067958) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:35.068284) ========= script_repo_revision: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:35.068709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:35.069006) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:35.080303) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-30 16:36:35.080625) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:36:35 INFO - MultiFileLogger online at 20160530 16:36:35 in /builds/slave/test 16:36:35 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:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:36:35 INFO - {'append_to_log': False, 16:36:35 INFO - 'base_work_dir': '/builds/slave/test', 16:36:35 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:36:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:36:35 INFO - 'branch': 'Mozilla-Beta', 16:36:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:35 INFO - 'config_files': ('talos/linux_config.py',), 16:36:35 INFO - 'default_actions': ('clobber', 16:36:35 INFO - 'read-buildbot-config', 16:36:35 INFO - 'download-and-extract', 16:36:35 INFO - 'populate-webroot', 16:36:35 INFO - 'create-virtualenv', 16:36:35 INFO - 'install', 16:36:35 INFO - 'run-tests'), 16:36:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:35 INFO - 'download_minidump_stackwalk': True, 16:36:35 INFO - 'download_symbols': 'ondemand', 16:36:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:36:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:36:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:36:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:36:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:35 INFO - 'installer_path': 'installer.exe', 16:36:35 INFO - 'log_level': 'info', 16:36:35 INFO - 'log_name': 'talos', 16:36:35 INFO - 'log_to_console': True, 16:36:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:36:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:36:35 INFO - 'opt_config_files': (), 16:36:35 INFO - 'pip_index': False, 16:36:35 INFO - 'sps_profile': False, 16:36:35 INFO - 'sps_profile_interval': 0, 16:36:35 INFO - 'suite': 'dromaeojs', 16:36:35 INFO - 'system_bits': '32', 16:36:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:35 INFO - 'title': 'talos-linux64-ix-062', 16:36:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:36:35 INFO - 'use_talos_json': True, 16:36:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:36:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:35 INFO - 'work_dir': 'build'} 16:36:35 INFO - ##### 16:36:35 INFO - ##### Running clobber 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: clobber 16:36:35 INFO - rmtree: /builds/slave/test/build 16:36:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:36:36 INFO - Running post-action listener: _resource_record_post_action 16:36:36 INFO - ##### 16:36:36 INFO - ##### Running read-buildbot-config step. 16:36:36 INFO - ##### 16:36:36 INFO - Running pre-action listener: _resource_record_pre_action 16:36:36 INFO - Running main action method: read_buildbot_config 16:36:36 INFO - Using buildbot properties: 16:36:36 INFO - { 16:36:36 INFO - "project": "", 16:36:36 INFO - "product": "firefox", 16:36:36 INFO - "script_repo_revision": "production", 16:36:36 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 16:36:36 INFO - "repository": "", 16:36:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 16:36:36 INFO - "buildid": "20160526140250", 16:36:36 INFO - "pgo_build": "True", 16:36:36 INFO - "basedir": "/builds/slave/test", 16:36:36 INFO - "buildnumber": 114, 16:36:36 INFO - "slavename": "talos-linux64-ix-062", 16:36:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:36:36 INFO - "platform": "ubuntu64_hw", 16:36:36 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:36:36 INFO - "branch": "mozilla-beta", 16:36:36 INFO - "repo_path": "releases/mozilla-beta", 16:36:36 INFO - "revision": "2ee4473c729acb2ba7dc723e7affe79ce14bff85", 16:36:36 INFO - "stage_platform": "linux64-pgo", 16:36:36 INFO - "builduid": "01574422c30242cc92a6c0b32dab29da", 16:36:36 INFO - "slavebuilddir": "test" 16:36:36 INFO - } 16:36:36 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:36 INFO - Running post-action listener: _resource_record_post_action 16:36:36 INFO - ##### 16:36:36 INFO - ##### Running download-and-extract step. 16:36:36 INFO - ##### 16:36:36 INFO - Running pre-action listener: _resource_record_pre_action 16:36:36 INFO - Running main action method: download_and_extract 16:36:36 INFO - mkdir: /builds/slave/test/build/tests 16:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:36 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:36 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:36 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:36 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:36 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:36 INFO - Downloaded 1412 bytes. 16:36:36 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:36:36 INFO - Using the following test package requirements: 16:36:36 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:36:36 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:36 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:36:36 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:36 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 16:36:36 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:36 INFO - u'jsshell-linux-x86_64.zip'], 16:36:36 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:36 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:36:36 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:36:36 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:36 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 16:36:36 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:36 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 16:36:36 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:36 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:36:36 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:36:36 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:36 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:36:36 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:36 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:36 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:36 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:36 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:36 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:54 INFO - Downloaded 23434470 bytes. 16:36:54 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:54 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:56 INFO - Return code: 0 16:36:56 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:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:56 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:56 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:56 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:56 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:56 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:06 INFO - Downloaded 23434470 bytes. 16:37:06 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:06 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:08 INFO - Return code: 0 16:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:08 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:08 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:08 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:08 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:08 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:09 INFO - Downloaded 10845194 bytes. 16:37:09 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:09 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:09 INFO - Return code: 0 16:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:09 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:09 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:09 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:09 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:09 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:12 INFO - Downloaded 53860430 bytes. 16:37:12 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:12 INFO - mkdir: /builds/slave/test/properties 16:37:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:37:12 INFO - Writing to file /builds/slave/test/properties/build_url 16:37:12 INFO - Contents: 16:37:12 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:12 INFO - Running post-action listener: _resource_record_post_action 16:37:12 INFO - Running post-action listener: set_extra_try_arguments 16:37:12 INFO - ##### 16:37:12 INFO - ##### Running populate-webroot step. 16:37:12 INFO - ##### 16:37:12 INFO - Running pre-action listener: _resource_record_pre_action 16:37:12 INFO - Running main action method: populate_webroot 16:37:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:37:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:37:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:37:12 INFO - '--tppagecycles', 16:37:12 INFO - '7'], 16:37:12 INFO - 'tests': ['tsvgm']}}, 16:37:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:37:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:37:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:37:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:37:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:37:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:37:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:12 INFO - 'talos_options': ['--e10s'], 16:37:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:12 INFO - 'tests': ['damp', 'tps']}, 16:37:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:12 INFO - 'talos_options': ['--e10s'], 16:37:12 INFO - 'tests': ['damp', 'tps']}, 16:37:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:37:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:37:12 INFO - 'other': {'tests': ['a11yr', 16:37:12 INFO - 'ts_paint', 16:37:12 INFO - 'tpaint', 16:37:12 INFO - 'sessionrestore', 16:37:12 INFO - 'sessionrestore_no_auto_restore', 16:37:12 INFO - 'tabpaint']}, 16:37:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:37:12 INFO - 'tests': ['a11yr', 16:37:12 INFO - 'ts_paint', 16:37:12 INFO - 'tpaint', 16:37:12 INFO - 'sessionrestore', 16:37:12 INFO - 'sessionrestore_no_auto_restore', 16:37:12 INFO - 'tabpaint']}, 16:37:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:37:12 INFO - 'tests': ['a11yr', 16:37:12 INFO - 'ts_paint', 16:37:12 INFO - 'tpaint', 16:37:12 INFO - 'sessionrestore', 16:37:12 INFO - 'sessionrestore_no_auto_restore', 16:37:12 INFO - 'tabpaint']}, 16:37:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:37:12 INFO - 'tests': ['a11yr', 16:37:12 INFO - 'ts_paint', 16:37:12 INFO - 'tpaint', 16:37:12 INFO - 'sessionrestore', 16:37:12 INFO - 'sessionrestore_no_auto_restore', 16:37:12 INFO - 'tabpaint']}, 16:37:12 INFO - 'other_l64': {'tests': ['a11yr', 16:37:12 INFO - 'ts_paint', 16:37:12 INFO - 'tpaint', 16:37:12 INFO - 'sessionrestore', 16:37:12 INFO - 'sessionrestore_no_auto_restore', 16:37:12 INFO - 'tabpaint']}, 16:37:12 INFO - 'other_nol64': {'tests': ['a11yr', 16:37:12 INFO - 'ts_paint', 16:37:12 INFO - 'tpaint', 16:37:12 INFO - 'sessionrestore', 16:37:12 INFO - 'sessionrestore_no_auto_restore', 16:37:12 INFO - 'tabpaint']}, 16:37:12 INFO - 'svgr': {'tests': ['tsvgx', 16:37:12 INFO - 'tsvgr_opacity', 16:37:12 INFO - 'tart', 16:37:12 INFO - 'tscrollx', 16:37:12 INFO - 'cart']}, 16:37:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:37:12 INFO - 'tests': ['tsvgx', 16:37:12 INFO - 'tsvgr_opacity', 16:37:12 INFO - 'tart', 16:37:12 INFO - 'tscrollx', 16:37:12 INFO - 'cart']}, 16:37:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:12 INFO - 'tests': ['tp5o']}, 16:37:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:12 INFO - 'talos_options': ['--e10s'], 16:37:12 INFO - 'tests': ['tp5o']}, 16:37:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:12 INFO - 'talos_options': ['--xperf_path', 16:37:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:12 INFO - 'tests': ['tp5n']}, 16:37:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:12 INFO - 'talos_options': ['--e10s', 16:37:12 INFO - '--xperf_path', 16:37:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:12 INFO - 'tests': ['tp5n']}}, 16:37:12 INFO - 'talos.zip': {'path': '', 16:37:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:37:12 INFO - Running post-action listener: _resource_record_post_action 16:37:12 INFO - ##### 16:37:12 INFO - ##### Running create-virtualenv step. 16:37:12 INFO - ##### 16:37:12 INFO - Running pre-action listener: _resource_record_pre_action 16:37:12 INFO - Running main action method: create_virtualenv 16:37:12 INFO - Creating virtualenv /builds/slave/test/build/venv 16:37:12 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:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:37:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:37:13 INFO - Using real prefix '/usr' 16:37:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:37:13 INFO - Installing distribute.............................................................................................................................................................................................done. 16:37:15 INFO - Installing pip.................done. 16:37:15 INFO - Return code: 0 16:37:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:37:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:15 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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:15 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 0x7f0296939f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527160>, '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 0x1528060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15284f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', '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:15 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:15 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:15 INFO - Using env: {'DISPLAY': ':0', 16:37:15 INFO - 'HOME': '/home/cltbld', 16:37:15 INFO - 'LANG': 'en_US.UTF-8', 16:37:15 INFO - 'LANGUAGE': 'en_US:en', 16:37:15 INFO - 'LOGNAME': 'cltbld', 16:37:15 INFO - 'MAIL': '/var/mail/cltbld', 16:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:15 INFO - 'MOZ_NO_REMOTE': '1', 16:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:15 INFO - 'NO_EM_RESTART': '1', 16:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:15 INFO - 'PWD': '/builds/slave/test', 16:37:15 INFO - 'SHELL': '/bin/bash', 16:37:15 INFO - 'SHLVL': '1', 16:37:15 INFO - 'TERM': 'linux', 16:37:15 INFO - 'TMOUT': '86400', 16:37:15 INFO - 'USER': 'cltbld', 16:37:15 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', 16:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:15 INFO - '_': '/tools/buildbot/bin/python'} 16:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:15 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:15 INFO - Cleaning up... 16:37:15 INFO - Return code: 0 16:37:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:37:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:15 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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:15 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 0x7f0296939f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527160>, '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 0x1528060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15284f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', '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:15 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:15 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:15 INFO - Using env: {'DISPLAY': ':0', 16:37:15 INFO - 'HOME': '/home/cltbld', 16:37:15 INFO - 'LANG': 'en_US.UTF-8', 16:37:15 INFO - 'LANGUAGE': 'en_US:en', 16:37:15 INFO - 'LOGNAME': 'cltbld', 16:37:15 INFO - 'MAIL': '/var/mail/cltbld', 16:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:15 INFO - 'MOZ_NO_REMOTE': '1', 16:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:15 INFO - 'NO_EM_RESTART': '1', 16:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:15 INFO - 'PWD': '/builds/slave/test', 16:37:15 INFO - 'SHELL': '/bin/bash', 16:37:15 INFO - 'SHLVL': '1', 16:37:15 INFO - 'TERM': 'linux', 16:37:15 INFO - 'TMOUT': '86400', 16:37:15 INFO - 'USER': 'cltbld', 16:37:15 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', 16:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:15 INFO - '_': '/tools/buildbot/bin/python'} 16:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:15 INFO - Downloading/unpacking psutil>=0.7.1 16:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:37:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:17 INFO - Installing collected packages: psutil 16:37:17 INFO - Running setup.py install for psutil 16:37:18 INFO - building 'psutil._psutil_linux' extension 16:37:18 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:18 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:18 INFO - building 'psutil._psutil_posix' extension 16:37:18 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:18 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:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:18 INFO - Successfully installed psutil 16:37:18 INFO - Cleaning up... 16:37:18 INFO - Return code: 0 16:37:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0296939f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527160>, '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 0x1528060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15284f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', '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:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:37:18 INFO - Using env: {'DISPLAY': ':0', 16:37:18 INFO - 'HOME': '/home/cltbld', 16:37:18 INFO - 'LANG': 'en_US.UTF-8', 16:37:18 INFO - 'LANGUAGE': 'en_US:en', 16:37:18 INFO - 'LOGNAME': 'cltbld', 16:37:18 INFO - 'MAIL': '/var/mail/cltbld', 16:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:18 INFO - 'MOZ_NO_REMOTE': '1', 16:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:18 INFO - 'NO_EM_RESTART': '1', 16:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:18 INFO - 'PWD': '/builds/slave/test', 16:37:18 INFO - 'SHELL': '/bin/bash', 16:37:18 INFO - 'SHLVL': '1', 16:37:18 INFO - 'TERM': 'linux', 16:37:18 INFO - 'TMOUT': '86400', 16:37:18 INFO - 'USER': 'cltbld', 16:37:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', 16:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:18 INFO - '_': '/tools/buildbot/bin/python'} 16:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:37:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:37:20 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:20 INFO - Installing collected packages: mozsystemmonitor 16:37:20 INFO - Running setup.py install for mozsystemmonitor 16:37:20 INFO - Successfully installed mozsystemmonitor 16:37:20 INFO - Cleaning up... 16:37:20 INFO - Return code: 0 16:37:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:20 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 0x7f0296939f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527160>, '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 0x1528060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15284f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', '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:20 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:20 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:20 INFO - Using env: {'DISPLAY': ':0', 16:37:20 INFO - 'HOME': '/home/cltbld', 16:37:20 INFO - 'LANG': 'en_US.UTF-8', 16:37:20 INFO - 'LANGUAGE': 'en_US:en', 16:37:20 INFO - 'LOGNAME': 'cltbld', 16:37:20 INFO - 'MAIL': '/var/mail/cltbld', 16:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:20 INFO - 'MOZ_NO_REMOTE': '1', 16:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:20 INFO - 'NO_EM_RESTART': '1', 16:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:20 INFO - 'PWD': '/builds/slave/test', 16:37:20 INFO - 'SHELL': '/bin/bash', 16:37:20 INFO - 'SHLVL': '1', 16:37:20 INFO - 'TERM': 'linux', 16:37:20 INFO - 'TMOUT': '86400', 16:37:20 INFO - 'USER': 'cltbld', 16:37:20 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', 16:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:20 INFO - '_': '/tools/buildbot/bin/python'} 16:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:21 INFO - Downloading/unpacking blobuploader==1.2.4 16:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:22 INFO - Downloading blobuploader-1.2.4.tar.gz 16:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:37:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:37:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:37:23 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:23 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:23 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:23 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:23 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:23 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:23 INFO - Downloading docopt-0.6.1.tar.gz 16:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:37:23 INFO - Installing collected packages: blobuploader, requests, docopt 16:37:23 INFO - Running setup.py install for blobuploader 16:37:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:37:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:37:23 INFO - Running setup.py install for requests 16:37:24 INFO - Running setup.py install for docopt 16:37:24 INFO - Successfully installed blobuploader requests docopt 16:37:24 INFO - Cleaning up... 16:37:24 INFO - Return code: 0 16:37:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:24 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 0x7f0296939f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527160>, '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 0x1528060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15284f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', '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:24 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:24 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:24 INFO - Using env: {'DISPLAY': ':0', 16:37:24 INFO - 'HOME': '/home/cltbld', 16:37:24 INFO - 'LANG': 'en_US.UTF-8', 16:37:24 INFO - 'LANGUAGE': 'en_US:en', 16:37:24 INFO - 'LOGNAME': 'cltbld', 16:37:24 INFO - 'MAIL': '/var/mail/cltbld', 16:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:24 INFO - 'MOZ_NO_REMOTE': '1', 16:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:24 INFO - 'NO_EM_RESTART': '1', 16:37:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:24 INFO - 'PWD': '/builds/slave/test', 16:37:24 INFO - 'SHELL': '/bin/bash', 16:37:24 INFO - 'SHLVL': '1', 16:37:24 INFO - 'TERM': 'linux', 16:37:24 INFO - 'TMOUT': '86400', 16:37:24 INFO - 'USER': 'cltbld', 16:37:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', 16:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:24 INFO - '_': '/tools/buildbot/bin/python'} 16:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:24 INFO - Running setup.py (path:/tmp/pip-Byexzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:24 INFO - Running setup.py (path:/tmp/pip-4AtR2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:24 INFO - Running setup.py (path:/tmp/pip-Fdl2Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:24 INFO - Running setup.py (path:/tmp/pip-ivyuES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:24 INFO - Running setup.py (path:/tmp/pip-ynVgve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:24 INFO - Running setup.py (path:/tmp/pip-ihdU4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:24 INFO - Running setup.py (path:/tmp/pip-mLCMcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:25 INFO - Running setup.py (path:/tmp/pip-p_BFQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:25 INFO - Running setup.py (path:/tmp/pip-rqo8JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:25 INFO - Running setup.py (path:/tmp/pip-bkLui1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:25 INFO - Running setup.py (path:/tmp/pip-M7TzHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:25 INFO - Running setup.py (path:/tmp/pip-rsJvZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:25 INFO - Running setup.py (path:/tmp/pip-kn6NsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:25 INFO - Running setup.py (path:/tmp/pip-BzEjS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:25 INFO - Running setup.py (path:/tmp/pip-kJ3NwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:25 INFO - Running setup.py (path:/tmp/pip-ub7Yri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:25 INFO - Running setup.py (path:/tmp/pip-PDGvcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:37:25 INFO - Running setup.py install for manifestparser 16:37:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:37:25 INFO - Running setup.py install for mozcrash 16:37:25 INFO - Running setup.py install for mozdebug 16:37:26 INFO - Running setup.py install for mozdevice 16:37:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Running setup.py install for mozfile 16:37:26 INFO - Running setup.py install for mozhttpd 16:37:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Running setup.py install for mozinfo 16:37:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Running setup.py install for mozInstall 16:37:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Running setup.py install for mozleak 16:37:26 INFO - Running setup.py install for mozlog 16:37:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Running setup.py install for moznetwork 16:37:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Running setup.py install for mozprocess 16:37:26 INFO - Running setup.py install for mozprofile 16:37:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:37:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:37:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:37:27 INFO - Running setup.py install for mozrunner 16:37:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:37:27 INFO - Running setup.py install for mozscreenshot 16:37:27 INFO - Running setup.py install for moztest 16:37:27 INFO - Running setup.py install for mozversion 16:37:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:37:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:37:27 INFO - Cleaning up... 16:37:27 INFO - Return code: 0 16:37:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:27 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:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:27 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:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:27 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 0x7f0296939f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527160>, '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 0x1528060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15284f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', '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:27 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:27 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:27 INFO - Using env: {'DISPLAY': ':0', 16:37:27 INFO - 'HOME': '/home/cltbld', 16:37:27 INFO - 'LANG': 'en_US.UTF-8', 16:37:27 INFO - 'LANGUAGE': 'en_US:en', 16:37:27 INFO - 'LOGNAME': 'cltbld', 16:37:27 INFO - 'MAIL': '/var/mail/cltbld', 16:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:27 INFO - 'MOZ_NO_REMOTE': '1', 16:37:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:27 INFO - 'NO_EM_RESTART': '1', 16:37:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:27 INFO - 'PWD': '/builds/slave/test', 16:37:27 INFO - 'SHELL': '/bin/bash', 16:37:27 INFO - 'SHLVL': '1', 16:37:27 INFO - 'TERM': 'linux', 16:37:27 INFO - 'TMOUT': '86400', 16:37:27 INFO - 'USER': 'cltbld', 16:37:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', 16:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:27 INFO - '_': '/tools/buildbot/bin/python'} 16:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:27 INFO - Running setup.py (path:/tmp/pip-n48Ixu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:27 INFO - Running setup.py (path:/tmp/pip-vLwLIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:27 INFO - Running setup.py (path:/tmp/pip-FTZxQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:27 INFO - Running setup.py (path:/tmp/pip-Cm4L2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:28 INFO - Running setup.py (path:/tmp/pip-ftBBX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:28 INFO - Running setup.py (path:/tmp/pip-N8VD4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:28 INFO - Running setup.py (path:/tmp/pip-pNbQMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:28 INFO - Running setup.py (path:/tmp/pip-tbaaIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:28 INFO - Running setup.py (path:/tmp/pip-sacbNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:28 INFO - Running setup.py (path:/tmp/pip-AH0x_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:28 INFO - Running setup.py (path:/tmp/pip-jQAuDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:28 INFO - Running setup.py (path:/tmp/pip-k2gEES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:28 INFO - Running setup.py (path:/tmp/pip-8BDhbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:28 INFO - Running setup.py (path:/tmp/pip-s6Hs8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:28 INFO - Running setup.py (path:/tmp/pip-uw0ZrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:28 INFO - Running setup.py (path:/tmp/pip-msisLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:28 INFO - Running setup.py (path:/tmp/pip-Mexgxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:28 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:28 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:28 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:28 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:28 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:28 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:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:30 INFO - Downloading blessings-1.6.tar.gz 16:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:37:30 INFO - Installing collected packages: blessings 16:37:30 INFO - Running setup.py install for blessings 16:37:31 INFO - Successfully installed blessings 16:37:31 INFO - Cleaning up... 16:37:31 INFO - Return code: 0 16:37:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:37:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:31 INFO - Reading from file tmpfile_stdout 16:37:31 INFO - Current package versions: 16:37:31 INFO - argparse == 1.2.1 16:37:31 INFO - blessings == 1.6 16:37:31 INFO - blobuploader == 1.2.4 16:37:31 INFO - docopt == 0.6.1 16:37:31 INFO - manifestparser == 1.1 16:37:31 INFO - mozInstall == 1.12 16:37:31 INFO - mozcrash == 0.17 16:37:31 INFO - mozdebug == 0.1 16:37:31 INFO - mozdevice == 0.48 16:37:31 INFO - mozfile == 1.2 16:37:31 INFO - mozhttpd == 0.7 16:37:31 INFO - mozinfo == 0.9 16:37:31 INFO - mozleak == 0.1 16:37:31 INFO - mozlog == 3.1 16:37:31 INFO - moznetwork == 0.27 16:37:31 INFO - mozprocess == 0.22 16:37:31 INFO - mozprofile == 0.28 16:37:31 INFO - mozrunner == 6.11 16:37:31 INFO - mozscreenshot == 0.1 16:37:31 INFO - mozsystemmonitor == 0.0 16:37:31 INFO - moztest == 0.7 16:37:31 INFO - mozversion == 1.4 16:37:31 INFO - psutil == 3.1.1 16:37:31 INFO - requests == 1.2.3 16:37:31 INFO - wsgiref == 0.1.2 16:37:31 INFO - Installing None 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', '-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 0x7f0296939f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527160>, '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 0x1528060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15284f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', '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', '-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:31 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: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': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', 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 - 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:31 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:31 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:31 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:31 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:31 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:31 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:31 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:31 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:31 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:31 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:31 INFO - Cleaning up... 16:37:31 INFO - Return code: 0 16:37:31 INFO - Installing jsonschema 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0296939f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527160>, '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 0x1528060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15284f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', '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', 'jsonschema'] 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 jsonschema 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': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', 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 jsonschema 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 jsonschema-2.5.1-py2.py3-none-any.whl 16:37:33 INFO - Downloading/unpacking functools32 (from jsonschema) 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 functools32-3.2.3-2.tar.gz 16:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:37:33 INFO - warning: no files found matching '*.txt' 16:37:33 INFO - no previously-included directories found matching 'build' 16:37:33 INFO - no previously-included directories found matching 'dist' 16:37:33 INFO - no previously-included directories found matching '.git*' 16:37:33 INFO - Installing collected packages: jsonschema, functools32 16:37:33 INFO - Running setup.py install for functools32 16:37:34 INFO - warning: no files found matching '*.txt' 16:37:34 INFO - no previously-included directories found matching 'build' 16:37:34 INFO - no previously-included directories found matching 'dist' 16:37:34 INFO - no previously-included directories found matching '.git*' 16:37:34 INFO - Successfully installed jsonschema functools32 16:37:34 INFO - Cleaning up... 16:37:34 INFO - Return code: 0 16:37:34 INFO - Installing flake8 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', '--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 0x7f0296939f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1527160>, '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 0x1528060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15284f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', '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', '--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:34 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: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': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', 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 - Downloading/unpacking flake8 16:37:34 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:34 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:34 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:34 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:34 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:34 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:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:37:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:37:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:37:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:37:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:37:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:37:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:36 INFO - no previously-included directories found matching 'docs/_build' 16:37:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:37:36 INFO - Running setup.py install for pep8 16:37:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:37 INFO - no previously-included directories found matching 'docs/_build' 16:37:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:37:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:37:37 INFO - Cleaning up... 16:37:37 INFO - Return code: 0 16:37:37 INFO - Running post-action listener: _resource_record_post_action 16:37:37 INFO - Running post-action listener: _start_resource_monitoring 16:37:37 INFO - Starting resource monitoring. 16:37:37 INFO - ##### 16:37:37 INFO - ##### Running install step. 16:37:37 INFO - ##### 16:37:37 INFO - Running pre-action listener: _resource_record_pre_action 16:37:37 INFO - Running main action method: install 16:37:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:37 INFO - Reading from file tmpfile_stdout 16:37:37 INFO - Detecting whether we're running mozinstall >=1.0... 16:37:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:37:37 INFO - Reading from file tmpfile_stdout 16:37:37 INFO - Output received: 16:37:37 INFO - Usage: mozinstall [options] installer 16:37:37 INFO - Options: 16:37:37 INFO - -h, --help show this help message and exit 16:37:37 INFO - -d DEST, --destination=DEST 16:37:37 INFO - Directory to install application into. [default: 16:37:37 INFO - "/builds/slave/test"] 16:37:37 INFO - --app=APP Application being installed. [default: firefox] 16:37:37 INFO - mkdir: /builds/slave/test/build/application 16:37:37 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:37 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:37:50 INFO - Reading from file tmpfile_stdout 16:37:50 INFO - Output received: 16:37:50 INFO - /builds/slave/test/build/application/firefox/firefox 16:37:50 INFO - Running post-action listener: _resource_record_post_action 16:37:50 INFO - ##### 16:37:50 INFO - ##### Running run-tests step. 16:37:50 INFO - ##### 16:37:50 INFO - Running pre-action listener: _resource_record_pre_action 16:37:50 INFO - Running main action method: run_tests 16:37:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:37:50 INFO - Python 2.7.3 16:37:50 INFO - Return code: 0 16:37:50 INFO - grabbing minidump binary from tooltool 16:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:50 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 0x1527160>, '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 0x1528060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15284f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:37:50 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:37:50 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:37:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:37:50 INFO - Return code: 0 16:37:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:37:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:37:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:37:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:37:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:37:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:37:51 INFO - Return code: 0 16:37:51 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-062', '--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:37:51 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-062 --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:37:51 INFO - Using env: {'DISPLAY': ':0', 16:37:51 INFO - 'HOME': '/home/cltbld', 16:37:51 INFO - 'LANG': 'en_US.UTF-8', 16:37:51 INFO - 'LANGUAGE': 'en_US:en', 16:37:51 INFO - 'LOGNAME': 'cltbld', 16:37:51 INFO - 'MAIL': '/var/mail/cltbld', 16:37:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:37:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:51 INFO - 'MOZ_NO_REMOTE': '1', 16:37:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:51 INFO - 'NO_EM_RESTART': '1', 16:37:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:51 INFO - 'PWD': '/builds/slave/test', 16:37:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:37:51 INFO - 'SHELL': '/bin/bash', 16:37:51 INFO - 'SHLVL': '1', 16:37:51 INFO - 'TERM': 'linux', 16:37:51 INFO - 'TMOUT': '86400', 16:37:51 INFO - 'USER': 'cltbld', 16:37:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600', 16:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:51 INFO - '_': '/tools/buildbot/bin/python'} 16:37:51 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-062', '--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:37:51 INFO - mozversion application_buildid: 20160526140250 16:37:51 INFO - mozversion application_changeset: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 16:37:51 INFO - mozversion application_display_name: Firefox 16:37:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:37:51 INFO - mozversion application_name: Firefox 16:37:51 INFO - mozversion application_remotingname: firefox 16:37:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:37:51 INFO - mozversion application_vendor: Mozilla 16:37:51 INFO - mozversion application_version: 47.0 16:37:51 INFO - mozversion platform_buildid: 20160526140250 16:37:51 INFO - mozversion platform_changeset: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 16:37:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:37:51 INFO - mozversion platform_version: 47.0 16:37:51 INFO - using testdate: 1464651471 16:37:51 INFO - actual date: 1464651471 16:37:51 INFO - starting webserver on 'localhost:47891' 16:37:51 INFO - SUITE-START | Running 2 tests 16:37:51 INFO - TEST-START | dromaeo_css 16:37:51 INFO - operating with platform_type : linux_ 16:37:51 INFO - Initialising browser for dromaeo_css test... 16:37:51 INFO - TEST-INFO | started process 19384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpudlYSb/profile http://localhost:47891/getInfo.html) 16:37:55 INFO - PROCESS | 19384 | __metrics Screen width/height:1600/1200 16:37:55 INFO - PROCESS | 19384 | colorDepth:24 16:37:55 INFO - PROCESS | 19384 | Browser inner width/height: 1024/697 16:37:55 INFO - PROCESS | 19384 | __metrics 16:37:56 INFO - PROCESS | 19384 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:37:56 INFO - TEST-INFO | 19384: exit 0 16:37:56 INFO - Browser initialized. 16:37:56 INFO - Running cycle 1/1 for dromaeo_css test... 16:37:56 INFO - TEST-INFO | started process 19471 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpudlYSb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:08 INFO - PROCESS | 19471 | RSS: Main: 139505664 16:38:08 INFO - PROCESS | 19471 | 16:38:59 INFO - PROCESS | 19471 | 1464651539396 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:07 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:47891/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47891/tests/dromaeo/cssquery-ext.html) 16:41:08 INFO - PROCESS | 19471 | RSS: Main: 246829056 16:41:08 INFO - PROCESS | 19471 | 16:44:10 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:47891/tests/dromaeo/cssquery-ext.html (next: http://localhost:47891/tests/dromaeo/cssquery-jquery.html) 16:44:10 INFO - PROCESS | 19471 | RSS: Main: 229351424 16:44:10 INFO - PROCESS | 19471 | 16:47:12 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:47891/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47891/tests/dromaeo/cssquery-mootools.html) 16:47:13 INFO - PROCESS | 19471 | RSS: Main: 215556096 16:47:13 INFO - PROCESS | 19471 | 16:50:14 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:47891/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47891/tests/dromaeo/cssquery-prototype.html) 16:50:15 INFO - PROCESS | 19471 | RSS: Main: 203911168 16:50:15 INFO - PROCESS | 19471 | 16:53:17 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:47891/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47891/tests/dromaeo/cssquery-yui.html) 16:53:18 INFO - PROCESS | 19471 | RSS: Main: 202133504 16:53:18 INFO - PROCESS | 19471 | 16:56:20 INFO - PROCESS | 19471 | Cycle 1(1): loaded http://localhost:47891/tests/dromaeo/cssquery-yui.html (next: http://localhost:47891/tests/dromaeo/cssquery-dojo.html) 16:56:20 INFO - PROCESS | 19471 | RSS: Main: 241885184 16:56:20 INFO - PROCESS | 19471 | 16:56:20 INFO - PROCESS | 19471 | __start_tp_report 16:56:20 INFO - PROCESS | 19471 | _x_x_mozilla_page_load 16:56:20 INFO - PROCESS | 19471 | _x_x_mozilla_page_load_details 16:56:20 INFO - PROCESS | 19471 | |i|pagename|runs| 16:56:20 INFO - PROCESS | 19471 | |0;dojo.html;3290.1445624137723;3323.102762254193;3324.9194011946115;3328.7669863109577;3363.0079126657633;5339.172428273619;5341.305630268064;5363.839084827452;5375.973120134394;5385.892282154359;5309.575233981282;5331.306930099091;5336.519713225809;5342.332208473941;5345;4812.68717533361;4884.53596908294;4916.459189489154;4990.65065445419;5000.5999520038495;4855.975720121394;4918.729469879156;4952.826651067214;4968.726720030397;4977.751112444382;4888.9511104889025;4950;4980.153373926441;4991.251312303148;4999.050180465718;4823.890505183792;4929.950700492985;4943.826966056189;4953.108440480712;4956.231784073474;4794.5684888359865;4820.0841840050625;4859.343988561534;4873.537013983666;4917.36074310341;5134.486551344873;5138.922916156223;5144.125498665236;5145.819896303611;5161.303224064778;5696.458836410535;5701.743421546041;5702.657840529581;5719.656820590736;5734.799282025109;5679.488846003838;5684;5723.771049158028;5781.248437703114;5811.302643682743;5417.349918009824;5440.619156659035;5440.7551660174995;5444.863878403072;5446.673199607996;5895.616784909053;5906.143609176645;5944.167816505693;5956.672383018976;5959.046552551571;5500.257465242221;5567;5570.415106413769;5589.524890384281;5597.524210442077;5677.233573467612;5734.168545560954;5740.942590574125;5746.798862039808;5747.741351639186;5580.972095139579;5703.230063941398;5722.599418040781;5723.7424315905055;5729.5702822288495;5799.768009279582;5807;5812.331581868139;5822.1266809978;5848.356680765112;4370.21336159488;4394.055278115221;4406.647468202536;4420.248557745191;4445.555444455593;3838.3091043612417;3909.159530700856;3957.248122856648;3965.940510892339;4009.358502639622;5552.583556233218;5564.026295398289;5566.304211973504;5572.693501857437;5576.776928922797;5765.423457654285;5806.854828629233;5807.128930660435;5809.88380232393;5814.912776308359;5411.485908838654;5522.585806064561;5538.889222215533;5600.159976003632;5619.662820230717;4940.987097645046;4964.851054468371;4968.975155124273;4975.378077740283;5000.224965130411;5965.105234214902;6005.789797357072;6011.819645410645;6015;6022.668753218615;5696.287964004582;5740.799072032459;5814.709264536841;5816.534677225727;5825.98045342072;6031.065184896348;6032.577719559764;6040.1241819934985;6044.607100538451;6047.244094488189;5592.189132575835;5691.288588926384;5692.1461780733225;5694.1458781183155;5705.429457054262;5803.82588522345;5854.707264636666;5860.619059761102;5860.677662728591;5893.5874488785375;5633.718314084197;5635.915461268002;5642.153676948491;5646.943530564642;5647;5519.475649813261;5579.497845193952;5639.210510528611;5639.8590035249445;5643.548516118619;5511.5039646432015;5607.971960140173;5615.6630602164005;5630.930123276565;5658.830235092953;5656.547476201977;5711.3431955324;5720.399358067343;5721.971390143022;5733.598648094593;5450.836474905759;5568.443155684399;5605.271314729059;5610.298712660918;5610.803621873378 16:56:20 INFO - PROCESS | 19471 | |1;ext.html;471.38719664436246;516.1741214057506;534.663162207809;541.480179028133;549.6097770582886;31935.840320798394;32549;32579.67420325796;32588.511172332433;32621.673783262162;41270.79364603173;41411.37882931758;41692.37461438081;41694;41765.164696706044;8877.46735195887;9112.134347237035;9112.544372781334;9119.589618467186;9122.315826313019;8869.290456763476;8955.507447090407;8997.865032024525;9011.414258073237;9015;9016.729498115066;9083.227925626297;9088.50013249271;9088.772780680503;9093.045230250827;8971.685990990316;9047.230985366252;9054.818903621923;9058.139476749699;9064.138906803842;8901.554922253861;9039.412438191497;9238.122378374044;9285.953570232174;9289.90710092904;44339;44682.553174468165;44805;44833.32750008752;44862.10275794466;3577.177249232665;3695.3533131701843;3777.320082385197;3950.2889479893606;4442.244818380883;29215.70784292151;29588.260293492618;29672;29697.851510742523;31148;3978.5822488638855;4258.446401967755;4329.7618630975285;4335.631471324941;4382.627476664487;292524;293642;294124;294796.5260173707;295540;46007.53992460033;46387.6083717489;70131.29868701349;70627.64686176536;70853;44855.327170092474;44918.55081449209;44947;45037.77481112573;45053.32420013702;16461.34154633825;16673.24970376336;16685.082320472247;16685.082320472247;16688.6662266754;13351.265680387478;13384.130031547918;13394.062415631008;13395.933020334836;13418.597442076558;15365.769513457308;15917.363305467883;15926.28331725052;15941.920290398706;15950.202489875692;5871.207387002785;6009.338972712998;6100.786472473531;6238.91705587049;6245;1049.490996866519;1073.1901748791759;1088.2273585754203;1095.9533645368654;1142.765733024728;30990.0702978911;31200.531992020136;31304.686953130633;33028;35758.64241357605;1071.9303245289186;1072.951717172729;1081.588996181446;1208.7763763703742;1276.942537585811;16117.355305787873;16201.108939008467;16288.592785180228;16307.755383669255;16427.671446571003;196962;197332;197548;197905;198635;59599;59954.10068848971;60017.39982600205;60031;60251.39748602458;1328.110166188656;1448.891333150018;1483.1620134623904;1516.7876497290388;1541.352631894607;30663.540046898866;32387;32755;33358.83320583381;33737.66262337443;53210.4678953221;53993.730031349594;54044;54111;54122.45877541174;308490;310941;311822;312692;312821;35176;36979;36980.260394792494;37002;37017.51929922773;46294;47140.29289560728;47286.527134729586;47588.2861757067;47609.04781904412;39472.40791388074;39999.80000099981;40136.39795403013;40148.799256003535;40606.59393406028;38415;39291;39983.60016399799;40091;40711.79644101761;39097.6090239094;39608.60391396165;40813.1837363257;41058.1788364237;41123.1775364497;33534.66465335315;35403.645963541065;35496.82251588725;35763.46354804732;35954.64045359513;26986.595201072392;26998.595021074307;27038.594421083308;27143.1857044289;27576.448471030868 16:56:20 INFO - PROCESS | 19471 | |2;jquery.html;346.78152763758845;361.80824163193506;362.1001810500905;363.11037957005345;371.7286380941914;17909.283628654855;18083;19418.805811941875;19431.31990380337;19449.902750486246;17970;18600.81399186008;18792.06039698013;18792.81207187931;18793;5531.695756733368;5777.566682498808;5831.766729330821;5835.35811060783;5851.327097383792;4328.4156638853665;5719.428057194289;6081.087836824468;6324.146240257575;6349.968250158743;6294.968525157391;6298.3701629837105;6326.240851097875;6331.050342448623;6343.777967771129;6102.816915492543;6335.366463353651;6337.588056776341;6344.809655710313;6351.174347334863;3929.0766669832565;5290.57675385972;5483.451654834525;5491.231227628095;5596.27248457702;20753.27363542284;21404.46488837776;21551.892240538855;21621.35135945924;21657.133714651394;2472.986075708951;2557.3223095879607;2653.230563136707;2675.929628148737;3129.874805007797;13387;14182.29088545579;14345.569632911029;14348.06737562055;14386.280685965765;1926.7976862429384;1952.4142757172933;1974.6346925818625;1975.5061234691327;2051.415346626204;63792.36207637957;67959;69101.65449172723;69952.65023674951;70134.29865701329;9960.352577082467;10179.694609161737;10319.896801032044;10348.948255258827;10457.372557646566;14592.124472531683;14609.488667896785;14617.122972621464;14749.557513274618;14819.925900370428;8053.395995300376;8142;8196.098429172785;8246.505209687439;8261.091279959199;8188.14024527428;8245.340372770164;8259.545724985184;8292.958535207285;8345.582720864053;4571.839985600488;4693.647976401783;4702;4703.3885594872445;4712.104700106968;1771.1112713636542;1792.2293413832178;1849.306510058728;1897.3074827687794;1906.428071578521;857.6440777077568;907.1880666803174;911.3893691226893;1031.5306535526317;1036.8237399642078;17024.31902723902;17686.734698979526;17843.365256491346;17990.820091799178;18046.729299060524;947.9952600236954;948.1750876737145;968.7142293023575;1042.374575254841;1052.5789684126257;9673.661421850202;9675.371100878561;9843.753906152404;9981.900180998096;10048;473810;476954;493196;496720;498260;67536.6623166881;68696.65651671709;71939.6403017992;76385.23614763781;78188.6090569555;1024.6106479537727;1053.5311786255043;1079.3469950679882;1080.9567617295377;1081.7721885659676;15409.76885346743;15429.922850386125;15449.150296733338;15464.922675386551;15566.455174068853;33441.83279083589;33817.15457113592;34909.476357854146;35622.82188589041;36110;47178.76410618062;49260;50649.49350506448;51038.234426482886;51628;8286.544240066854;8554.230119289294;8565.27195188416;8656;8656.264217541328;10258.53836577341;12984.15602985803;13023.088383813041;13200.669983250496;13321;6586.637734924625;10674.786504269716;10954.123670106213;11032.393218372745;11226.663200103683;11244.03229434862;11662.825057623973;11695.181337306307;11703.707407314885;11860.822087668519;11730.296182229093;11773.587924422603;11851.940740296242;11863.644090677293;11864.940675296913;8192.67229310821;8352.87470687928;8545.273651739672;8673.566321683764;8934.927808663002;9782.315237933277;11326.83009754871;11363.659090227306;11474.655760327203;11501 16:56:20 INFO - PROCESS | 19471 | |3;mootools.html;1464.143476066501;1604.4544854749383;1608.4852847088928;1859.2284202056148;1961.1076959983209;7900.486468379559;8071.596420178989;8077.757667269977;8083.272505474506;8094.554799486041;8033.678652853879;8182.877256841152;8184.099749027617;8193.139720329369;8195.836083278331;2422.382292515406;2433.0754313360985;2441.7680320369536;2450.4486490539575;2450.4608986023045;2418.04487227545;2454.987725061372;2495.4510007798253;2510.046182450666;2517.7356377580363;2454.349597356702;2455.054803900502;2458.090506512593;2459.766322199397;2467.864267465289;2391.703964194367;2399.4241382068353;2417.625268083441;2437.926862194137;2443.706755189371;2415.130553000918;2427.7936375408112;2442.2673198040693;2443.0472115874823;2445.315311712723;8266.710665126691;8305.875411868827;8310.335173186131;8320.83358332836;8326.12575679557;5101.770420331094;5316.069687804657;5323.840284791462;5324.1215199492035;5353.759080841332;3244.9675503244903;3261.7553683473834;3302.5211344354934;3358;3358.3786999404942;1032.4166845732138;1069.0325255643577;1080.6271836216492;1960.362882063335;1996.9700454493195;11170.162237832195;11240.213185077047;11247.66257012291;11285.717857053558;11350.602728904449;4536.909261814745;4598.471175814757;4680.3915490985955;4697.8355757548325;4698.506656801055;8832.690855820016;8838.779030524289;8846.867296990551;8851.557422128868;8869.556522173865;5226.764795584208;5289.259503669412;5317.229001794718;5318.095923692981;5331.86670333237;4150.979245103756;4163.354680024601;4164.958350416457;4713.269443236304;4835.879103022453;3679.576848662438;3718.4050551911564;3741.9251614967548;3762.736608437383;3805.46723458716;1155.8959693627614;1156.7512984708328;1161.355447726503;1166.731651720109;1176.4353110506834;1347.7574036673493;1374.1274290825397;1374.7731624281882;1442.6826098258366;1446.833614134367;7519.774406767806;7823.217678232131;7850.450468467153;7852.921470785333;7863.0957439894;495.6431369414016;504.27888119988035;510.03094121169335;512.4747134187488;521.4733119549282;6024.939750602525;6031.849203769941;6042.788502402483;6091.969540152271;6098.420650038239;9921.107100360858;10000.549975251131;10136.746581335525;10161.796764064677;10175.949120254352;9733.756656083513;9817.656382026738;9846.901530984742;9982.900170998342;10010.54952527138;8002.399820013522;8074.636641351153;8131.14622964592;8147.918520814835;8160.6327715252955;7988.6405111768945;8011.038675358995;8096.595170241582;8098.271155596025;8098.878516822135;8726.301895848444;8949.373543851867;9480.34094033555;9548.474833884204;9596.040395960626;8880.555972201493;8952.328575357005;9034.86447703272;9159.313051521029;9332.81334373295;6654.168228971379;7143.678534465857;7188.928110719035;7279.59962202084;7319.451041171827;7930.127685954656;7941.920580794349;7955.602219889098;7988.480748751545;8013.519188848454;7061;7166.641667916479;7181.102362204724;7296.598687072262;7298.37963773064;7039.788806335613;7144.571325720473;7147.714091436284;7191.42468602521;7245.855082898207;7292.854142917218;7409.2590740927635;7443.55338679681;7448;7456.51532650376;6759.188897332351;6821.727130914708;6825.89761153593;6830.112085428863;6837.555558888656;6762.357576030269;6773.830654233683;6775.830604234933;6787.015882696883;6790.694418751069 16:56:20 INFO - PROCESS | 19471 | |4;prototype.html;323.3436124666926;326.2056891469272;327.95572597699316;338.65626389214935;345.65607220815275;5780.450857168573;5810.3899090595405;5818.185454036438;5828;5833.70831458427;5703.5722320826;5713.257276554042;5720.9713951430285;5731.254936858202;5815.47660710536;4329.891752706192;4415.690901636886;4513.390692256537;4543.2957891526785;4592.311153326994;4559.544045595447;4566.611837993774;4574.290984897346;4578.35902973584;4610.561996610317;4518;4532.274836026237;4532.614727748145;4533.546645335457;4540.500544940054;4276.914461710764;4380.364847097169;4501.864944051684;4506.369108324837;4514.413126293593;3955.48578684772;3963.3948250958406;3965.048388386795;3973.264945985002;3974.682025437958;5550.4449555044175;5553.972230138824;5569.8607534811545;5571.220029195916;5573.581981351374;5208.609354298443;5210.036143313461;5214.608904332153;5217.478252174752;5221.921671174935;6163.568550201488;6171.87656246877;6179.845503862394;6201.751929922798;6205.069239614094;4108.116754897711;4227.577242275778;4232.936505952413;4396.340548917656;4400.73595584266;6328.683565821737;6412.7114279857515;6442.806715798487;6450.290468048511;6467.579607325556;4399.670024748157;4402.031553058322;4406.361077643724;4410.801513931817;4411.228035093845;4463.509014008457;4475.9552404475535;4476.9104617908115;4478.708883922534;4479.574440428154;5150.690958542499;5165.9225111623355;5169.81905633301;5171.9482805171465;5176.792928282826;6016.278046634432;6232.034034724625;6234.594751341148;6241.157443745036;6241.282252540925;1542.730022246125;1558.688262347535;1576.3694522190985;1580.47484177769;1585.5322679809483;960.6013504395737;1002.283367392318;1003.7992401519725;1013.1489548779061;1035.4512108582464;5963.2844058713235;6057.545684073712;6096.420840020191;6204.906926396107;6206.317305096436;6324.620522768649;6361.14124593174;6363.61818290904;6367.204099487564;6382.6170429774365;6086.269647642312;6100.908486372708;6125.081237814275;6125.418085281891;6125.9693701531205;3390.8643654254047;3429.159855835336;3430.8627654894026;3431.039308993486;3441.6042155151977;6510.576812507172;6652.933470665328;6663.400293973566;6665.700043498055;6688.966555167193;6466.773662921775;6500.252470965805;6501.414872661483;6510.414062734377;6510.739570417225;6638.236602790645;6641.800745977628;6643.10318107059;6651.201855777338;6652.101966234496;6304.306526282197;6339.4928405726505;6356.77751278703;6360.268569114611;6364.77723279683;6087.4521293083835;6215.844603884939;6222.81331560054;6225.782097626561;6240.563160578716;6616;6636;6636.170478690164;6636.369544893228;6644.435223006099;4371.912561748683;4379.167958087953;4381.496127945327;4382.430284063052;4386.64906807461;6335.208098987627;6335.271443784024;6335.556511044183;6338.271098823694;6350.174477317919;6176.135341052346;6183.227096612924;6230.314665386713;6264.404881536247;6270.874582508415;6041.516678665608;6161.322254552086;6162.938370616416;6171.7531298749345;6190.102435146789;6011.6693581853415;6030.30651475086;6053.213082299449;6055.364186760326;6062.120992456157;6184.969075154595;6197.81406557804;6198.380161983766;6199.070139479114;6213.099100630293;5873.500752436091;5979.880402392015;6057.515398768176;6060.333363330118;6078.908816367846 16:56:20 INFO - PROCESS | 19471 | |5;yui.html;652.6569615081856;689.6586189836032;710.5274992130234;716.8136284566011;738.7635956493922;14279.571612851618;14383.928080359598;14556.636084097903;14576.125432474058;14615.634609134777;13769;13796;13815.585532434017;13903.582892513215;13909.93045034776;770.437580566187;913.5021413329717;917.2020342302206;941.1059493481187;942.7831598732296;927.8144371125768;928.9256859451261;930.5393830054132;935.8642996765465;936.0873148680016;980.7793246519511;986.5609803637384;987.8913319534845;988.0712130597251;989.945552994585;796.7848680856165;966.6568368229283;969.3699095587854;975.5366201054513;976.8876579193377;714.7962830593308;718.0199028326349;719.8380364417964;719.9028131202273;726.6475759256756;12709.300988445631;12754.426050827735;12757.17078389911;12760.936195319056;12767.23396596198;14235.359408826627;14477;14686.339114739862;14722.337494812758;14796.778048329175;11364.488598013026;11371.545138194462;11378.829317560243;11403.657890263305;11590.246633968765;3876.3604005339084;3899.98050009751;3901.5903330150495;3974.7018973577096;4035.1727895781296;52260.21609675858;52283;52311.476885231044;52886.735566322306;53502.929941401344;11064.114870810316;11087.390193539433;11193.49629266685;11286.548538058385;11418.942905285421;18051.368202112862;18143.18355673998;18162.909185453987;18162.909185454253;18163.182656780213;7171;7349.63251837406;7860.685572577033;7932.365410767125;8132.512049277062;4281.079567892918;4357.9128417431475;4388.188185185751;4491.708038977521;4704.811807527729;3259.674032596769;3274.1323549259464;3279.1146390474437;3289.227031647561;3291.489819078047;527.6016607461343;576.3170642788225;587.8001479496907;593.2939801636039;623.2676604989119;565.6351653183756;569.0269638917415;590.9497692696083;606.2240332374568;609.5458883132095;8258.132896045949;8269.62786674601;8530.274926631306;8532.786680333042;8730.86903696445;603.471962033221;610.6458254212546;618.6288227063816;711.4521818199958;722.4437183368882;4182.644475219579;4208.410822484854;4262.2754131797665;4275.29457639486;4292.420523229386;56829.431705682415;57572;58077.4192258072;58383.12425313624;58469;52588.47411525912;52832.207516887276;53499.46500534945;53732.19401708977;55242;48093.27860082102;48230.27654585184;48509.999999999294;48651.27023094657;49091.263631045564;8468.153184681483;8646.956765216133;8692.739217823475;8724.956375218337;8788.780280493038;34856.47715284323;36216;36994.44508332431;37188.81405592955;38161.23677526379;40981.38527922143;43159;44713.10573788571;44801.55198447974;46061.30908036315;10846.945765271123;11138.498767555317;11500.712482187677;11553.364564948672;11731.472083756422;10995.34027958325;11636.650900473;11878.168528202943;12751.74496510046;13476.32618369058;10278.845817312897;11579.247348922294;11754.823677645014;12390.194637348544;12554.121211515107;12034.398280086136;12404.081246483058;12454.688632784253;13051.804222936473;13213.603591892259;11139.944300278446;11443.713907152054;11592.6522204334;12009.219400738924;12311.322877241837;9989.900100998897;10593.735156620838;10621.8937810624;10722.303050301705;11049.171312151782;9955.599652734714;10126.088652021353;10133.797324053625;10205.183585313305;10537 16:56:20 INFO - PROCESS | 19471 | __end_tp_report 16:56:20 INFO - PROCESS | 19471 | __start_cc_report 16:56:20 INFO - PROCESS | 19471 | _x_x_mozilla_cycle_collect,837 16:56:20 INFO - PROCESS | 19471 | __end_cc_report 16:56:20 INFO - PROCESS | 19471 | __startTimestamp1464652580875__endTimestamp 16:56:20 INFO - PROCESS | 19471 | 16:56:20 INFO - PROCESS | 19471 | ------- Summary: start ------- 16:56:20 INFO - PROCESS | 19471 | Number of tests: 6 16:56:20 INFO - PROCESS | 19471 | 16:56:20 INFO - PROCESS | 19471 | [#0] dojo.html Cycles:165 Average:5366.01 Median:5589.52 stddev:590.19 (10.6%) stddev-sans-first:569.09 16:56:20 INFO - PROCESS | 19471 | Values: 3290.1 3323.1 3324.9 3328.8 3363.0 5339.2 5341.3 5363.8 5376.0 5385.9 5309.6 5331.3 5336.5 5342.3 5345.0 4812.7 4884.5 4916.5 4990.7 5000.6 4856.0 4918.7 4952.8 4968.7 4977.8 4889.0 4950.0 4980.2 4991.3 4999.1 4823.9 4930.0 4943.8 4953.1 4956.2 4794.6 4820.1 4859.3 4873.5 4917.4 5134.5 5138.9 5144.1 5145.8 5161.3 5696.5 5701.7 5702.7 5719.7 5734.8 5679.5 5684.0 5723.8 5781.2 5811.3 5417.3 5440.6 5440.8 5444.9 5446.7 5895.6 5906.1 5944.2 5956.7 5959.0 5500.3 5567.0 5570.4 5589.5 5597.5 5677.2 5734.2 5740.9 5746.8 5747.7 5581.0 5703.2 5722.6 5723.7 5729.6 5799.8 5807.0 5812.3 5822.1 5848.4 4370.2 4394.1 4406.6 4420.2 4445.6 3838.3 3909.2 3957.2 3965.9 4009.4 5552.6 5564.0 5566.3 5572.7 5576.8 5765.4 5806.9 5807.1 5809.9 5814.9 5411.5 5522.6 5538.9 5600.2 5619.7 4941.0 4964.9 4969.0 4975.4 5000.2 5965.1 6005.8 6011.8 6015.0 6022.7 5696.3 5740.8 5814.7 5816.5 5826.0 6031.1 6032.6 6040.1 6044.6 6047.2 5592.2 5691.3 5692.1 5694.1 5705.4 5803.8 5854.7 5860.6 5860.7 5893.6 5633.7 5635.9 5642.2 5646.9 5647.0 5519.5 5579.5 5639.2 5639.9 5643.5 5511.5 5608.0 5615.7 5630.9 5658.8 5656.5 5711.3 5720.4 5722.0 5733.6 5450.8 5568.4 5605.3 5610.3 5610.8 16:56:20 INFO - PROCESS | 19471 | 16:56:20 INFO - PROCESS | 19471 | [#1] ext.html Cycles:180 Average:45238.74 Median:39381.70 stddev:71070.00 (180.5%) stddev-sans-first:71189.88 16:56:20 INFO - PROCESS | 19471 | Values: 471.4 516.2 534.7 541.5 549.6 31935.8 32549.0 32579.7 32588.5 32621.7 41270.8 41411.4 41692.4 41694.0 41765.2 8877.5 9112.1 9112.5 9119.6 9122.3 8869.3 8955.5 8997.9 9011.4 9015.0 9016.7 9083.2 9088.5 9088.8 9093.0 8971.7 9047.2 9054.8 9058.1 9064.1 8901.6 9039.4 9238.1 9286.0 9289.9 44339.0 44682.6 44805.0 44833.3 44862.1 3577.2 3695.4 3777.3 3950.3 4442.2 29215.7 29588.3 29672.0 29697.9 31148.0 3978.6 4258.4 4329.8 4335.6 4382.6 292524.0 293642.0 294124.0 294796.5 295540.0 46007.5 46387.6 70131.3 70627.6 70853.0 44855.3 44918.6 44947.0 45037.8 45053.3 16461.3 16673.2 16685.1 16685.1 16688.7 13351.3 13384.1 13394.1 13395.9 13418.6 15365.8 15917.4 15926.3 15941.9 15950.2 5871.2 6009.3 6100.8 6238.9 6245.0 1049.5 1073.2 1088.2 1096.0 1142.8 30990.1 31200.5 31304.7 33028.0 35758.6 1071.9 1073.0 1081.6 1208.8 1276.9 16117.4 16201.1 16288.6 16307.8 16427.7 196962.0 197332.0 197548.0 197905.0 198635.0 59599.0 59954.1 60017.4 60031.0 60251.4 1328.1 1448.9 1483.2 1516.8 1541.4 30663.5 32387.0 32755.0 33358.8 33737.7 53210.5 53993.7 54044.0 54111.0 54122.5 308490.0 310941.0 311822.0 312692.0 312821.0 35176.0 36979.0 36980.3 37002.0 37017.5 46294.0 47140.3 47286.5 47588.3 47609.0 39472.4 39999.8 40136.4 40148.8 40606.6 38415.0 39291.0 39983.6 40091.0 40711.8 39097.6 39608.6 40813.2 41058.2 41123.2 33534.7 35403.6 35496.8 35763.5 35954.6 26986.6 26998.6 27038.6 27143.2 27576.4 16:56:20 INFO - PROCESS | 19471 | 16:56:20 INFO - PROCESS | 19471 | [#2] jquery.html Cycles:180 Average:27465.82 Median:35266.15 stddev:79807.29 (226.3%) stddev-sans-first:80005.19 16:56:20 INFO - PROCESS | 19471 | Values: 346.8 361.8 362.1 363.1 371.7 17909.3 18083.0 19418.8 19431.3 19449.9 17970.0 18600.8 18792.1 18792.8 18793.0 5531.7 5777.6 5831.8 5835.4 5851.3 4328.4 5719.4 6081.1 6324.1 6350.0 6295.0 6298.4 6326.2 6331.1 6343.8 6102.8 6335.4 6337.6 6344.8 6351.2 3929.1 5290.6 5483.5 5491.2 5596.3 20753.3 21404.5 21551.9 21621.4 21657.1 2473.0 2557.3 2653.2 2675.9 3129.9 13387.0 14182.3 14345.6 14348.1 14386.3 1926.8 1952.4 1974.6 1975.5 2051.4 63792.4 67959.0 69101.7 69952.7 70134.3 9960.4 10179.7 10319.9 10348.9 10457.4 14592.1 14609.5 14617.1 14749.6 14819.9 8053.4 8142.0 8196.1 8246.5 8261.1 8188.1 8245.3 8259.5 8293.0 8345.6 4571.8 4693.6 4702.0 4703.4 4712.1 1771.1 1792.2 1849.3 1897.3 1906.4 857.6 907.2 911.4 1031.5 1036.8 17024.3 17686.7 17843.4 17990.8 18046.7 948.0 948.2 968.7 1042.4 1052.6 9673.7 9675.4 9843.8 9981.9 10048.0 473810.0 476954.0 493196.0 496720.0 498260.0 67536.7 68696.7 71939.6 76385.2 78188.6 1024.6 1053.5 1079.3 1081.0 1081.8 15409.8 15429.9 15449.2 15464.9 15566.5 33441.8 33817.2 34909.5 35622.8 36110.0 47178.8 49260.0 50649.5 51038.2 51628.0 8286.5 8554.2 8565.3 8656.0 8656.3 10258.5 12984.2 13023.1 13200.7 13321.0 6586.6 10674.8 10954.1 11032.4 11226.7 11244.0 11662.8 11695.2 11703.7 11860.8 11730.3 11773.6 11851.9 11863.6 11864.9 8192.7 8352.9 8545.3 8673.6 8934.9 9782.3 11326.8 11363.7 11474.7 11501.0 16:56:20 INFO - PROCESS | 19471 | 16:56:20 INFO - PROCESS | 19471 | [#3] mootools.html Cycles:180 Average:5790.31 Median:6028.39 stddev:2983.87 (49.5%) stddev-sans-first:2974.52 16:56:20 INFO - PROCESS | 19471 | Values: 1464.1 1604.5 1608.5 1859.2 1961.1 7900.5 8071.6 8077.8 8083.3 8094.6 8033.7 8182.9 8184.1 8193.1 8195.8 2422.4 2433.1 2441.8 2450.4 2450.5 2418.0 2455.0 2495.5 2510.0 2517.7 2454.3 2455.1 2458.1 2459.8 2467.9 2391.7 2399.4 2417.6 2437.9 2443.7 2415.1 2427.8 2442.3 2443.0 2445.3 8266.7 8305.9 8310.3 8320.8 8326.1 5101.8 5316.1 5323.8 5324.1 5353.8 3245.0 3261.8 3302.5 3358.0 3358.4 1032.4 1069.0 1080.6 1960.4 1997.0 11170.2 11240.2 11247.7 11285.7 11350.6 4536.9 4598.5 4680.4 4697.8 4698.5 8832.7 8838.8 8846.9 8851.6 8869.6 5226.8 5289.3 5317.2 5318.1 5331.9 4151.0 4163.4 4165.0 4713.3 4835.9 3679.6 3718.4 3741.9 3762.7 3805.5 1155.9 1156.8 1161.4 1166.7 1176.4 1347.8 1374.1 1374.8 1442.7 1446.8 7519.8 7823.2 7850.5 7852.9 7863.1 495.6 504.3 510.0 512.5 521.5 6024.9 6031.8 6042.8 6092.0 6098.4 9921.1 10000.5 10136.7 10161.8 10175.9 9733.8 9817.7 9846.9 9982.9 10010.5 8002.4 8074.6 8131.1 8147.9 8160.6 7988.6 8011.0 8096.6 8098.3 8098.9 8726.3 8949.4 9480.3 9548.5 9596.0 8880.6 8952.3 9034.9 9159.3 9332.8 6654.2 7143.7 7188.9 7279.6 7319.5 7930.1 7941.9 7955.6 7988.5 8013.5 7061.0 7166.6 7181.1 7296.6 7298.4 7039.8 7144.6 7147.7 7191.4 7245.9 7292.9 7409.3 7443.6 7448.0 7456.5 6759.2 6821.7 6825.9 6830.1 6837.6 6762.4 6773.8 6775.8 6787.0 6790.7 16:56:20 INFO - PROCESS | 19471 | 16:56:20 INFO - PROCESS | 19471 | [#4] prototype.html Cycles:180 Average:5184.56 Median:5971.58 stddev:1558.04 (26.1%) stddev-sans-first:1519.09 16:56:20 INFO - PROCESS | 19471 | Values: 323.3 326.2 328.0 338.7 345.7 5780.5 5810.4 5818.2 5828.0 5833.7 5703.6 5713.3 5721.0 5731.3 5815.5 4329.9 4415.7 4513.4 4543.3 4592.3 4559.5 4566.6 4574.3 4578.4 4610.6 4518.0 4532.3 4532.6 4533.5 4540.5 4276.9 4380.4 4501.9 4506.4 4514.4 3955.5 3963.4 3965.0 3973.3 3974.7 5550.4 5554.0 5569.9 5571.2 5573.6 5208.6 5210.0 5214.6 5217.5 5221.9 6163.6 6171.9 6179.8 6201.8 6205.1 4108.1 4227.6 4232.9 4396.3 4400.7 6328.7 6412.7 6442.8 6450.3 6467.6 4399.7 4402.0 4406.4 4410.8 4411.2 4463.5 4476.0 4476.9 4478.7 4479.6 5150.7 5165.9 5169.8 5171.9 5176.8 6016.3 6232.0 6234.6 6241.2 6241.3 1542.7 1558.7 1576.4 1580.5 1585.5 960.6 1002.3 1003.8 1013.1 1035.5 5963.3 6057.5 6096.4 6204.9 6206.3 6324.6 6361.1 6363.6 6367.2 6382.6 6086.3 6100.9 6125.1 6125.4 6126.0 3390.9 3429.2 3430.9 3431.0 3441.6 6510.6 6652.9 6663.4 6665.7 6689.0 6466.8 6500.3 6501.4 6510.4 6510.7 6638.2 6641.8 6643.1 6651.2 6652.1 6304.3 6339.5 6356.8 6360.3 6364.8 6087.5 6215.8 6222.8 6225.8 6240.6 6616.0 6636.0 6636.2 6636.4 6644.4 4371.9 4379.2 4381.5 4382.4 4386.6 6335.2 6335.3 6335.6 6338.3 6350.2 6176.1 6183.2 6230.3 6264.4 6270.9 6041.5 6161.3 6162.9 6171.8 6190.1 6011.7 6030.3 6053.2 6055.4 6062.1 6185.0 6197.8 6198.4 6199.1 6213.1 5873.5 5979.9 6057.5 6060.3 6078.9 16:56:20 INFO - PROCESS | 19471 | 16:56:20 INFO - PROCESS | 19471 | [#5] yui.html Cycles:180 Average:14380.85 Median:23758.46 stddev:16501.09 (69.5%) stddev-sans-first:16515.17 16:56:20 INFO - PROCESS | 19471 | Values: 652.7 689.7 710.5 716.8 738.8 14279.6 14383.9 14556.6 14576.1 14615.6 13769.0 13796.0 13815.6 13903.6 13909.9 770.4 913.5 917.2 941.1 942.8 927.8 928.9 930.5 935.9 936.1 980.8 986.6 987.9 988.1 989.9 796.8 966.7 969.4 975.5 976.9 714.8 718.0 719.8 719.9 726.6 12709.3 12754.4 12757.2 12760.9 12767.2 14235.4 14477.0 14686.3 14722.3 14796.8 11364.5 11371.5 11378.8 11403.7 11590.2 3876.4 3900.0 3901.6 3974.7 4035.2 52260.2 52283.0 52311.5 52886.7 53502.9 11064.1 11087.4 11193.5 11286.5 11418.9 18051.4 18143.2 18162.9 18162.9 18163.2 7171.0 7349.6 7860.7 7932.4 8132.5 4281.1 4357.9 4388.2 4491.7 4704.8 3259.7 3274.1 3279.1 3289.2 3291.5 527.6 576.3 587.8 593.3 623.3 565.6 569.0 590.9 606.2 609.5 8258.1 8269.6 8530.3 8532.8 8730.9 603.5 610.6 618.6 711.5 722.4 4182.6 4208.4 4262.3 4275.3 4292.4 56829.4 57572.0 58077.4 58383.1 58469.0 52588.5 52832.2 53499.5 53732.2 55242.0 48093.3 48230.3 48510.0 48651.3 49091.3 8468.2 8647.0 8692.7 8725.0 8788.8 34856.5 36216.0 36994.4 37188.8 38161.2 40981.4 43159.0 44713.1 44801.6 46061.3 10846.9 11138.5 11500.7 11553.4 11731.5 10995.3 11636.7 11878.2 12751.7 13476.3 10278.8 11579.2 11754.8 12390.2 12554.1 12034.4 12404.1 12454.7 13051.8 13213.6 11139.9 11443.7 11592.7 12009.2 12311.3 9989.9 10593.7 10621.9 10722.3 11049.2 9955.6 10126.1 10133.8 10205.2 10537.0 16:56:20 INFO - PROCESS | 19471 | -------- Summary: end -------- 16:56:20 INFO - PROCESS | 19471 | 16:56:21 INFO - TEST-INFO | 19471: exit 0 16:56:21 INFO - TEST-OK | dromaeo_css | took 1110088ms 16:56:21 INFO - TEST-START | kraken 16:56:21 INFO - operating with platform_type : linux_ 16:56:21 INFO - Initialising browser for kraken test... 16:56:21 INFO - TEST-INFO | started process 19664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFEGXRM/profile http://localhost:47891/getInfo.html) 16:56:25 INFO - PROCESS | 19664 | __metrics Screen width/height:1600/1200 16:56:25 INFO - PROCESS | 19664 | colorDepth:24 16:56:25 INFO - PROCESS | 19664 | Browser inner width/height: 1024/697 16:56:25 INFO - PROCESS | 19664 | __metrics 16:56:25 INFO - PROCESS | 19664 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:56:26 INFO - TEST-INFO | 19664: exit 0 16:56:26 INFO - Browser initialized. 16:56:26 INFO - Running cycle 1/1 for kraken test... 16:56:26 INFO - TEST-INFO | started process 19757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFEGXRM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:38 INFO - PROCESS | 19757 | RSS: Main: 138989568 16:56:38 INFO - PROCESS | 19757 | 16:56:41 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47891/tests/kraken/driver.html?testName=audio-beat-detection) 16:56:41 INFO - PROCESS | 19757 | RSS: Main: 182792192 16:56:41 INFO - PROCESS | 19757 | 16:56:44 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47891/tests/kraken/driver.html?testName=audio-dft) 16:56:44 INFO - PROCESS | 19757 | RSS: Main: 176054272 16:56:44 INFO - PROCESS | 19757 | 16:56:47 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47891/tests/kraken/driver.html?testName=audio-fft) 16:56:48 INFO - PROCESS | 19757 | RSS: Main: 175128576 16:56:48 INFO - PROCESS | 19757 | 16:56:50 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47891/tests/kraken/driver.html?testName=audio-oscillator) 16:56:51 INFO - PROCESS | 19757 | RSS: Main: 176500736 16:56:51 INFO - PROCESS | 19757 | 16:56:53 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47891/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:56:53 INFO - PROCESS | 19757 | RSS: Main: 175284224 16:56:53 INFO - PROCESS | 19757 | 16:56:56 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47891/tests/kraken/driver.html?testName=imaging-darkroom) 16:56:57 INFO - PROCESS | 19757 | RSS: Main: 174735360 16:56:57 INFO - PROCESS | 19757 | 16:57:00 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47891/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:01 INFO - PROCESS | 19757 | RSS: Main: 174997504 16:57:01 INFO - PROCESS | 19757 | 16:57:04 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47891/tests/kraken/driver.html?testName=json-parse-financial) 16:57:04 INFO - PROCESS | 19757 | RSS: Main: 174632960 16:57:04 INFO - PROCESS | 19757 | 16:57:06 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47891/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:06 INFO - PROCESS | 19757 | RSS: Main: 181788672 16:57:06 INFO - PROCESS | 19757 | 16:57:08 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47891/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:57:09 INFO - PROCESS | 19757 | RSS: Main: 180887552 16:57:09 INFO - PROCESS | 19757 | 16:57:11 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47891/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:57:11 INFO - PROCESS | 19757 | RSS: Main: 183787520 16:57:11 INFO - PROCESS | 19757 | 16:57:14 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47891/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:57:14 INFO - PROCESS | 19757 | RSS: Main: 187744256 16:57:14 INFO - PROCESS | 19757 | 16:57:17 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47891/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:57:18 INFO - PROCESS | 19757 | RSS: Main: 185647104 16:57:18 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | Cycle 1(1): loaded http://localhost:47891/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47891/tests/kraken/driver.html?testName=ai-astar) 16:57:19 INFO - PROCESS | 19757 | RSS: Main: 249106432 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | __start_tp_report 16:57:19 INFO - PROCESS | 19757 | _x_x_mozilla_page_load 16:57:19 INFO - PROCESS | 19757 | _x_x_mozilla_page_load_details 16:57:19 INFO - PROCESS | 19757 | |i|pagename|runs| 16:57:19 INFO - PROCESS | 19757 | |0;ai-astar;110;112;111;111;113;112;112;111;112;123 16:57:19 INFO - PROCESS | 19757 | |1;audio-beat-detection;159;134;153;167;140;154;161;131;179;128 16:57:19 INFO - PROCESS | 19757 | |2;audio-dft;161;161;162;160;159;162;163;161;164;164 16:57:19 INFO - PROCESS | 19757 | |3;audio-fft;80;77;77;169;77;78;75;83;180;76 16:57:19 INFO - PROCESS | 19757 | |4;audio-oscillator;95;95;153;95;95;96;147;95;93;141 16:57:19 INFO - PROCESS | 19757 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;116 16:57:19 INFO - PROCESS | 19757 | |6;imaging-darkroom;146;147;146;146;148;146;145;146;146;147 16:57:19 INFO - PROCESS | 19757 | |7;imaging-desaturate;97;98;95;95;96;96;96;96;96;95 16:57:19 INFO - PROCESS | 19757 | |8;json-parse-financial;55;56;56;59;57;59;56;58;67;54 16:57:19 INFO - PROCESS | 19757 | |9;json-stringify-tinderbox;66;66;66;64;65;65;66;65;65;66 16:57:19 INFO - PROCESS | 19757 | |10;stanford-crypto-aes;82;80;82;82;81;81;83;81;82;87 16:57:19 INFO - PROCESS | 19757 | |11;stanford-crypto-ccm;118;114;114;112;122;114;114;115;116;116 16:57:19 INFO - PROCESS | 19757 | |12;stanford-crypto-pbkdf2;145;135;146;145;146;139;138;150;139;149 16:57:19 INFO - PROCESS | 19757 | |13;stanford-crypto-sha256-iterative;68;69;69;69;68;68;68;67;73;67 16:57:19 INFO - PROCESS | 19757 | __end_tp_report 16:57:19 INFO - PROCESS | 19757 | __start_cc_report 16:57:19 INFO - PROCESS | 19757 | _x_x_mozilla_cycle_collect,1092 16:57:19 INFO - PROCESS | 19757 | __end_cc_report 16:57:19 INFO - PROCESS | 19757 | __startTimestamp1464652639968__endTimestamp 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | ------- Summary: start ------- 16:57:19 INFO - PROCESS | 19757 | Number of tests: 14 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.00 stddev:3.71 (3.3%) stddev-sans-first:3.81 16:57:19 INFO - PROCESS | 19757 | Values: 110.0 112.0 111.0 111.0 113.0 112.0 112.0 111.0 112.0 123.0 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:156.50 stddev:16.85 (10.8%) stddev-sans-first:17.59 16:57:19 INFO - PROCESS | 19757 | Values: 159.0 134.0 153.0 167.0 140.0 154.0 161.0 131.0 179.0 128.0 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.64 (1.0%) stddev-sans-first:1.72 16:57:19 INFO - PROCESS | 19757 | Values: 161.0 161.0 162.0 160.0 159.0 162.0 163.0 161.0 164.0 164.0 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#3] audio-fft Cycles:10 Average:97.20 Median:77.00 stddev:40.88 (53.1%) stddev-sans-first:42.89 16:57:19 INFO - PROCESS | 19757 | Values: 80.0 77.0 77.0 169.0 77.0 78.0 75.0 83.0 180.0 76.0 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:95.00 stddev:25.36 (26.7%) stddev-sans-first:26.27 16:57:19 INFO - PROCESS | 19757 | Values: 95.0 95.0 153.0 95.0 95.0 96.0 147.0 95.0 93.0 141.0 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:57:19 INFO - PROCESS | 19757 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 16:57:19 INFO - PROCESS | 19757 | Values: 146.0 147.0 146.0 146.0 148.0 146.0 145.0 146.0 146.0 147.0 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.94 (1.0%) stddev-sans-first:0.93 16:57:19 INFO - PROCESS | 19757 | Values: 97.0 98.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:3.65 (6.4%) stddev-sans-first:3.74 16:57:19 INFO - PROCESS | 19757 | Values: 55.0 56.0 56.0 59.0 57.0 59.0 56.0 58.0 67.0 54.0 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 16:57:19 INFO - PROCESS | 19757 | Values: 66.0 66.0 66.0 64.0 65.0 65.0 66.0 65.0 65.0 66.0 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:1.91 (2.3%) stddev-sans-first:2.03 16:57:19 INFO - PROCESS | 19757 | Values: 82.0 80.0 82.0 82.0 81.0 81.0 83.0 81.0 82.0 87.0 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:115.50 stddev:2.80 (2.4%) stddev-sans-first:2.82 16:57:19 INFO - PROCESS | 19757 | Values: 118.0 114.0 114.0 112.0 122.0 114.0 114.0 115.0 116.0 116.0 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:145.50 stddev:5.07 (3.5%) stddev-sans-first:5.34 16:57:19 INFO - PROCESS | 19757 | Values: 145.0 135.0 146.0 145.0 146.0 139.0 138.0 150.0 139.0 149.0 16:57:19 INFO - PROCESS | 19757 | 16:57:19 INFO - PROCESS | 19757 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.71 (2.5%) stddev-sans-first:1.80 16:57:19 INFO - PROCESS | 19757 | Values: 68.0 69.0 69.0 69.0 68.0 68.0 68.0 67.0 73.0 67.0 16:57:19 INFO - PROCESS | 19757 | -------- Summary: end -------- 16:57:19 INFO - PROCESS | 19757 | 16:57:20 INFO - TEST-INFO | 19757: exit 0 16:57:20 INFO - TEST-OK | kraken | took 59292ms 16:57:20 INFO - SUITE-END | took 1169s 16:57:21 INFO - Completed test suite (00:19:29) 16:57:21 INFO - javascript benchmark 16:57:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3290.1445624137723, 3323.102762254193, 3324.9194011946115, 3328.7669863109577, 3363.0079126657633, 5339.172428273619, 5341.305630268064, 5363.839084827452, 5375.973120134394, 5385.892282154359, 5309.575233981282, 5331.306930099091, 5336.519713225809, 5342.332208473941, 5345.0, 4812.68717533361, 4884.53596908294, 4916.459189489154, 4990.65065445419, 5000.5999520038495, 4855.975720121394, 4918.729469879156, 4952.826651067214, 4968.726720030397, 4977.751112444382, 4888.9511104889025, 4950.0, 4980.153373926441, 4991.251312303148, 4999.050180465718, 4823.890505183792, 4929.950700492985, 4943.826966056189, 4953.108440480712, 4956.231784073474, 4794.5684888359865, 4820.0841840050625, 4859.343988561534, 4873.537013983666, 4917.36074310341, 5134.486551344873, 5138.922916156223, 5144.125498665236, 5145.819896303611, 5161.303224064778, 5696.458836410535, 5701.743421546041, 5702.657840529581, 5719.656820590736, 5734.799282025109, 5679.488846003838, 5684.0, 5723.771049158028, 5781.248437703114, 5811.302643682743, 5417.349918009824, 5440.619156659035, 5440.7551660174995, 5444.863878403072, 5446.673199607996, 5895.616784909053, 5906.143609176645, 5944.167816505693, 5956.672383018976, 5959.046552551571, 5500.257465242221, 5567.0, 5570.415106413769, 5589.524890384281, 5597.524210442077, 5677.233573467612, 5734.168545560954, 5740.942590574125, 5746.798862039808, 5747.741351639186, 5580.972095139579, 5703.230063941398, 5722.599418040781, 5723.7424315905055, 5729.5702822288495, 5799.768009279582, 5807.0, 5812.331581868139, 5822.1266809978, 5848.356680765112, 4370.21336159488, 4394.055278115221, 4406.647468202536, 4420.248557745191, 4445.555444455593, 3838.3091043612417, 3909.159530700856, 3957.248122856648, 3965.940510892339, 4009.358502639622, 5552.583556233218, 5564.026295398289, 5566.304211973504, 5572.693501857437, 5576.776928922797, 5765.423457654285, 5806.854828629233, 5807.128930660435, 5809.88380232393, 5814.912776308359, 5411.485908838654, 5522.585806064561, 5538.889222215533, 5600.159976003632, 5619.662820230717, 4940.987097645046, 4964.851054468371, 4968.975155124273, 4975.378077740283, 5000.224965130411, 5965.105234214902, 6005.789797357072, 6011.819645410645, 6015.0, 6022.668753218615, 5696.287964004582, 5740.799072032459, 5814.709264536841, 5816.534677225727, 5825.98045342072, 6031.065184896348, 6032.577719559764, 6040.1241819934985, 6044.607100538451, 6047.244094488189, 5592.189132575835, 5691.288588926384, 5692.1461780733225, 5694.1458781183155, 5705.429457054262, 5803.82588522345, 5854.707264636666, 5860.619059761102, 5860.677662728591, 5893.5874488785375, 5633.718314084197, 5635.915461268002, 5642.153676948491, 5646.943530564642, 5647.0, 5519.475649813261, 5579.497845193952, 5639.210510528611, 5639.8590035249445, 5643.548516118619, 5511.5039646432015, 5607.971960140173, 5615.6630602164005, 5630.930123276565, 5658.830235092953, 5656.547476201977, 5711.3431955324, 5720.399358067343, 5721.971390143022, 5733.598648094593, 5450.836474905759, 5568.443155684399, 5605.271314729059, 5610.298712660918, 5610.803621873378], "unit": "score", "name": "dojo.html", "value": 5328.441999885137}, {"lowerIsBetter": false, "replicates": [471.38719664436246, 516.1741214057506, 534.663162207809, 541.480179028133, 549.6097770582886, 31935.840320798394, 32549.0, 32579.67420325796, 32588.511172332433, 32621.673783262162, 41270.79364603173, 41411.37882931758, 41692.37461438081, 41694.0, 41765.164696706044, 8877.46735195887, 9112.134347237035, 9112.544372781334, 9119.589618467186, 9122.315826313019, 8869.290456763476, 8955.507447090407, 8997.865032024525, 9011.414258073237, 9015.0, 9016.729498115066, 9083.227925626297, 9088.50013249271, 9088.772780680503, 9093.045230250827, 8971.685990990316, 9047.230985366252, 9054.818903621923, 9058.139476749699, 9064.138906803842, 8901.554922253861, 9039.412438191497, 9238.122378374044, 9285.953570232174, 9289.90710092904, 44339.0, 44682.553174468165, 44805.0, 44833.32750008752, 44862.10275794466, 3577.177249232665, 3695.3533131701843, 3777.320082385197, 3950.2889479893606, 4442.244818380883, 29215.70784292151, 29588.260293492618, 29672.0, 29697.851510742523, 31148.0, 3978.5822488638855, 4258.446401967755, 4329.7618630975285, 4335.631471324941, 4382.627476664487, 292524.0, 293642.0, 294124.0, 294796.5260173707, 295540.0, 46007.53992460033, 46387.6083717489, 70131.29868701349, 70627.64686176536, 70853.0, 44855.327170092474, 44918.55081449209, 44947.0, 45037.77481112573, 45053.32420013702, 16461.34154633825, 16673.24970376336, 16685.082320472247, 16685.082320472247, 16688.6662266754, 13351.265680387478, 13384.130031547918, 13394.062415631008, 13395.933020334836, 13418.597442076558, 15365.769513457308, 15917.363305467883, 15926.28331725052, 15941.920290398706, 15950.202489875692, 5871.207387002785, 6009.338972712998, 6100.786472473531, 6238.91705587049, 6245.0, 1049.490996866519, 1073.1901748791759, 1088.2273585754203, 1095.9533645368654, 1142.765733024728, 30990.0702978911, 31200.531992020136, 31304.686953130633, 33028.0, 35758.64241357605, 1071.9303245289186, 1072.951717172729, 1081.588996181446, 1208.7763763703742, 1276.942537585811, 16117.355305787873, 16201.108939008467, 16288.592785180228, 16307.755383669255, 16427.671446571003, 196962.0, 197332.0, 197548.0, 197905.0, 198635.0, 59599.0, 59954.10068848971, 60017.39982600205, 60031.0, 60251.39748602458, 1328.110166188656, 1448.891333150018, 1483.1620134623904, 1516.7876497290388, 1541.352631894607, 30663.540046898866, 32387.0, 32755.0, 33358.83320583381, 33737.66262337443, 53210.4678953221, 53993.730031349594, 54044.0, 54111.0, 54122.45877541174, 308490.0, 310941.0, 311822.0, 312692.0, 312821.0, 35176.0, 36979.0, 36980.260394792494, 37002.0, 37017.51929922773, 46294.0, 47140.29289560728, 47286.527134729586, 47588.2861757067, 47609.04781904412, 39472.40791388074, 39999.80000099981, 40136.39795403013, 40148.799256003535, 40606.59393406028, 38415.0, 39291.0, 39983.60016399799, 40091.0, 40711.79644101761, 39097.6090239094, 39608.60391396165, 40813.1837363257, 41058.1788364237, 41123.1775364497, 33534.66465335315, 35403.645963541065, 35496.82251588725, 35763.46354804732, 35954.64045359513, 26986.595201072392, 26998.595021074307, 27038.594421083308, 27143.1857044289, 27576.448471030868], "unit": "score", "name": "ext.html", "value": 19003.656963545924}, {"lowerIsBetter": false, "replicates": [346.78152763758845, 361.80824163193506, 362.1001810500905, 363.11037957005345, 371.7286380941914, 17909.283628654855, 18083.0, 19418.805811941875, 19431.31990380337, 19449.902750486246, 17970.0, 18600.81399186008, 18792.06039698013, 18792.81207187931, 18793.0, 5531.695756733368, 5777.566682498808, 5831.766729330821, 5835.35811060783, 5851.327097383792, 4328.4156638853665, 5719.428057194289, 6081.087836824468, 6324.146240257575, 6349.968250158743, 6294.968525157391, 6298.3701629837105, 6326.240851097875, 6331.050342448623, 6343.777967771129, 6102.816915492543, 6335.366463353651, 6337.588056776341, 6344.809655710313, 6351.174347334863, 3929.0766669832565, 5290.57675385972, 5483.451654834525, 5491.231227628095, 5596.27248457702, 20753.27363542284, 21404.46488837776, 21551.892240538855, 21621.35135945924, 21657.133714651394, 2472.986075708951, 2557.3223095879607, 2653.230563136707, 2675.929628148737, 3129.874805007797, 13387.0, 14182.29088545579, 14345.569632911029, 14348.06737562055, 14386.280685965765, 1926.7976862429384, 1952.4142757172933, 1974.6346925818625, 1975.5061234691327, 2051.415346626204, 63792.36207637957, 67959.0, 69101.65449172723, 69952.65023674951, 70134.29865701329, 9960.352577082467, 10179.694609161737, 10319.896801032044, 10348.948255258827, 10457.372557646566, 14592.124472531683, 14609.488667896785, 14617.122972621464, 14749.557513274618, 14819.925900370428, 8053.395995300376, 8142.0, 8196.098429172785, 8246.505209687439, 8261.091279959199, 8188.14024527428, 8245.340372770164, 8259.545724985184, 8292.958535207285, 8345.582720864053, 4571.839985600488, 4693.647976401783, 4702.0, 4703.3885594872445, 4712.104700106968, 1771.1112713636542, 1792.2293413832178, 1849.306510058728, 1897.3074827687794, 1906.428071578521, 857.6440777077568, 907.1880666803174, 911.3893691226893, 1031.5306535526317, 1036.8237399642078, 17024.31902723902, 17686.734698979526, 17843.365256491346, 17990.820091799178, 18046.729299060524, 947.9952600236954, 948.1750876737145, 968.7142293023575, 1042.374575254841, 1052.5789684126257, 9673.661421850202, 9675.371100878561, 9843.753906152404, 9981.900180998096, 10048.0, 473810.0, 476954.0, 493196.0, 496720.0, 498260.0, 67536.6623166881, 68696.65651671709, 71939.6403017992, 76385.23614763781, 78188.6090569555, 1024.6106479537727, 1053.5311786255043, 1079.3469950679882, 1080.9567617295377, 1081.7721885659676, 15409.76885346743, 15429.922850386125, 15449.150296733338, 15464.922675386551, 15566.455174068853, 33441.83279083589, 33817.15457113592, 34909.476357854146, 35622.82188589041, 36110.0, 47178.76410618062, 49260.0, 50649.49350506448, 51038.234426482886, 51628.0, 8286.544240066854, 8554.230119289294, 8565.27195188416, 8656.0, 8656.264217541328, 10258.53836577341, 12984.15602985803, 13023.088383813041, 13200.669983250496, 13321.0, 6586.637734924625, 10674.786504269716, 10954.123670106213, 11032.393218372745, 11226.663200103683, 11244.03229434862, 11662.825057623973, 11695.181337306307, 11703.707407314885, 11860.822087668519, 11730.296182229093, 11773.587924422603, 11851.940740296242, 11863.644090677293, 11864.940675296913, 8192.67229310821, 8352.87470687928, 8545.273651739672, 8673.566321683764, 8934.927808663002, 9782.315237933277, 11326.83009754871, 11363.659090227306, 11474.655760327203, 11501.0], "unit": "score", "name": "jquery.html", "value": 8965.158168153792}, {"lowerIsBetter": false, "replicates": [1464.143476066501, 1604.4544854749383, 1608.4852847088928, 1859.2284202056148, 1961.1076959983209, 7900.486468379559, 8071.596420178989, 8077.757667269977, 8083.272505474506, 8094.554799486041, 8033.678652853879, 8182.877256841152, 8184.099749027617, 8193.139720329369, 8195.836083278331, 2422.382292515406, 2433.0754313360985, 2441.7680320369536, 2450.4486490539575, 2450.4608986023045, 2418.04487227545, 2454.987725061372, 2495.4510007798253, 2510.046182450666, 2517.7356377580363, 2454.349597356702, 2455.054803900502, 2458.090506512593, 2459.766322199397, 2467.864267465289, 2391.703964194367, 2399.4241382068353, 2417.625268083441, 2437.926862194137, 2443.706755189371, 2415.130553000918, 2427.7936375408112, 2442.2673198040693, 2443.0472115874823, 2445.315311712723, 8266.710665126691, 8305.875411868827, 8310.335173186131, 8320.83358332836, 8326.12575679557, 5101.770420331094, 5316.069687804657, 5323.840284791462, 5324.1215199492035, 5353.759080841332, 3244.9675503244903, 3261.7553683473834, 3302.5211344354934, 3358.0, 3358.3786999404942, 1032.4166845732138, 1069.0325255643577, 1080.6271836216492, 1960.362882063335, 1996.9700454493195, 11170.162237832195, 11240.213185077047, 11247.66257012291, 11285.717857053558, 11350.602728904449, 4536.909261814745, 4598.471175814757, 4680.3915490985955, 4697.8355757548325, 4698.506656801055, 8832.690855820016, 8838.779030524289, 8846.867296990551, 8851.557422128868, 8869.556522173865, 5226.764795584208, 5289.259503669412, 5317.229001794718, 5318.095923692981, 5331.86670333237, 4150.979245103756, 4163.354680024601, 4164.958350416457, 4713.269443236304, 4835.879103022453, 3679.576848662438, 3718.4050551911564, 3741.9251614967548, 3762.736608437383, 3805.46723458716, 1155.8959693627614, 1156.7512984708328, 1161.355447726503, 1166.731651720109, 1176.4353110506834, 1347.7574036673493, 1374.1274290825397, 1374.7731624281882, 1442.6826098258366, 1446.833614134367, 7519.774406767806, 7823.217678232131, 7850.450468467153, 7852.921470785333, 7863.0957439894, 495.6431369414016, 504.27888119988035, 510.03094121169335, 512.4747134187488, 521.4733119549282, 6024.939750602525, 6031.849203769941, 6042.788502402483, 6091.969540152271, 6098.420650038239, 9921.107100360858, 10000.549975251131, 10136.746581335525, 10161.796764064677, 10175.949120254352, 9733.756656083513, 9817.656382026738, 9846.901530984742, 9982.900170998342, 10010.54952527138, 8002.399820013522, 8074.636641351153, 8131.14622964592, 8147.918520814835, 8160.6327715252955, 7988.6405111768945, 8011.038675358995, 8096.595170241582, 8098.271155596025, 8098.878516822135, 8726.301895848444, 8949.373543851867, 9480.34094033555, 9548.474833884204, 9596.040395960626, 8880.555972201493, 8952.328575357005, 9034.86447703272, 9159.313051521029, 9332.81334373295, 6654.168228971379, 7143.678534465857, 7188.928110719035, 7279.59962202084, 7319.451041171827, 7930.127685954656, 7941.920580794349, 7955.602219889098, 7988.480748751545, 8013.519188848454, 7061.0, 7166.641667916479, 7181.102362204724, 7296.598687072262, 7298.37963773064, 7039.788806335613, 7144.571325720473, 7147.714091436284, 7191.42468602521, 7245.855082898207, 7292.854142917218, 7409.2590740927635, 7443.55338679681, 7448.0, 7456.51532650376, 6759.188897332351, 6821.727130914708, 6825.89761153593, 6830.112085428863, 6837.555558888656, 6762.357576030269, 6773.830654233683, 6775.830604234933, 6787.015882696883, 6790.694418751069], "unit": "score", "name": "mootools.html", "value": 4713.892382070566}, {"lowerIsBetter": false, "replicates": [323.3436124666926, 326.2056891469272, 327.95572597699316, 338.65626389214935, 345.65607220815275, 5780.450857168573, 5810.3899090595405, 5818.185454036438, 5828.0, 5833.70831458427, 5703.5722320826, 5713.257276554042, 5720.9713951430285, 5731.254936858202, 5815.47660710536, 4329.891752706192, 4415.690901636886, 4513.390692256537, 4543.2957891526785, 4592.311153326994, 4559.544045595447, 4566.611837993774, 4574.290984897346, 4578.35902973584, 4610.561996610317, 4518.0, 4532.274836026237, 4532.614727748145, 4533.546645335457, 4540.500544940054, 4276.914461710764, 4380.364847097169, 4501.864944051684, 4506.369108324837, 4514.413126293593, 3955.48578684772, 3963.3948250958406, 3965.048388386795, 3973.264945985002, 3974.682025437958, 5550.4449555044175, 5553.972230138824, 5569.8607534811545, 5571.220029195916, 5573.581981351374, 5208.609354298443, 5210.036143313461, 5214.608904332153, 5217.478252174752, 5221.921671174935, 6163.568550201488, 6171.87656246877, 6179.845503862394, 6201.751929922798, 6205.069239614094, 4108.116754897711, 4227.577242275778, 4232.936505952413, 4396.340548917656, 4400.73595584266, 6328.683565821737, 6412.7114279857515, 6442.806715798487, 6450.290468048511, 6467.579607325556, 4399.670024748157, 4402.031553058322, 4406.361077643724, 4410.801513931817, 4411.228035093845, 4463.509014008457, 4475.9552404475535, 4476.9104617908115, 4478.708883922534, 4479.574440428154, 5150.690958542499, 5165.9225111623355, 5169.81905633301, 5171.9482805171465, 5176.792928282826, 6016.278046634432, 6232.034034724625, 6234.594751341148, 6241.157443745036, 6241.282252540925, 1542.730022246125, 1558.688262347535, 1576.3694522190985, 1580.47484177769, 1585.5322679809483, 960.6013504395737, 1002.283367392318, 1003.7992401519725, 1013.1489548779061, 1035.4512108582464, 5963.2844058713235, 6057.545684073712, 6096.420840020191, 6204.906926396107, 6206.317305096436, 6324.620522768649, 6361.14124593174, 6363.61818290904, 6367.204099487564, 6382.6170429774365, 6086.269647642312, 6100.908486372708, 6125.081237814275, 6125.418085281891, 6125.9693701531205, 3390.8643654254047, 3429.159855835336, 3430.8627654894026, 3431.039308993486, 3441.6042155151977, 6510.576812507172, 6652.933470665328, 6663.400293973566, 6665.700043498055, 6688.966555167193, 6466.773662921775, 6500.252470965805, 6501.414872661483, 6510.414062734377, 6510.739570417225, 6638.236602790645, 6641.800745977628, 6643.10318107059, 6651.201855777338, 6652.101966234496, 6304.306526282197, 6339.4928405726505, 6356.77751278703, 6360.268569114611, 6364.77723279683, 6087.4521293083835, 6215.844603884939, 6222.81331560054, 6225.782097626561, 6240.563160578716, 6616.0, 6636.0, 6636.170478690164, 6636.369544893228, 6644.435223006099, 4371.912561748683, 4379.167958087953, 4381.496127945327, 4382.430284063052, 4386.64906807461, 6335.208098987627, 6335.271443784024, 6335.556511044183, 6338.271098823694, 6350.174477317919, 6176.135341052346, 6183.227096612924, 6230.314665386713, 6264.404881536247, 6270.874582508415, 6041.516678665608, 6161.322254552086, 6162.938370616416, 6171.7531298749345, 6190.102435146789, 6011.6693581853415, 6030.30651475086, 6053.213082299449, 6055.364186760326, 6062.120992456157, 6184.969075154595, 6197.81406557804, 6198.380161983766, 6199.070139479114, 6213.099100630293, 5873.500752436091, 5979.880402392015, 6057.515398768176, 6060.333363330118, 6078.908816367846], "unit": "score", "name": "prototype.html", "value": 4674.650922116034}, {"lowerIsBetter": false, "replicates": [652.6569615081856, 689.6586189836032, 710.5274992130234, 716.8136284566011, 738.7635956493922, 14279.571612851618, 14383.928080359598, 14556.636084097903, 14576.125432474058, 14615.634609134777, 13769.0, 13796.0, 13815.585532434017, 13903.582892513215, 13909.93045034776, 770.437580566187, 913.5021413329717, 917.2020342302206, 941.1059493481187, 942.7831598732296, 927.8144371125768, 928.9256859451261, 930.5393830054132, 935.8642996765465, 936.0873148680016, 980.7793246519511, 986.5609803637384, 987.8913319534845, 988.0712130597251, 989.945552994585, 796.7848680856165, 966.6568368229283, 969.3699095587854, 975.5366201054513, 976.8876579193377, 714.7962830593308, 718.0199028326349, 719.8380364417964, 719.9028131202273, 726.6475759256756, 12709.300988445631, 12754.426050827735, 12757.17078389911, 12760.936195319056, 12767.23396596198, 14235.359408826627, 14477.0, 14686.339114739862, 14722.337494812758, 14796.778048329175, 11364.488598013026, 11371.545138194462, 11378.829317560243, 11403.657890263305, 11590.246633968765, 3876.3604005339084, 3899.98050009751, 3901.5903330150495, 3974.7018973577096, 4035.1727895781296, 52260.21609675858, 52283.0, 52311.476885231044, 52886.735566322306, 53502.929941401344, 11064.114870810316, 11087.390193539433, 11193.49629266685, 11286.548538058385, 11418.942905285421, 18051.368202112862, 18143.18355673998, 18162.909185453987, 18162.909185454253, 18163.182656780213, 7171.0, 7349.63251837406, 7860.685572577033, 7932.365410767125, 8132.512049277062, 4281.079567892918, 4357.9128417431475, 4388.188185185751, 4491.708038977521, 4704.811807527729, 3259.674032596769, 3274.1323549259464, 3279.1146390474437, 3289.227031647561, 3291.489819078047, 527.6016607461343, 576.3170642788225, 587.8001479496907, 593.2939801636039, 623.2676604989119, 565.6351653183756, 569.0269638917415, 590.9497692696083, 606.2240332374568, 609.5458883132095, 8258.132896045949, 8269.62786674601, 8530.274926631306, 8532.786680333042, 8730.86903696445, 603.471962033221, 610.6458254212546, 618.6288227063816, 711.4521818199958, 722.4437183368882, 4182.644475219579, 4208.410822484854, 4262.2754131797665, 4275.29457639486, 4292.420523229386, 56829.431705682415, 57572.0, 58077.4192258072, 58383.12425313624, 58469.0, 52588.47411525912, 52832.207516887276, 53499.46500534945, 53732.19401708977, 55242.0, 48093.27860082102, 48230.27654585184, 48509.999999999294, 48651.27023094657, 49091.263631045564, 8468.153184681483, 8646.956765216133, 8692.739217823475, 8724.956375218337, 8788.780280493038, 34856.47715284323, 36216.0, 36994.44508332431, 37188.81405592955, 38161.23677526379, 40981.38527922143, 43159.0, 44713.10573788571, 44801.55198447974, 46061.30908036315, 10846.945765271123, 11138.498767555317, 11500.712482187677, 11553.364564948672, 11731.472083756422, 10995.34027958325, 11636.650900473, 11878.168528202943, 12751.74496510046, 13476.32618369058, 10278.845817312897, 11579.247348922294, 11754.823677645014, 12390.194637348544, 12554.121211515107, 12034.398280086136, 12404.081246483058, 12454.688632784253, 13051.804222936473, 13213.603591892259, 11139.944300278446, 11443.713907152054, 11592.6522204334, 12009.219400738924, 12311.322877241837, 9989.900100998897, 10593.735156620838, 10621.8937810624, 10722.303050301705, 11049.171312151782, 9955.599652734714, 10126.088652021353, 10133.797324053625, 10205.183585313305, 10537.0], "unit": "score", "name": "yui.html", "value": 6614.168574740727}], "name": "dromaeo_css", "value": 7138.48948800856}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 111.0, 111.0, 113.0, 112.0, 112.0, 111.0, 112.0, 123.0], "unit": "score", "name": "ai-astar", "value": 112.7}, {"lowerIsBetter": true, "replicates": [159.0, 134.0, 153.0, 167.0, 140.0, 154.0, 161.0, 131.0, 179.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 150.6}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 160.0, 159.0, 162.0, 163.0, 161.0, 164.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [80.0, 77.0, 77.0, 169.0, 77.0, 78.0, 75.0, 83.0, 180.0, 76.0], "unit": "score", "name": "audio-fft", "value": 97.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 153.0, 95.0, 95.0, 96.0, 147.0, 95.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 148.0, 146.0, 145.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 56.0, 59.0, 57.0, 59.0, 56.0, 58.0, 67.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.4}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 82.0, 82.0, 81.0, 81.0, 83.0, 81.0, 82.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.1}, {"lowerIsBetter": true, "replicates": [118.0, 114.0, 114.0, 112.0, 122.0, 114.0, 114.0, 115.0, 116.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.5}, {"lowerIsBetter": true, "replicates": [145.0, 135.0, 146.0, 145.0, 146.0, 139.0, 138.0, 150.0, 139.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 73.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1524.3}]} 16:57:21 INFO - Return code: 0 16:57:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:57:21 INFO - # TBPL SUCCESS # 16:57:21 INFO - Running post-action listener: _resource_record_post_action 16:57:21 INFO - Running post-run listener: _resource_record_post_run 16:57:22 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 20480; Write bytes: 463089664; Read time: 48; Write time: 381492 16:57:22 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 213512192; Read time: 0; Write time: 252444 16:57:22 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 20480; Write bytes: 218411008; Read time: 48; Write time: 124328 16:57:22 INFO - Running post-run listener: _upload_blobber_files 16:57:22 INFO - Blob upload gear active. 16:57:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:57:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:57:22 INFO - (blobuploader) - INFO - Open directory for files ... 16:57:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:57:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:57:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:23 INFO - (blobuploader) - INFO - Done attempting. 16:57:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:57:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:57:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:24 INFO - (blobuploader) - INFO - Done attempting. 16:57:24 INFO - (blobuploader) - INFO - Iteration through files over. 16:57:24 INFO - Return code: 0 16:57:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:57:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:57:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/59381f4486b01e5cd08b50e1d51baacddb01e703cbfe917f1b47e6f4ca99257053d16bcf16be60fec1f3a24e786d9135c170946f508d7463f36b4d684bb9e5b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1c75fed931c78206f33252ae65179ae0f72f3cbccef73cf71c7f0fb170c979a32e7f0e5d86efbeaaca230fa7eba1a171c758b2e26d7464469a5574375bccf83"} 16:57:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:57:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:57:24 INFO - Contents: 16:57:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/59381f4486b01e5cd08b50e1d51baacddb01e703cbfe917f1b47e6f4ca99257053d16bcf16be60fec1f3a24e786d9135c170946f508d7463f36b4d684bb9e5b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1c75fed931c78206f33252ae65179ae0f72f3cbccef73cf71c7f0fb170c979a32e7f0e5d86efbeaaca230fa7eba1a171c758b2e26d7464469a5574375bccf83"} 16:57:24 INFO - Running post-run listener: copy_logs_to_upload_dir 16:57:24 INFO - Copying logs to upload dir... 16:57:24 INFO - mkdir: /builds/slave/test/build/upload/logs 16:57:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.305841 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-30 16:57:24.425101) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:24.429906) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600 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/59381f4486b01e5cd08b50e1d51baacddb01e703cbfe917f1b47e6f4ca99257053d16bcf16be60fec1f3a24e786d9135c170946f508d7463f36b4d684bb9e5b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1c75fed931c78206f33252ae65179ae0f72f3cbccef73cf71c7f0fb170c979a32e7f0e5d86efbeaaca230fa7eba1a171c758b2e26d7464469a5574375bccf83"} 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.011221 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/59381f4486b01e5cd08b50e1d51baacddb01e703cbfe917f1b47e6f4ca99257053d16bcf16be60fec1f3a24e786d9135c170946f508d7463f36b4d684bb9e5b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1c75fed931c78206f33252ae65179ae0f72f3cbccef73cf71c7f0fb170c979a32e7f0e5d86efbeaaca230fa7eba1a171c758b2e26d7464469a5574375bccf83"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:24.458241) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:24.458652) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1464650834.303069-114946600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:24.509298) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:57:24.512683) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:57:24.513019) ========= ========= Total master_lag: 0.18 =========