builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1464058918.34 results: success (0) buildid: 20160523170350 builduid: 1c7caa8606bd45b590752adeac87ea70 revision: a2baee5a734efd4bb9646e5ad06d7552d6618bcb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:58.342853) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:58.343355) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:58.343712) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:58.367176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:58.367536) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 20:01:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-05-23 20:01:58 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101822 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:58.483212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:58.486632) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014493 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:58.539617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:58.540023) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a2baee5a734efd4bb9646e5ad06d7552d6618bcb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a2baee5a734efd4bb9646e5ad06d7552d6618bcb --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=4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 20:01:58,717 truncating revision to first 12 chars 2016-05-23 20:01:58,717 Setting DEBUG logging. 2016-05-23 20:01:58,717 attempt 1/10 2016-05-23 20:01:58,717 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a2baee5a734e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 20:01:58,982 unpacking tar archive at: mozilla-aurora-a2baee5a734e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562497 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:59.115852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:59.116219) ========= script_repo_revision: a2baee5a734efd4bb9646e5ad06d7552d6618bcb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:59.116670) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:59.116977) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 20:01:59.127435) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-23 20:01:59.127756) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:01:59 INFO - MultiFileLogger online at 20160523 20:01:59 in /builds/slave/test 20:01:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:01:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:01:59 INFO - {'append_to_log': False, 20:01:59 INFO - 'base_work_dir': '/builds/slave/test', 20:01:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:01:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:01:59 INFO - 'branch': 'Mozilla-Aurora', 20:01:59 INFO - 'buildbot_json_path': 'buildprops.json', 20:01:59 INFO - 'config_files': ('talos/linux_config.py',), 20:01:59 INFO - 'default_actions': ('clobber', 20:01:59 INFO - 'read-buildbot-config', 20:01:59 INFO - 'download-and-extract', 20:01:59 INFO - 'populate-webroot', 20:01:59 INFO - 'create-virtualenv', 20:01:59 INFO - 'install', 20:01:59 INFO - 'run-tests'), 20:01:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:01:59 INFO - 'download_minidump_stackwalk': True, 20:01:59 INFO - 'download_symbols': 'ondemand', 20:01:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:01:59 INFO - 'tooltool.py': '/tools/tooltool.py', 20:01:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:01:59 INFO - '/tools/misc-python/virtualenv.py')}, 20:01:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:01:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:01:59 INFO - 'installer_path': 'installer.exe', 20:01:59 INFO - 'log_level': 'info', 20:01:59 INFO - 'log_name': 'talos', 20:01:59 INFO - 'log_to_console': True, 20:01:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:01:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:01:59 INFO - 'opt_config_files': (), 20:01:59 INFO - 'pip_index': False, 20:01:59 INFO - 'sps_profile': False, 20:01:59 INFO - 'sps_profile_interval': 0, 20:01:59 INFO - 'suite': 'dromaeojs', 20:01:59 INFO - 'system_bits': '32', 20:01:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:01:59 INFO - 'title': 'talos-linux64-ix-030', 20:01:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:01:59 INFO - 'use_talos_json': True, 20:01:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:01:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:01:59 INFO - 'work_dir': 'build'} 20:01:59 INFO - ##### 20:01:59 INFO - ##### Running clobber step. 20:01:59 INFO - ##### 20:01:59 INFO - Running pre-action listener: _resource_record_pre_action 20:01:59 INFO - Running main action method: clobber 20:01:59 INFO - rmtree: /builds/slave/test/build 20:01:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:02:00 INFO - Running post-action listener: _resource_record_post_action 20:02:00 INFO - ##### 20:02:00 INFO - ##### Running read-buildbot-config step. 20:02:00 INFO - ##### 20:02:00 INFO - Running pre-action listener: _resource_record_pre_action 20:02:00 INFO - Running main action method: read_buildbot_config 20:02:00 INFO - Using buildbot properties: 20:02:00 INFO - { 20:02:00 INFO - "project": "", 20:02:00 INFO - "product": "firefox", 20:02:00 INFO - "script_repo_revision": "production", 20:02:00 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 20:02:00 INFO - "repository": "", 20:02:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 20:02:00 INFO - "buildid": "20160523170350", 20:02:00 INFO - "pgo_build": "True", 20:02:00 INFO - "basedir": "/builds/slave/test", 20:02:00 INFO - "buildnumber": 341, 20:02:00 INFO - "slavename": "talos-linux64-ix-030", 20:02:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:02:00 INFO - "platform": "ubuntu64_hw", 20:02:00 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:02:00 INFO - "branch": "mozilla-aurora", 20:02:00 INFO - "repo_path": "releases/mozilla-aurora", 20:02:00 INFO - "revision": "a2baee5a734efd4bb9646e5ad06d7552d6618bcb", 20:02:00 INFO - "stage_platform": "linux64-pgo", 20:02:00 INFO - "builduid": "1c7caa8606bd45b590752adeac87ea70", 20:02:00 INFO - "slavebuilddir": "test" 20:02:00 INFO - } 20:02:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 20:02:00 INFO - Running post-action listener: _resource_record_post_action 20:02:00 INFO - ##### 20:02:00 INFO - ##### Running download-and-extract step. 20:02:00 INFO - ##### 20:02:00 INFO - Running pre-action listener: _resource_record_pre_action 20:02:00 INFO - Running main action method: download_and_extract 20:02:00 INFO - mkdir: /builds/slave/test/build/tests 20:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:00 INFO - https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:02:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 20:02:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 20:02:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 20:02:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:02:01 INFO - Downloaded 1361 bytes. 20:02:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 20:02:01 INFO - Using the following test package requirements: 20:02:01 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 20:02:01 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:02:01 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:02:01 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:01 INFO - u'jsshell-linux-x86_64.zip'], 20:02:01 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:02:01 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 20:02:01 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:02:01 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:02:01 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:02:01 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:02:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:02:01 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:02:01 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')]} 20:02:01 INFO - https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:02:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:02:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:02:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:02:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:02:02 INFO - Downloaded 23813419 bytes. 20:02:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:02:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:02:03 INFO - Return code: 0 20:02:03 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:02:03 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')]} 20:02:03 INFO - https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:02:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:02:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:02:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:02:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:02:04 INFO - Downloaded 23813419 bytes. 20:02:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:02:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:02:05 INFO - Return code: 0 20:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:05 INFO - https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:02:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 20:02:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 20:02:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 20:02:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:02:06 INFO - Downloaded 10840145 bytes. 20:02:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:02:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:02:07 INFO - Return code: 0 20:02:07 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')]} 20:02:07 INFO - https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:02:08 INFO - Downloaded 62728879 bytes. 20:02:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:02:08 INFO - mkdir: /builds/slave/test/properties 20:02:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:02:08 INFO - Writing to file /builds/slave/test/properties/build_url 20:02:08 INFO - Contents: 20:02:08 INFO - build_url:https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:02:09 INFO - Running post-action listener: _resource_record_post_action 20:02:09 INFO - Running post-action listener: set_extra_try_arguments 20:02:09 INFO - ##### 20:02:09 INFO - ##### Running populate-webroot step. 20:02:09 INFO - ##### 20:02:09 INFO - Running pre-action listener: _resource_record_pre_action 20:02:09 INFO - Running main action method: populate_webroot 20:02:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:02:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:02:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:02:09 INFO - '--tppagecycles', 20:02:09 INFO - '7'], 20:02:09 INFO - 'tests': ['tsvgm']}}, 20:02:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:02:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:02:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:02:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:02:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:02:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:02:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:09 INFO - 'talos_options': ['--disable-e10s'], 20:02:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:02:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:02:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:09 INFO - 'talos_options': ['--disable-e10s'], 20:02:09 INFO - 'tests': ['damp', 'tps']}, 20:02:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:09 INFO - 'tests': ['damp', 'tps']}, 20:02:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:02:09 INFO - 'tests': ['dromaeo_dom']}, 20:02:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:02:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:02:09 INFO - 'tests': ['a11yr', 20:02:09 INFO - 'ts_paint', 20:02:09 INFO - 'tpaint', 20:02:09 INFO - 'sessionrestore', 20:02:09 INFO - 'sessionrestore_no_auto_restore', 20:02:09 INFO - 'tabpaint']}, 20:02:09 INFO - 'other-e10s': {'tests': ['a11yr', 20:02:09 INFO - 'ts_paint', 20:02:09 INFO - 'tpaint', 20:02:09 INFO - 'sessionrestore', 20:02:09 INFO - 'sessionrestore_no_auto_restore', 20:02:09 INFO - 'tabpaint']}, 20:02:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:02:09 INFO - 'ts_paint', 20:02:09 INFO - 'tpaint', 20:02:09 INFO - 'sessionrestore', 20:02:09 INFO - 'sessionrestore_no_auto_restore', 20:02:09 INFO - 'tabpaint']}, 20:02:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:02:09 INFO - 'ts_paint', 20:02:09 INFO - 'tpaint', 20:02:09 INFO - 'sessionrestore', 20:02:09 INFO - 'sessionrestore_no_auto_restore', 20:02:09 INFO - 'tabpaint']}, 20:02:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:02:09 INFO - 'tests': ['a11yr', 20:02:09 INFO - 'ts_paint', 20:02:09 INFO - 'tpaint', 20:02:09 INFO - 'sessionrestore', 20:02:09 INFO - 'sessionrestore_no_auto_restore', 20:02:09 INFO - 'tabpaint']}, 20:02:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:02:09 INFO - 'tests': ['a11yr', 20:02:09 INFO - 'ts_paint', 20:02:09 INFO - 'tpaint', 20:02:09 INFO - 'sessionrestore', 20:02:09 INFO - 'sessionrestore_no_auto_restore', 20:02:09 INFO - 'tabpaint']}, 20:02:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:02:09 INFO - 'tests': ['tsvgx', 20:02:09 INFO - 'tsvgr_opacity', 20:02:09 INFO - 'tart', 20:02:09 INFO - 'tscrollx', 20:02:09 INFO - 'cart']}, 20:02:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:02:09 INFO - 'tsvgr_opacity', 20:02:09 INFO - 'tart', 20:02:09 INFO - 'tscrollx', 20:02:09 INFO - 'cart']}, 20:02:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:09 INFO - 'talos_options': ['--disable-e10s'], 20:02:09 INFO - 'tests': ['tp5o']}, 20:02:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:09 INFO - 'tests': ['tp5o']}, 20:02:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:09 INFO - 'talos_options': ['--disable-e10s', 20:02:09 INFO - '--xperf_path', 20:02:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:02:09 INFO - 'tests': ['tp5n']}, 20:02:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:09 INFO - 'talos_options': ['--xperf_path', 20:02:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:02:09 INFO - 'tests': ['tp5n']}}, 20:02:09 INFO - 'talos.zip': {'path': '', 20:02:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:02:09 INFO - Running post-action listener: _resource_record_post_action 20:02:09 INFO - ##### 20:02:09 INFO - ##### Running create-virtualenv step. 20:02:09 INFO - ##### 20:02:09 INFO - Running pre-action listener: _resource_record_pre_action 20:02:09 INFO - Running main action method: create_virtualenv 20:02:09 INFO - Creating virtualenv /builds/slave/test/build/venv 20:02:09 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 20:02:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:02:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:02:09 INFO - Using real prefix '/usr' 20:02:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:02:10 INFO - Installing distribute.............................................................................................................................................................................................done. 20:02:12 INFO - Installing pip.................done. 20:02:12 INFO - Return code: 0 20:02:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:02:12 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')]} 20:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:12 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')]} 20:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:12 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 0x7fd5183e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', '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 20:02:12 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 20:02:12 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 20:02:12 INFO - Using env: {'DISPLAY': ':0', 20:02:12 INFO - 'HOME': '/home/cltbld', 20:02:12 INFO - 'LANG': 'en_US.UTF-8', 20:02:12 INFO - 'LANGUAGE': 'en_US:en', 20:02:12 INFO - 'LOGNAME': 'cltbld', 20:02:12 INFO - 'MAIL': '/var/mail/cltbld', 20:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:12 INFO - 'MOZ_NO_REMOTE': '1', 20:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:12 INFO - 'NO_EM_RESTART': '1', 20:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:12 INFO - 'PWD': '/builds/slave/test', 20:02:12 INFO - 'SHELL': '/bin/bash', 20:02:12 INFO - 'SHLVL': '1', 20:02:12 INFO - 'TERM': 'linux', 20:02:12 INFO - 'TMOUT': '86400', 20:02:12 INFO - 'USER': 'cltbld', 20:02:12 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', 20:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:12 INFO - '_': '/tools/buildbot/bin/python'} 20:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:12 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 20:02:12 INFO - Cleaning up... 20:02:12 INFO - Return code: 0 20:02:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:02:12 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')]} 20:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:12 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')]} 20:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:12 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 0x7fd5183e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', '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 20:02:12 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 20:02:12 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 20:02:12 INFO - Using env: {'DISPLAY': ':0', 20:02:12 INFO - 'HOME': '/home/cltbld', 20:02:12 INFO - 'LANG': 'en_US.UTF-8', 20:02:12 INFO - 'LANGUAGE': 'en_US:en', 20:02:12 INFO - 'LOGNAME': 'cltbld', 20:02:12 INFO - 'MAIL': '/var/mail/cltbld', 20:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:12 INFO - 'MOZ_NO_REMOTE': '1', 20:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:12 INFO - 'NO_EM_RESTART': '1', 20:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:12 INFO - 'PWD': '/builds/slave/test', 20:02:12 INFO - 'SHELL': '/bin/bash', 20:02:12 INFO - 'SHLVL': '1', 20:02:12 INFO - 'TERM': 'linux', 20:02:12 INFO - 'TMOUT': '86400', 20:02:12 INFO - 'USER': 'cltbld', 20:02:12 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', 20:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:12 INFO - '_': '/tools/buildbot/bin/python'} 20:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:12 INFO - Downloading/unpacking psutil>=0.7.1 20:02:12 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 20:02:12 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 20:02:12 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 20:02:12 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 20:02:12 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 20:02:12 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 20:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:02:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:02:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:02:14 INFO - Installing collected packages: psutil 20:02:14 INFO - Running setup.py install for psutil 20:02:14 INFO - building 'psutil._psutil_linux' extension 20:02:14 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 20:02:14 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 20:02:14 INFO - building 'psutil._psutil_posix' extension 20:02:14 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 20:02:15 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 20:02:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:02:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:02:15 INFO - Successfully installed psutil 20:02:15 INFO - Cleaning up... 20:02:15 INFO - Return code: 0 20:02:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:02: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')]} 20:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02: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')]} 20:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd5183e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', '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 20:02:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:02:15 INFO - Using env: {'DISPLAY': ':0', 20:02:15 INFO - 'HOME': '/home/cltbld', 20:02:15 INFO - 'LANG': 'en_US.UTF-8', 20:02:15 INFO - 'LANGUAGE': 'en_US:en', 20:02:15 INFO - 'LOGNAME': 'cltbld', 20:02:15 INFO - 'MAIL': '/var/mail/cltbld', 20:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:15 INFO - 'MOZ_NO_REMOTE': '1', 20:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:15 INFO - 'NO_EM_RESTART': '1', 20:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:15 INFO - 'PWD': '/builds/slave/test', 20:02:15 INFO - 'SHELL': '/bin/bash', 20:02:15 INFO - 'SHLVL': '1', 20:02:15 INFO - 'TERM': 'linux', 20:02:15 INFO - 'TMOUT': '86400', 20:02:15 INFO - 'USER': 'cltbld', 20:02:15 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', 20:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:15 INFO - '_': '/tools/buildbot/bin/python'} 20:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:02:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:02:17 INFO - Installing collected packages: mozsystemmonitor 20:02:17 INFO - Running setup.py install for mozsystemmonitor 20:02:17 INFO - Successfully installed mozsystemmonitor 20:02:17 INFO - Cleaning up... 20:02:17 INFO - Return code: 0 20:02:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:02:17 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')]} 20:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:17 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')]} 20:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:17 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 0x7fd5183e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', '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 20:02:17 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 20:02:17 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 20:02:17 INFO - Using env: {'DISPLAY': ':0', 20:02:17 INFO - 'HOME': '/home/cltbld', 20:02:17 INFO - 'LANG': 'en_US.UTF-8', 20:02:17 INFO - 'LANGUAGE': 'en_US:en', 20:02:17 INFO - 'LOGNAME': 'cltbld', 20:02:17 INFO - 'MAIL': '/var/mail/cltbld', 20:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:17 INFO - 'MOZ_NO_REMOTE': '1', 20:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:17 INFO - 'NO_EM_RESTART': '1', 20:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:17 INFO - 'PWD': '/builds/slave/test', 20:02:17 INFO - 'SHELL': '/bin/bash', 20:02:17 INFO - 'SHLVL': '1', 20:02:17 INFO - 'TERM': 'linux', 20:02:17 INFO - 'TMOUT': '86400', 20:02:17 INFO - 'USER': 'cltbld', 20:02:17 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', 20:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:17 INFO - '_': '/tools/buildbot/bin/python'} 20:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:17 INFO - Downloading/unpacking blobuploader==1.2.4 20:02:17 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 20:02:17 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 20:02:17 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 20:02:17 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 20:02:17 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 20:02:17 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 20:02:19 INFO - Downloading blobuploader-1.2.4.tar.gz 20:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:02:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:02:19 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 20:02:19 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 20:02:19 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 20:02:19 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 20:02:19 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 20:02:19 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 20:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:02:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:02:20 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 20:02:20 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 20:02:20 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 20:02:20 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 20:02:20 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 20:02:20 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 20:02:20 INFO - Downloading docopt-0.6.1.tar.gz 20:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:02:20 INFO - Installing collected packages: blobuploader, requests, docopt 20:02:20 INFO - Running setup.py install for blobuploader 20:02:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:02:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:02:20 INFO - Running setup.py install for requests 20:02:20 INFO - Running setup.py install for docopt 20:02:20 INFO - Successfully installed blobuploader requests docopt 20:02:20 INFO - Cleaning up... 20:02:21 INFO - Return code: 0 20:02:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:21 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 0x7fd5183e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', '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 20:02:21 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 20:02:21 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 20:02:21 INFO - Using env: {'DISPLAY': ':0', 20:02:21 INFO - 'HOME': '/home/cltbld', 20:02:21 INFO - 'LANG': 'en_US.UTF-8', 20:02:21 INFO - 'LANGUAGE': 'en_US:en', 20:02:21 INFO - 'LOGNAME': 'cltbld', 20:02:21 INFO - 'MAIL': '/var/mail/cltbld', 20:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:21 INFO - 'MOZ_NO_REMOTE': '1', 20:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:21 INFO - 'NO_EM_RESTART': '1', 20:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:21 INFO - 'PWD': '/builds/slave/test', 20:02:21 INFO - 'SHELL': '/bin/bash', 20:02:21 INFO - 'SHLVL': '1', 20:02:21 INFO - 'TERM': 'linux', 20:02:21 INFO - 'TMOUT': '86400', 20:02:21 INFO - 'USER': 'cltbld', 20:02:21 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', 20:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:21 INFO - '_': '/tools/buildbot/bin/python'} 20:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:02:21 INFO - Running setup.py (path:/tmp/pip-Gg53cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:02:21 INFO - Running setup.py (path:/tmp/pip-hboZbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:02:21 INFO - Running setup.py (path:/tmp/pip-tR482o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:02:21 INFO - Running setup.py (path:/tmp/pip-c7r5uB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:02:21 INFO - Running setup.py (path:/tmp/pip-qX0fMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:02:21 INFO - Running setup.py (path:/tmp/pip-QEEwj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:02:21 INFO - Running setup.py (path:/tmp/pip-uJSXls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:02:21 INFO - Running setup.py (path:/tmp/pip-QSOhdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:02:21 INFO - Running setup.py (path:/tmp/pip-ilORwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:02:21 INFO - Running setup.py (path:/tmp/pip-EZGuu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:02:21 INFO - Running setup.py (path:/tmp/pip-KV_6Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:02:22 INFO - Running setup.py (path:/tmp/pip-fQM4_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:02:22 INFO - Running setup.py (path:/tmp/pip-QNCSv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:02:22 INFO - Running setup.py (path:/tmp/pip-KiKMdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:22 INFO - Running setup.py (path:/tmp/pip-7zZqKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:02:22 INFO - Running setup.py (path:/tmp/pip-u1TSV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:02:22 INFO - Running setup.py (path:/tmp/pip-ZxTVf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:02:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:02:22 INFO - Running setup.py install for manifestparser 20:02:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:02:22 INFO - Running setup.py install for mozcrash 20:02:22 INFO - Running setup.py install for mozdebug 20:02:22 INFO - Running setup.py install for mozdevice 20:02:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:02:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:02:22 INFO - Running setup.py install for mozfile 20:02:22 INFO - Running setup.py install for mozhttpd 20:02:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:02:23 INFO - Running setup.py install for mozinfo 20:02:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:02:23 INFO - Running setup.py install for mozInstall 20:02:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:02:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:02:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:02:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:02:23 INFO - Running setup.py install for mozleak 20:02:23 INFO - Running setup.py install for mozlog 20:02:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:02:23 INFO - Running setup.py install for moznetwork 20:02:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:02:23 INFO - Running setup.py install for mozprocess 20:02:23 INFO - Running setup.py install for mozprofile 20:02:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:02:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:02:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:02:23 INFO - Running setup.py install for mozrunner 20:02:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:02:23 INFO - Running setup.py install for mozscreenshot 20:02:23 INFO - Running setup.py install for moztest 20:02:24 INFO - Running setup.py install for mozversion 20:02:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:02:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:02:24 INFO - Cleaning up... 20:02:24 INFO - Return code: 0 20:02:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:24 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 0x7fd5183e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', '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 20:02:24 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 20:02:24 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 20:02:24 INFO - Using env: {'DISPLAY': ':0', 20:02:24 INFO - 'HOME': '/home/cltbld', 20:02:24 INFO - 'LANG': 'en_US.UTF-8', 20:02:24 INFO - 'LANGUAGE': 'en_US:en', 20:02:24 INFO - 'LOGNAME': 'cltbld', 20:02:24 INFO - 'MAIL': '/var/mail/cltbld', 20:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:24 INFO - 'MOZ_NO_REMOTE': '1', 20:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:24 INFO - 'NO_EM_RESTART': '1', 20:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:24 INFO - 'PWD': '/builds/slave/test', 20:02:24 INFO - 'SHELL': '/bin/bash', 20:02:24 INFO - 'SHLVL': '1', 20:02:24 INFO - 'TERM': 'linux', 20:02:24 INFO - 'TMOUT': '86400', 20:02:24 INFO - 'USER': 'cltbld', 20:02:24 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', 20:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:24 INFO - '_': '/tools/buildbot/bin/python'} 20:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:02:24 INFO - Running setup.py (path:/tmp/pip-bwUtZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:02:24 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)) 20:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:02:24 INFO - Running setup.py (path:/tmp/pip-nJu64y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:02:24 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)) 20:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:02:24 INFO - Running setup.py (path:/tmp/pip-CMiik1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:02:24 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)) 20:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:02:24 INFO - Running setup.py (path:/tmp/pip-15ZGpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:02:24 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)) 20:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:02:24 INFO - Running setup.py (path:/tmp/pip-H40YJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:02:24 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)) 20:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:02:24 INFO - Running setup.py (path:/tmp/pip-esVwgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:02:24 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)) 20:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:02:24 INFO - Running setup.py (path:/tmp/pip-VsTg3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:02:24 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)) 20:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:02:24 INFO - Running setup.py (path:/tmp/pip-huB5OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:02:25 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)) 20:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:02:25 INFO - Running setup.py (path:/tmp/pip-bohFpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:02:25 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)) 20:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:02:25 INFO - Running setup.py (path:/tmp/pip-uAvvLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:02:25 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)) 20:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:02:25 INFO - Running setup.py (path:/tmp/pip-U22MTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:02:25 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)) 20:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:02:25 INFO - Running setup.py (path:/tmp/pip-IGhMn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:02:25 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)) 20:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:02:25 INFO - Running setup.py (path:/tmp/pip-voJvgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:02:25 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)) 20:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:02:25 INFO - Running setup.py (path:/tmp/pip-yxwU4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:02:25 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)) 20:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:25 INFO - Running setup.py (path:/tmp/pip-jUrcoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:25 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)) 20:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:02:25 INFO - Running setup.py (path:/tmp/pip-6Afkvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:02:25 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)) 20:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:02:25 INFO - Running setup.py (path:/tmp/pip-BmvTzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:02:25 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)) 20:02:25 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)) 20:02:25 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)) 20:02:25 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)) 20:02:25 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)) 20:02:25 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)) 20:02:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:02:25 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 20:02:25 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 20:02:25 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 20:02:25 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 20:02:25 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 20:02:25 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 20:02:27 INFO - Downloading blessings-1.6.tar.gz 20:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:02:27 INFO - Installing collected packages: blessings 20:02:27 INFO - Running setup.py install for blessings 20:02:27 INFO - Successfully installed blessings 20:02:27 INFO - Cleaning up... 20:02:27 INFO - Return code: 0 20:02:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:02:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:02:27 INFO - Reading from file tmpfile_stdout 20:02:27 INFO - Current package versions: 20:02:27 INFO - argparse == 1.2.1 20:02:27 INFO - blessings == 1.6 20:02:27 INFO - blobuploader == 1.2.4 20:02:27 INFO - docopt == 0.6.1 20:02:27 INFO - manifestparser == 1.1 20:02:27 INFO - mozInstall == 1.12 20:02:27 INFO - mozcrash == 0.17 20:02:27 INFO - mozdebug == 0.1 20:02:27 INFO - mozdevice == 0.48 20:02:27 INFO - mozfile == 1.2 20:02:27 INFO - mozhttpd == 0.7 20:02:27 INFO - mozinfo == 0.9 20:02:27 INFO - mozleak == 0.1 20:02:27 INFO - mozlog == 3.1 20:02:27 INFO - moznetwork == 0.27 20:02:27 INFO - mozprocess == 0.22 20:02:27 INFO - mozprofile == 0.28 20:02:27 INFO - mozrunner == 6.11 20:02:27 INFO - mozscreenshot == 0.1 20:02:27 INFO - mozsystemmonitor == 0.0 20:02:27 INFO - moztest == 0.7 20:02:27 INFO - mozversion == 1.4 20:02:27 INFO - psutil == 3.1.1 20:02:27 INFO - requests == 1.2.3 20:02:27 INFO - wsgiref == 0.1.2 20:02:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:27 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 0x7fd5183e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', '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 20:02:27 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 20:02:27 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 20:02:27 INFO - Using env: {'DISPLAY': ':0', 20:02:27 INFO - 'HOME': '/home/cltbld', 20:02:27 INFO - 'LANG': 'en_US.UTF-8', 20:02:27 INFO - 'LANGUAGE': 'en_US:en', 20:02:27 INFO - 'LOGNAME': 'cltbld', 20:02:27 INFO - 'MAIL': '/var/mail/cltbld', 20:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:27 INFO - 'MOZ_NO_REMOTE': '1', 20:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:27 INFO - 'NO_EM_RESTART': '1', 20:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:27 INFO - 'PWD': '/builds/slave/test', 20:02:27 INFO - 'SHELL': '/bin/bash', 20:02:27 INFO - 'SHLVL': '1', 20:02:27 INFO - 'TERM': 'linux', 20:02:27 INFO - 'TMOUT': '86400', 20:02:27 INFO - 'USER': 'cltbld', 20:02:27 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', 20:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:27 INFO - '_': '/tools/buildbot/bin/python'} 20:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:28 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)) 20:02:28 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)) 20:02:28 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)) 20:02:28 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)) 20:02:28 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)) 20:02:28 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)) 20:02:28 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)) 20:02:28 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)) 20:02:28 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)) 20:02:28 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)) 20:02:28 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)) 20:02:28 INFO - Cleaning up... 20:02:28 INFO - Return code: 0 20:02:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5183e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', '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 20:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:02:28 INFO - Using env: {'DISPLAY': ':0', 20:02:28 INFO - 'HOME': '/home/cltbld', 20:02:28 INFO - 'LANG': 'en_US.UTF-8', 20:02:28 INFO - 'LANGUAGE': 'en_US:en', 20:02:28 INFO - 'LOGNAME': 'cltbld', 20:02:28 INFO - 'MAIL': '/var/mail/cltbld', 20:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:28 INFO - 'MOZ_NO_REMOTE': '1', 20:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:28 INFO - 'NO_EM_RESTART': '1', 20:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:28 INFO - 'PWD': '/builds/slave/test', 20:02:28 INFO - 'SHELL': '/bin/bash', 20:02:28 INFO - 'SHLVL': '1', 20:02:28 INFO - 'TERM': 'linux', 20:02:28 INFO - 'TMOUT': '86400', 20:02:28 INFO - 'USER': 'cltbld', 20:02:28 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', 20:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:28 INFO - '_': '/tools/buildbot/bin/python'} 20:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:28 INFO - Downloading/unpacking jsonschema 20:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:02:30 INFO - Downloading/unpacking functools32 (from jsonschema) 20:02:30 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 20:02:30 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 20:02:30 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 20:02:30 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 20:02:30 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 20:02:30 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 20:02:30 INFO - Downloading functools32-3.2.3-2.tar.gz 20:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:02:30 INFO - warning: no files found matching '*.txt' 20:02:30 INFO - no previously-included directories found matching 'build' 20:02:30 INFO - no previously-included directories found matching 'dist' 20:02:30 INFO - no previously-included directories found matching '.git*' 20:02:30 INFO - Installing collected packages: jsonschema, functools32 20:02:30 INFO - Running setup.py install for functools32 20:02:30 INFO - warning: no files found matching '*.txt' 20:02:30 INFO - no previously-included directories found matching 'build' 20:02:30 INFO - no previously-included directories found matching 'dist' 20:02:30 INFO - no previously-included directories found matching '.git*' 20:02:30 INFO - Successfully installed jsonschema functools32 20:02:30 INFO - Cleaning up... 20:02:30 INFO - Return code: 0 20:02:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:30 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 0x7fd5183e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', '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 20:02:30 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 20:02:30 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 20:02:30 INFO - Using env: {'DISPLAY': ':0', 20:02:30 INFO - 'HOME': '/home/cltbld', 20:02:30 INFO - 'LANG': 'en_US.UTF-8', 20:02:30 INFO - 'LANGUAGE': 'en_US:en', 20:02:30 INFO - 'LOGNAME': 'cltbld', 20:02:30 INFO - 'MAIL': '/var/mail/cltbld', 20:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:30 INFO - 'MOZ_NO_REMOTE': '1', 20:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:30 INFO - 'NO_EM_RESTART': '1', 20:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:30 INFO - 'PWD': '/builds/slave/test', 20:02:30 INFO - 'SHELL': '/bin/bash', 20:02:30 INFO - 'SHLVL': '1', 20:02:30 INFO - 'TERM': 'linux', 20:02:30 INFO - 'TMOUT': '86400', 20:02:30 INFO - 'USER': 'cltbld', 20:02:30 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', 20:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:30 INFO - '_': '/tools/buildbot/bin/python'} 20:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:30 INFO - Downloading/unpacking flake8 20:02:30 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 20:02:30 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 20:02:30 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 20:02:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:02:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:02:32 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 20:02:32 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 20:02:32 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 20:02:32 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 20:02:32 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 20:02:32 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 20:02:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:02:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:02:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:02:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:02:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:02:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:02:33 INFO - no previously-included directories found matching 'docs/_build' 20:02:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:02:33 INFO - Running setup.py install for pep8 20:02:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:02:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:02:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:02:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:02:33 INFO - no previously-included directories found matching 'docs/_build' 20:02:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:02:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:02:33 INFO - Cleaning up... 20:02:33 INFO - Return code: 0 20:02:33 INFO - Running post-action listener: _resource_record_post_action 20:02:33 INFO - Running post-action listener: _start_resource_monitoring 20:02:33 INFO - Starting resource monitoring. 20:02:33 INFO - ##### 20:02:33 INFO - ##### Running install step. 20:02:33 INFO - ##### 20:02:33 INFO - Running pre-action listener: _resource_record_pre_action 20:02:33 INFO - Running main action method: install 20:02:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:02:34 INFO - Reading from file tmpfile_stdout 20:02:34 INFO - Detecting whether we're running mozinstall >=1.0... 20:02:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:02:34 INFO - Reading from file tmpfile_stdout 20:02:34 INFO - Output received: 20:02:34 INFO - Usage: mozinstall [options] installer 20:02:34 INFO - Options: 20:02:34 INFO - -h, --help show this help message and exit 20:02:34 INFO - -d DEST, --destination=DEST 20:02:34 INFO - Directory to install application into. [default: 20:02:34 INFO - "/builds/slave/test"] 20:02:34 INFO - --app=APP Application being installed. [default: firefox] 20:02:34 INFO - mkdir: /builds/slave/test/build/application 20:02:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:02:49 INFO - Reading from file tmpfile_stdout 20:02:49 INFO - Output received: 20:02:49 INFO - /builds/slave/test/build/application/firefox/firefox 20:02:49 INFO - Running post-action listener: _resource_record_post_action 20:02:49 INFO - ##### 20:02:49 INFO - ##### Running run-tests step. 20:02:49 INFO - ##### 20:02:49 INFO - Running pre-action listener: _resource_record_pre_action 20:02:49 INFO - Running main action method: run_tests 20:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:02:49 INFO - Python 2.7.3 20:02:49 INFO - Return code: 0 20:02:49 INFO - grabbing minidump binary from tooltool 20:02: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')]} 20:02:49 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 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:02:49 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 20:02:49 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 20:02:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:02:49 INFO - Return code: 0 20:02:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:02:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:02:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:02:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:02:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:02:50 INFO - Return code: 0 20:02:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 20:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 20:02:50 INFO - Using env: {'DISPLAY': ':0', 20:02:50 INFO - 'HOME': '/home/cltbld', 20:02:50 INFO - 'LANG': 'en_US.UTF-8', 20:02:50 INFO - 'LANGUAGE': 'en_US:en', 20:02:50 INFO - 'LOGNAME': 'cltbld', 20:02:50 INFO - 'MAIL': '/var/mail/cltbld', 20:02:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:02:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:50 INFO - 'MOZ_NO_REMOTE': '1', 20:02:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:50 INFO - 'NO_EM_RESTART': '1', 20:02:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:50 INFO - 'PWD': '/builds/slave/test', 20:02:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:02:50 INFO - 'SHELL': '/bin/bash', 20:02:50 INFO - 'SHLVL': '1', 20:02:50 INFO - 'TERM': 'linux', 20:02:50 INFO - 'TMOUT': '86400', 20:02:50 INFO - 'USER': 'cltbld', 20:02:50 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345', 20:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:50 INFO - '_': '/tools/buildbot/bin/python'} 20:02:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 20:02:50 INFO - mozversion application_buildid: 20160523170350 20:02:50 INFO - mozversion application_changeset: a2baee5a734efd4bb9646e5ad06d7552d6618bcb 20:02:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:02:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:02:51 INFO - mozversion application_name: Firefox 20:02:51 INFO - mozversion application_remotingname: firefox-dev 20:02:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:02:51 INFO - mozversion application_vendor: Mozilla 20:02:51 INFO - mozversion application_version: 48.0a2 20:02:51 INFO - mozversion platform_buildid: 20160523170350 20:02:51 INFO - mozversion platform_changeset: a2baee5a734efd4bb9646e5ad06d7552d6618bcb 20:02:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:02:51 INFO - mozversion platform_version: 48.0a2 20:02:51 INFO - using testdate: 1464058970 20:02:51 INFO - actual date: 1464058970 20:02:51 INFO - starting webserver on 'localhost:36905' 20:02:51 INFO - SUITE-START | Running 2 tests 20:02:51 INFO - TEST-START | dromaeo_css 20:02:51 INFO - operating with platform_type : linux_ 20:02:51 INFO - Initialising browser for dromaeo_css test... 20:02:51 INFO - TEST-INFO | started process 18216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmpikOY/profile http://localhost:36905/getInfo.html) 20:02:54 INFO - PROCESS | 18216 | __metrics Screen width/height:1600/1200 20:02:54 INFO - PROCESS | 18216 | colorDepth:24 20:02:54 INFO - PROCESS | 18216 | Browser inner width/height: 1024/697 20:02:54 INFO - PROCESS | 18216 | __metrics 20:02:55 ERROR - PROCESS | 18216 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:02:56 INFO - TEST-INFO | 18216: exit 0 20:02:56 INFO - Browser initialized. 20:02:56 INFO - Running cycle 1/1 for dromaeo_css test... 20:02:56 INFO - TEST-INFO | started process 18310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmpikOY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:03:08 INFO - PROCESS | 18310 | RSS: Main: 142090240 20:03:08 INFO - PROCESS | 18310 | 20:04:00 INFO - PROCESS | 18310 | 1464059040283 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] 20:06:06 INFO - PROCESS | 18310 | Cycle 1(1): loaded http://localhost:36905/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36905/tests/dromaeo/cssquery-ext.html) 20:06:07 INFO - PROCESS | 18310 | RSS: Main: 251179008 20:06:07 INFO - PROCESS | 18310 | 20:09:09 INFO - PROCESS | 18310 | Cycle 1(1): loaded http://localhost:36905/tests/dromaeo/cssquery-ext.html (next: http://localhost:36905/tests/dromaeo/cssquery-jquery.html) 20:09:10 INFO - PROCESS | 18310 | RSS: Main: 223895552 20:09:10 INFO - PROCESS | 18310 | 20:12:12 INFO - PROCESS | 18310 | Cycle 1(1): loaded http://localhost:36905/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36905/tests/dromaeo/cssquery-mootools.html) 20:12:12 INFO - PROCESS | 18310 | RSS: Main: 221614080 20:12:12 INFO - PROCESS | 18310 | 20:15:14 INFO - PROCESS | 18310 | Cycle 1(1): loaded http://localhost:36905/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36905/tests/dromaeo/cssquery-prototype.html) 20:15:15 INFO - PROCESS | 18310 | RSS: Main: 223494144 20:15:15 INFO - PROCESS | 18310 | 20:18:17 INFO - PROCESS | 18310 | Cycle 1(1): loaded http://localhost:36905/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36905/tests/dromaeo/cssquery-yui.html) 20:18:18 INFO - PROCESS | 18310 | RSS: Main: 210718720 20:18:18 INFO - PROCESS | 18310 | 20:21:20 INFO - PROCESS | 18310 | Cycle 1(1): loaded http://localhost:36905/tests/dromaeo/cssquery-yui.html (next: http://localhost:36905/tests/dromaeo/cssquery-dojo.html) 20:21:20 INFO - PROCESS | 18310 | RSS: Main: 253796352 20:21:20 INFO - PROCESS | 18310 | 20:21:21 INFO - PROCESS | 18310 | __start_tp_report 20:21:21 INFO - PROCESS | 18310 | _x_x_mozilla_page_load 20:21:21 INFO - PROCESS | 18310 | _x_x_mozilla_page_load_details 20:21:21 INFO - PROCESS | 18310 | |i|pagename|runs| 20:21:21 INFO - PROCESS | 18310 | |0;dojo.html;3266.26509035467;3318.784279021862;3325.617553981291;3340.899773006811;3368.6126095499026;5456.91814622781;5506.063969125248;5516.9448305517035;5522.613417060802;5538.113901775721;5469.042917489443;5535.391106978229;5535.418781027995;5536.086545719952;5547.278853749017;4918.262260660912;4928.778204980785;4967.70193788372;5070.670406423589;5129.153689641204;4963.429205641343;4973.751312434382;5039.622028347871;5047.873803154932;5052.141136006888;5036.496350364971;5043.1678773002595;5049.3940727112795;5050.292958985745;5082.390113186404;4946.87632809179;4953.578945789613;4966.652334336598;4967.726775027409;5043.470435604246;4943.9258411123865;4953.801847926079;4956.504349565051;4959.256111583255;4997.30037794709;5374.086405311067;5374.8925021499745;5391.73041347931;5417.918731219035;5453.863653408657;5676.148577713335;5798.246227990377;5804.535637149018;5811.302643682743;5911.408859114097;5882.6764527950945;5888.38171991939;5902.675352855591;5911.083782013795;5947.375525569796;5508.338999320067;5516.724163791794;5517.172424136372;5517.613767036309;5519;5752.741126649311;5962.55280853929;5975.312839023568;6042.879142417127;6043.425874541911;5670.716464176775;5727.1695604138;5737.655740655574;5739.741711622987;5768.105943578752;5819.79630712923;5822.33043200029;5824.359320474744;5826.359100498942;5826.563007774349;5594.328680558359;5741.85645358861;5799.652020878761;5817;5822.534197264209;5768.394318596571;5801.071828507503;5817.069268916953;5818.94181058184;5823.82528524145;4449.3993310902615;4453.51011388747;4454.354118652842;4456.5766252205985;4479.238529449936;3881.126746482019;3926.0381206604566;3950.545687245946;3971.4439978403047;3999.8400063997115;5555.055640541118;5615.494605485526;5616;5619.100943848965;5649.887002259932;5749.310082790092;5906.143609176645;5925.614835035709;5929.495992840571;5931.733072011683;5518.172274158908;5579.46995035471;5590.552755779528;5600.103983362643;5604.719764011783;4873.244647079709;4875.1224779540025;4878.219484882402;4880.8779780505065;4916.311716359713;5904.704764761745;5957.553183511167;5958.404159584094;5961.582689211714;5966;5832.795852145155;5896.262967129109;5898.852528686817;5919.467247947706;5920.467157955804;5952.940470595238;6020.909686354796;6028.788992385245;6029.397060293935;6030.90953635687;5624.072028115315;5716.456936591017;5768.596198266081;5771.480566749013;5771.942280577308;5834.591578589628;5837.708114594338;5839;5839.620424672383;5875.41245875409;5682.857928551819;5697.116946873241;5714.799982000776;5716.199732037601;5720.2849643794525;5493.972530137324;5649.830505084854;5666.291713535808;5684.687342196219;5743.224664670216;5576.637518561281;5619;5623.662580245198;5624.353199382123;5645.576581756467;5723.112917497794;5731.283589551306;5735.598508104559;5738.483536481736;5740.225069615549;5503.009458297384;5593.300837395325;5624.7187640616985;5688.943110568841;5699.715014249354 20:21:21 INFO - PROCESS | 18310 | |1;ext.html;614.6158650843223;660.4650233311017;670.1087553553774;679.7043286170513;752.5710345103294;32097.67902320976;39266.214675706506;40083;40087.19825603486;40096.799516002415;43082;43546.56453435465;43655.12689746203;43696.56303436965;43812.780936095354;8047.195280471965;8697.52163631;8878.112188781135;8880.911190888073;10206.64276750314;10271.229657775697;10406.739831504197;10408.687739367831;10418.166546676248;10424.895751042468;10410.843837342445;10474.162067034618;10503.369797812118;10505.107065899409;10505.842412363783;10352.948235258813;10432.634857779942;10437.68686939393;10439.217058720626;10445.112165465944;10166.694999150037;10669.35983840972;10670.253082284244;10670.466476676213;10674.09270212033;33776.49335259973;42712;43167.13665726668;43305.566944330465;43364.56635433637;3544.4506101554302;3684.4104943209227;3689.2990331836863;4209.494860616715;4451.3323001550025;29075.709242907513;29217.561736573967;29317.41365172706;29420.11739647814;30277.394452110835;4483.865484035484;4489.753063581502;4522.751248681321;4571.062932098912;4626.4910859805395;369228;372554;375831;376351;376788;38731.41902871459;55345.44654553403;55413.61465963383;55703.72148139314;55704.44295557074;37015;37195.25609487795;37216.25567488635;37236.25527489435;37327.4400883987;15437.0737755735;16606.75089873653;16721.414750483917;16811.663766724843;16829.15854207309;13947.302634868216;14205.715885682228;14232.146071235758;14233.572992810232;14242.928785356007;9118.270538356915;9138.13187747163;9162.67930622425;9204.125608067223;9228.676996305097;3516.1209697575605;3574.195805943694;3610.2418492116426;3620.6312179755587;3634.0733113056003;1132.869719982196;1137.5051852444212;1148.3913525831322;1162.7209469727375;1219.0613227814533;30182.84908575487;30649.387012260075;30672.38655226883;30714.846425768174;30977.225569360948;1186.3652945674023;1216.2520050169082;1220.6277085488834;1245.993770031144;1264.4942023190797;15954.28205730745;16087.517374478784;16132.67734645324;16362.427315043917;16468.588285292964;525122;532136;533696;534402;535678;58097.128543071885;58798.11802822961;58861.70569147127;58958.70520647369;59051.704741476016;1418.4184484361363;1485.9777103343458;1502.384022550749;1515.371120984801;1519.6276912156593;30249.243768905955;30494.33532479551;32367.190820229684;32848.34303313968;32851.22210945772;49664;50500.24249636332;50512;50517.74741126271;50519.49480505295;358782;368578;368717;368910;369204;26618.06836760704;29579;29994.55008174923;30489.847550762104;30896.227594310323;42481.57518424776;42965.78517107394;43504.782476087414;43839.56160438482;44062;36793.63206367902;36895.63104369029;37007.07482312964;37248;37721.62278377181;35986.10034749047;36433.63566364408;36697.44953825748;37153.81423092867;39456.80271598624;40662.79668601638;41626;41729;41778.164436711704;42189.57810421979;34648;36006.099847504025;36199.09502262464;36403.27193456063;36766;27593.310167245978;28235.15294541167;28264.29339266535;28409.715902840708;28461.430771384872 20:21:21 INFO - PROCESS | 18310 | |2;jquery.html;427.52331150766895;428.5371798457666;431.6999685218772;433.74192355548456;443.14473066980725;18066.819331806695;18665.906670466644;18683.252669893205;18909.52726181846;19500;11799.587014454495;12079.154459187861;12169.087318451107;18049.548761280974;18708.345207917693;5289.841304760864;5396.514313711765;5408.864138530894;5431.34823821142;5434.972825135888;5564.387917329091;5819.068948968166;5940.940590594082;5955.315138759055;5984.162217289583;5950.285965684102;5953;5957.493613042897;5957.731902064395;5958.761649534035;5286.682799032032;5425.484578964992;5431.891362172754;5435.374931882845;5510.559155267589;5269.710165940872;5271.077561426735;5283.075461794209;5284.207368894658;5284.735763211824;13411.530596429078;17614.823851761448;22022.678639281694;22474.775252247433;22505.437364065867;2440.328909549888;2787.23351078453;3010.7892447528684;3059.4951832947536;3085.059056987618;10153.593856245741;10218.182545396425;10307.79384412315;10323.48382580868;10494.108000819939;2004.0781240629328;2031.7054027166125;2069.813716765483;2103.8948052597307;2161.0383379396176;70534;72672.63663681647;73154.63422682906;74261.6286918562;75554;11431.314121152758;11474;11565.479553420117;11610.94194529022;11736.471858766376;15984.36062557508;16010.599735006717;16117.758233626504;16160.11119388445;16162.676746465006;8870.15733505316;8911.287097032222;9009.63961441548;9023.684171053981;9024.052474490216;8738.912610873937;8803.515806630698;8868.512231827312;8926.68756593516;8958.148975847284;4956.826511072095;4973.825916092919;5005.874853128628;5048.899022019539;5077.974610126926;1977.584707211473;2056.814886660208;2085.374387683689;2106.24175296893;2123.118905654136;992.1219720547367;1045.3727763342085;1056.8638713383143;1070.286107207987;1128.8814674459227;18155.36456224026;18497.075146242903;18994.81005189958;19096;19100.80899191018;1051.984220236697;1052.8683914510686;1091.6779550032759;1110.4947249001684;1151.890570395811;8496.53269070207;10690.94654526738;10765.946170269099;10802.405867677353;10837.945810271056;489630;492359;506483;544754;546160;81417.59291203506;83880.58059709662;84682.5765871179;84696;85028;1074.1192222377576;1081.2701426537212;1091.8143915534538;1100.867895852503;1107.374333501569;16497.67004659924;16556.592689621517;16568.585785355463;16751.581210469347;16826.66346673035;37327;38960.41559376668;39396.60603394044;39746.20507589774;39804;53107.468925310255;54136.187957179885;54318.185227220834;54752;54811.45188548064;8189;8213.83572328562;8358.749237522885;8369.916300837158;8371.33029357662;8941.061188575106;12094.334811585448;12188.207766495505;12472.937635311766;12645.74708505843;10672.413017284123;11302.830457543309;11337.093032557541;11370.729734183547;11388.373639449579;11011.559537618727;11011.944940275247;11097.667069987914;11134.220604557928;11143.33140011602;11121.388323642277;11287.887121128684;11492.54029838797;11882.881171188177;12022.098342624513;8388.993320801543;8452.830943381221;8575.914240857512;8737.781555461164;8777.122287771172;8594.914050859412;11332.150088743212;11651.59219427316;11659.708507287385;11783.293002419883 20:21:21 INFO - PROCESS | 18310 | |3;mootools.html;1377.5936098850839;1532.586201725534;1541.083055581929;1705.6503416799558;1831.3681779785977;8023.83952320954;8221.09567947526;8246.505209687422;8268.627911743972;8285.17148285172;8293.253607175353;8306.210909963558;8362.91637083629;8369.958150209255;8389.035260944993;2133.1360798876403;2380.250221180331;2425.2360506440505;2439.121916110199;2456.054419048661;2280.4754906371463;2292.793648571628;2294.1740973249616;2294.3919861236786;2298.310506847947;2330.5571941331177;2337.5792357375667;2402.7957623602015;2406;2406.1458182345277;2141.753698324689;2314.583374992509;2346.0967527502034;2347.2840783561005;2355.0932890837066;2333.661619065243;2338.0764597983703;2372.7864492195613;2376.7742064503846;2380.73811880693;8351.498910065415;8402.873956890651;8405.411621186458;8408.747737567883;8422.831543369159;5147.742612869341;5223.4776522347465;5258.947410525922;5269.499397557226;5271.65734227274;3422.7946323220435;3484.0767196692896;3488.389531831919;3586.4620306953907;3592.802395868226;1159.6231224851872;1160.373398364882;1162.9592964246294;1180.8642006169314;1189.851268591426;11833.585824496102;11947.880521194764;11981;11984.221025633393;12011.459484323226;4449.354843547732;4510.120526497301;4559.088182363541;4670.1126785910565;4672.6261899047995;9577.042295770367;9578.281628877861;9592.040795920351;9602.807943841084;9610.66362677303;5243.895122097537;5285.207218917193;5290.603204759658;5297.311349524537;5297.947020529822;4330.913381732347;4695.882602934886;4728.1252968201;4788.545088216614;4795.424549054136;4095.2014357200655;4113.362428823537;4188.748675079444;4232.873013809591;4236.322188449833;1305.1386085183733;1320.0891384944357;1325.0856908732944;1335.833020872391;1343.5230493174977;927.6335847340263;955.4697143085515;971.1793534463367;979.1383582447543;988.9011098890197;5606.327240731139;5695.1741997410145;5733.709915269031;5776.68228247442;5907.7046147692445;450.8467121178749;455.9065391594715;463.9304104384369;469.2445163287105;470.25934153708045;3859.1316953685196;3860.401637746154;3878;3923.4703315052675;3933.4099885017476;10269.691909242734;10537.157027437786;10621.787564248672;10681.89318106809;10777.515011824487;10487.685369438928;10489.423081730578;10501.842472362921;10515.15878729715;10531.15750739939;7927.137122776143;8164.224398682116;8177.304929081095;8271.296939760068;8275.751727448187;5553.333599968029;5570.721463926869;5591.356993945748;5607.299087614048;5710.457506536873;8953.97029341608;9061.728148155566;9131.086891310815;9228.907710922806;9264.258859291105;8980.236679882284;9195;9377.484238366955;9390.577424015799;9459.858102128612;6927.099477067949;7068.151821781214;7303.123625165014;7498;7656.157822639394;8068.636911338886;8104.635291411782;8145.918540814753;8169.509829410016;8172.019357677117;7088.432925365855;7218.963905180441;7289.562626242442;7292.270772922878;7463.514871533333;7146.892796608159;7345.816354591178;7405.9629701851145;7492.7752167435065;7599.392048636207;6886.931130688829;6904;6929.7228110875;6960.930390696029;6964.199117101598;4961.231009193581;4968.503149685147;4989;5005;5023.949760502494;4944.604431645532;4963.354763880672;4985.501449854985;5056;5070.340855688737 20:21:21 INFO - PROCESS | 18310 | |4;prototype.html;332.38011109281183;350.07579988829485;354.83500172419826;362.47622185941293;366.369843868546;6159.445649891509;6185.0413185956195;6278.2779980302275;6291.779787707431;6355.841103972403;6200.720967556459;6214.223222097238;6225.906611400821;6235.282942461618;6237.220347456568;4604.3784089147875;4766.356541866839;4778.689385189969;4791.832285869995;4793.065352256312;4648.814047438115;4707.435107787071;4708.128996135709;4718.598919091882;4746.976265118687;4683.90632187356;4688.976555117237;4702.3416721659;4704.294355846633;4704.435467743859;4679.251319788817;4683.625309975194;4691.460482044575;4697.084068606623;4698.530146985308;3994.4208089827102;4082.6733861291027;4101.507819061731;4129.731567448136;4148.937765933513;5916.822495325147;5937.168796368512;5938.376470470625;5947.762089516415;5962.910556341659;5462.044142275086;5464.316960379952;5522.144067669517;5535.501804837584;5546.168074788774;6577.802665919982;6590.736370545221;6592.04415359775;6597.340265973412;6600.867982640369;4614.238650622643;4614.284785858197;4617.746023968681;4619.145458090264;4623.791929363187;6695.732170713166;6882.277360877136;6887.449004079662;6895.827604309882;6896.034555162231;4689.390379250675;4714.339992401066;4715.504871988461;4720.645951553647;4729.739864307496;4733.810647574127;4763.190257656207;4764.094821983812;4768.403949506312;4782.402199725035;5494.478024587658;5497.175423686479;5497.587680923947;5505.944940550623;5519.31008623922;6633.7346506140175;6650.235222949326;6652.467802575782;6659.766908158288;6661.800145995628;1647.8764092692857;1660.5433505786004;1709.2650160431133;1710.085104469103;1714.014441696005;1102.311055590256;1134.279732369951;1143.5368675686361;1144.4392247798519;1144.5593446523148;6315.621062736251;6332.303446620868;6346.524010699216;6369.7452101915405;6372.936270637234;6833.555818871758;6926.238113807477;6936.861262774716;6943.375096241261;6965.895511567331;6512.544121911421;6520.445762110274;6527.11883895668;6527.118838956775;6529.249136349285;3693.9076523087138;3727.142757165813;3732.925341493155;3739.0465431315383;3740.7755534667463;7054.400375967997;7067.787966361017;7072.752453664097;7075.186353569303;7078.433725302067;6953.200381956039;7130.643467826588;7133.144022717203;7139.678714457862;7141.464390170758;7097.680604372816;7125.572465652078;7133.89299160513;7145.606991615511;7151.42788576923;6962.094927659372;6973.65131743421;6980.476464265099;6981.685824138028;6986.47601429905;6861.416779573792;6863.38229559342;6864.279250678806;6870.003849441903;6877.862442751217;6914.585124892523;7111.964440177766;7117.82205444868;7122.821929451805;7127.536710113826;4564.77176141185;4615.376924115201;4617.284320930261;4628.421447319085;4630.120277147331;6955.582665040114;6960.443164546926;6971.093757811452;6975.3024697529845;6978.511504194657;6720.495962802712;6730.966345168439;6735.292794256533;6741.460683145238;6750.35871592198;6517.152770139852;6640.203175618956;6645.6677166140535;6663.833404164935;6694.430973367318;6500.3174666659315;6526.934730652632;6582.17722784652;6602.108715323562;6612.537122401578;6741.393274605309;6751.662416879235;6752.459803215633;6769.763058293133;6773.288804675635;6580.868382632225;6596.031785696552;6606.966965165144;6613.404793568602;6616.702248398929 20:21:21 INFO - PROCESS | 18310 | |5;yui.html;848.0840692052584;858.9699360522382;888.0542222533006;888.8666699995003;903.9401625497688;14167.504137355194;15153.924230378847;15302.693946121071;15320.310586023628;15337.616559586017;12623.495060197603;14136.151830890154;14211.431542738279;14223.502177423792;14254.643633909158;875.986860197096;894.472261365794;901.5582364641311;902.8916530016407;903.7153296711548;880.5685214245005;885.1635204731531;887.9378443508957;888.4358432395443;889.3418870036159;761.9619019049053;938.0197693410403;938.4556956964944;938.5448057692014;938.6855403439856;768.4428789127866;899.5592159841696;905.3029167541023;908.7046709819335;910.3445519226179;671.5601281160848;671.5634837355758;672.64686039829;672.865426914619;677.5054210426416;13403.396847141805;13404.396802143927;13451;13458.596242112751;13544;14205.147691138565;14898;15220.771688424682;15268.541943741706;15302.311395987095;11922.403879805976;12122.090843186708;12182.756344873142;12204;12230.082743794163;3988.4017397390626;4029.174019326031;4042.6361627453375;4051.4327994080854;4097.364908439167;53942.73028634871;54661;57929.42070579324;58358.70820645912;58406.12390814184;11575.247608905394;11609.477573509212;11707.882921170849;11798.233114847508;11890.88109118915;21250.36248912535;21373;21375.46561335979;21378.35864924055;21416.892915535635;7934.841303173905;8413.537255450887;8648.1784230498;8664.306855451674;8791.208791208823;4724.149653062482;4983.327250821165;5058.64589478733;5095.847124586268;5185;3437.6906078453057;3477;3484.4250698634946;3487.232808782064;3490.022793617791;633.2464367402775;673.3266733266734;703.6411430170548;704.1831475488409;714.7712731925734;615.6275453350748;627.7551754815626;666.4801454865213;706.6219572528776;717.9964100179466;8927.732168034969;8960.507172105597;8995.685151019683;9022.729318120468;9523.619055237852;687.7730348984823;692.5913710910587;732.0739264829995;737.4137560639198;738.737748099417;4278.886730357193;4496.527864574173;4507.188706032945;4659.464161621389;4701.811927522861;56698.43301566932;57122.42877571171;57426;57438.138427923615;57581.42418575844;55929;56630.716846416326;57330.426695733346;57672.42327576754;57848.42151578514;51126;51999.74000129975;52647;52716.736416317675;52799.99999999923;8484.61819218149;8856.557172141238;8866.73399798007;8867.600957956778;9176.311776616647;38056.42915356327;38443.231135376576;39390;39578.802105989285;39895.60104399035;49319.26021109758;49581;49711.25433118579;50070;50071.74964125156;12353.62939111828;12449.25304481734;12484.750304994031;12702.30137342455;12762.106652534234;11561.826572601249;12534.811977820158;12620.621381358575;12877.613671589866;13243.66890827737;12394.938025309815;12811.87188128144;13287.335633218494;13511.256880871646;13571.253581053137;13091;13103.344832758514;13278.269695166473;13386.665333366744;13446.46214151423;11800.468978896142;12135.271883687006;12459.065570082099;12778.68053298675;12869.485220591072;10230.386176829414;10280.588776448858;10412.271141020055;10638.361698297816;10722.249442538947;10704.571817127227;10860.456977151269;10944.616938407118;11054.502547385226;11093.334399935708 20:21:21 INFO - PROCESS | 18310 | __end_tp_report 20:21:21 INFO - PROCESS | 18310 | __start_cc_report 20:21:21 INFO - PROCESS | 18310 | _x_x_mozilla_cycle_collect,930 20:21:21 INFO - PROCESS | 18310 | __end_cc_report 20:21:21 INFO - PROCESS | 18310 | __startTimestamp1464060080998__endTimestamp 20:21:21 INFO - PROCESS | 18310 | 20:21:21 INFO - PROCESS | 18310 | ------- Summary: start ------- 20:21:21 INFO - PROCESS | 18310 | Number of tests: 6 20:21:21 INFO - PROCESS | 18310 | 20:21:21 INFO - PROCESS | 18310 | [#0] dojo.html Cycles:165 Average:5429.86 Median:5624.35 stddev:596.32 (10.6%) stddev-sans-first:573.48 20:21:21 INFO - PROCESS | 18310 | Values: 3266.3 3318.8 3325.6 3340.9 3368.6 5456.9 5506.1 5516.9 5522.6 5538.1 5469.0 5535.4 5535.4 5536.1 5547.3 4918.3 4928.8 4967.7 5070.7 5129.2 4963.4 4973.8 5039.6 5047.9 5052.1 5036.5 5043.2 5049.4 5050.3 5082.4 4946.9 4953.6 4966.7 4967.7 5043.5 4943.9 4953.8 4956.5 4959.3 4997.3 5374.1 5374.9 5391.7 5417.9 5453.9 5676.1 5798.2 5804.5 5811.3 5911.4 5882.7 5888.4 5902.7 5911.1 5947.4 5508.3 5516.7 5517.2 5517.6 5519.0 5752.7 5962.6 5975.3 6042.9 6043.4 5670.7 5727.2 5737.7 5739.7 5768.1 5819.8 5822.3 5824.4 5826.4 5826.6 5594.3 5741.9 5799.7 5817.0 5822.5 5768.4 5801.1 5817.1 5818.9 5823.8 4449.4 4453.5 4454.4 4456.6 4479.2 3881.1 3926.0 3950.5 3971.4 3999.8 5555.1 5615.5 5616.0 5619.1 5649.9 5749.3 5906.1 5925.6 5929.5 5931.7 5518.2 5579.5 5590.6 5600.1 5604.7 4873.2 4875.1 4878.2 4880.9 4916.3 5904.7 5957.6 5958.4 5961.6 5966.0 5832.8 5896.3 5898.9 5919.5 5920.5 5952.9 6020.9 6028.8 6029.4 6030.9 5624.1 5716.5 5768.6 5771.5 5771.9 5834.6 5837.7 5839.0 5839.6 5875.4 5682.9 5697.1 5714.8 5716.2 5720.3 5494.0 5649.8 5666.3 5684.7 5743.2 5576.6 5619.0 5623.7 5624.4 5645.6 5723.1 5731.3 5735.6 5738.5 5740.2 5503.0 5593.3 5624.7 5688.9 5699.7 20:21:21 INFO - PROCESS | 18310 | 20:21:21 INFO - PROCESS | 18310 | [#1] ext.html Cycles:180 Average:57307.30 Median:36565.54 stddev:114383.33 (312.8%) stddev-sans-first:114625.01 20:21:21 INFO - PROCESS | 18310 | Values: 614.6 660.5 670.1 679.7 752.6 32097.7 39266.2 40083.0 40087.2 40096.8 43082.0 43546.6 43655.1 43696.6 43812.8 8047.2 8697.5 8878.1 8880.9 10206.6 10271.2 10406.7 10408.7 10418.2 10424.9 10410.8 10474.2 10503.4 10505.1 10505.8 10352.9 10432.6 10437.7 10439.2 10445.1 10166.7 10669.4 10670.3 10670.5 10674.1 33776.5 42712.0 43167.1 43305.6 43364.6 3544.5 3684.4 3689.3 4209.5 4451.3 29075.7 29217.6 29317.4 29420.1 30277.4 4483.9 4489.8 4522.8 4571.1 4626.5 369228.0 372554.0 375831.0 376351.0 376788.0 38731.4 55345.4 55413.6 55703.7 55704.4 37015.0 37195.3 37216.3 37236.3 37327.4 15437.1 16606.8 16721.4 16811.7 16829.2 13947.3 14205.7 14232.1 14233.6 14242.9 9118.3 9138.1 9162.7 9204.1 9228.7 3516.1 3574.2 3610.2 3620.6 3634.1 1132.9 1137.5 1148.4 1162.7 1219.1 30182.8 30649.4 30672.4 30714.8 30977.2 1186.4 1216.3 1220.6 1246.0 1264.5 15954.3 16087.5 16132.7 16362.4 16468.6 525122.0 532136.0 533696.0 534402.0 535678.0 58097.1 58798.1 58861.7 58958.7 59051.7 1418.4 1486.0 1502.4 1515.4 1519.6 30249.2 30494.3 32367.2 32848.3 32851.2 49664.0 50500.2 50512.0 50517.7 50519.5 358782.0 368578.0 368717.0 368910.0 369204.0 26618.1 29579.0 29994.6 30489.8 30896.2 42481.6 42965.8 43504.8 43839.6 44062.0 36793.6 36895.6 37007.1 37248.0 37721.6 35986.1 36433.6 36697.4 37153.8 39456.8 40662.8 41626.0 41729.0 41778.2 42189.6 34648.0 36006.1 36199.1 36403.3 36766.0 27593.3 28235.2 28264.3 28409.7 28461.4 20:21:21 INFO - PROCESS | 18310 | 20:21:21 INFO - PROCESS | 18310 | [#2] jquery.html Cycles:180 Average:28827.29 Median:12472.88 stddev:84737.92 (679.4%) stddev-sans-first:84948.80 20:21:21 INFO - PROCESS | 18310 | Values: 427.5 428.5 431.7 433.7 443.1 18066.8 18665.9 18683.3 18909.5 19500.0 11799.6 12079.2 12169.1 18049.5 18708.3 5289.8 5396.5 5408.9 5431.3 5435.0 5564.4 5819.1 5940.9 5955.3 5984.2 5950.3 5953.0 5957.5 5957.7 5958.8 5286.7 5425.5 5431.9 5435.4 5510.6 5269.7 5271.1 5283.1 5284.2 5284.7 13411.5 17614.8 22022.7 22474.8 22505.4 2440.3 2787.2 3010.8 3059.5 3085.1 10153.6 10218.2 10307.8 10323.5 10494.1 2004.1 2031.7 2069.8 2103.9 2161.0 70534.0 72672.6 73154.6 74261.6 75554.0 11431.3 11474.0 11565.5 11610.9 11736.5 15984.4 16010.6 16117.8 16160.1 16162.7 8870.2 8911.3 9009.6 9023.7 9024.1 8738.9 8803.5 8868.5 8926.7 8958.1 4956.8 4973.8 5005.9 5048.9 5078.0 1977.6 2056.8 2085.4 2106.2 2123.1 992.1 1045.4 1056.9 1070.3 1128.9 18155.4 18497.1 18994.8 19096.0 19100.8 1052.0 1052.9 1091.7 1110.5 1151.9 8496.5 10690.9 10765.9 10802.4 10837.9 489630.0 492359.0 506483.0 544754.0 546160.0 81417.6 83880.6 84682.6 84696.0 85028.0 1074.1 1081.3 1091.8 1100.9 1107.4 16497.7 16556.6 16568.6 16751.6 16826.7 37327.0 38960.4 39396.6 39746.2 39804.0 53107.5 54136.2 54318.2 54752.0 54811.5 8189.0 8213.8 8358.7 8369.9 8371.3 8941.1 12094.3 12188.2 12472.9 12645.7 10672.4 11302.8 11337.1 11370.7 11388.4 11011.6 11011.9 11097.7 11134.2 11143.3 11121.4 11287.9 11492.5 11882.9 12022.1 8389.0 8452.8 8575.9 8737.8 8777.1 8594.9 11332.2 11651.6 11659.7 11783.3 20:21:21 INFO - PROCESS | 18310 | 20:21:21 INFO - PROCESS | 18310 | [#3] mootools.html Cycles:180 Average:5585.23 Median:4997.00 stddev:3101.63 (62.1%) stddev-sans-first:3094.21 20:21:21 INFO - PROCESS | 18310 | Values: 1377.6 1532.6 1541.1 1705.7 1831.4 8023.8 8221.1 8246.5 8268.6 8285.2 8293.3 8306.2 8362.9 8370.0 8389.0 2133.1 2380.3 2425.2 2439.1 2456.1 2280.5 2292.8 2294.2 2294.4 2298.3 2330.6 2337.6 2402.8 2406.0 2406.1 2141.8 2314.6 2346.1 2347.3 2355.1 2333.7 2338.1 2372.8 2376.8 2380.7 8351.5 8402.9 8405.4 8408.7 8422.8 5147.7 5223.5 5258.9 5269.5 5271.7 3422.8 3484.1 3488.4 3586.5 3592.8 1159.6 1160.4 1163.0 1180.9 1189.9 11833.6 11947.9 11981.0 11984.2 12011.5 4449.4 4510.1 4559.1 4670.1 4672.6 9577.0 9578.3 9592.0 9602.8 9610.7 5243.9 5285.2 5290.6 5297.3 5297.9 4330.9 4695.9 4728.1 4788.5 4795.4 4095.2 4113.4 4188.7 4232.9 4236.3 1305.1 1320.1 1325.1 1335.8 1343.5 927.6 955.5 971.2 979.1 988.9 5606.3 5695.2 5733.7 5776.7 5907.7 450.8 455.9 463.9 469.2 470.3 3859.1 3860.4 3878.0 3923.5 3933.4 10269.7 10537.2 10621.8 10681.9 10777.5 10487.7 10489.4 10501.8 10515.2 10531.2 7927.1 8164.2 8177.3 8271.3 8275.8 5553.3 5570.7 5591.4 5607.3 5710.5 8954.0 9061.7 9131.1 9228.9 9264.3 8980.2 9195.0 9377.5 9390.6 9459.9 6927.1 7068.2 7303.1 7498.0 7656.2 8068.6 8104.6 8145.9 8169.5 8172.0 7088.4 7219.0 7289.6 7292.3 7463.5 7146.9 7345.8 7406.0 7492.8 7599.4 6886.9 6904.0 6929.7 6960.9 6964.2 4961.2 4968.5 4989.0 5005.0 5023.9 4944.6 4963.4 4985.5 5056.0 5070.3 20:21:21 INFO - PROCESS | 18310 | 20:21:21 INFO - PROCESS | 18310 | [#4] prototype.html Cycles:180 Average:5564.90 Median:6339.41 stddev:1695.14 (26.7%) stddev-sans-first:1653.77 20:21:21 INFO - PROCESS | 18310 | Values: 332.4 350.1 354.8 362.5 366.4 6159.4 6185.0 6278.3 6291.8 6355.8 6200.7 6214.2 6225.9 6235.3 6237.2 4604.4 4766.4 4778.7 4791.8 4793.1 4648.8 4707.4 4708.1 4718.6 4747.0 4683.9 4689.0 4702.3 4704.3 4704.4 4679.3 4683.6 4691.5 4697.1 4698.5 3994.4 4082.7 4101.5 4129.7 4148.9 5916.8 5937.2 5938.4 5947.8 5962.9 5462.0 5464.3 5522.1 5535.5 5546.2 6577.8 6590.7 6592.0 6597.3 6600.9 4614.2 4614.3 4617.7 4619.1 4623.8 6695.7 6882.3 6887.4 6895.8 6896.0 4689.4 4714.3 4715.5 4720.6 4729.7 4733.8 4763.2 4764.1 4768.4 4782.4 5494.5 5497.2 5497.6 5505.9 5519.3 6633.7 6650.2 6652.5 6659.8 6661.8 1647.9 1660.5 1709.3 1710.1 1714.0 1102.3 1134.3 1143.5 1144.4 1144.6 6315.6 6332.3 6346.5 6369.7 6372.9 6833.6 6926.2 6936.9 6943.4 6965.9 6512.5 6520.4 6527.1 6527.1 6529.2 3693.9 3727.1 3732.9 3739.0 3740.8 7054.4 7067.8 7072.8 7075.2 7078.4 6953.2 7130.6 7133.1 7139.7 7141.5 7097.7 7125.6 7133.9 7145.6 7151.4 6962.1 6973.7 6980.5 6981.7 6986.5 6861.4 6863.4 6864.3 6870.0 6877.9 6914.6 7112.0 7117.8 7122.8 7127.5 4564.8 4615.4 4617.3 4628.4 4630.1 6955.6 6960.4 6971.1 6975.3 6978.5 6720.5 6731.0 6735.3 6741.5 6750.4 6517.2 6640.2 6645.7 6663.8 6694.4 6500.3 6526.9 6582.2 6602.1 6612.5 6741.4 6751.7 6752.5 6769.8 6773.3 6580.9 6596.0 6607.0 6613.4 6616.7 20:21:21 INFO - PROCESS | 18310 | 20:21:21 INFO - PROCESS | 18310 | [#5] yui.html Cycles:180 Average:15294.99 Median:27021.70 stddev:17520.45 (64.8%) stddev-sans-first:17536.00 20:21:21 INFO - PROCESS | 18310 | Values: 848.1 859.0 888.1 888.9 903.9 14167.5 15153.9 15302.7 15320.3 15337.6 12623.5 14136.2 14211.4 14223.5 14254.6 876.0 894.5 901.6 902.9 903.7 880.6 885.2 887.9 888.4 889.3 762.0 938.0 938.5 938.5 938.7 768.4 899.6 905.3 908.7 910.3 671.6 671.6 672.6 672.9 677.5 13403.4 13404.4 13451.0 13458.6 13544.0 14205.1 14898.0 15220.8 15268.5 15302.3 11922.4 12122.1 12182.8 12204.0 12230.1 3988.4 4029.2 4042.6 4051.4 4097.4 53942.7 54661.0 57929.4 58358.7 58406.1 11575.2 11609.5 11707.9 11798.2 11890.9 21250.4 21373.0 21375.5 21378.4 21416.9 7934.8 8413.5 8648.2 8664.3 8791.2 4724.1 4983.3 5058.6 5095.8 5185.0 3437.7 3477.0 3484.4 3487.2 3490.0 633.2 673.3 703.6 704.2 714.8 615.6 627.8 666.5 706.6 718.0 8927.7 8960.5 8995.7 9022.7 9523.6 687.8 692.6 732.1 737.4 738.7 4278.9 4496.5 4507.2 4659.5 4701.8 56698.4 57122.4 57426.0 57438.1 57581.4 55929.0 56630.7 57330.4 57672.4 57848.4 51126.0 51999.7 52647.0 52716.7 52800.0 8484.6 8856.6 8866.7 8867.6 9176.3 38056.4 38443.2 39390.0 39578.8 39895.6 49319.3 49581.0 49711.3 50070.0 50071.7 12353.6 12449.3 12484.8 12702.3 12762.1 11561.8 12534.8 12620.6 12877.6 13243.7 12394.9 12811.9 13287.3 13511.3 13571.3 13091.0 13103.3 13278.3 13386.7 13446.5 11800.5 12135.3 12459.1 12778.7 12869.5 10230.4 10280.6 10412.3 10638.4 10722.2 10704.6 10860.5 10944.6 11054.5 11093.3 20:21:21 INFO - PROCESS | 18310 | -------- Summary: end -------- 20:21:21 INFO - PROCESS | 18310 | 20:21:21 INFO - TEST-INFO | 18310: exit 0 20:21:21 INFO - TEST-OK | dromaeo_css | took 1110657ms 20:21:21 INFO - TEST-START | kraken 20:21:21 INFO - operating with platform_type : linux_ 20:21:21 INFO - Initialising browser for kraken test... 20:21:21 INFO - TEST-INFO | started process 18496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbh8TYQ/profile http://localhost:36905/getInfo.html) 20:21:25 INFO - PROCESS | 18496 | __metrics Screen width/height:1600/1200 20:21:25 INFO - PROCESS | 18496 | colorDepth:24 20:21:25 INFO - PROCESS | 18496 | Browser inner width/height: 1024/697 20:21:25 INFO - PROCESS | 18496 | __metrics 20:21:26 ERROR - PROCESS | 18496 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:21:27 INFO - TEST-INFO | 18496: exit 0 20:21:27 INFO - Browser initialized. 20:21:27 INFO - Running cycle 1/1 for kraken test... 20:21:27 INFO - TEST-INFO | started process 18583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbh8TYQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:38 INFO - PROCESS | 18583 | RSS: Main: 142045184 20:21:38 INFO - PROCESS | 18583 | 20:21:41 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36905/tests/kraken/driver.html?testName=audio-beat-detection) 20:21:42 INFO - PROCESS | 18583 | RSS: Main: 196530176 20:21:42 INFO - PROCESS | 18583 | 20:21:44 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36905/tests/kraken/driver.html?testName=audio-dft) 20:21:45 INFO - PROCESS | 18583 | RSS: Main: 182022144 20:21:45 INFO - PROCESS | 18583 | 20:21:48 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36905/tests/kraken/driver.html?testName=audio-fft) 20:21:48 INFO - PROCESS | 18583 | RSS: Main: 273309696 20:21:48 INFO - PROCESS | 18583 | 20:21:50 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36905/tests/kraken/driver.html?testName=audio-oscillator) 20:21:51 INFO - PROCESS | 18583 | RSS: Main: 178462720 20:21:51 INFO - PROCESS | 18583 | 20:21:53 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36905/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:21:54 INFO - PROCESS | 18583 | RSS: Main: 177131520 20:21:54 INFO - PROCESS | 18583 | 20:21:57 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36905/tests/kraken/driver.html?testName=imaging-darkroom) 20:21:57 INFO - PROCESS | 18583 | RSS: Main: 211980288 20:21:57 INFO - PROCESS | 18583 | 20:22:01 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36905/tests/kraken/driver.html?testName=imaging-desaturate) 20:22:01 INFO - PROCESS | 18583 | RSS: Main: 212639744 20:22:01 INFO - PROCESS | 18583 | 20:22:04 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36905/tests/kraken/driver.html?testName=json-parse-financial) 20:22:05 INFO - PROCESS | 18583 | RSS: Main: 211275776 20:22:05 INFO - PROCESS | 18583 | 20:22:06 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36905/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:22:07 INFO - PROCESS | 18583 | RSS: Main: 190255104 20:22:07 INFO - PROCESS | 18583 | 20:22:09 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36905/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:22:09 INFO - PROCESS | 18583 | RSS: Main: 196628480 20:22:09 INFO - PROCESS | 18583 | 20:22:11 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36905/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:22:12 INFO - PROCESS | 18583 | RSS: Main: 209543168 20:22:12 INFO - PROCESS | 18583 | 20:22:14 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36905/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:22:15 INFO - PROCESS | 18583 | RSS: Main: 214216704 20:22:15 INFO - PROCESS | 18583 | 20:22:17 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36905/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:22:18 INFO - PROCESS | 18583 | RSS: Main: 212328448 20:22:18 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | Cycle 1(1): loaded http://localhost:36905/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36905/tests/kraken/driver.html?testName=ai-astar) 20:22:20 INFO - PROCESS | 18583 | RSS: Main: 276041728 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | __start_tp_report 20:22:20 INFO - PROCESS | 18583 | _x_x_mozilla_page_load 20:22:20 INFO - PROCESS | 18583 | _x_x_mozilla_page_load_details 20:22:20 INFO - PROCESS | 18583 | |i|pagename|runs| 20:22:20 INFO - PROCESS | 18583 | |0;ai-astar;112;110;111;114;112;110;104;111;109;110 20:22:20 INFO - PROCESS | 18583 | |1;audio-beat-detection;150;125;159;170;127;160;157;128;185;127 20:22:20 INFO - PROCESS | 18583 | |2;audio-dft;161;160;160;161;162;160;163;159;160;159 20:22:20 INFO - PROCESS | 18583 | |3;audio-fft;75;76;77;178;73;76;75;77;177;75 20:22:20 INFO - PROCESS | 18583 | |4;audio-oscillator;93;92;155;93;92;92;152;91;91;152 20:22:20 INFO - PROCESS | 18583 | |5;imaging-gaussian-blur;117;117;117;117;117;117;119;116;116;117 20:22:20 INFO - PROCESS | 18583 | |6;imaging-darkroom;145;146;145;145;145;146;145;146;145;146 20:22:20 INFO - PROCESS | 18583 | |7;imaging-desaturate;94;94;94;94;94;95;96;95;95;95 20:22:20 INFO - PROCESS | 18583 | |8;json-parse-financial;56;55;54;54;56;56;54;74;54;53 20:22:20 INFO - PROCESS | 18583 | |9;json-stringify-tinderbox;59;58;58;57;57;57;70;58;58;57 20:22:20 INFO - PROCESS | 18583 | |10;stanford-crypto-aes;73;74;74;81;73;74;74;75;81;82 20:22:20 INFO - PROCESS | 18583 | |11;stanford-crypto-ccm;119;113;115;113;113;115;116;112;130;125 20:22:20 INFO - PROCESS | 18583 | |12;stanford-crypto-pbkdf2;157;163;163;162;159;160;160;163;158;158 20:22:20 INFO - PROCESS | 18583 | |13;stanford-crypto-sha256-iterative;67;66;66;65;66;65;67;64;66;66 20:22:20 INFO - PROCESS | 18583 | __end_tp_report 20:22:20 INFO - PROCESS | 18583 | __start_cc_report 20:22:20 INFO - PROCESS | 18583 | _x_x_mozilla_cycle_collect,1570 20:22:20 INFO - PROCESS | 18583 | __end_cc_report 20:22:20 INFO - PROCESS | 18583 | __startTimestamp1464060140535__endTimestamp 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | ------- Summary: start ------- 20:22:20 INFO - PROCESS | 18583 | Number of tests: 14 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.63 (2.4%) stddev-sans-first:2.71 20:22:20 INFO - PROCESS | 18583 | Values: 112.0 110.0 111.0 114.0 112.0 110.0 104.0 111.0 109.0 110.0 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:158.00 stddev:21.10 (13.4%) stddev-sans-first:22.38 20:22:20 INFO - PROCESS | 18583 | Values: 150.0 125.0 159.0 170.0 127.0 160.0 157.0 128.0 185.0 127.0 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 20:22:20 INFO - PROCESS | 18583 | Values: 161.0 160.0 160.0 161.0 162.0 160.0 163.0 159.0 160.0 159.0 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#3] audio-fft Cycles:10 Average:95.90 Median:75.50 stddev:43.02 (57.0%) stddev-sans-first:44.96 20:22:20 INFO - PROCESS | 18583 | Values: 75.0 76.0 77.0 178.0 73.0 76.0 75.0 77.0 177.0 75.0 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:92.00 stddev:29.48 (32.0%) stddev-sans-first:30.60 20:22:20 INFO - PROCESS | 18583 | Values: 93.0 92.0 155.0 93.0 92.0 92.0 152.0 91.0 91.0 152.0 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 20:22:20 INFO - PROCESS | 18583 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 119.0 116.0 116.0 117.0 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:22:20 INFO - PROCESS | 18583 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 20:22:20 INFO - PROCESS | 18583 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 96.0 95.0 95.0 95.0 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:55.50 stddev:6.20 (11.2%) stddev-sans-first:6.58 20:22:20 INFO - PROCESS | 18583 | Values: 56.0 55.0 54.0 54.0 56.0 56.0 54.0 74.0 54.0 53.0 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:58.00 stddev:3.96 (6.8%) stddev-sans-first:4.20 20:22:20 INFO - PROCESS | 18583 | Values: 59.0 58.0 58.0 57.0 57.0 57.0 70.0 58.0 58.0 57.0 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:74.50 stddev:3.67 (4.9%) stddev-sans-first:3.71 20:22:20 INFO - PROCESS | 18583 | Values: 73.0 74.0 74.0 81.0 73.0 74.0 74.0 75.0 81.0 82.0 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:115.50 stddev:5.95 (5.2%) stddev-sans-first:6.27 20:22:20 INFO - PROCESS | 18583 | Values: 119.0 113.0 115.0 113.0 113.0 115.0 116.0 112.0 130.0 125.0 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.00 stddev:2.31 (1.4%) stddev-sans-first:2.12 20:22:20 INFO - PROCESS | 18583 | Values: 157.0 163.0 163.0 162.0 159.0 160.0 160.0 163.0 158.0 158.0 20:22:20 INFO - PROCESS | 18583 | 20:22:20 INFO - PROCESS | 18583 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 20:22:20 INFO - PROCESS | 18583 | Values: 67.0 66.0 66.0 65.0 66.0 65.0 67.0 64.0 66.0 66.0 20:22:20 INFO - PROCESS | 18583 | -------- Summary: end -------- 20:22:20 INFO - PROCESS | 18583 | 20:22:21 INFO - TEST-INFO | 18583: exit 0 20:22:21 INFO - TEST-OK | kraken | took 59923ms 20:22:21 INFO - SUITE-END | took 1170s 20:22:21 INFO - Completed test suite (00:19:30) 20:22:21 INFO - javascript benchmark 20:22:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3266.26509035467, 3318.784279021862, 3325.617553981291, 3340.899773006811, 3368.6126095499026, 5456.91814622781, 5506.063969125248, 5516.9448305517035, 5522.613417060802, 5538.113901775721, 5469.042917489443, 5535.391106978229, 5535.418781027995, 5536.086545719952, 5547.278853749017, 4918.262260660912, 4928.778204980785, 4967.70193788372, 5070.670406423589, 5129.153689641204, 4963.429205641343, 4973.751312434382, 5039.622028347871, 5047.873803154932, 5052.141136006888, 5036.496350364971, 5043.1678773002595, 5049.3940727112795, 5050.292958985745, 5082.390113186404, 4946.87632809179, 4953.578945789613, 4966.652334336598, 4967.726775027409, 5043.470435604246, 4943.9258411123865, 4953.801847926079, 4956.504349565051, 4959.256111583255, 4997.30037794709, 5374.086405311067, 5374.8925021499745, 5391.73041347931, 5417.918731219035, 5453.863653408657, 5676.148577713335, 5798.246227990377, 5804.535637149018, 5811.302643682743, 5911.408859114097, 5882.6764527950945, 5888.38171991939, 5902.675352855591, 5911.083782013795, 5947.375525569796, 5508.338999320067, 5516.724163791794, 5517.172424136372, 5517.613767036309, 5519.0, 5752.741126649311, 5962.55280853929, 5975.312839023568, 6042.879142417127, 6043.425874541911, 5670.716464176775, 5727.1695604138, 5737.655740655574, 5739.741711622987, 5768.105943578752, 5819.79630712923, 5822.33043200029, 5824.359320474744, 5826.359100498942, 5826.563007774349, 5594.328680558359, 5741.85645358861, 5799.652020878761, 5817.0, 5822.534197264209, 5768.394318596571, 5801.071828507503, 5817.069268916953, 5818.94181058184, 5823.82528524145, 4449.3993310902615, 4453.51011388747, 4454.354118652842, 4456.5766252205985, 4479.238529449936, 3881.126746482019, 3926.0381206604566, 3950.545687245946, 3971.4439978403047, 3999.8400063997115, 5555.055640541118, 5615.494605485526, 5616.0, 5619.100943848965, 5649.887002259932, 5749.310082790092, 5906.143609176645, 5925.614835035709, 5929.495992840571, 5931.733072011683, 5518.172274158908, 5579.46995035471, 5590.552755779528, 5600.103983362643, 5604.719764011783, 4873.244647079709, 4875.1224779540025, 4878.219484882402, 4880.8779780505065, 4916.311716359713, 5904.704764761745, 5957.553183511167, 5958.404159584094, 5961.582689211714, 5966.0, 5832.795852145155, 5896.262967129109, 5898.852528686817, 5919.467247947706, 5920.467157955804, 5952.940470595238, 6020.909686354796, 6028.788992385245, 6029.397060293935, 6030.90953635687, 5624.072028115315, 5716.456936591017, 5768.596198266081, 5771.480566749013, 5771.942280577308, 5834.591578589628, 5837.708114594338, 5839.0, 5839.620424672383, 5875.41245875409, 5682.857928551819, 5697.116946873241, 5714.799982000776, 5716.199732037601, 5720.2849643794525, 5493.972530137324, 5649.830505084854, 5666.291713535808, 5684.687342196219, 5743.224664670216, 5576.637518561281, 5619.0, 5623.662580245198, 5624.353199382123, 5645.576581756467, 5723.112917497794, 5731.283589551306, 5735.598508104559, 5738.483536481736, 5740.225069615549, 5503.009458297384, 5593.300837395325, 5624.7187640616985, 5688.943110568841, 5699.715014249354], "value": 5391.494142015774, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.6158650843223, 660.4650233311017, 670.1087553553774, 679.7043286170513, 752.5710345103294, 32097.67902320976, 39266.214675706506, 40083.0, 40087.19825603486, 40096.799516002415, 43082.0, 43546.56453435465, 43655.12689746203, 43696.56303436965, 43812.780936095354, 8047.195280471965, 8697.52163631, 8878.112188781135, 8880.911190888073, 10206.64276750314, 10271.229657775697, 10406.739831504197, 10408.687739367831, 10418.166546676248, 10424.895751042468, 10410.843837342445, 10474.162067034618, 10503.369797812118, 10505.107065899409, 10505.842412363783, 10352.948235258813, 10432.634857779942, 10437.68686939393, 10439.217058720626, 10445.112165465944, 10166.694999150037, 10669.35983840972, 10670.253082284244, 10670.466476676213, 10674.09270212033, 33776.49335259973, 42712.0, 43167.13665726668, 43305.566944330465, 43364.56635433637, 3544.4506101554302, 3684.4104943209227, 3689.2990331836863, 4209.494860616715, 4451.3323001550025, 29075.709242907513, 29217.561736573967, 29317.41365172706, 29420.11739647814, 30277.394452110835, 4483.865484035484, 4489.753063581502, 4522.751248681321, 4571.062932098912, 4626.4910859805395, 369228.0, 372554.0, 375831.0, 376351.0, 376788.0, 38731.41902871459, 55345.44654553403, 55413.61465963383, 55703.72148139314, 55704.44295557074, 37015.0, 37195.25609487795, 37216.25567488635, 37236.25527489435, 37327.4400883987, 15437.0737755735, 16606.75089873653, 16721.414750483917, 16811.663766724843, 16829.15854207309, 13947.302634868216, 14205.715885682228, 14232.146071235758, 14233.572992810232, 14242.928785356007, 9118.270538356915, 9138.13187747163, 9162.67930622425, 9204.125608067223, 9228.676996305097, 3516.1209697575605, 3574.195805943694, 3610.2418492116426, 3620.6312179755587, 3634.0733113056003, 1132.869719982196, 1137.5051852444212, 1148.3913525831322, 1162.7209469727375, 1219.0613227814533, 30182.84908575487, 30649.387012260075, 30672.38655226883, 30714.846425768174, 30977.225569360948, 1186.3652945674023, 1216.2520050169082, 1220.6277085488834, 1245.993770031144, 1264.4942023190797, 15954.28205730745, 16087.517374478784, 16132.67734645324, 16362.427315043917, 16468.588285292964, 525122.0, 532136.0, 533696.0, 534402.0, 535678.0, 58097.128543071885, 58798.11802822961, 58861.70569147127, 58958.70520647369, 59051.704741476016, 1418.4184484361363, 1485.9777103343458, 1502.384022550749, 1515.371120984801, 1519.6276912156593, 30249.243768905955, 30494.33532479551, 32367.190820229684, 32848.34303313968, 32851.22210945772, 49664.0, 50500.24249636332, 50512.0, 50517.74741126271, 50519.49480505295, 358782.0, 368578.0, 368717.0, 368910.0, 369204.0, 26618.06836760704, 29579.0, 29994.55008174923, 30489.847550762104, 30896.227594310323, 42481.57518424776, 42965.78517107394, 43504.782476087414, 43839.56160438482, 44062.0, 36793.63206367902, 36895.63104369029, 37007.07482312964, 37248.0, 37721.62278377181, 35986.10034749047, 36433.63566364408, 36697.44953825748, 37153.81423092867, 39456.80271598624, 40662.79668601638, 41626.0, 41729.0, 41778.164436711704, 42189.57810421979, 34648.0, 36006.099847504025, 36199.09502262464, 36403.27193456063, 36766.0, 27593.310167245978, 28235.15294541167, 28264.29339266535, 28409.715902840708, 28461.430771384872], "value": 19353.783162392752, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.52331150766895, 428.5371798457666, 431.6999685218772, 433.74192355548456, 443.14473066980725, 18066.819331806695, 18665.906670466644, 18683.252669893205, 18909.52726181846, 19500.0, 11799.587014454495, 12079.154459187861, 12169.087318451107, 18049.548761280974, 18708.345207917693, 5289.841304760864, 5396.514313711765, 5408.864138530894, 5431.34823821142, 5434.972825135888, 5564.387917329091, 5819.068948968166, 5940.940590594082, 5955.315138759055, 5984.162217289583, 5950.285965684102, 5953.0, 5957.493613042897, 5957.731902064395, 5958.761649534035, 5286.682799032032, 5425.484578964992, 5431.891362172754, 5435.374931882845, 5510.559155267589, 5269.710165940872, 5271.077561426735, 5283.075461794209, 5284.207368894658, 5284.735763211824, 13411.530596429078, 17614.823851761448, 22022.678639281694, 22474.775252247433, 22505.437364065867, 2440.328909549888, 2787.23351078453, 3010.7892447528684, 3059.4951832947536, 3085.059056987618, 10153.593856245741, 10218.182545396425, 10307.79384412315, 10323.48382580868, 10494.108000819939, 2004.0781240629328, 2031.7054027166125, 2069.813716765483, 2103.8948052597307, 2161.0383379396176, 70534.0, 72672.63663681647, 73154.63422682906, 74261.6286918562, 75554.0, 11431.314121152758, 11474.0, 11565.479553420117, 11610.94194529022, 11736.471858766376, 15984.36062557508, 16010.599735006717, 16117.758233626504, 16160.11119388445, 16162.676746465006, 8870.15733505316, 8911.287097032222, 9009.63961441548, 9023.684171053981, 9024.052474490216, 8738.912610873937, 8803.515806630698, 8868.512231827312, 8926.68756593516, 8958.148975847284, 4956.826511072095, 4973.825916092919, 5005.874853128628, 5048.899022019539, 5077.974610126926, 1977.584707211473, 2056.814886660208, 2085.374387683689, 2106.24175296893, 2123.118905654136, 992.1219720547367, 1045.3727763342085, 1056.8638713383143, 1070.286107207987, 1128.8814674459227, 18155.36456224026, 18497.075146242903, 18994.81005189958, 19096.0, 19100.80899191018, 1051.984220236697, 1052.8683914510686, 1091.6779550032759, 1110.4947249001684, 1151.890570395811, 8496.53269070207, 10690.94654526738, 10765.946170269099, 10802.405867677353, 10837.945810271056, 489630.0, 492359.0, 506483.0, 544754.0, 546160.0, 81417.59291203506, 83880.58059709662, 84682.5765871179, 84696.0, 85028.0, 1074.1192222377576, 1081.2701426537212, 1091.8143915534538, 1100.867895852503, 1107.374333501569, 16497.67004659924, 16556.592689621517, 16568.585785355463, 16751.581210469347, 16826.66346673035, 37327.0, 38960.41559376668, 39396.60603394044, 39746.20507589774, 39804.0, 53107.468925310255, 54136.187957179885, 54318.185227220834, 54752.0, 54811.45188548064, 8189.0, 8213.83572328562, 8358.749237522885, 8369.916300837158, 8371.33029357662, 8941.061188575106, 12094.334811585448, 12188.207766495505, 12472.937635311766, 12645.74708505843, 10672.413017284123, 11302.830457543309, 11337.093032557541, 11370.729734183547, 11388.373639449579, 11011.559537618727, 11011.944940275247, 11097.667069987914, 11134.220604557928, 11143.33140011602, 11121.388323642277, 11287.887121128684, 11492.54029838797, 11882.881171188177, 12022.098342624513, 8388.993320801543, 8452.830943381221, 8575.914240857512, 8737.781555461164, 8777.122287771172, 8594.914050859412, 11332.150088743212, 11651.59219427316, 11659.708507287385, 11783.293002419883], "value": 9159.279830605392, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.5936098850839, 1532.586201725534, 1541.083055581929, 1705.6503416799558, 1831.3681779785977, 8023.83952320954, 8221.09567947526, 8246.505209687422, 8268.627911743972, 8285.17148285172, 8293.253607175353, 8306.210909963558, 8362.91637083629, 8369.958150209255, 8389.035260944993, 2133.1360798876403, 2380.250221180331, 2425.2360506440505, 2439.121916110199, 2456.054419048661, 2280.4754906371463, 2292.793648571628, 2294.1740973249616, 2294.3919861236786, 2298.310506847947, 2330.5571941331177, 2337.5792357375667, 2402.7957623602015, 2406.0, 2406.1458182345277, 2141.753698324689, 2314.583374992509, 2346.0967527502034, 2347.2840783561005, 2355.0932890837066, 2333.661619065243, 2338.0764597983703, 2372.7864492195613, 2376.7742064503846, 2380.73811880693, 8351.498910065415, 8402.873956890651, 8405.411621186458, 8408.747737567883, 8422.831543369159, 5147.742612869341, 5223.4776522347465, 5258.947410525922, 5269.499397557226, 5271.65734227274, 3422.7946323220435, 3484.0767196692896, 3488.389531831919, 3586.4620306953907, 3592.802395868226, 1159.6231224851872, 1160.373398364882, 1162.9592964246294, 1180.8642006169314, 1189.851268591426, 11833.585824496102, 11947.880521194764, 11981.0, 11984.221025633393, 12011.459484323226, 4449.354843547732, 4510.120526497301, 4559.088182363541, 4670.1126785910565, 4672.6261899047995, 9577.042295770367, 9578.281628877861, 9592.040795920351, 9602.807943841084, 9610.66362677303, 5243.895122097537, 5285.207218917193, 5290.603204759658, 5297.311349524537, 5297.947020529822, 4330.913381732347, 4695.882602934886, 4728.1252968201, 4788.545088216614, 4795.424549054136, 4095.2014357200655, 4113.362428823537, 4188.748675079444, 4232.873013809591, 4236.322188449833, 1305.1386085183733, 1320.0891384944357, 1325.0856908732944, 1335.833020872391, 1343.5230493174977, 927.6335847340263, 955.4697143085515, 971.1793534463367, 979.1383582447543, 988.9011098890197, 5606.327240731139, 5695.1741997410145, 5733.709915269031, 5776.68228247442, 5907.7046147692445, 450.8467121178749, 455.9065391594715, 463.9304104384369, 469.2445163287105, 470.25934153708045, 3859.1316953685196, 3860.401637746154, 3878.0, 3923.4703315052675, 3933.4099885017476, 10269.691909242734, 10537.157027437786, 10621.787564248672, 10681.89318106809, 10777.515011824487, 10487.685369438928, 10489.423081730578, 10501.842472362921, 10515.15878729715, 10531.15750739939, 7927.137122776143, 8164.224398682116, 8177.304929081095, 8271.296939760068, 8275.751727448187, 5553.333599968029, 5570.721463926869, 5591.356993945748, 5607.299087614048, 5710.457506536873, 8953.97029341608, 9061.728148155566, 9131.086891310815, 9228.907710922806, 9264.258859291105, 8980.236679882284, 9195.0, 9377.484238366955, 9390.577424015799, 9459.858102128612, 6927.099477067949, 7068.151821781214, 7303.123625165014, 7498.0, 7656.157822639394, 8068.636911338886, 8104.635291411782, 8145.918540814753, 8169.509829410016, 8172.019357677117, 7088.432925365855, 7218.963905180441, 7289.562626242442, 7292.270772922878, 7463.514871533333, 7146.892796608159, 7345.816354591178, 7405.9629701851145, 7492.7752167435065, 7599.392048636207, 6886.931130688829, 6904.0, 6929.7228110875, 6960.930390696029, 6964.199117101598, 4961.231009193581, 4968.503149685147, 4989.0, 5005.0, 5023.949760502494, 4944.604431645532, 4963.354763880672, 4985.501449854985, 5056.0, 5070.340855688737], "value": 4458.862843638151, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.38011109281183, 350.07579988829485, 354.83500172419826, 362.47622185941293, 366.369843868546, 6159.445649891509, 6185.0413185956195, 6278.2779980302275, 6291.779787707431, 6355.841103972403, 6200.720967556459, 6214.223222097238, 6225.906611400821, 6235.282942461618, 6237.220347456568, 4604.3784089147875, 4766.356541866839, 4778.689385189969, 4791.832285869995, 4793.065352256312, 4648.814047438115, 4707.435107787071, 4708.128996135709, 4718.598919091882, 4746.976265118687, 4683.90632187356, 4688.976555117237, 4702.3416721659, 4704.294355846633, 4704.435467743859, 4679.251319788817, 4683.625309975194, 4691.460482044575, 4697.084068606623, 4698.530146985308, 3994.4208089827102, 4082.6733861291027, 4101.507819061731, 4129.731567448136, 4148.937765933513, 5916.822495325147, 5937.168796368512, 5938.376470470625, 5947.762089516415, 5962.910556341659, 5462.044142275086, 5464.316960379952, 5522.144067669517, 5535.501804837584, 5546.168074788774, 6577.802665919982, 6590.736370545221, 6592.04415359775, 6597.340265973412, 6600.867982640369, 4614.238650622643, 4614.284785858197, 4617.746023968681, 4619.145458090264, 4623.791929363187, 6695.732170713166, 6882.277360877136, 6887.449004079662, 6895.827604309882, 6896.034555162231, 4689.390379250675, 4714.339992401066, 4715.504871988461, 4720.645951553647, 4729.739864307496, 4733.810647574127, 4763.190257656207, 4764.094821983812, 4768.403949506312, 4782.402199725035, 5494.478024587658, 5497.175423686479, 5497.587680923947, 5505.944940550623, 5519.31008623922, 6633.7346506140175, 6650.235222949326, 6652.467802575782, 6659.766908158288, 6661.800145995628, 1647.8764092692857, 1660.5433505786004, 1709.2650160431133, 1710.085104469103, 1714.014441696005, 1102.311055590256, 1134.279732369951, 1143.5368675686361, 1144.4392247798519, 1144.5593446523148, 6315.621062736251, 6332.303446620868, 6346.524010699216, 6369.7452101915405, 6372.936270637234, 6833.555818871758, 6926.238113807477, 6936.861262774716, 6943.375096241261, 6965.895511567331, 6512.544121911421, 6520.445762110274, 6527.11883895668, 6527.118838956775, 6529.249136349285, 3693.9076523087138, 3727.142757165813, 3732.925341493155, 3739.0465431315383, 3740.7755534667463, 7054.400375967997, 7067.787966361017, 7072.752453664097, 7075.186353569303, 7078.433725302067, 6953.200381956039, 7130.643467826588, 7133.144022717203, 7139.678714457862, 7141.464390170758, 7097.680604372816, 7125.572465652078, 7133.89299160513, 7145.606991615511, 7151.42788576923, 6962.094927659372, 6973.65131743421, 6980.476464265099, 6981.685824138028, 6986.47601429905, 6861.416779573792, 6863.38229559342, 6864.279250678806, 6870.003849441903, 6877.862442751217, 6914.585124892523, 7111.964440177766, 7117.82205444868, 7122.821929451805, 7127.536710113826, 4564.77176141185, 4615.376924115201, 4617.284320930261, 4628.421447319085, 4630.120277147331, 6955.582665040114, 6960.443164546926, 6971.093757811452, 6975.3024697529845, 6978.511504194657, 6720.495962802712, 6730.966345168439, 6735.292794256533, 6741.460683145238, 6750.35871592198, 6517.152770139852, 6640.203175618956, 6645.6677166140535, 6663.833404164935, 6694.430973367318, 6500.3174666659315, 6526.934730652632, 6582.17722784652, 6602.108715323562, 6612.537122401578, 6741.393274605309, 6751.662416879235, 6752.459803215633, 6769.763058293133, 6773.288804675635, 6580.868382632225, 6596.031785696552, 6606.966965165144, 6613.404793568602, 6616.702248398929], "value": 5015.229835410571, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [848.0840692052584, 858.9699360522382, 888.0542222533006, 888.8666699995003, 903.9401625497688, 14167.504137355194, 15153.924230378847, 15302.693946121071, 15320.310586023628, 15337.616559586017, 12623.495060197603, 14136.151830890154, 14211.431542738279, 14223.502177423792, 14254.643633909158, 875.986860197096, 894.472261365794, 901.5582364641311, 902.8916530016407, 903.7153296711548, 880.5685214245005, 885.1635204731531, 887.9378443508957, 888.4358432395443, 889.3418870036159, 761.9619019049053, 938.0197693410403, 938.4556956964944, 938.5448057692014, 938.6855403439856, 768.4428789127866, 899.5592159841696, 905.3029167541023, 908.7046709819335, 910.3445519226179, 671.5601281160848, 671.5634837355758, 672.64686039829, 672.865426914619, 677.5054210426416, 13403.396847141805, 13404.396802143927, 13451.0, 13458.596242112751, 13544.0, 14205.147691138565, 14898.0, 15220.771688424682, 15268.541943741706, 15302.311395987095, 11922.403879805976, 12122.090843186708, 12182.756344873142, 12204.0, 12230.082743794163, 3988.4017397390626, 4029.174019326031, 4042.6361627453375, 4051.4327994080854, 4097.364908439167, 53942.73028634871, 54661.0, 57929.42070579324, 58358.70820645912, 58406.12390814184, 11575.247608905394, 11609.477573509212, 11707.882921170849, 11798.233114847508, 11890.88109118915, 21250.36248912535, 21373.0, 21375.46561335979, 21378.35864924055, 21416.892915535635, 7934.841303173905, 8413.537255450887, 8648.1784230498, 8664.306855451674, 8791.208791208823, 4724.149653062482, 4983.327250821165, 5058.64589478733, 5095.847124586268, 5185.0, 3437.6906078453057, 3477.0, 3484.4250698634946, 3487.232808782064, 3490.022793617791, 633.2464367402775, 673.3266733266734, 703.6411430170548, 704.1831475488409, 714.7712731925734, 615.6275453350748, 627.7551754815626, 666.4801454865213, 706.6219572528776, 717.9964100179466, 8927.732168034969, 8960.507172105597, 8995.685151019683, 9022.729318120468, 9523.619055237852, 687.7730348984823, 692.5913710910587, 732.0739264829995, 737.4137560639198, 738.737748099417, 4278.886730357193, 4496.527864574173, 4507.188706032945, 4659.464161621389, 4701.811927522861, 56698.43301566932, 57122.42877571171, 57426.0, 57438.138427923615, 57581.42418575844, 55929.0, 56630.716846416326, 57330.426695733346, 57672.42327576754, 57848.42151578514, 51126.0, 51999.74000129975, 52647.0, 52716.736416317675, 52799.99999999923, 8484.61819218149, 8856.557172141238, 8866.73399798007, 8867.600957956778, 9176.311776616647, 38056.42915356327, 38443.231135376576, 39390.0, 39578.802105989285, 39895.60104399035, 49319.26021109758, 49581.0, 49711.25433118579, 50070.0, 50071.74964125156, 12353.62939111828, 12449.25304481734, 12484.750304994031, 12702.30137342455, 12762.106652534234, 11561.826572601249, 12534.811977820158, 12620.621381358575, 12877.613671589866, 13243.66890827737, 12394.938025309815, 12811.87188128144, 13287.335633218494, 13511.256880871646, 13571.253581053137, 13091.0, 13103.344832758514, 13278.269695166473, 13386.665333366744, 13446.46214151423, 11800.468978896142, 12135.271883687006, 12459.065570082099, 12778.68053298675, 12869.485220591072, 10230.386176829414, 10280.588776448858, 10412.271141020055, 10638.361698297816, 10722.249442538947, 10704.571817127227, 10860.456977151269, 10944.616938407118, 11054.502547385226, 11093.334399935708], "value": 6989.387203580495, "unit": "score"}], "name": "dromaeo_css", "value": 7284.306301429016, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 111.0, 114.0, 112.0, 110.0, 104.0, 111.0, 109.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 159.0, 170.0, 127.0, 160.0, 157.0, 128.0, 185.0, 127.0], "value": 148.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 162.0, 160.0, 163.0, 159.0, 160.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 178.0, 73.0, 76.0, 75.0, 77.0, 177.0, 75.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 155.0, 93.0, 92.0, 92.0, 152.0, 91.0, 91.0, 152.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 116.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 54.0, 56.0, 56.0, 54.0, 74.0, 54.0, 53.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 57.0, 57.0, 57.0, 70.0, 58.0, 58.0, 57.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 81.0, 73.0, 74.0, 74.0, 75.0, 81.0, 82.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 113.0, 115.0, 113.0, 113.0, 115.0, 116.0, 112.0, 130.0, 125.0], "value": 117.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 163.0, 163.0, 162.0, 159.0, 160.0, 160.0, 163.0, 158.0, 158.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 66.0, 65.0, 67.0, 64.0, 66.0, 66.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1517.5999999999997, "alertThreshold": 2.0}]} 20:22:21 INFO - Return code: 0 20:22:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:22:21 ERROR - # TBPL SUCCESS # 20:22:21 INFO - Running post-action listener: _resource_record_post_action 20:22:21 INFO - Running post-run listener: _resource_record_post_run 20:22:22 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 266240; Write bytes: 512503808; Read time: 28; Write time: 477912 20:22:22 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 261074944; Read time: 0; Write time: 319500 20:22:22 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250830848; Read time: 28; Write time: 158412 20:22:22 INFO - Running post-run listener: _upload_blobber_files 20:22:22 INFO - Blob upload gear active. 20:22:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:22:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:22:23 INFO - (blobuploader) - INFO - Open directory for files ... 20:22:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:22:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:22:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:22:24 INFO - (blobuploader) - INFO - Done attempting. 20:22:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:22:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:22:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:22:25 INFO - (blobuploader) - INFO - Done attempting. 20:22:25 INFO - (blobuploader) - INFO - Iteration through files over. 20:22:25 INFO - Return code: 0 20:22:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:22:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:22:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fec2fd0c3fc4e5934065a307dfdef1ff97716be9b96b12758f96b68be85e6bf69c058e7f31549c29acbd99023f8750c688ac8c8cb87ccd2fd78d66835ed7cb28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6b73e6a92a3ea96f1ee3648b85fbcb3499a69f9e52a0308cdb940e41cbb7f1176c58fff5a43f29b1042340ced03f8492616ee18dade0394839a78e99a613e2"} 20:22:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:22:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:22:25 INFO - Contents: 20:22:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fec2fd0c3fc4e5934065a307dfdef1ff97716be9b96b12758f96b68be85e6bf69c058e7f31549c29acbd99023f8750c688ac8c8cb87ccd2fd78d66835ed7cb28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6b73e6a92a3ea96f1ee3648b85fbcb3499a69f9e52a0308cdb940e41cbb7f1176c58fff5a43f29b1042340ced03f8492616ee18dade0394839a78e99a613e2"} 20:22:25 INFO - Running post-run listener: copy_logs_to_upload_dir 20:22:25 INFO - Copying logs to upload dir... 20:22:25 INFO - mkdir: /builds/slave/test/build/upload/logs 20:22:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.913084 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-23 20:22:25.073083) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 20:22:25.076891) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fec2fd0c3fc4e5934065a307dfdef1ff97716be9b96b12758f96b68be85e6bf69c058e7f31549c29acbd99023f8750c688ac8c8cb87ccd2fd78d66835ed7cb28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6b73e6a92a3ea96f1ee3648b85fbcb3499a69f9e52a0308cdb940e41cbb7f1176c58fff5a43f29b1042340ced03f8492616ee18dade0394839a78e99a613e2"} build_url:https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011469 build_url: 'https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fec2fd0c3fc4e5934065a307dfdef1ff97716be9b96b12758f96b68be85e6bf69c058e7f31549c29acbd99023f8750c688ac8c8cb87ccd2fd78d66835ed7cb28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6b73e6a92a3ea96f1ee3648b85fbcb3499a69f9e52a0308cdb940e41cbb7f1176c58fff5a43f29b1042340ced03f8492616ee18dade0394839a78e99a613e2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 20:22:25.106543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:22:25.106883) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464058916.880682-1944353345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:22:25.189318) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 20:22:25.190052) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 20:22:25.190770) ========= ========= Total master_lag: 0.19 =========