builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1463841737.72 results: success (0) buildid: 20160521050629 builduid: 89d9cda0ea4e41439844aefcac488dae revision: 110e5a10dce56ed02e43c58c179e6ac101df216d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:17.717999) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:17.718435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:17.718730) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:17.736857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:17.737168) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-21 07:42:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.8M=0s 2016-05-21 07:42:17 (88.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104921 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:17.856918) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:17.857200) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022757 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:17.907535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:17.907953) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 110e5a10dce56ed02e43c58c179e6ac101df216d --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 110e5a10dce56ed02e43c58c179e6ac101df216d --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=337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-21 07:42:18,042 truncating revision to first 12 chars 2016-05-21 07:42:18,042 Setting DEBUG logging. 2016-05-21 07:42:18,042 attempt 1/10 2016-05-21 07:42:18,042 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/110e5a10dce5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-21 07:42:18,317 unpacking tar archive at: mozilla-aurora-110e5a10dce5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544070 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:18.466558) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:18.466840) ========= script_repo_revision: 110e5a10dce56ed02e43c58c179e6ac101df216d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:18.467376) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:18.467699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 07:42:18.483758) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-05-21 07:42:18.484039) ========= /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=337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:42:18 INFO - MultiFileLogger online at 20160521 07:42:18 in /builds/slave/test 07:42:18 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 07:42:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:42:18 INFO - {'append_to_log': False, 07:42:18 INFO - 'base_work_dir': '/builds/slave/test', 07:42:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:42:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:42:18 INFO - 'branch': 'Mozilla-Aurora', 07:42:18 INFO - 'buildbot_json_path': 'buildprops.json', 07:42:18 INFO - 'config_files': ('talos/linux_config.py',), 07:42:18 INFO - 'default_actions': ('clobber', 07:42:18 INFO - 'read-buildbot-config', 07:42:18 INFO - 'download-and-extract', 07:42:18 INFO - 'populate-webroot', 07:42:18 INFO - 'create-virtualenv', 07:42:18 INFO - 'install', 07:42:18 INFO - 'run-tests'), 07:42:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:42:18 INFO - 'download_minidump_stackwalk': True, 07:42:18 INFO - 'download_symbols': 'ondemand', 07:42:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:42:18 INFO - 'tooltool.py': '/tools/tooltool.py', 07:42:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:42:18 INFO - '/tools/misc-python/virtualenv.py')}, 07:42:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:42:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:42:18 INFO - 'installer_path': 'installer.exe', 07:42:18 INFO - 'log_level': 'info', 07:42:18 INFO - 'log_name': 'talos', 07:42:18 INFO - 'log_to_console': True, 07:42:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:42:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:42:18 INFO - 'opt_config_files': (), 07:42:18 INFO - 'pip_index': False, 07:42:18 INFO - 'sps_profile': False, 07:42:18 INFO - 'sps_profile_interval': 0, 07:42:18 INFO - 'suite': 'dromaeojs', 07:42:18 INFO - 'system_bits': '32', 07:42:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:42:18 INFO - 'title': 'talos-linux64-ix-060', 07:42:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:42:18 INFO - 'use_talos_json': True, 07:42:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:42:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:42:18 INFO - 'work_dir': 'build'} 07:42:18 INFO - ##### 07:42:18 INFO - ##### Running clobber step. 07:42:18 INFO - ##### 07:42:18 INFO - Running pre-action listener: _resource_record_pre_action 07:42:18 INFO - Running main action method: clobber 07:42:18 INFO - rmtree: /builds/slave/test/build 07:42:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:42:19 INFO - Running post-action listener: _resource_record_post_action 07:42:19 INFO - ##### 07:42:19 INFO - ##### Running read-buildbot-config step. 07:42:19 INFO - ##### 07:42:19 INFO - Running pre-action listener: _resource_record_pre_action 07:42:19 INFO - Running main action method: read_buildbot_config 07:42:19 INFO - Using buildbot properties: 07:42:19 INFO - { 07:42:19 INFO - "project": "", 07:42:19 INFO - "product": "firefox", 07:42:19 INFO - "script_repo_revision": "production", 07:42:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:42:19 INFO - "repository": "", 07:42:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:42:19 INFO - "buildid": "20160521050629", 07:42:19 INFO - "pgo_build": "True", 07:42:19 INFO - "basedir": "/builds/slave/test", 07:42:19 INFO - "buildnumber": 248, 07:42:19 INFO - "slavename": "talos-linux64-ix-060", 07:42:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:42:19 INFO - "platform": "ubuntu64_hw", 07:42:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:42:19 INFO - "branch": "mozilla-aurora", 07:42:19 INFO - "repo_path": "releases/mozilla-aurora", 07:42:19 INFO - "revision": "110e5a10dce56ed02e43c58c179e6ac101df216d", 07:42:19 INFO - "stage_platform": "linux64-pgo", 07:42:19 INFO - "builduid": "89d9cda0ea4e41439844aefcac488dae", 07:42:19 INFO - "slavebuilddir": "test" 07:42:19 INFO - } 07:42:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 07:42:19 INFO - Running post-action listener: _resource_record_post_action 07:42:19 INFO - ##### 07:42:19 INFO - ##### Running download-and-extract step. 07:42:19 INFO - ##### 07:42:19 INFO - Running pre-action listener: _resource_record_pre_action 07:42:19 INFO - Running main action method: download_and_extract 07:42:19 INFO - mkdir: /builds/slave/test/build/tests 07:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:19 INFO - https://queue.taskcluster.net/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:42:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:42:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:42:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/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 07:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/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 07:42:21 INFO - Downloaded 1361 bytes. 07:42:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:42:21 INFO - Using the following test package requirements: 07:42:21 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:42:21 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:42:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:42:21 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:42:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:42:21 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:42:21 INFO - u'jsshell-linux-x86_64.zip'], 07:42:21 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:42:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:42:21 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:42:21 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:42:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:42:21 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:42:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:42:21 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:42:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:42:21 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:42:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:42:21 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:42: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')]} 07:42:21 INFO - https://queue.taskcluster.net/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:42:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:42:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:42:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/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 07:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/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 07:42:22 INFO - Downloaded 23813419 bytes. 07:42:22 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'] 07:42:22 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 07:42:24 INFO - Return code: 0 07:42:24 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 07:42: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')]} 07:42:24 INFO - https://queue.taskcluster.net/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:42:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:42:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:42:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/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 07:42:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/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 07:42:25 INFO - Downloaded 23813419 bytes. 07:42:25 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'] 07:42:25 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 07:42:27 INFO - Return code: 0 07:42: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')]} 07:42:27 INFO - https://queue.taskcluster.net/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:42:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:42:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:42:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/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 07:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/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 07:42:28 INFO - Downloaded 10840145 bytes. 07:42:28 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'] 07:42:28 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 07:42:28 INFO - Return code: 0 07:42: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')]} 07:42:28 INFO - https://queue.taskcluster.net/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:42:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:42:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:42:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/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 07:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/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 07:42:28 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:42:28 INFO - Running command: ['nslookup', 'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 07:42:28 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 07:42:28 INFO - Server: 10.26.75.40 07:42:28 INFO - Address: 10.26.75.40#53 07:42:28 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 07:42:28 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 07:42:28 INFO - Address: 10.26.48.46 07:42:28 INFO - Return code: 0 07:42:28 INFO - retry: attempt #1 caught exception: 07:42:28 INFO - retry: Failed, sleeping 30 seconds before retrying 07:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbY4bj4ORxuLcaA000J-tw/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 #2 07:43:01 INFO - Downloaded 62733200 bytes. 07:43:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:43:01 INFO - mkdir: /builds/slave/test/properties 07:43:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:43:01 INFO - Writing to file /builds/slave/test/properties/build_url 07:43:01 INFO - Contents: 07:43:01 INFO - build_url:https://queue.taskcluster.net/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:43:01 INFO - Running post-action listener: _resource_record_post_action 07:43:01 INFO - Running post-action listener: set_extra_try_arguments 07:43:01 INFO - ##### 07:43:01 INFO - ##### Running populate-webroot step. 07:43:01 INFO - ##### 07:43:01 INFO - Running pre-action listener: _resource_record_pre_action 07:43:01 INFO - Running main action method: populate_webroot 07:43:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:43:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:43:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:43:01 INFO - '--tppagecycles', 07:43:01 INFO - '7'], 07:43:01 INFO - 'tests': ['tsvgm']}}, 07:43:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:43:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:43:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:43:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:43:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:43:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:43:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:01 INFO - 'talos_options': ['--disable-e10s'], 07:43:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:01 INFO - 'talos_options': ['--disable-e10s'], 07:43:01 INFO - 'tests': ['damp', 'tps']}, 07:43:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:01 INFO - 'tests': ['damp', 'tps']}, 07:43:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:43:01 INFO - 'tests': ['dromaeo_dom']}, 07:43:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:43:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:43:01 INFO - 'tests': ['a11yr', 07:43:01 INFO - 'ts_paint', 07:43:01 INFO - 'tpaint', 07:43:01 INFO - 'sessionrestore', 07:43:01 INFO - 'sessionrestore_no_auto_restore', 07:43:01 INFO - 'tabpaint']}, 07:43:01 INFO - 'other-e10s': {'tests': ['a11yr', 07:43:01 INFO - 'ts_paint', 07:43:01 INFO - 'tpaint', 07:43:01 INFO - 'sessionrestore', 07:43:01 INFO - 'sessionrestore_no_auto_restore', 07:43:01 INFO - 'tabpaint']}, 07:43:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:43:01 INFO - 'ts_paint', 07:43:01 INFO - 'tpaint', 07:43:01 INFO - 'sessionrestore', 07:43:01 INFO - 'sessionrestore_no_auto_restore', 07:43:01 INFO - 'tabpaint']}, 07:43:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:43:01 INFO - 'ts_paint', 07:43:01 INFO - 'tpaint', 07:43:01 INFO - 'sessionrestore', 07:43:01 INFO - 'sessionrestore_no_auto_restore', 07:43:01 INFO - 'tabpaint']}, 07:43:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:43:01 INFO - 'tests': ['a11yr', 07:43:01 INFO - 'ts_paint', 07:43:01 INFO - 'tpaint', 07:43:01 INFO - 'sessionrestore', 07:43:01 INFO - 'sessionrestore_no_auto_restore', 07:43:01 INFO - 'tabpaint']}, 07:43:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:43:01 INFO - 'tests': ['a11yr', 07:43:01 INFO - 'ts_paint', 07:43:01 INFO - 'tpaint', 07:43:01 INFO - 'sessionrestore', 07:43:01 INFO - 'sessionrestore_no_auto_restore', 07:43:01 INFO - 'tabpaint']}, 07:43:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:43:01 INFO - 'tests': ['tsvgx', 07:43:01 INFO - 'tsvgr_opacity', 07:43:01 INFO - 'tart', 07:43:01 INFO - 'tscrollx', 07:43:01 INFO - 'cart']}, 07:43:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:43:01 INFO - 'tsvgr_opacity', 07:43:01 INFO - 'tart', 07:43:01 INFO - 'tscrollx', 07:43:01 INFO - 'cart']}, 07:43:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:01 INFO - 'talos_options': ['--disable-e10s'], 07:43:01 INFO - 'tests': ['tp5o']}, 07:43:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:01 INFO - 'tests': ['tp5o']}, 07:43:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:01 INFO - 'talos_options': ['--disable-e10s', 07:43:01 INFO - '--xperf_path', 07:43:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:01 INFO - 'tests': ['tp5n']}, 07:43:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:01 INFO - 'talos_options': ['--xperf_path', 07:43:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:01 INFO - 'tests': ['tp5n']}}, 07:43:01 INFO - 'talos.zip': {'path': '', 07:43:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:43:01 INFO - Running post-action listener: _resource_record_post_action 07:43:01 INFO - ##### 07:43:01 INFO - ##### Running create-virtualenv step. 07:43:02 INFO - ##### 07:43:02 INFO - Running pre-action listener: _resource_record_pre_action 07:43:02 INFO - Running main action method: create_virtualenv 07:43:02 INFO - Creating virtualenv /builds/slave/test/build/venv 07:43:02 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 07:43:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:43:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:43:02 INFO - Using real prefix '/usr' 07:43:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:43:02 INFO - Installing distribute.............................................................................................................................................................................................done. 07:43:04 INFO - Installing pip.................done. 07:43:04 INFO - Return code: 0 07:43:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:43:04 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')]} 07:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:04 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')]} 07:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:04 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 0x7f375839bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf527d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1640>, '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 0xfe2540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe29d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', '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 07:43:04 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 07:43:04 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 07:43:04 INFO - Using env: {'DISPLAY': ':0', 07:43:04 INFO - 'HOME': '/home/cltbld', 07:43:04 INFO - 'LANG': 'en_US.UTF-8', 07:43:04 INFO - 'LANGUAGE': 'en_US:en', 07:43:04 INFO - 'LOGNAME': 'cltbld', 07:43:04 INFO - 'MAIL': '/var/mail/cltbld', 07:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:04 INFO - 'MOZ_NO_REMOTE': '1', 07:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:04 INFO - 'NO_EM_RESTART': '1', 07:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:04 INFO - 'PWD': '/builds/slave/test', 07:43:04 INFO - 'SHELL': '/bin/bash', 07:43:04 INFO - 'SHLVL': '1', 07:43:04 INFO - 'TERM': 'linux', 07:43:04 INFO - 'TMOUT': '86400', 07:43:04 INFO - 'USER': 'cltbld', 07:43:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', 07:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:04 INFO - '_': '/tools/buildbot/bin/python'} 07:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:04 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 07:43:04 INFO - Cleaning up... 07:43:04 INFO - Return code: 0 07:43:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:43:04 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')]} 07:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:04 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')]} 07:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:04 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 0x7f375839bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf527d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1640>, '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 0xfe2540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe29d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', '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 07:43:04 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 07:43:04 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 07:43:04 INFO - Using env: {'DISPLAY': ':0', 07:43:04 INFO - 'HOME': '/home/cltbld', 07:43:04 INFO - 'LANG': 'en_US.UTF-8', 07:43:04 INFO - 'LANGUAGE': 'en_US:en', 07:43:04 INFO - 'LOGNAME': 'cltbld', 07:43:04 INFO - 'MAIL': '/var/mail/cltbld', 07:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:04 INFO - 'MOZ_NO_REMOTE': '1', 07:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:04 INFO - 'NO_EM_RESTART': '1', 07:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:04 INFO - 'PWD': '/builds/slave/test', 07:43:04 INFO - 'SHELL': '/bin/bash', 07:43:04 INFO - 'SHLVL': '1', 07:43:04 INFO - 'TERM': 'linux', 07:43:04 INFO - 'TMOUT': '86400', 07:43:04 INFO - 'USER': 'cltbld', 07:43:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', 07:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:04 INFO - '_': '/tools/buildbot/bin/python'} 07:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:05 INFO - Downloading/unpacking psutil>=0.7.1 07:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:43:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:43:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:43:07 INFO - Installing collected packages: psutil 07:43:07 INFO - Running setup.py install for psutil 07:43:07 INFO - building 'psutil._psutil_linux' extension 07:43:07 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 07:43:07 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 07:43:07 INFO - building 'psutil._psutil_posix' extension 07:43:07 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 07:43:07 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 07:43:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:43:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:43:07 INFO - Successfully installed psutil 07:43:07 INFO - Cleaning up... 07:43:07 INFO - Return code: 0 07:43:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:43: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')]} 07:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43: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')]} 07:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:07 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 0x7f375839bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf527d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1640>, '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 0xfe2540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe29d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', '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 07:43:07 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 07:43:07 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 07:43:07 INFO - Using env: {'DISPLAY': ':0', 07:43:07 INFO - 'HOME': '/home/cltbld', 07:43:07 INFO - 'LANG': 'en_US.UTF-8', 07:43:07 INFO - 'LANGUAGE': 'en_US:en', 07:43:07 INFO - 'LOGNAME': 'cltbld', 07:43:07 INFO - 'MAIL': '/var/mail/cltbld', 07:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:07 INFO - 'MOZ_NO_REMOTE': '1', 07:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:07 INFO - 'NO_EM_RESTART': '1', 07:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:07 INFO - 'PWD': '/builds/slave/test', 07:43:07 INFO - 'SHELL': '/bin/bash', 07:43:07 INFO - 'SHLVL': '1', 07:43:07 INFO - 'TERM': 'linux', 07:43:07 INFO - 'TMOUT': '86400', 07:43:07 INFO - 'USER': 'cltbld', 07:43:07 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', 07:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:07 INFO - '_': '/tools/buildbot/bin/python'} 07:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:43:07 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 07:43:07 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 07:43:07 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 07:43:07 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 07:43:07 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 07:43:07 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 07:43:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:43:09 INFO - Installing collected packages: mozsystemmonitor 07:43:09 INFO - Running setup.py install for mozsystemmonitor 07:43:09 INFO - Successfully installed mozsystemmonitor 07:43:09 INFO - Cleaning up... 07:43:09 INFO - Return code: 0 07:43:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:09 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 0x7f375839bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf527d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1640>, '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 0xfe2540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe29d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', '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 07:43:09 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 07:43:09 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 07:43:09 INFO - Using env: {'DISPLAY': ':0', 07:43:09 INFO - 'HOME': '/home/cltbld', 07:43:09 INFO - 'LANG': 'en_US.UTF-8', 07:43:09 INFO - 'LANGUAGE': 'en_US:en', 07:43:09 INFO - 'LOGNAME': 'cltbld', 07:43:09 INFO - 'MAIL': '/var/mail/cltbld', 07:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:09 INFO - 'MOZ_NO_REMOTE': '1', 07:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:09 INFO - 'NO_EM_RESTART': '1', 07:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:09 INFO - 'PWD': '/builds/slave/test', 07:43:09 INFO - 'SHELL': '/bin/bash', 07:43:09 INFO - 'SHLVL': '1', 07:43:09 INFO - 'TERM': 'linux', 07:43:09 INFO - 'TMOUT': '86400', 07:43:09 INFO - 'USER': 'cltbld', 07:43:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', 07:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:09 INFO - '_': '/tools/buildbot/bin/python'} 07:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:10 INFO - Downloading/unpacking blobuploader==1.2.4 07:43:10 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 07:43:10 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 07:43:10 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 07:43:10 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 07:43:10 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 07:43:10 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 07:43:11 INFO - Downloading blobuploader-1.2.4.tar.gz 07:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:43:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:43:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:12 INFO - Downloading docopt-0.6.1.tar.gz 07:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:43:12 INFO - Installing collected packages: blobuploader, requests, docopt 07:43:12 INFO - Running setup.py install for blobuploader 07:43:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:43:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:43:12 INFO - Running setup.py install for requests 07:43:13 INFO - Running setup.py install for docopt 07:43:13 INFO - Successfully installed blobuploader requests docopt 07:43:13 INFO - Cleaning up... 07:43:13 INFO - Return code: 0 07:43:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:13 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')]} 07:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:13 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')]} 07:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:13 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 0x7f375839bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf527d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1640>, '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 0xfe2540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe29d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', '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 07:43:13 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 07:43:13 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 07:43:13 INFO - Using env: {'DISPLAY': ':0', 07:43:13 INFO - 'HOME': '/home/cltbld', 07:43:13 INFO - 'LANG': 'en_US.UTF-8', 07:43:13 INFO - 'LANGUAGE': 'en_US:en', 07:43:13 INFO - 'LOGNAME': 'cltbld', 07:43:13 INFO - 'MAIL': '/var/mail/cltbld', 07:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:13 INFO - 'MOZ_NO_REMOTE': '1', 07:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:13 INFO - 'NO_EM_RESTART': '1', 07:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:13 INFO - 'PWD': '/builds/slave/test', 07:43:13 INFO - 'SHELL': '/bin/bash', 07:43:13 INFO - 'SHLVL': '1', 07:43:13 INFO - 'TERM': 'linux', 07:43:13 INFO - 'TMOUT': '86400', 07:43:13 INFO - 'USER': 'cltbld', 07:43:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', 07:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:13 INFO - '_': '/tools/buildbot/bin/python'} 07:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:13 INFO - Running setup.py (path:/tmp/pip-g33H2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:13 INFO - Running setup.py (path:/tmp/pip-VU4Vfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:13 INFO - Running setup.py (path:/tmp/pip-iKEKpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:13 INFO - Running setup.py (path:/tmp/pip-DXHKus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:13 INFO - Running setup.py (path:/tmp/pip-2Hp45v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:13 INFO - Running setup.py (path:/tmp/pip-o4KGgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:13 INFO - Running setup.py (path:/tmp/pip-rI8yyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:14 INFO - Running setup.py (path:/tmp/pip-nFSu2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:14 INFO - Running setup.py (path:/tmp/pip-lDJ_d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:14 INFO - Running setup.py (path:/tmp/pip-osHVDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:14 INFO - Running setup.py (path:/tmp/pip-mAG4C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:14 INFO - Running setup.py (path:/tmp/pip-5STZqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:14 INFO - Running setup.py (path:/tmp/pip-p9j18W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:14 INFO - Running setup.py (path:/tmp/pip-hXkbhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:14 INFO - Running setup.py (path:/tmp/pip-79MDLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:14 INFO - Running setup.py (path:/tmp/pip-HADPo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:14 INFO - Running setup.py (path:/tmp/pip-vdX0XQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:43:14 INFO - Running setup.py install for manifestparser 07:43:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:43:14 INFO - Running setup.py install for mozcrash 07:43:14 INFO - Running setup.py install for mozdebug 07:43:15 INFO - Running setup.py install for mozdevice 07:43:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:43:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:43:15 INFO - Running setup.py install for mozfile 07:43:15 INFO - Running setup.py install for mozhttpd 07:43:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:43:15 INFO - Running setup.py install for mozinfo 07:43:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:43:15 INFO - Running setup.py install for mozInstall 07:43:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:43:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:43:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:43:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:43:15 INFO - Running setup.py install for mozleak 07:43:15 INFO - Running setup.py install for mozlog 07:43:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:43:15 INFO - Running setup.py install for moznetwork 07:43:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:43:15 INFO - Running setup.py install for mozprocess 07:43:15 INFO - Running setup.py install for mozprofile 07:43:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:43:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:43:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:43:16 INFO - Running setup.py install for mozrunner 07:43:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:43:16 INFO - Running setup.py install for mozscreenshot 07:43:16 INFO - Running setup.py install for moztest 07:43:16 INFO - Running setup.py install for mozversion 07:43:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:43:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:43:16 INFO - Cleaning up... 07:43:16 INFO - Return code: 0 07:43:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:16 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 0x7f375839bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf527d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1640>, '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 0xfe2540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe29d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', '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 07:43:16 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 07:43:16 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 07:43:16 INFO - Using env: {'DISPLAY': ':0', 07:43:16 INFO - 'HOME': '/home/cltbld', 07:43:16 INFO - 'LANG': 'en_US.UTF-8', 07:43:16 INFO - 'LANGUAGE': 'en_US:en', 07:43:16 INFO - 'LOGNAME': 'cltbld', 07:43:16 INFO - 'MAIL': '/var/mail/cltbld', 07:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:16 INFO - 'MOZ_NO_REMOTE': '1', 07:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:16 INFO - 'NO_EM_RESTART': '1', 07:43:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:16 INFO - 'PWD': '/builds/slave/test', 07:43:16 INFO - 'SHELL': '/bin/bash', 07:43:16 INFO - 'SHLVL': '1', 07:43:16 INFO - 'TERM': 'linux', 07:43:16 INFO - 'TMOUT': '86400', 07:43:16 INFO - 'USER': 'cltbld', 07:43:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', 07:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:16 INFO - '_': '/tools/buildbot/bin/python'} 07:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:16 INFO - Running setup.py (path:/tmp/pip-lBQOI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:16 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)) 07:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:16 INFO - Running setup.py (path:/tmp/pip-YXYETd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:16 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)) 07:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:16 INFO - Running setup.py (path:/tmp/pip-x6gWHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:16 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)) 07:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:16 INFO - Running setup.py (path:/tmp/pip-B3UTe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:17 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)) 07:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:17 INFO - Running setup.py (path:/tmp/pip-QOLzr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:17 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)) 07:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:17 INFO - Running setup.py (path:/tmp/pip-xl2qk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:17 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)) 07:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:17 INFO - Running setup.py (path:/tmp/pip-OYwc32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:17 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)) 07:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:17 INFO - Running setup.py (path:/tmp/pip-wqe5mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:17 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)) 07:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:17 INFO - Running setup.py (path:/tmp/pip-zjWMIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:17 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)) 07:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:17 INFO - Running setup.py (path:/tmp/pip-L2OZHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:17 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)) 07:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:17 INFO - Running setup.py (path:/tmp/pip-fwhCRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:17 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)) 07:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:17 INFO - Running setup.py (path:/tmp/pip-cEjDO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:17 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)) 07:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:17 INFO - Running setup.py (path:/tmp/pip-8ICEgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:17 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)) 07:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:17 INFO - Running setup.py (path:/tmp/pip-CLUPbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:17 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)) 07:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:17 INFO - Running setup.py (path:/tmp/pip-8Fgmwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:17 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)) 07:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:17 INFO - Running setup.py (path:/tmp/pip-xenSfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:17 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)) 07:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:17 INFO - Running setup.py (path:/tmp/pip-bVcdp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:17 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)) 07:43:17 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)) 07:43:17 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)) 07:43:17 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)) 07:43:17 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)) 07:43:17 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)) 07:43:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:43: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 07:43: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 07:43: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 07:43: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 07:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:19 INFO - Downloading blessings-1.6.tar.gz 07:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:43:19 INFO - Installing collected packages: blessings 07:43:19 INFO - Running setup.py install for blessings 07:43:20 INFO - Successfully installed blessings 07:43:20 INFO - Cleaning up... 07:43:20 INFO - Return code: 0 07:43:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:43:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:20 INFO - Reading from file tmpfile_stdout 07:43:20 INFO - Current package versions: 07:43:20 INFO - argparse == 1.2.1 07:43:20 INFO - blessings == 1.6 07:43:20 INFO - blobuploader == 1.2.4 07:43:20 INFO - docopt == 0.6.1 07:43:20 INFO - manifestparser == 1.1 07:43:20 INFO - mozInstall == 1.12 07:43:20 INFO - mozcrash == 0.17 07:43:20 INFO - mozdebug == 0.1 07:43:20 INFO - mozdevice == 0.48 07:43:20 INFO - mozfile == 1.2 07:43:20 INFO - mozhttpd == 0.7 07:43:20 INFO - mozinfo == 0.9 07:43:20 INFO - mozleak == 0.1 07:43:20 INFO - mozlog == 3.1 07:43:20 INFO - moznetwork == 0.27 07:43:20 INFO - mozprocess == 0.22 07:43:20 INFO - mozprofile == 0.28 07:43:20 INFO - mozrunner == 6.11 07:43:20 INFO - mozscreenshot == 0.1 07:43:20 INFO - mozsystemmonitor == 0.0 07:43:20 INFO - moztest == 0.7 07:43:20 INFO - mozversion == 1.4 07:43:20 INFO - psutil == 3.1.1 07:43:20 INFO - requests == 1.2.3 07:43:20 INFO - wsgiref == 0.1.2 07:43:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:20 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 0x7f375839bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf527d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1640>, '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 0xfe2540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe29d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', '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 07:43:20 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 07:43:20 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 07:43:20 INFO - Using env: {'DISPLAY': ':0', 07:43:20 INFO - 'HOME': '/home/cltbld', 07:43:20 INFO - 'LANG': 'en_US.UTF-8', 07:43:20 INFO - 'LANGUAGE': 'en_US:en', 07:43:20 INFO - 'LOGNAME': 'cltbld', 07:43:20 INFO - 'MAIL': '/var/mail/cltbld', 07:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:20 INFO - 'MOZ_NO_REMOTE': '1', 07:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:20 INFO - 'NO_EM_RESTART': '1', 07:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:20 INFO - 'PWD': '/builds/slave/test', 07:43:20 INFO - 'SHELL': '/bin/bash', 07:43:20 INFO - 'SHLVL': '1', 07:43:20 INFO - 'TERM': 'linux', 07:43:20 INFO - 'TMOUT': '86400', 07:43:20 INFO - 'USER': 'cltbld', 07:43:20 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', 07:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:20 INFO - '_': '/tools/buildbot/bin/python'} 07:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:20 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)) 07:43:20 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)) 07:43:20 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)) 07:43:20 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)) 07:43:20 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)) 07:43:20 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)) 07:43:20 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)) 07:43:20 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)) 07:43:20 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)) 07:43:20 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)) 07:43:20 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)) 07:43:20 INFO - Cleaning up... 07:43:20 INFO - Return code: 0 07:43:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f375839bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf527d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1640>, '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 0xfe2540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe29d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', '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 07:43:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:43:20 INFO - Using env: {'DISPLAY': ':0', 07:43:20 INFO - 'HOME': '/home/cltbld', 07:43:20 INFO - 'LANG': 'en_US.UTF-8', 07:43:20 INFO - 'LANGUAGE': 'en_US:en', 07:43:20 INFO - 'LOGNAME': 'cltbld', 07:43:20 INFO - 'MAIL': '/var/mail/cltbld', 07:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:20 INFO - 'MOZ_NO_REMOTE': '1', 07:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:20 INFO - 'NO_EM_RESTART': '1', 07:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:20 INFO - 'PWD': '/builds/slave/test', 07:43:20 INFO - 'SHELL': '/bin/bash', 07:43:20 INFO - 'SHLVL': '1', 07:43:20 INFO - 'TERM': 'linux', 07:43:20 INFO - 'TMOUT': '86400', 07:43:20 INFO - 'USER': 'cltbld', 07:43:20 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', 07:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:20 INFO - '_': '/tools/buildbot/bin/python'} 07:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:20 INFO - Downloading/unpacking jsonschema 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:43:22 INFO - Downloading/unpacking functools32 (from jsonschema) 07:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:22 INFO - Downloading functools32-3.2.3-2.tar.gz 07:43:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:43:22 INFO - warning: no files found matching '*.txt' 07:43:22 INFO - no previously-included directories found matching 'build' 07:43:22 INFO - no previously-included directories found matching 'dist' 07:43:22 INFO - no previously-included directories found matching '.git*' 07:43:22 INFO - Installing collected packages: jsonschema, functools32 07:43:22 INFO - Running setup.py install for functools32 07:43:23 INFO - warning: no files found matching '*.txt' 07:43:23 INFO - no previously-included directories found matching 'build' 07:43:23 INFO - no previously-included directories found matching 'dist' 07:43:23 INFO - no previously-included directories found matching '.git*' 07:43:23 INFO - Successfully installed jsonschema functools32 07:43:23 INFO - Cleaning up... 07:43:23 INFO - Return code: 0 07:43:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:43:23 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')]} 07:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:23 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')]} 07:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:23 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 0x7f375839bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf527d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1640>, '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 0xfe2540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe29d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', '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 07:43:23 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 07:43:23 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 07:43:23 INFO - Using env: {'DISPLAY': ':0', 07:43:23 INFO - 'HOME': '/home/cltbld', 07:43:23 INFO - 'LANG': 'en_US.UTF-8', 07:43:23 INFO - 'LANGUAGE': 'en_US:en', 07:43:23 INFO - 'LOGNAME': 'cltbld', 07:43:23 INFO - 'MAIL': '/var/mail/cltbld', 07:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:23 INFO - 'MOZ_NO_REMOTE': '1', 07:43:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:23 INFO - 'NO_EM_RESTART': '1', 07:43:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:23 INFO - 'PWD': '/builds/slave/test', 07:43:23 INFO - 'SHELL': '/bin/bash', 07:43:23 INFO - 'SHLVL': '1', 07:43:23 INFO - 'TERM': 'linux', 07:43:23 INFO - 'TMOUT': '86400', 07:43:23 INFO - 'USER': 'cltbld', 07:43:23 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', 07:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:23 INFO - '_': '/tools/buildbot/bin/python'} 07:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:23 INFO - Downloading/unpacking flake8 07:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:43:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:43:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:43:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:43:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:43:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:43:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:43:26 INFO - no previously-included directories found matching 'docs/_build' 07:43:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:43:26 INFO - Running setup.py install for pep8 07:43:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:43:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:43:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:43:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:43:26 INFO - no previously-included directories found matching 'docs/_build' 07:43:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:43:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:43:26 INFO - Cleaning up... 07:43:26 INFO - Return code: 0 07:43:26 INFO - Running post-action listener: _resource_record_post_action 07:43:26 INFO - Running post-action listener: _start_resource_monitoring 07:43:26 INFO - Starting resource monitoring. 07:43:26 INFO - ##### 07:43:26 INFO - ##### Running install step. 07:43:26 INFO - ##### 07:43:26 INFO - Running pre-action listener: _resource_record_pre_action 07:43:26 INFO - Running main action method: install 07:43:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:26 INFO - Reading from file tmpfile_stdout 07:43:26 INFO - Detecting whether we're running mozinstall >=1.0... 07:43:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:43:26 INFO - Reading from file tmpfile_stdout 07:43:26 INFO - Output received: 07:43:26 INFO - Usage: mozinstall [options] installer 07:43:26 INFO - Options: 07:43:26 INFO - -h, --help show this help message and exit 07:43:26 INFO - -d DEST, --destination=DEST 07:43:26 INFO - Directory to install application into. [default: 07:43:26 INFO - "/builds/slave/test"] 07:43:26 INFO - --app=APP Application being installed. [default: firefox] 07:43:26 INFO - mkdir: /builds/slave/test/build/application 07:43:26 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'] 07:43:26 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 07:43:42 INFO - Reading from file tmpfile_stdout 07:43:42 INFO - Output received: 07:43:42 INFO - /builds/slave/test/build/application/firefox/firefox 07:43:42 INFO - Running post-action listener: _resource_record_post_action 07:43:42 INFO - ##### 07:43:42 INFO - ##### Running run-tests step. 07:43:42 INFO - ##### 07:43:42 INFO - Running pre-action listener: _resource_record_pre_action 07:43:42 INFO - Running main action method: run_tests 07:43:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:43:42 INFO - Python 2.7.3 07:43:42 INFO - Return code: 0 07:43:42 INFO - grabbing minidump binary from tooltool 07:43:42 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')]} 07:43:42 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 0xfe1640>, '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 0xfe2540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe29d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:43:42 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 07:43:42 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 07:43:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:43:42 INFO - Return code: 0 07:43:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:43:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:43:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:43:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:43:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:43:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:43:43 INFO - Return code: 0 07:43:43 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/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 07:43:43 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/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 07:43:43 INFO - Using env: {'DISPLAY': ':0', 07:43:43 INFO - 'HOME': '/home/cltbld', 07:43:43 INFO - 'LANG': 'en_US.UTF-8', 07:43:43 INFO - 'LANGUAGE': 'en_US:en', 07:43:43 INFO - 'LOGNAME': 'cltbld', 07:43:43 INFO - 'MAIL': '/var/mail/cltbld', 07:43:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:43:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:43 INFO - 'MOZ_NO_REMOTE': '1', 07:43:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:43 INFO - 'NO_EM_RESTART': '1', 07:43:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:43 INFO - 'PWD': '/builds/slave/test', 07:43:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:43:43 INFO - 'SHELL': '/bin/bash', 07:43:43 INFO - 'SHLVL': '1', 07:43:43 INFO - 'TERM': 'linux', 07:43:43 INFO - 'TMOUT': '86400', 07:43:43 INFO - 'USER': 'cltbld', 07:43:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640', 07:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:43 INFO - '_': '/tools/buildbot/bin/python'} 07:43:43 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/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 07:43:43 INFO - mozversion application_buildid: 20160521050629 07:43:43 INFO - mozversion application_changeset: 110e5a10dce56ed02e43c58c179e6ac101df216d 07:43:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:43:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:43:43 INFO - mozversion application_name: Firefox 07:43:43 INFO - mozversion application_remotingname: firefox-dev 07:43:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:43:43 INFO - mozversion application_vendor: Mozilla 07:43:43 INFO - mozversion application_version: 48.0a2 07:43:43 INFO - mozversion platform_buildid: 20160521050629 07:43:43 INFO - mozversion platform_changeset: 110e5a10dce56ed02e43c58c179e6ac101df216d 07:43:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:43:43 INFO - mozversion platform_version: 48.0a2 07:43:43 INFO - using testdate: 1463841823 07:43:43 INFO - actual date: 1463841823 07:43:43 INFO - starting webserver on 'localhost:39236' 07:43:43 INFO - SUITE-START | Running 2 tests 07:43:43 INFO - TEST-START | dromaeo_css 07:43:43 INFO - operating with platform_type : linux_ 07:43:43 INFO - Initialising browser for dromaeo_css test... 07:43:43 INFO - TEST-INFO | started process 11618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpesBAEv/profile http://localhost:39236/getInfo.html) 07:43:47 INFO - PROCESS | 11618 | __metrics Screen width/height:1600/1200 07:43:47 INFO - PROCESS | 11618 | colorDepth:24 07:43:47 INFO - PROCESS | 11618 | Browser inner width/height: 1024/697 07:43:47 INFO - PROCESS | 11618 | __metrics 07:43:48 ERROR - PROCESS | 11618 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:43:49 INFO - TEST-INFO | 11618: exit 0 07:43:49 INFO - Browser initialized. 07:43:49 INFO - Running cycle 1/1 for dromaeo_css test... 07:43:49 INFO - TEST-INFO | started process 11707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpesBAEv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:01 INFO - PROCESS | 11707 | RSS: Main: 142266368 07:44:01 INFO - PROCESS | 11707 | 07:44:52 INFO - PROCESS | 11707 | 1463841892816 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] 07:46:59 INFO - PROCESS | 11707 | Cycle 1(1): loaded http://localhost:39236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39236/tests/dromaeo/cssquery-ext.html) 07:47:00 INFO - PROCESS | 11707 | RSS: Main: 249626624 07:47:00 INFO - PROCESS | 11707 | 07:50:02 INFO - PROCESS | 11707 | Cycle 1(1): loaded http://localhost:39236/tests/dromaeo/cssquery-ext.html (next: http://localhost:39236/tests/dromaeo/cssquery-jquery.html) 07:50:03 INFO - PROCESS | 11707 | RSS: Main: 230293504 07:50:03 INFO - PROCESS | 11707 | 07:53:05 INFO - PROCESS | 11707 | Cycle 1(1): loaded http://localhost:39236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39236/tests/dromaeo/cssquery-mootools.html) 07:53:05 INFO - PROCESS | 11707 | RSS: Main: 221843456 07:53:05 INFO - PROCESS | 11707 | 07:56:07 INFO - PROCESS | 11707 | Cycle 1(1): loaded http://localhost:39236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39236/tests/dromaeo/cssquery-prototype.html) 07:56:08 INFO - PROCESS | 11707 | RSS: Main: 218349568 07:56:08 INFO - PROCESS | 11707 | 07:59:10 INFO - PROCESS | 11707 | Cycle 1(1): loaded http://localhost:39236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39236/tests/dromaeo/cssquery-yui.html) 07:59:11 INFO - PROCESS | 11707 | RSS: Main: 184913920 07:59:11 INFO - PROCESS | 11707 | 08:02:13 INFO - PROCESS | 11707 | Cycle 1(1): loaded http://localhost:39236/tests/dromaeo/cssquery-yui.html (next: http://localhost:39236/tests/dromaeo/cssquery-dojo.html) 08:02:14 INFO - PROCESS | 11707 | RSS: Main: 248631296 08:02:14 INFO - PROCESS | 11707 | 08:02:14 INFO - PROCESS | 11707 | __start_tp_report 08:02:14 INFO - PROCESS | 11707 | _x_x_mozilla_page_load 08:02:14 INFO - PROCESS | 11707 | _x_x_mozilla_page_load_details 08:02:14 INFO - PROCESS | 11707 | |i|pagename|runs| 08:02:14 INFO - PROCESS | 11707 | |0;dojo.html;3322.3853587086387;3364.5457863188476;3381.915452113697;3392.236746731984;3409.9318013639727;5528.419515950827;5531.280933478647;5538.113901775717;5541.501264886159;5547.278853749007;5551.555875529958;5567.805126820562;5571.275734154565;5584.9162262566;5624.9875022495935;4955.628327875405;4978.975105124469;5075;5120;5148.716820574867;4937.308776771255;5002.599792016648;5008.574271186953;5011.724355160465;5050.46970068143;5042.47054059324;5053.949460505403;5075.923861142086;5077.720725360104;5078.238264260372;5072.568831649332;5074.619403544749;5082.517160869711;5097.6941383517105;5106.029854327666;4926.827561035347;4945.134601444769;4983.327250821165;5007.899842003139;5020.497950204986;5449.427810079964;5452.454754524555;5455.290812194429;5462.126059830448;5485.149801780731;5881.088431293157;5925.4370834770625;5929.258842644669;5931.881362372728;5945.910811337833;5923.614965027303;5941.762329506814;5987.970060149672;5993.730282137314;6059.39406059395;5609.719514024282;5618.381977982419;5619.550435965154;5627.212190293362;5628.802991895264;6068.484178844759;6084.726187321581;6086.147939288503;6086.634801911811;6088.4824789893355;5766.567507436959;5807.448292412214;5843.24037875082;5884.617499862496;5901.203337549462;5933.3769954154195;5939.22790037301;5942.10868369748;5942.64344139353;5946;5899.262592175978;5915.733791979371;5938.762449502058;5958.165856780054;5960.761569537257;5926.940730592725;5942.1978032965;5975.880482390327;5991.400859913973;5996.280446346466;4491.528389519119;4501.504834468205;4502.594766471033;4506.143832671782;4527.660425468103;3981.163955569305;4051.4327994080854;4054.5742697016976;4061.289274376972;4093.8567150150197;5684.63049901755;5702.600817942704;5716.771329146871;5718.656880587178;5738.913916291259;5972.432618901197;5975.372585878507;5981.342052374235;5993.340732519419;5993.340732519419;5569.387367389584;5669.546436285087;5691.743871525791;5699.373068962411;5761.337446193657;4940.505949405031;4964.503549645079;4964.702117872939;4971.502849715;4999.250112483084;6165.630062196283;6170.167027451326;6176.227971503562;6178.814635560941;6183.84540386485;5900.64596124234;5976.432238937294;6006.519478441802;6043.335233124265;6066.029435290332;6130.854494055399;6149.354317796567;6155.938440615716;6166.445019948226;6185.319614842454;5845.240118784701;5848.035074212878;5848.122781582797;5850.356460789395;5851.853703657443;5868.002439585366;5985.95245831969;6022.307434645072;6027.397260274113;6068.362821903636;5850.561207909339;5888.676122813286;5900.881982360414;5901.793437229677;5908.645481271137;5776.797812076557;5875.236219291465;5882.794102206573;5889.38161493037;5892.263467066617;5682.176084467646;5737.827865164052;5752.338481074563;5766.711664416846;5804.071348584206;5844.503217226584;5850.5904586678525;5868.559858010752;5888.852778680567;5894.941050589439;5665.66006039639;5667.3765885753355;5764.740586673526;5770;5788.160716695971 08:02:14 INFO - PROCESS | 11707 | |1;ext.html;654.7937399719088;673.2392396591852;683.4703105093549;736.723728601774;744.9478536502445;33385.83307083464;34222.48666270008;34245.31509369811;34269.82865085674;34286;34834;41628.37557436641;42528.78735606318;42644.14711705772;42678.573214267846;8772.210501054904;8949.105089491031;8961.417507862001;8964.731058068268;8966.641334346617;8390.160983901591;8859.468431894074;8963.775905602346;8973.192412682858;10706.732331691692;10593.629222977197;10644.520996555173;10646.25476216665;10654.200934929873;10659.733506662356;10532.210084243674;10571.312864663772;10599;10603.151747860153;10607.151427885829;10546.156307495383;10638.893611063944;10645.627403040933;10656.040956313891;10664.466776661213;41324.1735165298;41646.37530437046;41757.37363939543;44987.625928055524;45081.54918450806;3794.146317078663;3987.023179321085;4113.9794301028605;4454.933176002362;4617.261238201905;32301.192470188198;32339.838300808344;32484.512732309035;32713.345733085203;34005.489917651255;4267.210566045261;4320.157569273962;4349.956500434987;4352.978235108836;4460.553944605514;311858;315798;317171;317544;317944;41232;69191.65404173048;70155;70328;70367;40743.7962810184;40957.590424095375;40963.59036409658;40997.590024099976;41018.58981410207;17248;17453.563660908578;17458.912705436393;17464.65070698604;17498.387556435464;13947.721045579032;15032.173230472428;15123.773143402857;15167.696646067017;15172.165530895907;9580;9687.079727425884;9729.70810875675;9739.610415583438;9794.951025244829;3598.3702852000797;3718.3864662330952;3738.719596030309;3778.962210377861;3779.3197224499854;1042.2183362478142;1140.4240858366638;1154.9191556591127;1161.8547681539808;1224.69994851262;32866.83566582199;33457.83271083629;33893.66106338955;33984.80346209838;34152;1178.8997935175435;1198.6583823610229;1218.9878101218874;1243.1795015289865;1304.5108084468325;15958.1223032732;16106.436274730328;16386.67226655484;16393.91803040977;16701.331946721995;509234;520601;521148;523086;523231;63549.364506354344;64572.67713661402;64599;64724;64794.67602661956;1477.6601381682274;1531.4792970390122;1553.1768162873468;1592.2914303134994;1613.2014652746732;32760.83619581887;32801.179970500925;33338.833305833316;33733;33773;53576.19635705546;54347.72826135844;54435.45564544304;54440;54514;374932;376402;376776.6966990885;377134;377332;28299.858500707363;32130.51804222892;32582.348353032332;32777.83611081929;32966.505502417;45219.095618086794;46072.539274606825;46446;46845;46910.765446172554;40133;40587.59412405838;40893.38659920163;41917;42532;41748.3737743928;41764.791176043924;43907.34138987982;44374;47211.29183062325;42690.359644605975;43437.565624343355;43484;43979.12041759211;44269;36451;37196.07009824668;37563.81218093892;38151.42772858354;38363.61636383712;28796;28991;29437.55843662304;29462.263443414085;29540 08:02:14 INFO - PROCESS | 11707 | |2;jquery.html;435.2122657989039;435.49917594766015;443.6406510726314;448.625397792843;453.14582012905663;18685;19179.808201917993;19577.51056223595;19618;19707.901460492714;19094.140763665633;19402.126904289307;19467.902660486678;19476;19546.218151273933;5791.652500849952;5800.651960882339;5899.233099697033;5955.85110372242;5965.701714914258;5873.353931067579;5893.0276504376725;5898.941010589882;5901.350851406363;5909.349971503131;5762.942370576304;5802.274715660543;5879.176915231871;5918.763249470016;5925.259342582177;5793.478586927196;5841.123831425278;5848.7660493580415;5866.413358664121;5892.852678683024;5281.735913204325;5572.944270557324;5805.4194580542035;5808.07070868659;5810.912836307459;22265.109395624157;22572.20997265088;22622.77377226223;23135.190268340695;23224.419389515228;2387.152560840894;2416.7099948006176;2539.631753395747;2880.0351882119307;3067.9233019174476;10448.634297799617;10778.622748203776;10895.83656245157;13158.73682526344;13988.880889528813;2052.8563000589966;2148.5380643161793;2163.2212403534713;2194.8244140468883;2256.1426657869906;75191.62404187943;75262;76359.23640763576;80969.59515202446;81007.5949620254;11037.503312350964;11254.606088786853;11441.256318339281;11453.59912403062;11607.883921160848;16115.597110072342;16170.676586468206;16364.67270654604;16377.590560236089;16396.26216820246;8874.600642971081;8897.73306800797;8897.777555561033;8957.372983891195;9000.919889613157;8760.255378292917;8804.163604457566;8844.115588441104;8892.244159246407;8905.154010369004;5032.949670503322;5060.2662613920775;5075.213341932006;5087.796488140433;5127.87180320495;2043.529988102715;2046.2838006697536;2085.9478513037297;2110.7361579802523;2151.806337429639;984.2372161574837;1054.6888667843004;1129.8474705914762;1130.197559732599;1131.688785583971;18636.627267454576;18639.627207456047;18902.52743681419;19295;19436.2225510978;1046.733083063829;1054.2567489919588;1099.3294090604725;1110.8778034416207;1148.4602236948622;10484.318519296221;10579.735506612396;10739.710762097671;10842.40366779819;10921.290116142425;532767;548291;553186;558401;565029;95278;98752.50623746835;98922;99029.50485247672;99036.50481747545;1093.2893619147617;1123.8201887697928;1134.65393055119;1136.2784631758893;1140.6806094293445;16477.58806029859;16688.24902879349;16875.578110547336;16923.66152676915;17304.826951730323;40835;40934;41098.38352424776;43199.35200972051;43397;52134;58769.70615146897;59204.111938321825;59262.70368648129;59370.40629593649;8311.293540049164;8383.496990180609;8818.38271321027;8858.557072146496;9111.225545828678;7920.762377128695;11674.649760507198;12195.329256890956;12350.258984460961;12574.30841303737;10529.526171322463;11282.774344513227;11549.82675259855;11771.352575608424;11814.527418903148;11524.13568982313;11769.823452648388;11811.350375729073;11894;11929.701757456132;11591.942040290081;11872.347020913932;11932.463039163433;11990.640280791591;11990.700232494257;8819.426737262058;8832.293416526534;8931.19619234272;8994.55027248648;9007.414518056305;11175.55297788112;11471.369074700971;11615.419229038684;11618.244814087395;11948.940255298668 08:02:14 INFO - PROCESS | 11707 | |3;mootools.html;1433.4481224728477;1559.7270477666405;1584.231647650889;1778.635379747152;1903.9238430462783;8204.753857384281;8358.038825535064;8364.539950302731;8373.53945532997;8375.246227839501;8185.386096042791;8368.414211005233;8370.707025254118;8382;8391.832163356728;2096.6226079305793;2130.5525839573706;2327.627579587266;2367.6330168823774;2392.8803559822027;2367.10050180931;2378.52429514097;2379.6430535419654;2380.083667787897;2381.1070848431837;2289.496310811619;2298.2186056740707;2312.0520586559514;2356.681847950522;2361.8937147828387;2055.3731112010832;2267.115824828318;2316;2333.6382860656627;2345.1791872844537;2258.5934531784274;2315.178111770331;2320.7795259450327;2324.1865347128537;2324.4537533679572;8210.220029097227;8273.007239131342;8276.08963014068;8280.461769984931;8283.668653253922;5044.747762611892;5199.220116982445;5204.609654275944;5207.0366982108435;5207.583393328525;3323.6344002159744;3388.5764279465066;3485;3502.5464432260583;3508.9298214035575;1120.1095129372168;1166.609185922717;1175.994120029403;1188.2929656854158;1234.3149551998638;12164;12218.694532636666;12222.449989750394;12224.694382640417;12230.449629766681;4553.2714765638;4555.362249285103;4604.37840891482;4626.86119416418;4640.025594625099;10475.738106547396;10509.842352364567;10532.789344213226;10545.47272636365;10556;5279.52484276417;5341.332333458317;5341.679499230058;5350.464953504618;5350.652207606493;4335.848245311399;4646.558576935186;4840.661153719277;4843.95156048435;4894.241392584155;4026.3960405939342;4041.9191616167514;4124.566920473307;4145;4188.623023927861;1330.0490149543123;1338.110156745753;1338.819259399988;1342.8254326937436;1345;964.5755867418454;989.3569180032893;998.8401855703053;1013.6300250408548;1016.5730393234859;5819.359870414251;5829.708514574254;5953.196318497034;6007.639541627429;6015.939840601538;441.15959097918517;442.90256143648344;447.88578912377784;450.97519636419656;457.80543269110495;3838.9232215355537;3848.7883166426113;3864.016903205228;3897.0841852164717;3945.723799334019;10065.144462720751;10415.531301091469;10513.57945682164;10554.630587929385;10562.577496900038;10205.38767673927;10248.282620216662;10339.431331276852;10351.63769268072;10353.534090965924;7976.042874855055;7989.720359787496;8042.235987581171;8061.596920153969;8074.555899425471;5782.190493331022;5814.098814683731;5828.6211396259105;5850.385709500441;6019.6990150493175;9280.535973201448;9330.253579713471;9428.057194280516;9521.952390238004;9574.952125239608;9208.401453905743;9540.522973851419;9709.854352184864;9744.951275243578;9768.120869121529;6875.48433867452;7048.506604537838;7377.668004939684;7660.770176894479;7705.6147192641265;8108.83782324362;8120.959395203223;8171.918280817115;8174.386920980831;8183.427160098736;7358.264173582813;7435.219301973215;7526.548407095592;7534.510256833289;7610.048743907012;7447.962760186165;7522.962385188039;7538.962305188439;7617.6572054256585;7639.732609358646;7029.718811247493;7037.190723066913;7068.681909314196;7080.787576372717;7080.964595176991;4838.612910967044;4985.476524964972;4985.825496107619;5014.398272207359;5016.774245158904;5015.2978582997675;5127.179651255781;5145.202493613496;5147.510986456281;5258.211268309784 08:02:14 INFO - PROCESS | 11707 | |4;prototype.html;345.90141809584276;353.93452211340906;356.58992159017134;358.4157822748919;359.05568355225734;6135.417135372132;6277.058441233818;6328.430441260286;6360.840978975522;6366.80899573013;6248.593841400306;6313.463355614766;6353.30113687494;6356.745730170799;6372.171617689693;4813.951860481394;4826.01066781309;4833.130036593412;4834.734089625069;4846.006568653435;4551.704139230939;4596.862094137165;4755.144074066667;4828.5412885775795;4841.3222148899185;4725.3148293497425;4736.8578942631775;4744.786484608184;4745.76271186441;4748.406449193851;4691.085238378518;4721.598664113537;4729.952700472985;4736.715797052153;4755.453122890843;4164.3961625564425;4170.291050521389;4174;4174.352975288835;4176.60322269384;6039.094135879654;6047.7580896764075;6050;6058.818235452944;6067.332593414721;5305.124654432014;5574.581906356999;5580.330360356743;5581.330240371181;5592.468715472024;6589.769358072493;6671.86656266872;6694.93305066948;6700.597964122119;6725.461963042993;4602.493725690171;4602.654800889946;4605.930911036337;4606.861794146181;4608.953910460886;6849.726010959555;6923.653817309114;6933.306669333027;6936;6937.098177236978;4702.106599746037;4704;4711.3639658646325;4712.717236965793;4720.527947205252;4532.637389008872;4766.213574760126;4767.69010014348;4771.427428708577;4776.546228108324;5434.75543600531;5436.6737995719595;5447.237386765856;5481.342238931274;5498.230247765316;6674.5327827052615;6683.832904177337;6685.933140668531;6703.095082163943;6708.966455167693;1580.4073472447833;1616.83023282556;1650.2079002078829;1654.2638525856119;1655.8509734123986;1075.0593230922943;1082.7130810335268;1091.2579445976812;1095.7260684828793;1099.3458891959272;6388.968055159695;6436.742530298736;6441.130447389636;6450.3549645036055;6455.806325810233;6797.932020679828;6806.944923536859;6813.591184528944;6817.7272909083085;6830.385265326145;6421.101045853584;6441.903371449432;6442.77450289247;6446.903296450557;6451.612903225821;3634.7819130852236;3653.1415117447377;3655.360311945452;3662.633736626316;3670.559532856021;6949.583025018515;7020.157581090302;7050.6827192776445;7094.574325540484;7104;6862.245153033163;6878.58728476293;6880.621565813928;6885.208201056842;6890.965545172242;7068.045813815069;7068.081149450539;7085.078939737904;7095.396891264197;7102.609356485443;6713.328667133248;6763.628000460022;6772.729090836311;6773.458123350219;6797.422219111431;6564.8358791030605;6658.434033107046;6864.21061577925;6869.828254293682;6893.03497510359;7190.892136618059;7220.530665506935;7223.061002069698;7228.89156662661;7238.963805181151;4710.952890471051;4756.143894099096;4764.404449443819;4764.571188593043;4764.857054288377;6653.068570400244;6712.093867328043;6828.760993365208;6838.350356716104;6887;6765.729370825112;6774.4580433564215;6779.389854913082;6787.21946976104;6800.217974932748;6727.058211850247;6736.292689267556;6738.59568425896;6739.191297044386;6746.089277947414;6611.338866113542;6623.337666233531;6624.9337506624315;6637.103990961158;6645.368689974444;6563.310852360624;6775.525713200029;6786.185657721105;6791.558548694319;6797.5581587196675;6599.868002640016;6604.933950660432;6606.306337834651;6621.271660117287;6625.436837868642 08:02:14 INFO - PROCESS | 11707 | |5;yui.html;827.6730691376906;884.747846863644;925.7407925780782;927.7726956895559;933.8179055084253;15198.468053618126;15686.764698529518;17436.912815435935;17796.46610601684;17811.198496067675;16329.510114696548;16433.424830130916;16514.256858441368;16514.83485165148;16522.25649845757;889.452986413356;908.7955210077713;911.5032307392454;912.4662072687453;913.4382354851751;756.5876597254482;879.0550158579521;890.2877697841733;914.2640174659397;917.4082716647758;944.2210176604294;948.4119845695678;952.1478276942132;952.6665667016558;952.7713348796274;945.3004776465435;947.0245646983618;947.6209516193543;947.8388673925484;948.1514044929818;572.461885827321;698.4656737595743;707.1584814071239;710.3074502360157;710.5488015110391;14334.21161836109;14338.784918226234;14367.85632143686;14379.209143497104;14393.208373539452;13426.731465370638;14366.928165359212;14486.637834054127;14728.337224824802;14815.629609259855;12071.758564828742;12339.876601234053;12433.440495177649;12463.252204867737;12556.434960426803;4103.712740108193;4105.178964207171;4130.318497447917;4164.083901541656;4215.620594146541;58008;58908.11637825436;58981.705091474694;59511.70244148751;59734.70132649352;12246;12312.507499699912;12330.383480825923;12353.505859765508;12610.558630447891;22551.661725074136;22590.887045564996;22624.660630090562;22692.092316307164;22722.545549089256;8838.337124715672;8923.464592124494;8940.5082720451;9136.177744002938;9250.629974801068;5081.720505372166;5082.237664350377;5091.567216786615;5176.534111929945;5186.222066690027;3695;3727.589965103836;3730.776153430803;3747.306748251582;3754.3805272129794;614.0911451052378;639.6034458635676;643.5591619740493;648.9772857950044;670.554081535783;649.3344322069917;723.5369363607296;756.5460723565817;758.2947858491546;762.1045271805717;9193.356465047516;9355.719328420158;9524.619015239312;9613.631268216155;9959.900400996043;768.2893323675689;807.7738233294687;810.7527204202656;819.700809204636;827.1067247372823;4509.819607215674;4524.5701658342405;4552.635789136861;4552.7495987720995;4559.863204103882;59204.40795591989;59632.40367596268;59885.10172347418;59983.70008150019;60002.39997599968;54080.459195407544;55255.72372138114;55620;56233;56667.43332566704;45358.546414535434;46560.5343946563;47151;47860.760696196994;48212.27681584849;9527.428354298765;9554.856677149988;9643.903560964582;9732.902670973483;9777.657781977881;36459.27081458409;37362.81318593498;37432.25135497329;37791.05522361963;39293.214135717695;43340;44391.55608444003;45989.77005114953;48359.758201208766;49724.254136187265;12344.321062341658;12713.491460341484;12786.61640150797;12859.29273889945;12999.1550549214;13957.720845582828;14021.3690383935;14131.576052718436;14278.571642850731;14471.927640361731;12291;12406.193597416139;12831.358432078172;12948.93525532404;13274.203547787163;13151.60545183646;13639.659008524866;13871.583852484442;14413.13521188732;14470.855291446951;13309.80035299452;13496.055276130577;13527.323633818072;13649;13739.381727822072;11035.668929931793;11077.169212308949;11227.607033753779;11282.887171128184;11310.773784524099;10926.399048052433;11118.833217501582;11380.658580242605;11393;11413.714657133638 08:02:14 INFO - PROCESS | 11707 | __end_tp_report 08:02:14 INFO - PROCESS | 11707 | __start_cc_report 08:02:14 INFO - PROCESS | 11707 | _x_x_mozilla_cycle_collect,848 08:02:14 INFO - PROCESS | 11707 | __end_cc_report 08:02:14 INFO - PROCESS | 11707 | __startTimestamp1463842934231__endTimestamp 08:02:14 INFO - PROCESS | 11707 | 08:02:14 INFO - PROCESS | 11707 | ------- Summary: start ------- 08:02:14 INFO - PROCESS | 11707 | Number of tests: 6 08:02:14 INFO - PROCESS | 11707 | 08:02:14 INFO - PROCESS | 11707 | [#0] dojo.html Cycles:165 Average:5533.41 Median:5766.71 stddev:625.12 (10.8%) stddev-sans-first:602.49 08:02:14 INFO - PROCESS | 11707 | Values: 3322.4 3364.5 3381.9 3392.2 3409.9 5528.4 5531.3 5538.1 5541.5 5547.3 5551.6 5567.8 5571.3 5584.9 5625.0 4955.6 4979.0 5075.0 5120.0 5148.7 4937.3 5002.6 5008.6 5011.7 5050.5 5042.5 5053.9 5075.9 5077.7 5078.2 5072.6 5074.6 5082.5 5097.7 5106.0 4926.8 4945.1 4983.3 5007.9 5020.5 5449.4 5452.5 5455.3 5462.1 5485.1 5881.1 5925.4 5929.3 5931.9 5945.9 5923.6 5941.8 5988.0 5993.7 6059.4 5609.7 5618.4 5619.6 5627.2 5628.8 6068.5 6084.7 6086.1 6086.6 6088.5 5766.6 5807.4 5843.2 5884.6 5901.2 5933.4 5939.2 5942.1 5942.6 5946.0 5899.3 5915.7 5938.8 5958.2 5960.8 5926.9 5942.2 5975.9 5991.4 5996.3 4491.5 4501.5 4502.6 4506.1 4527.7 3981.2 4051.4 4054.6 4061.3 4093.9 5684.6 5702.6 5716.8 5718.7 5738.9 5972.4 5975.4 5981.3 5993.3 5993.3 5569.4 5669.5 5691.7 5699.4 5761.3 4940.5 4964.5 4964.7 4971.5 4999.3 6165.6 6170.2 6176.2 6178.8 6183.8 5900.6 5976.4 6006.5 6043.3 6066.0 6130.9 6149.4 6155.9 6166.4 6185.3 5845.2 5848.0 5848.1 5850.4 5851.9 5868.0 5986.0 6022.3 6027.4 6068.4 5850.6 5888.7 5900.9 5901.8 5908.6 5776.8 5875.2 5882.8 5889.4 5892.3 5682.2 5737.8 5752.3 5766.7 5804.1 5844.5 5850.6 5868.6 5888.9 5894.9 5665.7 5667.4 5764.7 5770.0 5788.2 08:02:14 INFO - PROCESS | 11707 | 08:02:14 INFO - PROCESS | 11707 | [#1] ext.html Cycles:180 Average:57004.64 Median:376955.35 stddev:109337.10 (29.0%) stddev-sans-first:109561.97 08:02:14 INFO - PROCESS | 11707 | Values: 654.8 673.2 683.5 736.7 744.9 33385.8 34222.5 34245.3 34269.8 34286.0 34834.0 41628.4 42528.8 42644.1 42678.6 8772.2 8949.1 8961.4 8964.7 8966.6 8390.2 8859.5 8963.8 8973.2 10706.7 10593.6 10644.5 10646.3 10654.2 10659.7 10532.2 10571.3 10599.0 10603.2 10607.2 10546.2 10638.9 10645.6 10656.0 10664.5 41324.2 41646.4 41757.4 44987.6 45081.5 3794.1 3987.0 4114.0 4454.9 4617.3 32301.2 32339.8 32484.5 32713.3 34005.5 4267.2 4320.2 4350.0 4353.0 4460.6 311858.0 315798.0 317171.0 317544.0 317944.0 41232.0 69191.7 70155.0 70328.0 70367.0 40743.8 40957.6 40963.6 40997.6 41018.6 17248.0 17453.6 17458.9 17464.7 17498.4 13947.7 15032.2 15123.8 15167.7 15172.2 9580.0 9687.1 9729.7 9739.6 9795.0 3598.4 3718.4 3738.7 3779.0 3779.3 1042.2 1140.4 1154.9 1161.9 1224.7 32866.8 33457.8 33893.7 33984.8 34152.0 1178.9 1198.7 1219.0 1243.2 1304.5 15958.1 16106.4 16386.7 16393.9 16701.3 509234.0 520601.0 521148.0 523086.0 523231.0 63549.4 64572.7 64599.0 64724.0 64794.7 1477.7 1531.5 1553.2 1592.3 1613.2 32760.8 32801.2 33338.8 33733.0 33773.0 53576.2 54347.7 54435.5 54440.0 54514.0 374932.0 376402.0 376776.7 377134.0 377332.0 28299.9 32130.5 32582.3 32777.8 32966.5 45219.1 46072.5 46446.0 46845.0 46910.8 40133.0 40587.6 40893.4 41917.0 42532.0 41748.4 41764.8 43907.3 44374.0 47211.3 42690.4 43437.6 43484.0 43979.1 44269.0 36451.0 37196.1 37563.8 38151.4 38363.6 28796.0 28991.0 29437.6 29462.3 29540.0 08:02:14 INFO - PROCESS | 11707 | 08:02:14 INFO - PROCESS | 11707 | [#2] jquery.html Cycles:180 Average:30914.25 Median:22878.98 stddev:90694.58 (396.4%) stddev-sans-first:90920.13 08:02:14 INFO - PROCESS | 11707 | Values: 435.2 435.5 443.6 448.6 453.1 18685.0 19179.8 19577.5 19618.0 19707.9 19094.1 19402.1 19467.9 19476.0 19546.2 5791.7 5800.7 5899.2 5955.9 5965.7 5873.4 5893.0 5898.9 5901.4 5909.3 5762.9 5802.3 5879.2 5918.8 5925.3 5793.5 5841.1 5848.8 5866.4 5892.9 5281.7 5572.9 5805.4 5808.1 5810.9 22265.1 22572.2 22622.8 23135.2 23224.4 2387.2 2416.7 2539.6 2880.0 3067.9 10448.6 10778.6 10895.8 13158.7 13988.9 2052.9 2148.5 2163.2 2194.8 2256.1 75191.6 75262.0 76359.2 80969.6 81007.6 11037.5 11254.6 11441.3 11453.6 11607.9 16115.6 16170.7 16364.7 16377.6 16396.3 8874.6 8897.7 8897.8 8957.4 9000.9 8760.3 8804.2 8844.1 8892.2 8905.2 5032.9 5060.3 5075.2 5087.8 5127.9 2043.5 2046.3 2085.9 2110.7 2151.8 984.2 1054.7 1129.8 1130.2 1131.7 18636.6 18639.6 18902.5 19295.0 19436.2 1046.7 1054.3 1099.3 1110.9 1148.5 10484.3 10579.7 10739.7 10842.4 10921.3 532767.0 548291.0 553186.0 558401.0 565029.0 95278.0 98752.5 98922.0 99029.5 99036.5 1093.3 1123.8 1134.7 1136.3 1140.7 16477.6 16688.2 16875.6 16923.7 17304.8 40835.0 40934.0 41098.4 43199.4 43397.0 52134.0 58769.7 59204.1 59262.7 59370.4 8311.3 8383.5 8818.4 8858.6 9111.2 7920.8 11674.6 12195.3 12350.3 12574.3 10529.5 11282.8 11549.8 11771.4 11814.5 11524.1 11769.8 11811.4 11894.0 11929.7 11591.9 11872.3 11932.5 11990.6 11990.7 8819.4 8832.3 8931.2 8994.6 9007.4 11175.6 11471.4 11615.4 11618.2 11948.9 08:02:14 INFO - PROCESS | 11707 | 08:02:14 INFO - PROCESS | 11707 | [#3] mootools.html Cycles:180 Average:5647.74 Median:4842.31 stddev:3167.49 (65.4%) stddev-sans-first:3160.54 08:02:14 INFO - PROCESS | 11707 | Values: 1433.4 1559.7 1584.2 1778.6 1903.9 8204.8 8358.0 8364.5 8373.5 8375.2 8185.4 8368.4 8370.7 8382.0 8391.8 2096.6 2130.6 2327.6 2367.6 2392.9 2367.1 2378.5 2379.6 2380.1 2381.1 2289.5 2298.2 2312.1 2356.7 2361.9 2055.4 2267.1 2316.0 2333.6 2345.2 2258.6 2315.2 2320.8 2324.2 2324.5 8210.2 8273.0 8276.1 8280.5 8283.7 5044.7 5199.2 5204.6 5207.0 5207.6 3323.6 3388.6 3485.0 3502.5 3508.9 1120.1 1166.6 1176.0 1188.3 1234.3 12164.0 12218.7 12222.4 12224.7 12230.4 4553.3 4555.4 4604.4 4626.9 4640.0 10475.7 10509.8 10532.8 10545.5 10556.0 5279.5 5341.3 5341.7 5350.5 5350.7 4335.8 4646.6 4840.7 4844.0 4894.2 4026.4 4041.9 4124.6 4145.0 4188.6 1330.0 1338.1 1338.8 1342.8 1345.0 964.6 989.4 998.8 1013.6 1016.6 5819.4 5829.7 5953.2 6007.6 6015.9 441.2 442.9 447.9 451.0 457.8 3838.9 3848.8 3864.0 3897.1 3945.7 10065.1 10415.5 10513.6 10554.6 10562.6 10205.4 10248.3 10339.4 10351.6 10353.5 7976.0 7989.7 8042.2 8061.6 8074.6 5782.2 5814.1 5828.6 5850.4 6019.7 9280.5 9330.3 9428.1 9522.0 9575.0 9208.4 9540.5 9709.9 9745.0 9768.1 6875.5 7048.5 7377.7 7660.8 7705.6 8108.8 8121.0 8171.9 8174.4 8183.4 7358.3 7435.2 7526.5 7534.5 7610.0 7448.0 7523.0 7539.0 7617.7 7639.7 7029.7 7037.2 7068.7 7080.8 7081.0 4838.6 4985.5 4985.8 5014.4 5016.8 5015.3 5127.2 5145.2 5147.5 5258.2 08:02:14 INFO - PROCESS | 11707 | 08:02:14 INFO - PROCESS | 11707 | [#4] prototype.html Cycles:180 Average:5566.31 Median:6405.03 stddev:1692.74 (26.4%) stddev-sans-first:1651.52 08:02:14 INFO - PROCESS | 11707 | Values: 345.9 353.9 356.6 358.4 359.1 6135.4 6277.1 6328.4 6360.8 6366.8 6248.6 6313.5 6353.3 6356.7 6372.2 4814.0 4826.0 4833.1 4834.7 4846.0 4551.7 4596.9 4755.1 4828.5 4841.3 4725.3 4736.9 4744.8 4745.8 4748.4 4691.1 4721.6 4730.0 4736.7 4755.5 4164.4 4170.3 4174.0 4174.4 4176.6 6039.1 6047.8 6050.0 6058.8 6067.3 5305.1 5574.6 5580.3 5581.3 5592.5 6589.8 6671.9 6694.9 6700.6 6725.5 4602.5 4602.7 4605.9 4606.9 4609.0 6849.7 6923.7 6933.3 6936.0 6937.1 4702.1 4704.0 4711.4 4712.7 4720.5 4532.6 4766.2 4767.7 4771.4 4776.5 5434.8 5436.7 5447.2 5481.3 5498.2 6674.5 6683.8 6685.9 6703.1 6709.0 1580.4 1616.8 1650.2 1654.3 1655.9 1075.1 1082.7 1091.3 1095.7 1099.3 6389.0 6436.7 6441.1 6450.4 6455.8 6797.9 6806.9 6813.6 6817.7 6830.4 6421.1 6441.9 6442.8 6446.9 6451.6 3634.8 3653.1 3655.4 3662.6 3670.6 6949.6 7020.2 7050.7 7094.6 7104.0 6862.2 6878.6 6880.6 6885.2 6891.0 7068.0 7068.1 7085.1 7095.4 7102.6 6713.3 6763.6 6772.7 6773.5 6797.4 6564.8 6658.4 6864.2 6869.8 6893.0 7190.9 7220.5 7223.1 7228.9 7239.0 4711.0 4756.1 4764.4 4764.6 4764.9 6653.1 6712.1 6828.8 6838.4 6887.0 6765.7 6774.5 6779.4 6787.2 6800.2 6727.1 6736.3 6738.6 6739.2 6746.1 6611.3 6623.3 6624.9 6637.1 6645.4 6563.3 6775.5 6786.2 6791.6 6797.6 6599.9 6604.9 6606.3 6621.3 6625.4 08:02:14 INFO - PROCESS | 11707 | 08:02:14 INFO - PROCESS | 11707 | [#5] yui.html Cycles:180 Average:15485.40 Median:4552.69 stddev:17197.08 (377.7%) stddev-sans-first:17210.09 08:02:14 INFO - PROCESS | 11707 | Values: 827.7 884.7 925.7 927.8 933.8 15198.5 15686.8 17436.9 17796.5 17811.2 16329.5 16433.4 16514.3 16514.8 16522.3 889.5 908.8 911.5 912.5 913.4 756.6 879.1 890.3 914.3 917.4 944.2 948.4 952.1 952.7 952.8 945.3 947.0 947.6 947.8 948.2 572.5 698.5 707.2 710.3 710.5 14334.2 14338.8 14367.9 14379.2 14393.2 13426.7 14366.9 14486.6 14728.3 14815.6 12071.8 12339.9 12433.4 12463.3 12556.4 4103.7 4105.2 4130.3 4164.1 4215.6 58008.0 58908.1 58981.7 59511.7 59734.7 12246.0 12312.5 12330.4 12353.5 12610.6 22551.7 22590.9 22624.7 22692.1 22722.5 8838.3 8923.5 8940.5 9136.2 9250.6 5081.7 5082.2 5091.6 5176.5 5186.2 3695.0 3727.6 3730.8 3747.3 3754.4 614.1 639.6 643.6 649.0 670.6 649.3 723.5 756.5 758.3 762.1 9193.4 9355.7 9524.6 9613.6 9959.9 768.3 807.8 810.8 819.7 827.1 4509.8 4524.6 4552.6 4552.7 4559.9 59204.4 59632.4 59885.1 59983.7 60002.4 54080.5 55255.7 55620.0 56233.0 56667.4 45358.5 46560.5 47151.0 47860.8 48212.3 9527.4 9554.9 9643.9 9732.9 9777.7 36459.3 37362.8 37432.3 37791.1 39293.2 43340.0 44391.6 45989.8 48359.8 49724.3 12344.3 12713.5 12786.6 12859.3 12999.2 13957.7 14021.4 14131.6 14278.6 14471.9 12291.0 12406.2 12831.4 12948.9 13274.2 13151.6 13639.7 13871.6 14413.1 14470.9 13309.8 13496.1 13527.3 13649.0 13739.4 11035.7 11077.2 11227.6 11282.9 11310.8 10926.4 11118.8 11380.7 11393.0 11413.7 08:02:14 INFO - PROCESS | 11707 | -------- Summary: end -------- 08:02:14 INFO - PROCESS | 11707 | 08:02:14 INFO - TEST-INFO | 11707: exit 0 08:02:14 INFO - TEST-OK | dromaeo_css | took 1111113ms 08:02:14 INFO - TEST-START | kraken 08:02:14 INFO - operating with platform_type : linux_ 08:02:14 INFO - Initialising browser for kraken test... 08:02:14 INFO - TEST-INFO | started process 11901 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv6HDsn/profile http://localhost:39236/getInfo.html) 08:02:18 INFO - PROCESS | 11901 | __metrics Screen width/height:1600/1200 08:02:18 INFO - PROCESS | 11901 | colorDepth:24 08:02:18 INFO - PROCESS | 11901 | Browser inner width/height: 1024/697 08:02:18 INFO - PROCESS | 11901 | __metrics 08:02:19 ERROR - PROCESS | 11901 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:02:20 INFO - TEST-INFO | 11901: exit 0 08:02:20 INFO - Browser initialized. 08:02:20 INFO - Running cycle 1/1 for kraken test... 08:02:20 INFO - TEST-INFO | started process 11996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv6HDsn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:32 INFO - PROCESS | 11996 | RSS: Main: 142544896 08:02:32 INFO - PROCESS | 11996 | 08:02:35 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39236/tests/kraken/driver.html?testName=audio-beat-detection) 08:02:35 INFO - PROCESS | 11996 | RSS: Main: 196755456 08:02:35 INFO - PROCESS | 11996 | 08:02:38 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39236/tests/kraken/driver.html?testName=audio-dft) 08:02:39 INFO - PROCESS | 11996 | RSS: Main: 182296576 08:02:39 INFO - PROCESS | 11996 | 08:02:41 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39236/tests/kraken/driver.html?testName=audio-fft) 08:02:42 INFO - PROCESS | 11996 | RSS: Main: 272760832 08:02:42 INFO - PROCESS | 11996 | 08:02:44 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39236/tests/kraken/driver.html?testName=audio-oscillator) 08:02:45 INFO - PROCESS | 11996 | RSS: Main: 179441664 08:02:45 INFO - PROCESS | 11996 | 08:02:47 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:02:47 INFO - PROCESS | 11996 | RSS: Main: 178057216 08:02:47 INFO - PROCESS | 11996 | 08:02:50 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39236/tests/kraken/driver.html?testName=imaging-darkroom) 08:02:51 INFO - PROCESS | 11996 | RSS: Main: 212869120 08:02:51 INFO - PROCESS | 11996 | 08:02:54 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39236/tests/kraken/driver.html?testName=imaging-desaturate) 08:02:55 INFO - PROCESS | 11996 | RSS: Main: 211214336 08:02:55 INFO - PROCESS | 11996 | 08:02:58 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39236/tests/kraken/driver.html?testName=json-parse-financial) 08:02:58 INFO - PROCESS | 11996 | RSS: Main: 211640320 08:02:58 INFO - PROCESS | 11996 | 08:03:00 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:03:00 INFO - PROCESS | 11996 | RSS: Main: 190615552 08:03:00 INFO - PROCESS | 11996 | 08:03:02 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39236/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:03:03 INFO - PROCESS | 11996 | RSS: Main: 195715072 08:03:03 INFO - PROCESS | 11996 | 08:03:05 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:03:05 INFO - PROCESS | 11996 | RSS: Main: 208625664 08:03:05 INFO - PROCESS | 11996 | 08:03:08 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:03:08 INFO - PROCESS | 11996 | RSS: Main: 214536192 08:03:08 INFO - PROCESS | 11996 | 08:03:11 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:03:12 INFO - PROCESS | 11996 | RSS: Main: 209883136 08:03:12 INFO - PROCESS | 11996 | 08:03:13 INFO - PROCESS | 11996 | Cycle 1(1): loaded http://localhost:39236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39236/tests/kraken/driver.html?testName=ai-astar) 08:03:14 INFO - PROCESS | 11996 | RSS: Main: 274022400 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | __start_tp_report 08:03:14 INFO - PROCESS | 11996 | _x_x_mozilla_page_load 08:03:14 INFO - PROCESS | 11996 | _x_x_mozilla_page_load_details 08:03:14 INFO - PROCESS | 11996 | |i|pagename|runs| 08:03:14 INFO - PROCESS | 11996 | |0;ai-astar;111;109;110;109;109;110;105;109;111;111 08:03:14 INFO - PROCESS | 11996 | |1;audio-beat-detection;158;132;156;174;126;153;173;138;191;127 08:03:14 INFO - PROCESS | 11996 | |2;audio-dft;161;161;160;161;160;161;161;160;159;161 08:03:14 INFO - PROCESS | 11996 | |3;audio-fft;77;78;77;170;77;75;76;74;160;75 08:03:14 INFO - PROCESS | 11996 | |4;audio-oscillator;92;91;147;92;92;91;149;90;91;149 08:03:14 INFO - PROCESS | 11996 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;118;117;116 08:03:14 INFO - PROCESS | 11996 | |6;imaging-darkroom;146;145;145;146;146;146;145;145;146;145 08:03:14 INFO - PROCESS | 11996 | |7;imaging-desaturate;95;96;95;94;95;94;95;94;94;95 08:03:14 INFO - PROCESS | 11996 | |8;json-parse-financial;55;54;55;56;55;55;57;68;53;53 08:03:14 INFO - PROCESS | 11996 | |9;json-stringify-tinderbox;58;59;58;59;58;59;58;58;59;59 08:03:14 INFO - PROCESS | 11996 | |10;stanford-crypto-aes;73;72;71;74;76;72;73;72;72;74 08:03:14 INFO - PROCESS | 11996 | |11;stanford-crypto-ccm;121;113;112;117;113;109;111;115;125;125 08:03:14 INFO - PROCESS | 11996 | |12;stanford-crypto-pbkdf2;161;155;156;160;155;160;156;164;156;156 08:03:14 INFO - PROCESS | 11996 | |13;stanford-crypto-sha256-iterative;69;73;64;66;64;66;65;65;66;64 08:03:14 INFO - PROCESS | 11996 | __end_tp_report 08:03:14 INFO - PROCESS | 11996 | __start_cc_report 08:03:14 INFO - PROCESS | 11996 | _x_x_mozilla_cycle_collect,1601 08:03:14 INFO - PROCESS | 11996 | __end_cc_report 08:03:14 INFO - PROCESS | 11996 | __startTimestamp1463842994017__endTimestamp 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | ------- Summary: start ------- 08:03:14 INFO - PROCESS | 11996 | Number of tests: 14 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.78 (1.6%) stddev-sans-first:1.79 08:03:14 INFO - PROCESS | 11996 | Values: 111.0 109.0 110.0 109.0 109.0 110.0 105.0 109.0 111.0 111.0 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#1] audio-beat-detection Cycles:10 Average:152.80 Median:157.00 stddev:22.08 (14.1%) stddev-sans-first:23.34 08:03:14 INFO - PROCESS | 11996 | Values: 158.0 132.0 156.0 174.0 126.0 153.0 173.0 138.0 191.0 127.0 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 08:03:14 INFO - PROCESS | 11996 | Values: 161.0 161.0 160.0 161.0 160.0 161.0 161.0 160.0 159.0 161.0 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.50 stddev:37.57 (49.1%) stddev-sans-first:39.34 08:03:14 INFO - PROCESS | 11996 | Values: 77.0 78.0 77.0 170.0 77.0 75.0 76.0 74.0 160.0 75.0 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:91.00 stddev:27.57 (30.3%) stddev-sans-first:28.60 08:03:14 INFO - PROCESS | 11996 | Values: 92.0 91.0 147.0 92.0 92.0 91.0 149.0 90.0 91.0 149.0 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:03:14 INFO - PROCESS | 11996 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 116.0 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:03:14 INFO - PROCESS | 11996 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:03:14 INFO - PROCESS | 11996 | Values: 95.0 96.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:4.36 (7.9%) stddev-sans-first:4.60 08:03:14 INFO - PROCESS | 11996 | Values: 55.0 54.0 55.0 56.0 55.0 55.0 57.0 68.0 53.0 53.0 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 08:03:14 INFO - PROCESS | 11996 | Values: 58.0 59.0 58.0 59.0 58.0 59.0 58.0 58.0 59.0 59.0 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:1.45 (2.0%) stddev-sans-first:1.54 08:03:14 INFO - PROCESS | 11996 | Values: 73.0 72.0 71.0 74.0 76.0 72.0 73.0 72.0 72.0 74.0 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#11] stanford-crypto-ccm Cycles:10 Average:116.10 Median:116.00 stddev:5.74 (5.0%) stddev-sans-first:5.81 08:03:14 INFO - PROCESS | 11996 | Values: 121.0 113.0 112.0 117.0 113.0 109.0 111.0 115.0 125.0 125.0 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:158.00 stddev:3.11 (2.0%) stddev-sans-first:3.09 08:03:14 INFO - PROCESS | 11996 | Values: 161.0 155.0 156.0 160.0 155.0 160.0 156.0 164.0 156.0 156.0 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - PROCESS | 11996 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:2.82 (4.3%) stddev-sans-first:2.80 08:03:14 INFO - PROCESS | 11996 | Values: 69.0 73.0 64.0 66.0 64.0 66.0 65.0 65.0 66.0 64.0 08:03:14 INFO - PROCESS | 11996 | -------- Summary: end -------- 08:03:14 INFO - PROCESS | 11996 | 08:03:14 INFO - TEST-INFO | 11996: exit 0 08:03:14 INFO - TEST-OK | kraken | took 60030ms 08:03:14 INFO - SUITE-END | took 1171s 08:03:15 INFO - Completed test suite (00:19:31) 08:03:15 INFO - javascript benchmark 08:03:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3322.3853587086387, 3364.5457863188476, 3381.915452113697, 3392.236746731984, 3409.9318013639727, 5528.419515950827, 5531.280933478647, 5538.113901775717, 5541.501264886159, 5547.278853749007, 5551.555875529958, 5567.805126820562, 5571.275734154565, 5584.9162262566, 5624.9875022495935, 4955.628327875405, 4978.975105124469, 5075.0, 5120.0, 5148.716820574867, 4937.308776771255, 5002.599792016648, 5008.574271186953, 5011.724355160465, 5050.46970068143, 5042.47054059324, 5053.949460505403, 5075.923861142086, 5077.720725360104, 5078.238264260372, 5072.568831649332, 5074.619403544749, 5082.517160869711, 5097.6941383517105, 5106.029854327666, 4926.827561035347, 4945.134601444769, 4983.327250821165, 5007.899842003139, 5020.497950204986, 5449.427810079964, 5452.454754524555, 5455.290812194429, 5462.126059830448, 5485.149801780731, 5881.088431293157, 5925.4370834770625, 5929.258842644669, 5931.881362372728, 5945.910811337833, 5923.614965027303, 5941.762329506814, 5987.970060149672, 5993.730282137314, 6059.39406059395, 5609.719514024282, 5618.381977982419, 5619.550435965154, 5627.212190293362, 5628.802991895264, 6068.484178844759, 6084.726187321581, 6086.147939288503, 6086.634801911811, 6088.4824789893355, 5766.567507436959, 5807.448292412214, 5843.24037875082, 5884.617499862496, 5901.203337549462, 5933.3769954154195, 5939.22790037301, 5942.10868369748, 5942.64344139353, 5946.0, 5899.262592175978, 5915.733791979371, 5938.762449502058, 5958.165856780054, 5960.761569537257, 5926.940730592725, 5942.1978032965, 5975.880482390327, 5991.400859913973, 5996.280446346466, 4491.528389519119, 4501.504834468205, 4502.594766471033, 4506.143832671782, 4527.660425468103, 3981.163955569305, 4051.4327994080854, 4054.5742697016976, 4061.289274376972, 4093.8567150150197, 5684.63049901755, 5702.600817942704, 5716.771329146871, 5718.656880587178, 5738.913916291259, 5972.432618901197, 5975.372585878507, 5981.342052374235, 5993.340732519419, 5993.340732519419, 5569.387367389584, 5669.546436285087, 5691.743871525791, 5699.373068962411, 5761.337446193657, 4940.505949405031, 4964.503549645079, 4964.702117872939, 4971.502849715, 4999.250112483084, 6165.630062196283, 6170.167027451326, 6176.227971503562, 6178.814635560941, 6183.84540386485, 5900.64596124234, 5976.432238937294, 6006.519478441802, 6043.335233124265, 6066.029435290332, 6130.854494055399, 6149.354317796567, 6155.938440615716, 6166.445019948226, 6185.319614842454, 5845.240118784701, 5848.035074212878, 5848.122781582797, 5850.356460789395, 5851.853703657443, 5868.002439585366, 5985.95245831969, 6022.307434645072, 6027.397260274113, 6068.362821903636, 5850.561207909339, 5888.676122813286, 5900.881982360414, 5901.793437229677, 5908.645481271137, 5776.797812076557, 5875.236219291465, 5882.794102206573, 5889.38161493037, 5892.263467066617, 5682.176084467646, 5737.827865164052, 5752.338481074563, 5766.711664416846, 5804.071348584206, 5844.503217226584, 5850.5904586678525, 5868.559858010752, 5888.852778680567, 5894.941050589439, 5665.66006039639, 5667.3765885753355, 5764.740586673526, 5770.0, 5788.160716695971], "value": 5492.252274961052, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.7937399719088, 673.2392396591852, 683.4703105093549, 736.723728601774, 744.9478536502445, 33385.83307083464, 34222.48666270008, 34245.31509369811, 34269.82865085674, 34286.0, 34834.0, 41628.37557436641, 42528.78735606318, 42644.14711705772, 42678.573214267846, 8772.210501054904, 8949.105089491031, 8961.417507862001, 8964.731058068268, 8966.641334346617, 8390.160983901591, 8859.468431894074, 8963.775905602346, 8973.192412682858, 10706.732331691692, 10593.629222977197, 10644.520996555173, 10646.25476216665, 10654.200934929873, 10659.733506662356, 10532.210084243674, 10571.312864663772, 10599.0, 10603.151747860153, 10607.151427885829, 10546.156307495383, 10638.893611063944, 10645.627403040933, 10656.040956313891, 10664.466776661213, 41324.1735165298, 41646.37530437046, 41757.37363939543, 44987.625928055524, 45081.54918450806, 3794.146317078663, 3987.023179321085, 4113.9794301028605, 4454.933176002362, 4617.261238201905, 32301.192470188198, 32339.838300808344, 32484.512732309035, 32713.345733085203, 34005.489917651255, 4267.210566045261, 4320.157569273962, 4349.956500434987, 4352.978235108836, 4460.553944605514, 311858.0, 315798.0, 317171.0, 317544.0, 317944.0, 41232.0, 69191.65404173048, 70155.0, 70328.0, 70367.0, 40743.7962810184, 40957.590424095375, 40963.59036409658, 40997.590024099976, 41018.58981410207, 17248.0, 17453.563660908578, 17458.912705436393, 17464.65070698604, 17498.387556435464, 13947.721045579032, 15032.173230472428, 15123.773143402857, 15167.696646067017, 15172.165530895907, 9580.0, 9687.079727425884, 9729.70810875675, 9739.610415583438, 9794.951025244829, 3598.3702852000797, 3718.3864662330952, 3738.719596030309, 3778.962210377861, 3779.3197224499854, 1042.2183362478142, 1140.4240858366638, 1154.9191556591127, 1161.8547681539808, 1224.69994851262, 32866.83566582199, 33457.83271083629, 33893.66106338955, 33984.80346209838, 34152.0, 1178.8997935175435, 1198.6583823610229, 1218.9878101218874, 1243.1795015289865, 1304.5108084468325, 15958.1223032732, 16106.436274730328, 16386.67226655484, 16393.91803040977, 16701.331946721995, 509234.0, 520601.0, 521148.0, 523086.0, 523231.0, 63549.364506354344, 64572.67713661402, 64599.0, 64724.0, 64794.67602661956, 1477.6601381682274, 1531.4792970390122, 1553.1768162873468, 1592.2914303134994, 1613.2014652746732, 32760.83619581887, 32801.179970500925, 33338.833305833316, 33733.0, 33773.0, 53576.19635705546, 54347.72826135844, 54435.45564544304, 54440.0, 54514.0, 374932.0, 376402.0, 376776.6966990885, 377134.0, 377332.0, 28299.858500707363, 32130.51804222892, 32582.348353032332, 32777.83611081929, 32966.505502417, 45219.095618086794, 46072.539274606825, 46446.0, 46845.0, 46910.765446172554, 40133.0, 40587.59412405838, 40893.38659920163, 41917.0, 42532.0, 41748.3737743928, 41764.791176043924, 43907.34138987982, 44374.0, 47211.29183062325, 42690.359644605975, 43437.565624343355, 43484.0, 43979.12041759211, 44269.0, 36451.0, 37196.07009824668, 37563.81218093892, 38151.42772858354, 38363.61636383712, 28796.0, 28991.0, 29437.55843662304, 29462.263443414085, 29540.0], "value": 19981.540031693297, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.2122657989039, 435.49917594766015, 443.6406510726314, 448.625397792843, 453.14582012905663, 18685.0, 19179.808201917993, 19577.51056223595, 19618.0, 19707.901460492714, 19094.140763665633, 19402.126904289307, 19467.902660486678, 19476.0, 19546.218151273933, 5791.652500849952, 5800.651960882339, 5899.233099697033, 5955.85110372242, 5965.701714914258, 5873.353931067579, 5893.0276504376725, 5898.941010589882, 5901.350851406363, 5909.349971503131, 5762.942370576304, 5802.274715660543, 5879.176915231871, 5918.763249470016, 5925.259342582177, 5793.478586927196, 5841.123831425278, 5848.7660493580415, 5866.413358664121, 5892.852678683024, 5281.735913204325, 5572.944270557324, 5805.4194580542035, 5808.07070868659, 5810.912836307459, 22265.109395624157, 22572.20997265088, 22622.77377226223, 23135.190268340695, 23224.419389515228, 2387.152560840894, 2416.7099948006176, 2539.631753395747, 2880.0351882119307, 3067.9233019174476, 10448.634297799617, 10778.622748203776, 10895.83656245157, 13158.73682526344, 13988.880889528813, 2052.8563000589966, 2148.5380643161793, 2163.2212403534713, 2194.8244140468883, 2256.1426657869906, 75191.62404187943, 75262.0, 76359.23640763576, 80969.59515202446, 81007.5949620254, 11037.503312350964, 11254.606088786853, 11441.256318339281, 11453.59912403062, 11607.883921160848, 16115.597110072342, 16170.676586468206, 16364.67270654604, 16377.590560236089, 16396.26216820246, 8874.600642971081, 8897.73306800797, 8897.777555561033, 8957.372983891195, 9000.919889613157, 8760.255378292917, 8804.163604457566, 8844.115588441104, 8892.244159246407, 8905.154010369004, 5032.949670503322, 5060.2662613920775, 5075.213341932006, 5087.796488140433, 5127.87180320495, 2043.529988102715, 2046.2838006697536, 2085.9478513037297, 2110.7361579802523, 2151.806337429639, 984.2372161574837, 1054.6888667843004, 1129.8474705914762, 1130.197559732599, 1131.688785583971, 18636.627267454576, 18639.627207456047, 18902.52743681419, 19295.0, 19436.2225510978, 1046.733083063829, 1054.2567489919588, 1099.3294090604725, 1110.8778034416207, 1148.4602236948622, 10484.318519296221, 10579.735506612396, 10739.710762097671, 10842.40366779819, 10921.290116142425, 532767.0, 548291.0, 553186.0, 558401.0, 565029.0, 95278.0, 98752.50623746835, 98922.0, 99029.50485247672, 99036.50481747545, 1093.2893619147617, 1123.8201887697928, 1134.65393055119, 1136.2784631758893, 1140.6806094293445, 16477.58806029859, 16688.24902879349, 16875.578110547336, 16923.66152676915, 17304.826951730323, 40835.0, 40934.0, 41098.38352424776, 43199.35200972051, 43397.0, 52134.0, 58769.70615146897, 59204.111938321825, 59262.70368648129, 59370.40629593649, 8311.293540049164, 8383.496990180609, 8818.38271321027, 8858.557072146496, 9111.225545828678, 7920.762377128695, 11674.649760507198, 12195.329256890956, 12350.258984460961, 12574.30841303737, 10529.526171322463, 11282.774344513227, 11549.82675259855, 11771.352575608424, 11814.527418903148, 11524.13568982313, 11769.823452648388, 11811.350375729073, 11894.0, 11929.701757456132, 11591.942040290081, 11872.347020913932, 11932.463039163433, 11990.640280791591, 11990.700232494257, 8819.426737262058, 8832.293416526534, 8931.19619234272, 8994.55027248648, 9007.414518056305, 11175.55297788112, 11471.369074700971, 11615.419229038684, 11618.244814087395, 11948.940255298668], "value": 9568.045130184959, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.4481224728477, 1559.7270477666405, 1584.231647650889, 1778.635379747152, 1903.9238430462783, 8204.753857384281, 8358.038825535064, 8364.539950302731, 8373.53945532997, 8375.246227839501, 8185.386096042791, 8368.414211005233, 8370.707025254118, 8382.0, 8391.832163356728, 2096.6226079305793, 2130.5525839573706, 2327.627579587266, 2367.6330168823774, 2392.8803559822027, 2367.10050180931, 2378.52429514097, 2379.6430535419654, 2380.083667787897, 2381.1070848431837, 2289.496310811619, 2298.2186056740707, 2312.0520586559514, 2356.681847950522, 2361.8937147828387, 2055.3731112010832, 2267.115824828318, 2316.0, 2333.6382860656627, 2345.1791872844537, 2258.5934531784274, 2315.178111770331, 2320.7795259450327, 2324.1865347128537, 2324.4537533679572, 8210.220029097227, 8273.007239131342, 8276.08963014068, 8280.461769984931, 8283.668653253922, 5044.747762611892, 5199.220116982445, 5204.609654275944, 5207.0366982108435, 5207.583393328525, 3323.6344002159744, 3388.5764279465066, 3485.0, 3502.5464432260583, 3508.9298214035575, 1120.1095129372168, 1166.609185922717, 1175.994120029403, 1188.2929656854158, 1234.3149551998638, 12164.0, 12218.694532636666, 12222.449989750394, 12224.694382640417, 12230.449629766681, 4553.2714765638, 4555.362249285103, 4604.37840891482, 4626.86119416418, 4640.025594625099, 10475.738106547396, 10509.842352364567, 10532.789344213226, 10545.47272636365, 10556.0, 5279.52484276417, 5341.332333458317, 5341.679499230058, 5350.464953504618, 5350.652207606493, 4335.848245311399, 4646.558576935186, 4840.661153719277, 4843.95156048435, 4894.241392584155, 4026.3960405939342, 4041.9191616167514, 4124.566920473307, 4145.0, 4188.623023927861, 1330.0490149543123, 1338.110156745753, 1338.819259399988, 1342.8254326937436, 1345.0, 964.5755867418454, 989.3569180032893, 998.8401855703053, 1013.6300250408548, 1016.5730393234859, 5819.359870414251, 5829.708514574254, 5953.196318497034, 6007.639541627429, 6015.939840601538, 441.15959097918517, 442.90256143648344, 447.88578912377784, 450.97519636419656, 457.80543269110495, 3838.9232215355537, 3848.7883166426113, 3864.016903205228, 3897.0841852164717, 3945.723799334019, 10065.144462720751, 10415.531301091469, 10513.57945682164, 10554.630587929385, 10562.577496900038, 10205.38767673927, 10248.282620216662, 10339.431331276852, 10351.63769268072, 10353.534090965924, 7976.042874855055, 7989.720359787496, 8042.235987581171, 8061.596920153969, 8074.555899425471, 5782.190493331022, 5814.098814683731, 5828.6211396259105, 5850.385709500441, 6019.6990150493175, 9280.535973201448, 9330.253579713471, 9428.057194280516, 9521.952390238004, 9574.952125239608, 9208.401453905743, 9540.522973851419, 9709.854352184864, 9744.951275243578, 9768.120869121529, 6875.48433867452, 7048.506604537838, 7377.668004939684, 7660.770176894479, 7705.6147192641265, 8108.83782324362, 8120.959395203223, 8171.918280817115, 8174.386920980831, 8183.427160098736, 7358.264173582813, 7435.219301973215, 7526.548407095592, 7534.510256833289, 7610.048743907012, 7447.962760186165, 7522.962385188039, 7538.962305188439, 7617.6572054256585, 7639.732609358646, 7029.718811247493, 7037.190723066913, 7068.681909314196, 7080.787576372717, 7080.964595176991, 4838.612910967044, 4985.476524964972, 4985.825496107619, 5014.398272207359, 5016.774245158904, 5015.2978582997675, 5127.179651255781, 5145.202493613496, 5147.510986456281, 5258.211268309784], "value": 4490.641584166841, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.90141809584276, 353.93452211340906, 356.58992159017134, 358.4157822748919, 359.05568355225734, 6135.417135372132, 6277.058441233818, 6328.430441260286, 6360.840978975522, 6366.80899573013, 6248.593841400306, 6313.463355614766, 6353.30113687494, 6356.745730170799, 6372.171617689693, 4813.951860481394, 4826.01066781309, 4833.130036593412, 4834.734089625069, 4846.006568653435, 4551.704139230939, 4596.862094137165, 4755.144074066667, 4828.5412885775795, 4841.3222148899185, 4725.3148293497425, 4736.8578942631775, 4744.786484608184, 4745.76271186441, 4748.406449193851, 4691.085238378518, 4721.598664113537, 4729.952700472985, 4736.715797052153, 4755.453122890843, 4164.3961625564425, 4170.291050521389, 4174.0, 4174.352975288835, 4176.60322269384, 6039.094135879654, 6047.7580896764075, 6050.0, 6058.818235452944, 6067.332593414721, 5305.124654432014, 5574.581906356999, 5580.330360356743, 5581.330240371181, 5592.468715472024, 6589.769358072493, 6671.86656266872, 6694.93305066948, 6700.597964122119, 6725.461963042993, 4602.493725690171, 4602.654800889946, 4605.930911036337, 4606.861794146181, 4608.953910460886, 6849.726010959555, 6923.653817309114, 6933.306669333027, 6936.0, 6937.098177236978, 4702.106599746037, 4704.0, 4711.3639658646325, 4712.717236965793, 4720.527947205252, 4532.637389008872, 4766.213574760126, 4767.69010014348, 4771.427428708577, 4776.546228108324, 5434.75543600531, 5436.6737995719595, 5447.237386765856, 5481.342238931274, 5498.230247765316, 6674.5327827052615, 6683.832904177337, 6685.933140668531, 6703.095082163943, 6708.966455167693, 1580.4073472447833, 1616.83023282556, 1650.2079002078829, 1654.2638525856119, 1655.8509734123986, 1075.0593230922943, 1082.7130810335268, 1091.2579445976812, 1095.7260684828793, 1099.3458891959272, 6388.968055159695, 6436.742530298736, 6441.130447389636, 6450.3549645036055, 6455.806325810233, 6797.932020679828, 6806.944923536859, 6813.591184528944, 6817.7272909083085, 6830.385265326145, 6421.101045853584, 6441.903371449432, 6442.77450289247, 6446.903296450557, 6451.612903225821, 3634.7819130852236, 3653.1415117447377, 3655.360311945452, 3662.633736626316, 3670.559532856021, 6949.583025018515, 7020.157581090302, 7050.6827192776445, 7094.574325540484, 7104.0, 6862.245153033163, 6878.58728476293, 6880.621565813928, 6885.208201056842, 6890.965545172242, 7068.045813815069, 7068.081149450539, 7085.078939737904, 7095.396891264197, 7102.609356485443, 6713.328667133248, 6763.628000460022, 6772.729090836311, 6773.458123350219, 6797.422219111431, 6564.8358791030605, 6658.434033107046, 6864.21061577925, 6869.828254293682, 6893.03497510359, 7190.892136618059, 7220.530665506935, 7223.061002069698, 7228.89156662661, 7238.963805181151, 4710.952890471051, 4756.143894099096, 4764.404449443819, 4764.571188593043, 4764.857054288377, 6653.068570400244, 6712.093867328043, 6828.760993365208, 6838.350356716104, 6887.0, 6765.729370825112, 6774.4580433564215, 6779.389854913082, 6787.21946976104, 6800.217974932748, 6727.058211850247, 6736.292689267556, 6738.59568425896, 6739.191297044386, 6746.089277947414, 6611.338866113542, 6623.337666233531, 6624.9337506624315, 6637.103990961158, 6645.368689974444, 6563.310852360624, 6775.525713200029, 6786.185657721105, 6791.558548694319, 6797.5581587196675, 6599.868002640016, 6604.933950660432, 6606.306337834651, 6621.271660117287, 6625.436837868642], "value": 5011.443605009314, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.6730691376906, 884.747846863644, 925.7407925780782, 927.7726956895559, 933.8179055084253, 15198.468053618126, 15686.764698529518, 17436.912815435935, 17796.46610601684, 17811.198496067675, 16329.510114696548, 16433.424830130916, 16514.256858441368, 16514.83485165148, 16522.25649845757, 889.452986413356, 908.7955210077713, 911.5032307392454, 912.4662072687453, 913.4382354851751, 756.5876597254482, 879.0550158579521, 890.2877697841733, 914.2640174659397, 917.4082716647758, 944.2210176604294, 948.4119845695678, 952.1478276942132, 952.6665667016558, 952.7713348796274, 945.3004776465435, 947.0245646983618, 947.6209516193543, 947.8388673925484, 948.1514044929818, 572.461885827321, 698.4656737595743, 707.1584814071239, 710.3074502360157, 710.5488015110391, 14334.21161836109, 14338.784918226234, 14367.85632143686, 14379.209143497104, 14393.208373539452, 13426.731465370638, 14366.928165359212, 14486.637834054127, 14728.337224824802, 14815.629609259855, 12071.758564828742, 12339.876601234053, 12433.440495177649, 12463.252204867737, 12556.434960426803, 4103.712740108193, 4105.178964207171, 4130.318497447917, 4164.083901541656, 4215.620594146541, 58008.0, 58908.11637825436, 58981.705091474694, 59511.70244148751, 59734.70132649352, 12246.0, 12312.507499699912, 12330.383480825923, 12353.505859765508, 12610.558630447891, 22551.661725074136, 22590.887045564996, 22624.660630090562, 22692.092316307164, 22722.545549089256, 8838.337124715672, 8923.464592124494, 8940.5082720451, 9136.177744002938, 9250.629974801068, 5081.720505372166, 5082.237664350377, 5091.567216786615, 5176.534111929945, 5186.222066690027, 3695.0, 3727.589965103836, 3730.776153430803, 3747.306748251582, 3754.3805272129794, 614.0911451052378, 639.6034458635676, 643.5591619740493, 648.9772857950044, 670.554081535783, 649.3344322069917, 723.5369363607296, 756.5460723565817, 758.2947858491546, 762.1045271805717, 9193.356465047516, 9355.719328420158, 9524.619015239312, 9613.631268216155, 9959.900400996043, 768.2893323675689, 807.7738233294687, 810.7527204202656, 819.700809204636, 827.1067247372823, 4509.819607215674, 4524.5701658342405, 4552.635789136861, 4552.7495987720995, 4559.863204103882, 59204.40795591989, 59632.40367596268, 59885.10172347418, 59983.70008150019, 60002.39997599968, 54080.459195407544, 55255.72372138114, 55620.0, 56233.0, 56667.43332566704, 45358.546414535434, 46560.5343946563, 47151.0, 47860.760696196994, 48212.27681584849, 9527.428354298765, 9554.856677149988, 9643.903560964582, 9732.902670973483, 9777.657781977881, 36459.27081458409, 37362.81318593498, 37432.25135497329, 37791.05522361963, 39293.214135717695, 43340.0, 44391.55608444003, 45989.77005114953, 48359.758201208766, 49724.254136187265, 12344.321062341658, 12713.491460341484, 12786.61640150797, 12859.29273889945, 12999.1550549214, 13957.720845582828, 14021.3690383935, 14131.576052718436, 14278.571642850731, 14471.927640361731, 12291.0, 12406.193597416139, 12831.358432078172, 12948.93525532404, 13274.203547787163, 13151.60545183646, 13639.659008524866, 13871.583852484442, 14413.13521188732, 14470.855291446951, 13309.80035299452, 13496.055276130577, 13527.323633818072, 13649.0, 13739.381727822072, 11035.668929931793, 11077.169212308949, 11227.607033753779, 11282.887171128184, 11310.773784524099, 10926.399048052433, 11118.833217501582, 11380.658580242605, 11393.0, 11413.714657133638], "value": 7232.596894928903, "unit": "score"}], "name": "dromaeo_css", "value": 7449.629298767705, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 110.0, 109.0, 109.0, 110.0, 105.0, 109.0, 111.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 132.0, 156.0, 174.0, 126.0, 153.0, 173.0, 138.0, 191.0, 127.0], "value": 152.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 161.0, 160.0, 159.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 170.0, 77.0, 75.0, 76.0, 74.0, 160.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 147.0, 92.0, 92.0, 91.0, 149.0, 90.0, 91.0, 149.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 56.0, 55.0, 55.0, 57.0, 68.0, 53.0, 53.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 58.0, 59.0, 58.0, 58.0, 59.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 71.0, 74.0, 76.0, 72.0, 73.0, 72.0, 72.0, 74.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 113.0, 112.0, 117.0, 113.0, 109.0, 111.0, 115.0, 125.0, 125.0], "value": 116.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 155.0, 156.0, 160.0, 155.0, 160.0, 156.0, 164.0, 156.0, 156.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 64.0, 66.0, 64.0, 66.0, 65.0, 65.0, 66.0, 64.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1509.8000000000002, "alertThreshold": 2.0}]} 08:03:15 INFO - Return code: 0 08:03:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:03:15 ERROR - # TBPL SUCCESS # 08:03:15 INFO - Running post-action listener: _resource_record_post_action 08:03:15 INFO - Running post-run listener: _resource_record_post_run 08:03:16 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 327929856; Read time: 24; Write time: 248768 08:03:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 82853888; Read time: 0; Write time: 79356 08:03:16 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 245075968; Read time: 24; Write time: 169412 08:03:16 INFO - Running post-run listener: _upload_blobber_files 08:03:16 INFO - Blob upload gear active. 08:03:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:03:16 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 08:03:16 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'] 08:03:16 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 08:03:16 INFO - (blobuploader) - INFO - Open directory for files ... 08:03:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:03:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:03:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:17 INFO - (blobuploader) - INFO - Done attempting. 08:03:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:03:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:03:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:18 INFO - (blobuploader) - INFO - Done attempting. 08:03:18 INFO - (blobuploader) - INFO - Iteration through files over. 08:03:18 INFO - Return code: 0 08:03:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:03:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:03:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79806dae51bbf34977717e6f1033cdbed4aebc698e3cabfa82eab2a8fee820ab8e7f648309019fd84a2a443486ae38d21769176701a32a069d3f28316611464f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f99fd79c9ef5bfb29b13f6d79e3e0f013b75023a90966efb58b04c05fd7248df4976a5bc0c4b676de07005dc65d209745284e59ba86910b156746c5411d7cce9"} 08:03:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:03:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:03:18 INFO - Contents: 08:03:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79806dae51bbf34977717e6f1033cdbed4aebc698e3cabfa82eab2a8fee820ab8e7f648309019fd84a2a443486ae38d21769176701a32a069d3f28316611464f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f99fd79c9ef5bfb29b13f6d79e3e0f013b75023a90966efb58b04c05fd7248df4976a5bc0c4b676de07005dc65d209745284e59ba86910b156746c5411d7cce9"} 08:03:18 INFO - Running post-run listener: copy_logs_to_upload_dir 08:03:18 INFO - Copying logs to upload dir... 08:03:18 INFO - mkdir: /builds/slave/test/build/upload/logs 08:03:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.962919 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-05-21 08:03:18.492033) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 08:03:18.495903) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640 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/79806dae51bbf34977717e6f1033cdbed4aebc698e3cabfa82eab2a8fee820ab8e7f648309019fd84a2a443486ae38d21769176701a32a069d3f28316611464f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f99fd79c9ef5bfb29b13f6d79e3e0f013b75023a90966efb58b04c05fd7248df4976a5bc0c4b676de07005dc65d209745284e59ba86910b156746c5411d7cce9"} build_url:https://queue.taskcluster.net/v1/task/AbY4bj4ORxuLcaA000J-tw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/AbY4bj4ORxuLcaA000J-tw/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/79806dae51bbf34977717e6f1033cdbed4aebc698e3cabfa82eab2a8fee820ab8e7f648309019fd84a2a443486ae38d21769176701a32a069d3f28316611464f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f99fd79c9ef5bfb29b13f6d79e3e0f013b75023a90966efb58b04c05fd7248df4976a5bc0c4b676de07005dc65d209745284e59ba86910b156746c5411d7cce9"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 08:03:18.566050) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 08:03:18.566370) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463841190.50679-869376640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 08:03:18.627475) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 08:03:18.627798) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 08:03:18.628058) ========= ========= Total master_lag: 0.22 =========