builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1462799207.75 results: success (0) buildid: 20160506162552 builduid: b72a63e889694b7881d89602fbd1d472 revision: 025d85d8686491f7975b9d2e86b97180e3f9e0fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:06:47.750170) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:06:47.750707) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:06:47.750991) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:06:47.767612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:06:47.768001) ========= 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=a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 06:06:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-05-09 06:06:48 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081823 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:06:47.863437) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:06:47.863766) ========= 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=a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014680 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:06:47.913875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:06:47.914216) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 025d85d8686491f7975b9d2e86b97180e3f9e0fa --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 025d85d8686491f7975b9d2e86b97180e3f9e0fa --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=a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 06:06:48,795 truncating revision to first 12 chars 2016-05-09 06:06:48,795 Setting DEBUG logging. 2016-05-09 06:06:48,795 attempt 1/10 2016-05-09 06:06:48,795 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/025d85d86864?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 06:06:49,794 unpacking tar archive at: mozilla-beta-025d85d86864/testing/mozharness/ program finished with exit code 0 elapsedTime=1.319216 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:06:49.246141) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:06:49.246465) ========= script_repo_revision: 025d85d8686491f7975b9d2e86b97180e3f9e0fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:06:49.246865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:06:49.247128) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:06:49.256315) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-05-09 06:06:49.256906) ========= /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=a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:06:50 INFO - MultiFileLogger online at 20160509 06:06:50 in /builds/slave/test 06:06:50 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 06:06:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:06:50 INFO - {'append_to_log': False, 06:06:50 INFO - 'base_work_dir': '/builds/slave/test', 06:06:50 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:06:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:06:50 INFO - 'branch': 'Mozilla-Beta', 06:06:50 INFO - 'buildbot_json_path': 'buildprops.json', 06:06:50 INFO - 'config_files': ('talos/linux_config.py',), 06:06:50 INFO - 'default_actions': ('clobber', 06:06:50 INFO - 'read-buildbot-config', 06:06:50 INFO - 'download-and-extract', 06:06:50 INFO - 'populate-webroot', 06:06:50 INFO - 'create-virtualenv', 06:06:50 INFO - 'install', 06:06:50 INFO - 'run-tests'), 06:06:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:06:50 INFO - 'download_minidump_stackwalk': True, 06:06:50 INFO - 'download_symbols': 'ondemand', 06:06:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:06:50 INFO - 'tooltool.py': '/tools/tooltool.py', 06:06:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:06:50 INFO - '/tools/misc-python/virtualenv.py')}, 06:06:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:06:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:06:50 INFO - 'installer_path': 'installer.exe', 06:06:50 INFO - 'log_level': 'info', 06:06:50 INFO - 'log_name': 'talos', 06:06:50 INFO - 'log_to_console': True, 06:06:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:06:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:06:50 INFO - 'opt_config_files': (), 06:06:50 INFO - 'pip_index': False, 06:06:50 INFO - 'sps_profile': False, 06:06:50 INFO - 'sps_profile_interval': 0, 06:06:50 INFO - 'suite': 'dromaeojs', 06:06:50 INFO - 'system_bits': '32', 06:06:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:06:50 INFO - 'title': 'talos-linux64-ix-002', 06:06:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:06:50 INFO - 'use_talos_json': True, 06:06:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:06:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:06:50 INFO - 'work_dir': 'build'} 06:06:50 INFO - ##### 06:06:50 INFO - ##### Running clobber step. 06:06:50 INFO - ##### 06:06:50 INFO - Running pre-action listener: _resource_record_pre_action 06:06:50 INFO - Running main action method: clobber 06:06:50 INFO - rmtree: /builds/slave/test/build 06:06:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:06:51 INFO - Running post-action listener: _resource_record_post_action 06:06:51 INFO - ##### 06:06:51 INFO - ##### Running read-buildbot-config step. 06:06:51 INFO - ##### 06:06:51 INFO - Running pre-action listener: _resource_record_pre_action 06:06:51 INFO - Running main action method: read_buildbot_config 06:06:51 INFO - Using buildbot properties: 06:06:51 INFO - { 06:06:51 INFO - "project": "", 06:06:51 INFO - "product": "firefox", 06:06:51 INFO - "script_repo_revision": "production", 06:06:51 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:06:51 INFO - "repository": "", 06:06:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:06:51 INFO - "buildid": "20160506162552", 06:06:51 INFO - "pgo_build": "True", 06:06:51 INFO - "basedir": "/builds/slave/test", 06:06:51 INFO - "buildnumber": 230, 06:06:51 INFO - "slavename": "talos-linux64-ix-002", 06:06:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:06:51 INFO - "platform": "ubuntu64_hw", 06:06:51 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:06:51 INFO - "branch": "mozilla-beta", 06:06:51 INFO - "repo_path": "releases/mozilla-beta", 06:06:51 INFO - "revision": "025d85d8686491f7975b9d2e86b97180e3f9e0fa", 06:06:51 INFO - "stage_platform": "linux64-pgo", 06:06:51 INFO - "builduid": "b72a63e889694b7881d89602fbd1d472", 06:06:51 INFO - "slavebuilddir": "test" 06:06:51 INFO - } 06:06:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 06:06:51 INFO - Running post-action listener: _resource_record_post_action 06:06:51 INFO - ##### 06:06:51 INFO - ##### Running download-and-extract step. 06:06:51 INFO - ##### 06:06:51 INFO - Running pre-action listener: _resource_record_pre_action 06:06:51 INFO - Running main action method: download_and_extract 06:06:51 INFO - mkdir: /builds/slave/test/build/tests 06:06: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')]} 06:06:51 INFO - https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:06:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:06:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:06:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/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 06:06:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/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 06:06:51 INFO - Downloaded 1412 bytes. 06:06:51 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:06:51 INFO - Using the following test package requirements: 06:06:51 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:06:51 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:06:51 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:06:51 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:06:51 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 06:06:51 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:06:51 INFO - u'jsshell-linux-x86_64.zip'], 06:06:51 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:06:51 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:06:51 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:06:51 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:06:51 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 06:06:51 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:06:51 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 06:06:51 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:06:51 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:06:51 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:06:51 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:06:51 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:06:51 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:06: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')]} 06:06:51 INFO - https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:06:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:06:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:06:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/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 06:06:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/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 06:06:52 INFO - Downloaded 23364641 bytes. 06:06:52 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'] 06:06:52 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 06:06:54 INFO - Return code: 0 06:06:54 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 06:06:54 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')]} 06:06:54 INFO - https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:06:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:06:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:06:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/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 06:06:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/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 06:06:55 INFO - Downloaded 23364641 bytes. 06:06:55 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'] 06:06:55 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 06:06:57 INFO - Return code: 0 06:06:57 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')]} 06:06:57 INFO - https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:06:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:06:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:06:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/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 06:06:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/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 06:06:58 INFO - Downloaded 10845194 bytes. 06:06:58 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'] 06:06:58 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 06:06:58 INFO - Return code: 0 06:06:58 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')]} 06:06:58 INFO - https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:06:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:06:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:06:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/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 06:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/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 06:06:59 INFO - Downloaded 53795175 bytes. 06:06:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:06:59 INFO - mkdir: /builds/slave/test/properties 06:06:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:06:59 INFO - Writing to file /builds/slave/test/properties/build_url 06:06:59 INFO - Contents: 06:06:59 INFO - build_url:https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:07:00 INFO - Running post-action listener: _resource_record_post_action 06:07:00 INFO - Running post-action listener: set_extra_try_arguments 06:07:00 INFO - ##### 06:07:00 INFO - ##### Running populate-webroot step. 06:07:00 INFO - ##### 06:07:00 INFO - Running pre-action listener: _resource_record_pre_action 06:07:00 INFO - Running main action method: populate_webroot 06:07:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:07:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:07:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:07:00 INFO - '--tppagecycles', 06:07:00 INFO - '7'], 06:07:00 INFO - 'tests': ['tsvgm']}}, 06:07:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:07:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:07:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:07:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:07:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:07:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:07:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:07:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:00 INFO - 'talos_options': ['--e10s'], 06:07:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:07:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:00 INFO - 'tests': ['damp', 'tps']}, 06:07:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:00 INFO - 'talos_options': ['--e10s'], 06:07:00 INFO - 'tests': ['damp', 'tps']}, 06:07:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:07:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:07:00 INFO - 'other': {'tests': ['a11yr', 06:07:00 INFO - 'ts_paint', 06:07:00 INFO - 'tpaint', 06:07:00 INFO - 'sessionrestore', 06:07:00 INFO - 'sessionrestore_no_auto_restore', 06:07:00 INFO - 'tabpaint']}, 06:07:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:07:00 INFO - 'tests': ['a11yr', 06:07:00 INFO - 'ts_paint', 06:07:00 INFO - 'tpaint', 06:07:00 INFO - 'sessionrestore', 06:07:00 INFO - 'sessionrestore_no_auto_restore', 06:07:00 INFO - 'tabpaint']}, 06:07:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:07:00 INFO - 'tests': ['a11yr', 06:07:00 INFO - 'ts_paint', 06:07:00 INFO - 'tpaint', 06:07:00 INFO - 'sessionrestore', 06:07:00 INFO - 'sessionrestore_no_auto_restore', 06:07:00 INFO - 'tabpaint']}, 06:07:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:07:00 INFO - 'tests': ['a11yr', 06:07:00 INFO - 'ts_paint', 06:07:00 INFO - 'tpaint', 06:07:00 INFO - 'sessionrestore', 06:07:00 INFO - 'sessionrestore_no_auto_restore', 06:07:00 INFO - 'tabpaint']}, 06:07:00 INFO - 'other_l64': {'tests': ['a11yr', 06:07:00 INFO - 'ts_paint', 06:07:00 INFO - 'tpaint', 06:07:00 INFO - 'sessionrestore', 06:07:00 INFO - 'sessionrestore_no_auto_restore', 06:07:00 INFO - 'tabpaint']}, 06:07:00 INFO - 'other_nol64': {'tests': ['a11yr', 06:07:00 INFO - 'ts_paint', 06:07:00 INFO - 'tpaint', 06:07:00 INFO - 'sessionrestore', 06:07:00 INFO - 'sessionrestore_no_auto_restore', 06:07:00 INFO - 'tabpaint']}, 06:07:00 INFO - 'svgr': {'tests': ['tsvgx', 06:07:00 INFO - 'tsvgr_opacity', 06:07:00 INFO - 'tart', 06:07:00 INFO - 'tscrollx', 06:07:00 INFO - 'cart']}, 06:07:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:07:00 INFO - 'tests': ['tsvgx', 06:07:00 INFO - 'tsvgr_opacity', 06:07:00 INFO - 'tart', 06:07:00 INFO - 'tscrollx', 06:07:00 INFO - 'cart']}, 06:07:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:00 INFO - 'tests': ['tp5o']}, 06:07:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:00 INFO - 'talos_options': ['--e10s'], 06:07:00 INFO - 'tests': ['tp5o']}, 06:07:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:00 INFO - 'talos_options': ['--xperf_path', 06:07:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:07:00 INFO - 'tests': ['tp5n']}, 06:07:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:00 INFO - 'talos_options': ['--e10s', 06:07:00 INFO - '--xperf_path', 06:07:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:07:00 INFO - 'tests': ['tp5n']}}, 06:07:00 INFO - 'talos.zip': {'path': '', 06:07:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:07:00 INFO - Running post-action listener: _resource_record_post_action 06:07:00 INFO - ##### 06:07:00 INFO - ##### Running create-virtualenv step. 06:07:00 INFO - ##### 06:07:00 INFO - Running pre-action listener: _resource_record_pre_action 06:07:00 INFO - Running main action method: create_virtualenv 06:07:00 INFO - Creating virtualenv /builds/slave/test/build/venv 06:07:00 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 06:07:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:07:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:07:00 INFO - Using real prefix '/usr' 06:07:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:07:00 INFO - Installing distribute.............................................................................................................................................................................................done. 06:07:02 INFO - Installing pip.................done. 06:07:02 INFO - Return code: 0 06:07:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f83cb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2571410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2600160>, '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 0x2601060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26014f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', '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 06:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:07:02 INFO - Using env: {'DISPLAY': ':0', 06:07:02 INFO - 'HOME': '/home/cltbld', 06:07:02 INFO - 'LANG': 'en_US.UTF-8', 06:07:02 INFO - 'LANGUAGE': 'en_US:en', 06:07:02 INFO - 'LOGNAME': 'cltbld', 06:07:02 INFO - 'MAIL': '/var/mail/cltbld', 06:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:02 INFO - 'MOZ_NO_REMOTE': '1', 06:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:02 INFO - 'NO_EM_RESTART': '1', 06:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:02 INFO - 'PWD': '/builds/slave/test', 06:07:02 INFO - 'SHELL': '/bin/bash', 06:07:02 INFO - 'SHLVL': '1', 06:07:02 INFO - 'TERM': 'linux', 06:07:02 INFO - 'TMOUT': '86400', 06:07:02 INFO - 'USER': 'cltbld', 06:07:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', 06:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:02 INFO - '_': '/tools/buildbot/bin/python'} 06:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:03 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 06:07:03 INFO - Cleaning up... 06:07:03 INFO - Return code: 0 06:07:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:03 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 0x7f8f83cb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2571410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2600160>, '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 0x2601060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26014f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', '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 06:07:03 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 06:07:03 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 06:07:03 INFO - Using env: {'DISPLAY': ':0', 06:07:03 INFO - 'HOME': '/home/cltbld', 06:07:03 INFO - 'LANG': 'en_US.UTF-8', 06:07:03 INFO - 'LANGUAGE': 'en_US:en', 06:07:03 INFO - 'LOGNAME': 'cltbld', 06:07:03 INFO - 'MAIL': '/var/mail/cltbld', 06:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:03 INFO - 'MOZ_NO_REMOTE': '1', 06:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:03 INFO - 'NO_EM_RESTART': '1', 06:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:03 INFO - 'PWD': '/builds/slave/test', 06:07:03 INFO - 'SHELL': '/bin/bash', 06:07:03 INFO - 'SHLVL': '1', 06:07:03 INFO - 'TERM': 'linux', 06:07:03 INFO - 'TMOUT': '86400', 06:07:03 INFO - 'USER': 'cltbld', 06:07:03 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', 06:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:03 INFO - '_': '/tools/buildbot/bin/python'} 06:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:03 INFO - Downloading/unpacking psutil>=0.7.1 06:07:03 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 06:07:03 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 06:07:03 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 06:07:03 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 06:07:03 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 06:07:03 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 06:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:07:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:07:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:07:05 INFO - Installing collected packages: psutil 06:07:05 INFO - Running setup.py install for psutil 06:07:05 INFO - building 'psutil._psutil_linux' extension 06:07:05 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 06:07:05 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 06:07:05 INFO - building 'psutil._psutil_posix' extension 06:07:05 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 06:07:05 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 06:07:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:07:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:07:05 INFO - Successfully installed psutil 06:07:05 INFO - Cleaning up... 06:07:05 INFO - Return code: 0 06:07:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:07: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')]} 06:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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')]} 06:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:05 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 0x7f8f83cb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2571410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2600160>, '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 0x2601060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26014f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', '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 06:07:05 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 06:07:05 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 06:07:05 INFO - Using env: {'DISPLAY': ':0', 06:07:05 INFO - 'HOME': '/home/cltbld', 06:07:05 INFO - 'LANG': 'en_US.UTF-8', 06:07:05 INFO - 'LANGUAGE': 'en_US:en', 06:07:05 INFO - 'LOGNAME': 'cltbld', 06:07:05 INFO - 'MAIL': '/var/mail/cltbld', 06:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:05 INFO - 'MOZ_NO_REMOTE': '1', 06:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:05 INFO - 'NO_EM_RESTART': '1', 06:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:05 INFO - 'PWD': '/builds/slave/test', 06:07:05 INFO - 'SHELL': '/bin/bash', 06:07:05 INFO - 'SHLVL': '1', 06:07:05 INFO - 'TERM': 'linux', 06:07:05 INFO - 'TMOUT': '86400', 06:07:05 INFO - 'USER': 'cltbld', 06:07:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', 06:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:05 INFO - '_': '/tools/buildbot/bin/python'} 06:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:07:06 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 06:07:06 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 06:07:06 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 06:07:06 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 06:07:06 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 06:07:06 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 06:07:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:07:08 INFO - Installing collected packages: mozsystemmonitor 06:07:08 INFO - Running setup.py install for mozsystemmonitor 06:07:08 INFO - Successfully installed mozsystemmonitor 06:07:08 INFO - Cleaning up... 06:07:08 INFO - Return code: 0 06:07:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:08 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 0x7f8f83cb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2571410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2600160>, '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 0x2601060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26014f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', '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 06:07:08 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 06:07:08 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 06:07:08 INFO - Using env: {'DISPLAY': ':0', 06:07:08 INFO - 'HOME': '/home/cltbld', 06:07:08 INFO - 'LANG': 'en_US.UTF-8', 06:07:08 INFO - 'LANGUAGE': 'en_US:en', 06:07:08 INFO - 'LOGNAME': 'cltbld', 06:07:08 INFO - 'MAIL': '/var/mail/cltbld', 06:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:08 INFO - 'MOZ_NO_REMOTE': '1', 06:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:08 INFO - 'NO_EM_RESTART': '1', 06:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:08 INFO - 'PWD': '/builds/slave/test', 06:07:08 INFO - 'SHELL': '/bin/bash', 06:07:08 INFO - 'SHLVL': '1', 06:07:08 INFO - 'TERM': 'linux', 06:07:08 INFO - 'TMOUT': '86400', 06:07:08 INFO - 'USER': 'cltbld', 06:07:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', 06:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:08 INFO - '_': '/tools/buildbot/bin/python'} 06:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:08 INFO - Downloading/unpacking blobuploader==1.2.4 06:07:08 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 06:07:08 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 06:07:08 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 06:07:08 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 06:07:08 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 06:07:08 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 06:07:10 INFO - Downloading blobuploader-1.2.4.tar.gz 06:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:07:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:07:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:11 INFO - Downloading docopt-0.6.1.tar.gz 06:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:07:11 INFO - Installing collected packages: blobuploader, requests, docopt 06:07:11 INFO - Running setup.py install for blobuploader 06:07:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:07:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:07:11 INFO - Running setup.py install for requests 06:07:11 INFO - Running setup.py install for docopt 06:07:11 INFO - Successfully installed blobuploader requests docopt 06:07:11 INFO - Cleaning up... 06:07:11 INFO - Return code: 0 06:07:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07: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')]} 06:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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')]} 06:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:11 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 0x7f8f83cb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2571410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2600160>, '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 0x2601060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26014f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', '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 06:07:11 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 06:07:11 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 06:07:11 INFO - Using env: {'DISPLAY': ':0', 06:07:11 INFO - 'HOME': '/home/cltbld', 06:07:11 INFO - 'LANG': 'en_US.UTF-8', 06:07:11 INFO - 'LANGUAGE': 'en_US:en', 06:07:11 INFO - 'LOGNAME': 'cltbld', 06:07:11 INFO - 'MAIL': '/var/mail/cltbld', 06:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:11 INFO - 'MOZ_NO_REMOTE': '1', 06:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:11 INFO - 'NO_EM_RESTART': '1', 06:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:11 INFO - 'PWD': '/builds/slave/test', 06:07:11 INFO - 'SHELL': '/bin/bash', 06:07:11 INFO - 'SHLVL': '1', 06:07:11 INFO - 'TERM': 'linux', 06:07:11 INFO - 'TMOUT': '86400', 06:07:11 INFO - 'USER': 'cltbld', 06:07:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', 06:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:11 INFO - '_': '/tools/buildbot/bin/python'} 06:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:07:11 INFO - Running setup.py (path:/tmp/pip-TVZUKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:07:11 INFO - Running setup.py (path:/tmp/pip-8BnCwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:07:12 INFO - Running setup.py (path:/tmp/pip-Zy_FpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:07:12 INFO - Running setup.py (path:/tmp/pip-L0sXLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:07:12 INFO - Running setup.py (path:/tmp/pip-JjFQNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:07:12 INFO - Running setup.py (path:/tmp/pip-vndzAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:07:12 INFO - Running setup.py (path:/tmp/pip-wMH6g8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:07:12 INFO - Running setup.py (path:/tmp/pip-p_knbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:07:12 INFO - Running setup.py (path:/tmp/pip-bixmcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:07:12 INFO - Running setup.py (path:/tmp/pip-B_P7xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:07:12 INFO - Running setup.py (path:/tmp/pip-mG7wA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:07:12 INFO - Running setup.py (path:/tmp/pip-8HmjjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:07:12 INFO - Running setup.py (path:/tmp/pip-tSEM1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:07:12 INFO - Running setup.py (path:/tmp/pip-V90l1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:12 INFO - Running setup.py (path:/tmp/pip-NwZBT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:07:12 INFO - Running setup.py (path:/tmp/pip-x3bl4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:07:13 INFO - Running setup.py (path:/tmp/pip-450TfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:07:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:07:13 INFO - Running setup.py install for manifestparser 06:07:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:07:13 INFO - Running setup.py install for mozcrash 06:07:13 INFO - Running setup.py install for mozdebug 06:07:13 INFO - Running setup.py install for mozdevice 06:07:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:07:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:07:13 INFO - Running setup.py install for mozfile 06:07:13 INFO - Running setup.py install for mozhttpd 06:07:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:07:13 INFO - Running setup.py install for mozinfo 06:07:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:07:13 INFO - Running setup.py install for mozInstall 06:07:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:07:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:07:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:07:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:07:13 INFO - Running setup.py install for mozleak 06:07:13 INFO - Running setup.py install for mozlog 06:07:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:07:14 INFO - Running setup.py install for moznetwork 06:07:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:07:14 INFO - Running setup.py install for mozprocess 06:07:14 INFO - Running setup.py install for mozprofile 06:07:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:07:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:07:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:07:14 INFO - Running setup.py install for mozrunner 06:07:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:07:14 INFO - Running setup.py install for mozscreenshot 06:07:14 INFO - Running setup.py install for moztest 06:07:14 INFO - Running setup.py install for mozversion 06:07:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:07:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:07:14 INFO - Cleaning up... 06:07:14 INFO - Return code: 0 06:07:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07:14 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')]} 06:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:14 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')]} 06:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:14 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 0x7f8f83cb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2571410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2600160>, '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 0x2601060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26014f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', '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 06:07:14 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 06:07:14 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 06:07:14 INFO - Using env: {'DISPLAY': ':0', 06:07:14 INFO - 'HOME': '/home/cltbld', 06:07:14 INFO - 'LANG': 'en_US.UTF-8', 06:07:14 INFO - 'LANGUAGE': 'en_US:en', 06:07:14 INFO - 'LOGNAME': 'cltbld', 06:07:14 INFO - 'MAIL': '/var/mail/cltbld', 06:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:14 INFO - 'MOZ_NO_REMOTE': '1', 06:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:14 INFO - 'NO_EM_RESTART': '1', 06:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:14 INFO - 'PWD': '/builds/slave/test', 06:07:14 INFO - 'SHELL': '/bin/bash', 06:07:14 INFO - 'SHLVL': '1', 06:07:14 INFO - 'TERM': 'linux', 06:07:14 INFO - 'TMOUT': '86400', 06:07:14 INFO - 'USER': 'cltbld', 06:07:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', 06:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:14 INFO - '_': '/tools/buildbot/bin/python'} 06:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:07:15 INFO - Running setup.py (path:/tmp/pip-L2gKxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:07:15 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)) 06:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:07:15 INFO - Running setup.py (path:/tmp/pip-fGq_9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:07:15 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)) 06:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:07:15 INFO - Running setup.py (path:/tmp/pip-t8KUc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:07:15 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)) 06:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:07:15 INFO - Running setup.py (path:/tmp/pip-mC1uLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:07:15 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)) 06:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:07:15 INFO - Running setup.py (path:/tmp/pip-X9ntLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:07:15 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)) 06:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:07:15 INFO - Running setup.py (path:/tmp/pip-Xi_8rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:07:15 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)) 06:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:07:15 INFO - Running setup.py (path:/tmp/pip-YDwfbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:07:15 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)) 06:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:07:15 INFO - Running setup.py (path:/tmp/pip-SV9U50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:07:15 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)) 06:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:07:15 INFO - Running setup.py (path:/tmp/pip-uYf17n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:07:15 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)) 06:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:07:15 INFO - Running setup.py (path:/tmp/pip-rVxVLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:07:15 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)) 06:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:07:15 INFO - Running setup.py (path:/tmp/pip-X79_VU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:07:15 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)) 06:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:07:15 INFO - Running setup.py (path:/tmp/pip-7IZ3RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:07:15 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)) 06:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:07:15 INFO - Running setup.py (path:/tmp/pip-iYEHMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:07:16 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)) 06:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:07:16 INFO - Running setup.py (path:/tmp/pip-gfMfP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:07:16 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)) 06:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:16 INFO - Running setup.py (path:/tmp/pip-MQiF0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:16 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)) 06:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:07:16 INFO - Running setup.py (path:/tmp/pip-jJUC1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:07:16 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)) 06:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:07:16 INFO - Running setup.py (path:/tmp/pip-iFmeRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:07:16 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)) 06:07:16 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)) 06:07:16 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)) 06:07:16 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)) 06:07:16 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)) 06:07:16 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)) 06:07:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:07:16 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 06:07:16 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 06:07:16 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 06:07:16 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 06:07:16 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 06:07:16 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 06:07:18 INFO - Downloading blessings-1.6.tar.gz 06:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:07:18 INFO - Installing collected packages: blessings 06:07:18 INFO - Running setup.py install for blessings 06:07:18 INFO - Successfully installed blessings 06:07:18 INFO - Cleaning up... 06:07:18 INFO - Return code: 0 06:07:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:07:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:07:18 INFO - Reading from file tmpfile_stdout 06:07:18 INFO - Current package versions: 06:07:18 INFO - argparse == 1.2.1 06:07:18 INFO - blessings == 1.6 06:07:18 INFO - blobuploader == 1.2.4 06:07:18 INFO - docopt == 0.6.1 06:07:18 INFO - manifestparser == 1.1 06:07:18 INFO - mozInstall == 1.12 06:07:18 INFO - mozcrash == 0.17 06:07:18 INFO - mozdebug == 0.1 06:07:18 INFO - mozdevice == 0.48 06:07:18 INFO - mozfile == 1.2 06:07:18 INFO - mozhttpd == 0.7 06:07:18 INFO - mozinfo == 0.9 06:07:18 INFO - mozleak == 0.1 06:07:18 INFO - mozlog == 3.1 06:07:18 INFO - moznetwork == 0.27 06:07:18 INFO - mozprocess == 0.22 06:07:18 INFO - mozprofile == 0.28 06:07:18 INFO - mozrunner == 6.11 06:07:18 INFO - mozscreenshot == 0.1 06:07:18 INFO - mozsystemmonitor == 0.0 06:07:18 INFO - moztest == 0.7 06:07:18 INFO - mozversion == 1.4 06:07:18 INFO - psutil == 3.1.1 06:07:18 INFO - requests == 1.2.3 06:07:18 INFO - wsgiref == 0.1.2 06:07:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:18 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 0x7f8f83cb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2571410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2600160>, '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 0x2601060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26014f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', '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 06:07:18 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 06:07:18 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 06:07:18 INFO - Using env: {'DISPLAY': ':0', 06:07:18 INFO - 'HOME': '/home/cltbld', 06:07:18 INFO - 'LANG': 'en_US.UTF-8', 06:07:18 INFO - 'LANGUAGE': 'en_US:en', 06:07:18 INFO - 'LOGNAME': 'cltbld', 06:07:18 INFO - 'MAIL': '/var/mail/cltbld', 06:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:18 INFO - 'MOZ_NO_REMOTE': '1', 06:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:18 INFO - 'NO_EM_RESTART': '1', 06:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:18 INFO - 'PWD': '/builds/slave/test', 06:07:18 INFO - 'SHELL': '/bin/bash', 06:07:18 INFO - 'SHLVL': '1', 06:07:18 INFO - 'TERM': 'linux', 06:07:18 INFO - 'TMOUT': '86400', 06:07:18 INFO - 'USER': 'cltbld', 06:07:18 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', 06:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:18 INFO - '_': '/tools/buildbot/bin/python'} 06:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:18 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)) 06:07:18 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)) 06:07:18 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)) 06:07:18 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)) 06:07:18 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)) 06:07:18 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)) 06:07:18 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)) 06:07:18 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)) 06:07:18 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)) 06:07:18 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)) 06:07:18 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)) 06:07:18 INFO - Cleaning up... 06:07:18 INFO - Return code: 0 06:07:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f83cb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2571410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2600160>, '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 0x2601060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26014f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', '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 06:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:07:18 INFO - Using env: {'DISPLAY': ':0', 06:07:18 INFO - 'HOME': '/home/cltbld', 06:07:18 INFO - 'LANG': 'en_US.UTF-8', 06:07:18 INFO - 'LANGUAGE': 'en_US:en', 06:07:18 INFO - 'LOGNAME': 'cltbld', 06:07:18 INFO - 'MAIL': '/var/mail/cltbld', 06:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:18 INFO - 'MOZ_NO_REMOTE': '1', 06:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:18 INFO - 'NO_EM_RESTART': '1', 06:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:18 INFO - 'PWD': '/builds/slave/test', 06:07:18 INFO - 'SHELL': '/bin/bash', 06:07:18 INFO - 'SHLVL': '1', 06:07:18 INFO - 'TERM': 'linux', 06:07:18 INFO - 'TMOUT': '86400', 06:07:18 INFO - 'USER': 'cltbld', 06:07:18 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', 06:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:18 INFO - '_': '/tools/buildbot/bin/python'} 06:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:19 INFO - Downloading/unpacking jsonschema 06:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:07:20 INFO - Downloading/unpacking functools32 (from jsonschema) 06:07: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 06:07: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 06:07: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 06:07: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 06:07: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 06:07: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 06:07:21 INFO - Downloading functools32-3.2.3-2.tar.gz 06:07:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:07:21 INFO - warning: no files found matching '*.txt' 06:07:21 INFO - no previously-included directories found matching 'build' 06:07:21 INFO - no previously-included directories found matching 'dist' 06:07:21 INFO - no previously-included directories found matching '.git*' 06:07:21 INFO - Installing collected packages: jsonschema, functools32 06:07:21 INFO - Running setup.py install for functools32 06:07:21 INFO - warning: no files found matching '*.txt' 06:07:21 INFO - no previously-included directories found matching 'build' 06:07:21 INFO - no previously-included directories found matching 'dist' 06:07:21 INFO - no previously-included directories found matching '.git*' 06:07:21 INFO - Successfully installed jsonschema functools32 06:07:21 INFO - Cleaning up... 06:07:21 INFO - Return code: 0 06:07:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:21 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 0x7f8f83cb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2571410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2600160>, '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 0x2601060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26014f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', '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 06:07:21 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 06:07:21 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 06:07:21 INFO - Using env: {'DISPLAY': ':0', 06:07:21 INFO - 'HOME': '/home/cltbld', 06:07:21 INFO - 'LANG': 'en_US.UTF-8', 06:07:21 INFO - 'LANGUAGE': 'en_US:en', 06:07:21 INFO - 'LOGNAME': 'cltbld', 06:07:21 INFO - 'MAIL': '/var/mail/cltbld', 06:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:21 INFO - 'MOZ_NO_REMOTE': '1', 06:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:21 INFO - 'NO_EM_RESTART': '1', 06:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:21 INFO - 'PWD': '/builds/slave/test', 06:07:21 INFO - 'SHELL': '/bin/bash', 06:07:21 INFO - 'SHLVL': '1', 06:07:21 INFO - 'TERM': 'linux', 06:07:21 INFO - 'TMOUT': '86400', 06:07:21 INFO - 'USER': 'cltbld', 06:07:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', 06:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:21 INFO - '_': '/tools/buildbot/bin/python'} 06:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:21 INFO - Downloading/unpacking flake8 06:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:07:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:07:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:07:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:07:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:07:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:07:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:07:24 INFO - no previously-included directories found matching 'docs/_build' 06:07:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:07:24 INFO - Running setup.py install for pep8 06:07:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:07:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:07:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:07:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:07:24 INFO - no previously-included directories found matching 'docs/_build' 06:07:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:07:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:07:24 INFO - Cleaning up... 06:07:24 INFO - Return code: 0 06:07:24 INFO - Running post-action listener: _resource_record_post_action 06:07:24 INFO - Running post-action listener: _start_resource_monitoring 06:07:24 INFO - Starting resource monitoring. 06:07:24 INFO - ##### 06:07:24 INFO - ##### Running install step. 06:07:24 INFO - ##### 06:07:24 INFO - Running pre-action listener: _resource_record_pre_action 06:07:24 INFO - Running main action method: install 06:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:07:24 INFO - Reading from file tmpfile_stdout 06:07:24 INFO - Detecting whether we're running mozinstall >=1.0... 06:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:07:24 INFO - Reading from file tmpfile_stdout 06:07:24 INFO - Output received: 06:07:24 INFO - Usage: mozinstall [options] installer 06:07:24 INFO - Options: 06:07:24 INFO - -h, --help show this help message and exit 06:07:24 INFO - -d DEST, --destination=DEST 06:07:24 INFO - Directory to install application into. [default: 06:07:24 INFO - "/builds/slave/test"] 06:07:24 INFO - --app=APP Application being installed. [default: firefox] 06:07:24 INFO - mkdir: /builds/slave/test/build/application 06:07:24 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'] 06:07:24 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 06:07:37 INFO - Reading from file tmpfile_stdout 06:07:37 INFO - Output received: 06:07:37 INFO - /builds/slave/test/build/application/firefox/firefox 06:07:37 INFO - Running post-action listener: _resource_record_post_action 06:07:37 INFO - ##### 06:07:37 INFO - ##### Running run-tests step. 06:07:37 INFO - ##### 06:07:37 INFO - Running pre-action listener: _resource_record_pre_action 06:07:37 INFO - Running main action method: run_tests 06:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:07:37 INFO - Python 2.7.3 06:07:37 INFO - Return code: 0 06:07:37 INFO - grabbing minidump binary from tooltool 06:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:37 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 0x2600160>, '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 0x2601060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26014f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:07:37 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 06:07:37 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 06:07:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:07:37 INFO - Return code: 0 06:07:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:07:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:07:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:07:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:07:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:07:38 INFO - Return code: 0 06:07:38 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/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 06:07:38 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/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 06:07:38 INFO - Using env: {'DISPLAY': ':0', 06:07:38 INFO - 'HOME': '/home/cltbld', 06:07:38 INFO - 'LANG': 'en_US.UTF-8', 06:07:38 INFO - 'LANGUAGE': 'en_US:en', 06:07:38 INFO - 'LOGNAME': 'cltbld', 06:07:38 INFO - 'MAIL': '/var/mail/cltbld', 06:07:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:07:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:38 INFO - 'MOZ_NO_REMOTE': '1', 06:07:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:38 INFO - 'NO_EM_RESTART': '1', 06:07:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:38 INFO - 'PWD': '/builds/slave/test', 06:07:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:07:38 INFO - 'SHELL': '/bin/bash', 06:07:38 INFO - 'SHLVL': '1', 06:07:38 INFO - 'TERM': 'linux', 06:07:38 INFO - 'TMOUT': '86400', 06:07:38 INFO - 'USER': 'cltbld', 06:07:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377', 06:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:38 INFO - '_': '/tools/buildbot/bin/python'} 06:07:38 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/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 06:07:38 INFO - mozversion application_buildid: 20160506162552 06:07:38 INFO - mozversion application_changeset: 025d85d8686491f7975b9d2e86b97180e3f9e0fa 06:07:38 INFO - mozversion application_display_name: Firefox 06:07:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:07:38 INFO - mozversion application_name: Firefox 06:07:38 INFO - mozversion application_remotingname: firefox 06:07:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:07:38 INFO - mozversion application_vendor: Mozilla 06:07:38 INFO - mozversion application_version: 47.0 06:07:38 INFO - mozversion platform_buildid: 20160506162552 06:07:38 INFO - mozversion platform_changeset: 025d85d8686491f7975b9d2e86b97180e3f9e0fa 06:07:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:07:38 INFO - mozversion platform_version: 47.0 06:07:38 INFO - using testdate: 1462799258 06:07:38 INFO - actual date: 1462799258 06:07:38 INFO - starting webserver on 'localhost:56766' 06:07:38 INFO - SUITE-START | Running 2 tests 06:07:38 INFO - TEST-START | dromaeo_css 06:07:38 INFO - operating with platform_type : linux_ 06:07:38 INFO - Initialising browser for dromaeo_css test... 06:07:38 INFO - TEST-INFO | started process 4820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5z4RRk/profile http://localhost:56766/getInfo.html) 06:07:42 INFO - PROCESS | 4820 | __metrics Screen width/height:1600/1200 06:07:42 INFO - PROCESS | 4820 | colorDepth:24 06:07:42 INFO - PROCESS | 4820 | Browser inner width/height: 1024/697 06:07:42 INFO - PROCESS | 4820 | __metrics 06:07:43 INFO - PROCESS | 4820 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:07:44 INFO - TEST-INFO | 4820: exit 0 06:07:44 INFO - Browser initialized. 06:07:44 INFO - Running cycle 1/1 for dromaeo_css test... 06:07:44 INFO - TEST-INFO | started process 4912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5z4RRk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:07:56 INFO - PROCESS | 4912 | RSS: Main: 139235328 06:07:56 INFO - PROCESS | 4912 | 06:08:47 INFO - PROCESS | 4912 | 1462799327880 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] 06:10:54 INFO - PROCESS | 4912 | Cycle 1(1): loaded http://localhost:56766/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56766/tests/dromaeo/cssquery-ext.html) 06:10:56 INFO - PROCESS | 4912 | RSS: Main: 283922432 06:10:56 INFO - PROCESS | 4912 | 06:13:58 INFO - PROCESS | 4912 | Cycle 1(1): loaded http://localhost:56766/tests/dromaeo/cssquery-ext.html (next: http://localhost:56766/tests/dromaeo/cssquery-jquery.html) 06:13:58 INFO - PROCESS | 4912 | RSS: Main: 223899648 06:13:58 INFO - PROCESS | 4912 | 06:17:00 INFO - PROCESS | 4912 | Cycle 1(1): loaded http://localhost:56766/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56766/tests/dromaeo/cssquery-mootools.html) 06:17:01 INFO - PROCESS | 4912 | RSS: Main: 221364224 06:17:01 INFO - PROCESS | 4912 | 06:20:03 INFO - PROCESS | 4912 | Cycle 1(1): loaded http://localhost:56766/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56766/tests/dromaeo/cssquery-prototype.html) 06:20:03 INFO - PROCESS | 4912 | RSS: Main: 212307968 06:20:03 INFO - PROCESS | 4912 | 06:23:06 INFO - PROCESS | 4912 | Cycle 1(1): loaded http://localhost:56766/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56766/tests/dromaeo/cssquery-yui.html) 06:23:06 INFO - PROCESS | 4912 | RSS: Main: 197693440 06:23:06 INFO - PROCESS | 4912 | 06:26:08 INFO - PROCESS | 4912 | Cycle 1(1): loaded http://localhost:56766/tests/dromaeo/cssquery-yui.html (next: http://localhost:56766/tests/dromaeo/cssquery-dojo.html) 06:26:09 INFO - PROCESS | 4912 | RSS: Main: 260272128 06:26:09 INFO - PROCESS | 4912 | 06:26:09 INFO - PROCESS | 4912 | __start_tp_report 06:26:09 INFO - PROCESS | 4912 | _x_x_mozilla_page_load 06:26:09 INFO - PROCESS | 4912 | _x_x_mozilla_page_load_details 06:26:09 INFO - PROCESS | 4912 | |i|pagename|runs| 06:26:09 INFO - PROCESS | 4912 | |0;dojo.html;3241.8703251869924;3341.816200108996;3354.849031793569;3358.0261724100014;3397.5922889253284;5375.973120134398;5396.8920621587595;5416.783328666858;5417.674939503632;5456.317960254968;5393.2449457076045;5434.565234781218;5436.673799572029;5441.211024401459;5448.42791506892;4849.127157111719;4950.4307004694565;4995.075910956485;5018.397792264934;5059.316992206061;4915.262710593403;5013.122703526887;5013.222950442687;5014.8244811431605;5017.899642007158;4815.735134567597;4890.388701412324;4897.583705385029;4897.608191344684;4947.257911313314;4935.407751069859;4974.502549745032;5025.3718285214345;5051.9494805051845;5053.823116190915;4811.422629284473;4927.457979622239;4950.628702847301;4979.278004689336;4986.501349864984;5162.432132465426;5210.348706411699;5225.503577160163;5233.764480598382;5263.526282634543;5665.490105890449;5669.829905102853;5678.716064196815;5679.346875109374;5700.600957932947;5641.830745077655;5668.631538949996;5714.51426628737;5752.165935939265;5788.131780232957;5426;5444;5446.373667028263;5448.727563621803;5478.04134276504;5869.501092407193;5870.178175055496;5870.970645146747;5871.442212989845;5917.437843404869;5626.1842032905;5704.201411802351;5709.400512946164;5729.255196824386;5826.184334193216;5837.3287071986415;5842.182094506772;5843.211166492469;5846.41535846412;5848.473637372657;5778.711064446761;5793;5806.44838740319;5807.448292412214;5814.360420353758;5695.060315048054;5696.23100881384;5780;5787.536997040227;5793.420657934257;4391.363252328459;4395.472543294761;4396.120775844844;4412.0955204183065;4418.138462999685;3955.861544845917;3973.304671682444;3977.105151340925;4008.118213992917;4008.9198216035516;5296.073187192226;5522.585806064561;5585.525230355465;5605.7197140142825;5613.522850557667;5763.769449221984;5813.59304848665;5814.505767009851;5815.73829177688;5817.272840894888;5379.865503362369;5459.454054594509;5505.862353441116;5514.834554963358;5530.336359636869;4854.854354369375;4900.681455705368;4909.533594308535;4913.336699545587;4932.260160975882;6055.455009049118;6080.7567697291615;6085.269767627913;6086.2087928569;6087.817365479043;5773.191753154646;5789.189513468202;5854.882902341929;5868.3251426084835;5870.823875283749;6001.2498437695285;6073.210482637229;6082.543809214415;6090.390960903874;6130.6628135452975;5726.455986681425;5767.048437008015;5771.480566749013;5788.652680839163;5789.681567513827;5659.575531835211;5774.162746401832;5837.29952405714;5849.473547380756;5875.148103525051;5542.057850165562;5580.637258578179;5615.298087739033;5622.8313150605545;5652.802151924663;5583.0787919992745;5604.85987850307;5607.607467477237;5612.01789686795;5632.436756324335;5343.679379237258;5458.9454105458435;5486.61593688438;5505.284313039279;5551.833444996657;5536.474034966672;5590.301212348457;5624.409437009055;5636.689982051026;5651.350094738993;5488.1493368527945;5513.50974305827;5535.335759708861;5560.1103823389685;5563.082091454865 06:26:09 INFO - PROCESS | 4912 | |1;ext.html;554.944505549445;563.5322682173796;575.4935656622172;577.7429044075383;596.4065754574199;31589.526157107663;39201.21597568047;39327.41008884866;39390.60609393905;39517.209655806866;42802.35796463056;43235.78382108085;43266.783666081705;43328;43399.56600433995;8900.554972251377;9116.088391160863;9118.088191180896;9120.08799120086;9123.726288211365;8880.1563851434;9050.502222377767;9058.094190580921;9060.139286767779;9306.302027347941;9206.49364284964;9305.813883722321;9310.674126405576;9314.487703176323;9318.394304370195;9145.039770824034;9221.81556368869;9248.6300547978;9256.8611470828;9282.164605185499;9037;9178.48554988426;9180.265578753684;9181.954090229572;9184.448933064037;43169.35245971313;43644.345334820006;43656.78171609122;43671.344929826075;43695;3769.1142581493327;3792.27946690128;3801.144742432958;3831.8658846940225;3864.5555761087553;33149.17127071819;33314;33364.33271334584;33556.32887342264;33623.32753344944;4217.894552636209;4222.2822120239325;4274.209271284792;4296.742195468282;4334;289114.55442722864;290926;291864;292555;292619;46715.5328446718;47503.5249647506;47526;63779.68110159419;64480.67759661172;43737;43978.12043759107;44083.77958110253;44130.338044929355;44208.557914421086;16051.357945682275;16177.595560110856;16195.514134575982;16205.59486012859;16205.756913646304;12802.871971280354;12856.228626282453;12862.549810756578;12874.227546347249;12878.227306361649;15395.461158859385;15519.922400387926;15544.611384715246;15606.531804045897;15655.295511701774;6035.39646035393;6135.509159267248;6140.293866205444;6168.506519478431;6184.546631541584;1067.5996501312009;1101.432762127505;1165;1174.788538063157;1191.4343916132661;30330.696693032787;30499;30803.383932321227;31017.0694879154;31074.22314442157;1138.920275580718;1151.3897634253858;1195.055905834381;1225.7180848404917;1255.4225056473942;15859.365625375087;15970.121643309498;16100.677986440205;16198.59503512398;16201.4329498467;351022;353840;354829;355350;355703;58614.41385586175;59188.40811591915;59230;59244.70377648171;59294.70352648209;1410.4851729118798;1486.3162945045185;1489.1660670024821;1523.8171419429518;1525.3593490733917;28776.280592985342;29643;29706.554401684425;30060;30162.69837301687;45961.08077838358;46407;46458;46478.76760616175;46523.302150468444;186337;190454;191676;192268;207639;30793.38413231678;31348;36591;37248.255034899696;38141.809290953366;45499.54500454953;45873;45932.7703361481;46385.536144639475;46752;38319.6168038316;38377.232455350175;38596.035099122746;38627.6137238624;38811.61188388193;37584.43623345707;37778.43332349962;38501.4224786634;38958.2208355837;39127.2174556513;36789;38183.902455969226;38286.23427531378;38533.03667408337;38676.613233868426;32957.835210823796;33592.66407335895;34262.657373425944;34379.82810085933;34481.13797155091;26523.204303870916;26652.20043398701;26861.194164175107;27221.455570888076;27567.586486203123 06:26:09 INFO - PROCESS | 4912 | |2;jquery.html;332.41215172942833;391.7355784845229;395.35162333772615;397.12434082847335;398.5436675007117;17683.646327073468;18796.906015469922;18946;19400.805991940095;19408.22367105314;12547.560835370763;12796.872031279685;12806.423710933008;12806.487740490393;12820.358982050906;5358.946410535903;5359.5712343012465;5428.158635411518;5470.398256191816;5475.4524547545125;5421.051316019701;5434.728263586825;5445.237666726662;5446.128619420893;5446.1558458439;5387.919181212285;5433.646812957145;5541.944580554204;5769.913451298234;5790.247267855173;5681.3466451358;5784.392638772932;5806.59353845231;5807.535397168216;5841.8831623367505;5176;5247.947520524784;5250.68495890244;5264.526192642642;5264.868053368506;14314.141151530837;14549.34527946245;14557.854421455755;14733.852661473355;20218.19127234909;2363.9527209455887;2379.3932547200525;2387.092904696204;2489.987550062238;2706.161090062067;10448.26862119652;10478.738031549196;10842.620508282173;12941.352932353439;14139.151650900978;1976.0613708488354;1982.8810271383763;1987.592543528573;1995.2617531513433;2003.0885946894127;50627;64022;64938.675306623634;66170.3382966169;66593;9996;10363.170946324275;10666;10792.676219713421;10944.069754070833;14694.485693000694;14890.106593604418;14908.254587270592;14923.776143357858;14942.327595258239;7716.344110750649;7794.41541884361;8129.634166462523;8178.5092894426525;8203.466774659628;7394.7781566553085;7440;7459.962700186573;7508.0990281166605;7659.387249020177;4739.976300118477;4773.64197685175;4780.378550788375;4810.7113573185725;4840.322354870321;1926.9518262043562;1967.1049672399024;1987.8210961013579;1990.7810140884492;2005.8796472211714;921.4195057114109;966.9951650241704;1029.9742506437249;1070.925035247525;1071.8499410082595;17137.7977626454;17151.056691882066;17215.397461088804;17301.134943252786;17674.116294185238;985.3496692183124;998.3061772068343;1000.3297790480395;1040.47976011994;1051.164324362134;9929.80140397188;10003.499825008721;10127.746806329753;10166.796664066676;10166.949165254126;437514;444267;467264;473985;477719;73464;73565.26434735584;74079.5184096315;74086;75919.62040189764;1061.4639606998571;1062.4262898034974;1091.579741799413;1092;1098.983515247272;15470.613234669223;15489;15658.765118523004;15767.842321577096;15769.605759856095;32684.673153269116;33493.33013339671;34159.65840341565;34553.30893382169;35117.473237900944;44879.32681009722;48520.5147948516;49350;49434;49506.504934950186;8455.154484551496;8459.64645656692;8547.27348175412;8558.272546833588;8720.345974051845;10129.290949633749;12893.161944473579;13112.672183195114;13174.40715167839;13183.472661093449;11371.601993930173;11437.370944597795;11599.536018559163;11655.766884662089;11863;11459.08327333828;11463.140264480031;11527.193096483166;11633.941830290794;11690.532378704756;11269.887301126884;11527.769444610893;11806.173567850168;11840.348780817138;12131.45408456604;8591.871121933302;8664.653413863374;8689.261412779984;8787.428817126865;9000.279977601907;10336.689899302732;11336.886631133913;11346.94326528362;11375.715607109558;11558.422078895854 06:26:09 INFO - PROCESS | 4912 | |3;mootools.html;1490.4336352186167;1580.4784421141026;1595.2502323907763;1754.9034803085833;1841.3647291684372;8262.132476090006;8438.451500652453;8448.662053517859;8458.619362128704;8480.957595212023;8416.873746893787;8524.744257672264;8569.828603427928;8572;8604.096569860169;2446.4006318451916;2465.1988103866224;2469.64190192422;2470.234227389506;2473.492933948545;2409.771071748181;2491.4394261291154;2491.725910149891;2504.4615407687343;2508.3352911478473;2449.1183174057414;2455.0793452455327;2480.08236952327;2480.1815400917653;2480.342709182068;2384.4992551564105;2387.522495500898;2413.3242692046256;2445.902163913441;2449.350922005652;2469.469064151198;2473.8144639151956;2496.5131799299143;2508.097085049381;2513.673222481084;8662.177093176202;8686.826263474695;8700.869486957701;8704.129587041309;8728.170823771732;5165.535101840853;5315.415304316522;5336.759845806948;5356.839294821161;5358.196270559409;3198.056573310879;3200.2959348943195;3251.7723759336855;3275.8689652413873;3278.950815737766;1045.577870255095;1061.5170097605649;1089.1504626391427;1964.5579744557504;1997.1512107354317;12071.879281207164;12164.08769342294;12167.087468439813;12173.147879648428;12189.329586872718;4310.52584215736;4488.079943611552;4584.6561507887045;4634.884127896762;4660.603848672833;9596.95201523988;9618.182454491447;9622;9629.903700962901;9646;5119.948800512022;5171.095058364771;5172.379314482287;5179.04187725272;5180.430152683201;4209.600087991697;4278.572142785696;4322.805473753689;4682.321063445781;4779.689320194246;3625.2024554597947;3668.908277293089;3677.6690097890782;3687.0966613179407;3733.533308336458;1067.2529229539198;1073.457903758597;1082.1342925659599;1088.7713580148259;1089.9019088282093;1246.812978053281;1270.0284282523876;1285.556483013359;1515.0985163827504;1516.196415899575;7989.121196668362;8337.791555211168;8342.916570834335;8350.874736878952;8371.330293576499;537.4088502647057;543.7824870051932;544.5942772634413;546.3989611427478;551.715866328841;5815.709214539256;5823.184754134425;5833.008388573952;5843.5325173985975;5869.765209391662;10139.2902496826;10186.134178594753;10194.694159175237;10326.586936522604;10360.896391036144;9719.854202186973;10115.949420252851;10151.847722284172;10188.490575471196;10196.541155648014;8127.0653874803975;8243.629036693363;8244.422890397735;8257.876131858027;8333.208345207195;7600.049993750781;7658.042744656918;7746.109197442141;7748.496347737379;7750.147483776893;9036.502992335221;9189.081091890757;9297.395669281475;9383.296252781205;9422.858657120012;9296.6281348748;9365.765855853386;9386.202172815387;9559.761005974906;9572.32993690435;6411.455026322815;7053.294670532906;7264.237255088351;7299.890501642586;7387.667554960147;8008.559529225716;8026.43814932949;8038.236367545074;8067.475614085066;8071.596420179085;6968;7020.7893763187185;7048.929510704827;7073;7292.525985810906;7035.296470352924;7076.858462830817;7093.219745828058;7203.71185152588;7208.56748595086;7619.9238007619215;7907.762767116996;7914.287714105758;7915.604219789103;7926.445148839526;6933.89599156003;7005;7005.22942476317;7009.649517524002;7031.718731250898;7043.859122817617;7047.260037695968;7059.117610298713;7062.576245425291;7306.4885458017425 06:26:09 INFO - PROCESS | 4912 | |4;prototype.html;340.74614412262866;352.33057191336457;352.7599741640582;366.6297039989613;375.3056844837052;5946.316173640027;5947.405259474051;5995;6005.309389420218;6020.5785595008365;5894.17481552583;5899.321578018529;5912.054071348574;5919.408059194078;5923.229980102581;4423.712458690191;4501.009777848868;4651.1162879053045;4669.53304669532;4673.0420263846;4634.050019745944;4635.9536404635855;4651.767411629422;4652.116097941397;4658.580727734503;4609.193391156551;4616.169089563878;4618.145643056028;4620.145273124466;4632.3283123947;4416.470023597173;4493.932591011154;4597.678162528624;4599.379083823675;4615.14619795339;4065.7560546367313;4068.9593104068877;4072.6334629883454;4076.32740597801;4076.510818701745;5662.094064949588;5666.744996475128;5669;5669.744861481243;5675.801346952837;5322.33470816148;5361.115415956362;5364;5371.543418809406;5373.5163835254625;6292.244930608311;6301.59039662425;6304.27500837405;6307.022411526175;6312.810615681537;4422.29243321067;4487.52880947499;4500.729956202638;4523.819047238107;4538.818447262105;6568.244651865049;6582.407583317477;6588.439982601484;6590.868182636321;6608;4622.237330840441;4625.606823419979;4626.398568186114;4629.375034370384;4632.351470794091;4688.789004494738;4693.48371679115;4694.342792009122;4696.0842635686395;4697.084068606658;5352.973235133877;5359.115745901882;5362.8659283517445;5364.9731751341;5367.221752845816;6106.389361063947;6262.09199666055;6344.143540622049;6350.269718982377;6358.427741503287;1594.9043057416593;1604.4625050608176;1611.3393508661627;1616.1757503673211;1617.24797968945;987.5950860147306;1047.994760026195;1065.6643157405392;1075.2473268711933;1116.6873275482878;6015.879682406327;6023.548233882477;6037.818865434044;6046.244219472566;6086.117512960596;6508.251551071688;6517.348265173539;6523.7716679915975;6527.477801775846;6528.477721782246;6111.449969502677;6114.633122012605;6115.143879856823;6115.510759139258;6115.663638499926;3407.182276253731;3467.739919506047;3497.4229252173104;3498.1079824644553;3499.842507087187;6192.504599632019;6525.771597994142;6675.866482670416;6741.056252124707;6741.393274605309;6583.3416658334745;6598.967005164944;6737.258901520829;6777.051212830208;6814.591124532544;6867.484938629623;6873.1064961554675;6881.380675739208;6881.449484041264;6883.965580172167;6632.635205063768;6637.4114095503755;6639.3360663935155;6640.667966601554;6645.767398141235;6497.4477169441125;6507.056476810931;6514.478841692748;6524.412802847766;6525.249596296487;6729.596224226562;6859.2454829969665;6870.141232345957;6872.656367181721;6874.140732408449;4633.629309655152;4653.674242803107;4674.579287864109;4676.275177347517;4687.015726697432;6612.338766123349;6618.933810662024;6619.470442364695;6620.569662971891;6627.204735431586;6416.294207637063;6427.453666438405;6434.871302574016;6436.066770318184;6439.259485159267;6421.422072013541;6428;6431.614103153825;6436.259830119409;6436.774712885027;6114.877702445837;6211.81364559064;6282.937170628418;6298.968505157445;6304.085907543472;6441.1304473895425;6445;6456.709448074754;6463.612183269019;6465.321141280097;6242.750289988349;6297.811065668037;6300.243970723543;6313.873722525615;6319.873602528016 06:26:09 INFO - PROCESS | 4912 | |5;yui.html;760.6609675248612;780.4965797060893;814.5845618734451;900.4282280751722;933.9486328251945;14310.642233944156;14585.34365953532;14779.039362441434;14779.334929928153;14803.777943330859;14080.78878816816;14100.36548355324;14102.717945641081;14116.011879168462;14120.152790832532;908.0465511213233;913.2876356441986;913.6528119314651;944.1549812917435;968.6173961285288;964.1033838530165;965.3242730088931;970.1705042188933;971.1745016735789;971.8542218667186;1003.2676146413123;1004.5981607357043;1004.7136566078633;1005.8994100589956;1006.2000709436016;991.6033586565395;996.227923359395;996.8853581838109;997.1324947295826;997.1574019953129;729.3435907683074;733.6515155301242;733.6698485681464;733.8605664923648;734.5445823589355;15529.689406211926;15586.922065389714;15598.454054108166;15605.45380911674;15619.453319133776;14161;14261.286935653176;14318.212498312589;14396.496122635657;14421.206833624146;11693.298402095901;11696.67212220402;11858.466369013415;11894.881051189464;12123.696907577381;3911.902202444933;3949.328614135575;3957.2481228566767;4054.452648892391;4058.6955978301744;45637;50290;51944.22083668748;52452.73773631146;54134.18798718022;11114.666560003212;11417.657470275904;11505.71235719097;11792.764144717057;11810.173287869766;17558.736618950727;19984.90007549982;20104.296349627693;20201.393958181277;20439.4890127748;8359.456635318686;8478.279346255515;8536.914630853737;8545.658173673108;8681.262092722063;4488.169688607618;4561.429821272341;4668;4672.2057250267535;4672.43930728308;3450.706689931384;3516.2615850671646;3527.047697121814;3529.6823285904393;3540.6282340354405;661.5237029338869;662.8508585568209;667.072768851297;669.8325418645338;674.9730010799512;648.9422241745924;676.2561182698992;679.1917618034523;701.1516065560627;746.123305116486;9127.543622818832;9190.908090919005;9469.763255918657;9476.715698529055;9493.715188544216;732.8058064612775;743.6988019851968;768.500474691455;774.0517865614689;774.6552784011061;4312.778714446781;4378.868633940987;4501.257292546758;4507.2788353863225;4689.7655117244;61850.690746546876;62595;62722;63761;63906.6804665983;49609.50390496049;52112.47887521076;54532.45467545353;55209.447905521236;58276.708616457494;48424.273635895486;48601.51398486041;48747.512524875005;49282;50313;9071.228945539702;9294.488803115893;9582.568784404579;9763.80472390534;9765.707028789147;36289.637103629684;36425.817870910476;37336;37677.62322376741;37839.62160378361;43042;43126.78436607797;44053;45281.547184527735;45383.773081134386;12066;12351;12420.751584968431;12451.564195253122;12507.914034886606;13319.933400332937;13378.397972091085;13425.798613020617;13482.393292302066;13622.182669039888;12627.684307892008;12705;12735.172213806072;12996.740065198832;13083.084184107021;12753.298568578817;12807.871921280668;12877;13089.018323625956;13255.602331930058;12681.556145534862;12812.103152779217;12962;12980.286084265455;13201.339933003119;10409.739756506147;10457.424841633783;10855.131589472981;10876.945615272189;11067.169962253025;10586.4706764663;11047.447627618747;11182.832257515982;11392.08863290918;11439.199256051996 06:26:09 INFO - PROCESS | 4912 | __end_tp_report 06:26:09 INFO - PROCESS | 4912 | __start_cc_report 06:26:09 INFO - PROCESS | 4912 | _x_x_mozilla_cycle_collect,1170 06:26:09 INFO - PROCESS | 4912 | __end_cc_report 06:26:09 INFO - PROCESS | 4912 | __startTimestamp1462800369096__endTimestamp 06:26:09 INFO - PROCESS | 4912 | 06:26:09 INFO - PROCESS | 4912 | ------- Summary: start ------- 06:26:09 INFO - PROCESS | 4912 | Number of tests: 6 06:26:09 INFO - PROCESS | 4912 | 06:26:09 INFO - PROCESS | 4912 | [#0] dojo.html Cycles:165 Average:5378.91 Median:5560.11 stddev:586.53 (10.5%) stddev-sans-first:563.86 06:26:09 INFO - PROCESS | 4912 | Values: 3241.9 3341.8 3354.8 3358.0 3397.6 5376.0 5396.9 5416.8 5417.7 5456.3 5393.2 5434.6 5436.7 5441.2 5448.4 4849.1 4950.4 4995.1 5018.4 5059.3 4915.3 5013.1 5013.2 5014.8 5017.9 4815.7 4890.4 4897.6 4897.6 4947.3 4935.4 4974.5 5025.4 5051.9 5053.8 4811.4 4927.5 4950.6 4979.3 4986.5 5162.4 5210.3 5225.5 5233.8 5263.5 5665.5 5669.8 5678.7 5679.3 5700.6 5641.8 5668.6 5714.5 5752.2 5788.1 5426.0 5444.0 5446.4 5448.7 5478.0 5869.5 5870.2 5871.0 5871.4 5917.4 5626.2 5704.2 5709.4 5729.3 5826.2 5837.3 5842.2 5843.2 5846.4 5848.5 5778.7 5793.0 5806.4 5807.4 5814.4 5695.1 5696.2 5780.0 5787.5 5793.4 4391.4 4395.5 4396.1 4412.1 4418.1 3955.9 3973.3 3977.1 4008.1 4008.9 5296.1 5522.6 5585.5 5605.7 5613.5 5763.8 5813.6 5814.5 5815.7 5817.3 5379.9 5459.5 5505.9 5514.8 5530.3 4854.9 4900.7 4909.5 4913.3 4932.3 6055.5 6080.8 6085.3 6086.2 6087.8 5773.2 5789.2 5854.9 5868.3 5870.8 6001.2 6073.2 6082.5 6090.4 6130.7 5726.5 5767.0 5771.5 5788.7 5789.7 5659.6 5774.2 5837.3 5849.5 5875.1 5542.1 5580.6 5615.3 5622.8 5652.8 5583.1 5604.9 5607.6 5612.0 5632.4 5343.7 5458.9 5486.6 5505.3 5551.8 5536.5 5590.3 5624.4 5636.7 5651.4 5488.1 5513.5 5535.3 5560.1 5563.1 06:26:09 INFO - PROCESS | 4912 | 06:26:09 INFO - PROCESS | 4912 | [#1] ext.html Cycles:180 Average:45640.21 Median:38348.42 stddev:75245.50 (196.2%) stddev-sans-first:75380.43 06:26:09 INFO - PROCESS | 4912 | Values: 554.9 563.5 575.5 577.7 596.4 31589.5 39201.2 39327.4 39390.6 39517.2 42802.4 43235.8 43266.8 43328.0 43399.6 8900.6 9116.1 9118.1 9120.1 9123.7 8880.2 9050.5 9058.1 9060.1 9306.3 9206.5 9305.8 9310.7 9314.5 9318.4 9145.0 9221.8 9248.6 9256.9 9282.2 9037.0 9178.5 9180.3 9182.0 9184.4 43169.4 43644.3 43656.8 43671.3 43695.0 3769.1 3792.3 3801.1 3831.9 3864.6 33149.2 33314.0 33364.3 33556.3 33623.3 4217.9 4222.3 4274.2 4296.7 4334.0 289114.6 290926.0 291864.0 292555.0 292619.0 46715.5 47503.5 47526.0 63779.7 64480.7 43737.0 43978.1 44083.8 44130.3 44208.6 16051.4 16177.6 16195.5 16205.6 16205.8 12802.9 12856.2 12862.5 12874.2 12878.2 15395.5 15519.9 15544.6 15606.5 15655.3 6035.4 6135.5 6140.3 6168.5 6184.5 1067.6 1101.4 1165.0 1174.8 1191.4 30330.7 30499.0 30803.4 31017.1 31074.2 1138.9 1151.4 1195.1 1225.7 1255.4 15859.4 15970.1 16100.7 16198.6 16201.4 351022.0 353840.0 354829.0 355350.0 355703.0 58614.4 59188.4 59230.0 59244.7 59294.7 1410.5 1486.3 1489.2 1523.8 1525.4 28776.3 29643.0 29706.6 30060.0 30162.7 45961.1 46407.0 46458.0 46478.8 46523.3 186337.0 190454.0 191676.0 192268.0 207639.0 30793.4 31348.0 36591.0 37248.3 38141.8 45499.5 45873.0 45932.8 46385.5 46752.0 38319.6 38377.2 38596.0 38627.6 38811.6 37584.4 37778.4 38501.4 38958.2 39127.2 36789.0 38183.9 38286.2 38533.0 38676.6 32957.8 33592.7 34262.7 34379.8 34481.1 26523.2 26652.2 26861.2 27221.5 27567.6 06:26:09 INFO - PROCESS | 4912 | 06:26:09 INFO - PROCESS | 4912 | [#2] jquery.html Cycles:180 Average:26115.96 Median:2383.24 stddev:75381.57 (3163.0%) stddev-sans-first:75568.17 06:26:09 INFO - PROCESS | 4912 | Values: 332.4 391.7 395.4 397.1 398.5 17683.6 18796.9 18946.0 19400.8 19408.2 12547.6 12796.9 12806.4 12806.5 12820.4 5358.9 5359.6 5428.2 5470.4 5475.5 5421.1 5434.7 5445.2 5446.1 5446.2 5387.9 5433.6 5541.9 5769.9 5790.2 5681.3 5784.4 5806.6 5807.5 5841.9 5176.0 5247.9 5250.7 5264.5 5264.9 14314.1 14549.3 14557.9 14733.9 20218.2 2364.0 2379.4 2387.1 2490.0 2706.2 10448.3 10478.7 10842.6 12941.4 14139.2 1976.1 1982.9 1987.6 1995.3 2003.1 50627.0 64022.0 64938.7 66170.3 66593.0 9996.0 10363.2 10666.0 10792.7 10944.1 14694.5 14890.1 14908.3 14923.8 14942.3 7716.3 7794.4 8129.6 8178.5 8203.5 7394.8 7440.0 7460.0 7508.1 7659.4 4740.0 4773.6 4780.4 4810.7 4840.3 1927.0 1967.1 1987.8 1990.8 2005.9 921.4 967.0 1030.0 1070.9 1071.8 17137.8 17151.1 17215.4 17301.1 17674.1 985.3 998.3 1000.3 1040.5 1051.2 9929.8 10003.5 10127.7 10166.8 10166.9 437514.0 444267.0 467264.0 473985.0 477719.0 73464.0 73565.3 74079.5 74086.0 75919.6 1061.5 1062.4 1091.6 1092.0 1099.0 15470.6 15489.0 15658.8 15767.8 15769.6 32684.7 33493.3 34159.7 34553.3 35117.5 44879.3 48520.5 49350.0 49434.0 49506.5 8455.2 8459.6 8547.3 8558.3 8720.3 10129.3 12893.2 13112.7 13174.4 13183.5 11371.6 11437.4 11599.5 11655.8 11863.0 11459.1 11463.1 11527.2 11633.9 11690.5 11269.9 11527.8 11806.2 11840.3 12131.5 8591.9 8664.7 8689.3 8787.4 9000.3 10336.7 11336.9 11346.9 11375.7 11558.4 06:26:09 INFO - PROCESS | 4912 | 06:26:09 INFO - PROCESS | 4912 | [#3] mootools.html Cycles:180 Average:5904.74 Median:544.19 stddev:3130.54 (575.3%) stddev-sans-first:3121.74 06:26:09 INFO - PROCESS | 4912 | Values: 1490.4 1580.5 1595.3 1754.9 1841.4 8262.1 8438.5 8448.7 8458.6 8481.0 8416.9 8524.7 8569.8 8572.0 8604.1 2446.4 2465.2 2469.6 2470.2 2473.5 2409.8 2491.4 2491.7 2504.5 2508.3 2449.1 2455.1 2480.1 2480.2 2480.3 2384.5 2387.5 2413.3 2445.9 2449.4 2469.5 2473.8 2496.5 2508.1 2513.7 8662.2 8686.8 8700.9 8704.1 8728.2 5165.5 5315.4 5336.8 5356.8 5358.2 3198.1 3200.3 3251.8 3275.9 3279.0 1045.6 1061.5 1089.2 1964.6 1997.2 12071.9 12164.1 12167.1 12173.1 12189.3 4310.5 4488.1 4584.7 4634.9 4660.6 9597.0 9618.2 9622.0 9629.9 9646.0 5119.9 5171.1 5172.4 5179.0 5180.4 4209.6 4278.6 4322.8 4682.3 4779.7 3625.2 3668.9 3677.7 3687.1 3733.5 1067.3 1073.5 1082.1 1088.8 1089.9 1246.8 1270.0 1285.6 1515.1 1516.2 7989.1 8337.8 8342.9 8350.9 8371.3 537.4 543.8 544.6 546.4 551.7 5815.7 5823.2 5833.0 5843.5 5869.8 10139.3 10186.1 10194.7 10326.6 10360.9 9719.9 10115.9 10151.8 10188.5 10196.5 8127.1 8243.6 8244.4 8257.9 8333.2 7600.0 7658.0 7746.1 7748.5 7750.1 9036.5 9189.1 9297.4 9383.3 9422.9 9296.6 9365.8 9386.2 9559.8 9572.3 6411.5 7053.3 7264.2 7299.9 7387.7 8008.6 8026.4 8038.2 8067.5 8071.6 6968.0 7020.8 7048.9 7073.0 7292.5 7035.3 7076.9 7093.2 7203.7 7208.6 7619.9 7907.8 7914.3 7915.6 7926.4 6933.9 7005.0 7005.2 7009.6 7031.7 7043.9 7047.3 7059.1 7062.6 7306.5 06:26:09 INFO - PROCESS | 4912 | 06:26:09 INFO - PROCESS | 4912 | [#4] prototype.html Cycles:180 Average:5338.95 Median:6030.68 stddev:1597.15 (26.5%) stddev-sans-first:1556.95 06:26:09 INFO - PROCESS | 4912 | Values: 340.7 352.3 352.8 366.6 375.3 5946.3 5947.4 5995.0 6005.3 6020.6 5894.2 5899.3 5912.1 5919.4 5923.2 4423.7 4501.0 4651.1 4669.5 4673.0 4634.1 4636.0 4651.8 4652.1 4658.6 4609.2 4616.2 4618.1 4620.1 4632.3 4416.5 4493.9 4597.7 4599.4 4615.1 4065.8 4069.0 4072.6 4076.3 4076.5 5662.1 5666.7 5669.0 5669.7 5675.8 5322.3 5361.1 5364.0 5371.5 5373.5 6292.2 6301.6 6304.3 6307.0 6312.8 4422.3 4487.5 4500.7 4523.8 4538.8 6568.2 6582.4 6588.4 6590.9 6608.0 4622.2 4625.6 4626.4 4629.4 4632.4 4688.8 4693.5 4694.3 4696.1 4697.1 5353.0 5359.1 5362.9 5365.0 5367.2 6106.4 6262.1 6344.1 6350.3 6358.4 1594.9 1604.5 1611.3 1616.2 1617.2 987.6 1048.0 1065.7 1075.2 1116.7 6015.9 6023.5 6037.8 6046.2 6086.1 6508.3 6517.3 6523.8 6527.5 6528.5 6111.4 6114.6 6115.1 6115.5 6115.7 3407.2 3467.7 3497.4 3498.1 3499.8 6192.5 6525.8 6675.9 6741.1 6741.4 6583.3 6599.0 6737.3 6777.1 6814.6 6867.5 6873.1 6881.4 6881.4 6884.0 6632.6 6637.4 6639.3 6640.7 6645.8 6497.4 6507.1 6514.5 6524.4 6525.2 6729.6 6859.2 6870.1 6872.7 6874.1 4633.6 4653.7 4674.6 4676.3 4687.0 6612.3 6618.9 6619.5 6620.6 6627.2 6416.3 6427.5 6434.9 6436.1 6439.3 6421.4 6428.0 6431.6 6436.3 6436.8 6114.9 6211.8 6282.9 6299.0 6304.1 6441.1 6445.0 6456.7 6463.6 6465.3 6242.8 6297.8 6300.2 6313.9 6319.9 06:26:09 INFO - PROCESS | 4912 | 06:26:09 INFO - PROCESS | 4912 | [#5] yui.html Cycles:180 Average:14938.65 Median:23677.39 stddev:16804.45 (71.0%) stddev-sans-first:16817.86 06:26:09 INFO - PROCESS | 4912 | Values: 760.7 780.5 814.6 900.4 933.9 14310.6 14585.3 14779.0 14779.3 14803.8 14080.8 14100.4 14102.7 14116.0 14120.2 908.0 913.3 913.7 944.2 968.6 964.1 965.3 970.2 971.2 971.9 1003.3 1004.6 1004.7 1005.9 1006.2 991.6 996.2 996.9 997.1 997.2 729.3 733.7 733.7 733.9 734.5 15529.7 15586.9 15598.5 15605.5 15619.5 14161.0 14261.3 14318.2 14396.5 14421.2 11693.3 11696.7 11858.5 11894.9 12123.7 3911.9 3949.3 3957.2 4054.5 4058.7 45637.0 50290.0 51944.2 52452.7 54134.2 11114.7 11417.7 11505.7 11792.8 11810.2 17558.7 19984.9 20104.3 20201.4 20439.5 8359.5 8478.3 8536.9 8545.7 8681.3 4488.2 4561.4 4668.0 4672.2 4672.4 3450.7 3516.3 3527.0 3529.7 3540.6 661.5 662.9 667.1 669.8 675.0 648.9 676.3 679.2 701.2 746.1 9127.5 9190.9 9469.8 9476.7 9493.7 732.8 743.7 768.5 774.1 774.7 4312.8 4378.9 4501.3 4507.3 4689.8 61850.7 62595.0 62722.0 63761.0 63906.7 49609.5 52112.5 54532.5 55209.4 58276.7 48424.3 48601.5 48747.5 49282.0 50313.0 9071.2 9294.5 9582.6 9763.8 9765.7 36289.6 36425.8 37336.0 37677.6 37839.6 43042.0 43126.8 44053.0 45281.5 45383.8 12066.0 12351.0 12420.8 12451.6 12507.9 13319.9 13378.4 13425.8 13482.4 13622.2 12627.7 12705.0 12735.2 12996.7 13083.1 12753.3 12807.9 12877.0 13089.0 13255.6 12681.6 12812.1 12962.0 12980.3 13201.3 10409.7 10457.4 10855.1 10876.9 11067.2 10586.5 11047.4 11182.8 11392.1 11439.2 06:26:09 INFO - PROCESS | 4912 | -------- Summary: end -------- 06:26:09 INFO - PROCESS | 4912 | 06:26:09 INFO - TEST-INFO | 4912: exit 0 06:26:09 INFO - TEST-OK | dromaeo_css | took 1111089ms 06:26:09 INFO - TEST-START | kraken 06:26:09 INFO - operating with platform_type : linux_ 06:26:09 INFO - Initialising browser for kraken test... 06:26:09 INFO - TEST-INFO | started process 5114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPPV0LL/profile http://localhost:56766/getInfo.html) 06:26:13 INFO - PROCESS | 5114 | __metrics Screen width/height:1600/1200 06:26:13 INFO - PROCESS | 5114 | colorDepth:24 06:26:13 INFO - PROCESS | 5114 | Browser inner width/height: 1024/697 06:26:13 INFO - PROCESS | 5114 | __metrics 06:26:14 INFO - PROCESS | 5114 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:26:15 INFO - TEST-INFO | 5114: exit 0 06:26:15 INFO - Browser initialized. 06:26:15 INFO - Running cycle 1/1 for kraken test... 06:26:15 INFO - TEST-INFO | started process 5201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPPV0LL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:26:27 INFO - PROCESS | 5201 | RSS: Main: 138895360 06:26:27 INFO - PROCESS | 5201 | 06:26:30 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56766/tests/kraken/driver.html?testName=audio-beat-detection) 06:26:30 INFO - PROCESS | 5201 | RSS: Main: 177262592 06:26:30 INFO - PROCESS | 5201 | 06:26:33 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56766/tests/kraken/driver.html?testName=audio-dft) 06:26:33 INFO - PROCESS | 5201 | RSS: Main: 175124480 06:26:33 INFO - PROCESS | 5201 | 06:26:36 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56766/tests/kraken/driver.html?testName=audio-fft) 06:26:37 INFO - PROCESS | 5201 | RSS: Main: 170819584 06:26:37 INFO - PROCESS | 5201 | 06:26:39 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56766/tests/kraken/driver.html?testName=audio-oscillator) 06:26:39 INFO - PROCESS | 5201 | RSS: Main: 171794432 06:26:39 INFO - PROCESS | 5201 | 06:26:42 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56766/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:26:42 INFO - PROCESS | 5201 | RSS: Main: 169807872 06:26:42 INFO - PROCESS | 5201 | 06:26:45 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56766/tests/kraken/driver.html?testName=imaging-darkroom) 06:26:46 INFO - PROCESS | 5201 | RSS: Main: 169521152 06:26:46 INFO - PROCESS | 5201 | 06:26:49 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56766/tests/kraken/driver.html?testName=imaging-desaturate) 06:26:50 INFO - PROCESS | 5201 | RSS: Main: 169926656 06:26:50 INFO - PROCESS | 5201 | 06:26:53 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56766/tests/kraken/driver.html?testName=json-parse-financial) 06:26:53 INFO - PROCESS | 5201 | RSS: Main: 169619456 06:26:53 INFO - PROCESS | 5201 | 06:26:55 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56766/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:26:55 INFO - PROCESS | 5201 | RSS: Main: 175939584 06:26:55 INFO - PROCESS | 5201 | 06:26:57 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:26:58 INFO - PROCESS | 5201 | RSS: Main: 174661632 06:26:58 INFO - PROCESS | 5201 | 06:27:00 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:27:00 INFO - PROCESS | 5201 | RSS: Main: 180600832 06:27:00 INFO - PROCESS | 5201 | 06:27:03 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:27:03 INFO - PROCESS | 5201 | RSS: Main: 185778176 06:27:03 INFO - PROCESS | 5201 | 06:27:06 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:27:06 INFO - PROCESS | 5201 | RSS: Main: 184627200 06:27:06 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56766/tests/kraken/driver.html?testName=ai-astar) 06:27:08 INFO - PROCESS | 5201 | RSS: Main: 247279616 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | __start_tp_report 06:27:08 INFO - PROCESS | 5201 | _x_x_mozilla_page_load 06:27:08 INFO - PROCESS | 5201 | _x_x_mozilla_page_load_details 06:27:08 INFO - PROCESS | 5201 | |i|pagename|runs| 06:27:08 INFO - PROCESS | 5201 | |0;ai-astar;111;113;104;110;109;111;98;111;109;110 06:27:08 INFO - PROCESS | 5201 | |1;audio-beat-detection;157;130;169;162;127;153;164;139;186;132 06:27:08 INFO - PROCESS | 5201 | |2;audio-dft;161;160;159;160;162;161;160;163;160;162 06:27:08 INFO - PROCESS | 5201 | |3;audio-fft;76;76;74;173;74;77;75;74;166;76 06:27:08 INFO - PROCESS | 5201 | |4;audio-oscillator;91;93;138;92;92;94;153;93;91;150 06:27:08 INFO - PROCESS | 5201 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;117;117;117 06:27:08 INFO - PROCESS | 5201 | |6;imaging-darkroom;145;145;145;144;146;145;145;145;145;149 06:27:08 INFO - PROCESS | 5201 | |7;imaging-desaturate;95;95;96;96;95;96;96;96;96;95 06:27:08 INFO - PROCESS | 5201 | |8;json-parse-financial;56;55;57;55;56;55;55;65;55;54 06:27:08 INFO - PROCESS | 5201 | |9;json-stringify-tinderbox;65;67;70;65;66;66;66;66;66;67 06:27:08 INFO - PROCESS | 5201 | |10;stanford-crypto-aes;77;78;86;78;78;78;78;79;78;77 06:27:08 INFO - PROCESS | 5201 | |11;stanford-crypto-ccm;113;114;124;121;117;119;112;113;114;117 06:27:08 INFO - PROCESS | 5201 | |12;stanford-crypto-pbkdf2;146;145;148;137;141;134;151;144;143;144 06:27:08 INFO - PROCESS | 5201 | |13;stanford-crypto-sha256-iterative;66;72;67;67;65;64;74;68;65;66 06:27:08 INFO - PROCESS | 5201 | __end_tp_report 06:27:08 INFO - PROCESS | 5201 | __start_cc_report 06:27:08 INFO - PROCESS | 5201 | _x_x_mozilla_cycle_collect,1034 06:27:08 INFO - PROCESS | 5201 | __end_cc_report 06:27:08 INFO - PROCESS | 5201 | __startTimestamp1462800428633__endTimestamp 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | ------- Summary: start ------- 06:27:08 INFO - PROCESS | 5201 | Number of tests: 14 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#0] ai-astar Cycles:10 Average:108.60 Median:111.00 stddev:4.40 (4.0%) stddev-sans-first:4.58 06:27:08 INFO - PROCESS | 5201 | Values: 111.0 113.0 104.0 110.0 109.0 111.0 98.0 111.0 109.0 110.0 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:159.50 stddev:19.42 (12.2%) stddev-sans-first:20.51 06:27:08 INFO - PROCESS | 5201 | Values: 157.0 130.0 169.0 162.0 127.0 153.0 164.0 139.0 186.0 132.0 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 06:27:08 INFO - PROCESS | 5201 | Values: 161.0 160.0 159.0 160.0 162.0 161.0 160.0 163.0 160.0 162.0 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:39.79 (52.7%) stddev-sans-first:41.66 06:27:08 INFO - PROCESS | 5201 | Values: 76.0 76.0 74.0 173.0 74.0 77.0 75.0 74.0 166.0 76.0 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:92.00 stddev:26.71 (29.0%) stddev-sans-first:27.55 06:27:08 INFO - PROCESS | 5201 | Values: 91.0 93.0 138.0 92.0 92.0 94.0 153.0 93.0 91.0 150.0 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 06:27:08 INFO - PROCESS | 5201 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 06:27:08 INFO - PROCESS | 5201 | Values: 145.0 145.0 145.0 144.0 146.0 145.0 145.0 145.0 145.0 149.0 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:27:08 INFO - PROCESS | 5201 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.50 stddev:3.16 (5.7%) stddev-sans-first:3.35 06:27:08 INFO - PROCESS | 5201 | Values: 56.0 55.0 57.0 55.0 56.0 55.0 55.0 65.0 55.0 54.0 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:1.43 (2.2%) stddev-sans-first:1.42 06:27:08 INFO - PROCESS | 5201 | Values: 65.0 67.0 70.0 65.0 66.0 66.0 66.0 66.0 66.0 67.0 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.00 stddev:2.63 (3.4%) stddev-sans-first:2.71 06:27:08 INFO - PROCESS | 5201 | Values: 77.0 78.0 86.0 78.0 78.0 78.0 78.0 79.0 78.0 77.0 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#11] stanford-crypto-ccm Cycles:10 Average:116.40 Median:117.00 stddev:3.95 (3.4%) stddev-sans-first:3.99 06:27:08 INFO - PROCESS | 5201 | Values: 113.0 114.0 124.0 121.0 117.0 119.0 112.0 113.0 114.0 117.0 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:144.50 stddev:4.99 (3.5%) stddev-sans-first:5.20 06:27:08 INFO - PROCESS | 5201 | Values: 146.0 145.0 148.0 137.0 141.0 134.0 151.0 144.0 143.0 144.0 06:27:08 INFO - PROCESS | 5201 | 06:27:08 INFO - PROCESS | 5201 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:3.20 (4.8%) stddev-sans-first:3.36 06:27:08 INFO - PROCESS | 5201 | Values: 66.0 72.0 67.0 67.0 65.0 64.0 74.0 68.0 65.0 66.0 06:27:08 INFO - PROCESS | 5201 | -------- Summary: end -------- 06:27:08 INFO - PROCESS | 5201 | 06:27:09 INFO - TEST-INFO | 5201: exit 0 06:27:09 INFO - TEST-OK | kraken | took 59969ms 06:27:09 INFO - SUITE-END | took 1171s 06:27:10 INFO - Completed test suite (00:19:31) 06:27:10 INFO - javascript benchmark 06:27:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3241.8703251869924, 3341.816200108996, 3354.849031793569, 3358.0261724100014, 3397.5922889253284, 5375.973120134398, 5396.8920621587595, 5416.783328666858, 5417.674939503632, 5456.317960254968, 5393.2449457076045, 5434.565234781218, 5436.673799572029, 5441.211024401459, 5448.42791506892, 4849.127157111719, 4950.4307004694565, 4995.075910956485, 5018.397792264934, 5059.316992206061, 4915.262710593403, 5013.122703526887, 5013.222950442687, 5014.8244811431605, 5017.899642007158, 4815.735134567597, 4890.388701412324, 4897.583705385029, 4897.608191344684, 4947.257911313314, 4935.407751069859, 4974.502549745032, 5025.3718285214345, 5051.9494805051845, 5053.823116190915, 4811.422629284473, 4927.457979622239, 4950.628702847301, 4979.278004689336, 4986.501349864984, 5162.432132465426, 5210.348706411699, 5225.503577160163, 5233.764480598382, 5263.526282634543, 5665.490105890449, 5669.829905102853, 5678.716064196815, 5679.346875109374, 5700.600957932947, 5641.830745077655, 5668.631538949996, 5714.51426628737, 5752.165935939265, 5788.131780232957, 5426.0, 5444.0, 5446.373667028263, 5448.727563621803, 5478.04134276504, 5869.501092407193, 5870.178175055496, 5870.970645146747, 5871.442212989845, 5917.437843404869, 5626.1842032905, 5704.201411802351, 5709.400512946164, 5729.255196824386, 5826.184334193216, 5837.3287071986415, 5842.182094506772, 5843.211166492469, 5846.41535846412, 5848.473637372657, 5778.711064446761, 5793.0, 5806.44838740319, 5807.448292412214, 5814.360420353758, 5695.060315048054, 5696.23100881384, 5780.0, 5787.536997040227, 5793.420657934257, 4391.363252328459, 4395.472543294761, 4396.120775844844, 4412.0955204183065, 4418.138462999685, 3955.861544845917, 3973.304671682444, 3977.105151340925, 4008.118213992917, 4008.9198216035516, 5296.073187192226, 5522.585806064561, 5585.525230355465, 5605.7197140142825, 5613.522850557667, 5763.769449221984, 5813.59304848665, 5814.505767009851, 5815.73829177688, 5817.272840894888, 5379.865503362369, 5459.454054594509, 5505.862353441116, 5514.834554963358, 5530.336359636869, 4854.854354369375, 4900.681455705368, 4909.533594308535, 4913.336699545587, 4932.260160975882, 6055.455009049118, 6080.7567697291615, 6085.269767627913, 6086.2087928569, 6087.817365479043, 5773.191753154646, 5789.189513468202, 5854.882902341929, 5868.3251426084835, 5870.823875283749, 6001.2498437695285, 6073.210482637229, 6082.543809214415, 6090.390960903874, 6130.6628135452975, 5726.455986681425, 5767.048437008015, 5771.480566749013, 5788.652680839163, 5789.681567513827, 5659.575531835211, 5774.162746401832, 5837.29952405714, 5849.473547380756, 5875.148103525051, 5542.057850165562, 5580.637258578179, 5615.298087739033, 5622.8313150605545, 5652.802151924663, 5583.0787919992745, 5604.85987850307, 5607.607467477237, 5612.01789686795, 5632.436756324335, 5343.679379237258, 5458.9454105458435, 5486.61593688438, 5505.284313039279, 5551.833444996657, 5536.474034966672, 5590.301212348457, 5624.409437009055, 5636.689982051026, 5651.350094738993, 5488.1493368527945, 5513.50974305827, 5535.335759708861, 5560.1103823389685, 5563.082091454865], "unit": "score", "name": "dojo.html", "value": 5342.0107205948}, {"lowerIsBetter": false, "replicates": [554.944505549445, 563.5322682173796, 575.4935656622172, 577.7429044075383, 596.4065754574199, 31589.526157107663, 39201.21597568047, 39327.41008884866, 39390.60609393905, 39517.209655806866, 42802.35796463056, 43235.78382108085, 43266.783666081705, 43328.0, 43399.56600433995, 8900.554972251377, 9116.088391160863, 9118.088191180896, 9120.08799120086, 9123.726288211365, 8880.1563851434, 9050.502222377767, 9058.094190580921, 9060.139286767779, 9306.302027347941, 9206.49364284964, 9305.813883722321, 9310.674126405576, 9314.487703176323, 9318.394304370195, 9145.039770824034, 9221.81556368869, 9248.6300547978, 9256.8611470828, 9282.164605185499, 9037.0, 9178.48554988426, 9180.265578753684, 9181.954090229572, 9184.448933064037, 43169.35245971313, 43644.345334820006, 43656.78171609122, 43671.344929826075, 43695.0, 3769.1142581493327, 3792.27946690128, 3801.144742432958, 3831.8658846940225, 3864.5555761087553, 33149.17127071819, 33314.0, 33364.33271334584, 33556.32887342264, 33623.32753344944, 4217.894552636209, 4222.2822120239325, 4274.209271284792, 4296.742195468282, 4334.0, 289114.55442722864, 290926.0, 291864.0, 292555.0, 292619.0, 46715.5328446718, 47503.5249647506, 47526.0, 63779.68110159419, 64480.67759661172, 43737.0, 43978.12043759107, 44083.77958110253, 44130.338044929355, 44208.557914421086, 16051.357945682275, 16177.595560110856, 16195.514134575982, 16205.59486012859, 16205.756913646304, 12802.871971280354, 12856.228626282453, 12862.549810756578, 12874.227546347249, 12878.227306361649, 15395.461158859385, 15519.922400387926, 15544.611384715246, 15606.531804045897, 15655.295511701774, 6035.39646035393, 6135.509159267248, 6140.293866205444, 6168.506519478431, 6184.546631541584, 1067.5996501312009, 1101.432762127505, 1165.0, 1174.788538063157, 1191.4343916132661, 30330.696693032787, 30499.0, 30803.383932321227, 31017.0694879154, 31074.22314442157, 1138.920275580718, 1151.3897634253858, 1195.055905834381, 1225.7180848404917, 1255.4225056473942, 15859.365625375087, 15970.121643309498, 16100.677986440205, 16198.59503512398, 16201.4329498467, 351022.0, 353840.0, 354829.0, 355350.0, 355703.0, 58614.41385586175, 59188.40811591915, 59230.0, 59244.70377648171, 59294.70352648209, 1410.4851729118798, 1486.3162945045185, 1489.1660670024821, 1523.8171419429518, 1525.3593490733917, 28776.280592985342, 29643.0, 29706.554401684425, 30060.0, 30162.69837301687, 45961.08077838358, 46407.0, 46458.0, 46478.76760616175, 46523.302150468444, 186337.0, 190454.0, 191676.0, 192268.0, 207639.0, 30793.38413231678, 31348.0, 36591.0, 37248.255034899696, 38141.809290953366, 45499.54500454953, 45873.0, 45932.7703361481, 46385.536144639475, 46752.0, 38319.6168038316, 38377.232455350175, 38596.035099122746, 38627.6137238624, 38811.61188388193, 37584.43623345707, 37778.43332349962, 38501.4224786634, 38958.2208355837, 39127.2174556513, 36789.0, 38183.902455969226, 38286.23427531378, 38533.03667408337, 38676.613233868426, 32957.835210823796, 33592.66407335895, 34262.657373425944, 34379.82810085933, 34481.13797155091, 26523.204303870916, 26652.20043398701, 26861.194164175107, 27221.455570888076, 27567.586486203123], "unit": "score", "name": "ext.html", "value": 18908.91472624155}, {"lowerIsBetter": false, "replicates": [332.41215172942833, 391.7355784845229, 395.35162333772615, 397.12434082847335, 398.5436675007117, 17683.646327073468, 18796.906015469922, 18946.0, 19400.805991940095, 19408.22367105314, 12547.560835370763, 12796.872031279685, 12806.423710933008, 12806.487740490393, 12820.358982050906, 5358.946410535903, 5359.5712343012465, 5428.158635411518, 5470.398256191816, 5475.4524547545125, 5421.051316019701, 5434.728263586825, 5445.237666726662, 5446.128619420893, 5446.1558458439, 5387.919181212285, 5433.646812957145, 5541.944580554204, 5769.913451298234, 5790.247267855173, 5681.3466451358, 5784.392638772932, 5806.59353845231, 5807.535397168216, 5841.8831623367505, 5176.0, 5247.947520524784, 5250.68495890244, 5264.526192642642, 5264.868053368506, 14314.141151530837, 14549.34527946245, 14557.854421455755, 14733.852661473355, 20218.19127234909, 2363.9527209455887, 2379.3932547200525, 2387.092904696204, 2489.987550062238, 2706.161090062067, 10448.26862119652, 10478.738031549196, 10842.620508282173, 12941.352932353439, 14139.151650900978, 1976.0613708488354, 1982.8810271383763, 1987.592543528573, 1995.2617531513433, 2003.0885946894127, 50627.0, 64022.0, 64938.675306623634, 66170.3382966169, 66593.0, 9996.0, 10363.170946324275, 10666.0, 10792.676219713421, 10944.069754070833, 14694.485693000694, 14890.106593604418, 14908.254587270592, 14923.776143357858, 14942.327595258239, 7716.344110750649, 7794.41541884361, 8129.634166462523, 8178.5092894426525, 8203.466774659628, 7394.7781566553085, 7440.0, 7459.962700186573, 7508.0990281166605, 7659.387249020177, 4739.976300118477, 4773.64197685175, 4780.378550788375, 4810.7113573185725, 4840.322354870321, 1926.9518262043562, 1967.1049672399024, 1987.8210961013579, 1990.7810140884492, 2005.8796472211714, 921.4195057114109, 966.9951650241704, 1029.9742506437249, 1070.925035247525, 1071.8499410082595, 17137.7977626454, 17151.056691882066, 17215.397461088804, 17301.134943252786, 17674.116294185238, 985.3496692183124, 998.3061772068343, 1000.3297790480395, 1040.47976011994, 1051.164324362134, 9929.80140397188, 10003.499825008721, 10127.746806329753, 10166.796664066676, 10166.949165254126, 437514.0, 444267.0, 467264.0, 473985.0, 477719.0, 73464.0, 73565.26434735584, 74079.5184096315, 74086.0, 75919.62040189764, 1061.4639606998571, 1062.4262898034974, 1091.579741799413, 1092.0, 1098.983515247272, 15470.613234669223, 15489.0, 15658.765118523004, 15767.842321577096, 15769.605759856095, 32684.673153269116, 33493.33013339671, 34159.65840341565, 34553.30893382169, 35117.473237900944, 44879.32681009722, 48520.5147948516, 49350.0, 49434.0, 49506.504934950186, 8455.154484551496, 8459.64645656692, 8547.27348175412, 8558.272546833588, 8720.345974051845, 10129.290949633749, 12893.161944473579, 13112.672183195114, 13174.40715167839, 13183.472661093449, 11371.601993930173, 11437.370944597795, 11599.536018559163, 11655.766884662089, 11863.0, 11459.08327333828, 11463.140264480031, 11527.193096483166, 11633.941830290794, 11690.532378704756, 11269.887301126884, 11527.769444610893, 11806.173567850168, 11840.348780817138, 12131.45408456604, 8591.871121933302, 8664.653413863374, 8689.261412779984, 8787.428817126865, 9000.279977601907, 10336.689899302732, 11336.886631133913, 11346.94326528362, 11375.715607109558, 11558.422078895854], "unit": "score", "name": "jquery.html", "value": 8693.82727951875}, {"lowerIsBetter": false, "replicates": [1490.4336352186167, 1580.4784421141026, 1595.2502323907763, 1754.9034803085833, 1841.3647291684372, 8262.132476090006, 8438.451500652453, 8448.662053517859, 8458.619362128704, 8480.957595212023, 8416.873746893787, 8524.744257672264, 8569.828603427928, 8572.0, 8604.096569860169, 2446.4006318451916, 2465.1988103866224, 2469.64190192422, 2470.234227389506, 2473.492933948545, 2409.771071748181, 2491.4394261291154, 2491.725910149891, 2504.4615407687343, 2508.3352911478473, 2449.1183174057414, 2455.0793452455327, 2480.08236952327, 2480.1815400917653, 2480.342709182068, 2384.4992551564105, 2387.522495500898, 2413.3242692046256, 2445.902163913441, 2449.350922005652, 2469.469064151198, 2473.8144639151956, 2496.5131799299143, 2508.097085049381, 2513.673222481084, 8662.177093176202, 8686.826263474695, 8700.869486957701, 8704.129587041309, 8728.170823771732, 5165.535101840853, 5315.415304316522, 5336.759845806948, 5356.839294821161, 5358.196270559409, 3198.056573310879, 3200.2959348943195, 3251.7723759336855, 3275.8689652413873, 3278.950815737766, 1045.577870255095, 1061.5170097605649, 1089.1504626391427, 1964.5579744557504, 1997.1512107354317, 12071.879281207164, 12164.08769342294, 12167.087468439813, 12173.147879648428, 12189.329586872718, 4310.52584215736, 4488.079943611552, 4584.6561507887045, 4634.884127896762, 4660.603848672833, 9596.95201523988, 9618.182454491447, 9622.0, 9629.903700962901, 9646.0, 5119.948800512022, 5171.095058364771, 5172.379314482287, 5179.04187725272, 5180.430152683201, 4209.600087991697, 4278.572142785696, 4322.805473753689, 4682.321063445781, 4779.689320194246, 3625.2024554597947, 3668.908277293089, 3677.6690097890782, 3687.0966613179407, 3733.533308336458, 1067.2529229539198, 1073.457903758597, 1082.1342925659599, 1088.7713580148259, 1089.9019088282093, 1246.812978053281, 1270.0284282523876, 1285.556483013359, 1515.0985163827504, 1516.196415899575, 7989.121196668362, 8337.791555211168, 8342.916570834335, 8350.874736878952, 8371.330293576499, 537.4088502647057, 543.7824870051932, 544.5942772634413, 546.3989611427478, 551.715866328841, 5815.709214539256, 5823.184754134425, 5833.008388573952, 5843.5325173985975, 5869.765209391662, 10139.2902496826, 10186.134178594753, 10194.694159175237, 10326.586936522604, 10360.896391036144, 9719.854202186973, 10115.949420252851, 10151.847722284172, 10188.490575471196, 10196.541155648014, 8127.0653874803975, 8243.629036693363, 8244.422890397735, 8257.876131858027, 8333.208345207195, 7600.049993750781, 7658.042744656918, 7746.109197442141, 7748.496347737379, 7750.147483776893, 9036.502992335221, 9189.081091890757, 9297.395669281475, 9383.296252781205, 9422.858657120012, 9296.6281348748, 9365.765855853386, 9386.202172815387, 9559.761005974906, 9572.32993690435, 6411.455026322815, 7053.294670532906, 7264.237255088351, 7299.890501642586, 7387.667554960147, 8008.559529225716, 8026.43814932949, 8038.236367545074, 8067.475614085066, 8071.596420179085, 6968.0, 7020.7893763187185, 7048.929510704827, 7073.0, 7292.525985810906, 7035.296470352924, 7076.858462830817, 7093.219745828058, 7203.71185152588, 7208.56748595086, 7619.9238007619215, 7907.762767116996, 7914.287714105758, 7915.604219789103, 7926.445148839526, 6933.89599156003, 7005.0, 7005.22942476317, 7009.649517524002, 7031.718731250898, 7043.859122817617, 7047.260037695968, 7059.117610298713, 7062.576245425291, 7306.4885458017425], "unit": "score", "name": "mootools.html", "value": 4766.426855528511}, {"lowerIsBetter": false, "replicates": [340.74614412262866, 352.33057191336457, 352.7599741640582, 366.6297039989613, 375.3056844837052, 5946.316173640027, 5947.405259474051, 5995.0, 6005.309389420218, 6020.5785595008365, 5894.17481552583, 5899.321578018529, 5912.054071348574, 5919.408059194078, 5923.229980102581, 4423.712458690191, 4501.009777848868, 4651.1162879053045, 4669.53304669532, 4673.0420263846, 4634.050019745944, 4635.9536404635855, 4651.767411629422, 4652.116097941397, 4658.580727734503, 4609.193391156551, 4616.169089563878, 4618.145643056028, 4620.145273124466, 4632.3283123947, 4416.470023597173, 4493.932591011154, 4597.678162528624, 4599.379083823675, 4615.14619795339, 4065.7560546367313, 4068.9593104068877, 4072.6334629883454, 4076.32740597801, 4076.510818701745, 5662.094064949588, 5666.744996475128, 5669.0, 5669.744861481243, 5675.801346952837, 5322.33470816148, 5361.115415956362, 5364.0, 5371.543418809406, 5373.5163835254625, 6292.244930608311, 6301.59039662425, 6304.27500837405, 6307.022411526175, 6312.810615681537, 4422.29243321067, 4487.52880947499, 4500.729956202638, 4523.819047238107, 4538.818447262105, 6568.244651865049, 6582.407583317477, 6588.439982601484, 6590.868182636321, 6608.0, 4622.237330840441, 4625.606823419979, 4626.398568186114, 4629.375034370384, 4632.351470794091, 4688.789004494738, 4693.48371679115, 4694.342792009122, 4696.0842635686395, 4697.084068606658, 5352.973235133877, 5359.115745901882, 5362.8659283517445, 5364.9731751341, 5367.221752845816, 6106.389361063947, 6262.09199666055, 6344.143540622049, 6350.269718982377, 6358.427741503287, 1594.9043057416593, 1604.4625050608176, 1611.3393508661627, 1616.1757503673211, 1617.24797968945, 987.5950860147306, 1047.994760026195, 1065.6643157405392, 1075.2473268711933, 1116.6873275482878, 6015.879682406327, 6023.548233882477, 6037.818865434044, 6046.244219472566, 6086.117512960596, 6508.251551071688, 6517.348265173539, 6523.7716679915975, 6527.477801775846, 6528.477721782246, 6111.449969502677, 6114.633122012605, 6115.143879856823, 6115.510759139258, 6115.663638499926, 3407.182276253731, 3467.739919506047, 3497.4229252173104, 3498.1079824644553, 3499.842507087187, 6192.504599632019, 6525.771597994142, 6675.866482670416, 6741.056252124707, 6741.393274605309, 6583.3416658334745, 6598.967005164944, 6737.258901520829, 6777.051212830208, 6814.591124532544, 6867.484938629623, 6873.1064961554675, 6881.380675739208, 6881.449484041264, 6883.965580172167, 6632.635205063768, 6637.4114095503755, 6639.3360663935155, 6640.667966601554, 6645.767398141235, 6497.4477169441125, 6507.056476810931, 6514.478841692748, 6524.412802847766, 6525.249596296487, 6729.596224226562, 6859.2454829969665, 6870.141232345957, 6872.656367181721, 6874.140732408449, 4633.629309655152, 4653.674242803107, 4674.579287864109, 4676.275177347517, 4687.015726697432, 6612.338766123349, 6618.933810662024, 6619.470442364695, 6620.569662971891, 6627.204735431586, 6416.294207637063, 6427.453666438405, 6434.871302574016, 6436.066770318184, 6439.259485159267, 6421.422072013541, 6428.0, 6431.614103153825, 6436.259830119409, 6436.774712885027, 6114.877702445837, 6211.81364559064, 6282.937170628418, 6298.968505157445, 6304.085907543472, 6441.1304473895425, 6445.0, 6456.709448074754, 6463.612183269019, 6465.321141280097, 6242.750289988349, 6297.811065668037, 6300.243970723543, 6313.873722525615, 6319.873602528016], "unit": "score", "name": "prototype.html", "value": 4822.620825111292}, {"lowerIsBetter": false, "replicates": [760.6609675248612, 780.4965797060893, 814.5845618734451, 900.4282280751722, 933.9486328251945, 14310.642233944156, 14585.34365953532, 14779.039362441434, 14779.334929928153, 14803.777943330859, 14080.78878816816, 14100.36548355324, 14102.717945641081, 14116.011879168462, 14120.152790832532, 908.0465511213233, 913.2876356441986, 913.6528119314651, 944.1549812917435, 968.6173961285288, 964.1033838530165, 965.3242730088931, 970.1705042188933, 971.1745016735789, 971.8542218667186, 1003.2676146413123, 1004.5981607357043, 1004.7136566078633, 1005.8994100589956, 1006.2000709436016, 991.6033586565395, 996.227923359395, 996.8853581838109, 997.1324947295826, 997.1574019953129, 729.3435907683074, 733.6515155301242, 733.6698485681464, 733.8605664923648, 734.5445823589355, 15529.689406211926, 15586.922065389714, 15598.454054108166, 15605.45380911674, 15619.453319133776, 14161.0, 14261.286935653176, 14318.212498312589, 14396.496122635657, 14421.206833624146, 11693.298402095901, 11696.67212220402, 11858.466369013415, 11894.881051189464, 12123.696907577381, 3911.902202444933, 3949.328614135575, 3957.2481228566767, 4054.452648892391, 4058.6955978301744, 45637.0, 50290.0, 51944.22083668748, 52452.73773631146, 54134.18798718022, 11114.666560003212, 11417.657470275904, 11505.71235719097, 11792.764144717057, 11810.173287869766, 17558.736618950727, 19984.90007549982, 20104.296349627693, 20201.393958181277, 20439.4890127748, 8359.456635318686, 8478.279346255515, 8536.914630853737, 8545.658173673108, 8681.262092722063, 4488.169688607618, 4561.429821272341, 4668.0, 4672.2057250267535, 4672.43930728308, 3450.706689931384, 3516.2615850671646, 3527.047697121814, 3529.6823285904393, 3540.6282340354405, 661.5237029338869, 662.8508585568209, 667.072768851297, 669.8325418645338, 674.9730010799512, 648.9422241745924, 676.2561182698992, 679.1917618034523, 701.1516065560627, 746.123305116486, 9127.543622818832, 9190.908090919005, 9469.763255918657, 9476.715698529055, 9493.715188544216, 732.8058064612775, 743.6988019851968, 768.500474691455, 774.0517865614689, 774.6552784011061, 4312.778714446781, 4378.868633940987, 4501.257292546758, 4507.2788353863225, 4689.7655117244, 61850.690746546876, 62595.0, 62722.0, 63761.0, 63906.6804665983, 49609.50390496049, 52112.47887521076, 54532.45467545353, 55209.447905521236, 58276.708616457494, 48424.273635895486, 48601.51398486041, 48747.512524875005, 49282.0, 50313.0, 9071.228945539702, 9294.488803115893, 9582.568784404579, 9763.80472390534, 9765.707028789147, 36289.637103629684, 36425.817870910476, 37336.0, 37677.62322376741, 37839.62160378361, 43042.0, 43126.78436607797, 44053.0, 45281.547184527735, 45383.773081134386, 12066.0, 12351.0, 12420.751584968431, 12451.564195253122, 12507.914034886606, 13319.933400332937, 13378.397972091085, 13425.798613020617, 13482.393292302066, 13622.182669039888, 12627.684307892008, 12705.0, 12735.172213806072, 12996.740065198832, 13083.084184107021, 12753.298568578817, 12807.871921280668, 12877.0, 13089.018323625956, 13255.602331930058, 12681.556145534862, 12812.103152779217, 12962.0, 12980.286084265455, 13201.339933003119, 10409.739756506147, 10457.424841633783, 10855.131589472981, 10876.945615272189, 11067.169962253025, 10586.4706764663, 11047.447627618747, 11182.832257515982, 11392.08863290918, 11439.199256051996], "unit": "score", "name": "yui.html", "value": 7032.703905666326}], "name": "dromaeo_css", "value": 7222.754470412335}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 104.0, 110.0, 109.0, 111.0, 98.0, 111.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [157.0, 130.0, 169.0, 162.0, 127.0, 153.0, 164.0, 139.0, 186.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 151.9}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 159.0, 160.0, 162.0, 161.0, 160.0, 163.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 74.0, 173.0, 74.0, 77.0, 75.0, 74.0, 166.0, 76.0], "unit": "score", "name": "audio-fft", "value": 94.1}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 138.0, 92.0, 92.0, 94.0, 153.0, 93.0, 91.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 144.0, 146.0, 145.0, 145.0, 145.0, 145.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 57.0, 55.0, 56.0, 55.0, 55.0, 65.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 70.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 86.0, 78.0, 78.0, 78.0, 78.0, 79.0, 78.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.7}, {"lowerIsBetter": true, "replicates": [113.0, 114.0, 124.0, 121.0, 117.0, 119.0, 112.0, 113.0, 114.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 148.0, 137.0, 141.0, 134.0, 151.0, 144.0, 143.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [66.0, 72.0, 67.0, 67.0, 65.0, 64.0, 74.0, 68.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1510.3000000000004}]} 06:27:10 INFO - Return code: 0 06:27:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:27:10 INFO - # TBPL SUCCESS # 06:27:10 INFO - Running post-action listener: _resource_record_post_action 06:27:10 INFO - Running post-run listener: _resource_record_post_run 06:27:11 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 459743232; Read time: 0; Write time: 396812 06:27:11 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 237785088; Read time: 0; Write time: 269976 06:27:11 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 221958144; Read time: 0; Write time: 126836 06:27:11 INFO - Running post-run listener: _upload_blobber_files 06:27:11 INFO - Blob upload gear active. 06:27:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:27:11 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 06:27:11 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'] 06:27:11 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 06:27:11 INFO - (blobuploader) - INFO - Open directory for files ... 06:27:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:27:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:27:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:27:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:27:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:27:12 INFO - (blobuploader) - INFO - Done attempting. 06:27:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:27:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:27:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:27:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:27:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:27:13 INFO - (blobuploader) - INFO - Done attempting. 06:27:13 INFO - (blobuploader) - INFO - Iteration through files over. 06:27:13 INFO - Return code: 0 06:27:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:27:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:27:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b85865508790ac1814e5222454633d419ec62963fb15b3091ebf7988b3e163cff812936c1b7ef86c2b059fb6a91f44a1d101643ee7a234fa15169eb0f2aaaf6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1835f1a2965ea94e8967ee7c1ada05257b3998c2437b76e5516e27d623fcec2f470b8533748b0050797a275d3e7529d141e3e715776bc75c65489091538c770d"} 06:27:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:27:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:27:13 INFO - Contents: 06:27:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b85865508790ac1814e5222454633d419ec62963fb15b3091ebf7988b3e163cff812936c1b7ef86c2b059fb6a91f44a1d101643ee7a234fa15169eb0f2aaaf6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1835f1a2965ea94e8967ee7c1ada05257b3998c2437b76e5516e27d623fcec2f470b8533748b0050797a275d3e7529d141e3e715776bc75c65489091538c770d"} 06:27:13 INFO - Running post-run listener: copy_logs_to_upload_dir 06:27:13 INFO - Copying logs to upload dir... 06:27:13 INFO - mkdir: /builds/slave/test/build/upload/logs 06:27:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1223.424689 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-05-09 06:27:12.698334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:27:12.702075) ========= 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=a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377 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/9b85865508790ac1814e5222454633d419ec62963fb15b3091ebf7988b3e163cff812936c1b7ef86c2b059fb6a91f44a1d101643ee7a234fa15169eb0f2aaaf6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1835f1a2965ea94e8967ee7c1ada05257b3998c2437b76e5516e27d623fcec2f470b8533748b0050797a275d3e7529d141e3e715776bc75c65489091538c770d"} build_url:https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011151 build_url: 'https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/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/9b85865508790ac1814e5222454633d419ec62963fb15b3091ebf7988b3e163cff812936c1b7ef86c2b059fb6a91f44a1d101643ee7a234fa15169eb0f2aaaf6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1835f1a2965ea94e8967ee7c1ada05257b3998c2437b76e5516e27d623fcec2f470b8533748b0050797a275d3e7529d141e3e715776bc75c65489091538c770d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:27:12.726586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:27:12.726926) ========= 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=a0d2d2de893abaa8702a9954000001a7-1462799207.907638-197001377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:27:12.812550) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:27:12.812885) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:27:12.813169) ========= ========= Total master_lag: 0.17 =========