builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1464652322.31 results: success (0) buildid: 20160526112438 builduid: 7b7803f5dee74ad79ba6e8f098a8fa00 revision: 417e1ec42d8f68c55e52c336cdf81e83323db88c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:02.310512) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:02.311217) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:02.311696) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:02.324899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:02.325394) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 16:52:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.2M=0s 2016-05-30 16:52:02 (34.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122340 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:02.460476) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:02.460815) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023163 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:02.510394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:52:02.510768) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 417e1ec42d8f68c55e52c336cdf81e83323db88c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 417e1ec42d8f68c55e52c336cdf81e83323db88c --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=82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 16:52:02,608 truncating revision to first 12 chars 2016-05-30 16:52:02,608 Setting DEBUG logging. 2016-05-30 16:52:02,608 attempt 1/10 2016-05-30 16:52:02,608 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/417e1ec42d8f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 16:52:03,832 unpacking tar archive at: mozilla-beta-417e1ec42d8f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.567268 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:52:04.091466) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:04.091808) ========= script_repo_revision: 417e1ec42d8f68c55e52c336cdf81e83323db88c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:04.092217) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:04.092510) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:52:04.102748) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-05-30 16:52:04.103153) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:52:04 INFO - MultiFileLogger online at 20160530 16:52:04 in /builds/slave/test 16:52:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:52:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:52:04 INFO - {'append_to_log': False, 16:52:04 INFO - 'base_work_dir': '/builds/slave/test', 16:52:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:52:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:52:04 INFO - 'branch': 'Mozilla-Beta', 16:52:04 INFO - 'buildbot_json_path': 'buildprops.json', 16:52:04 INFO - 'config_files': ('talos/linux_config.py',), 16:52:04 INFO - 'default_actions': ('clobber', 16:52:04 INFO - 'read-buildbot-config', 16:52:04 INFO - 'download-and-extract', 16:52:04 INFO - 'populate-webroot', 16:52:04 INFO - 'create-virtualenv', 16:52:04 INFO - 'install', 16:52:04 INFO - 'run-tests'), 16:52:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:52:04 INFO - 'download_minidump_stackwalk': True, 16:52:04 INFO - 'download_symbols': 'ondemand', 16:52:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:52:04 INFO - 'tooltool.py': '/tools/tooltool.py', 16:52:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:52:04 INFO - '/tools/misc-python/virtualenv.py')}, 16:52:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:52:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:52:04 INFO - 'installer_path': 'installer.exe', 16:52:04 INFO - 'log_level': 'info', 16:52:04 INFO - 'log_name': 'talos', 16:52:04 INFO - 'log_to_console': True, 16:52:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:52:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:52:04 INFO - 'opt_config_files': (), 16:52:04 INFO - 'pip_index': False, 16:52:04 INFO - 'sps_profile': False, 16:52:04 INFO - 'sps_profile_interval': 0, 16:52:04 INFO - 'suite': 'dromaeojs', 16:52:04 INFO - 'system_bits': '32', 16:52:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:52:04 INFO - 'title': 'talos-linux64-ix-066', 16:52:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:52:04 INFO - 'use_talos_json': True, 16:52:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:52:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:52:04 INFO - 'work_dir': 'build'} 16:52:04 INFO - ##### 16:52:04 INFO - ##### Running clobber step. 16:52:04 INFO - ##### 16:52:04 INFO - Running pre-action listener: _resource_record_pre_action 16:52:04 INFO - Running main action method: clobber 16:52:04 INFO - rmtree: /builds/slave/test/build 16:52:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:52:04 INFO - Running post-action listener: _resource_record_post_action 16:52:04 INFO - ##### 16:52:04 INFO - ##### Running read-buildbot-config step. 16:52:04 INFO - ##### 16:52:04 INFO - Running pre-action listener: _resource_record_pre_action 16:52:04 INFO - Running main action method: read_buildbot_config 16:52:04 INFO - Using buildbot properties: 16:52:04 INFO - { 16:52:04 INFO - "project": "", 16:52:04 INFO - "product": "firefox", 16:52:04 INFO - "script_repo_revision": "production", 16:52:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 16:52:04 INFO - "repository": "", 16:52:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 16:52:04 INFO - "buildid": "20160526112438", 16:52:04 INFO - "pgo_build": "True", 16:52:04 INFO - "basedir": "/builds/slave/test", 16:52:04 INFO - "buildnumber": 23, 16:52:04 INFO - "slavename": "talos-linux64-ix-066", 16:52:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:52:04 INFO - "platform": "ubuntu64_hw", 16:52:04 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:52:04 INFO - "branch": "mozilla-beta", 16:52:04 INFO - "repo_path": "releases/mozilla-beta", 16:52:04 INFO - "revision": "417e1ec42d8f68c55e52c336cdf81e83323db88c", 16:52:04 INFO - "stage_platform": "linux64-pgo", 16:52:04 INFO - "builduid": "7b7803f5dee74ad79ba6e8f098a8fa00", 16:52:04 INFO - "slavebuilddir": "test" 16:52:04 INFO - } 16:52:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 16:52:04 INFO - Running post-action listener: _resource_record_post_action 16:52:04 INFO - ##### 16:52:04 INFO - ##### Running download-and-extract step. 16:52:04 INFO - ##### 16:52:04 INFO - Running pre-action listener: _resource_record_pre_action 16:52:04 INFO - Running main action method: download_and_extract 16:52:04 INFO - mkdir: /builds/slave/test/build/tests 16:52: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')]} 16:52:04 INFO - https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:52:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:52:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:52:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:52:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:52:05 INFO - Downloaded 1412 bytes. 16:52:05 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:52:05 INFO - Using the following test package requirements: 16:52:05 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:52:05 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:05 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:52:05 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:05 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 16:52:05 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:05 INFO - u'jsshell-linux-x86_64.zip'], 16:52:05 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:05 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:52:05 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:52:05 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:05 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 16:52:05 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:05 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 16:52:05 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:05 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:52:05 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:52:05 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:52:05 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:52:05 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:05 INFO - https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:52:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:52:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:52:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:52:06 INFO - Downloaded 23434090 bytes. 16:52:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:52:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:52:07 INFO - Return code: 0 16:52:07 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:52: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')]} 16:52:07 INFO - https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:52:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:52:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:52:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:52:09 INFO - Downloaded 23434090 bytes. 16:52:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:52:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:52:10 INFO - Return code: 0 16:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:10 INFO - https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:52:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:52:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:52:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:52:11 INFO - Downloaded 10845194 bytes. 16:52:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:52:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:52:11 INFO - Return code: 0 16:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:11 INFO - https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:52:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:52:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:52:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:52:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:52:13 INFO - Downloaded 53852157 bytes. 16:52:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:52:13 INFO - mkdir: /builds/slave/test/properties 16:52:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:52:13 INFO - Writing to file /builds/slave/test/properties/build_url 16:52:13 INFO - Contents: 16:52:13 INFO - build_url:https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:52:14 INFO - Running post-action listener: _resource_record_post_action 16:52:14 INFO - Running post-action listener: set_extra_try_arguments 16:52:14 INFO - ##### 16:52:14 INFO - ##### Running populate-webroot step. 16:52:14 INFO - ##### 16:52:14 INFO - Running pre-action listener: _resource_record_pre_action 16:52:14 INFO - Running main action method: populate_webroot 16:52:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:52:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:52:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:52:14 INFO - '--tppagecycles', 16:52:14 INFO - '7'], 16:52:14 INFO - 'tests': ['tsvgm']}}, 16:52:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:52:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:52:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:52:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:52:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:52:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:52:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:14 INFO - 'talos_options': ['--e10s'], 16:52:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:14 INFO - 'tests': ['damp', 'tps']}, 16:52:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:14 INFO - 'talos_options': ['--e10s'], 16:52:14 INFO - 'tests': ['damp', 'tps']}, 16:52:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:52:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:52:14 INFO - 'other': {'tests': ['a11yr', 16:52:14 INFO - 'ts_paint', 16:52:14 INFO - 'tpaint', 16:52:14 INFO - 'sessionrestore', 16:52:14 INFO - 'sessionrestore_no_auto_restore', 16:52:14 INFO - 'tabpaint']}, 16:52:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:52:14 INFO - 'tests': ['a11yr', 16:52:14 INFO - 'ts_paint', 16:52:14 INFO - 'tpaint', 16:52:14 INFO - 'sessionrestore', 16:52:14 INFO - 'sessionrestore_no_auto_restore', 16:52:14 INFO - 'tabpaint']}, 16:52:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:52:14 INFO - 'tests': ['a11yr', 16:52:14 INFO - 'ts_paint', 16:52:14 INFO - 'tpaint', 16:52:14 INFO - 'sessionrestore', 16:52:14 INFO - 'sessionrestore_no_auto_restore', 16:52:14 INFO - 'tabpaint']}, 16:52:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:52:14 INFO - 'tests': ['a11yr', 16:52:14 INFO - 'ts_paint', 16:52:14 INFO - 'tpaint', 16:52:14 INFO - 'sessionrestore', 16:52:14 INFO - 'sessionrestore_no_auto_restore', 16:52:14 INFO - 'tabpaint']}, 16:52:14 INFO - 'other_l64': {'tests': ['a11yr', 16:52:14 INFO - 'ts_paint', 16:52:14 INFO - 'tpaint', 16:52:14 INFO - 'sessionrestore', 16:52:14 INFO - 'sessionrestore_no_auto_restore', 16:52:14 INFO - 'tabpaint']}, 16:52:14 INFO - 'other_nol64': {'tests': ['a11yr', 16:52:14 INFO - 'ts_paint', 16:52:14 INFO - 'tpaint', 16:52:14 INFO - 'sessionrestore', 16:52:14 INFO - 'sessionrestore_no_auto_restore', 16:52:14 INFO - 'tabpaint']}, 16:52:14 INFO - 'svgr': {'tests': ['tsvgx', 16:52:14 INFO - 'tsvgr_opacity', 16:52:14 INFO - 'tart', 16:52:14 INFO - 'tscrollx', 16:52:14 INFO - 'cart']}, 16:52:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:52:14 INFO - 'tests': ['tsvgx', 16:52:14 INFO - 'tsvgr_opacity', 16:52:14 INFO - 'tart', 16:52:14 INFO - 'tscrollx', 16:52:14 INFO - 'cart']}, 16:52:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:14 INFO - 'tests': ['tp5o']}, 16:52:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:14 INFO - 'talos_options': ['--e10s'], 16:52:14 INFO - 'tests': ['tp5o']}, 16:52:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:14 INFO - 'talos_options': ['--xperf_path', 16:52:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:14 INFO - 'tests': ['tp5n']}, 16:52:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:14 INFO - 'talos_options': ['--e10s', 16:52:14 INFO - '--xperf_path', 16:52:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:14 INFO - 'tests': ['tp5n']}}, 16:52:14 INFO - 'talos.zip': {'path': '', 16:52:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:52:14 INFO - Running post-action listener: _resource_record_post_action 16:52:14 INFO - ##### 16:52:14 INFO - ##### Running create-virtualenv step. 16:52:14 INFO - ##### 16:52:14 INFO - Running pre-action listener: _resource_record_pre_action 16:52:14 INFO - Running main action method: create_virtualenv 16:52:14 INFO - Creating virtualenv /builds/slave/test/build/venv 16:52:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:52:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:52:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:52:14 INFO - Using real prefix '/usr' 16:52:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:52:14 INFO - Installing distribute.............................................................................................................................................................................................done. 16:52:16 INFO - Installing pip.................done. 16:52:16 INFO - Return code: 0 16:52:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:52: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')]} 16:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52: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')]} 16:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:16 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 0x7f4383f17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1160>, '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 0x29d2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d24f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:52:16 INFO - Using env: {'DISPLAY': ':0', 16:52:16 INFO - 'HOME': '/home/cltbld', 16:52:16 INFO - 'LANG': 'en_US.UTF-8', 16:52:16 INFO - 'LANGUAGE': 'en_US:en', 16:52:16 INFO - 'LOGNAME': 'cltbld', 16:52:16 INFO - 'MAIL': '/var/mail/cltbld', 16:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:16 INFO - 'MOZ_NO_REMOTE': '1', 16:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:16 INFO - 'NO_EM_RESTART': '1', 16:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:16 INFO - 'PWD': '/builds/slave/test', 16:52:16 INFO - 'SHELL': '/bin/bash', 16:52:16 INFO - 'SHLVL': '1', 16:52:16 INFO - 'TERM': 'linux', 16:52:16 INFO - 'TMOUT': '86400', 16:52:16 INFO - 'USER': 'cltbld', 16:52:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 16:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:16 INFO - '_': '/tools/buildbot/bin/python'} 16:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:52:16 INFO - Cleaning up... 16:52:16 INFO - Return code: 0 16:52:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:52: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')]} 16:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52: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')]} 16:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:16 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 0x7f4383f17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1160>, '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 0x29d2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d24f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:52:16 INFO - Using env: {'DISPLAY': ':0', 16:52:16 INFO - 'HOME': '/home/cltbld', 16:52:16 INFO - 'LANG': 'en_US.UTF-8', 16:52:16 INFO - 'LANGUAGE': 'en_US:en', 16:52:16 INFO - 'LOGNAME': 'cltbld', 16:52:16 INFO - 'MAIL': '/var/mail/cltbld', 16:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:16 INFO - 'MOZ_NO_REMOTE': '1', 16:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:16 INFO - 'NO_EM_RESTART': '1', 16:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:16 INFO - 'PWD': '/builds/slave/test', 16:52:16 INFO - 'SHELL': '/bin/bash', 16:52:16 INFO - 'SHLVL': '1', 16:52:16 INFO - 'TERM': 'linux', 16:52:16 INFO - 'TMOUT': '86400', 16:52:16 INFO - 'USER': 'cltbld', 16:52:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 16:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:16 INFO - '_': '/tools/buildbot/bin/python'} 16:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:17 INFO - Downloading/unpacking psutil>=0.7.1 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:52:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:19 INFO - Installing collected packages: psutil 16:52:19 INFO - Running setup.py install for psutil 16:52:19 INFO - building 'psutil._psutil_linux' extension 16:52:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:52:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:52:19 INFO - building 'psutil._psutil_posix' extension 16:52:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:52:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:52:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:19 INFO - Successfully installed psutil 16:52:19 INFO - Cleaning up... 16:52:19 INFO - Return code: 0 16:52:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:52: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')]} 16:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52: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')]} 16:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:19 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 0x7f4383f17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1160>, '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 0x29d2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d24f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:52:19 INFO - Using env: {'DISPLAY': ':0', 16:52:19 INFO - 'HOME': '/home/cltbld', 16:52:19 INFO - 'LANG': 'en_US.UTF-8', 16:52:19 INFO - 'LANGUAGE': 'en_US:en', 16:52:19 INFO - 'LOGNAME': 'cltbld', 16:52:19 INFO - 'MAIL': '/var/mail/cltbld', 16:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:19 INFO - 'MOZ_NO_REMOTE': '1', 16:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:19 INFO - 'NO_EM_RESTART': '1', 16:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:19 INFO - 'PWD': '/builds/slave/test', 16:52:19 INFO - 'SHELL': '/bin/bash', 16:52:19 INFO - 'SHLVL': '1', 16:52:19 INFO - 'TERM': 'linux', 16:52:19 INFO - 'TMOUT': '86400', 16:52:19 INFO - 'USER': 'cltbld', 16:52:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 16:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:19 INFO - '_': '/tools/buildbot/bin/python'} 16:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:52:21 INFO - Installing collected packages: mozsystemmonitor 16:52:21 INFO - Running setup.py install for mozsystemmonitor 16:52:22 INFO - Successfully installed mozsystemmonitor 16:52:22 INFO - Cleaning up... 16:52:22 INFO - Return code: 0 16:52:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:22 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 0x7f4383f17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1160>, '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 0x29d2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d24f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:52:22 INFO - Using env: {'DISPLAY': ':0', 16:52:22 INFO - 'HOME': '/home/cltbld', 16:52:22 INFO - 'LANG': 'en_US.UTF-8', 16:52:22 INFO - 'LANGUAGE': 'en_US:en', 16:52:22 INFO - 'LOGNAME': 'cltbld', 16:52:22 INFO - 'MAIL': '/var/mail/cltbld', 16:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:22 INFO - 'MOZ_NO_REMOTE': '1', 16:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:22 INFO - 'NO_EM_RESTART': '1', 16:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:22 INFO - 'PWD': '/builds/slave/test', 16:52:22 INFO - 'SHELL': '/bin/bash', 16:52:22 INFO - 'SHLVL': '1', 16:52:22 INFO - 'TERM': 'linux', 16:52:22 INFO - 'TMOUT': '86400', 16:52:22 INFO - 'USER': 'cltbld', 16:52:22 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 16:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:22 INFO - '_': '/tools/buildbot/bin/python'} 16:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:22 INFO - Downloading/unpacking blobuploader==1.2.4 16:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:24 INFO - Downloading blobuploader-1.2.4.tar.gz 16:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:52:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:52:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:24 INFO - Downloading docopt-0.6.1.tar.gz 16:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:52:24 INFO - Installing collected packages: blobuploader, requests, docopt 16:52:24 INFO - Running setup.py install for blobuploader 16:52:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:52:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:52:25 INFO - Running setup.py install for requests 16:52:25 INFO - Running setup.py install for docopt 16:52:25 INFO - Successfully installed blobuploader requests docopt 16:52:25 INFO - Cleaning up... 16:52:25 INFO - Return code: 0 16:52:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:25 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 0x7f4383f17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1160>, '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 0x29d2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d24f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:52:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:52:25 INFO - Using env: {'DISPLAY': ':0', 16:52:25 INFO - 'HOME': '/home/cltbld', 16:52:25 INFO - 'LANG': 'en_US.UTF-8', 16:52:25 INFO - 'LANGUAGE': 'en_US:en', 16:52:25 INFO - 'LOGNAME': 'cltbld', 16:52:25 INFO - 'MAIL': '/var/mail/cltbld', 16:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:25 INFO - 'MOZ_NO_REMOTE': '1', 16:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:25 INFO - 'NO_EM_RESTART': '1', 16:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:25 INFO - 'PWD': '/builds/slave/test', 16:52:25 INFO - 'SHELL': '/bin/bash', 16:52:25 INFO - 'SHLVL': '1', 16:52:25 INFO - 'TERM': 'linux', 16:52:25 INFO - 'TMOUT': '86400', 16:52:25 INFO - 'USER': 'cltbld', 16:52:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 16:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:25 INFO - '_': '/tools/buildbot/bin/python'} 16:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:52:25 INFO - Running setup.py (path:/tmp/pip-KPf0ZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:52:25 INFO - Running setup.py (path:/tmp/pip-xKzgRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:52:25 INFO - Running setup.py (path:/tmp/pip-uLTDf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:52:25 INFO - Running setup.py (path:/tmp/pip-4L4ySP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:52:26 INFO - Running setup.py (path:/tmp/pip-zrxkgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:52:26 INFO - Running setup.py (path:/tmp/pip-L4aSAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:52:26 INFO - Running setup.py (path:/tmp/pip-T3mkFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:52:26 INFO - Running setup.py (path:/tmp/pip-sOMJmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:52:26 INFO - Running setup.py (path:/tmp/pip-jqDRtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:52:26 INFO - Running setup.py (path:/tmp/pip-Enmrvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:52:26 INFO - Running setup.py (path:/tmp/pip-nrezyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:52:26 INFO - Running setup.py (path:/tmp/pip-NxwCD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:52:26 INFO - Running setup.py (path:/tmp/pip-PsY8DC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:52:26 INFO - Running setup.py (path:/tmp/pip-6Y8yiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:26 INFO - Running setup.py (path:/tmp/pip-EGT_KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:52:26 INFO - Running setup.py (path:/tmp/pip-PD3hos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:52:26 INFO - Running setup.py (path:/tmp/pip-lkRl23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:52:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:52:26 INFO - Running setup.py install for manifestparser 16:52:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:52:27 INFO - Running setup.py install for mozcrash 16:52:27 INFO - Running setup.py install for mozdebug 16:52:27 INFO - Running setup.py install for mozdevice 16:52:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:52:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:52:27 INFO - Running setup.py install for mozfile 16:52:27 INFO - Running setup.py install for mozhttpd 16:52:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:52:27 INFO - Running setup.py install for mozinfo 16:52:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:52:27 INFO - Running setup.py install for mozInstall 16:52:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:52:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:52:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:52:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:52:27 INFO - Running setup.py install for mozleak 16:52:27 INFO - Running setup.py install for mozlog 16:52:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:52:28 INFO - Running setup.py install for moznetwork 16:52:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:52:28 INFO - Running setup.py install for mozprocess 16:52:28 INFO - Running setup.py install for mozprofile 16:52:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:52:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:52:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:52:28 INFO - Running setup.py install for mozrunner 16:52:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:52:28 INFO - Running setup.py install for mozscreenshot 16:52:28 INFO - Running setup.py install for moztest 16:52:28 INFO - Running setup.py install for mozversion 16:52:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:52:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:52:28 INFO - Cleaning up... 16:52:28 INFO - Return code: 0 16:52:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:28 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 0x7f4383f17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1160>, '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 0x29d2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d24f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:52:28 INFO - Using env: {'DISPLAY': ':0', 16:52:28 INFO - 'HOME': '/home/cltbld', 16:52:28 INFO - 'LANG': 'en_US.UTF-8', 16:52:28 INFO - 'LANGUAGE': 'en_US:en', 16:52:28 INFO - 'LOGNAME': 'cltbld', 16:52:28 INFO - 'MAIL': '/var/mail/cltbld', 16:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:28 INFO - 'MOZ_NO_REMOTE': '1', 16:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:28 INFO - 'NO_EM_RESTART': '1', 16:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:28 INFO - 'PWD': '/builds/slave/test', 16:52:28 INFO - 'SHELL': '/bin/bash', 16:52:28 INFO - 'SHLVL': '1', 16:52:28 INFO - 'TERM': 'linux', 16:52:28 INFO - 'TMOUT': '86400', 16:52:28 INFO - 'USER': 'cltbld', 16:52:28 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 16:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:28 INFO - '_': '/tools/buildbot/bin/python'} 16:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:52:28 INFO - Running setup.py (path:/tmp/pip-Gudq58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:52:29 INFO - Running setup.py (path:/tmp/pip-EFhq8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:52:29 INFO - Running setup.py (path:/tmp/pip-R39U5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:52:29 INFO - Running setup.py (path:/tmp/pip-374frT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:52:29 INFO - Running setup.py (path:/tmp/pip-SRiTUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:52:29 INFO - Running setup.py (path:/tmp/pip-xXmjQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:52:29 INFO - Running setup.py (path:/tmp/pip-TLH4eA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:52:29 INFO - Running setup.py (path:/tmp/pip-hqoKKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:52:29 INFO - Running setup.py (path:/tmp/pip-_f_DxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:52:29 INFO - Running setup.py (path:/tmp/pip-bp70tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:52:29 INFO - Running setup.py (path:/tmp/pip-YN_JzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:52:29 INFO - Running setup.py (path:/tmp/pip-ziMMUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:52:29 INFO - Running setup.py (path:/tmp/pip-_rMGQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:52:29 INFO - Running setup.py (path:/tmp/pip-k0jTNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:30 INFO - Running setup.py (path:/tmp/pip-W_xla9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:52:30 INFO - Running setup.py (path:/tmp/pip-f3E0fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:52:30 INFO - Running setup.py (path:/tmp/pip-w752Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:52:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:32 INFO - Downloading blessings-1.6.tar.gz 16:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:52:32 INFO - Installing collected packages: blessings 16:52:32 INFO - Running setup.py install for blessings 16:52:32 INFO - Successfully installed blessings 16:52:32 INFO - Cleaning up... 16:52:32 INFO - Return code: 0 16:52:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:52:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:52:32 INFO - Reading from file tmpfile_stdout 16:52:32 INFO - Current package versions: 16:52:32 INFO - argparse == 1.2.1 16:52:32 INFO - blessings == 1.6 16:52:32 INFO - blobuploader == 1.2.4 16:52:32 INFO - docopt == 0.6.1 16:52:32 INFO - manifestparser == 1.1 16:52:32 INFO - mozInstall == 1.12 16:52:32 INFO - mozcrash == 0.17 16:52:32 INFO - mozdebug == 0.1 16:52:32 INFO - mozdevice == 0.48 16:52:32 INFO - mozfile == 1.2 16:52:32 INFO - mozhttpd == 0.7 16:52:32 INFO - mozinfo == 0.9 16:52:32 INFO - mozleak == 0.1 16:52:32 INFO - mozlog == 3.1 16:52:32 INFO - moznetwork == 0.27 16:52:32 INFO - mozprocess == 0.22 16:52:32 INFO - mozprofile == 0.28 16:52:32 INFO - mozrunner == 6.11 16:52:32 INFO - mozscreenshot == 0.1 16:52:32 INFO - mozsystemmonitor == 0.0 16:52:32 INFO - moztest == 0.7 16:52:32 INFO - mozversion == 1.4 16:52:32 INFO - psutil == 3.1.1 16:52:32 INFO - requests == 1.2.3 16:52:32 INFO - wsgiref == 0.1.2 16:52:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:32 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 0x7f4383f17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1160>, '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 0x29d2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d24f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:52:32 INFO - Using env: {'DISPLAY': ':0', 16:52:32 INFO - 'HOME': '/home/cltbld', 16:52:32 INFO - 'LANG': 'en_US.UTF-8', 16:52:32 INFO - 'LANGUAGE': 'en_US:en', 16:52:32 INFO - 'LOGNAME': 'cltbld', 16:52:32 INFO - 'MAIL': '/var/mail/cltbld', 16:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:32 INFO - 'MOZ_NO_REMOTE': '1', 16:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:32 INFO - 'NO_EM_RESTART': '1', 16:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:32 INFO - 'PWD': '/builds/slave/test', 16:52:32 INFO - 'SHELL': '/bin/bash', 16:52:32 INFO - 'SHLVL': '1', 16:52:32 INFO - 'TERM': 'linux', 16:52:32 INFO - 'TMOUT': '86400', 16:52:32 INFO - 'USER': 'cltbld', 16:52:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 16:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:32 INFO - '_': '/tools/buildbot/bin/python'} 16:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:52:32 INFO - Cleaning up... 16:52:32 INFO - Return code: 0 16:52:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:32 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 0x7f4383f17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1160>, '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 0x29d2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d24f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:52:32 INFO - Using env: {'DISPLAY': ':0', 16:52:32 INFO - 'HOME': '/home/cltbld', 16:52:32 INFO - 'LANG': 'en_US.UTF-8', 16:52:32 INFO - 'LANGUAGE': 'en_US:en', 16:52:32 INFO - 'LOGNAME': 'cltbld', 16:52:32 INFO - 'MAIL': '/var/mail/cltbld', 16:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:32 INFO - 'MOZ_NO_REMOTE': '1', 16:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:32 INFO - 'NO_EM_RESTART': '1', 16:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:32 INFO - 'PWD': '/builds/slave/test', 16:52:32 INFO - 'SHELL': '/bin/bash', 16:52:32 INFO - 'SHLVL': '1', 16:52:32 INFO - 'TERM': 'linux', 16:52:32 INFO - 'TMOUT': '86400', 16:52:32 INFO - 'USER': 'cltbld', 16:52:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 16:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:32 INFO - '_': '/tools/buildbot/bin/python'} 16:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:32 INFO - Downloading/unpacking jsonschema 16:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:52:34 INFO - Downloading/unpacking functools32 (from jsonschema) 16:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:35 INFO - Downloading functools32-3.2.3-2.tar.gz 16:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:52:35 INFO - warning: no files found matching '*.txt' 16:52:35 INFO - no previously-included directories found matching 'build' 16:52:35 INFO - no previously-included directories found matching 'dist' 16:52:35 INFO - no previously-included directories found matching '.git*' 16:52:35 INFO - Installing collected packages: jsonschema, functools32 16:52:35 INFO - Running setup.py install for functools32 16:52:35 INFO - warning: no files found matching '*.txt' 16:52:35 INFO - no previously-included directories found matching 'build' 16:52:35 INFO - no previously-included directories found matching 'dist' 16:52:35 INFO - no previously-included directories found matching '.git*' 16:52:35 INFO - Successfully installed jsonschema functools32 16:52:35 INFO - Cleaning up... 16:52:35 INFO - Return code: 0 16:52:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:35 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 0x7f4383f17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2942410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1160>, '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 0x29d2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d24f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:52:35 INFO - Using env: {'DISPLAY': ':0', 16:52:35 INFO - 'HOME': '/home/cltbld', 16:52:35 INFO - 'LANG': 'en_US.UTF-8', 16:52:35 INFO - 'LANGUAGE': 'en_US:en', 16:52:35 INFO - 'LOGNAME': 'cltbld', 16:52:35 INFO - 'MAIL': '/var/mail/cltbld', 16:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:35 INFO - 'MOZ_NO_REMOTE': '1', 16:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:35 INFO - 'NO_EM_RESTART': '1', 16:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:35 INFO - 'PWD': '/builds/slave/test', 16:52:35 INFO - 'SHELL': '/bin/bash', 16:52:35 INFO - 'SHLVL': '1', 16:52:35 INFO - 'TERM': 'linux', 16:52:35 INFO - 'TMOUT': '86400', 16:52:35 INFO - 'USER': 'cltbld', 16:52:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 16:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:35 INFO - '_': '/tools/buildbot/bin/python'} 16:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:35 INFO - Downloading/unpacking flake8 16:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:52:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:52:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:52:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:52:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:52:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:52:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:52:38 INFO - no previously-included directories found matching 'docs/_build' 16:52:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:52:38 INFO - Running setup.py install for pep8 16:52:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:52:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:52:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:52:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:52:38 INFO - no previously-included directories found matching 'docs/_build' 16:52:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:52:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:52:38 INFO - Cleaning up... 16:52:38 INFO - Return code: 0 16:52:38 INFO - Running post-action listener: _resource_record_post_action 16:52:38 INFO - Running post-action listener: _start_resource_monitoring 16:52:38 INFO - Starting resource monitoring. 16:52:38 INFO - ##### 16:52:38 INFO - ##### Running install step. 16:52:38 INFO - ##### 16:52:38 INFO - Running pre-action listener: _resource_record_pre_action 16:52:38 INFO - Running main action method: install 16:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:52:38 INFO - Reading from file tmpfile_stdout 16:52:38 INFO - Detecting whether we're running mozinstall >=1.0... 16:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:52:38 INFO - Reading from file tmpfile_stdout 16:52:38 INFO - Output received: 16:52:38 INFO - Usage: mozinstall [options] installer 16:52:38 INFO - Options: 16:52:38 INFO - -h, --help show this help message and exit 16:52:38 INFO - -d DEST, --destination=DEST 16:52:38 INFO - Directory to install application into. [default: 16:52:38 INFO - "/builds/slave/test"] 16:52:38 INFO - --app=APP Application being installed. [default: firefox] 16:52:38 INFO - mkdir: /builds/slave/test/build/application 16:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:52:51 INFO - Reading from file tmpfile_stdout 16:52:51 INFO - Output received: 16:52:51 INFO - /builds/slave/test/build/application/firefox/firefox 16:52:51 INFO - Running post-action listener: _resource_record_post_action 16:52:51 INFO - ##### 16:52:51 INFO - ##### Running run-tests step. 16:52:51 INFO - ##### 16:52:51 INFO - Running pre-action listener: _resource_record_pre_action 16:52:51 INFO - Running main action method: run_tests 16:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:52:51 INFO - Python 2.7.3 16:52:51 INFO - Return code: 0 16:52:51 INFO - grabbing minidump binary from tooltool 16:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:51 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 0x29d1160>, '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 0x29d2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d24f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:52:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:52:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:52:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:52:51 INFO - Return code: 0 16:52:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:52:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:52:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:52:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:52:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:52:52 INFO - Return code: 0 16:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:52:52 INFO - Using env: {'DISPLAY': ':0', 16:52:52 INFO - 'HOME': '/home/cltbld', 16:52:52 INFO - 'LANG': 'en_US.UTF-8', 16:52:52 INFO - 'LANGUAGE': 'en_US:en', 16:52:52 INFO - 'LOGNAME': 'cltbld', 16:52:52 INFO - 'MAIL': '/var/mail/cltbld', 16:52:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:52:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:52 INFO - 'MOZ_NO_REMOTE': '1', 16:52:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:52 INFO - 'NO_EM_RESTART': '1', 16:52:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:52 INFO - 'PWD': '/builds/slave/test', 16:52:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:52:52 INFO - 'SHELL': '/bin/bash', 16:52:52 INFO - 'SHLVL': '1', 16:52:52 INFO - 'TERM': 'linux', 16:52:52 INFO - 'TMOUT': '86400', 16:52:52 INFO - 'USER': 'cltbld', 16:52:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968', 16:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:52 INFO - '_': '/tools/buildbot/bin/python'} 16:52:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:52:52 INFO - mozversion application_buildid: 20160526112438 16:52:52 INFO - mozversion application_changeset: 417e1ec42d8f68c55e52c336cdf81e83323db88c 16:52:52 INFO - mozversion application_display_name: Firefox 16:52:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:52:52 INFO - mozversion application_name: Firefox 16:52:52 INFO - mozversion application_remotingname: firefox 16:52:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:52:52 INFO - mozversion application_vendor: Mozilla 16:52:52 INFO - mozversion application_version: 47.0 16:52:52 INFO - mozversion platform_buildid: 20160526112438 16:52:52 INFO - mozversion platform_changeset: 417e1ec42d8f68c55e52c336cdf81e83323db88c 16:52:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:52:52 INFO - mozversion platform_version: 47.0 16:52:52 INFO - using testdate: 1464652372 16:52:52 INFO - actual date: 1464652372 16:52:52 INFO - starting webserver on 'localhost:45524' 16:52:52 INFO - SUITE-START | Running 2 tests 16:52:52 INFO - TEST-START | dromaeo_css 16:52:52 INFO - operating with platform_type : linux_ 16:52:52 INFO - Initialising browser for dromaeo_css test... 16:52:52 INFO - TEST-INFO | started process 5476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN29Hsx/profile http://localhost:45524/getInfo.html) 16:52:57 INFO - PROCESS | 5476 | __metrics Screen width/height:1600/1200 16:52:57 INFO - PROCESS | 5476 | colorDepth:24 16:52:57 INFO - PROCESS | 5476 | Browser inner width/height: 1024/697 16:52:57 INFO - PROCESS | 5476 | __metrics 16:52:58 INFO - PROCESS | 5476 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:52:59 INFO - TEST-INFO | 5476: exit 0 16:52:59 INFO - Browser initialized. 16:52:59 INFO - Running cycle 1/1 for dromaeo_css test... 16:52:59 INFO - TEST-INFO | started process 5569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN29Hsx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:10 INFO - PROCESS | 5569 | RSS: Main: 139034624 16:53:10 INFO - PROCESS | 5569 | 16:54:02 INFO - PROCESS | 5569 | 1464652442434 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:56:09 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:45524/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45524/tests/dromaeo/cssquery-ext.html) 16:56:10 INFO - PROCESS | 5569 | RSS: Main: 215613440 16:56:10 INFO - PROCESS | 5569 | 16:59:12 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:45524/tests/dromaeo/cssquery-ext.html (next: http://localhost:45524/tests/dromaeo/cssquery-jquery.html) 16:59:13 INFO - PROCESS | 5569 | RSS: Main: 222023680 16:59:13 INFO - PROCESS | 5569 | 17:02:14 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:45524/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45524/tests/dromaeo/cssquery-mootools.html) 17:02:15 INFO - PROCESS | 5569 | RSS: Main: 231559168 17:02:15 INFO - PROCESS | 5569 | 17:05:17 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:45524/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45524/tests/dromaeo/cssquery-prototype.html) 17:05:17 INFO - PROCESS | 5569 | RSS: Main: 187314176 17:05:17 INFO - PROCESS | 5569 | 17:08:20 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:45524/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45524/tests/dromaeo/cssquery-yui.html) 17:08:20 INFO - PROCESS | 5569 | RSS: Main: 202760192 17:08:20 INFO - PROCESS | 5569 | 17:11:23 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:45524/tests/dromaeo/cssquery-yui.html (next: http://localhost:45524/tests/dromaeo/cssquery-dojo.html) 17:11:23 INFO - PROCESS | 5569 | RSS: Main: 253194240 17:11:23 INFO - PROCESS | 5569 | 17:11:23 INFO - PROCESS | 5569 | __start_tp_report 17:11:23 INFO - PROCESS | 5569 | _x_x_mozilla_page_load 17:11:23 INFO - PROCESS | 5569 | _x_x_mozilla_page_load_details 17:11:23 INFO - PROCESS | 5569 | |i|pagename|runs| 17:11:23 INFO - PROCESS | 5569 | |0;dojo.html;3221.339625376798;3300.3894279558276;3319.0872510059744;3340.966590334096;3352.9161770955725;5321.201819727043;5335.066363386406;5343.064963631368;5353.330833645794;5353.946460535399;5345.358556973169;5380.865478363043;5381.784728610851;5382.569394448445;5383.542398896088;4682.578567928886;4915.066137433885;4965.329680493123;5026.296318515392;5046.243063540462;4755.2153894607345;4840.661153719224;4841.878953026167;4845.200541910581;4845.903081938359;4853.878653033667;4945.406551213841;4973.452920178777;4989.75051247438;4998.225275082368;4808.975955120237;4935.70385776851;4953.281774142747;4955.776990035457;4961.578265847407;4728.598069164125;4849.903001939977;4870.853874383774;4898.363212782351;4901.803927842882;5171.896562068738;5225.790968361299;5238.214267859814;5246.842594722164;5261.447548007481;5621.578381621394;5622.381538030813;5623.578231632644;5628.915566266509;5635.633683810539;5525.171224316345;5623.49388555028;5659.377468478464;5664.54683625309;5729.28383952006;5382.461753824626;5402.297701298806;5402.459754024605;5405.513503784599;5432.13085906257;5842.620229685142;5849;5849.298084229919;5852.795152169739;5856.180134781134;5451.155070964007;5616.859578510488;5649.491545760901;5664.943350566442;5674.347450043216;5760.510356619734;5767.826965191051;5771.422857714279;5777.942220577825;5785.27684039495;5718.971405142947;5722.484976352065;5726.484616384545;5729.140628905698;5738.626989245686;5521;5694.373618901917;5724.370319264877;5793.971030144907;5815.854603634943;4371.23503386906;4373.169097871394;4376.956230437719;4380.080183161572;4400.515943246241;3952.8418863245147;3971.205758848242;3976.721629485966;4004.3993400990084;4011.5587285398583;5212.4266330703595;5293.12663410533;5342.412334643186;5353.625246232727;5367.973160134175;5747.626404283708;5763.567732420085;5767.596268261265;5773.884522309614;5776.68228247442;5168.7415629218385;5375.5162035417;5389.191621256843;5413.918791218135;5452.263944367539;4973.452920178777;4991.800327986913;5007.023630392038;5008.449070602231;5033.0940430722085;5938.406159384027;5969.79105731306;5989.251343582052;5996.610220335664;5999.400059993965;5536.501714845684;5657.575681823962;5806.129080637854;5806.68063256525;5806.709664516842;5841.766329346949;5897.203877476486;5946.672932988728;5947.01874190771;5982.641041537521;5656.8020119295625;5692.829215123553;5703.173039909107;5710.543156547549;5711.514521265739;5560.7219639018695;5691.943080569141;5727.885442291047;5763.94236057634;5791.623544469596;5673.659580425187;5675.205471234113;5677.205191273308;5678.574106941914;5686.317641883001;5605.691686957257;5637.210790489253;5652.378238393856;5654.745536450787;5663.8017669383025;5308.920366194433;5558.805441809517;5575.080111781511;5611.607187496836;5615.747291371979;5495.395506494203;5619;5661.575381846295;5731.5128214100605;5736.053551164011;5466.234727138124;5495.890082198413;5511.696856672921;5527.723613819373;5548 17:11:23 INFO - PROCESS | 5569 | |1;ext.html;479.76011994003;527.1854984049643;534.6898798696757;542.154239386557;615.4153554123584;30866.845665771667;38260.426093608585;38594.228115437676;38594.42108368373;38628.29601927866;42507.36238956411;42989.140217195636;43020.78489607555;43034.56965430345;43069.13861722771;8787.25308348791;9008.594613242387;9011.684591039282;9014.909850901506;9016.639334426614;8828.426152300111;8943.821123577525;8959.955200223989;8966;8968.865467018;9047.819043619123;9201.355905086646;9203.95398023009;9216.216621587173;9225.769355766093;9127.95436022819;9208.079192080806;9214;9220.400673956172;9223.584938677775;9025.323100767402;9169.954150229272;9172.036936121678;9172.08279172084;9176.90823091774;41819.58180418187;42134.36798448026;42205.78897105495;42224.1555168898;42246.36630450515;3814.7138964577766;3905.628965248297;4136.91726165478;4509.503954564995;4635.93373524088;32387;32467.188320291945;32570.674293257;32806;33851.83074084614;4230.471191101113;4284.8500302489265;4324.372965919955;4339.544347843463;4411.580899814512;281094;282704;282848;283039;284368.57815710997;60331;60347.09479357813;60677.39322606717;60788;60834.087488687706;66186.33813661899;72856;73496.63251683707;73548.26451735414;73738;17169.48491545256;17370.131493425277;17394.21726022332;17414.0422276776;17415;14662.120272783666;14780.630484237765;14825.77761333581;14832.406703731946;14833.851661483248;22002.669959950614;22384.552308954055;22446.32661020172;22464.43838904008;22505.774942250697;7778.766637000899;7928.207179282025;7993.760187194393;8134.715284964997;8248.667638076642;1004.7089490005308;1097.1216748792979;1136.971575710614;1176.276589897207;1198.9580364687195;29636.40727185444;29768.702312977028;30453.23866903345;30720.84639576788;31483.37033259322;997.4962643864947;1128.1087940526893;1143.9199256052163;1144.9141314401286;1211.3398197982121;13739;14112.71774564503;14288.285585720672;14727;15668.138252396227;332929;336464;337478;337731;338194;55982.44017559772;56352;56482.43517564854;56497.71751141218;56558.151627725616;1378.3177327222888;1485.4281101775678;1486.6283429142713;1492.6939977304626;1499.3028241867803;28041.439171216054;29024.56463153012;29305.560416594195;29483.11550653484;29845;45491;54632.45367546433;55399.72300138474;55490;55516.16725749198;301517;302146;305664;307185;307523;40595.7970210147;40646.59353406428;44714.65323663989;49811.50188498069;50620.49379506158;45864;46211.537884620724;46604;46804.53195468138;47099;38953.41569876397;39455.60544394519;39781.80109099436;40240;41019.384709229984;38751;39026.219475610895;39046.60953390544;39218.411723824735;39942;38497;38818.2236355277;39461;39551.80224098861;39767.602323977546;33377.332453351286;35168.824155879054;35487;35813.28373432569;35920.820395897856;26402;26727.732722672525;26852.46295074127;26868.59697104584;27079.466846634143 17:11:23 INFO - PROCESS | 5569 | |2;jquery.html;366.6663336363908;372.78192257529344;374.2066818345109;374.61040517861426;377.8847451527285;17657.11714414279;17789.733154002683;18409.44771656849;18542.814571854276;18559.443216703487;17516.211770470327;18364.173612187482;18637.906810465964;18658.06709664518;18699.3455229067;5450.754716037778;5711.143328500717;5749.885002299951;5752.741126649311;5754.971225143869;4304.139172165579;5597.6641401515835;5949.7025148742605;6206.224221972254;6218.937810621904;6169.444749972502;6178.814635560918;6185.721642526097;6210.09953556734;6220.47125994291;5914.9112763308585;6119.602225855349;6161.661108639;6168.013117901114;6171.691415429233;3837.827297771607;5176.974115129438;5412.3505179378335;5489.6980666063355;5494.36814766303;21241.15035398582;21264.36206913795;21434.571308573897;21651;21652.242171524078;2441.7802397784285;2459.5203935232635;2507.022261318087;2572.382628169226;2572.421205228827;13729.931350343284;13746.65633359174;13894.957878159179;14110.294485275695;14504.057236279714;1661.775660285858;1744.3213035881308;1765.8675599330102;1801.7387478815629;1827.8629102817208;69220.30779692189;70266;70395.64802176008;70597;72098.27901721021;9736.513174341255;10029.548670309854;10304.072633463024;10368.896311036793;10397.792044159074;14314.785278220836;14376.712465750627;14470.638234044023;14505.274736263145;14506.564803055926;8194;8422.284105851071;8433.83132337362;8455.704050358208;8518.361122915681;8393.970893970805;8429.536375499407;8447.704330348408;8543.700970466003;8587.098354672795;6090;6143.262808462924;6194.690265486798;6232.158658581034;6261.749530018748;1726.5683579105223;1732.116620523517;1738.1743671755814;1830.3159107385943;1885.8019907909747;935.5883411299006;971.2521358553875;986.4771671014374;1014.3305418423805;1117.4692021289984;17147.314107435563;17271.65456690859;17361.65276694459;17523.211455484532;17942.192601332972;969.6024629901707;976.6239997600975;992.6327258914248;1016.1819735113157;1031.5512751952924;9731.513424328898;9884.55519501624;10148.695539133838;10254.53854576546;10435.113015393625;457895;471577;472284;483329;491154;51514.48485515172;52082.47917520852;76621.85067223996;78917;83300.58349708213;1025.8050970315617;1086.625114335553;1092.3445932440632;1093.830456279278;1095.45774841454;15492.302846372166;15581.935870841795;15870.682586347977;15988.200589970687;16108.355665773237;23861.761382385954;31405.371892562478;34534;34891.9532414028;35507.82246088753;41792.791036044626;43890.78054609706;45251.321230182235;45657.08685826199;45770;8708.956455217683;8811.383203175972;8871.157240062184;8949.821003579762;9017.819643607223;10169.338992965433;12943.482260709467;13568.118072325267;13759.518416855763;13831.446742130202;6387.712552935036;10621.884702106168;11192.38441885704;11471.13966452536;11749.353785541536;11498.367589782642;11501.367424791717;11575.76848463043;11607.825882611598;11667.124965627781;11594.94202528982;11996.64010079699;12009.879901200877;12043.33761643083;12286.262824230575;8575.742727718178;8815.074417186102;8858.069902660129;8905.599248033725;8994.685186018458;11673.649790506299;12160.331181785086;12211.572594959134;12243.081768867549;12293.692657683629 17:11:23 INFO - PROCESS | 5569 | |3;mootools.html;1363.9795403068963;1592.6336942503224;1621.0435842852714;1851.6204178143473;1926;7496.92503074969;7656.042994625672;7668.961655191716;7676.193999630035;7676.616169191539;7418.666160022798;7534.924650753491;7579.545227286367;7580.88628670569;7582.090149182092;2326.581215381231;2345.6012477878717;2346.1905642553293;2350.330155905567;2352.8353015288935;2327.3018094571644;2346.9530609387803;2370.6207006878903;2384.666146739458;2390.497995420964;2321.315212012452;2342.9297121086393;2356.670066190735;2357.387079359362;2361.2325994051916;2323.8373313868037;2332.6384410416244;2364.2552595932225;2374.050379848057;2378.3102900158933;2311.872846993415;2355.7644235576304;2372.1223147435558;2373.2168384433094;2376.916807911732;6718.563293385914;6864.553804002774;7728.149903510609;7748.2251774822635;7766.06807183136;4280.4221430106845;4424.225760491933;4644.303354496852;4680.110778951988;4704.1767690654;3054.22117360074;3079.291762894547;3089.3975674743433;3099.5040793473163;3124.297033167542;1029.197226163586;1039.8752149742004;1047.9214058945533;1075.4031512510553;1080.027974822658;9944.602215911355;10129.544170512345;10129.746756331077;10133.341332813343;10145;4181.703671861733;4275.080857615628;4296.2266791977745;4316.374125751811;4332.393464914914;9044.231240344512;9051.728448146567;9068.501232432147;9089;9092.772680683036;4906;4917.286993385939;4918.827841025547;4920.3111564381015;4922.58158056562;4433.091216300651;4434.091011342667;4447.421835161473;4466.017476155241;4484.439445069366;3466.6533346665133;3619.529461170031;3630.9636903631153;3648.288583726148;3670.137517683342;1114.509615769059;1129.6159305836056;1137.852079229695;1141.14414189358;1143.2283208834003;1201.405304374323;1204.4399354300292;1290.7095903421655;1468.9045212061183;1511.6145382927502;7463.552186868806;7478.326950574475;7629.7329593463965;7630.2751238632245;7645.426593005435;531.1236459841216;534.1747000883644;542.8642839290178;552.9612927095145;554.0995881692251;5551.944480555224;5566.944330556724;5582.218489411485;5604;5607.327120745455;8234.588270586446;8584.74245772628;8991.190792828676;9135.132162444557;9139.588718507683;8883.777905552284;8920.24177944869;8999.145081217273;9027.368084234173;9033.232175265177;7139.32176443237;7497.737579184703;7522.210167932398;7529.096508419025;7533.9829123068785;7231.566106033655;7258.818529536804;7284;7291.197968223385;7343.963280183565;8356.33149348063;8434.789130271793;8550;8620.13798620158;8643.827123457622;8349.499030058216;8656.22094011542;8683.739487815375;8688.869666955126;8737.038925718292;6777.08509351251;6782.321767823179;6829;6839.829004274933;6844.93155068443;7333.156686981066;7349.118105827335;7384;7396.371308438843;7400.296971787671;6871.931280687129;7015.052967849275;7153.892691609526;7220.350168484862;7299.160596531255;7036.824079398056;7086.185088714864;7125.608091555015;7164.355208031302;7178.3898368637165;6909.654517274015;6945.895811562932;7009.509334346547;7020.122484689414;7026.051483049723;6560.114384558024;6601.438877695449;6634.535582509178;6655.833604159935;6670.299618539983;6823.112995310578;6867.141607299088;6876.587404755731;6878.58728476293;6885.139357580302 17:11:23 INFO - PROCESS | 5569 | |4;prototype.html;339.14535370865417;352.79890462436424;352.86943830782604;353.7894952503261;355.6816649099056;5880.617759845607;5911.615744976579;5916.349201587822;5925.229720136376;5960.165576819238;5833.941660583393;5834.649921004742;5840.240768700074;5841.094630332294;5844.620099693528;4415.845445409412;4498.415206023213;4566.406367172263;4613.469451013135;4643.419572553431;4615.561521655454;4617.976910115462;4626.7223966562115;4627.167109920213;4638.1883170445035;4580.748058856761;4583.770811459431;4588.701734387271;4591.288350305691;4606.078784243165;4405;4470.888227794315;4564.840230591946;4574.9542504574865;4599.2871104978785;4054.898627534306;4056.9188616227807;4061.3298805697023;4068.247374235746;4076.449679293317;5574.191742197399;5584.106542953108;5591.993441180586;5594.664320140804;5595.916061259084;5298.682079075268;5300.0459917214885;5300.734963251822;5303.681779093266;5304.708241046741;6162.414570615784;6166.167567378391;6169.3522180170885;6175.07373893915;6179.0422484514975;4198.9370159447635;4316.5467625899455;4325.52419233884;4482.081173359454;4483.529229430896;6377.71300291488;6409.871802563969;6430.582012169194;6433.646149461824;6444.355564443565;4456.9108617828115;4462.3306504024;4464.241079016575;4466.598006179394;4474;4517.141743068806;4523.389342438794;4533.365328853963;4535.4103966484145;4535.841245556389;5198.038362902875;5205.29728486657;5214.6610470320065;5214.921776173361;5220.1647736362;6042.305134909454;6210.441060304594;6222;6234.594751341239;6238.189035425366;1575.0549670198018;1589.5390336802197;1599.3762432651276;1600.1279302780013;1608.3727346334938;1007.8941711120374;1057.4501259345097;1059.3802625464036;1070.29895418501;1072.6674730833467;5840.415958404125;5852.590318677737;5856.414358564195;5860.501857342174;5864.38423965486;6285.2457705075685;6386.201724784402;6415.037744338387;6417.069524918954;6420.454261387835;5929.762809487572;5941.55438342126;5948.405159484104;5949.732262048218;5955.076963070731;3400.3199360128074;3437.570303712036;3441.0193094967813;3445.896623101311;3450.9654903450646;6448;6541.672916354259;6560.573562718408;6572.8356791080605;6574.572652777554;6464.482841372679;6477.125588045647;6506;6506.869862602722;6507.7071531781185;6544.541882068304;6563.113979612691;6576.210854697467;6578.440832529289;6581.86836263272;6310.085037669604;6323.715432805443;6334.493240540838;6335.809925702236;6348.714307856065;6171.337389049495;6181.567290289637;6282.057691346335;6317.494600432046;6318.526110541636;6518.57629254097;6541.934580654323;6546.541742078009;6547.312532184052;6549.508786840911;4460.576245256695;4461.977690111528;4468.4637843458995;4473.507914129508;4478.462584489882;6314.273858506331;6328.240611126695;6330.272018717722;6333.746650133943;6333.809985700436;6147.84630384244;6149.292831324455;6165;6172.783952561639;6175.073738939195;6017.488513476404;6094.238220222473;6149.508039356751;6151.292601350902;6157.53818463626;5993.130996005642;6037.426444487766;6038.667873266837;6042.305134909366;6044.15381846533;6168.1056246844855;6170.475509581556;6173.969130154321;6184.196054512884;6190.380961903774;5915.615484993634;5980.641161530322;6034.607750496204;6049.667268300285;6050.0924861269405 17:11:23 INFO - PROCESS | 5569 | |5;yui.html;697.1564407067448;765.6975494679601;767.5586537740799;773.5088218980949;783.1698399696321;13997.300134993247;14202.289885505723;14208.360623771929;14224.288785560719;14252.572422827332;14360.856391436082;14420.134791912466;14443.78334324986;14477.276136193175;14489.058211216263;785.0461689047805;925.3984909808645;932.2029664636757;946.2666433514013;950.078423928788;942.63708472238;945.6690158444524;947.720422475368;950.538988590533;951.3673407184215;964.9614015439374;975.9853602195973;976.8876579193412;976.9706908792748;977.1596427072711;810.3760104719363;951.3198063384644;957.3346524165707;961.1637875048717;968.2205824311461;703.9014537964689;704.4364508393265;704.5526090932244;713.5148099292479;727.7780277015509;13971;14009.929950350284;14023.158610483404;14025.228612426312;14031.228282444461;13589.388477518536;13844;13879.583612491642;14097.436102555885;14342.211178385185;11194.38430886301;11212.327260364404;11458.312501249868;11460.255083419552;11553.480093395818;3889.4554762333296;3920.313945059603;3944.408338749182;3951.723379363446;3980.203959208141;48052;48187.75906120482;48348;48381.51618483841;50802.23796643053;10503.159747220205;10706.518206680563;11040.33757974524;11083.113350931906;11319.660410187707;18312.809667371577;18336.54158646018;18368.173432195585;18400.539986500444;18413.355532556296;7939.0870049945;7944.126146123922;7989.2809647132035;8259.917400825914;8624.353173512012;4583.862484125481;4659.301104834302;4734.976325118421;4762.809487620526;4874.000829829876;3233.644299127094;3277.393682168806;3278.7868788528667;3280.1471617379652;3285.65500622436;568.2640979930999;597.7041364524501;604.3171216525386;604.7490291529055;630.9652969086652;646.4311405962817;662.215274899246;667.3593350383686;685.6229074009275;689.3038031588133;8605.913940860637;8838.337124715672;8922.73231803047;9029.63881444748;9310.441373517611;650.4503694378243;680.251723104581;702.3362922038624;773.4353921637236;773.8856047291994;4207.76857272853;4590.747508886977;4603.378543896598;4616.815327386934;4708.411448568929;64509;65385.67307163434;66021;66725.33274667288;66750.33249667539;54421;54471;54624;54989.72505137449;55018;51469.48530514647;51621.7418912903;51996.48003519992;52534.474655253725;53444.46555534473;9269.108797163171;9325.020872808529;9492.145706886413;9510.429374237568;9565.808683826424;36606.45090323594;37229.44155837611;37607.62392376041;38178.2364352717;38581.807090964365;48273;49052.75473622609;49399;49987.25019124789;50656.746716266185;12343.382830858242;12354.52725073853;12482.126251162696;12527.248365098123;12660.30368329714;13580.864191358356;13737.450501980209;13976.720465590835;14135.505257315945;14504.347304371118;11832.940835296113;12087.09346798976;12140.089493288215;12159.148859579744;12411.193272437262;11552.075833933433;12071.818922715991;12569.497220111092;12614.747705046031;12799.616011519669;12266.32535210572;12302.200356976768;12476.599548128988;12801.807972880228;12814.679633008876;11142.498587563741;11189.328640281608;11243.66269011931;11369.2609980351;11389.829152562552;10679.796061181769;10760.139188864716;10826.783464330512;10910.563577456813;10983.670489885317 17:11:23 INFO - PROCESS | 5569 | __end_tp_report 17:11:23 INFO - PROCESS | 5569 | __start_cc_report 17:11:23 INFO - PROCESS | 5569 | _x_x_mozilla_cycle_collect,684 17:11:23 INFO - PROCESS | 5569 | __end_cc_report 17:11:23 INFO - PROCESS | 5569 | __startTimestamp1464653483335__endTimestamp 17:11:23 INFO - PROCESS | 5569 | 17:11:23 INFO - PROCESS | 5569 | ------- Summary: start ------- 17:11:23 INFO - PROCESS | 5569 | Number of tests: 6 17:11:23 INFO - PROCESS | 5569 | 17:11:23 INFO - PROCESS | 5569 | [#0] dojo.html Cycles:165 Average:5330.88 Median:5525.17 stddev:574.37 (10.4%) stddev-sans-first:551.78 17:11:23 INFO - PROCESS | 5569 | Values: 3221.3 3300.4 3319.1 3341.0 3352.9 5321.2 5335.1 5343.1 5353.3 5353.9 5345.4 5380.9 5381.8 5382.6 5383.5 4682.6 4915.1 4965.3 5026.3 5046.2 4755.2 4840.7 4841.9 4845.2 4845.9 4853.9 4945.4 4973.5 4989.8 4998.2 4809.0 4935.7 4953.3 4955.8 4961.6 4728.6 4849.9 4870.9 4898.4 4901.8 5171.9 5225.8 5238.2 5246.8 5261.4 5621.6 5622.4 5623.6 5628.9 5635.6 5525.2 5623.5 5659.4 5664.5 5729.3 5382.5 5402.3 5402.5 5405.5 5432.1 5842.6 5849.0 5849.3 5852.8 5856.2 5451.2 5616.9 5649.5 5664.9 5674.3 5760.5 5767.8 5771.4 5777.9 5785.3 5719.0 5722.5 5726.5 5729.1 5738.6 5521.0 5694.4 5724.4 5794.0 5815.9 4371.2 4373.2 4377.0 4380.1 4400.5 3952.8 3971.2 3976.7 4004.4 4011.6 5212.4 5293.1 5342.4 5353.6 5368.0 5747.6 5763.6 5767.6 5773.9 5776.7 5168.7 5375.5 5389.2 5413.9 5452.3 4973.5 4991.8 5007.0 5008.4 5033.1 5938.4 5969.8 5989.3 5996.6 5999.4 5536.5 5657.6 5806.1 5806.7 5806.7 5841.8 5897.2 5946.7 5947.0 5982.6 5656.8 5692.8 5703.2 5710.5 5711.5 5560.7 5691.9 5727.9 5763.9 5791.6 5673.7 5675.2 5677.2 5678.6 5686.3 5605.7 5637.2 5652.4 5654.7 5663.8 5308.9 5558.8 5575.1 5611.6 5615.7 5495.4 5619.0 5661.6 5731.5 5736.1 5466.2 5495.9 5511.7 5527.7 5548.0 17:11:23 INFO - PROCESS | 5569 | 17:11:23 INFO - PROCESS | 5569 | [#1] ext.html Cycles:180 Average:49669.09 Median:39659.70 stddev:80623.15 (203.3%) stddev-sans-first:80764.72 17:11:23 INFO - PROCESS | 5569 | Values: 479.8 527.2 534.7 542.2 615.4 30866.8 38260.4 38594.2 38594.4 38628.3 42507.4 42989.1 43020.8 43034.6 43069.1 8787.3 9008.6 9011.7 9014.9 9016.6 8828.4 8943.8 8960.0 8966.0 8968.9 9047.8 9201.4 9204.0 9216.2 9225.8 9128.0 9208.1 9214.0 9220.4 9223.6 9025.3 9170.0 9172.0 9172.1 9176.9 41819.6 42134.4 42205.8 42224.2 42246.4 3814.7 3905.6 4136.9 4509.5 4635.9 32387.0 32467.2 32570.7 32806.0 33851.8 4230.5 4284.9 4324.4 4339.5 4411.6 281094.0 282704.0 282848.0 283039.0 284368.6 60331.0 60347.1 60677.4 60788.0 60834.1 66186.3 72856.0 73496.6 73548.3 73738.0 17169.5 17370.1 17394.2 17414.0 17415.0 14662.1 14780.6 14825.8 14832.4 14833.9 22002.7 22384.6 22446.3 22464.4 22505.8 7778.8 7928.2 7993.8 8134.7 8248.7 1004.7 1097.1 1137.0 1176.3 1199.0 29636.4 29768.7 30453.2 30720.8 31483.4 997.5 1128.1 1143.9 1144.9 1211.3 13739.0 14112.7 14288.3 14727.0 15668.1 332929.0 336464.0 337478.0 337731.0 338194.0 55982.4 56352.0 56482.4 56497.7 56558.2 1378.3 1485.4 1486.6 1492.7 1499.3 28041.4 29024.6 29305.6 29483.1 29845.0 45491.0 54632.5 55399.7 55490.0 55516.2 301517.0 302146.0 305664.0 307185.0 307523.0 40595.8 40646.6 44714.7 49811.5 50620.5 45864.0 46211.5 46604.0 46804.5 47099.0 38953.4 39455.6 39781.8 40240.0 41019.4 38751.0 39026.2 39046.6 39218.4 39942.0 38497.0 38818.2 39461.0 39551.8 39767.6 33377.3 35168.8 35487.0 35813.3 35920.8 26402.0 26727.7 26852.5 26868.6 27079.5 17:11:23 INFO - PROCESS | 5569 | 17:11:23 INFO - PROCESS | 5569 | [#2] jquery.html Cycles:180 Average:26903.85 Median:16988.90 stddev:77734.23 (457.6%) stddev-sans-first:77926.76 17:11:23 INFO - PROCESS | 5569 | Values: 366.7 372.8 374.2 374.6 377.9 17657.1 17789.7 18409.4 18542.8 18559.4 17516.2 18364.2 18637.9 18658.1 18699.3 5450.8 5711.1 5749.9 5752.7 5755.0 4304.1 5597.7 5949.7 6206.2 6218.9 6169.4 6178.8 6185.7 6210.1 6220.5 5914.9 6119.6 6161.7 6168.0 6171.7 3837.8 5177.0 5412.4 5489.7 5494.4 21241.2 21264.4 21434.6 21651.0 21652.2 2441.8 2459.5 2507.0 2572.4 2572.4 13729.9 13746.7 13895.0 14110.3 14504.1 1661.8 1744.3 1765.9 1801.7 1827.9 69220.3 70266.0 70395.6 70597.0 72098.3 9736.5 10029.5 10304.1 10368.9 10397.8 14314.8 14376.7 14470.6 14505.3 14506.6 8194.0 8422.3 8433.8 8455.7 8518.4 8394.0 8429.5 8447.7 8543.7 8587.1 6090.0 6143.3 6194.7 6232.2 6261.7 1726.6 1732.1 1738.2 1830.3 1885.8 935.6 971.3 986.5 1014.3 1117.5 17147.3 17271.7 17361.7 17523.2 17942.2 969.6 976.6 992.6 1016.2 1031.6 9731.5 9884.6 10148.7 10254.5 10435.1 457895.0 471577.0 472284.0 483329.0 491154.0 51514.5 52082.5 76621.9 78917.0 83300.6 1025.8 1086.6 1092.3 1093.8 1095.5 15492.3 15581.9 15870.7 15988.2 16108.4 23861.8 31405.4 34534.0 34892.0 35507.8 41792.8 43890.8 45251.3 45657.1 45770.0 8709.0 8811.4 8871.2 8949.8 9017.8 10169.3 12943.5 13568.1 13759.5 13831.4 6387.7 10621.9 11192.4 11471.1 11749.4 11498.4 11501.4 11575.8 11607.8 11667.1 11594.9 11996.6 12009.9 12043.3 12286.3 8575.7 8815.1 8858.1 8905.6 8994.7 11673.6 12160.3 12211.6 12243.1 12293.7 17:11:23 INFO - PROCESS | 5569 | 17:11:23 INFO - PROCESS | 5569 | [#3] mootools.html Cycles:180 Average:5439.09 Median:6617.99 stddev:2764.41 (41.8%) stddev-sans-first:2755.19 17:11:23 INFO - PROCESS | 5569 | Values: 1364.0 1592.6 1621.0 1851.6 1926.0 7496.9 7656.0 7669.0 7676.2 7676.6 7418.7 7534.9 7579.5 7580.9 7582.1 2326.6 2345.6 2346.2 2350.3 2352.8 2327.3 2347.0 2370.6 2384.7 2390.5 2321.3 2342.9 2356.7 2357.4 2361.2 2323.8 2332.6 2364.3 2374.1 2378.3 2311.9 2355.8 2372.1 2373.2 2376.9 6718.6 6864.6 7728.1 7748.2 7766.1 4280.4 4424.2 4644.3 4680.1 4704.2 3054.2 3079.3 3089.4 3099.5 3124.3 1029.2 1039.9 1047.9 1075.4 1080.0 9944.6 10129.5 10129.7 10133.3 10145.0 4181.7 4275.1 4296.2 4316.4 4332.4 9044.2 9051.7 9068.5 9089.0 9092.8 4906.0 4917.3 4918.8 4920.3 4922.6 4433.1 4434.1 4447.4 4466.0 4484.4 3466.7 3619.5 3631.0 3648.3 3670.1 1114.5 1129.6 1137.9 1141.1 1143.2 1201.4 1204.4 1290.7 1468.9 1511.6 7463.6 7478.3 7629.7 7630.3 7645.4 531.1 534.2 542.9 553.0 554.1 5551.9 5566.9 5582.2 5604.0 5607.3 8234.6 8584.7 8991.2 9135.1 9139.6 8883.8 8920.2 8999.1 9027.4 9033.2 7139.3 7497.7 7522.2 7529.1 7534.0 7231.6 7258.8 7284.0 7291.2 7344.0 8356.3 8434.8 8550.0 8620.1 8643.8 8349.5 8656.2 8683.7 8688.9 8737.0 6777.1 6782.3 6829.0 6839.8 6844.9 7333.2 7349.1 7384.0 7396.4 7400.3 6871.9 7015.1 7153.9 7220.4 7299.2 7036.8 7086.2 7125.6 7164.4 7178.4 6909.7 6945.9 7009.5 7020.1 7026.1 6560.1 6601.4 6634.5 6655.8 6670.3 6823.1 6867.1 6876.6 6878.6 6885.1 17:11:23 INFO - PROCESS | 5569 | 17:11:23 INFO - PROCESS | 5569 | [#4] prototype.html Cycles:180 Average:5193.72 Median:5896.12 stddev:1529.15 (25.9%) stddev-sans-first:1489.40 17:11:23 INFO - PROCESS | 5569 | Values: 339.1 352.8 352.9 353.8 355.7 5880.6 5911.6 5916.3 5925.2 5960.2 5833.9 5834.6 5840.2 5841.1 5844.6 4415.8 4498.4 4566.4 4613.5 4643.4 4615.6 4618.0 4626.7 4627.2 4638.2 4580.7 4583.8 4588.7 4591.3 4606.1 4405.0 4470.9 4564.8 4575.0 4599.3 4054.9 4056.9 4061.3 4068.2 4076.4 5574.2 5584.1 5592.0 5594.7 5595.9 5298.7 5300.0 5300.7 5303.7 5304.7 6162.4 6166.2 6169.4 6175.1 6179.0 4198.9 4316.5 4325.5 4482.1 4483.5 6377.7 6409.9 6430.6 6433.6 6444.4 4456.9 4462.3 4464.2 4466.6 4474.0 4517.1 4523.4 4533.4 4535.4 4535.8 5198.0 5205.3 5214.7 5214.9 5220.2 6042.3 6210.4 6222.0 6234.6 6238.2 1575.1 1589.5 1599.4 1600.1 1608.4 1007.9 1057.5 1059.4 1070.3 1072.7 5840.4 5852.6 5856.4 5860.5 5864.4 6285.2 6386.2 6415.0 6417.1 6420.5 5929.8 5941.6 5948.4 5949.7 5955.1 3400.3 3437.6 3441.0 3445.9 3451.0 6448.0 6541.7 6560.6 6572.8 6574.6 6464.5 6477.1 6506.0 6506.9 6507.7 6544.5 6563.1 6576.2 6578.4 6581.9 6310.1 6323.7 6334.5 6335.8 6348.7 6171.3 6181.6 6282.1 6317.5 6318.5 6518.6 6541.9 6546.5 6547.3 6549.5 4460.6 4462.0 4468.5 4473.5 4478.5 6314.3 6328.2 6330.3 6333.7 6333.8 6147.8 6149.3 6165.0 6172.8 6175.1 6017.5 6094.2 6149.5 6151.3 6157.5 5993.1 6037.4 6038.7 6042.3 6044.2 6168.1 6170.5 6174.0 6184.2 6190.4 5915.6 5980.6 6034.6 6049.7 6050.1 17:11:23 INFO - PROCESS | 5569 | 17:11:23 INFO - PROCESS | 5569 | [#5] yui.html Cycles:180 Average:15046.45 Median:4683.86 stddev:17451.30 (372.6%) stddev-sans-first:17466.99 17:11:23 INFO - PROCESS | 5569 | Values: 697.2 765.7 767.6 773.5 783.2 13997.3 14202.3 14208.4 14224.3 14252.6 14360.9 14420.1 14443.8 14477.3 14489.1 785.0 925.4 932.2 946.3 950.1 942.6 945.7 947.7 950.5 951.4 965.0 976.0 976.9 977.0 977.2 810.4 951.3 957.3 961.2 968.2 703.9 704.4 704.6 713.5 727.8 13971.0 14009.9 14023.2 14025.2 14031.2 13589.4 13844.0 13879.6 14097.4 14342.2 11194.4 11212.3 11458.3 11460.3 11553.5 3889.5 3920.3 3944.4 3951.7 3980.2 48052.0 48187.8 48348.0 48381.5 50802.2 10503.2 10706.5 11040.3 11083.1 11319.7 18312.8 18336.5 18368.2 18400.5 18413.4 7939.1 7944.1 7989.3 8259.9 8624.4 4583.9 4659.3 4735.0 4762.8 4874.0 3233.6 3277.4 3278.8 3280.1 3285.7 568.3 597.7 604.3 604.7 631.0 646.4 662.2 667.4 685.6 689.3 8605.9 8838.3 8922.7 9029.6 9310.4 650.5 680.3 702.3 773.4 773.9 4207.8 4590.7 4603.4 4616.8 4708.4 64509.0 65385.7 66021.0 66725.3 66750.3 54421.0 54471.0 54624.0 54989.7 55018.0 51469.5 51621.7 51996.5 52534.5 53444.5 9269.1 9325.0 9492.1 9510.4 9565.8 36606.5 37229.4 37607.6 38178.2 38581.8 48273.0 49052.8 49399.0 49987.3 50656.7 12343.4 12354.5 12482.1 12527.2 12660.3 13580.9 13737.5 13976.7 14135.5 14504.3 11832.9 12087.1 12140.1 12159.1 12411.2 11552.1 12071.8 12569.5 12614.7 12799.6 12266.3 12302.2 12476.6 12801.8 12814.7 11142.5 11189.3 11243.7 11369.3 11389.8 10679.8 10760.1 10826.8 10910.6 10983.7 17:11:23 INFO - PROCESS | 5569 | -------- Summary: end -------- 17:11:23 INFO - PROCESS | 5569 | 17:11:23 INFO - TEST-INFO | 5569: exit 0 17:11:24 INFO - TEST-OK | dromaeo_css | took 1111379ms 17:11:24 INFO - TEST-START | kraken 17:11:24 INFO - operating with platform_type : linux_ 17:11:24 INFO - Initialising browser for kraken test... 17:11:24 INFO - TEST-INFO | started process 5772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB_e9In/profile http://localhost:45524/getInfo.html) 17:11:28 INFO - PROCESS | 5772 | __metrics Screen width/height:1600/1200 17:11:28 INFO - PROCESS | 5772 | colorDepth:24 17:11:28 INFO - PROCESS | 5772 | Browser inner width/height: 1024/697 17:11:28 INFO - PROCESS | 5772 | __metrics 17:11:29 INFO - PROCESS | 5772 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:11:30 INFO - TEST-INFO | 5772: exit 0 17:11:30 INFO - Browser initialized. 17:11:30 INFO - Running cycle 1/1 for kraken test... 17:11:30 INFO - TEST-INFO | started process 5863 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB_e9In/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:41 INFO - PROCESS | 5863 | RSS: Main: 139673600 17:11:41 INFO - PROCESS | 5863 | 17:11:44 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45524/tests/kraken/driver.html?testName=audio-beat-detection) 17:11:45 INFO - PROCESS | 5863 | RSS: Main: 183652352 17:11:45 INFO - PROCESS | 5863 | 17:11:47 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45524/tests/kraken/driver.html?testName=audio-dft) 17:11:48 INFO - PROCESS | 5863 | RSS: Main: 175931392 17:11:48 INFO - PROCESS | 5863 | 17:11:51 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45524/tests/kraken/driver.html?testName=audio-fft) 17:11:51 INFO - PROCESS | 5863 | RSS: Main: 175722496 17:11:51 INFO - PROCESS | 5863 | 17:11:53 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45524/tests/kraken/driver.html?testName=audio-oscillator) 17:11:54 INFO - PROCESS | 5863 | RSS: Main: 175943680 17:11:54 INFO - PROCESS | 5863 | 17:11:56 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45524/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:11:57 INFO - PROCESS | 5863 | RSS: Main: 174002176 17:11:57 INFO - PROCESS | 5863 | 17:12:00 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45524/tests/kraken/driver.html?testName=imaging-darkroom) 17:12:00 INFO - PROCESS | 5863 | RSS: Main: 174518272 17:12:00 INFO - PROCESS | 5863 | 17:12:03 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45524/tests/kraken/driver.html?testName=imaging-desaturate) 17:12:04 INFO - PROCESS | 5863 | RSS: Main: 174460928 17:12:04 INFO - PROCESS | 5863 | 17:12:07 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45524/tests/kraken/driver.html?testName=json-parse-financial) 17:12:07 INFO - PROCESS | 5863 | RSS: Main: 175063040 17:12:07 INFO - PROCESS | 5863 | 17:12:09 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45524/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:12:09 INFO - PROCESS | 5863 | RSS: Main: 179294208 17:12:09 INFO - PROCESS | 5863 | 17:12:11 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45524/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:12:12 INFO - PROCESS | 5863 | RSS: Main: 177336320 17:12:12 INFO - PROCESS | 5863 | 17:12:14 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45524/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:12:14 INFO - PROCESS | 5863 | RSS: Main: 182185984 17:12:14 INFO - PROCESS | 5863 | 17:12:17 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:12:17 INFO - PROCESS | 5863 | RSS: Main: 186585088 17:12:17 INFO - PROCESS | 5863 | 17:12:20 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:12:20 INFO - PROCESS | 5863 | RSS: Main: 184246272 17:12:20 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:45524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45524/tests/kraken/driver.html?testName=ai-astar) 17:12:22 INFO - PROCESS | 5863 | RSS: Main: 247410688 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | __start_tp_report 17:12:22 INFO - PROCESS | 5863 | _x_x_mozilla_page_load 17:12:22 INFO - PROCESS | 5863 | _x_x_mozilla_page_load_details 17:12:22 INFO - PROCESS | 5863 | |i|pagename|runs| 17:12:22 INFO - PROCESS | 5863 | |0;ai-astar;111;112;114;111;111;110;111;112;111;123 17:12:22 INFO - PROCESS | 5863 | |1;audio-beat-detection;153;128;156;180;133;157;158;131;166;128 17:12:22 INFO - PROCESS | 5863 | |2;audio-dft;162;160;162;159;162;162;160;160;161;160 17:12:22 INFO - PROCESS | 5863 | |3;audio-fft;76;77;74;165;76;76;76;77;163;74 17:12:22 INFO - PROCESS | 5863 | |4;audio-oscillator;94;93;146;93;93;93;148;94;94;140 17:12:22 INFO - PROCESS | 5863 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;116;116 17:12:22 INFO - PROCESS | 5863 | |6;imaging-darkroom;147;145;146;146;146;145;145;145;145;146 17:12:22 INFO - PROCESS | 5863 | |7;imaging-desaturate;96;96;95;96;96;96;96;95;95;95 17:12:22 INFO - PROCESS | 5863 | |8;json-parse-financial;56;65;57;57;57;56;57;58;66;55 17:12:22 INFO - PROCESS | 5863 | |9;json-stringify-tinderbox;66;65;64;65;64;64;64;64;64;65 17:12:22 INFO - PROCESS | 5863 | |10;stanford-crypto-aes;78;78;80;78;80;78;79;79;79;85 17:12:22 INFO - PROCESS | 5863 | |11;stanford-crypto-ccm;113;112;112;110;120;115;119;110;111;118 17:12:22 INFO - PROCESS | 5863 | |12;stanford-crypto-pbkdf2;140;139;145;139;147;136;145;143;147;143 17:12:22 INFO - PROCESS | 5863 | |13;stanford-crypto-sha256-iterative;67;69;66;67;67;68;66;67;67;67 17:12:22 INFO - PROCESS | 5863 | __end_tp_report 17:12:22 INFO - PROCESS | 5863 | __start_cc_report 17:12:22 INFO - PROCESS | 5863 | _x_x_mozilla_cycle_collect,1029 17:12:22 INFO - PROCESS | 5863 | __end_cc_report 17:12:22 INFO - PROCESS | 5863 | __startTimestamp1464653542865__endTimestamp 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | ------- Summary: start ------- 17:12:22 INFO - PROCESS | 5863 | Number of tests: 14 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#0] ai-astar Cycles:10 Average:112.60 Median:111.50 stddev:3.81 (3.4%) stddev-sans-first:3.99 17:12:22 INFO - PROCESS | 5863 | Values: 111.0 112.0 114.0 111.0 111.0 110.0 111.0 112.0 111.0 123.0 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:156.50 stddev:18.02 (11.5%) stddev-sans-first:19.05 17:12:22 INFO - PROCESS | 5863 | Values: 153.0 128.0 156.0 180.0 133.0 157.0 158.0 131.0 166.0 128.0 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.12 17:12:22 INFO - PROCESS | 5863 | Values: 162.0 160.0 162.0 159.0 162.0 162.0 160.0 160.0 161.0 160.0 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:37.23 (49.0%) stddev-sans-first:38.95 17:12:22 INFO - PROCESS | 5863 | Values: 76.0 77.0 74.0 165.0 76.0 76.0 76.0 77.0 163.0 74.0 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:93.00 stddev:24.83 (26.7%) stddev-sans-first:25.75 17:12:22 INFO - PROCESS | 5863 | Values: 94.0 93.0 146.0 93.0 93.0 93.0 148.0 94.0 94.0 140.0 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:12:22 INFO - PROCESS | 5863 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 17:12:22 INFO - PROCESS | 5863 | Values: 147.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:12:22 INFO - PROCESS | 5863 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:57.00 stddev:3.84 (6.7%) stddev-sans-first:3.97 17:12:22 INFO - PROCESS | 5863 | Values: 56.0 65.0 57.0 57.0 57.0 56.0 57.0 58.0 66.0 55.0 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.50 17:12:22 INFO - PROCESS | 5863 | Values: 66.0 65.0 64.0 65.0 64.0 64.0 64.0 64.0 64.0 65.0 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.12 (2.7%) stddev-sans-first:2.19 17:12:22 INFO - PROCESS | 5863 | Values: 78.0 78.0 80.0 78.0 80.0 78.0 79.0 79.0 79.0 85.0 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#11] stanford-crypto-ccm Cycles:10 Average:114.00 Median:114.00 stddev:3.77 (3.3%) stddev-sans-first:3.98 17:12:22 INFO - PROCESS | 5863 | Values: 113.0 112.0 112.0 110.0 120.0 115.0 119.0 110.0 111.0 118.0 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.40 Median:144.00 stddev:3.75 (2.6%) stddev-sans-first:3.87 17:12:22 INFO - PROCESS | 5863 | Values: 140.0 139.0 145.0 139.0 147.0 136.0 145.0 143.0 147.0 143.0 17:12:22 INFO - PROCESS | 5863 | 17:12:22 INFO - PROCESS | 5863 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 17:12:22 INFO - PROCESS | 5863 | Values: 67.0 69.0 66.0 67.0 67.0 68.0 66.0 67.0 67.0 67.0 17:12:22 INFO - PROCESS | 5863 | -------- Summary: end -------- 17:12:22 INFO - PROCESS | 5863 | 17:12:23 INFO - TEST-INFO | 5863: exit 0 17:12:23 INFO - TEST-OK | kraken | took 59981ms 17:12:23 INFO - SUITE-END | took 1171s 17:12:24 INFO - Completed test suite (00:19:31) 17:12:24 INFO - javascript benchmark 17:12:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3221.339625376798, 3300.3894279558276, 3319.0872510059744, 3340.966590334096, 3352.9161770955725, 5321.201819727043, 5335.066363386406, 5343.064963631368, 5353.330833645794, 5353.946460535399, 5345.358556973169, 5380.865478363043, 5381.784728610851, 5382.569394448445, 5383.542398896088, 4682.578567928886, 4915.066137433885, 4965.329680493123, 5026.296318515392, 5046.243063540462, 4755.2153894607345, 4840.661153719224, 4841.878953026167, 4845.200541910581, 4845.903081938359, 4853.878653033667, 4945.406551213841, 4973.452920178777, 4989.75051247438, 4998.225275082368, 4808.975955120237, 4935.70385776851, 4953.281774142747, 4955.776990035457, 4961.578265847407, 4728.598069164125, 4849.903001939977, 4870.853874383774, 4898.363212782351, 4901.803927842882, 5171.896562068738, 5225.790968361299, 5238.214267859814, 5246.842594722164, 5261.447548007481, 5621.578381621394, 5622.381538030813, 5623.578231632644, 5628.915566266509, 5635.633683810539, 5525.171224316345, 5623.49388555028, 5659.377468478464, 5664.54683625309, 5729.28383952006, 5382.461753824626, 5402.297701298806, 5402.459754024605, 5405.513503784599, 5432.13085906257, 5842.620229685142, 5849.0, 5849.298084229919, 5852.795152169739, 5856.180134781134, 5451.155070964007, 5616.859578510488, 5649.491545760901, 5664.943350566442, 5674.347450043216, 5760.510356619734, 5767.826965191051, 5771.422857714279, 5777.942220577825, 5785.27684039495, 5718.971405142947, 5722.484976352065, 5726.484616384545, 5729.140628905698, 5738.626989245686, 5521.0, 5694.373618901917, 5724.370319264877, 5793.971030144907, 5815.854603634943, 4371.23503386906, 4373.169097871394, 4376.956230437719, 4380.080183161572, 4400.515943246241, 3952.8418863245147, 3971.205758848242, 3976.721629485966, 4004.3993400990084, 4011.5587285398583, 5212.4266330703595, 5293.12663410533, 5342.412334643186, 5353.625246232727, 5367.973160134175, 5747.626404283708, 5763.567732420085, 5767.596268261265, 5773.884522309614, 5776.68228247442, 5168.7415629218385, 5375.5162035417, 5389.191621256843, 5413.918791218135, 5452.263944367539, 4973.452920178777, 4991.800327986913, 5007.023630392038, 5008.449070602231, 5033.0940430722085, 5938.406159384027, 5969.79105731306, 5989.251343582052, 5996.610220335664, 5999.400059993965, 5536.501714845684, 5657.575681823962, 5806.129080637854, 5806.68063256525, 5806.709664516842, 5841.766329346949, 5897.203877476486, 5946.672932988728, 5947.01874190771, 5982.641041537521, 5656.8020119295625, 5692.829215123553, 5703.173039909107, 5710.543156547549, 5711.514521265739, 5560.7219639018695, 5691.943080569141, 5727.885442291047, 5763.94236057634, 5791.623544469596, 5673.659580425187, 5675.205471234113, 5677.205191273308, 5678.574106941914, 5686.317641883001, 5605.691686957257, 5637.210790489253, 5652.378238393856, 5654.745536450787, 5663.8017669383025, 5308.920366194433, 5558.805441809517, 5575.080111781511, 5611.607187496836, 5615.747291371979, 5495.395506494203, 5619.0, 5661.575381846295, 5731.5128214100605, 5736.053551164011, 5466.234727138124, 5495.890082198413, 5511.696856672921, 5527.723613819373, 5548.0], "unit": "score", "name": "dojo.html", "value": 5295.229707539903}, {"lowerIsBetter": false, "replicates": [479.76011994003, 527.1854984049643, 534.6898798696757, 542.154239386557, 615.4153554123584, 30866.845665771667, 38260.426093608585, 38594.228115437676, 38594.42108368373, 38628.29601927866, 42507.36238956411, 42989.140217195636, 43020.78489607555, 43034.56965430345, 43069.13861722771, 8787.25308348791, 9008.594613242387, 9011.684591039282, 9014.909850901506, 9016.639334426614, 8828.426152300111, 8943.821123577525, 8959.955200223989, 8966.0, 8968.865467018, 9047.819043619123, 9201.355905086646, 9203.95398023009, 9216.216621587173, 9225.769355766093, 9127.95436022819, 9208.079192080806, 9214.0, 9220.400673956172, 9223.584938677775, 9025.323100767402, 9169.954150229272, 9172.036936121678, 9172.08279172084, 9176.90823091774, 41819.58180418187, 42134.36798448026, 42205.78897105495, 42224.1555168898, 42246.36630450515, 3814.7138964577766, 3905.628965248297, 4136.91726165478, 4509.503954564995, 4635.93373524088, 32387.0, 32467.188320291945, 32570.674293257, 32806.0, 33851.83074084614, 4230.471191101113, 4284.8500302489265, 4324.372965919955, 4339.544347843463, 4411.580899814512, 281094.0, 282704.0, 282848.0, 283039.0, 284368.57815710997, 60331.0, 60347.09479357813, 60677.39322606717, 60788.0, 60834.087488687706, 66186.33813661899, 72856.0, 73496.63251683707, 73548.26451735414, 73738.0, 17169.48491545256, 17370.131493425277, 17394.21726022332, 17414.0422276776, 17415.0, 14662.120272783666, 14780.630484237765, 14825.77761333581, 14832.406703731946, 14833.851661483248, 22002.669959950614, 22384.552308954055, 22446.32661020172, 22464.43838904008, 22505.774942250697, 7778.766637000899, 7928.207179282025, 7993.760187194393, 8134.715284964997, 8248.667638076642, 1004.7089490005308, 1097.1216748792979, 1136.971575710614, 1176.276589897207, 1198.9580364687195, 29636.40727185444, 29768.702312977028, 30453.23866903345, 30720.84639576788, 31483.37033259322, 997.4962643864947, 1128.1087940526893, 1143.9199256052163, 1144.9141314401286, 1211.3398197982121, 13739.0, 14112.71774564503, 14288.285585720672, 14727.0, 15668.138252396227, 332929.0, 336464.0, 337478.0, 337731.0, 338194.0, 55982.44017559772, 56352.0, 56482.43517564854, 56497.71751141218, 56558.151627725616, 1378.3177327222888, 1485.4281101775678, 1486.6283429142713, 1492.6939977304626, 1499.3028241867803, 28041.439171216054, 29024.56463153012, 29305.560416594195, 29483.11550653484, 29845.0, 45491.0, 54632.45367546433, 55399.72300138474, 55490.0, 55516.16725749198, 301517.0, 302146.0, 305664.0, 307185.0, 307523.0, 40595.7970210147, 40646.59353406428, 44714.65323663989, 49811.50188498069, 50620.49379506158, 45864.0, 46211.537884620724, 46604.0, 46804.53195468138, 47099.0, 38953.41569876397, 39455.60544394519, 39781.80109099436, 40240.0, 41019.384709229984, 38751.0, 39026.219475610895, 39046.60953390544, 39218.411723824735, 39942.0, 38497.0, 38818.2236355277, 39461.0, 39551.80224098861, 39767.602323977546, 33377.332453351286, 35168.824155879054, 35487.0, 35813.28373432569, 35920.820395897856, 26402.0, 26727.732722672525, 26852.46295074127, 26868.59697104584, 27079.466846634143], "unit": "score", "name": "ext.html", "value": 19991.866095624482}, {"lowerIsBetter": false, "replicates": [366.6663336363908, 372.78192257529344, 374.2066818345109, 374.61040517861426, 377.8847451527285, 17657.11714414279, 17789.733154002683, 18409.44771656849, 18542.814571854276, 18559.443216703487, 17516.211770470327, 18364.173612187482, 18637.906810465964, 18658.06709664518, 18699.3455229067, 5450.754716037778, 5711.143328500717, 5749.885002299951, 5752.741126649311, 5754.971225143869, 4304.139172165579, 5597.6641401515835, 5949.7025148742605, 6206.224221972254, 6218.937810621904, 6169.444749972502, 6178.814635560918, 6185.721642526097, 6210.09953556734, 6220.47125994291, 5914.9112763308585, 6119.602225855349, 6161.661108639, 6168.013117901114, 6171.691415429233, 3837.827297771607, 5176.974115129438, 5412.3505179378335, 5489.6980666063355, 5494.36814766303, 21241.15035398582, 21264.36206913795, 21434.571308573897, 21651.0, 21652.242171524078, 2441.7802397784285, 2459.5203935232635, 2507.022261318087, 2572.382628169226, 2572.421205228827, 13729.931350343284, 13746.65633359174, 13894.957878159179, 14110.294485275695, 14504.057236279714, 1661.775660285858, 1744.3213035881308, 1765.8675599330102, 1801.7387478815629, 1827.8629102817208, 69220.30779692189, 70266.0, 70395.64802176008, 70597.0, 72098.27901721021, 9736.513174341255, 10029.548670309854, 10304.072633463024, 10368.896311036793, 10397.792044159074, 14314.785278220836, 14376.712465750627, 14470.638234044023, 14505.274736263145, 14506.564803055926, 8194.0, 8422.284105851071, 8433.83132337362, 8455.704050358208, 8518.361122915681, 8393.970893970805, 8429.536375499407, 8447.704330348408, 8543.700970466003, 8587.098354672795, 6090.0, 6143.262808462924, 6194.690265486798, 6232.158658581034, 6261.749530018748, 1726.5683579105223, 1732.116620523517, 1738.1743671755814, 1830.3159107385943, 1885.8019907909747, 935.5883411299006, 971.2521358553875, 986.4771671014374, 1014.3305418423805, 1117.4692021289984, 17147.314107435563, 17271.65456690859, 17361.65276694459, 17523.211455484532, 17942.192601332972, 969.6024629901707, 976.6239997600975, 992.6327258914248, 1016.1819735113157, 1031.5512751952924, 9731.513424328898, 9884.55519501624, 10148.695539133838, 10254.53854576546, 10435.113015393625, 457895.0, 471577.0, 472284.0, 483329.0, 491154.0, 51514.48485515172, 52082.47917520852, 76621.85067223996, 78917.0, 83300.58349708213, 1025.8050970315617, 1086.625114335553, 1092.3445932440632, 1093.830456279278, 1095.45774841454, 15492.302846372166, 15581.935870841795, 15870.682586347977, 15988.200589970687, 16108.355665773237, 23861.761382385954, 31405.371892562478, 34534.0, 34891.9532414028, 35507.82246088753, 41792.791036044626, 43890.78054609706, 45251.321230182235, 45657.08685826199, 45770.0, 8708.956455217683, 8811.383203175972, 8871.157240062184, 8949.821003579762, 9017.819643607223, 10169.338992965433, 12943.482260709467, 13568.118072325267, 13759.518416855763, 13831.446742130202, 6387.712552935036, 10621.884702106168, 11192.38441885704, 11471.13966452536, 11749.353785541536, 11498.367589782642, 11501.367424791717, 11575.76848463043, 11607.825882611598, 11667.124965627781, 11594.94202528982, 11996.64010079699, 12009.879901200877, 12043.33761643083, 12286.262824230575, 8575.742727718178, 8815.074417186102, 8858.069902660129, 8905.599248033725, 8994.685186018458, 11673.649790506299, 12160.331181785086, 12211.572594959134, 12243.081768867549, 12293.692657683629], "unit": "score", "name": "jquery.html", "value": 8974.25074921441}, {"lowerIsBetter": false, "replicates": [1363.9795403068963, 1592.6336942503224, 1621.0435842852714, 1851.6204178143473, 1926.0, 7496.92503074969, 7656.042994625672, 7668.961655191716, 7676.193999630035, 7676.616169191539, 7418.666160022798, 7534.924650753491, 7579.545227286367, 7580.88628670569, 7582.090149182092, 2326.581215381231, 2345.6012477878717, 2346.1905642553293, 2350.330155905567, 2352.8353015288935, 2327.3018094571644, 2346.9530609387803, 2370.6207006878903, 2384.666146739458, 2390.497995420964, 2321.315212012452, 2342.9297121086393, 2356.670066190735, 2357.387079359362, 2361.2325994051916, 2323.8373313868037, 2332.6384410416244, 2364.2552595932225, 2374.050379848057, 2378.3102900158933, 2311.872846993415, 2355.7644235576304, 2372.1223147435558, 2373.2168384433094, 2376.916807911732, 6718.563293385914, 6864.553804002774, 7728.149903510609, 7748.2251774822635, 7766.06807183136, 4280.4221430106845, 4424.225760491933, 4644.303354496852, 4680.110778951988, 4704.1767690654, 3054.22117360074, 3079.291762894547, 3089.3975674743433, 3099.5040793473163, 3124.297033167542, 1029.197226163586, 1039.8752149742004, 1047.9214058945533, 1075.4031512510553, 1080.027974822658, 9944.602215911355, 10129.544170512345, 10129.746756331077, 10133.341332813343, 10145.0, 4181.703671861733, 4275.080857615628, 4296.2266791977745, 4316.374125751811, 4332.393464914914, 9044.231240344512, 9051.728448146567, 9068.501232432147, 9089.0, 9092.772680683036, 4906.0, 4917.286993385939, 4918.827841025547, 4920.3111564381015, 4922.58158056562, 4433.091216300651, 4434.091011342667, 4447.421835161473, 4466.017476155241, 4484.439445069366, 3466.6533346665133, 3619.529461170031, 3630.9636903631153, 3648.288583726148, 3670.137517683342, 1114.509615769059, 1129.6159305836056, 1137.852079229695, 1141.14414189358, 1143.2283208834003, 1201.405304374323, 1204.4399354300292, 1290.7095903421655, 1468.9045212061183, 1511.6145382927502, 7463.552186868806, 7478.326950574475, 7629.7329593463965, 7630.2751238632245, 7645.426593005435, 531.1236459841216, 534.1747000883644, 542.8642839290178, 552.9612927095145, 554.0995881692251, 5551.944480555224, 5566.944330556724, 5582.218489411485, 5604.0, 5607.327120745455, 8234.588270586446, 8584.74245772628, 8991.190792828676, 9135.132162444557, 9139.588718507683, 8883.777905552284, 8920.24177944869, 8999.145081217273, 9027.368084234173, 9033.232175265177, 7139.32176443237, 7497.737579184703, 7522.210167932398, 7529.096508419025, 7533.9829123068785, 7231.566106033655, 7258.818529536804, 7284.0, 7291.197968223385, 7343.963280183565, 8356.33149348063, 8434.789130271793, 8550.0, 8620.13798620158, 8643.827123457622, 8349.499030058216, 8656.22094011542, 8683.739487815375, 8688.869666955126, 8737.038925718292, 6777.08509351251, 6782.321767823179, 6829.0, 6839.829004274933, 6844.93155068443, 7333.156686981066, 7349.118105827335, 7384.0, 7396.371308438843, 7400.296971787671, 6871.931280687129, 7015.052967849275, 7153.892691609526, 7220.350168484862, 7299.160596531255, 7036.824079398056, 7086.185088714864, 7125.608091555015, 7164.355208031302, 7178.3898368637165, 6909.654517274015, 6945.895811562932, 7009.509334346547, 7020.122484689414, 7026.051483049723, 6560.114384558024, 6601.438877695449, 6634.535582509178, 6655.833604159935, 6670.299618539983, 6823.112995310578, 6867.141607299088, 6876.587404755731, 6878.58728476293, 6885.139357580302], "unit": "score", "name": "mootools.html", "value": 4443.545476968276}, {"lowerIsBetter": false, "replicates": [339.14535370865417, 352.79890462436424, 352.86943830782604, 353.7894952503261, 355.6816649099056, 5880.617759845607, 5911.615744976579, 5916.349201587822, 5925.229720136376, 5960.165576819238, 5833.941660583393, 5834.649921004742, 5840.240768700074, 5841.094630332294, 5844.620099693528, 4415.845445409412, 4498.415206023213, 4566.406367172263, 4613.469451013135, 4643.419572553431, 4615.561521655454, 4617.976910115462, 4626.7223966562115, 4627.167109920213, 4638.1883170445035, 4580.748058856761, 4583.770811459431, 4588.701734387271, 4591.288350305691, 4606.078784243165, 4405.0, 4470.888227794315, 4564.840230591946, 4574.9542504574865, 4599.2871104978785, 4054.898627534306, 4056.9188616227807, 4061.3298805697023, 4068.247374235746, 4076.449679293317, 5574.191742197399, 5584.106542953108, 5591.993441180586, 5594.664320140804, 5595.916061259084, 5298.682079075268, 5300.0459917214885, 5300.734963251822, 5303.681779093266, 5304.708241046741, 6162.414570615784, 6166.167567378391, 6169.3522180170885, 6175.07373893915, 6179.0422484514975, 4198.9370159447635, 4316.5467625899455, 4325.52419233884, 4482.081173359454, 4483.529229430896, 6377.71300291488, 6409.871802563969, 6430.582012169194, 6433.646149461824, 6444.355564443565, 4456.9108617828115, 4462.3306504024, 4464.241079016575, 4466.598006179394, 4474.0, 4517.141743068806, 4523.389342438794, 4533.365328853963, 4535.4103966484145, 4535.841245556389, 5198.038362902875, 5205.29728486657, 5214.6610470320065, 5214.921776173361, 5220.1647736362, 6042.305134909454, 6210.441060304594, 6222.0, 6234.594751341239, 6238.189035425366, 1575.0549670198018, 1589.5390336802197, 1599.3762432651276, 1600.1279302780013, 1608.3727346334938, 1007.8941711120374, 1057.4501259345097, 1059.3802625464036, 1070.29895418501, 1072.6674730833467, 5840.415958404125, 5852.590318677737, 5856.414358564195, 5860.501857342174, 5864.38423965486, 6285.2457705075685, 6386.201724784402, 6415.037744338387, 6417.069524918954, 6420.454261387835, 5929.762809487572, 5941.55438342126, 5948.405159484104, 5949.732262048218, 5955.076963070731, 3400.3199360128074, 3437.570303712036, 3441.0193094967813, 3445.896623101311, 3450.9654903450646, 6448.0, 6541.672916354259, 6560.573562718408, 6572.8356791080605, 6574.572652777554, 6464.482841372679, 6477.125588045647, 6506.0, 6506.869862602722, 6507.7071531781185, 6544.541882068304, 6563.113979612691, 6576.210854697467, 6578.440832529289, 6581.86836263272, 6310.085037669604, 6323.715432805443, 6334.493240540838, 6335.809925702236, 6348.714307856065, 6171.337389049495, 6181.567290289637, 6282.057691346335, 6317.494600432046, 6318.526110541636, 6518.57629254097, 6541.934580654323, 6546.541742078009, 6547.312532184052, 6549.508786840911, 4460.576245256695, 4461.977690111528, 4468.4637843458995, 4473.507914129508, 4478.462584489882, 6314.273858506331, 6328.240611126695, 6330.272018717722, 6333.746650133943, 6333.809985700436, 6147.84630384244, 6149.292831324455, 6165.0, 6172.783952561639, 6175.073738939195, 6017.488513476404, 6094.238220222473, 6149.508039356751, 6151.292601350902, 6157.53818463626, 5993.130996005642, 6037.426444487766, 6038.667873266837, 6042.305134909366, 6044.15381846533, 6168.1056246844855, 6170.475509581556, 6173.969130154321, 6184.196054512884, 6190.380961903774, 5915.615484993634, 5980.641161530322, 6034.607750496204, 6049.667268300285, 6050.0924861269405], "unit": "score", "name": "prototype.html", "value": 4701.779335020556}, {"lowerIsBetter": false, "replicates": [697.1564407067448, 765.6975494679601, 767.5586537740799, 773.5088218980949, 783.1698399696321, 13997.300134993247, 14202.289885505723, 14208.360623771929, 14224.288785560719, 14252.572422827332, 14360.856391436082, 14420.134791912466, 14443.78334324986, 14477.276136193175, 14489.058211216263, 785.0461689047805, 925.3984909808645, 932.2029664636757, 946.2666433514013, 950.078423928788, 942.63708472238, 945.6690158444524, 947.720422475368, 950.538988590533, 951.3673407184215, 964.9614015439374, 975.9853602195973, 976.8876579193412, 976.9706908792748, 977.1596427072711, 810.3760104719363, 951.3198063384644, 957.3346524165707, 961.1637875048717, 968.2205824311461, 703.9014537964689, 704.4364508393265, 704.5526090932244, 713.5148099292479, 727.7780277015509, 13971.0, 14009.929950350284, 14023.158610483404, 14025.228612426312, 14031.228282444461, 13589.388477518536, 13844.0, 13879.583612491642, 14097.436102555885, 14342.211178385185, 11194.38430886301, 11212.327260364404, 11458.312501249868, 11460.255083419552, 11553.480093395818, 3889.4554762333296, 3920.313945059603, 3944.408338749182, 3951.723379363446, 3980.203959208141, 48052.0, 48187.75906120482, 48348.0, 48381.51618483841, 50802.23796643053, 10503.159747220205, 10706.518206680563, 11040.33757974524, 11083.113350931906, 11319.660410187707, 18312.809667371577, 18336.54158646018, 18368.173432195585, 18400.539986500444, 18413.355532556296, 7939.0870049945, 7944.126146123922, 7989.2809647132035, 8259.917400825914, 8624.353173512012, 4583.862484125481, 4659.301104834302, 4734.976325118421, 4762.809487620526, 4874.000829829876, 3233.644299127094, 3277.393682168806, 3278.7868788528667, 3280.1471617379652, 3285.65500622436, 568.2640979930999, 597.7041364524501, 604.3171216525386, 604.7490291529055, 630.9652969086652, 646.4311405962817, 662.215274899246, 667.3593350383686, 685.6229074009275, 689.3038031588133, 8605.913940860637, 8838.337124715672, 8922.73231803047, 9029.63881444748, 9310.441373517611, 650.4503694378243, 680.251723104581, 702.3362922038624, 773.4353921637236, 773.8856047291994, 4207.76857272853, 4590.747508886977, 4603.378543896598, 4616.815327386934, 4708.411448568929, 64509.0, 65385.67307163434, 66021.0, 66725.33274667288, 66750.33249667539, 54421.0, 54471.0, 54624.0, 54989.72505137449, 55018.0, 51469.48530514647, 51621.7418912903, 51996.48003519992, 52534.474655253725, 53444.46555534473, 9269.108797163171, 9325.020872808529, 9492.145706886413, 9510.429374237568, 9565.808683826424, 36606.45090323594, 37229.44155837611, 37607.62392376041, 38178.2364352717, 38581.807090964365, 48273.0, 49052.75473622609, 49399.0, 49987.25019124789, 50656.746716266185, 12343.382830858242, 12354.52725073853, 12482.126251162696, 12527.248365098123, 12660.30368329714, 13580.864191358356, 13737.450501980209, 13976.720465590835, 14135.505257315945, 14504.347304371118, 11832.940835296113, 12087.09346798976, 12140.089493288215, 12159.148859579744, 12411.193272437262, 11552.075833933433, 12071.818922715991, 12569.497220111092, 12614.747705046031, 12799.616011519669, 12266.32535210572, 12302.200356976768, 12476.599548128988, 12801.807972880228, 12814.679633008876, 11142.498587563741, 11189.328640281608, 11243.66269011931, 11369.2609980351, 11389.829152562552, 10679.796061181769, 10760.139188864716, 10826.783464330512, 10910.563577456813, 10983.670489885317], "unit": "score", "name": "yui.html", "value": 6882.919789946545}], "name": "dromaeo_css", "value": 7176.684581338682}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 114.0, 111.0, 111.0, 110.0, 111.0, 112.0, 111.0, 123.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [153.0, 128.0, 156.0, 180.0, 133.0, 157.0, 158.0, 131.0, 166.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 162.0, 159.0, 162.0, 162.0, 160.0, 160.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 74.0, 165.0, 76.0, 76.0, 76.0, 77.0, 163.0, 74.0], "unit": "score", "name": "audio-fft", "value": 93.4}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 146.0, 93.0, 93.0, 93.0, 148.0, 94.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [56.0, 65.0, 57.0, 57.0, 57.0, 56.0, 57.0, 58.0, 66.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 80.0, 78.0, 80.0, 78.0, 79.0, 79.0, 79.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [113.0, 112.0, 112.0, 110.0, 120.0, 115.0, 119.0, 110.0, 111.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.0}, {"lowerIsBetter": true, "replicates": [140.0, 139.0, 145.0, 139.0, 147.0, 136.0, 145.0, 143.0, 147.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.4}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 66.0, 67.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1508.2000000000003}]} 17:12:24 INFO - Return code: 0 17:12:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:12:24 INFO - # TBPL SUCCESS # 17:12:24 INFO - Running post-action listener: _resource_record_post_action 17:12:24 INFO - Running post-run listener: _resource_record_post_run 17:12:25 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 503808; Write bytes: 286031872; Read time: 68; Write time: 186248 17:12:25 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 67194880; Read time: 0; Write time: 41852 17:12:25 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 503808; Write bytes: 218836992; Read time: 68; Write time: 144396 17:12:25 INFO - Running post-run listener: _upload_blobber_files 17:12:25 INFO - Blob upload gear active. 17:12:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:12:25 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 17:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:12:25 INFO - (blobuploader) - INFO - Open directory for files ... 17:12:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:12:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:12:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:26 INFO - (blobuploader) - INFO - Done attempting. 17:12:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:12:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:12:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:27 INFO - (blobuploader) - INFO - Done attempting. 17:12:27 INFO - (blobuploader) - INFO - Iteration through files over. 17:12:27 INFO - Return code: 0 17:12:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:12:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:12:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f12d917ed02e35ed8d1684e98cee30a0df1bf5c527bbec51561a5c7c1991f19684cccd2a905c44af9b6d5fc3c3aab583185f5872c60011c47d1be49593419833", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f454fe3c23c994bf6f47c8f3460db0f0a7324e00eb489934ad2011c1188ae76c34696991fea6cd9e6c24e95ea24b2d22d9fa90dc87dbed7f0a9c6fa4d3b81ef"} 17:12:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:12:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:12:27 INFO - Contents: 17:12:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f12d917ed02e35ed8d1684e98cee30a0df1bf5c527bbec51561a5c7c1991f19684cccd2a905c44af9b6d5fc3c3aab583185f5872c60011c47d1be49593419833", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f454fe3c23c994bf6f47c8f3460db0f0a7324e00eb489934ad2011c1188ae76c34696991fea6cd9e6c24e95ea24b2d22d9fa90dc87dbed7f0a9c6fa4d3b81ef"} 17:12:27 INFO - Running post-run listener: copy_logs_to_upload_dir 17:12:27 INFO - Copying logs to upload dir... 17:12:27 INFO - mkdir: /builds/slave/test/build/upload/logs 17:12:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1223.032434 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-05-30 17:12:27.143050) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 17:12:27.147242) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f12d917ed02e35ed8d1684e98cee30a0df1bf5c527bbec51561a5c7c1991f19684cccd2a905c44af9b6d5fc3c3aab583185f5872c60011c47d1be49593419833", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f454fe3c23c994bf6f47c8f3460db0f0a7324e00eb489934ad2011c1188ae76c34696991fea6cd9e6c24e95ea24b2d22d9fa90dc87dbed7f0a9c6fa4d3b81ef"} build_url:https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/f4GDJdCZR7SnRBdlkgdboQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f12d917ed02e35ed8d1684e98cee30a0df1bf5c527bbec51561a5c7c1991f19684cccd2a905c44af9b6d5fc3c3aab583185f5872c60011c47d1be49593419833", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f454fe3c23c994bf6f47c8f3460db0f0a7324e00eb489934ad2011c1188ae76c34696991fea6cd9e6c24e95ea24b2d22d9fa90dc87dbed7f0a9c6fa4d3b81ef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 17:12:27.179013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 17:12:27.179573) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464652321.738370-1087646968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 17:12:27.265788) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 17:12:27.266268) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 17:12:27.266718) ========= ========= Total master_lag: 0.16 =========