builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1460972713.44 results: success (0) buildid: 20160418000649 builduid: 9eeaa1c12cae47b781f853e73aac361d revision: 96046381bf0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:13.440372) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:13.440885) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:13.441226) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:13.459383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:13.459649) ========= 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=df17445c3590ff7897617a0e00000225-1460971753.797805-202910072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 02:45:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-18 02:45:13 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111725 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:13.584698) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:13.585009) ========= 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=df17445c3590ff7897617a0e00000225-1460971753.797805-202910072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020622 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:13.634813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:13.635156) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 96046381bf0b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 96046381bf0b --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=df17445c3590ff7897617a0e00000225-1460971753.797805-202910072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 02:45:13,719 Setting DEBUG logging. 2016-04-18 02:45:13,719 attempt 1/10 2016-04-18 02:45:13,720 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/96046381bf0b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 02:45:14,068 unpacking tar archive at: fx-team-96046381bf0b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.697173 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:14.344731) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:14.345045) ========= script_repo_revision: 96046381bf0b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:14.345455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:14.345724) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 02:45:14.354406) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-18 02:45:14.354674) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=df17445c3590ff7897617a0e00000225-1460971753.797805-202910072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:45:14 INFO - MultiFileLogger online at 20160418 02:45:14 in /builds/slave/test 02:45:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:45:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:45:14 INFO - {'append_to_log': False, 02:45:14 INFO - 'base_work_dir': '/builds/slave/test', 02:45:14 INFO - 'blob_upload_branch': 'Fx-Team', 02:45:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:45:14 INFO - 'branch': 'Fx-Team', 02:45:14 INFO - 'buildbot_json_path': 'buildprops.json', 02:45:14 INFO - 'config_files': ('talos/linux_config.py',), 02:45:14 INFO - 'default_actions': ('clobber', 02:45:14 INFO - 'read-buildbot-config', 02:45:14 INFO - 'download-and-extract', 02:45:14 INFO - 'populate-webroot', 02:45:14 INFO - 'create-virtualenv', 02:45:14 INFO - 'install', 02:45:14 INFO - 'run-tests'), 02:45:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:45:14 INFO - 'download_minidump_stackwalk': True, 02:45:14 INFO - 'download_symbols': 'ondemand', 02:45:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:45:14 INFO - 'tooltool.py': '/tools/tooltool.py', 02:45:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:45:14 INFO - '/tools/misc-python/virtualenv.py')}, 02:45:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:45:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:45:14 INFO - 'installer_path': 'installer.exe', 02:45:14 INFO - 'log_level': 'info', 02:45:14 INFO - 'log_name': 'talos', 02:45:14 INFO - 'log_to_console': True, 02:45:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:45:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:45:14 INFO - 'opt_config_files': (), 02:45:14 INFO - 'pip_index': False, 02:45:14 INFO - 'sps_profile': False, 02:45:14 INFO - 'sps_profile_interval': 0, 02:45:14 INFO - 'suite': 'dromaeojs', 02:45:14 INFO - 'system_bits': '32', 02:45:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:45:14 INFO - 'title': 'talos-linux64-ix-021', 02:45:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:45:14 INFO - 'use_talos_json': True, 02:45:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:45:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:45:14 INFO - 'work_dir': 'build'} 02:45:14 INFO - ##### 02:45:14 INFO - ##### Running clobber step. 02:45:14 INFO - ##### 02:45:14 INFO - Running pre-action listener: _resource_record_pre_action 02:45:14 INFO - Running main action method: clobber 02:45:14 INFO - rmtree: /builds/slave/test/build 02:45:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:45:15 INFO - Running post-action listener: _resource_record_post_action 02:45:15 INFO - ##### 02:45:15 INFO - ##### Running read-buildbot-config step. 02:45:15 INFO - ##### 02:45:15 INFO - Running pre-action listener: _resource_record_pre_action 02:45:15 INFO - Running main action method: read_buildbot_config 02:45:15 INFO - Using buildbot properties: 02:45:15 INFO - { 02:45:15 INFO - "project": "", 02:45:15 INFO - "product": "firefox", 02:45:15 INFO - "script_repo_revision": "production", 02:45:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:45:15 INFO - "repository": "", 02:45:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:45:15 INFO - "buildid": "20160418000649", 02:45:15 INFO - "pgo_build": "True", 02:45:15 INFO - "basedir": "/builds/slave/test", 02:45:15 INFO - "buildnumber": 40, 02:45:15 INFO - "slavename": "talos-linux64-ix-021", 02:45:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:45:15 INFO - "platform": "ubuntu64_hw", 02:45:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:45:15 INFO - "branch": "fx-team", 02:45:15 INFO - "repo_path": "integration/fx-team", 02:45:15 INFO - "revision": "96046381bf0b", 02:45:15 INFO - "stage_platform": "linux64-pgo", 02:45:15 INFO - "builduid": "9eeaa1c12cae47b781f853e73aac361d", 02:45:15 INFO - "slavebuilddir": "test" 02:45:15 INFO - } 02:45:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:45:15 INFO - Running post-action listener: _resource_record_post_action 02:45:15 INFO - ##### 02:45:15 INFO - ##### Running download-and-extract step. 02:45:15 INFO - ##### 02:45:15 INFO - Running pre-action listener: _resource_record_pre_action 02:45:15 INFO - Running main action method: download_and_extract 02:45:15 INFO - mkdir: /builds/slave/test/build/tests 02:45: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')]} 02:45:15 INFO - https://queue.taskcluster.net/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:45:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:45:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:45:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:45:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:45:16 INFO - Downloaded 1361 bytes. 02:45:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:45:16 INFO - Using the following test package requirements: 02:45:16 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:45:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:45:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:45:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:16 INFO - u'jsshell-linux-x86_64.zip'], 02:45:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:45:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:45:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:45:16 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:45:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:45:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:45:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:16 INFO - https://queue.taskcluster.net/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:45:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:45:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:45:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:45:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:45:18 INFO - Downloaded 23774902 bytes. 02:45:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:45:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:45:19 INFO - Return code: 0 02:45:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:19 INFO - https://queue.taskcluster.net/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:45:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:45:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:45:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:45:36 INFO - Downloaded 23774902 bytes. 02:45:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:45:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:45:37 INFO - Return code: 0 02:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:37 INFO - https://queue.taskcluster.net/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:45:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:45:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:45:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:45:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:45:38 INFO - Downloaded 10841076 bytes. 02:45:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:45:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:45:38 INFO - Return code: 0 02:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:38 INFO - https://queue.taskcluster.net/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:45:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:45:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:45:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:45:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:45:40 INFO - Downloaded 58239803 bytes. 02:45:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:45:40 INFO - mkdir: /builds/slave/test/properties 02:45:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:45:40 INFO - Writing to file /builds/slave/test/properties/build_url 02:45:40 INFO - Contents: 02:45:40 INFO - build_url:https://queue.taskcluster.net/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:45:41 INFO - Running post-action listener: _resource_record_post_action 02:45:41 INFO - Running post-action listener: set_extra_try_arguments 02:45:41 INFO - ##### 02:45:41 INFO - ##### Running populate-webroot step. 02:45:41 INFO - ##### 02:45:41 INFO - Running pre-action listener: _resource_record_pre_action 02:45:41 INFO - Running main action method: populate_webroot 02:45:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:45:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:45:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:45:41 INFO - '--tppagecycles', 02:45:41 INFO - '7'], 02:45:41 INFO - 'tests': ['tsvgm']}}, 02:45:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:45:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:45:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:45:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:45:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:41 INFO - 'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:41 INFO - 'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['damp', 'tps']}, 02:45:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:41 INFO - 'tests': ['damp', 'tps']}, 02:45:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['dromaeo_dom']}, 02:45:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:45:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['a11yr', 02:45:41 INFO - 'ts_paint', 02:45:41 INFO - 'tpaint', 02:45:41 INFO - 'sessionrestore', 02:45:41 INFO - 'sessionrestore_no_auto_restore', 02:45:41 INFO - 'tabpaint']}, 02:45:41 INFO - 'other-e10s': {'tests': ['a11yr', 02:45:41 INFO - 'ts_paint', 02:45:41 INFO - 'tpaint', 02:45:41 INFO - 'sessionrestore', 02:45:41 INFO - 'sessionrestore_no_auto_restore', 02:45:41 INFO - 'tabpaint']}, 02:45:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:45:41 INFO - 'ts_paint', 02:45:41 INFO - 'tpaint', 02:45:41 INFO - 'sessionrestore', 02:45:41 INFO - 'sessionrestore_no_auto_restore', 02:45:41 INFO - 'tabpaint']}, 02:45:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:45:41 INFO - 'ts_paint', 02:45:41 INFO - 'tpaint', 02:45:41 INFO - 'sessionrestore', 02:45:41 INFO - 'sessionrestore_no_auto_restore', 02:45:41 INFO - 'tabpaint']}, 02:45:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['a11yr', 02:45:41 INFO - 'ts_paint', 02:45:41 INFO - 'tpaint', 02:45:41 INFO - 'sessionrestore', 02:45:41 INFO - 'sessionrestore_no_auto_restore', 02:45:41 INFO - 'tabpaint']}, 02:45:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['a11yr', 02:45:41 INFO - 'ts_paint', 02:45:41 INFO - 'tpaint', 02:45:41 INFO - 'sessionrestore', 02:45:41 INFO - 'sessionrestore_no_auto_restore', 02:45:41 INFO - 'tabpaint']}, 02:45:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['tsvgx', 02:45:41 INFO - 'tsvgr_opacity', 02:45:41 INFO - 'tart', 02:45:41 INFO - 'tscrollx', 02:45:41 INFO - 'cart']}, 02:45:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:45:41 INFO - 'tsvgr_opacity', 02:45:41 INFO - 'tart', 02:45:41 INFO - 'tscrollx', 02:45:41 INFO - 'cart']}, 02:45:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:41 INFO - 'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['tp5o']}, 02:45:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:41 INFO - 'tests': ['tp5o']}, 02:45:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:41 INFO - 'talos_options': ['--disable-e10s', 02:45:41 INFO - '--xperf_path', 02:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:45:41 INFO - 'tests': ['tp5n']}, 02:45:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:41 INFO - 'talos_options': ['--xperf_path', 02:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:45:41 INFO - 'tests': ['tp5n']}}, 02:45:41 INFO - 'talos.zip': {'path': '', 02:45:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:45:41 INFO - Running post-action listener: _resource_record_post_action 02:45:41 INFO - ##### 02:45:41 INFO - ##### Running create-virtualenv step. 02:45:41 INFO - ##### 02:45:41 INFO - Running pre-action listener: _resource_record_pre_action 02:45:41 INFO - Running main action method: create_virtualenv 02:45:41 INFO - Creating virtualenv /builds/slave/test/build/venv 02:45:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:45:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:45:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:45:41 INFO - Using real prefix '/usr' 02:45:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:45:41 INFO - Installing distribute.............................................................................................................................................................................................done. 02:45:43 INFO - Installing pip.................done. 02:45:43 INFO - Return code: 0 02:45:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:43 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 0x7fb0a4d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b209a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf810>, '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 0x2bb0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', '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 02:45:43 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 02:45:43 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 02:45:43 INFO - Using env: {'DISPLAY': ':0', 02:45:43 INFO - 'HOME': '/home/cltbld', 02:45:43 INFO - 'LANG': 'en_US.UTF-8', 02:45:43 INFO - 'LANGUAGE': 'en_US:en', 02:45:43 INFO - 'LOGNAME': 'cltbld', 02:45:43 INFO - 'MAIL': '/var/mail/cltbld', 02:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:43 INFO - 'MOZ_NO_REMOTE': '1', 02:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:43 INFO - 'NO_EM_RESTART': '1', 02:45:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:43 INFO - 'PWD': '/builds/slave/test', 02:45:43 INFO - 'SHELL': '/bin/bash', 02:45:43 INFO - 'SHLVL': '1', 02:45:43 INFO - 'TERM': 'linux', 02:45:43 INFO - 'TMOUT': '86400', 02:45:43 INFO - 'USER': 'cltbld', 02:45:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', 02:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:43 INFO - '_': '/tools/buildbot/bin/python'} 02:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:43 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 02:45:43 INFO - Cleaning up... 02:45:43 INFO - Return code: 0 02:45:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:43 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 0x7fb0a4d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b209a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf810>, '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 0x2bb0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', '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 02:45:43 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 02:45:43 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 02:45:43 INFO - Using env: {'DISPLAY': ':0', 02:45:43 INFO - 'HOME': '/home/cltbld', 02:45:43 INFO - 'LANG': 'en_US.UTF-8', 02:45:43 INFO - 'LANGUAGE': 'en_US:en', 02:45:43 INFO - 'LOGNAME': 'cltbld', 02:45:43 INFO - 'MAIL': '/var/mail/cltbld', 02:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:43 INFO - 'MOZ_NO_REMOTE': '1', 02:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:43 INFO - 'NO_EM_RESTART': '1', 02:45:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:43 INFO - 'PWD': '/builds/slave/test', 02:45:43 INFO - 'SHELL': '/bin/bash', 02:45:43 INFO - 'SHLVL': '1', 02:45:43 INFO - 'TERM': 'linux', 02:45:43 INFO - 'TMOUT': '86400', 02:45:43 INFO - 'USER': 'cltbld', 02:45:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', 02:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:43 INFO - '_': '/tools/buildbot/bin/python'} 02:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:44 INFO - Downloading/unpacking psutil>=0.7.1 02:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:45:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:46 INFO - Installing collected packages: psutil 02:45:46 INFO - Running setup.py install for psutil 02:45:46 INFO - building 'psutil._psutil_linux' extension 02:45:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:45:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:45:46 INFO - building 'psutil._psutil_posix' extension 02:45:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:45:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:45:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:46 INFO - Successfully installed psutil 02:45:46 INFO - Cleaning up... 02:45:46 INFO - Return code: 0 02:45:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:45:46 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')]} 02:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:46 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')]} 02:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:46 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 0x7fb0a4d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b209a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf810>, '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 0x2bb0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', '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 02:45:46 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 02:45:46 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 02:45:46 INFO - Using env: {'DISPLAY': ':0', 02:45:46 INFO - 'HOME': '/home/cltbld', 02:45:46 INFO - 'LANG': 'en_US.UTF-8', 02:45:46 INFO - 'LANGUAGE': 'en_US:en', 02:45:46 INFO - 'LOGNAME': 'cltbld', 02:45:46 INFO - 'MAIL': '/var/mail/cltbld', 02:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:46 INFO - 'MOZ_NO_REMOTE': '1', 02:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:46 INFO - 'NO_EM_RESTART': '1', 02:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:46 INFO - 'PWD': '/builds/slave/test', 02:45:46 INFO - 'SHELL': '/bin/bash', 02:45:46 INFO - 'SHLVL': '1', 02:45:46 INFO - 'TERM': 'linux', 02:45:46 INFO - 'TMOUT': '86400', 02:45:46 INFO - 'USER': 'cltbld', 02:45:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', 02:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:46 INFO - '_': '/tools/buildbot/bin/python'} 02:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:45:48 INFO - Installing collected packages: mozsystemmonitor 02:45:48 INFO - Running setup.py install for mozsystemmonitor 02:45:48 INFO - Successfully installed mozsystemmonitor 02:45:48 INFO - Cleaning up... 02:45:49 INFO - Return code: 0 02:45:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0a4d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b209a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf810>, '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 0x2bb0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', '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 02:45:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:45:49 INFO - Using env: {'DISPLAY': ':0', 02:45:49 INFO - 'HOME': '/home/cltbld', 02:45:49 INFO - 'LANG': 'en_US.UTF-8', 02:45:49 INFO - 'LANGUAGE': 'en_US:en', 02:45:49 INFO - 'LOGNAME': 'cltbld', 02:45:49 INFO - 'MAIL': '/var/mail/cltbld', 02:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:49 INFO - 'MOZ_NO_REMOTE': '1', 02:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:49 INFO - 'NO_EM_RESTART': '1', 02:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:49 INFO - 'PWD': '/builds/slave/test', 02:45:49 INFO - 'SHELL': '/bin/bash', 02:45:49 INFO - 'SHLVL': '1', 02:45:49 INFO - 'TERM': 'linux', 02:45:49 INFO - 'TMOUT': '86400', 02:45:49 INFO - 'USER': 'cltbld', 02:45:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', 02:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:49 INFO - '_': '/tools/buildbot/bin/python'} 02:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:49 INFO - Downloading/unpacking blobuploader==1.2.4 02:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:51 INFO - Downloading blobuploader-1.2.4.tar.gz 02:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:45:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:45:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:51 INFO - Downloading docopt-0.6.1.tar.gz 02:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:45:51 INFO - Installing collected packages: blobuploader, requests, docopt 02:45:51 INFO - Running setup.py install for blobuploader 02:45:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:45:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:45:51 INFO - Running setup.py install for requests 02:45:52 INFO - Running setup.py install for docopt 02:45:52 INFO - Successfully installed blobuploader requests docopt 02:45:52 INFO - Cleaning up... 02:45:52 INFO - Return code: 0 02:45:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0a4d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b209a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf810>, '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 0x2bb0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', '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 02:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:45:52 INFO - Using env: {'DISPLAY': ':0', 02:45:52 INFO - 'HOME': '/home/cltbld', 02:45:52 INFO - 'LANG': 'en_US.UTF-8', 02:45:52 INFO - 'LANGUAGE': 'en_US:en', 02:45:52 INFO - 'LOGNAME': 'cltbld', 02:45:52 INFO - 'MAIL': '/var/mail/cltbld', 02:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:52 INFO - 'MOZ_NO_REMOTE': '1', 02:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:52 INFO - 'NO_EM_RESTART': '1', 02:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:52 INFO - 'PWD': '/builds/slave/test', 02:45:52 INFO - 'SHELL': '/bin/bash', 02:45:52 INFO - 'SHLVL': '1', 02:45:52 INFO - 'TERM': 'linux', 02:45:52 INFO - 'TMOUT': '86400', 02:45:52 INFO - 'USER': 'cltbld', 02:45:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', 02:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:52 INFO - '_': '/tools/buildbot/bin/python'} 02:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:52 INFO - Running setup.py (path:/tmp/pip-lN_3ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:52 INFO - Running setup.py (path:/tmp/pip-nKzZjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:52 INFO - Running setup.py (path:/tmp/pip-hGseSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:52 INFO - Running setup.py (path:/tmp/pip-H9Iwhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:52 INFO - Running setup.py (path:/tmp/pip-CW502Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:52 INFO - Running setup.py (path:/tmp/pip-9GYGj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:53 INFO - Running setup.py (path:/tmp/pip-udnlYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:53 INFO - Running setup.py (path:/tmp/pip-4j7CIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:53 INFO - Running setup.py (path:/tmp/pip-63UUxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:53 INFO - Running setup.py (path:/tmp/pip-q6sqBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:53 INFO - Running setup.py (path:/tmp/pip-ehumZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:53 INFO - Running setup.py (path:/tmp/pip-P69gyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:53 INFO - Running setup.py (path:/tmp/pip-l1Kinp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:53 INFO - Running setup.py (path:/tmp/pip-Ett1rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:53 INFO - Running setup.py (path:/tmp/pip-TUHesN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:53 INFO - Running setup.py (path:/tmp/pip-ugRXCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:53 INFO - Running setup.py (path:/tmp/pip-uagO1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:45:53 INFO - Running setup.py install for manifestparser 02:45:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:45:54 INFO - Running setup.py install for mozcrash 02:45:54 INFO - Running setup.py install for mozdebug 02:45:54 INFO - Running setup.py install for mozdevice 02:45:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:45:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:45:54 INFO - Running setup.py install for mozfile 02:45:54 INFO - Running setup.py install for mozhttpd 02:45:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:45:54 INFO - Running setup.py install for mozinfo 02:45:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:45:54 INFO - Running setup.py install for mozInstall 02:45:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:45:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:45:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:45:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:45:54 INFO - Running setup.py install for mozleak 02:45:54 INFO - Running setup.py install for mozlog 02:45:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:45:54 INFO - Running setup.py install for moznetwork 02:45:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:45:55 INFO - Running setup.py install for mozprocess 02:45:55 INFO - Running setup.py install for mozprofile 02:45:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:45:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:45:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:45:55 INFO - Running setup.py install for mozrunner 02:45:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:45:55 INFO - Running setup.py install for mozscreenshot 02:45:55 INFO - Running setup.py install for moztest 02:45:55 INFO - Running setup.py install for mozversion 02:45:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:45:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:45:55 INFO - Cleaning up... 02:45:55 INFO - Return code: 0 02:45:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:55 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 0x7fb0a4d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b209a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf810>, '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 0x2bb0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', '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 02:45:55 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 02:45:55 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 02:45:55 INFO - Using env: {'DISPLAY': ':0', 02:45:55 INFO - 'HOME': '/home/cltbld', 02:45:55 INFO - 'LANG': 'en_US.UTF-8', 02:45:55 INFO - 'LANGUAGE': 'en_US:en', 02:45:55 INFO - 'LOGNAME': 'cltbld', 02:45:55 INFO - 'MAIL': '/var/mail/cltbld', 02:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:55 INFO - 'MOZ_NO_REMOTE': '1', 02:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:55 INFO - 'NO_EM_RESTART': '1', 02:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:55 INFO - 'PWD': '/builds/slave/test', 02:45:55 INFO - 'SHELL': '/bin/bash', 02:45:55 INFO - 'SHLVL': '1', 02:45:55 INFO - 'TERM': 'linux', 02:45:55 INFO - 'TMOUT': '86400', 02:45:55 INFO - 'USER': 'cltbld', 02:45:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', 02:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:55 INFO - '_': '/tools/buildbot/bin/python'} 02:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:55 INFO - Running setup.py (path:/tmp/pip-jPchJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:55 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)) 02:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:55 INFO - Running setup.py (path:/tmp/pip-TjrQLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:56 INFO - Running setup.py (path:/tmp/pip-H02trf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:56 INFO - Running setup.py (path:/tmp/pip-q__sPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:56 INFO - Running setup.py (path:/tmp/pip-74N_se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:56 INFO - Running setup.py (path:/tmp/pip-nAtjwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:56 INFO - Running setup.py (path:/tmp/pip-C0tkFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:56 INFO - Running setup.py (path:/tmp/pip-NOmZWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:56 INFO - Running setup.py (path:/tmp/pip-2L9siZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:56 INFO - Running setup.py (path:/tmp/pip-IvPSjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:56 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)) 02:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:56 INFO - Running setup.py (path:/tmp/pip-NNNHQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:56 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)) 02:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:56 INFO - Running setup.py (path:/tmp/pip-lE12f4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:56 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)) 02:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:56 INFO - Running setup.py (path:/tmp/pip-41YXKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:56 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)) 02:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:56 INFO - Running setup.py (path:/tmp/pip-ZfYHwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:56 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)) 02:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:56 INFO - Running setup.py (path:/tmp/pip-uNj8lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:57 INFO - Running setup.py (path:/tmp/pip-LhCwIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:57 INFO - Running setup.py (path:/tmp/pip-eJrsUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:45:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:59 INFO - Downloading blessings-1.6.tar.gz 02:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:45:59 INFO - Installing collected packages: blessings 02:45:59 INFO - Running setup.py install for blessings 02:45:59 INFO - Successfully installed blessings 02:45:59 INFO - Cleaning up... 02:45:59 INFO - Return code: 0 02:45:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:45:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:59 INFO - Reading from file tmpfile_stdout 02:45:59 INFO - Current package versions: 02:45:59 INFO - argparse == 1.2.1 02:45:59 INFO - blessings == 1.6 02:45:59 INFO - blobuploader == 1.2.4 02:45:59 INFO - docopt == 0.6.1 02:45:59 INFO - manifestparser == 1.1 02:45:59 INFO - mozInstall == 1.12 02:45:59 INFO - mozcrash == 0.17 02:45:59 INFO - mozdebug == 0.1 02:45:59 INFO - mozdevice == 0.48 02:45:59 INFO - mozfile == 1.2 02:45:59 INFO - mozhttpd == 0.7 02:45:59 INFO - mozinfo == 0.9 02:45:59 INFO - mozleak == 0.1 02:45:59 INFO - mozlog == 3.1 02:45:59 INFO - moznetwork == 0.27 02:45:59 INFO - mozprocess == 0.22 02:45:59 INFO - mozprofile == 0.28 02:45:59 INFO - mozrunner == 6.11 02:45:59 INFO - mozscreenshot == 0.1 02:45:59 INFO - mozsystemmonitor == 0.0 02:45:59 INFO - moztest == 0.7 02:45:59 INFO - mozversion == 1.4 02:45:59 INFO - psutil == 3.1.1 02:45:59 INFO - requests == 1.2.3 02:45:59 INFO - wsgiref == 0.1.2 02:45:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0a4d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b209a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf810>, '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 0x2bb0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', '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 02:45:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:45:59 INFO - Using env: {'DISPLAY': ':0', 02:45:59 INFO - 'HOME': '/home/cltbld', 02:45:59 INFO - 'LANG': 'en_US.UTF-8', 02:45:59 INFO - 'LANGUAGE': 'en_US:en', 02:45:59 INFO - 'LOGNAME': 'cltbld', 02:45:59 INFO - 'MAIL': '/var/mail/cltbld', 02:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:59 INFO - 'MOZ_NO_REMOTE': '1', 02:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:59 INFO - 'NO_EM_RESTART': '1', 02:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:59 INFO - 'PWD': '/builds/slave/test', 02:45:59 INFO - 'SHELL': '/bin/bash', 02:45:59 INFO - 'SHLVL': '1', 02:45:59 INFO - 'TERM': 'linux', 02:45:59 INFO - 'TMOUT': '86400', 02:45:59 INFO - 'USER': 'cltbld', 02:45:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', 02:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:59 INFO - '_': '/tools/buildbot/bin/python'} 02:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:59 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)) 02:45:59 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)) 02:45:59 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)) 02:45:59 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)) 02:45:59 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)) 02:45:59 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)) 02:45:59 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)) 02:45:59 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)) 02:45:59 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)) 02:45:59 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)) 02:45:59 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)) 02:45:59 INFO - Cleaning up... 02:45:59 INFO - Return code: 0 02:45:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0a4d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b209a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf810>, '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 0x2bb0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', '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 02:45:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:45:59 INFO - Using env: {'DISPLAY': ':0', 02:45:59 INFO - 'HOME': '/home/cltbld', 02:45:59 INFO - 'LANG': 'en_US.UTF-8', 02:45:59 INFO - 'LANGUAGE': 'en_US:en', 02:45:59 INFO - 'LOGNAME': 'cltbld', 02:45:59 INFO - 'MAIL': '/var/mail/cltbld', 02:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:59 INFO - 'MOZ_NO_REMOTE': '1', 02:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:59 INFO - 'NO_EM_RESTART': '1', 02:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:59 INFO - 'PWD': '/builds/slave/test', 02:45:59 INFO - 'SHELL': '/bin/bash', 02:45:59 INFO - 'SHLVL': '1', 02:45:59 INFO - 'TERM': 'linux', 02:45:59 INFO - 'TMOUT': '86400', 02:45:59 INFO - 'USER': 'cltbld', 02:45:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', 02:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:59 INFO - '_': '/tools/buildbot/bin/python'} 02:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:59 INFO - Downloading/unpacking jsonschema 02:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:46:01 INFO - Downloading/unpacking functools32 (from jsonschema) 02:46:01 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 02:46:01 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 02:46:01 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 02:46:01 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 02:46:01 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 02:46:01 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 02:46:01 INFO - Downloading functools32-3.2.3-2.tar.gz 02:46:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:46:02 INFO - warning: no files found matching '*.txt' 02:46:02 INFO - no previously-included directories found matching 'build' 02:46:02 INFO - no previously-included directories found matching 'dist' 02:46:02 INFO - no previously-included directories found matching '.git*' 02:46:02 INFO - Installing collected packages: jsonschema, functools32 02:46:02 INFO - Running setup.py install for functools32 02:46:02 INFO - warning: no files found matching '*.txt' 02:46:02 INFO - no previously-included directories found matching 'build' 02:46:02 INFO - no previously-included directories found matching 'dist' 02:46:02 INFO - no previously-included directories found matching '.git*' 02:46:02 INFO - Successfully installed jsonschema functools32 02:46:02 INFO - Cleaning up... 02:46:02 INFO - Return code: 0 02:46:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0a4d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b209a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf810>, '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 0x2bb0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', '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 02:46:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:46:02 INFO - Using env: {'DISPLAY': ':0', 02:46:02 INFO - 'HOME': '/home/cltbld', 02:46:02 INFO - 'LANG': 'en_US.UTF-8', 02:46:02 INFO - 'LANGUAGE': 'en_US:en', 02:46:02 INFO - 'LOGNAME': 'cltbld', 02:46:02 INFO - 'MAIL': '/var/mail/cltbld', 02:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:02 INFO - 'MOZ_NO_REMOTE': '1', 02:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:02 INFO - 'NO_EM_RESTART': '1', 02:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:02 INFO - 'PWD': '/builds/slave/test', 02:46:02 INFO - 'SHELL': '/bin/bash', 02:46:02 INFO - 'SHLVL': '1', 02:46:02 INFO - 'TERM': 'linux', 02:46:02 INFO - 'TMOUT': '86400', 02:46:02 INFO - 'USER': 'cltbld', 02:46:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', 02:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:02 INFO - '_': '/tools/buildbot/bin/python'} 02:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:02 INFO - Downloading/unpacking flake8 02:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:46:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:46:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:46:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:46:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:46:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:46:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:46:05 INFO - no previously-included directories found matching 'docs/_build' 02:46:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:46:05 INFO - Running setup.py install for pep8 02:46:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:46:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:46:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:46:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:46:05 INFO - no previously-included directories found matching 'docs/_build' 02:46:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:46:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:46:05 INFO - Cleaning up... 02:46:05 INFO - Return code: 0 02:46:05 INFO - Running post-action listener: _resource_record_post_action 02:46:05 INFO - Running post-action listener: _start_resource_monitoring 02:46:05 INFO - Starting resource monitoring. 02:46:05 INFO - ##### 02:46:05 INFO - ##### Running install step. 02:46:05 INFO - ##### 02:46:05 INFO - Running pre-action listener: _resource_record_pre_action 02:46:05 INFO - Running main action method: install 02:46:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:05 INFO - Reading from file tmpfile_stdout 02:46:05 INFO - Detecting whether we're running mozinstall >=1.0... 02:46:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:46:05 INFO - Reading from file tmpfile_stdout 02:46:05 INFO - Output received: 02:46:05 INFO - Usage: mozinstall [options] installer 02:46:05 INFO - Options: 02:46:05 INFO - -h, --help show this help message and exit 02:46:05 INFO - -d DEST, --destination=DEST 02:46:05 INFO - Directory to install application into. [default: 02:46:05 INFO - "/builds/slave/test"] 02:46:05 INFO - --app=APP Application being installed. [default: firefox] 02:46:05 INFO - mkdir: /builds/slave/test/build/application 02:46:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:46:22 INFO - Reading from file tmpfile_stdout 02:46:22 INFO - Output received: 02:46:22 INFO - /builds/slave/test/build/application/firefox/firefox 02:46:22 INFO - Running post-action listener: _resource_record_post_action 02:46:22 INFO - ##### 02:46:22 INFO - ##### Running run-tests step. 02:46:22 INFO - ##### 02:46:22 INFO - Running pre-action listener: _resource_record_pre_action 02:46:22 INFO - Running main action method: run_tests 02:46:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:46:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:46:22 INFO - Python 2.7.3 02:46:22 INFO - Return code: 0 02:46:22 INFO - grabbing minidump binary from tooltool 02:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:46:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf810>, '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 0x2bb0710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:46:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:46:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:46:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:46:22 INFO - Return code: 0 02:46:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:46:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:46:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:46:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:46:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:46:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:46:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:46:23 INFO - Return code: 0 02:46:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 02:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 02:46:23 INFO - Using env: {'DISPLAY': ':0', 02:46:23 INFO - 'HOME': '/home/cltbld', 02:46:23 INFO - 'LANG': 'en_US.UTF-8', 02:46:23 INFO - 'LANGUAGE': 'en_US:en', 02:46:23 INFO - 'LOGNAME': 'cltbld', 02:46:23 INFO - 'MAIL': '/var/mail/cltbld', 02:46:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:46:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:23 INFO - 'MOZ_NO_REMOTE': '1', 02:46:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:23 INFO - 'NO_EM_RESTART': '1', 02:46:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:23 INFO - 'PWD': '/builds/slave/test', 02:46:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:46:23 INFO - 'SHELL': '/bin/bash', 02:46:23 INFO - 'SHLVL': '1', 02:46:23 INFO - 'TERM': 'linux', 02:46:23 INFO - 'TMOUT': '86400', 02:46:23 INFO - 'USER': 'cltbld', 02:46:23 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460971753.797805-202910072', 02:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:23 INFO - '_': '/tools/buildbot/bin/python'} 02:46:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 02:46:23 INFO - mozversion application_buildid: 20160418000649 02:46:23 INFO - mozversion application_changeset: 96046381bf0b32a868995824a5abc6c209496a3e 02:46:23 INFO - mozversion application_display_name: Nightly 02:46:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:46:23 INFO - mozversion application_name: Firefox 02:46:23 INFO - mozversion application_remotingname: firefox 02:46:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:46:23 INFO - mozversion application_vendor: Mozilla 02:46:23 INFO - mozversion application_version: 48.0a1 02:46:23 INFO - mozversion platform_buildid: 20160418000649 02:46:23 INFO - mozversion platform_changeset: 96046381bf0b32a868995824a5abc6c209496a3e 02:46:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:46:23 INFO - mozversion platform_version: 48.0a1 02:46:23 INFO - using testdate: 1460972783 02:46:23 INFO - actual date: 1460972783 02:46:23 INFO - starting webserver on 'localhost:59892' 02:46:23 INFO - SUITE-START | Running 2 tests 02:46:23 INFO - TEST-START | dromaeo_css 02:46:23 INFO - operating with platform_type : linux_ 02:46:23 INFO - Initialising browser for dromaeo_css test... 02:46:23 INFO - TEST-INFO | started process 32153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxNgT08/profile http://localhost:59892/getInfo.html) 02:46:28 INFO - PROCESS | 32153 | __metrics Screen width/height:1600/1200 02:46:28 INFO - PROCESS | 32153 | colorDepth:24 02:46:28 INFO - PROCESS | 32153 | Browser inner width/height: 1024/697 02:46:28 INFO - PROCESS | 32153 | __metrics 02:46:29 ERROR - PROCESS | 32153 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:46:29 INFO - PROCESS | 32153 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 02:46:30 INFO - TEST-INFO | 32153: exit 0 02:46:30 INFO - Browser initialized. 02:46:30 INFO - Running cycle 1/1 for dromaeo_css test... 02:46:30 INFO - TEST-INFO | started process 32233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxNgT08/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:42 INFO - PROCESS | 32233 | RSS: Main: 153075712 02:46:42 INFO - PROCESS | 32233 | 02:47:33 INFO - PROCESS | 32233 | 1460972853355 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] 02:49:41 INFO - PROCESS | 32233 | Cycle 1(1): loaded http://localhost:59892/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59892/tests/dromaeo/cssquery-ext.html) 02:49:42 INFO - PROCESS | 32233 | RSS: Main: 257425408 02:49:42 INFO - PROCESS | 32233 | 02:52:44 INFO - PROCESS | 32233 | Cycle 1(1): loaded http://localhost:59892/tests/dromaeo/cssquery-ext.html (next: http://localhost:59892/tests/dromaeo/cssquery-jquery.html) 02:52:44 INFO - PROCESS | 32233 | RSS: Main: 235040768 02:52:44 INFO - PROCESS | 32233 | 02:55:46 INFO - PROCESS | 32233 | Cycle 1(1): loaded http://localhost:59892/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59892/tests/dromaeo/cssquery-mootools.html) 02:55:47 INFO - PROCESS | 32233 | RSS: Main: 239403008 02:55:47 INFO - PROCESS | 32233 | 02:58:49 INFO - PROCESS | 32233 | Cycle 1(1): loaded http://localhost:59892/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59892/tests/dromaeo/cssquery-prototype.html) 02:58:49 INFO - PROCESS | 32233 | RSS: Main: 230477824 02:58:49 INFO - PROCESS | 32233 | 03:01:52 INFO - PROCESS | 32233 | Cycle 1(1): loaded http://localhost:59892/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59892/tests/dromaeo/cssquery-yui.html) 03:01:52 INFO - PROCESS | 32233 | RSS: Main: 222138368 03:01:52 INFO - PROCESS | 32233 | 03:04:55 INFO - PROCESS | 32233 | Cycle 1(1): loaded http://localhost:59892/tests/dromaeo/cssquery-yui.html (next: http://localhost:59892/tests/dromaeo/cssquery-dojo.html) 03:04:55 INFO - PROCESS | 32233 | RSS: Main: 272564224 03:04:55 INFO - PROCESS | 32233 | 03:04:55 INFO - PROCESS | 32233 | __start_tp_report 03:04:55 INFO - PROCESS | 32233 | _x_x_mozilla_page_load 03:04:55 INFO - PROCESS | 32233 | _x_x_mozilla_page_load_details 03:04:55 INFO - PROCESS | 32233 | |i|pagename|runs| 03:04:55 INFO - PROCESS | 32233 | |0;dojo.html;3010.924726881828;3029.378977309649;3067.6625571187164;3069.554914537392;3098.349346637205;5169.198774190002;5198.194279886614;5204.479552044799;5238.842834714955;5308.601854860882;5265.289185959894;5318.946810531894;5332.440093790145;5369.19462080689;5379.677219366831;4801.951980480203;4821.758912054401;4839.830605928793;4843.806247750086;5005.224190250498;4943.505649435064;4944.2089265717495;4962.0324036812835;5015.799368025275;5041.697498150104;4785.090832741768;4810.591099756525;4828.686135401188;4880.560749532524;4887.193613053842;4822.855314340575;4827.51724827518;4836.975815120937;4837.201861692816;4882.292067650206;4715.7877895494785;4761.142994261032;4788.257820037899;4796.232602783538;4832.806687732486;5193.610479214074;5205.999999999962;5207.6875387476875;5245;5261.289725886994;5583.553315734732;5607.887842243133;5610.579206559524;5611.2144299798065;5614.438556144394;5616.66300022;5632.831015069554;5642.069058605325;5683.090705487143;5743.310802703661;5290.867728306785;5315.787368505294;5316.282301889273;5316.867078323073;5343.438938911398;5776.480116789425;5777.7977770777825;5781.1328300754385;5781.797637082682;5782.797602083907;5394.352677678704;5538.833834984957;5542.140968149863;5593.580481463907;5632.1270203117765;5578.832635020955;5579.553635709133;5583.888322233533;5587.636803607753;5613.943860561424;5580;5591.30108736408;5591.3569939456665;5594.0769772987815;5595.300587426572;5513.61404701667;5593.664380137205;5650.63270887391;5658.801941932095;5702;4177.895552611209;4180.937285940713;4181.874543763692;4182.142660754538;4218.282891908383;3766.7551609145316;3810.5617853946596;3830.042489377656;3846.8653597123966;3868.845246190177;5296.602754793329;5309.044372012998;5317.41508434072;5341.0653135701095;5357.7053262070185;5638.126090455986;5671.943280567141;5675.744591493392;5676.914846277309;5676.971615141898;5239.528442440199;5264.15773476242;5273.604479664041;5295.788168473218;5347.786088556492;4779.522047795263;4783.736894470838;4795.424549054066;4806.158922188603;4824.059308434821;5847.9415205848245;5855.209546711225;5855.238818953594;5859.062549991981;5878.059510478303;5555.833325000256;5632.183333416713;5657.547396208293;5666.405027472221;5723.170140329546;5856.677882716321;5875.118732190205;5876.735546900485;5901.5868889177345;5929.377415371324;5593.944060559343;5594.188842617717;5595.244641973281;5595.300587426572;5614.803481878114;5570.5543556516195;5699.743511542073;5706.229658995982;5709.800156994485;5734.770609175586;5545.528630066489;5551.167324901297;5554;5559.444055594408;5563.916541251965;5478.616496845182;5488.231647569423;5522.392536820867;5527.115661494142;5531.778728850801;5390.784368625211;5443.700596467233;5509.146082357241;5523.779048838162;5546.750396232099;5601.887962240814;5603.915941260802;5612.607117501899;5617.101263797937;5619.269494965628;5481.095619222943;5492.038893193595;5496.038193316073;5505.889882202254;5542.057850165401 03:04:55 INFO - PROCESS | 32233 | |1;ext.html;605.8243109498246;660.7224965514483;661.0414898397325;668.7091115364815;671.9092922455467;29210.85394573027;36100.277994440126;37318.813405933;37333.62666373339;37417.81291093548;39107;39675.40486892699;39732.20535589287;39746;39886.800565997204;7673.539587624732;8296.58517074147;8505.319574434061;8508.489490630582;8528.616212270432;7870.803229919241;7995.760127196164;7999.160088190714;10059.144972677295;10478.790424191511;10110.69667909964;10226.130778883766;10226.130778883766;10228.94885525575;10232.181425485944;7866.68533258669;10032.949835250814;10191.439470829102;10211.948940255252;10216.795664086676;9940.25448091396;10379.42913139777;10386.065254127165;10389.324693894872;10395.064444200058;35912.46131308033;36784.26431471382;37182.44226336607;37227.25545489102;37230;3349.2464195555804;3390.3897298486263;3650.324689932371;3752.43713442983;3928.88213353597;28923;29303.85348073246;29599;31465.37069258625;32019.51970720441;4207.894802629929;4320.740755554645;4328.545502722201;4332.263515202423;4356.302991521373;286690;287186;287191;288154.5592272046;288850;55802.162967555516;56204.71897640486;56347;56406.7179664099;56517.71741141268;60010.69994649999;64033.679831600544;65953.67023164949;66120;66153.33846661568;17211.225494852762;17357.045362505185;17418.82581174172;17497.212625431886;17498.300067997137;13066.869331306756;13191.604251872459;13207.867921320856;13220.603381898558;13240.139390939557;19165.32921347774;19361.322353717835;19375.12811923467;19390.127444265043;19404.902975485315;6974.546654467444;7062.470314726416;7151.779201183165;7213.639318034182;7215.458840586977;1030.8711411073616;1064.914806815453;1076.7792602516465;1083.6640641401034;1267.6957530192872;31275.70371332796;31579;31753.523697144563;32009.51985720216;32012.839935800173;1110.8000559899135;1131.4064896520154;1147.9024282936043;1200.9191727445195;1214.2775048845922;16598;16931.661366772594;17023.659526809643;17039.744403833705;17104.57238569046;443825;443882;448330;449171;450125;55163.724181379635;56140.43859561352;56440.717796410754;56451;56520.43479565152;758.5069704691995;1222.4560070768423;1273.6943133647858;1338.939747711336;1435.9928200358931;28179;29974.100776976724;31662.68337316597;31758.523622145225;31847.840760796047;44738;45049.0990180188;45090.549094508635;45205.547944520134;45288.77355613201;267880;269267;269954;270514;270953;25062.498750024533;27194.32014199661;27986;28040.439191215653;28275.858620706764;43781.34327985146;43807.78096109499;44751.776241119886;44767;45339.54660453485;37738;37887.81056094812;37905.62094379131;37985.4302185473;38041.42937855879;36173;37819.81090094532;37867.62132378641;38106.42840357452;38333;38229;38921.80539097286;39278;39607.80196099001;39801;32880.83559582187;33951.15122121967;34226.82886585551;34292.314153717285;34404.31191376209;26616.334591635365;26624.33439163959;26915.86542067277;27214.319642009108;27265.86367068152 03:04:55 INFO - PROCESS | 32233 | |2;jquery.html;390.4631132193234;399.85605182134424;403.5601194697779;405.4688358250694;410.4561456070706;17386.826131738693;17935.372261970835;17967.910160449213;17979.37072202473;18722.438326850217;17477.213525391355;17527.12364381782;17563.5609109772;18270.360537381162;18533.07334633266;5581.916271255935;5629.324481062278;5664.971675141639;5678.233438485793;5742.7415766290615;5492.697901615409;5527.198556209347;5545.584081193906;5565.499105080542;5565.749541270632;5363.356397232337;5634.464725851038;5656.717164141797;5658.688772117532;5659.547236221092;5080.847574572768;5642.492175704166;5692.146178073281;5723.942760572403;5730.226419433386;5381.515663590296;5546.528545073674;5588.245586845765;5618.971905140448;5628.465295796893;13787.724245515134;13866.584002479942;13887.930560347235;16865.494035178963;20292;2260.062074239189;2297.184499502669;2338.941526461835;2402.735699073118;2406.7111946566347;10077.44574048427;10157;10247.180225581935;10247.948760256226;12114.909658130811;1891.4136617648435;1926.306529649325;1935.5838494723562;2053.5276886316083;2055.743032120985;77843.61078194629;78441.60779196124;82321;82700;83565.58217208875;10489.688788901387;10579.894201058045;10787.190960677981;10884.510197041152;11005.229633925548;14916.70166596662;14986.925065374822;15005.099694018394;15005.774913376308;15027.549173524812;8053;8257.339412846957;8269.255766981001;8382.664693412316;8388.028813228886;8090.797730056678;8098.473599216032;8114.7565573031725;8210.507369557845;8224.506529608243;4552.1806074906835;4552.908941821212;4585.564371384713;4587.495375508692;4660.720356778536;1830.6338732253603;1843.7234414837612;1861.2368928739152;1866.3281218761235;1880.5674694820268;941.1670671455674;1035.2701345551518;1054.0513537815873;1084.5607528950788;1090.3893819461127;18632;19093.236270549023;19380.515487112934;19594.510137246398;19825.405237842886;992.8858181309098;1023.6621914768109;1029.2846471702244;1042.338115296792;1054.7152268887357;10521.473926303808;10588.788224235472;10711.94644026775;10751;10799.78400431987;468200;472847;472941;479799;509931;91676;93717.5314123425;98601.50699246458;98740;99966.50016750015;1087.429099722636;1108.2685427617735;1114.7547539541288;1121.859767529059;1125.5047778977223;16307.266173022479;16783.74824377611;16807.495775126765;16940.915295423936;17000.48998530046;29863.104106876828;38568.61431385762;40144.79927600343;40409;40742.59257407507;55198.89602208014;55996.44003560075;56801.431985681265;57147;57567.7121614406;8487.321014318963;8800.295976321751;8882.866756998521;8988.741586172162;9021.45871247701;10925.453727313761;12619.242845428937;13347.799783003069;13446.126001809851;13502.324883755577;10765.138788897026;11345.943270283597;11610.825837612274;11712.70718232017;12141.75716485683;11101.722456938642;11337.433128343386;11373.488193031168;11581.189316748083;11645.126615503701;11484.19610627248;11508.251963622337;12154.878451215374;12261.448234829633;12404.689882753004;8465.95767021161;8782.560871956504;8886.800281961852;8951.060138685345;8971.596278167628;9140;11870;11890.227135236182;12010.63968080959;12235.388230588256 03:04:55 INFO - PROCESS | 32233 | |3;mootools.html;1355.3833005982278;1459.8976576863859;1528.0449718925672;1641.4911377472984;1770.955726106848;7912.406569507289;8248.505089694616;8265.338772898169;8265.380096492772;8266.090730019701;8062.4759390639565;8179.591020448984;8222.383321250914;8226.629801658924;8229.135940726228;2024.2712623455545;2246.472079061419;2328.3247858121167;2328.522652856169;2355.316958082154;2348.5772560939026;2360.1503458754833;2371.9644205336936;2372.240882917467;2374.53696529176;2306.6078766609635;2347.8943447544816;2350.3888988862846;2350.9529809403803;2356.5522550715395;2010.567727938493;2243.0915479230857;2325.7674232576605;2325.9418514537188;2328.9767102329097;2255.672927425514;2259.7401298850677;2265.7734226577377;2268.353519247023;2283.4519715268384;8266.504009759434;8290.544020078893;8292.17078292172;8372.41393102483;8379.664813407517;4886.975565122151;5047.545720885101;5049.394072711261;5063.11395505785;5081.161608334621;3273.394422031908;3350.6984371406447;3393.1856354474994;3428.9142771430916;3431.1079119428878;1136.8294755786699;1161.7211869151427;1169.7192673758323;1179.7050737315672;1190.6249531397582;11433.085353171726;11473.655790326304;11474.885251147465;11504.079673626173;11516.366599837005;4405.60349568534;4498.730076195438;4666.533346665306;4718.764061796896;4720.032393359353;9771.31600787938;9780.804383912424;9798.412095274307;9799.11807937289;9803.803923921481;4681.602063824613;5188.662736922088;5193.246979187997;5219.921701174486;5238.057149713089;4559.452865656076;4657.022025374641;4662.743549104764;4667.346571479996;4679.695819771704;3869.090763670535;3869.903252418712;3962.5244970603712;3981.343078392091;3992.900177495586;1225.3934302520308;1227.4599176362372;1243.1919252485775;1259.6472987563498;1271.2690203133236;957.8228027814737;965.3869792681697;972.2805124208035;977.9217662586976;984.8178087053918;5621.057037782699;5631.746571404296;5668.546516278688;5708.771649134072;5730.283714535683;467.91109689159634;481.22042291488015;484.41627838454576;485.0807719371771;999.2855108597388;4009.939850902239;4056.9797151014645;4059.106996460774;4078.57174996627;4109.301418758818;9993.450360230258;10332.948335258276;10356.223283253787;10364.222683298784;10413.16694664425;10190.490475476197;10198.490075496344;10199.0820826126;10207.132393746615;10254.077133058061;7358.705651773977;7585.317321441097;7723.613819309012;7745.728899488604;7818.530888146729;5864.504551339382;5913.34953155144;6019.277686677627;6026.969865150646;6049.425304596057;9161.679341223025;9252.49111298885;9331.72004839856;9530.666426675032;9555.569999350186;9068.818623627623;9447.196988256075;9568.09103135201;9575.09036641518;9581.185599223865;6871.828204294733;7146.928530714834;7356.632168391452;7378.409727221702;7579.848403032019;8141.267285944056;8153.592320383838;8213.54825484604;8231.588420579066;8258.298044666271;7119.110111236096;7243;7283.8543229136185;7339.853202935805;7477.289657482531;7318.34134927859;7374.557526548424;7383.409327253914;7400.629968501661;7408.222136675571;6522.34776522344;6623.172103487064;6625.734970601315;6626.966865165643;6627.23786764509;4870.2938073979785;4907.656464047483;4954.1825598775795;4970.975145124251;5000.349954505891;5071.340725705634;5111.642185047011;5120.25756265332;5123.513266239701;5259.000789850069 03:04:55 INFO - PROCESS | 32233 | |4;prototype.html;334.3163231192212;337.67751797033833;340.9198838273006;346.39726875237096;347.08369903454883;5620.325560932689;5638.661680299179;5689.402612725661;5707.885842283152;5750.453706897838;5654.632448890819;5660.632058916168;5682.772689092431;5692.459216374448;5701.8311246194535;4197.349410841317;4221.24017676818;4374.693771436001;4380.123975204971;4395.099004704044;4386;4408.889777755549;4414.492333381654;4416.359627853975;4430.933535996963;4194.496660400756;4399.824007039714;4407.779611019452;4411.558844115595;4412.558744125594;4268.338407546835;4292.656587472995;4401.581849724271;4404.515503294635;4408.779561021936;3868.6324799144318;3875.3218186817194;3876.069743261597;3894.591067937854;3899.064224586079;5248.186531087687;5389.568834493231;5392.325959255093;5415.833666533379;5417.022786682872;5016.247562865599;5028.371453568304;5030.421501527335;5045.117104506697;5065.898682026375;5875.941240587582;5899.439553242435;5902.2622172228475;5905.527557795366;5907.172995780594;3973.304671682473;4237.300845360512;4258.5528519505315;4269.338252570857;4294.935575966332;6192.420932662142;6193.4425901669065;6206.34833342497;6230.127782110508;6231.442139465134;4289.592488713567;4313.352997050468;4314.245007123741;4315.417418648505;4317.525072242051;4065.288574499451;4374.606285434326;4379.912401751947;4385.802638881258;4396.494403143615;4874.171390863562;4893.828715994923;4899.412070551485;4904.215325547895;4912.214045752662;5961.105834124916;5975.731092100866;5977.103434484775;5981.581289309706;6009;1465.340596731475;1489.4489039055402;1515.4014164404998;1516.150955464943;1521.6424140327015;946.3375637054089;994.8408254679362;996.0736515041082;1014.4116412480744;1022.8005538919839;5636.718164091779;5654.123610840326;5659.490645841894;5667.404922483162;5693.9430605693415;5999.460048595647;6015.518758499309;6030.487408570233;6050;6061.363556826558;5531.557475401958;5649.610233859651;5814.767409303665;5827.096799996008;5838.5329173666005;3298.5876765404323;3310.304835984422;3316.4527852904002;3316.7346612271444;3322.252493189013;6195.938040619536;6416.486681065597;6419;6430.935690643128;6473.643949582818;6306.590071645328;6325.545124621271;6325.96837015812;6332.8416789579705;6348.809535713936;6280.717367718372;6404.679766011681;6449.226092868886;6470.352964703586;6481.384268494391;6190.7523699051535;6205.968970155121;6209.516193522627;6225.595336303126;6243.37566243372;6118.235220597426;6140.3596453525415;6153.2000839890525;6168.938310616836;6187.16473276102;6330.49356051524;6444.387783160592;6490.935090649222;6502.187226596676;6510.21877374718;4318.481782186158;4318.956810431855;4338.262495375857;4347.500037495728;4357;6053.697315134314;6229.501639868709;6239.0953311770445;6246.875062498633;6253.78111766086;5934.139549765174;5952.494038006818;6001.969990150022;6042.637441753509;6057.57596968208;5950.256217972754;5966.49284810796;5994.700264986646;6015.608985415934;6035.577509574287;5509.586780991522;5906.734196961061;5920.407959204045;5935.673537955454;5948.078047902582;6018.21763170785;6023.216981792339;6038.486728628116;6061.212042434456;6064.818055458343;5661.320641523043;5879.882402352015;5899.6725736708895;5926.081457374114;5941.405859414024 03:04:55 INFO - PROCESS | 32233 | |5;yui.html;833.3791325462529;857.6912311567836;860.3418384935521;866.1857853617599;873.3100850328233;15663.608409789747;16190.676186476278;16191.595210119724;16197.83802161978;16225;14824.184669843155;14976.17631030293;15077.944543881933;15095.92452037741;15155.242237888117;681.2063945503483;795.2405452792569;819.2544784246337;828.3290534666924;839.3411172229801;812.7521106062678;817.5094943034192;818.3248819723722;818.5048045932215;821.7904434369258;849.6898631999306;849.796048948251;850.7107583421636;852.21170417364;854.7393045121236;703.4231929817552;836.1471299274737;847.9067302596709;851.5784686580121;854.1074577066948;620.92548894133;621.1521273461692;621.2420846567181;622.9719662615194;624.1854380034054;13203.2738199399;13213.471461141542;13227;13236.669083272898;13279.734405311936;13482.393292301771;13829;13882.51411200603;13901.930490347584;13968.720625587534;11639.59261425846;11790.646280611509;11877.287362758176;11911.344876031815;12025.93987030068;3827.2536855313224;3859.1895701902354;3868.2456920900436;3984.4222587724616;3988.142549351874;54313.185302220496;55538.44461555373;55812.44187558113;55829.72085139589;55914.44085559174;10754.300970436896;10800.945995269973;10822.134229261641;10838.78322433547;10848.132149428027;18952.526186845163;18962;18965.52586185329;18965.90517047406;19000.239990400507;7989.568869844796;8140.75577732669;8323.375746819012;8384.077751447336;8467.153284671484;4370.694051416434;4433.844815431445;4540.205464043779;4563.566461186182;4655.720656760537;3299.7690161688934;3450.741194410429;3457.87897423594;3460.498227756961;3462.497937799005;654.4633400611453;662.3409707341131;682.7166725808833;691.2914262880487;712.1311999360771;621.5059028072693;681.2948598200838;713.4149997002409;716.2729829223342;775.317720406039;8214.58927053645;9094.408863423989;9419.293552983554;9610.183134433511;9659.082387173208;699.4928676709446;733.7505248215632;755.7732680195919;770.6917233106802;786.7679034684782;4572.131295053996;4600.838970636011;4619.353290539327;4769.689970151929;4780.689255198401;63233;64379.67810161013;65026;65079.349206508276;65101;56858;56894;57143.71428142833;58274.4172558269;58274.41725582775;41592.792036040235;41781.58218417777;48251.75874120607;48481.5151848477;49292.50707492879;8617.439866408664;8848.734537963872;8953;8984.685536006209;9237.445753254557;29880.85059574688;30774.846125770124;31279.84360078185;31939.520907186874;32722.34555308833;40743;41982;42748;42911.78544107259;43862.56137438712;11866.76266474683;12085.39573021363;12177.208481448677;12309.56916507918;12766.234025958473;12680.492780288685;12925.676858078246;13095.083344165816;13123.934380328037;13519.594412167651;12642.24146551173;12954.352282385655;12973.870261297643;13359.53241636538;13813.585592432242;11861.229020113666;11966.341851198267;12088.879111208775;12110.75778484443;12131.939340303243;12455.813162802746;13008.739825203633;13050.086493945333;13078.346082696018;13320.267385293902;10352.482375881025;10834.789622260905;10878.447905531622;10884.945575272073;11051.502682379152;10745.086667633339;10752.301100428447;10926.78146437051;11129.387883666475;11175.664730058112 03:04:55 INFO - PROCESS | 32233 | __end_tp_report 03:04:55 INFO - PROCESS | 32233 | __start_cc_report 03:04:55 INFO - PROCESS | 32233 | _x_x_mozilla_cycle_collect,863 03:04:55 INFO - PROCESS | 32233 | __end_cc_report 03:04:55 INFO - PROCESS | 32233 | __startTimestamp1460973895790__endTimestamp 03:04:55 INFO - PROCESS | 32233 | 03:04:55 INFO - PROCESS | 32233 | ------- Summary: start ------- 03:04:55 INFO - PROCESS | 32233 | Number of tests: 6 03:04:55 INFO - PROCESS | 32233 | 03:04:55 INFO - PROCESS | 32233 | [#0] dojo.html Cycles:165 Average:5250.67 Median:5496.04 stddev:602.03 (11.0%) stddev-sans-first:577.66 03:04:55 INFO - PROCESS | 32233 | Values: 3010.9 3029.4 3067.7 3069.6 3098.3 5169.2 5198.2 5204.5 5238.8 5308.6 5265.3 5318.9 5332.4 5369.2 5379.7 4802.0 4821.8 4839.8 4843.8 5005.2 4943.5 4944.2 4962.0 5015.8 5041.7 4785.1 4810.6 4828.7 4880.6 4887.2 4822.9 4827.5 4837.0 4837.2 4882.3 4715.8 4761.1 4788.3 4796.2 4832.8 5193.6 5206.0 5207.7 5245.0 5261.3 5583.6 5607.9 5610.6 5611.2 5614.4 5616.7 5632.8 5642.1 5683.1 5743.3 5290.9 5315.8 5316.3 5316.9 5343.4 5776.5 5777.8 5781.1 5781.8 5782.8 5394.4 5538.8 5542.1 5593.6 5632.1 5578.8 5579.6 5583.9 5587.6 5613.9 5580.0 5591.3 5591.4 5594.1 5595.3 5513.6 5593.7 5650.6 5658.8 5702.0 4177.9 4180.9 4181.9 4182.1 4218.3 3766.8 3810.6 3830.0 3846.9 3868.8 5296.6 5309.0 5317.4 5341.1 5357.7 5638.1 5671.9 5675.7 5676.9 5677.0 5239.5 5264.2 5273.6 5295.8 5347.8 4779.5 4783.7 4795.4 4806.2 4824.1 5847.9 5855.2 5855.2 5859.1 5878.1 5555.8 5632.2 5657.5 5666.4 5723.2 5856.7 5875.1 5876.7 5901.6 5929.4 5593.9 5594.2 5595.2 5595.3 5614.8 5570.6 5699.7 5706.2 5709.8 5734.8 5545.5 5551.2 5554.0 5559.4 5563.9 5478.6 5488.2 5522.4 5527.1 5531.8 5390.8 5443.7 5509.1 5523.8 5546.8 5601.9 5603.9 5612.6 5617.1 5619.3 5481.1 5492.0 5496.0 5505.9 5542.1 03:04:55 INFO - PROCESS | 32233 | 03:04:55 INFO - PROCESS | 32233 | [#1] ext.html Cycles:180 Average:50328.06 Median:34348.31 stddev:90684.80 (264.0%) stddev-sans-first:90862.35 03:04:55 INFO - PROCESS | 32233 | Values: 605.8 660.7 661.0 668.7 671.9 29210.9 36100.3 37318.8 37333.6 37417.8 39107.0 39675.4 39732.2 39746.0 39886.8 7673.5 8296.6 8505.3 8508.5 8528.6 7870.8 7995.8 7999.2 10059.1 10478.8 10110.7 10226.1 10226.1 10228.9 10232.2 7866.7 10032.9 10191.4 10211.9 10216.8 9940.3 10379.4 10386.1 10389.3 10395.1 35912.5 36784.3 37182.4 37227.3 37230.0 3349.2 3390.4 3650.3 3752.4 3928.9 28923.0 29303.9 29599.0 31465.4 32019.5 4207.9 4320.7 4328.5 4332.3 4356.3 286690.0 287186.0 287191.0 288154.6 288850.0 55802.2 56204.7 56347.0 56406.7 56517.7 60010.7 64033.7 65953.7 66120.0 66153.3 17211.2 17357.0 17418.8 17497.2 17498.3 13066.9 13191.6 13207.9 13220.6 13240.1 19165.3 19361.3 19375.1 19390.1 19404.9 6974.5 7062.5 7151.8 7213.6 7215.5 1030.9 1064.9 1076.8 1083.7 1267.7 31275.7 31579.0 31753.5 32009.5 32012.8 1110.8 1131.4 1147.9 1200.9 1214.3 16598.0 16931.7 17023.7 17039.7 17104.6 443825.0 443882.0 448330.0 449171.0 450125.0 55163.7 56140.4 56440.7 56451.0 56520.4 758.5 1222.5 1273.7 1338.9 1436.0 28179.0 29974.1 31662.7 31758.5 31847.8 44738.0 45049.1 45090.5 45205.5 45288.8 267880.0 269267.0 269954.0 270514.0 270953.0 25062.5 27194.3 27986.0 28040.4 28275.9 43781.3 43807.8 44751.8 44767.0 45339.5 37738.0 37887.8 37905.6 37985.4 38041.4 36173.0 37819.8 37867.6 38106.4 38333.0 38229.0 38921.8 39278.0 39607.8 39801.0 32880.8 33951.2 34226.8 34292.3 34404.3 26616.3 26624.3 26915.9 27214.3 27265.9 03:04:55 INFO - PROCESS | 32233 | 03:04:55 INFO - PROCESS | 32233 | [#2] jquery.html Cycles:180 Average:28411.75 Median:2054.64 stddev:79476.85 (3868.2%) stddev-sans-first:79671.95 03:04:55 INFO - PROCESS | 32233 | Values: 390.5 399.9 403.6 405.5 410.5 17386.8 17935.4 17967.9 17979.4 18722.4 17477.2 17527.1 17563.6 18270.4 18533.1 5581.9 5629.3 5665.0 5678.2 5742.7 5492.7 5527.2 5545.6 5565.5 5565.7 5363.4 5634.5 5656.7 5658.7 5659.5 5080.8 5642.5 5692.1 5723.9 5730.2 5381.5 5546.5 5588.2 5619.0 5628.5 13787.7 13866.6 13887.9 16865.5 20292.0 2260.1 2297.2 2338.9 2402.7 2406.7 10077.4 10157.0 10247.2 10247.9 12114.9 1891.4 1926.3 1935.6 2053.5 2055.7 77843.6 78441.6 82321.0 82700.0 83565.6 10489.7 10579.9 10787.2 10884.5 11005.2 14916.7 14986.9 15005.1 15005.8 15027.5 8053.0 8257.3 8269.3 8382.7 8388.0 8090.8 8098.5 8114.8 8210.5 8224.5 4552.2 4552.9 4585.6 4587.5 4660.7 1830.6 1843.7 1861.2 1866.3 1880.6 941.2 1035.3 1054.1 1084.6 1090.4 18632.0 19093.2 19380.5 19594.5 19825.4 992.9 1023.7 1029.3 1042.3 1054.7 10521.5 10588.8 10711.9 10751.0 10799.8 468200.0 472847.0 472941.0 479799.0 509931.0 91676.0 93717.5 98601.5 98740.0 99966.5 1087.4 1108.3 1114.8 1121.9 1125.5 16307.3 16783.7 16807.5 16940.9 17000.5 29863.1 38568.6 40144.8 40409.0 40742.6 55198.9 55996.4 56801.4 57147.0 57567.7 8487.3 8800.3 8882.9 8988.7 9021.5 10925.5 12619.2 13347.8 13446.1 13502.3 10765.1 11345.9 11610.8 11712.7 12141.8 11101.7 11337.4 11373.5 11581.2 11645.1 11484.2 11508.3 12154.9 12261.4 12404.7 8466.0 8782.6 8886.8 8951.1 8971.6 9140.0 11870.0 11890.2 12010.6 12235.4 03:04:55 INFO - PROCESS | 32233 | 03:04:55 INFO - PROCESS | 32233 | [#3] mootools.html Cycles:180 Average:5531.76 Median:5048.47 stddev:3062.37 (60.7%) stddev-sans-first:3054.88 03:04:55 INFO - PROCESS | 32233 | Values: 1355.4 1459.9 1528.0 1641.5 1771.0 7912.4 8248.5 8265.3 8265.4 8266.1 8062.5 8179.6 8222.4 8226.6 8229.1 2024.3 2246.5 2328.3 2328.5 2355.3 2348.6 2360.2 2372.0 2372.2 2374.5 2306.6 2347.9 2350.4 2351.0 2356.6 2010.6 2243.1 2325.8 2325.9 2329.0 2255.7 2259.7 2265.8 2268.4 2283.5 8266.5 8290.5 8292.2 8372.4 8379.7 4887.0 5047.5 5049.4 5063.1 5081.2 3273.4 3350.7 3393.2 3428.9 3431.1 1136.8 1161.7 1169.7 1179.7 1190.6 11433.1 11473.7 11474.9 11504.1 11516.4 4405.6 4498.7 4666.5 4718.8 4720.0 9771.3 9780.8 9798.4 9799.1 9803.8 4681.6 5188.7 5193.2 5219.9 5238.1 4559.5 4657.0 4662.7 4667.3 4679.7 3869.1 3869.9 3962.5 3981.3 3992.9 1225.4 1227.5 1243.2 1259.6 1271.3 957.8 965.4 972.3 977.9 984.8 5621.1 5631.7 5668.5 5708.8 5730.3 467.9 481.2 484.4 485.1 999.3 4009.9 4057.0 4059.1 4078.6 4109.3 9993.5 10332.9 10356.2 10364.2 10413.2 10190.5 10198.5 10199.1 10207.1 10254.1 7358.7 7585.3 7723.6 7745.7 7818.5 5864.5 5913.3 6019.3 6027.0 6049.4 9161.7 9252.5 9331.7 9530.7 9555.6 9068.8 9447.2 9568.1 9575.1 9581.2 6871.8 7146.9 7356.6 7378.4 7579.8 8141.3 8153.6 8213.5 8231.6 8258.3 7119.1 7243.0 7283.9 7339.9 7477.3 7318.3 7374.6 7383.4 7400.6 7408.2 6522.3 6623.2 6625.7 6627.0 6627.2 4870.3 4907.7 4954.2 4971.0 5000.3 5071.3 5111.6 5120.3 5123.5 5259.0 03:04:55 INFO - PROCESS | 32233 | 03:04:55 INFO - PROCESS | 32233 | [#4] prototype.html Cycles:180 Average:5020.35 Median:5690.93 stddev:1502.25 (26.4%) stddev-sans-first:1464.71 03:04:55 INFO - PROCESS | 32233 | Values: 334.3 337.7 340.9 346.4 347.1 5620.3 5638.7 5689.4 5707.9 5750.5 5654.6 5660.6 5682.8 5692.5 5701.8 4197.3 4221.2 4374.7 4380.1 4395.1 4386.0 4408.9 4414.5 4416.4 4430.9 4194.5 4399.8 4407.8 4411.6 4412.6 4268.3 4292.7 4401.6 4404.5 4408.8 3868.6 3875.3 3876.1 3894.6 3899.1 5248.2 5389.6 5392.3 5415.8 5417.0 5016.2 5028.4 5030.4 5045.1 5065.9 5875.9 5899.4 5902.3 5905.5 5907.2 3973.3 4237.3 4258.6 4269.3 4294.9 6192.4 6193.4 6206.3 6230.1 6231.4 4289.6 4313.4 4314.2 4315.4 4317.5 4065.3 4374.6 4379.9 4385.8 4396.5 4874.2 4893.8 4899.4 4904.2 4912.2 5961.1 5975.7 5977.1 5981.6 6009.0 1465.3 1489.4 1515.4 1516.2 1521.6 946.3 994.8 996.1 1014.4 1022.8 5636.7 5654.1 5659.5 5667.4 5693.9 5999.5 6015.5 6030.5 6050.0 6061.4 5531.6 5649.6 5814.8 5827.1 5838.5 3298.6 3310.3 3316.5 3316.7 3322.3 6195.9 6416.5 6419.0 6430.9 6473.6 6306.6 6325.5 6326.0 6332.8 6348.8 6280.7 6404.7 6449.2 6470.4 6481.4 6190.8 6206.0 6209.5 6225.6 6243.4 6118.2 6140.4 6153.2 6168.9 6187.2 6330.5 6444.4 6490.9 6502.2 6510.2 4318.5 4319.0 4338.3 4347.5 4357.0 6053.7 6229.5 6239.1 6246.9 6253.8 5934.1 5952.5 6002.0 6042.6 6057.6 5950.3 5966.5 5994.7 6015.6 6035.6 5509.6 5906.7 5920.4 5935.7 5948.1 6018.2 6023.2 6038.5 6061.2 6064.8 5661.3 5879.9 5899.7 5926.1 5941.4 03:04:55 INFO - PROCESS | 32233 | 03:04:55 INFO - PROCESS | 32233 | [#5] yui.html Cycles:180 Average:14777.57 Median:23641.24 stddev:17054.24 (72.1%) stddev-sans-first:17069.93 03:04:55 INFO - PROCESS | 32233 | Values: 833.4 857.7 860.3 866.2 873.3 15663.6 16190.7 16191.6 16197.8 16225.0 14824.2 14976.2 15077.9 15095.9 15155.2 681.2 795.2 819.3 828.3 839.3 812.8 817.5 818.3 818.5 821.8 849.7 849.8 850.7 852.2 854.7 703.4 836.1 847.9 851.6 854.1 620.9 621.2 621.2 623.0 624.2 13203.3 13213.5 13227.0 13236.7 13279.7 13482.4 13829.0 13882.5 13901.9 13968.7 11639.6 11790.6 11877.3 11911.3 12025.9 3827.3 3859.2 3868.2 3984.4 3988.1 54313.2 55538.4 55812.4 55829.7 55914.4 10754.3 10800.9 10822.1 10838.8 10848.1 18952.5 18962.0 18965.5 18965.9 19000.2 7989.6 8140.8 8323.4 8384.1 8467.2 4370.7 4433.8 4540.2 4563.6 4655.7 3299.8 3450.7 3457.9 3460.5 3462.5 654.5 662.3 682.7 691.3 712.1 621.5 681.3 713.4 716.3 775.3 8214.6 9094.4 9419.3 9610.2 9659.1 699.5 733.8 755.8 770.7 786.8 4572.1 4600.8 4619.4 4769.7 4780.7 63233.0 64379.7 65026.0 65079.3 65101.0 56858.0 56894.0 57143.7 58274.4 58274.4 41592.8 41781.6 48251.8 48481.5 49292.5 8617.4 8848.7 8953.0 8984.7 9237.4 29880.9 30774.8 31279.8 31939.5 32722.3 40743.0 41982.0 42748.0 42911.8 43862.6 11866.8 12085.4 12177.2 12309.6 12766.2 12680.5 12925.7 13095.1 13123.9 13519.6 12642.2 12954.4 12973.9 13359.5 13813.6 11861.2 11966.3 12088.9 12110.8 12131.9 12455.8 13008.7 13050.1 13078.3 13320.3 10352.5 10834.8 10878.4 10884.9 11051.5 10745.1 10752.3 10926.8 11129.4 11175.7 03:04:55 INFO - PROCESS | 32233 | -------- Summary: end -------- 03:04:55 INFO - PROCESS | 32233 | 03:04:56 INFO - TEST-INFO | 32233: exit 0 03:04:56 INFO - TEST-OK | dromaeo_css | took 1113066ms 03:04:56 INFO - TEST-START | kraken 03:04:56 INFO - operating with platform_type : linux_ 03:04:56 INFO - Initialising browser for kraken test... 03:04:56 INFO - TEST-INFO | started process 32408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwYw5jD/profile http://localhost:59892/getInfo.html) 03:05:01 INFO - PROCESS | 32408 | __metrics Screen width/height:1600/1200 03:05:01 INFO - PROCESS | 32408 | colorDepth:24 03:05:01 INFO - PROCESS | 32408 | Browser inner width/height: 1024/697 03:05:01 INFO - PROCESS | 32408 | __metrics 03:05:02 ERROR - PROCESS | 32408 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:05:03 INFO - TEST-INFO | 32408: exit 0 03:05:03 INFO - Browser initialized. 03:05:03 INFO - Running cycle 1/1 for kraken test... 03:05:03 INFO - TEST-INFO | started process 32491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwYw5jD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:15 INFO - PROCESS | 32491 | RSS: Main: 152829952 03:05:15 INFO - PROCESS | 32491 | 03:05:17 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59892/tests/kraken/driver.html?testName=audio-beat-detection) 03:05:18 INFO - PROCESS | 32491 | RSS: Main: 207982592 03:05:18 INFO - PROCESS | 32491 | 03:05:21 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59892/tests/kraken/driver.html?testName=audio-dft) 03:05:21 INFO - PROCESS | 32491 | RSS: Main: 193765376 03:05:21 INFO - PROCESS | 32491 | 03:05:24 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59892/tests/kraken/driver.html?testName=audio-fft) 03:05:25 INFO - PROCESS | 32491 | RSS: Main: 263872512 03:05:25 INFO - PROCESS | 32491 | 03:05:27 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59892/tests/kraken/driver.html?testName=audio-oscillator) 03:05:28 INFO - PROCESS | 32491 | RSS: Main: 172908544 03:05:28 INFO - PROCESS | 32491 | 03:05:30 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59892/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:05:30 INFO - PROCESS | 32491 | RSS: Main: 176902144 03:05:30 INFO - PROCESS | 32491 | 03:05:33 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59892/tests/kraken/driver.html?testName=imaging-darkroom) 03:05:34 INFO - PROCESS | 32491 | RSS: Main: 213655552 03:05:34 INFO - PROCESS | 32491 | 03:05:37 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59892/tests/kraken/driver.html?testName=imaging-desaturate) 03:05:38 INFO - PROCESS | 32491 | RSS: Main: 214081536 03:05:38 INFO - PROCESS | 32491 | 03:05:41 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59892/tests/kraken/driver.html?testName=json-parse-financial) 03:05:41 INFO - PROCESS | 32491 | RSS: Main: 214384640 03:05:41 INFO - PROCESS | 32491 | 03:05:43 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59892/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:05:43 INFO - PROCESS | 32491 | RSS: Main: 199704576 03:05:43 INFO - PROCESS | 32491 | 03:05:45 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59892/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:05:46 INFO - PROCESS | 32491 | RSS: Main: 201203712 03:05:46 INFO - PROCESS | 32491 | 03:05:48 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59892/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:05:48 INFO - PROCESS | 32491 | RSS: Main: 216879104 03:05:48 INFO - PROCESS | 32491 | 03:05:51 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:05:51 INFO - PROCESS | 32491 | RSS: Main: 223870976 03:05:51 INFO - PROCESS | 32491 | 03:05:54 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:05:55 INFO - PROCESS | 32491 | RSS: Main: 219201536 03:05:55 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | Cycle 1(1): loaded http://localhost:59892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59892/tests/kraken/driver.html?testName=ai-astar) 03:05:57 INFO - PROCESS | 32491 | RSS: Main: 282804224 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | __start_tp_report 03:05:57 INFO - PROCESS | 32491 | _x_x_mozilla_page_load 03:05:57 INFO - PROCESS | 32491 | _x_x_mozilla_page_load_details 03:05:57 INFO - PROCESS | 32491 | |i|pagename|runs| 03:05:57 INFO - PROCESS | 32491 | |0;ai-astar;110;110;105;109;110;110;98;110;110;110 03:05:57 INFO - PROCESS | 32491 | |1;audio-beat-detection;151;128;154;191;127;155;160;135;183;128 03:05:57 INFO - PROCESS | 32491 | |2;audio-dft;163;161;162;160;161;163;161;160;161;161 03:05:57 INFO - PROCESS | 32491 | |3;audio-fft;73;77;98;111;73;77;74;122;102;75 03:05:57 INFO - PROCESS | 32491 | |4;audio-oscillator;92;92;150;93;93;93;153;93;93;141 03:05:57 INFO - PROCESS | 32491 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;116;117;117 03:05:57 INFO - PROCESS | 32491 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;145 03:05:57 INFO - PROCESS | 32491 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 03:05:57 INFO - PROCESS | 32491 | |8;json-parse-financial;57;56;57;58;57;56;57;76;56;54 03:05:57 INFO - PROCESS | 32491 | |9;json-stringify-tinderbox;60;60;59;60;61;60;61;60;60;66 03:05:57 INFO - PROCESS | 32491 | |10;stanford-crypto-aes;78;75;75;75;76;76;77;77;77;77 03:05:57 INFO - PROCESS | 32491 | |11;stanford-crypto-ccm;133;128;126;130;122;124;123;123;156;124 03:05:57 INFO - PROCESS | 32491 | |12;stanford-crypto-pbkdf2;165;165;163;164;167;165;165;165;165;163 03:05:57 INFO - PROCESS | 32491 | |13;stanford-crypto-sha256-iterative;70;69;68;69;68;67;69;68;69;68 03:05:57 INFO - PROCESS | 32491 | __end_tp_report 03:05:57 INFO - PROCESS | 32491 | __start_cc_report 03:05:57 INFO - PROCESS | 32491 | _x_x_mozilla_cycle_collect,1614 03:05:57 INFO - PROCESS | 32491 | __end_cc_report 03:05:57 INFO - PROCESS | 32491 | __startTimestamp1460973957269__endTimestamp 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | ------- Summary: start ------- 03:05:57 INFO - PROCESS | 32491 | Number of tests: 14 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.91 (3.6%) stddev-sans-first:4.09 03:05:57 INFO - PROCESS | 32491 | Values: 110.0 110.0 105.0 109.0 110.0 110.0 98.0 110.0 110.0 110.0 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:154.50 stddev:22.66 (14.7%) stddev-sans-first:24.03 03:05:57 INFO - PROCESS | 32491 | Values: 151.0 128.0 154.0 191.0 127.0 155.0 160.0 135.0 183.0 128.0 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 03:05:57 INFO - PROCESS | 32491 | Values: 163.0 161.0 162.0 160.0 161.0 163.0 161.0 160.0 161.0 161.0 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#3] audio-fft Cycles:10 Average:88.20 Median:74.50 stddev:18.37 (24.7%) stddev-sans-first:18.64 03:05:57 INFO - PROCESS | 32491 | Values: 73.0 77.0 98.0 111.0 73.0 77.0 74.0 122.0 102.0 75.0 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:93.00 stddev:26.87 (28.9%) stddev-sans-first:27.76 03:05:57 INFO - PROCESS | 32491 | Values: 92.0 92.0 150.0 93.0 93.0 93.0 153.0 93.0 93.0 141.0 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:05:57 INFO - PROCESS | 32491 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:05:57 INFO - PROCESS | 32491 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:05:57 INFO - PROCESS | 32491 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:57.00 stddev:6.28 (11.0%) stddev-sans-first:6.64 03:05:57 INFO - PROCESS | 32491 | Values: 57.0 56.0 57.0 58.0 57.0 56.0 57.0 76.0 56.0 54.0 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.00 stddev:1.95 (3.2%) stddev-sans-first:2.05 03:05:57 INFO - PROCESS | 32491 | Values: 60.0 60.0 59.0 60.0 61.0 60.0 61.0 60.0 60.0 66.0 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:77.00 stddev:1.06 (1.4%) stddev-sans-first:0.93 03:05:57 INFO - PROCESS | 32491 | Values: 78.0 75.0 75.0 75.0 76.0 76.0 77.0 77.0 77.0 77.0 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:127.00 stddev:10.15 (8.0%) stddev-sans-first:10.65 03:05:57 INFO - PROCESS | 32491 | Values: 133.0 128.0 126.0 130.0 122.0 124.0 123.0 123.0 156.0 124.0 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 03:05:57 INFO - PROCESS | 32491 | Values: 165.0 165.0 163.0 164.0 167.0 165.0 165.0 165.0 165.0 163.0 03:05:57 INFO - PROCESS | 32491 | 03:05:57 INFO - PROCESS | 32491 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.71 03:05:57 INFO - PROCESS | 32491 | Values: 70.0 69.0 68.0 69.0 68.0 67.0 69.0 68.0 69.0 68.0 03:05:57 INFO - PROCESS | 32491 | -------- Summary: end -------- 03:05:57 INFO - PROCESS | 32491 | 03:05:58 INFO - TEST-INFO | 32491: exit 0 03:05:58 INFO - TEST-OK | kraken | took 61794ms 03:05:58 INFO - SUITE-END | took 1174s 03:05:58 INFO - Completed test suite (00:19:34) 03:05:58 INFO - javascript benchmark 03:05:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3010.924726881828, 3029.378977309649, 3067.6625571187164, 3069.554914537392, 3098.349346637205, 5169.198774190002, 5198.194279886614, 5204.479552044799, 5238.842834714955, 5308.601854860882, 5265.289185959894, 5318.946810531894, 5332.440093790145, 5369.19462080689, 5379.677219366831, 4801.951980480203, 4821.758912054401, 4839.830605928793, 4843.806247750086, 5005.224190250498, 4943.505649435064, 4944.2089265717495, 4962.0324036812835, 5015.799368025275, 5041.697498150104, 4785.090832741768, 4810.591099756525, 4828.686135401188, 4880.560749532524, 4887.193613053842, 4822.855314340575, 4827.51724827518, 4836.975815120937, 4837.201861692816, 4882.292067650206, 4715.7877895494785, 4761.142994261032, 4788.257820037899, 4796.232602783538, 4832.806687732486, 5193.610479214074, 5205.999999999962, 5207.6875387476875, 5245.0, 5261.289725886994, 5583.553315734732, 5607.887842243133, 5610.579206559524, 5611.2144299798065, 5614.438556144394, 5616.66300022, 5632.831015069554, 5642.069058605325, 5683.090705487143, 5743.310802703661, 5290.867728306785, 5315.787368505294, 5316.282301889273, 5316.867078323073, 5343.438938911398, 5776.480116789425, 5777.7977770777825, 5781.1328300754385, 5781.797637082682, 5782.797602083907, 5394.352677678704, 5538.833834984957, 5542.140968149863, 5593.580481463907, 5632.1270203117765, 5578.832635020955, 5579.553635709133, 5583.888322233533, 5587.636803607753, 5613.943860561424, 5580.0, 5591.30108736408, 5591.3569939456665, 5594.0769772987815, 5595.300587426572, 5513.61404701667, 5593.664380137205, 5650.63270887391, 5658.801941932095, 5702.0, 4177.895552611209, 4180.937285940713, 4181.874543763692, 4182.142660754538, 4218.282891908383, 3766.7551609145316, 3810.5617853946596, 3830.042489377656, 3846.8653597123966, 3868.845246190177, 5296.602754793329, 5309.044372012998, 5317.41508434072, 5341.0653135701095, 5357.7053262070185, 5638.126090455986, 5671.943280567141, 5675.744591493392, 5676.914846277309, 5676.971615141898, 5239.528442440199, 5264.15773476242, 5273.604479664041, 5295.788168473218, 5347.786088556492, 4779.522047795263, 4783.736894470838, 4795.424549054066, 4806.158922188603, 4824.059308434821, 5847.9415205848245, 5855.209546711225, 5855.238818953594, 5859.062549991981, 5878.059510478303, 5555.833325000256, 5632.183333416713, 5657.547396208293, 5666.405027472221, 5723.170140329546, 5856.677882716321, 5875.118732190205, 5876.735546900485, 5901.5868889177345, 5929.377415371324, 5593.944060559343, 5594.188842617717, 5595.244641973281, 5595.300587426572, 5614.803481878114, 5570.5543556516195, 5699.743511542073, 5706.229658995982, 5709.800156994485, 5734.770609175586, 5545.528630066489, 5551.167324901297, 5554.0, 5559.444055594408, 5563.916541251965, 5478.616496845182, 5488.231647569423, 5522.392536820867, 5527.115661494142, 5531.778728850801, 5390.784368625211, 5443.700596467233, 5509.146082357241, 5523.779048838162, 5546.750396232099, 5601.887962240814, 5603.915941260802, 5612.607117501899, 5617.101263797937, 5619.269494965628, 5481.095619222943, 5492.038893193595, 5496.038193316073, 5505.889882202254, 5542.057850165401], "value": 5209.363358790284, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.8243109498246, 660.7224965514483, 661.0414898397325, 668.7091115364815, 671.9092922455467, 29210.85394573027, 36100.277994440126, 37318.813405933, 37333.62666373339, 37417.81291093548, 39107.0, 39675.40486892699, 39732.20535589287, 39746.0, 39886.800565997204, 7673.539587624732, 8296.58517074147, 8505.319574434061, 8508.489490630582, 8528.616212270432, 7870.803229919241, 7995.760127196164, 7999.160088190714, 10059.144972677295, 10478.790424191511, 10110.69667909964, 10226.130778883766, 10226.130778883766, 10228.94885525575, 10232.181425485944, 7866.68533258669, 10032.949835250814, 10191.439470829102, 10211.948940255252, 10216.795664086676, 9940.25448091396, 10379.42913139777, 10386.065254127165, 10389.324693894872, 10395.064444200058, 35912.46131308033, 36784.26431471382, 37182.44226336607, 37227.25545489102, 37230.0, 3349.2464195555804, 3390.3897298486263, 3650.324689932371, 3752.43713442983, 3928.88213353597, 28923.0, 29303.85348073246, 29599.0, 31465.37069258625, 32019.51970720441, 4207.894802629929, 4320.740755554645, 4328.545502722201, 4332.263515202423, 4356.302991521373, 286690.0, 287186.0, 287191.0, 288154.5592272046, 288850.0, 55802.162967555516, 56204.71897640486, 56347.0, 56406.7179664099, 56517.71741141268, 60010.69994649999, 64033.679831600544, 65953.67023164949, 66120.0, 66153.33846661568, 17211.225494852762, 17357.045362505185, 17418.82581174172, 17497.212625431886, 17498.300067997137, 13066.869331306756, 13191.604251872459, 13207.867921320856, 13220.603381898558, 13240.139390939557, 19165.32921347774, 19361.322353717835, 19375.12811923467, 19390.127444265043, 19404.902975485315, 6974.546654467444, 7062.470314726416, 7151.779201183165, 7213.639318034182, 7215.458840586977, 1030.8711411073616, 1064.914806815453, 1076.7792602516465, 1083.6640641401034, 1267.6957530192872, 31275.70371332796, 31579.0, 31753.523697144563, 32009.51985720216, 32012.839935800173, 1110.8000559899135, 1131.4064896520154, 1147.9024282936043, 1200.9191727445195, 1214.2775048845922, 16598.0, 16931.661366772594, 17023.659526809643, 17039.744403833705, 17104.57238569046, 443825.0, 443882.0, 448330.0, 449171.0, 450125.0, 55163.724181379635, 56140.43859561352, 56440.717796410754, 56451.0, 56520.43479565152, 758.5069704691995, 1222.4560070768423, 1273.6943133647858, 1338.939747711336, 1435.9928200358931, 28179.0, 29974.100776976724, 31662.68337316597, 31758.523622145225, 31847.840760796047, 44738.0, 45049.0990180188, 45090.549094508635, 45205.547944520134, 45288.77355613201, 267880.0, 269267.0, 269954.0, 270514.0, 270953.0, 25062.498750024533, 27194.32014199661, 27986.0, 28040.439191215653, 28275.858620706764, 43781.34327985146, 43807.78096109499, 44751.776241119886, 44767.0, 45339.54660453485, 37738.0, 37887.81056094812, 37905.62094379131, 37985.4302185473, 38041.42937855879, 36173.0, 37819.81090094532, 37867.62132378641, 38106.42840357452, 38333.0, 38229.0, 38921.80539097286, 39278.0, 39607.80196099001, 39801.0, 32880.83559582187, 33951.15122121967, 34226.82886585551, 34292.314153717285, 34404.31191376209, 26616.334591635365, 26624.33439163959, 26915.86542067277, 27214.319642009108, 27265.86367068152], "value": 19304.322092316543, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.4631132193234, 399.85605182134424, 403.5601194697779, 405.4688358250694, 410.4561456070706, 17386.826131738693, 17935.372261970835, 17967.910160449213, 17979.37072202473, 18722.438326850217, 17477.213525391355, 17527.12364381782, 17563.5609109772, 18270.360537381162, 18533.07334633266, 5581.916271255935, 5629.324481062278, 5664.971675141639, 5678.233438485793, 5742.7415766290615, 5492.697901615409, 5527.198556209347, 5545.584081193906, 5565.499105080542, 5565.749541270632, 5363.356397232337, 5634.464725851038, 5656.717164141797, 5658.688772117532, 5659.547236221092, 5080.847574572768, 5642.492175704166, 5692.146178073281, 5723.942760572403, 5730.226419433386, 5381.515663590296, 5546.528545073674, 5588.245586845765, 5618.971905140448, 5628.465295796893, 13787.724245515134, 13866.584002479942, 13887.930560347235, 16865.494035178963, 20292.0, 2260.062074239189, 2297.184499502669, 2338.941526461835, 2402.735699073118, 2406.7111946566347, 10077.44574048427, 10157.0, 10247.180225581935, 10247.948760256226, 12114.909658130811, 1891.4136617648435, 1926.306529649325, 1935.5838494723562, 2053.5276886316083, 2055.743032120985, 77843.61078194629, 78441.60779196124, 82321.0, 82700.0, 83565.58217208875, 10489.688788901387, 10579.894201058045, 10787.190960677981, 10884.510197041152, 11005.229633925548, 14916.70166596662, 14986.925065374822, 15005.099694018394, 15005.774913376308, 15027.549173524812, 8053.0, 8257.339412846957, 8269.255766981001, 8382.664693412316, 8388.028813228886, 8090.797730056678, 8098.473599216032, 8114.7565573031725, 8210.507369557845, 8224.506529608243, 4552.1806074906835, 4552.908941821212, 4585.564371384713, 4587.495375508692, 4660.720356778536, 1830.6338732253603, 1843.7234414837612, 1861.2368928739152, 1866.3281218761235, 1880.5674694820268, 941.1670671455674, 1035.2701345551518, 1054.0513537815873, 1084.5607528950788, 1090.3893819461127, 18632.0, 19093.236270549023, 19380.515487112934, 19594.510137246398, 19825.405237842886, 992.8858181309098, 1023.6621914768109, 1029.2846471702244, 1042.338115296792, 1054.7152268887357, 10521.473926303808, 10588.788224235472, 10711.94644026775, 10751.0, 10799.78400431987, 468200.0, 472847.0, 472941.0, 479799.0, 509931.0, 91676.0, 93717.5314123425, 98601.50699246458, 98740.0, 99966.50016750015, 1087.429099722636, 1108.2685427617735, 1114.7547539541288, 1121.859767529059, 1125.5047778977223, 16307.266173022479, 16783.74824377611, 16807.495775126765, 16940.915295423936, 17000.48998530046, 29863.104106876828, 38568.61431385762, 40144.79927600343, 40409.0, 40742.59257407507, 55198.89602208014, 55996.44003560075, 56801.431985681265, 57147.0, 57567.7121614406, 8487.321014318963, 8800.295976321751, 8882.866756998521, 8988.741586172162, 9021.45871247701, 10925.453727313761, 12619.242845428937, 13347.799783003069, 13446.126001809851, 13502.324883755577, 10765.138788897026, 11345.943270283597, 11610.825837612274, 11712.70718232017, 12141.75716485683, 11101.722456938642, 11337.433128343386, 11373.488193031168, 11581.189316748083, 11645.126615503701, 11484.19610627248, 11508.251963622337, 12154.878451215374, 12261.448234829633, 12404.689882753004, 8465.95767021161, 8782.560871956504, 8886.800281961852, 8951.060138685345, 8971.596278167628, 9140.0, 11870.0, 11890.227135236182, 12010.63968080959, 12235.388230588256], "value": 9069.274053260819, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.3833005982278, 1459.8976576863859, 1528.0449718925672, 1641.4911377472984, 1770.955726106848, 7912.406569507289, 8248.505089694616, 8265.338772898169, 8265.380096492772, 8266.090730019701, 8062.4759390639565, 8179.591020448984, 8222.383321250914, 8226.629801658924, 8229.135940726228, 2024.2712623455545, 2246.472079061419, 2328.3247858121167, 2328.522652856169, 2355.316958082154, 2348.5772560939026, 2360.1503458754833, 2371.9644205336936, 2372.240882917467, 2374.53696529176, 2306.6078766609635, 2347.8943447544816, 2350.3888988862846, 2350.9529809403803, 2356.5522550715395, 2010.567727938493, 2243.0915479230857, 2325.7674232576605, 2325.9418514537188, 2328.9767102329097, 2255.672927425514, 2259.7401298850677, 2265.7734226577377, 2268.353519247023, 2283.4519715268384, 8266.504009759434, 8290.544020078893, 8292.17078292172, 8372.41393102483, 8379.664813407517, 4886.975565122151, 5047.545720885101, 5049.394072711261, 5063.11395505785, 5081.161608334621, 3273.394422031908, 3350.6984371406447, 3393.1856354474994, 3428.9142771430916, 3431.1079119428878, 1136.8294755786699, 1161.7211869151427, 1169.7192673758323, 1179.7050737315672, 1190.6249531397582, 11433.085353171726, 11473.655790326304, 11474.885251147465, 11504.079673626173, 11516.366599837005, 4405.60349568534, 4498.730076195438, 4666.533346665306, 4718.764061796896, 4720.032393359353, 9771.31600787938, 9780.804383912424, 9798.412095274307, 9799.11807937289, 9803.803923921481, 4681.602063824613, 5188.662736922088, 5193.246979187997, 5219.921701174486, 5238.057149713089, 4559.452865656076, 4657.022025374641, 4662.743549104764, 4667.346571479996, 4679.695819771704, 3869.090763670535, 3869.903252418712, 3962.5244970603712, 3981.343078392091, 3992.900177495586, 1225.3934302520308, 1227.4599176362372, 1243.1919252485775, 1259.6472987563498, 1271.2690203133236, 957.8228027814737, 965.3869792681697, 972.2805124208035, 977.9217662586976, 984.8178087053918, 5621.057037782699, 5631.746571404296, 5668.546516278688, 5708.771649134072, 5730.283714535683, 467.91109689159634, 481.22042291488015, 484.41627838454576, 485.0807719371771, 999.2855108597388, 4009.939850902239, 4056.9797151014645, 4059.106996460774, 4078.57174996627, 4109.301418758818, 9993.450360230258, 10332.948335258276, 10356.223283253787, 10364.222683298784, 10413.16694664425, 10190.490475476197, 10198.490075496344, 10199.0820826126, 10207.132393746615, 10254.077133058061, 7358.705651773977, 7585.317321441097, 7723.613819309012, 7745.728899488604, 7818.530888146729, 5864.504551339382, 5913.34953155144, 6019.277686677627, 6026.969865150646, 6049.425304596057, 9161.679341223025, 9252.49111298885, 9331.72004839856, 9530.666426675032, 9555.569999350186, 9068.818623627623, 9447.196988256075, 9568.09103135201, 9575.09036641518, 9581.185599223865, 6871.828204294733, 7146.928530714834, 7356.632168391452, 7378.409727221702, 7579.848403032019, 8141.267285944056, 8153.592320383838, 8213.54825484604, 8231.588420579066, 8258.298044666271, 7119.110111236096, 7243.0, 7283.8543229136185, 7339.853202935805, 7477.289657482531, 7318.34134927859, 7374.557526548424, 7383.409327253914, 7400.629968501661, 7408.222136675571, 6522.34776522344, 6623.172103487064, 6625.734970601315, 6626.966865165643, 6627.23786764509, 4870.2938073979785, 4907.656464047483, 4954.1825598775795, 4970.975145124251, 5000.349954505891, 5071.340725705634, 5111.642185047011, 5120.25756265332, 5123.513266239701, 5259.000789850069], "value": 4436.369917371696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.3163231192212, 337.67751797033833, 340.9198838273006, 346.39726875237096, 347.08369903454883, 5620.325560932689, 5638.661680299179, 5689.402612725661, 5707.885842283152, 5750.453706897838, 5654.632448890819, 5660.632058916168, 5682.772689092431, 5692.459216374448, 5701.8311246194535, 4197.349410841317, 4221.24017676818, 4374.693771436001, 4380.123975204971, 4395.099004704044, 4386.0, 4408.889777755549, 4414.492333381654, 4416.359627853975, 4430.933535996963, 4194.496660400756, 4399.824007039714, 4407.779611019452, 4411.558844115595, 4412.558744125594, 4268.338407546835, 4292.656587472995, 4401.581849724271, 4404.515503294635, 4408.779561021936, 3868.6324799144318, 3875.3218186817194, 3876.069743261597, 3894.591067937854, 3899.064224586079, 5248.186531087687, 5389.568834493231, 5392.325959255093, 5415.833666533379, 5417.022786682872, 5016.247562865599, 5028.371453568304, 5030.421501527335, 5045.117104506697, 5065.898682026375, 5875.941240587582, 5899.439553242435, 5902.2622172228475, 5905.527557795366, 5907.172995780594, 3973.304671682473, 4237.300845360512, 4258.5528519505315, 4269.338252570857, 4294.935575966332, 6192.420932662142, 6193.4425901669065, 6206.34833342497, 6230.127782110508, 6231.442139465134, 4289.592488713567, 4313.352997050468, 4314.245007123741, 4315.417418648505, 4317.525072242051, 4065.288574499451, 4374.606285434326, 4379.912401751947, 4385.802638881258, 4396.494403143615, 4874.171390863562, 4893.828715994923, 4899.412070551485, 4904.215325547895, 4912.214045752662, 5961.105834124916, 5975.731092100866, 5977.103434484775, 5981.581289309706, 6009.0, 1465.340596731475, 1489.4489039055402, 1515.4014164404998, 1516.150955464943, 1521.6424140327015, 946.3375637054089, 994.8408254679362, 996.0736515041082, 1014.4116412480744, 1022.8005538919839, 5636.718164091779, 5654.123610840326, 5659.490645841894, 5667.404922483162, 5693.9430605693415, 5999.460048595647, 6015.518758499309, 6030.487408570233, 6050.0, 6061.363556826558, 5531.557475401958, 5649.610233859651, 5814.767409303665, 5827.096799996008, 5838.5329173666005, 3298.5876765404323, 3310.304835984422, 3316.4527852904002, 3316.7346612271444, 3322.252493189013, 6195.938040619536, 6416.486681065597, 6419.0, 6430.935690643128, 6473.643949582818, 6306.590071645328, 6325.545124621271, 6325.96837015812, 6332.8416789579705, 6348.809535713936, 6280.717367718372, 6404.679766011681, 6449.226092868886, 6470.352964703586, 6481.384268494391, 6190.7523699051535, 6205.968970155121, 6209.516193522627, 6225.595336303126, 6243.37566243372, 6118.235220597426, 6140.3596453525415, 6153.2000839890525, 6168.938310616836, 6187.16473276102, 6330.49356051524, 6444.387783160592, 6490.935090649222, 6502.187226596676, 6510.21877374718, 4318.481782186158, 4318.956810431855, 4338.262495375857, 4347.500037495728, 4357.0, 6053.697315134314, 6229.501639868709, 6239.0953311770445, 6246.875062498633, 6253.78111766086, 5934.139549765174, 5952.494038006818, 6001.969990150022, 6042.637441753509, 6057.57596968208, 5950.256217972754, 5966.49284810796, 5994.700264986646, 6015.608985415934, 6035.577509574287, 5509.586780991522, 5906.734196961061, 5920.407959204045, 5935.673537955454, 5948.078047902582, 6018.21763170785, 6023.216981792339, 6038.486728628116, 6061.212042434456, 6064.818055458343, 5661.320641523043, 5879.882402352015, 5899.6725736708895, 5926.081457374114, 5941.405859414024], "value": 4536.363937660748, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.3791325462529, 857.6912311567836, 860.3418384935521, 866.1857853617599, 873.3100850328233, 15663.608409789747, 16190.676186476278, 16191.595210119724, 16197.83802161978, 16225.0, 14824.184669843155, 14976.17631030293, 15077.944543881933, 15095.92452037741, 15155.242237888117, 681.2063945503483, 795.2405452792569, 819.2544784246337, 828.3290534666924, 839.3411172229801, 812.7521106062678, 817.5094943034192, 818.3248819723722, 818.5048045932215, 821.7904434369258, 849.6898631999306, 849.796048948251, 850.7107583421636, 852.21170417364, 854.7393045121236, 703.4231929817552, 836.1471299274737, 847.9067302596709, 851.5784686580121, 854.1074577066948, 620.92548894133, 621.1521273461692, 621.2420846567181, 622.9719662615194, 624.1854380034054, 13203.2738199399, 13213.471461141542, 13227.0, 13236.669083272898, 13279.734405311936, 13482.393292301771, 13829.0, 13882.51411200603, 13901.930490347584, 13968.720625587534, 11639.59261425846, 11790.646280611509, 11877.287362758176, 11911.344876031815, 12025.93987030068, 3827.2536855313224, 3859.1895701902354, 3868.2456920900436, 3984.4222587724616, 3988.142549351874, 54313.185302220496, 55538.44461555373, 55812.44187558113, 55829.72085139589, 55914.44085559174, 10754.300970436896, 10800.945995269973, 10822.134229261641, 10838.78322433547, 10848.132149428027, 18952.526186845163, 18962.0, 18965.52586185329, 18965.90517047406, 19000.239990400507, 7989.568869844796, 8140.75577732669, 8323.375746819012, 8384.077751447336, 8467.153284671484, 4370.694051416434, 4433.844815431445, 4540.205464043779, 4563.566461186182, 4655.720656760537, 3299.7690161688934, 3450.741194410429, 3457.87897423594, 3460.498227756961, 3462.497937799005, 654.4633400611453, 662.3409707341131, 682.7166725808833, 691.2914262880487, 712.1311999360771, 621.5059028072693, 681.2948598200838, 713.4149997002409, 716.2729829223342, 775.317720406039, 8214.58927053645, 9094.408863423989, 9419.293552983554, 9610.183134433511, 9659.082387173208, 699.4928676709446, 733.7505248215632, 755.7732680195919, 770.6917233106802, 786.7679034684782, 4572.131295053996, 4600.838970636011, 4619.353290539327, 4769.689970151929, 4780.689255198401, 63233.0, 64379.67810161013, 65026.0, 65079.349206508276, 65101.0, 56858.0, 56894.0, 57143.71428142833, 58274.4172558269, 58274.41725582775, 41592.792036040235, 41781.58218417777, 48251.75874120607, 48481.5151848477, 49292.50707492879, 8617.439866408664, 8848.734537963872, 8953.0, 8984.685536006209, 9237.445753254557, 29880.85059574688, 30774.846125770124, 31279.84360078185, 31939.520907186874, 32722.34555308833, 40743.0, 41982.0, 42748.0, 42911.78544107259, 43862.56137438712, 11866.76266474683, 12085.39573021363, 12177.208481448677, 12309.56916507918, 12766.234025958473, 12680.492780288685, 12925.676858078246, 13095.083344165816, 13123.934380328037, 13519.594412167651, 12642.24146551173, 12954.352282385655, 12973.870261297643, 13359.53241636538, 13813.585592432242, 11861.229020113666, 11966.341851198267, 12088.879111208775, 12110.75778484443, 12131.939340303243, 12455.813162802746, 13008.739825203633, 13050.086493945333, 13078.346082696018, 13320.267385293902, 10352.482375881025, 10834.789622260905, 10878.447905531622, 10884.945575272073, 11051.502682379152, 10745.086667633339, 10752.301100428447, 10926.78146437051, 11129.387883666475, 11175.664730058112], "value": 6787.297752955517, "unit": "score"}], "name": "dromaeo_css", "value": 7067.2071261855135, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 105.0, 109.0, 110.0, 110.0, 98.0, 110.0, 110.0, 110.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 154.0, 191.0, 127.0, 155.0, 160.0, 135.0, 183.0, 128.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 160.0, 161.0, 163.0, 161.0, 160.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 98.0, 111.0, 73.0, 77.0, 74.0, 122.0, 102.0, 75.0], "value": 88.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 93.0, 93.0, 93.0, 153.0, 93.0, 93.0, 141.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 58.0, 57.0, 56.0, 57.0, 76.0, 56.0, 54.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 61.0, 60.0, 61.0, 60.0, 60.0, 66.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 75.0, 76.0, 76.0, 77.0, 77.0, 77.0, 77.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 128.0, 126.0, 130.0, 122.0, 124.0, 123.0, 123.0, 156.0, 124.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 163.0, 164.0, 167.0, 165.0, 165.0, 165.0, 165.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 69.0, 68.0, 67.0, 69.0, 68.0, 69.0, 68.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1532.4, "alertThreshold": 2.0}]} 03:05:58 INFO - Return code: 0 03:05:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:05:58 ERROR - # TBPL SUCCESS # 03:05:58 INFO - Running post-action listener: _resource_record_post_action 03:05:58 INFO - Running post-run listener: _resource_record_post_run 03:05:59 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 16384; Write bytes: 533155840; Read time: 36; Write time: 1117624 03:05:59 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 244154368; Read time: 0; Write time: 632640 03:05:59 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 16384; Write bytes: 289001472; Read time: 36; Write time: 484984 03:05:59 INFO - Running post-run listener: _upload_blobber_files 03:05:59 INFO - Blob upload gear active. 03:05:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:05:59 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 03:05:59 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:05:59 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:06:00 INFO - (blobuploader) - INFO - Open directory for files ... 03:06:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:06:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:06:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:00 INFO - (blobuploader) - INFO - Done attempting. 03:06:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:06:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:06:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:01 INFO - (blobuploader) - INFO - Done attempting. 03:06:01 INFO - (blobuploader) - INFO - Iteration through files over. 03:06:01 INFO - Return code: 0 03:06:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:06:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:06:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c14ddd8f228052407b13e8014d6cc4cbbde831be757ffbb9f3e104d8c71b19e62889f665c14c1b81cb2e0edeb75b0844bbeefd7dc7e4b700ee6cc4dc34806472", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0fad72353d0584a02d0aaa567a51c70c09debb4559837be2414b8352abd6c220eb4a7931a5941e8fa5e9c47eac8455c94d8f701dd062b207c8e22eaedd827a66"} 03:06:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:06:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:06:01 INFO - Contents: 03:06:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c14ddd8f228052407b13e8014d6cc4cbbde831be757ffbb9f3e104d8c71b19e62889f665c14c1b81cb2e0edeb75b0844bbeefd7dc7e4b700ee6cc4dc34806472", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0fad72353d0584a02d0aaa567a51c70c09debb4559837be2414b8352abd6c220eb4a7931a5941e8fa5e9c47eac8455c94d8f701dd062b207c8e22eaedd827a66"} 03:06:01 INFO - Running post-run listener: copy_logs_to_upload_dir 03:06:01 INFO - Copying logs to upload dir... 03:06:01 INFO - mkdir: /builds/slave/test/build/upload/logs 03:06:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.417771 ========= master_lag: 12.63 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-18 03:06:14.398777) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 03:06:14.402477) ========= 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=df17445c3590ff7897617a0e00000225-1460971753.797805-202910072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c14ddd8f228052407b13e8014d6cc4cbbde831be757ffbb9f3e104d8c71b19e62889f665c14c1b81cb2e0edeb75b0844bbeefd7dc7e4b700ee6cc4dc34806472", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0fad72353d0584a02d0aaa567a51c70c09debb4559837be2414b8352abd6c220eb4a7931a5941e8fa5e9c47eac8455c94d8f701dd062b207c8e22eaedd827a66"} build_url:https://queue.taskcluster.net/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/O73UugR4Qw6s6P8at89a0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c14ddd8f228052407b13e8014d6cc4cbbde831be757ffbb9f3e104d8c71b19e62889f665c14c1b81cb2e0edeb75b0844bbeefd7dc7e4b700ee6cc4dc34806472", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0fad72353d0584a02d0aaa567a51c70c09debb4559837be2414b8352abd6c220eb4a7931a5941e8fa5e9c47eac8455c94d8f701dd062b207c8e22eaedd827a66"}' ========= master_lag: 0.29 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 03:06:14.706274) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 03:06:14.706602) ========= 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=df17445c3590ff7897617a0e00000225-1460971753.797805-202910072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 03:06:14.730998) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 03:06:14.731289) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 03:06:15.367178) ========= ========= Total master_lag: 12.99 =========