builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1461363020.45 results: success (0) buildid: 20160422122844 builduid: 7cd0caf2d5824d22b57bb0c83a0813cb revision: 104bef115f31497dd411582328eef6ed375d0c72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:20.452362) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:20.452832) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:20.453128) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:20.466754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:20.467105) ========= 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-1461363019.995718-2144899226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 15:10:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-22 15:10:20 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080667 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:20.558688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:20.559013) ========= 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-1461363019.995718-2144899226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015672 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:20.608969) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:20.609318) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 104bef115f31497dd411582328eef6ed375d0c72 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 104bef115f31497dd411582328eef6ed375d0c72 --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-1461363019.995718-2144899226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 15:10:20,852 truncating revision to first 12 chars 2016-04-22 15:10:20,852 Setting DEBUG logging. 2016-04-22 15:10:20,852 attempt 1/10 2016-04-22 15:10:20,852 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/104bef115f31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 15:10:21,114 unpacking tar archive at: mozilla-aurora-104bef115f31/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581684 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:21.203684) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:21.204021) ========= script_repo_revision: 104bef115f31497dd411582328eef6ed375d0c72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:21.204419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:21.204688) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 15:10:21.214696) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-22 15:10:21.215000) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1461363019.995718-2144899226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:10:21 INFO - MultiFileLogger online at 20160422 15:10:21 in /builds/slave/test 15:10:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:10:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:10:21 INFO - {'append_to_log': False, 15:10:21 INFO - 'base_work_dir': '/builds/slave/test', 15:10:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:10:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:10:21 INFO - 'branch': 'Mozilla-Aurora', 15:10:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:10:21 INFO - 'config_files': ('talos/linux_config.py',), 15:10:21 INFO - 'default_actions': ('clobber', 15:10:21 INFO - 'read-buildbot-config', 15:10:21 INFO - 'download-and-extract', 15:10:21 INFO - 'populate-webroot', 15:10:21 INFO - 'create-virtualenv', 15:10:21 INFO - 'install', 15:10:21 INFO - 'run-tests'), 15:10:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:10:21 INFO - 'download_minidump_stackwalk': True, 15:10:21 INFO - 'download_symbols': 'ondemand', 15:10:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:10:21 INFO - 'tooltool.py': '/tools/tooltool.py', 15:10:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:10:21 INFO - '/tools/misc-python/virtualenv.py')}, 15:10:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:10:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:10:21 INFO - 'installer_path': 'installer.exe', 15:10:21 INFO - 'log_level': 'info', 15:10:21 INFO - 'log_name': 'talos', 15:10:21 INFO - 'log_to_console': True, 15:10:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:10:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:10:21 INFO - 'opt_config_files': (), 15:10:21 INFO - 'pip_index': False, 15:10:21 INFO - 'sps_profile': False, 15:10:21 INFO - 'sps_profile_interval': 0, 15:10:21 INFO - 'suite': 'dromaeojs', 15:10:21 INFO - 'system_bits': '32', 15:10:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:10:21 INFO - 'title': 'talos-linux64-ix-002', 15:10:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:10:21 INFO - 'use_talos_json': True, 15:10:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:10:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:10:21 INFO - 'work_dir': 'build'} 15:10:21 INFO - ##### 15:10:21 INFO - ##### Running clobber step. 15:10:21 INFO - ##### 15:10:21 INFO - Running pre-action listener: _resource_record_pre_action 15:10:21 INFO - Running main action method: clobber 15:10:21 INFO - rmtree: /builds/slave/test/build 15:10:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:10:22 INFO - Running post-action listener: _resource_record_post_action 15:10:22 INFO - ##### 15:10:22 INFO - ##### Running read-buildbot-config step. 15:10:22 INFO - ##### 15:10:22 INFO - Running pre-action listener: _resource_record_pre_action 15:10:22 INFO - Running main action method: read_buildbot_config 15:10:22 INFO - Using buildbot properties: 15:10:22 INFO - { 15:10:22 INFO - "project": "", 15:10:22 INFO - "product": "firefox", 15:10:22 INFO - "script_repo_revision": "production", 15:10:22 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:10:22 INFO - "repository": "", 15:10:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:10:22 INFO - "buildid": "20160422122844", 15:10:22 INFO - "pgo_build": "True", 15:10:22 INFO - "basedir": "/builds/slave/test", 15:10:22 INFO - "buildnumber": 277, 15:10:22 INFO - "slavename": "talos-linux64-ix-002", 15:10:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:10:22 INFO - "platform": "ubuntu64_hw", 15:10:22 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:10:22 INFO - "branch": "mozilla-aurora", 15:10:22 INFO - "repo_path": "releases/mozilla-aurora", 15:10:22 INFO - "revision": "104bef115f31497dd411582328eef6ed375d0c72", 15:10:22 INFO - "stage_platform": "linux64-pgo", 15:10:22 INFO - "builduid": "7cd0caf2d5824d22b57bb0c83a0813cb", 15:10:22 INFO - "slavebuilddir": "test" 15:10:22 INFO - } 15:10:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 15:10:22 INFO - Running post-action listener: _resource_record_post_action 15:10:22 INFO - ##### 15:10:22 INFO - ##### Running download-and-extract step. 15:10:22 INFO - ##### 15:10:22 INFO - Running pre-action listener: _resource_record_pre_action 15:10:22 INFO - Running main action method: download_and_extract 15:10:22 INFO - mkdir: /builds/slave/test/build/tests 15:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:22 INFO - https://queue.taskcluster.net/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:10:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:10:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:10:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:10:22 INFO - Downloaded 1448 bytes. 15:10:22 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:10:22 INFO - Using the following test package requirements: 15:10:22 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:10:22 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:10:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:10:22 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:10:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:10:22 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:10:22 INFO - u'jsshell-linux-x86_64.zip'], 15:10:22 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:10:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:10:22 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:10:22 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:10:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:10:22 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:10:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:10:22 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:10:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:10:22 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:10:22 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:10:22 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:10:22 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:22 INFO - https://queue.taskcluster.net/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:10:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:10:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:10:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:10:24 INFO - Downloaded 23358625 bytes. 15:10:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:10:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:10:25 INFO - Return code: 0 15:10:25 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:25 INFO - https://queue.taskcluster.net/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:10:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:10:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:10:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:10:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:10:30 INFO - Downloaded 23358625 bytes. 15:10:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:10:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:10:31 INFO - Return code: 0 15:10:31 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')]} 15:10:31 INFO - https://queue.taskcluster.net/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:10:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:10:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:10:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:10:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:10:32 INFO - Downloaded 10845198 bytes. 15:10:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:10:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:10:33 INFO - Return code: 0 15:10:33 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')]} 15:10:33 INFO - https://queue.taskcluster.net/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:10:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:10:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:10:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:10:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:10:38 INFO - Downloaded 60829849 bytes. 15:10:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:10:38 INFO - mkdir: /builds/slave/test/properties 15:10:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:10:38 INFO - Writing to file /builds/slave/test/properties/build_url 15:10:38 INFO - Contents: 15:10:38 INFO - build_url:https://queue.taskcluster.net/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:10:39 INFO - Running post-action listener: _resource_record_post_action 15:10:39 INFO - Running post-action listener: set_extra_try_arguments 15:10:39 INFO - ##### 15:10:39 INFO - ##### Running populate-webroot step. 15:10:39 INFO - ##### 15:10:39 INFO - Running pre-action listener: _resource_record_pre_action 15:10:39 INFO - Running main action method: populate_webroot 15:10:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:10:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:10:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:10:39 INFO - '--tppagecycles', 15:10:39 INFO - '7'], 15:10:39 INFO - 'tests': ['tsvgm']}}, 15:10:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:10:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:10:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:10:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:10:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:10:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:10:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'talos_options': ['--e10s'], 15:10:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'tests': ['damp', 'tps']}, 15:10:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'talos_options': ['--e10s'], 15:10:39 INFO - 'tests': ['damp', 'tps']}, 15:10:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:10:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:10:39 INFO - 'other': {'tests': ['a11yr', 15:10:39 INFO - 'ts_paint', 15:10:39 INFO - 'tpaint', 15:10:39 INFO - 'sessionrestore', 15:10:39 INFO - 'sessionrestore_no_auto_restore', 15:10:39 INFO - 'tabpaint']}, 15:10:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:10:39 INFO - 'tests': ['a11yr', 15:10:39 INFO - 'ts_paint', 15:10:39 INFO - 'tpaint', 15:10:39 INFO - 'sessionrestore', 15:10:39 INFO - 'sessionrestore_no_auto_restore', 15:10:39 INFO - 'tabpaint']}, 15:10:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:10:39 INFO - 'tests': ['a11yr', 15:10:39 INFO - 'ts_paint', 15:10:39 INFO - 'tpaint', 15:10:39 INFO - 'sessionrestore', 15:10:39 INFO - 'sessionrestore_no_auto_restore', 15:10:39 INFO - 'tabpaint']}, 15:10:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:10:39 INFO - 'tests': ['a11yr', 15:10:39 INFO - 'ts_paint', 15:10:39 INFO - 'tpaint', 15:10:39 INFO - 'sessionrestore', 15:10:39 INFO - 'sessionrestore_no_auto_restore', 15:10:39 INFO - 'tabpaint']}, 15:10:39 INFO - 'other_l64': {'tests': ['a11yr', 15:10:39 INFO - 'ts_paint', 15:10:39 INFO - 'tpaint', 15:10:39 INFO - 'sessionrestore', 15:10:39 INFO - 'sessionrestore_no_auto_restore', 15:10:39 INFO - 'tabpaint']}, 15:10:39 INFO - 'other_nol64': {'tests': ['a11yr', 15:10:39 INFO - 'ts_paint', 15:10:39 INFO - 'tpaint', 15:10:39 INFO - 'sessionrestore', 15:10:39 INFO - 'sessionrestore_no_auto_restore', 15:10:39 INFO - 'tabpaint']}, 15:10:39 INFO - 'svgr': {'tests': ['tsvgx', 15:10:39 INFO - 'tsvgr_opacity', 15:10:39 INFO - 'tart', 15:10:39 INFO - 'tscrollx', 15:10:39 INFO - 'cart']}, 15:10:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:10:39 INFO - 'tests': ['tsvgx', 15:10:39 INFO - 'tsvgr_opacity', 15:10:39 INFO - 'tart', 15:10:39 INFO - 'tscrollx', 15:10:39 INFO - 'cart']}, 15:10:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'tests': ['tp5o']}, 15:10:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'talos_options': ['--e10s'], 15:10:39 INFO - 'tests': ['tp5o']}, 15:10:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'talos_options': ['--xperf_path', 15:10:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:39 INFO - 'tests': ['tp5n']}, 15:10:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'talos_options': ['--e10s', 15:10:39 INFO - '--xperf_path', 15:10:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:39 INFO - 'tests': ['tp5n']}}, 15:10:39 INFO - 'talos.zip': {'path': '', 15:10:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:10:39 INFO - Running post-action listener: _resource_record_post_action 15:10:39 INFO - ##### 15:10:39 INFO - ##### Running create-virtualenv step. 15:10:39 INFO - ##### 15:10:39 INFO - Running pre-action listener: _resource_record_pre_action 15:10:39 INFO - Running main action method: create_virtualenv 15:10:39 INFO - Creating virtualenv /builds/slave/test/build/venv 15:10:39 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 15:10:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:10:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:10:39 INFO - Using real prefix '/usr' 15:10:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:10:39 INFO - Installing distribute.............................................................................................................................................................................................done. 15:10:41 INFO - Installing pip.................done. 15:10:41 INFO - Return code: 0 15:10:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:10:41 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')]} 15:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:41 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')]} 15:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:41 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 0x7f3573f72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b580>, '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 0x1b2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c910>, '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-1461363019.995718-2144899226', '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 15:10:41 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 15:10:41 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 15:10:41 INFO - Using env: {'DISPLAY': ':0', 15:10:41 INFO - 'HOME': '/home/cltbld', 15:10:41 INFO - 'LANG': 'en_US.UTF-8', 15:10:41 INFO - 'LANGUAGE': 'en_US:en', 15:10:41 INFO - 'LOGNAME': 'cltbld', 15:10:41 INFO - 'MAIL': '/var/mail/cltbld', 15:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:41 INFO - 'MOZ_NO_REMOTE': '1', 15:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:41 INFO - 'NO_EM_RESTART': '1', 15:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:41 INFO - 'PWD': '/builds/slave/test', 15:10:41 INFO - 'SHELL': '/bin/bash', 15:10:41 INFO - 'SHLVL': '1', 15:10:41 INFO - 'TERM': 'linux', 15:10:41 INFO - 'TMOUT': '86400', 15:10:41 INFO - 'USER': 'cltbld', 15:10:41 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461363019.995718-2144899226', 15:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:41 INFO - '_': '/tools/buildbot/bin/python'} 15:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:41 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 15:10:41 INFO - Cleaning up... 15:10:41 INFO - Return code: 0 15:10:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:10:41 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')]} 15:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:41 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')]} 15:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:41 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 0x7f3573f72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b580>, '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 0x1b2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c910>, '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-1461363019.995718-2144899226', '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 15:10:41 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 15:10:41 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 15:10:41 INFO - Using env: {'DISPLAY': ':0', 15:10:41 INFO - 'HOME': '/home/cltbld', 15:10:41 INFO - 'LANG': 'en_US.UTF-8', 15:10:41 INFO - 'LANGUAGE': 'en_US:en', 15:10:41 INFO - 'LOGNAME': 'cltbld', 15:10:41 INFO - 'MAIL': '/var/mail/cltbld', 15:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:41 INFO - 'MOZ_NO_REMOTE': '1', 15:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:41 INFO - 'NO_EM_RESTART': '1', 15:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:41 INFO - 'PWD': '/builds/slave/test', 15:10:41 INFO - 'SHELL': '/bin/bash', 15:10:41 INFO - 'SHLVL': '1', 15:10:41 INFO - 'TERM': 'linux', 15:10:41 INFO - 'TMOUT': '86400', 15:10:41 INFO - 'USER': 'cltbld', 15:10:41 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461363019.995718-2144899226', 15:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:41 INFO - '_': '/tools/buildbot/bin/python'} 15:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:42 INFO - Downloading/unpacking psutil>=0.7.1 15:10:42 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 15:10:42 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 15:10:42 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 15:10:42 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 15:10:42 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 15:10:42 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 15:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:10:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:44 INFO - Installing collected packages: psutil 15:10:44 INFO - Running setup.py install for psutil 15:10:44 INFO - building 'psutil._psutil_linux' extension 15:10:44 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 15:10:44 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 15:10:44 INFO - building 'psutil._psutil_posix' extension 15:10:44 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 15:10:44 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 15:10:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:44 INFO - Successfully installed psutil 15:10:44 INFO - Cleaning up... 15:10:44 INFO - Return code: 0 15:10:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:10:44 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')]} 15:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:44 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')]} 15:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:44 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 0x7f3573f72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b580>, '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 0x1b2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c910>, '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-1461363019.995718-2144899226', '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 15:10:44 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 15:10:44 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 15:10:44 INFO - Using env: {'DISPLAY': ':0', 15:10:44 INFO - 'HOME': '/home/cltbld', 15:10:44 INFO - 'LANG': 'en_US.UTF-8', 15:10:44 INFO - 'LANGUAGE': 'en_US:en', 15:10:44 INFO - 'LOGNAME': 'cltbld', 15:10:44 INFO - 'MAIL': '/var/mail/cltbld', 15:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:44 INFO - 'MOZ_NO_REMOTE': '1', 15:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:44 INFO - 'NO_EM_RESTART': '1', 15:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:44 INFO - 'PWD': '/builds/slave/test', 15:10:44 INFO - 'SHELL': '/bin/bash', 15:10:44 INFO - 'SHLVL': '1', 15:10:44 INFO - 'TERM': 'linux', 15:10:44 INFO - 'TMOUT': '86400', 15:10:44 INFO - 'USER': 'cltbld', 15:10:44 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461363019.995718-2144899226', 15:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:44 INFO - '_': '/tools/buildbot/bin/python'} 15:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:10:46 INFO - Installing collected packages: mozsystemmonitor 15:10:46 INFO - Running setup.py install for mozsystemmonitor 15:10:46 INFO - Successfully installed mozsystemmonitor 15:10:46 INFO - Cleaning up... 15:10:46 INFO - Return code: 0 15:10:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3573f72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b580>, '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 0x1b2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c910>, '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-1461363019.995718-2144899226', '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 15:10:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:10:46 INFO - Using env: {'DISPLAY': ':0', 15:10:46 INFO - 'HOME': '/home/cltbld', 15:10:46 INFO - 'LANG': 'en_US.UTF-8', 15:10:46 INFO - 'LANGUAGE': 'en_US:en', 15:10:46 INFO - 'LOGNAME': 'cltbld', 15:10:46 INFO - 'MAIL': '/var/mail/cltbld', 15:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:46 INFO - 'MOZ_NO_REMOTE': '1', 15:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:46 INFO - 'NO_EM_RESTART': '1', 15:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:46 INFO - 'PWD': '/builds/slave/test', 15:10:46 INFO - 'SHELL': '/bin/bash', 15:10:46 INFO - 'SHLVL': '1', 15:10:46 INFO - 'TERM': 'linux', 15:10:46 INFO - 'TMOUT': '86400', 15:10:46 INFO - 'USER': 'cltbld', 15:10:46 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461363019.995718-2144899226', 15:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:46 INFO - '_': '/tools/buildbot/bin/python'} 15:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:47 INFO - Downloading/unpacking blobuploader==1.2.4 15:10:47 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 15:10:47 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 15:10:47 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 15:10:47 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 15:10:47 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 15:10:47 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 15:10:49 INFO - Downloading blobuploader-1.2.4.tar.gz 15:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:10:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:10:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:49 INFO - Downloading docopt-0.6.1.tar.gz 15:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:10:49 INFO - Installing collected packages: blobuploader, requests, docopt 15:10:49 INFO - Running setup.py install for blobuploader 15:10:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:10:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:10:49 INFO - Running setup.py install for requests 15:10:50 INFO - Running setup.py install for docopt 15:10:50 INFO - Successfully installed blobuploader requests docopt 15:10:50 INFO - Cleaning up... 15:10:50 INFO - Return code: 0 15:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:50 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')]} 15:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:50 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')]} 15:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:50 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 0x7f3573f72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b580>, '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 0x1b2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c910>, '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-1461363019.995718-2144899226', '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 15:10:50 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 15:10:50 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 15:10:50 INFO - Using env: {'DISPLAY': ':0', 15:10:50 INFO - 'HOME': '/home/cltbld', 15:10:50 INFO - 'LANG': 'en_US.UTF-8', 15:10:50 INFO - 'LANGUAGE': 'en_US:en', 15:10:50 INFO - 'LOGNAME': 'cltbld', 15:10:50 INFO - 'MAIL': '/var/mail/cltbld', 15:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:50 INFO - 'MOZ_NO_REMOTE': '1', 15:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:50 INFO - 'NO_EM_RESTART': '1', 15:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:50 INFO - 'PWD': '/builds/slave/test', 15:10:50 INFO - 'SHELL': '/bin/bash', 15:10:50 INFO - 'SHLVL': '1', 15:10:50 INFO - 'TERM': 'linux', 15:10:50 INFO - 'TMOUT': '86400', 15:10:50 INFO - 'USER': 'cltbld', 15:10:50 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461363019.995718-2144899226', 15:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:50 INFO - '_': '/tools/buildbot/bin/python'} 15:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:50 INFO - Running setup.py (path:/tmp/pip-QSYTK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:50 INFO - Running setup.py (path:/tmp/pip-Y6e7wR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:50 INFO - Running setup.py (path:/tmp/pip-gbUlR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:50 INFO - Running setup.py (path:/tmp/pip-T58sjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:50 INFO - Running setup.py (path:/tmp/pip-qwzmNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:50 INFO - Running setup.py (path:/tmp/pip-LUQ9RT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:51 INFO - Running setup.py (path:/tmp/pip-rhdV0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:51 INFO - Running setup.py (path:/tmp/pip-2ycqqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:51 INFO - Running setup.py (path:/tmp/pip-E5PE5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:51 INFO - Running setup.py (path:/tmp/pip-C7HIYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:51 INFO - Running setup.py (path:/tmp/pip-3xwXbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:51 INFO - Running setup.py (path:/tmp/pip-KHCVn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:51 INFO - Running setup.py (path:/tmp/pip-M6Do2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:51 INFO - Running setup.py (path:/tmp/pip-lI1K3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:51 INFO - Running setup.py (path:/tmp/pip-fVN2qE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:51 INFO - Running setup.py (path:/tmp/pip-x1g0Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:51 INFO - Running setup.py (path:/tmp/pip-F4QpAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:10:51 INFO - Running setup.py install for manifestparser 15:10:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:10:51 INFO - Running setup.py install for mozcrash 15:10:52 INFO - Running setup.py install for mozdebug 15:10:52 INFO - Running setup.py install for mozdevice 15:10:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:10:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:10:52 INFO - Running setup.py install for mozfile 15:10:52 INFO - Running setup.py install for mozhttpd 15:10:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:10:52 INFO - Running setup.py install for mozinfo 15:10:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:10:52 INFO - Running setup.py install for mozInstall 15:10:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:10:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:10:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:10:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:10:52 INFO - Running setup.py install for mozleak 15:10:52 INFO - Running setup.py install for mozlog 15:10:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:10:52 INFO - Running setup.py install for moznetwork 15:10:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:10:52 INFO - Running setup.py install for mozprocess 15:10:53 INFO - Running setup.py install for mozprofile 15:10:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:10:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:10:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:10:53 INFO - Running setup.py install for mozrunner 15:10:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:10:53 INFO - Running setup.py install for mozscreenshot 15:10:53 INFO - Running setup.py install for moztest 15:10:53 INFO - Running setup.py install for mozversion 15:10:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:10:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:10:53 INFO - Cleaning up... 15:10:53 INFO - Return code: 0 15:10:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:53 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')]} 15:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:53 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')]} 15:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:53 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 0x7f3573f72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b580>, '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 0x1b2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c910>, '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-1461363019.995718-2144899226', '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 15:10:53 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 15:10:53 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 15:10:53 INFO - Using env: {'DISPLAY': ':0', 15:10:53 INFO - 'HOME': '/home/cltbld', 15:10:53 INFO - 'LANG': 'en_US.UTF-8', 15:10:53 INFO - 'LANGUAGE': 'en_US:en', 15:10:53 INFO - 'LOGNAME': 'cltbld', 15:10:53 INFO - 'MAIL': '/var/mail/cltbld', 15:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:53 INFO - 'MOZ_NO_REMOTE': '1', 15:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:53 INFO - 'NO_EM_RESTART': '1', 15:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:53 INFO - 'PWD': '/builds/slave/test', 15:10:53 INFO - 'SHELL': '/bin/bash', 15:10:53 INFO - 'SHLVL': '1', 15:10:53 INFO - 'TERM': 'linux', 15:10:53 INFO - 'TMOUT': '86400', 15:10:53 INFO - 'USER': 'cltbld', 15:10:53 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461363019.995718-2144899226', 15:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:53 INFO - '_': '/tools/buildbot/bin/python'} 15:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:53 INFO - Running setup.py (path:/tmp/pip-prJ2s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:53 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)) 15:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:53 INFO - Running setup.py (path:/tmp/pip-OYKged-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:53 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:54 INFO - Running setup.py (path:/tmp/pip-x2kBH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:54 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:54 INFO - Running setup.py (path:/tmp/pip-IN4t1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:54 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:54 INFO - Running setup.py (path:/tmp/pip-lYxAyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:54 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:54 INFO - Running setup.py (path:/tmp/pip-CnRZx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:54 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:54 INFO - Running setup.py (path:/tmp/pip-AY_pS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:54 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:54 INFO - Running setup.py (path:/tmp/pip-EiwvBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:54 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:54 INFO - Running setup.py (path:/tmp/pip-BJdDXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:54 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:54 INFO - Running setup.py (path:/tmp/pip-8OtgA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:54 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:54 INFO - Running setup.py (path:/tmp/pip-aZyuPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:54 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:54 INFO - Running setup.py (path:/tmp/pip-gDxY2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:54 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:54 INFO - Running setup.py (path:/tmp/pip-ojr9__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:54 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:54 INFO - Running setup.py (path:/tmp/pip-m1jbWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:54 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:54 INFO - Running setup.py (path:/tmp/pip-Q8b1t4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:54 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)) 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:54 INFO - Running setup.py (path:/tmp/pip-HjLAl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:55 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)) 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:55 INFO - Running setup.py (path:/tmp/pip-pqn6X8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:55 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)) 15:10:55 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)) 15:10:55 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)) 15:10:55 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)) 15:10:55 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)) 15:10:55 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)) 15:10:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:10:55 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 15:10:55 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 15:10:55 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 15:10:55 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 15:10:55 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 15:10:55 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 15:10:56 INFO - Downloading blessings-1.6.tar.gz 15:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:10:57 INFO - Installing collected packages: blessings 15:10:57 INFO - Running setup.py install for blessings 15:10:57 INFO - Successfully installed blessings 15:10:57 INFO - Cleaning up... 15:10:57 INFO - Return code: 0 15:10:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:10:57 INFO - Reading from file tmpfile_stdout 15:10:57 INFO - Current package versions: 15:10:57 INFO - argparse == 1.2.1 15:10:57 INFO - blessings == 1.6 15:10:57 INFO - blobuploader == 1.2.4 15:10:57 INFO - docopt == 0.6.1 15:10:57 INFO - manifestparser == 1.1 15:10:57 INFO - mozInstall == 1.12 15:10:57 INFO - mozcrash == 0.17 15:10:57 INFO - mozdebug == 0.1 15:10:57 INFO - mozdevice == 0.48 15:10:57 INFO - mozfile == 1.2 15:10:57 INFO - mozhttpd == 0.7 15:10:57 INFO - mozinfo == 0.9 15:10:57 INFO - mozleak == 0.1 15:10:57 INFO - mozlog == 3.1 15:10:57 INFO - moznetwork == 0.27 15:10:57 INFO - mozprocess == 0.22 15:10:57 INFO - mozprofile == 0.28 15:10:57 INFO - mozrunner == 6.11 15:10:57 INFO - mozscreenshot == 0.1 15:10:57 INFO - mozsystemmonitor == 0.0 15:10:57 INFO - moztest == 0.7 15:10:57 INFO - mozversion == 1.4 15:10:57 INFO - psutil == 3.1.1 15:10:57 INFO - requests == 1.2.3 15:10:57 INFO - wsgiref == 0.1.2 15:10:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10: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')]} 15:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10: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')]} 15:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:57 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 0x7f3573f72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b580>, '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 0x1b2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c910>, '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-1461363019.995718-2144899226', '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 15:10:57 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 15:10:57 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 15:10:57 INFO - Using env: {'DISPLAY': ':0', 15:10:57 INFO - 'HOME': '/home/cltbld', 15:10:57 INFO - 'LANG': 'en_US.UTF-8', 15:10:57 INFO - 'LANGUAGE': 'en_US:en', 15:10:57 INFO - 'LOGNAME': 'cltbld', 15:10:57 INFO - 'MAIL': '/var/mail/cltbld', 15:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:57 INFO - 'MOZ_NO_REMOTE': '1', 15:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:57 INFO - 'NO_EM_RESTART': '1', 15:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:57 INFO - 'PWD': '/builds/slave/test', 15:10:57 INFO - 'SHELL': '/bin/bash', 15:10:57 INFO - 'SHLVL': '1', 15:10:57 INFO - 'TERM': 'linux', 15:10:57 INFO - 'TMOUT': '86400', 15:10:57 INFO - 'USER': 'cltbld', 15:10:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461363019.995718-2144899226', 15:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:57 INFO - '_': '/tools/buildbot/bin/python'} 15:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:57 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)) 15:10:57 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)) 15:10:57 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)) 15:10:57 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)) 15:10:57 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)) 15:10:57 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)) 15:10:57 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)) 15:10:57 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)) 15:10:57 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)) 15:10:57 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)) 15:10:57 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)) 15:10:57 INFO - Cleaning up... 15:10:57 INFO - Return code: 0 15:10:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:10: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')]} 15:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10: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')]} 15:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:57 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 0x7f3573f72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b580>, '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 0x1b2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c910>, '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-1461363019.995718-2144899226', '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 15:10:57 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 15:10:57 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 15:10:57 INFO - Using env: {'DISPLAY': ':0', 15:10:57 INFO - 'HOME': '/home/cltbld', 15:10:57 INFO - 'LANG': 'en_US.UTF-8', 15:10:57 INFO - 'LANGUAGE': 'en_US:en', 15:10:57 INFO - 'LOGNAME': 'cltbld', 15:10:57 INFO - 'MAIL': '/var/mail/cltbld', 15:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:57 INFO - 'MOZ_NO_REMOTE': '1', 15:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:57 INFO - 'NO_EM_RESTART': '1', 15:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:57 INFO - 'PWD': '/builds/slave/test', 15:10:57 INFO - 'SHELL': '/bin/bash', 15:10:57 INFO - 'SHLVL': '1', 15:10:57 INFO - 'TERM': 'linux', 15:10:57 INFO - 'TMOUT': '86400', 15:10:57 INFO - 'USER': 'cltbld', 15:10:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461363019.995718-2144899226', 15:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:57 INFO - '_': '/tools/buildbot/bin/python'} 15:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:57 INFO - Downloading/unpacking jsonschema 15:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:10:59 INFO - Downloading/unpacking functools32 (from jsonschema) 15:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:59 INFO - Downloading functools32-3.2.3-2.tar.gz 15:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:10:59 INFO - warning: no files found matching '*.txt' 15:10:59 INFO - no previously-included directories found matching 'build' 15:10:59 INFO - no previously-included directories found matching 'dist' 15:10:59 INFO - no previously-included directories found matching '.git*' 15:10:59 INFO - Installing collected packages: jsonschema, functools32 15:11:00 INFO - Running setup.py install for functools32 15:11:00 INFO - warning: no files found matching '*.txt' 15:11:00 INFO - no previously-included directories found matching 'build' 15:11:00 INFO - no previously-included directories found matching 'dist' 15:11:00 INFO - no previously-included directories found matching '.git*' 15:11:00 INFO - Successfully installed jsonschema functools32 15:11:00 INFO - Cleaning up... 15:11:00 INFO - Return code: 0 15:11:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:00 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 0x7f3573f72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b580>, '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 0x1b2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c910>, '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-1461363019.995718-2144899226', '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 15:11:00 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 15:11:00 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 15:11:00 INFO - Using env: {'DISPLAY': ':0', 15:11:00 INFO - 'HOME': '/home/cltbld', 15:11:00 INFO - 'LANG': 'en_US.UTF-8', 15:11:00 INFO - 'LANGUAGE': 'en_US:en', 15:11:00 INFO - 'LOGNAME': 'cltbld', 15:11:00 INFO - 'MAIL': '/var/mail/cltbld', 15:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:00 INFO - 'MOZ_NO_REMOTE': '1', 15:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:00 INFO - 'NO_EM_RESTART': '1', 15:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:00 INFO - 'PWD': '/builds/slave/test', 15:11:00 INFO - 'SHELL': '/bin/bash', 15:11:00 INFO - 'SHLVL': '1', 15:11:00 INFO - 'TERM': 'linux', 15:11:00 INFO - 'TMOUT': '86400', 15:11:00 INFO - 'USER': 'cltbld', 15:11:00 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461363019.995718-2144899226', 15:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:00 INFO - '_': '/tools/buildbot/bin/python'} 15:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:00 INFO - Downloading/unpacking flake8 15:11:00 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 15:11:00 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 15:11:00 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 15:11:00 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 15:11:00 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 15:11:00 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 15:11:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:11:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:11:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:11:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:11:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:11:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:11:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:11:03 INFO - no previously-included directories found matching 'docs/_build' 15:11:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:11:03 INFO - Running setup.py install for pep8 15:11:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:11:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:11:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:11:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:11:03 INFO - no previously-included directories found matching 'docs/_build' 15:11:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:11:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:11:03 INFO - Cleaning up... 15:11:03 INFO - Return code: 0 15:11:03 INFO - Running post-action listener: _resource_record_post_action 15:11:03 INFO - Running post-action listener: _start_resource_monitoring 15:11:03 INFO - Starting resource monitoring. 15:11:03 INFO - ##### 15:11:03 INFO - ##### Running install step. 15:11:03 INFO - ##### 15:11:03 INFO - Running pre-action listener: _resource_record_pre_action 15:11:03 INFO - Running main action method: install 15:11:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:11:03 INFO - Reading from file tmpfile_stdout 15:11:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:11:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:11:03 INFO - Reading from file tmpfile_stdout 15:11:03 INFO - Output received: 15:11:03 INFO - Usage: mozinstall [options] installer 15:11:03 INFO - Options: 15:11:03 INFO - -h, --help show this help message and exit 15:11:03 INFO - -d DEST, --destination=DEST 15:11:03 INFO - Directory to install application into. [default: 15:11:03 INFO - "/builds/slave/test"] 15:11:03 INFO - --app=APP Application being installed. [default: firefox] 15:11:03 INFO - mkdir: /builds/slave/test/build/application 15:11:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:11:18 INFO - Reading from file tmpfile_stdout 15:11:18 INFO - Output received: 15:11:18 INFO - /builds/slave/test/build/application/firefox/firefox 15:11:18 INFO - Running post-action listener: _resource_record_post_action 15:11:18 INFO - ##### 15:11:18 INFO - ##### Running run-tests step. 15:11:18 INFO - ##### 15:11:18 INFO - Running pre-action listener: _resource_record_pre_action 15:11:18 INFO - Running main action method: run_tests 15:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:11:18 INFO - Python 2.7.3 15:11:18 INFO - Return code: 0 15:11:18 INFO - grabbing minidump binary from tooltool 15:11: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')]} 15:11:18 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 0x1b2b580>, '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 0x1b2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:11:18 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 15:11:18 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 15:11:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:11:18 INFO - Return code: 0 15:11:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:11:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:11:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:11:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:11:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:11:19 INFO - Return code: 0 15:11:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.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 15:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.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 15:11:19 INFO - Using env: {'DISPLAY': ':0', 15:11:19 INFO - 'HOME': '/home/cltbld', 15:11:19 INFO - 'LANG': 'en_US.UTF-8', 15:11:19 INFO - 'LANGUAGE': 'en_US:en', 15:11:19 INFO - 'LOGNAME': 'cltbld', 15:11:19 INFO - 'MAIL': '/var/mail/cltbld', 15:11:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:11:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:19 INFO - 'MOZ_NO_REMOTE': '1', 15:11:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:19 INFO - 'NO_EM_RESTART': '1', 15:11:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:19 INFO - 'PWD': '/builds/slave/test', 15:11:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:11:19 INFO - 'SHELL': '/bin/bash', 15:11:19 INFO - 'SHLVL': '1', 15:11:19 INFO - 'TERM': 'linux', 15:11:19 INFO - 'TMOUT': '86400', 15:11:19 INFO - 'USER': 'cltbld', 15:11:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461363019.995718-2144899226', 15:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:19 INFO - '_': '/tools/buildbot/bin/python'} 15:11:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.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 15:11:20 INFO - mozversion application_buildid: 20160422122844 15:11:20 INFO - mozversion application_changeset: 104bef115f31497dd411582328eef6ed375d0c72 15:11:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:11:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:11:20 INFO - mozversion application_name: Firefox 15:11:20 INFO - mozversion application_remotingname: firefox-dev 15:11:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:11:20 INFO - mozversion application_vendor: Mozilla 15:11:20 INFO - mozversion application_version: 47.0a2 15:11:20 INFO - mozversion platform_buildid: 20160422122844 15:11:20 INFO - mozversion platform_changeset: 104bef115f31497dd411582328eef6ed375d0c72 15:11:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:11:20 INFO - mozversion platform_version: 47.0a2 15:11:20 INFO - using testdate: 1461363080 15:11:20 INFO - actual date: 1461363080 15:11:20 INFO - starting webserver on 'localhost:36210' 15:11:20 INFO - SUITE-START | Running 2 tests 15:11:20 INFO - TEST-START | dromaeo_css 15:11:20 INFO - operating with platform_type : linux_ 15:11:20 INFO - Initialising browser for dromaeo_css test... 15:11:20 INFO - TEST-INFO | started process 14490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiOwmij/profile http://localhost:36210/getInfo.html) 15:11:24 INFO - PROCESS | 14490 | __metrics Screen width/height:1600/1200 15:11:24 INFO - PROCESS | 14490 | colorDepth:24 15:11:24 INFO - PROCESS | 14490 | Browser inner width/height: 1024/697 15:11:24 INFO - PROCESS | 14490 | __metrics 15:11:25 INFO - PROCESS | 14490 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:11:26 INFO - TEST-INFO | 14490: exit 0 15:11:26 INFO - Browser initialized. 15:11:26 INFO - Running cycle 1/1 for dromaeo_css test... 15:11:26 INFO - TEST-INFO | started process 14579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiOwmij/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:38 INFO - PROCESS | 14579 | RSS: Main: 141955072 15:11:38 INFO - PROCESS | 14579 | 15:12:29 INFO - PROCESS | 14579 | 1461363149192 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] 15:14:36 INFO - PROCESS | 14579 | Cycle 1(1): loaded http://localhost:36210/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36210/tests/dromaeo/cssquery-ext.html) 15:14:37 INFO - PROCESS | 14579 | RSS: Main: 256892928 15:14:37 INFO - PROCESS | 14579 | 15:17:39 INFO - PROCESS | 14579 | Cycle 1(1): loaded http://localhost:36210/tests/dromaeo/cssquery-ext.html (next: http://localhost:36210/tests/dromaeo/cssquery-jquery.html) 15:17:40 INFO - PROCESS | 14579 | RSS: Main: 221040640 15:17:40 INFO - PROCESS | 14579 | 15:20:42 INFO - PROCESS | 14579 | Cycle 1(1): loaded http://localhost:36210/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36210/tests/dromaeo/cssquery-mootools.html) 15:20:42 INFO - PROCESS | 14579 | RSS: Main: 217939968 15:20:42 INFO - PROCESS | 14579 | 15:23:44 INFO - PROCESS | 14579 | Cycle 1(1): loaded http://localhost:36210/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36210/tests/dromaeo/cssquery-prototype.html) 15:23:45 INFO - PROCESS | 14579 | RSS: Main: 194048000 15:23:45 INFO - PROCESS | 14579 | 15:26:47 INFO - PROCESS | 14579 | Cycle 1(1): loaded http://localhost:36210/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36210/tests/dromaeo/cssquery-yui.html) 15:26:48 INFO - PROCESS | 14579 | RSS: Main: 210980864 15:26:48 INFO - PROCESS | 14579 | 15:29:50 INFO - PROCESS | 14579 | Cycle 1(1): loaded http://localhost:36210/tests/dromaeo/cssquery-yui.html (next: http://localhost:36210/tests/dromaeo/cssquery-dojo.html) 15:29:50 INFO - PROCESS | 14579 | RSS: Main: 243343360 15:29:50 INFO - PROCESS | 14579 | 15:29:50 INFO - PROCESS | 14579 | __start_tp_report 15:29:50 INFO - PROCESS | 14579 | _x_x_mozilla_page_load 15:29:50 INFO - PROCESS | 14579 | _x_x_mozilla_page_load_details 15:29:50 INFO - PROCESS | 14579 | |i|pagename|runs| 15:29:50 INFO - PROCESS | 14579 | |0;dojo.html;3262.722668573171;3342.2312868040335;3342.8829990950308;3357.513160591714;3391.762576619636;5375.48932851379;5420.620556561043;5422.674639521631;5423.972880135599;5484.561235101192;5417.052015897222;5420.647657902234;5456.372517160527;5459.535939445152;5460.453954604538;4829.203181475053;4931.654784165119;4988.775505102261;5015.498450154992;5050.7979680812905;4876.195427754434;4892;4951.900961980758;4961.08219979305;4964.578010869062;4912.263160525932;4976.154053810861;5020.949790502103;5049.798008079672;5057.291979122926;5043.67216130954;5048.242763585455;5058.671186372874;5061.139606266944;5092.643514953937;4558.459822511019;4868.561829435333;4916;4918.8278410255825;4975.477574854624;5313.335833020872;5319.441458646825;5319.893602127974;5326.893462130774;5335.0663633863915;5656.830295091154;5816.680082595455;5843.444872737083;5844.6785426801935;5886.440788125121;5917.763289468416;5954.106883967396;5956.047032474783;5967.701614919237;6003.609765365237;5486.561075113981;5518.806841760599;5518.889622207574;5518.944810551883;5521.696306703129;5797.391273916178;5940.554458415636;5971.5222782177325;5997.010493268649;6059.1820104286235;5764.221830052973;5769.942300577024;5770.826875193751;5771.884562308815;5772.913406298909;5860.413958604191;5862.296524417097;5863.912041319383;5866.266716660418;5866.472017518444;5665.745041473144;5815.854603634943;5825.4174582542255;5905.173275741399;5907.586468947218;5886.676232807236;5907.675077870673;5908.527317814564;5915.37888521699;5917;4493.191225579361;4506.729596224237;4506.864794056183;4516.299973504112;4535.909281814345;3923.156521347924;4018.3369743991916;4070.6539944105084;4081.89795255121;4111.09555897702;5578.721063946787;5583.720813959286;5592.440755924375;5610.523105535994;5620.606557540933;5693.202951586781;5856.502197313276;5900.852478687982;5919.230500034968;5924.259467566554;5466.262054622654;5503.752331145108;5543.251661025791;5565.9721701392045;5605.80379686709;5079.619028572872;5097.923531147036;5099.082165210223;5101.489851014869;5128.9230661540105;5857.7949771757785;6055.364186760415;6101.60339577926;6102.176206212104;6103.755849765959;5808.390119037609;5845.590808643354;5849.590528662953;5853.268341457318;5854.531637469077;6034.39656034393;6039.818805435844;6043.576949613484;6046.606970546901;6047.365026672136;5652.3217213934595;5732.856678583069;5753.021986262429;5789.478946894799;5838.474537291664;5911.822645320647;5929.673867937305;5933.940660593339;5935.940640593539;5942.465178133989;5713.153724247194;5733.770649173986;5779.508741756998;5780.277465316835;5795.884082318415;5557.888842223052;5740.913886291625;5780.393058728773;5798.942010580009;5831.387704290988;5626.1842032905815;5642.915356269577;5644.0687286598895;5656.632318899258;5659.094544872801;5776.624519406225;5783.219265399285;5784.132380143013;5785.623934444247;5788.102844059177;5455.618106732491;5455.645383050089;5639.069553523786;5710.771569137188;5734.139879018181 15:29:50 INFO - PROCESS | 14579 | |1;ext.html;546.6801920876287;550.2516577454661;554.5037191713419;559.6586082489681;593.7951406764664;30448.238794030134;38653.80673096634;39118.80440597793;39149.02127446812;39154.80422597883;41849.16301673972;42344.576554234445;42404;42424.36363454543;42436.787816060954;8777.561121943892;8992.77518062047;8992.820143597124;8993.865092023592;8994.640214391417;8647.178518040777;8758.211760941515;8765.03584605696;8783.780405489882;9000.369974101815;9004.729858104267;9037.41256818308;9045.231155351803;9062.546872656341;9083.454992700426;8949.910500895005;9006.59470323837;9020.09799020096;9029.954850225708;9033.187013168847;8872.245859101984;9112.635494580209;9113.772155696095;9125.863112053325;9134.497602631853;41087.383689244685;41552;41599.58400415987;41646.37530437046;41671.374929376085;3716.8141592920247;3724.5158129443;3767.7550959187565;3785.867494637702;3821.503204583414;30069.69930300691;31567.210819729462;31608.525872111935;31680.524792128137;32641.020769376955;3538.2569660371355;3688.589855880241;3695.593484716679;3725.3853114236117;3785.261873934584;219799;220680;221429;280528;282697;43643.56356436459;44159.33760993588;60901.39098608957;61684.38315616876;61752.38247617556;42325.57674423278;42341.36487952683;42404.57595424068;42410;42502.57497425048;16200.189990500428;16272.918635406984;16288.755668664979;16299.592510187103;16348.591285217964;13205.33973301331;13210.801837972438;13263.535776247785;13341.066125371324;13342.19946803195;15311.540653780405;15348.386064557517;15356.308966096552;15356.846431535765;15406.075635461908;5661.943380566224;5714.79998200061;5791.826245212566;5793.536517078708;5818.418158184148;1010.6816352848829;1028.8508166315842;1105.8838821923744;1106.7067227184803;1200.1299058182922;29139.417211655647;29209.24744515336;29256.85371573171;30141.547876781864;30267.243318917204;1078.9244752867223;1098.0940723902813;1165.854268216473;1197.0423661071109;1217.6834023154045;15496.147711875956;15617.765733514007;15689.529314120595;15715.68568628621;15959.04245745259;338225;340007;343124;343558;343606;55672.72163639156;56534;56565.43434565602;56597.43402566004;56601;1269.7650934577132;1294.9223046617233;1418.8368337641098;1460.8393076761547;1482.3625840888305;26532.336691582866;26969.190924272305;26992.46015079648;27022.32444188911;27554.724452755217;41095.7945210272;41404.378934315406;41522;41543.792281038404;41548.37677434902;178964;180604.09697951426;180766;182376;182594;28874.42251154923;32542.186445339055;32990.67009329876;33676.663233367355;33854.830725846216;39484.210315794095;39665.40501892416;40073.39889901712;40469.797651012734;41028.17943641051;34617.480737789454;35852.64147358597;37087.629123708415;37263.44104838376;37473;36152.27695446129;36314.4552831713;36594.45108323431;36624.45063323999;36994.8150259247;35968;36776.44835327419;37277.440838387985;37506;37603;32156.51765223477;33634.327313453105;33691.83154084214;33775.66224337725;33910.491342629386;25535.744642553338;25640.743592563835;25963.22110336693;26114.086006990423;26193.869030654725 15:29:50 INFO - PROCESS | 14579 | |2;jquery.html;344.4953143644561;383.32917394559536;389.67267495303946;390.33837645191414;392.7878945369497;17152.313907443702;17951.371701990432;19056.809431905676;19060.523486912833;19210.615787684237;17096.743548846745;17099.31602735889;17623.295068197258;17663.82336176638;17700.203490842912;5621.8032368867;5802.680852553108;5823.12653102036;5835.153902684108;5835.474807267345;4270.871873843789;5719.59962802604;6021.277446706401;6256.37436256373;6294.055891616271;6186.226721659793;6221.440070393686;6245.843853903643;6254.874902501947;6259.499240060807;6011.458968692817;6278.748850045993;6289.276733175652;6293.55945083842;6293.590916590407;3854.710896682732;5332.573394128461;5535.335759708821;5539.196816461631;5552.611317207797;19637.116329765195;19773.110210040584;19930.70103948442;20083;20149.697754533692;2420.298113547069;2625.789936805051;2726.4001919577663;2755.586662000716;2861.9427611447863;12602.747945041048;13123.54067607629;13173.209607423585;13339.466421343135;13341.53304634343;1955.4915721912264;1960.372680742163;2000.3198912369865;2002.6595478768645;2096.6016456873144;62966.37033629651;64778.3522164777;64887.35112648908;64903;64932.3506764931;10359.533820978075;10469.476526173661;10475.738106547245;10476.952304769462;10530.420826854597;14722.190279534729;14832.81337492998;14841.480548180762;14848.703025939421;14853.628659283604;7699.884501732478;7889;7974.641141148662;8036;8042.798930026796;7628.694852205849;7685.654145563463;7713.807154821062;7743.225677432211;7800.609969501502;4613;4634.420697412824;4641.976790116096;4673.976630116827;4707.929381059287;1835.4952388093382;1851.5833937364255;1853.490290170187;1964.1946801811189;2007.959840803205;942.3921570586933;970.4419958523877;974.4104816585864;1020.698893826323;1026.6817286641017;14889;16000.959937604252;16963.660726785394;17156.142192890307;17322;937.2267878999852;965.7537327981461;1008.6167256442504;1014.0771897573173;1032.7056788815153;9707.029297070236;9821.754456138511;9833.115019648123;9893.15908147801;10018.3488073275;383038;386397;387791;388872;411482;71851.28148718446;74606;74708.25291747121;75180;75458.62270688612;1039.4542864995938;1043.9739006524899;1055.456439933435;1055.6780182044397;1067.6690226029955;15213.239338033276;15390.615234619225;15481.225938703245;15495.612609684396;15863.286152123414;33566.664333356355;33780;34749.305013900084;35187.94436166919;35192.64807351894;46185.53814461813;49832.501674982785;49871;50059.249111264086;50150.74924625354;8358.623861926106;8592.742217733477;8602.096779838277;8772.517511536927;8862.158094980967;12402;12581.433835477608;12628.810567841307;12633;12696.74606507883;5277.577793776565;10796.056709792312;11547.8267825981;11696.649100526998;11796.174267801172;11429.885701143216;11665.72687488466;11667;11692.240004399688;11826.704332391759;11047.281926674741;11393.601223957121;11466.598669046543;11653.76692466163;11713.355765432641;8222.17778222173;8355.83288334242;8753.693620723245;8794.42836215644;8836.160564746338;9198.172164505228;10974.670759877217;11400.771984560428;11605.419729013347;11654.941725291319 15:29:50 INFO - PROCESS | 14579 | |3;mootools.html;1456.9635759106015;1585.9207039648015;1597.2732406754924;1752.2552915011117;1835.908204589771;7557.622118894061;8199.71301004465;8328.208820162075;8329.167083291675;8330.583470826465;8293.460925039868;8447.873281900776;8456.83086338273;8461.153884611536;8462.788430289245;2165.545235500547;2362.29131260622;2432.8783560821976;2477.6407420924;2505.949881002379;2464.852108873464;2505.2985164154065;2505.8747062646794;2512.962305565418;2513.836600620954;2460.5324988252173;2481.751824817513;2482.453860150773;2484.1057219401;2486.2292689266296;2354.223106374901;2416.226807421626;2423.5637585234826;2427.2475532584954;2435.099013365066;2429.854208747463;2441.963370549443;2461.064795377763;2473.9134130305533;2474.2206205045354;8650.178233067849;8712.303015758724;8714.869276960851;8723.040465548784;8723.38936274461;5282.022825777243;5344.732763361816;5404.054290499186;5414.756335964891;5415.539679127279;3248.545203671488;3319.867205311785;3329.900102996914;3334.4498157803932;3339.081752518077;1020.1226944827442;1029.3978022856638;1030.0626429948786;1037.5123691864812;1037.7924415116931;12132.454039568152;12169.817452738216;12224.14430989831;12237.510499580007;12246.142770006103;4665.160271151225;4694.741789201558;4757.215059515211;4777.402824646919;4777.9044419112115;10246.846297305547;10280.485975701185;10294.742631434274;10305.124064454456;10307.84538231927;4637.791299391535;5327.174287985368;5385.272988146628;5392.973035134799;5394.217838413408;4732.550407711262;4818.445878723992;4823.324734537167;4827;4845.927311090337;3792.4500947362476;3844.308024555551;3878.941815872764;3933.4689816874356;3946.131850992777;1180.8819118088122;1182.43243243242;1186.4364426897155;1194.5042807235075;1273.3442277227236;1434.7058852935124;1443.4875619155048;1453.2370505484705;1469.353484466831;1473.2707309881678;8020.238077382639;8041.477303975223;8065.354771618257;8082.19178082187;8090.433669643068;490.60996507776406;498.7057635994781;503.2602074949818;503.8916632923939;506.4530307268142;6280.5289603279025;6284.874302514016;6303.432691057827;6341.524385671001;6394.808155755335;10328.845067323997;10707.304025238334;10709.303895246783;10876.075533579577;10877.292975956696;10423.895761042444;10554.47227638615;10633;10660.733481663021;10692.251542392114;8223.95888020556;8325.8334833303;8327.375446841512;8411.579421028924;8413.873791893126;7935.603219838869;7958.0848202455145;7960.601969901366;8046.275835174863;8083.474574152661;9403.764905877135;9409.200217981275;9412.717618471457;9475.099865512766;9507.572159252712;9671.371360861522;9747.658831940847;9824.754381140528;9850.359726617748;9985.251106166921;6482;6961.79114626562;7215.71137154508;7232.927670723226;7288.817779555554;8183.468074575134;8189.918100819154;8200.917990820015;8214.917850821415;8268.131846156308;7329.74345897891;7499.362554182955;7517.436192285491;7611.467197296136;7666.655000524878;7016.26329235423;7370.705171793068;7371.668274927749;7446.7021319146625;7468.477206595703;7965.681372745025;7970.043594768433;8000.119986801331;8006.95996520037;8013.439059265796;7144.64276786169;7162.427005839416;7306.3789577884345;7358;7362.852742945218;7227.674754635948;7232.710691572278;7280.672369743268;7287.2348403419;7290.088738907637 15:29:50 INFO - PROCESS | 14579 | |4;prototype.html;345.5939271356156;351.89267273481596;352.4237871080784;354.3762977160199;355.53247479564374;6021.42796434338;6073.362296958817;6082.72627731752;6082.756689732411;6090.056041313604;6007.15899774032;6016.398360163981;6017.488513476349;6021.337652858182;6028.879422411549;4486.97756511217;4604.562566556172;4679.8596042118625;4705.411823522059;4732.692374995631;4682.882927926795;4708.058388322332;4712.599429048535;4723.763811809413;4726.385569875912;4671.135839869635;4676.3920690310215;4677.158111539921;4683.203855344583;4695.8356457524;4508.864734057984;4587.839425620121;4642;4658.091672123937;4680.625549956029;4123.0516981094515;4126.112885729583;4134.545200027995;4135.545090040093;4140.896477588054;5701.629394089371;5706.457886500776;5715.657060576379;5723.084306510938;5723.427657234285;5458.990086833948;5459.918101228484;5470.425605311425;5477.698726570037;5517.641353312022;6377.553571250014;6379.138816259839;6380.361963803629;6382.457491113261;6383.904241436382;4428.225060614412;4551.203539380628;4558.247889098295;4586.197415452316;4619.63042956566;6580.703868325937;6632.801015969529;6649.6010239385305;6670.699818508178;6672.099266598995;4737.810487580458;4739.549742774431;4748.881277968009;4752.1683705351425;4764.6426518011285;4842.789302674331;4846;4846.055019271279;4847.442544107473;4848;5470.425605311465;5489.4236105209175;5491.752871120809;5493.972530137404;5497.8075767348755;6280.842978925563;6438.549301548846;6461.838454038687;6472.288048314682;6480.222373315232;1685.9157042147845;1704.1479260369815;1719.5787032177197;1721.672882152387;1721.9225134868962;1100.6422912553292;1149.9827502587468;1150.7871043856912;1158.9304641721524;1179.722765150189;6118.969405152946;6126.754929802847;6128.3565225651555;6135.355787642234;6140.416660417253;6513.934860651428;6546.443552298013;6560.081588577603;6563.638999855054;6582.736690532325;6170.228721409824;6175.135481032659;6178.073289006685;6189.381061893865;6201.534884883652;3543.0965103898343;3570.8571657133425;3570.9285814283567;3574.4280915053987;3577.373959557067;6792.830179245559;6825.385715285648;6963.442924566022;6992.79021629352;7006.369426751617;6941.68762405693;6966.164060312795;6966.860662786818;6983.022376867242;6983.2318444971015;6979.162500499972;6984.057152284377;6988.860222795515;7004.229534751174;7037.472189585802;6703.899441508283;6710.765123220664;6721.697523611351;6725.058491811248;6735.4274886635185;6451.41937225652;6571.474282057519;6590.9670451647435;6596.70314835824;6616.073749674953;6946.5137440378685;6962.582245065312;6983.511154219156;6984.965075174591;6988.895166572607;4535;4552.567506086916;4553.430821147356;4557.977210113928;4561.977190114028;6716.529842910949;6723.966380168068;6735.6295403753265;6738.59568425896;6745.662716864039;6330.303666596578;6503.089567460464;6504.902426463512;6520.054592084027;6520.836979075371;6410.775622853178;6434.388733070538;6460.35396460369;6471.06169605414;6531.934680653133;6384.776532821329;6391.265004524539;6401.839954001187;6407.487401008001;6409.615423074631;6520.9347906520325;6521.902171467526;6524.380183882524;6525;6539.0191471277785;6062.757489700362;6145.9692701538;6381.8085457436355;6404.423601875854;6414.422701956846 15:29:50 INFO - PROCESS | 14579 | |5;yui.html;740.3891789273848;770.1489853711648;798.161929973528;827.230675471811;847.2036285891262;13221.867781322184;13376.531821386254;13419.731605367899;13429.261390623511;13442.126261792977;13857.376418061187;13878.861211387908;13880.16718996861;13914;13972;774.3302043732159;895.8253140637578;904.7104926423547;908.2280061947325;909.5997760985179;907.8774365460645;912.333996182787;913.7578541686458;913.995430022849;914.0950459045564;961.8076384723048;969.830279701053;970.2626004236796;970.3692599810145;971.3686104032365;778.5562229529171;791.877259024852;945.8392073347547;963.2775418436173;965.0638880286111;703.5110598134298;703.6657587645878;703.954242974205;707.9946476004087;708.3235510087853;13095.279759613217;13156.144850584682;13158.14472059313;13167.078304518687;13180.406881690347;12537.498500059986;12886;13012.934935325262;13052.477900883954;13318.667033324147;11038.227324087316;11059.447027648666;11111.777764444747;11306.886931130666;11336.829947550794;3716.9070773230615;3725.981370093132;3758.342290099222;3819.7708137511836;3852.9614703852885;44040.55959440397;44380;49611.50388496105;52022.99999999962;52096.73951630218;10388.636397726195;10431.739206519898;10675.893241067646;10714.41070741101;10840.186985975926;17093.743593846102;17281.39515116965;17287.308507659553;17348.045857477708;17448.563785905455;7637.4653774236385;7791.0650721913735;7983.1578947368425;8085.514869107872;8144;4175.290200665894;4192.91614167721;4336.653067754635;4354.9782251088545;4516.728996260169;3355.5302257683943;3388.203772113551;3393.2025973896116;3398.0145757730475;3398.303347813692;622.6202016769766;630.7224821078711;640.8814369341686;641.2241188162283;653.0856800479272;614.8186285045922;647.1037612906065;674.4233680203356;679.5175425447889;711.0578483509371;7939.6824127035425;7981.48120372174;8195.385346099067;8262.8347433051;8554.315654747605;537.7633841109899;594.0406243916044;623.4700504571078;683.402023229674;699.8600279944031;3750.212455384345;3896.7272290939927;3966.3257246268204;4047.514298284225;4113.979430102891;54731.45268547343;55202.44797552053;55637.44362556404;55741;56427;50383.24425133626;50619;52237.21644175341;53126;53196;45875.77062114601;46385.07229855384;46921.5307846924;47285;47494.287585686245;8353;8493.193146651058;8812.339074569305;8844.690435834715;8888.866666999871;35681;36099.27801443904;36394.8180259097;37144.814275928446;37474.8126259367;46515.302270466644;46713;46738.532614673415;47648.761756190994;47779.28331074967;11093.778124437627;11341.829872551752;11528.250663706833;11544.769104617693;11834.467448964646;11316.15128865355;11516.136289778467;11624.070074394198;11668.591599293984;11669.941650291694;11423.143264255048;11731.589394371156;11835.881641183478;12158.75682486363;12188.451519681814;11105.500252488819;11346.375949322866;11359.375234362189;11764.35296058725;11927.582534611247;11001.394923279297;11052.723681908017;11396;11635.418229088342;11977.820332695192;9828.901710982798;9986.709701917496;10053.04496072872;10063.849042264226;10535.525901334611;9077.500737459502;9193.862092068759;9300.302477314364;9644.18024467928;9763.560639771085 15:29:50 INFO - PROCESS | 14579 | __end_tp_report 15:29:50 INFO - PROCESS | 14579 | __start_cc_report 15:29:50 INFO - PROCESS | 14579 | _x_x_mozilla_cycle_collect,903 15:29:50 INFO - PROCESS | 14579 | __end_cc_report 15:29:50 INFO - PROCESS | 14579 | __startTimestamp1461364190978__endTimestamp 15:29:50 INFO - PROCESS | 14579 | 15:29:50 INFO - PROCESS | 14579 | ------- Summary: start ------- 15:29:50 INFO - PROCESS | 14579 | Number of tests: 6 15:29:50 INFO - PROCESS | 14579 | 15:29:50 INFO - PROCESS | 14579 | [#0] dojo.html Cycles:165 Average:5446.24 Median:5652.32 stddev:599.58 (10.6%) stddev-sans-first:576.43 15:29:50 INFO - PROCESS | 14579 | Values: 3262.7 3342.2 3342.9 3357.5 3391.8 5375.5 5420.6 5422.7 5424.0 5484.6 5417.1 5420.6 5456.4 5459.5 5460.5 4829.2 4931.7 4988.8 5015.5 5050.8 4876.2 4892.0 4951.9 4961.1 4964.6 4912.3 4976.2 5020.9 5049.8 5057.3 5043.7 5048.2 5058.7 5061.1 5092.6 4558.5 4868.6 4916.0 4918.8 4975.5 5313.3 5319.4 5319.9 5326.9 5335.1 5656.8 5816.7 5843.4 5844.7 5886.4 5917.8 5954.1 5956.0 5967.7 6003.6 5486.6 5518.8 5518.9 5518.9 5521.7 5797.4 5940.6 5971.5 5997.0 6059.2 5764.2 5769.9 5770.8 5771.9 5772.9 5860.4 5862.3 5863.9 5866.3 5866.5 5665.7 5815.9 5825.4 5905.2 5907.6 5886.7 5907.7 5908.5 5915.4 5917.0 4493.2 4506.7 4506.9 4516.3 4535.9 3923.2 4018.3 4070.7 4081.9 4111.1 5578.7 5583.7 5592.4 5610.5 5620.6 5693.2 5856.5 5900.9 5919.2 5924.3 5466.3 5503.8 5543.3 5566.0 5605.8 5079.6 5097.9 5099.1 5101.5 5128.9 5857.8 6055.4 6101.6 6102.2 6103.8 5808.4 5845.6 5849.6 5853.3 5854.5 6034.4 6039.8 6043.6 6046.6 6047.4 5652.3 5732.9 5753.0 5789.5 5838.5 5911.8 5929.7 5933.9 5935.9 5942.5 5713.2 5733.8 5779.5 5780.3 5795.9 5557.9 5740.9 5780.4 5798.9 5831.4 5626.2 5642.9 5644.1 5656.6 5659.1 5776.6 5783.2 5784.1 5785.6 5788.1 5455.6 5455.6 5639.1 5710.8 5734.1 15:29:50 INFO - PROCESS | 14579 | 15:29:50 INFO - PROCESS | 14579 | [#1] ext.html Cycles:180 Average:42678.23 Median:3692.09 stddev:69321.89 (1877.6%) stddev-sans-first:69444.18 15:29:50 INFO - PROCESS | 14579 | Values: 546.7 550.3 554.5 559.7 593.8 30448.2 38653.8 39118.8 39149.0 39154.8 41849.2 42344.6 42404.0 42424.4 42436.8 8777.6 8992.8 8992.8 8993.9 8994.6 8647.2 8758.2 8765.0 8783.8 9000.4 9004.7 9037.4 9045.2 9062.5 9083.5 8949.9 9006.6 9020.1 9030.0 9033.2 8872.2 9112.6 9113.8 9125.9 9134.5 41087.4 41552.0 41599.6 41646.4 41671.4 3716.8 3724.5 3767.8 3785.9 3821.5 30069.7 31567.2 31608.5 31680.5 32641.0 3538.3 3688.6 3695.6 3725.4 3785.3 219799.0 220680.0 221429.0 280528.0 282697.0 43643.6 44159.3 60901.4 61684.4 61752.4 42325.6 42341.4 42404.6 42410.0 42502.6 16200.2 16272.9 16288.8 16299.6 16348.6 13205.3 13210.8 13263.5 13341.1 13342.2 15311.5 15348.4 15356.3 15356.8 15406.1 5661.9 5714.8 5791.8 5793.5 5818.4 1010.7 1028.9 1105.9 1106.7 1200.1 29139.4 29209.2 29256.9 30141.5 30267.2 1078.9 1098.1 1165.9 1197.0 1217.7 15496.1 15617.8 15689.5 15715.7 15959.0 338225.0 340007.0 343124.0 343558.0 343606.0 55672.7 56534.0 56565.4 56597.4 56601.0 1269.8 1294.9 1418.8 1460.8 1482.4 26532.3 26969.2 26992.5 27022.3 27554.7 41095.8 41404.4 41522.0 41543.8 41548.4 178964.0 180604.1 180766.0 182376.0 182594.0 28874.4 32542.2 32990.7 33676.7 33854.8 39484.2 39665.4 40073.4 40469.8 41028.2 34617.5 35852.6 37087.6 37263.4 37473.0 36152.3 36314.5 36594.5 36624.5 36994.8 35968.0 36776.4 37277.4 37506.0 37603.0 32156.5 33634.3 33691.8 33775.7 33910.5 25535.7 25640.7 25963.2 26114.1 26193.9 15:29:50 INFO - PROCESS | 14579 | 15:29:50 INFO - PROCESS | 14579 | [#2] jquery.html Cycles:180 Average:24546.35 Median:17062.25 stddev:64361.27 (377.2%) stddev-sans-first:64516.17 15:29:50 INFO - PROCESS | 14579 | Values: 344.5 383.3 389.7 390.3 392.8 17152.3 17951.4 19056.8 19060.5 19210.6 17096.7 17099.3 17623.3 17663.8 17700.2 5621.8 5802.7 5823.1 5835.2 5835.5 4270.9 5719.6 6021.3 6256.4 6294.1 6186.2 6221.4 6245.8 6254.9 6259.5 6011.5 6278.7 6289.3 6293.6 6293.6 3854.7 5332.6 5535.3 5539.2 5552.6 19637.1 19773.1 19930.7 20083.0 20149.7 2420.3 2625.8 2726.4 2755.6 2861.9 12602.7 13123.5 13173.2 13339.5 13341.5 1955.5 1960.4 2000.3 2002.7 2096.6 62966.4 64778.4 64887.4 64903.0 64932.4 10359.5 10469.5 10475.7 10477.0 10530.4 14722.2 14832.8 14841.5 14848.7 14853.6 7699.9 7889.0 7974.6 8036.0 8042.8 7628.7 7685.7 7713.8 7743.2 7800.6 4613.0 4634.4 4642.0 4674.0 4707.9 1835.5 1851.6 1853.5 1964.2 2008.0 942.4 970.4 974.4 1020.7 1026.7 14889.0 16001.0 16963.7 17156.1 17322.0 937.2 965.8 1008.6 1014.1 1032.7 9707.0 9821.8 9833.1 9893.2 10018.3 383038.0 386397.0 387791.0 388872.0 411482.0 71851.3 74606.0 74708.3 75180.0 75458.6 1039.5 1044.0 1055.5 1055.7 1067.7 15213.2 15390.6 15481.2 15495.6 15863.3 33566.7 33780.0 34749.3 35187.9 35192.6 46185.5 49832.5 49871.0 50059.2 50150.7 8358.6 8592.7 8602.1 8772.5 8862.2 12402.0 12581.4 12628.8 12633.0 12696.7 5277.6 10796.1 11547.8 11696.6 11796.2 11429.9 11665.7 11667.0 11692.2 11826.7 11047.3 11393.6 11466.6 11653.8 11713.4 8222.2 8355.8 8753.7 8794.4 8836.2 9198.2 10974.7 11400.8 11605.4 11654.9 15:29:50 INFO - PROCESS | 14579 | 15:29:50 INFO - PROCESS | 14579 | [#3] mootools.html Cycles:180 Average:6029.82 Median:2894.24 stddev:3223.99 (111.4%) stddev-sans-first:3214.71 15:29:50 INFO - PROCESS | 14579 | Values: 1457.0 1585.9 1597.3 1752.3 1835.9 7557.6 8199.7 8328.2 8329.2 8330.6 8293.5 8447.9 8456.8 8461.2 8462.8 2165.5 2362.3 2432.9 2477.6 2505.9 2464.9 2505.3 2505.9 2513.0 2513.8 2460.5 2481.8 2482.5 2484.1 2486.2 2354.2 2416.2 2423.6 2427.2 2435.1 2429.9 2442.0 2461.1 2473.9 2474.2 8650.2 8712.3 8714.9 8723.0 8723.4 5282.0 5344.7 5404.1 5414.8 5415.5 3248.5 3319.9 3329.9 3334.4 3339.1 1020.1 1029.4 1030.1 1037.5 1037.8 12132.5 12169.8 12224.1 12237.5 12246.1 4665.2 4694.7 4757.2 4777.4 4777.9 10246.8 10280.5 10294.7 10305.1 10307.8 4637.8 5327.2 5385.3 5393.0 5394.2 4732.6 4818.4 4823.3 4827.0 4845.9 3792.5 3844.3 3878.9 3933.5 3946.1 1180.9 1182.4 1186.4 1194.5 1273.3 1434.7 1443.5 1453.2 1469.4 1473.3 8020.2 8041.5 8065.4 8082.2 8090.4 490.6 498.7 503.3 503.9 506.5 6280.5 6284.9 6303.4 6341.5 6394.8 10328.8 10707.3 10709.3 10876.1 10877.3 10423.9 10554.5 10633.0 10660.7 10692.3 8224.0 8325.8 8327.4 8411.6 8413.9 7935.6 7958.1 7960.6 8046.3 8083.5 9403.8 9409.2 9412.7 9475.1 9507.6 9671.4 9747.7 9824.8 9850.4 9985.3 6482.0 6961.8 7215.7 7232.9 7288.8 8183.5 8189.9 8200.9 8214.9 8268.1 7329.7 7499.4 7517.4 7611.5 7666.7 7016.3 7370.7 7371.7 7446.7 7468.5 7965.7 7970.0 8000.1 8007.0 8013.4 7144.6 7162.4 7306.4 7358.0 7362.9 7227.7 7232.7 7280.7 7287.2 7290.1 15:29:50 INFO - PROCESS | 14579 | 15:29:50 INFO - PROCESS | 14579 | [#4] prototype.html Cycles:180 Average:5426.53 Median:6104.51 stddev:1616.14 (26.5%) stddev-sans-first:1575.04 15:29:50 INFO - PROCESS | 14579 | Values: 345.6 351.9 352.4 354.4 355.5 6021.4 6073.4 6082.7 6082.8 6090.1 6007.2 6016.4 6017.5 6021.3 6028.9 4487.0 4604.6 4679.9 4705.4 4732.7 4682.9 4708.1 4712.6 4723.8 4726.4 4671.1 4676.4 4677.2 4683.2 4695.8 4508.9 4587.8 4642.0 4658.1 4680.6 4123.1 4126.1 4134.5 4135.5 4140.9 5701.6 5706.5 5715.7 5723.1 5723.4 5459.0 5459.9 5470.4 5477.7 5517.6 6377.6 6379.1 6380.4 6382.5 6383.9 4428.2 4551.2 4558.2 4586.2 4619.6 6580.7 6632.8 6649.6 6670.7 6672.1 4737.8 4739.5 4748.9 4752.2 4764.6 4842.8 4846.0 4846.1 4847.4 4848.0 5470.4 5489.4 5491.8 5494.0 5497.8 6280.8 6438.5 6461.8 6472.3 6480.2 1685.9 1704.1 1719.6 1721.7 1721.9 1100.6 1150.0 1150.8 1158.9 1179.7 6119.0 6126.8 6128.4 6135.4 6140.4 6513.9 6546.4 6560.1 6563.6 6582.7 6170.2 6175.1 6178.1 6189.4 6201.5 3543.1 3570.9 3570.9 3574.4 3577.4 6792.8 6825.4 6963.4 6992.8 7006.4 6941.7 6966.2 6966.9 6983.0 6983.2 6979.2 6984.1 6988.9 7004.2 7037.5 6703.9 6710.8 6721.7 6725.1 6735.4 6451.4 6571.5 6591.0 6596.7 6616.1 6946.5 6962.6 6983.5 6985.0 6988.9 4535.0 4552.6 4553.4 4558.0 4562.0 6716.5 6724.0 6735.6 6738.6 6745.7 6330.3 6503.1 6504.9 6520.1 6520.8 6410.8 6434.4 6460.4 6471.1 6531.9 6384.8 6391.3 6401.8 6407.5 6409.6 6520.9 6521.9 6524.4 6525.0 6539.0 6062.8 6146.0 6381.8 6404.4 6414.4 15:29:50 INFO - PROCESS | 14579 | 15:29:50 INFO - PROCESS | 14579 | [#5] yui.html Cycles:180 Average:13983.04 Median:46130.42 stddev:16052.42 (34.8%) stddev-sans-first:16066.64 15:29:50 INFO - PROCESS | 14579 | Values: 740.4 770.1 798.2 827.2 847.2 13221.9 13376.5 13419.7 13429.3 13442.1 13857.4 13878.9 13880.2 13914.0 13972.0 774.3 895.8 904.7 908.2 909.6 907.9 912.3 913.8 914.0 914.1 961.8 969.8 970.3 970.4 971.4 778.6 791.9 945.8 963.3 965.1 703.5 703.7 704.0 708.0 708.3 13095.3 13156.1 13158.1 13167.1 13180.4 12537.5 12886.0 13012.9 13052.5 13318.7 11038.2 11059.4 11111.8 11306.9 11336.8 3716.9 3726.0 3758.3 3819.8 3853.0 44040.6 44380.0 49611.5 52023.0 52096.7 10388.6 10431.7 10675.9 10714.4 10840.2 17093.7 17281.4 17287.3 17348.0 17448.6 7637.5 7791.1 7983.2 8085.5 8144.0 4175.3 4192.9 4336.7 4355.0 4516.7 3355.5 3388.2 3393.2 3398.0 3398.3 622.6 630.7 640.9 641.2 653.1 614.8 647.1 674.4 679.5 711.1 7939.7 7981.5 8195.4 8262.8 8554.3 537.8 594.0 623.5 683.4 699.9 3750.2 3896.7 3966.3 4047.5 4114.0 54731.5 55202.4 55637.4 55741.0 56427.0 50383.2 50619.0 52237.2 53126.0 53196.0 45875.8 46385.1 46921.5 47285.0 47494.3 8353.0 8493.2 8812.3 8844.7 8888.9 35681.0 36099.3 36394.8 37144.8 37474.8 46515.3 46713.0 46738.5 47648.8 47779.3 11093.8 11341.8 11528.3 11544.8 11834.5 11316.2 11516.1 11624.1 11668.6 11669.9 11423.1 11731.6 11835.9 12158.8 12188.5 11105.5 11346.4 11359.4 11764.4 11927.6 11001.4 11052.7 11396.0 11635.4 11977.8 9828.9 9986.7 10053.0 10063.8 10535.5 9077.5 9193.9 9300.3 9644.2 9763.6 15:29:50 INFO - PROCESS | 14579 | -------- Summary: end -------- 15:29:50 INFO - PROCESS | 14579 | 15:29:51 INFO - TEST-INFO | 14579: exit 0 15:29:51 INFO - TEST-OK | dromaeo_css | took 1111527ms 15:29:51 INFO - TEST-START | kraken 15:29:51 INFO - operating with platform_type : linux_ 15:29:51 INFO - Initialising browser for kraken test... 15:29:51 INFO - TEST-INFO | started process 14774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmped1wfR/profile http://localhost:36210/getInfo.html) 15:29:55 INFO - PROCESS | 14774 | __metrics Screen width/height:1600/1200 15:29:55 INFO - PROCESS | 14774 | colorDepth:24 15:29:55 INFO - PROCESS | 14774 | Browser inner width/height: 1024/697 15:29:55 INFO - PROCESS | 14774 | __metrics 15:29:56 INFO - PROCESS | 14774 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:29:57 INFO - TEST-INFO | 14774: exit 0 15:29:57 INFO - Browser initialized. 15:29:57 INFO - Running cycle 1/1 for kraken test... 15:29:57 INFO - TEST-INFO | started process 14863 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmped1wfR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:30:09 INFO - PROCESS | 14863 | RSS: Main: 142131200 15:30:09 INFO - PROCESS | 14863 | 15:30:11 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36210/tests/kraken/driver.html?testName=audio-beat-detection) 15:30:12 INFO - PROCESS | 14863 | RSS: Main: 177864704 15:30:12 INFO - PROCESS | 14863 | 15:30:15 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36210/tests/kraken/driver.html?testName=audio-dft) 15:30:15 INFO - PROCESS | 14863 | RSS: Main: 175816704 15:30:15 INFO - PROCESS | 14863 | 15:30:18 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36210/tests/kraken/driver.html?testName=audio-fft) 15:30:19 INFO - PROCESS | 14863 | RSS: Main: 171945984 15:30:19 INFO - PROCESS | 14863 | 15:30:21 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36210/tests/kraken/driver.html?testName=audio-oscillator) 15:30:21 INFO - PROCESS | 14863 | RSS: Main: 172826624 15:30:21 INFO - PROCESS | 14863 | 15:30:23 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36210/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:30:24 INFO - PROCESS | 14863 | RSS: Main: 171249664 15:30:24 INFO - PROCESS | 14863 | 15:30:27 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36210/tests/kraken/driver.html?testName=imaging-darkroom) 15:30:27 INFO - PROCESS | 14863 | RSS: Main: 171552768 15:30:27 INFO - PROCESS | 14863 | 15:30:31 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36210/tests/kraken/driver.html?testName=imaging-desaturate) 15:30:31 INFO - PROCESS | 14863 | RSS: Main: 171999232 15:30:31 INFO - PROCESS | 14863 | 15:30:34 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36210/tests/kraken/driver.html?testName=json-parse-financial) 15:30:35 INFO - PROCESS | 14863 | RSS: Main: 171835392 15:30:35 INFO - PROCESS | 14863 | 15:30:36 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36210/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:30:37 INFO - PROCESS | 14863 | RSS: Main: 176705536 15:30:37 INFO - PROCESS | 14863 | 15:30:39 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:30:39 INFO - PROCESS | 14863 | RSS: Main: 174829568 15:30:39 INFO - PROCESS | 14863 | 15:30:41 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:30:42 INFO - PROCESS | 14863 | RSS: Main: 181805056 15:30:42 INFO - PROCESS | 14863 | 15:30:44 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:30:45 INFO - PROCESS | 14863 | RSS: Main: 185470976 15:30:45 INFO - PROCESS | 14863 | 15:30:47 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:30:48 INFO - PROCESS | 14863 | RSS: Main: 184008704 15:30:48 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36210/tests/kraken/driver.html?testName=ai-astar) 15:30:50 INFO - PROCESS | 14863 | RSS: Main: 246112256 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | __start_tp_report 15:30:50 INFO - PROCESS | 14863 | _x_x_mozilla_page_load 15:30:50 INFO - PROCESS | 14863 | _x_x_mozilla_page_load_details 15:30:50 INFO - PROCESS | 14863 | |i|pagename|runs| 15:30:50 INFO - PROCESS | 14863 | |0;ai-astar;110;110;106;109;108;110;98;109;110;110 15:30:50 INFO - PROCESS | 14863 | |1;audio-beat-detection;168;127;157;184;129;154;162;129;177;128 15:30:50 INFO - PROCESS | 14863 | |2;audio-dft;161;161;161;160;161;161;161;164;162;159 15:30:50 INFO - PROCESS | 14863 | |3;audio-fft;76;75;73;161;77;75;75;75;163;73 15:30:50 INFO - PROCESS | 14863 | |4;audio-oscillator;93;93;137;93;93;93;150;94;93;143 15:30:50 INFO - PROCESS | 14863 | |5;imaging-gaussian-blur;118;117;117;118;116;117;116;117;117;117 15:30:50 INFO - PROCESS | 14863 | |6;imaging-darkroom;146;146;146;145;146;146;146;145;146;146 15:30:50 INFO - PROCESS | 14863 | |7;imaging-desaturate;96;96;95;95;96;96;95;96;96;96 15:30:50 INFO - PROCESS | 14863 | |8;json-parse-financial;53;55;54;55;54;56;55;63;56;53 15:30:50 INFO - PROCESS | 14863 | |9;json-stringify-tinderbox;64;65;66;80;64;65;65;65;66;65 15:30:50 INFO - PROCESS | 14863 | |10;stanford-crypto-aes;79;82;87;80;82;80;82;81;81;80 15:30:50 INFO - PROCESS | 14863 | |11;stanford-crypto-ccm;117;122;111;114;120;118;117;119;113;111 15:30:50 INFO - PROCESS | 14863 | |12;stanford-crypto-pbkdf2;145;149;146;147;135;136;150;145;146;136 15:30:50 INFO - PROCESS | 14863 | |13;stanford-crypto-sha256-iterative;68;68;70;72;66;66;65;68;66;65 15:30:50 INFO - PROCESS | 14863 | __end_tp_report 15:30:50 INFO - PROCESS | 14863 | __start_cc_report 15:30:50 INFO - PROCESS | 14863 | _x_x_mozilla_cycle_collect,1066 15:30:50 INFO - PROCESS | 14863 | __end_cc_report 15:30:50 INFO - PROCESS | 14863 | __startTimestamp1461364250310__endTimestamp 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | ------- Summary: start ------- 15:30:50 INFO - PROCESS | 14863 | Number of tests: 14 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:3.74 (3.4%) stddev-sans-first:3.90 15:30:50 INFO - PROCESS | 14863 | Values: 110.0 110.0 106.0 109.0 108.0 110.0 98.0 109.0 110.0 110.0 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:159.50 stddev:21.83 (13.7%) stddev-sans-first:22.33 15:30:50 INFO - PROCESS | 14863 | Values: 168.0 127.0 157.0 184.0 129.0 154.0 162.0 129.0 177.0 128.0 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 15:30:50 INFO - PROCESS | 14863 | Values: 161.0 161.0 161.0 160.0 161.0 161.0 161.0 164.0 162.0 159.0 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.00 stddev:36.76 (49.0%) stddev-sans-first:38.51 15:30:50 INFO - PROCESS | 14863 | Values: 76.0 75.0 73.0 161.0 77.0 75.0 75.0 75.0 163.0 73.0 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:93.00 stddev:24.44 (26.3%) stddev-sans-first:25.30 15:30:50 INFO - PROCESS | 14863 | Values: 93.0 93.0 137.0 93.0 93.0 93.0 150.0 94.0 93.0 143.0 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 15:30:50 INFO - PROCESS | 14863 | Values: 118.0 117.0 117.0 118.0 116.0 117.0 116.0 117.0 117.0 117.0 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 15:30:50 INFO - PROCESS | 14863 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 15:30:50 INFO - PROCESS | 14863 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:2.88 (5.2%) stddev-sans-first:2.92 15:30:50 INFO - PROCESS | 14863 | Values: 53.0 55.0 54.0 55.0 54.0 56.0 55.0 63.0 56.0 53.0 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:65.00 stddev:4.79 (7.4%) stddev-sans-first:4.99 15:30:50 INFO - PROCESS | 14863 | Values: 64.0 65.0 66.0 80.0 64.0 65.0 65.0 65.0 66.0 65.0 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.50 stddev:2.22 (2.7%) stddev-sans-first:2.18 15:30:50 INFO - PROCESS | 14863 | Values: 79.0 82.0 87.0 80.0 82.0 80.0 82.0 81.0 81.0 80.0 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:117.50 stddev:3.79 (3.2%) stddev-sans-first:4.01 15:30:50 INFO - PROCESS | 14863 | Values: 117.0 122.0 111.0 114.0 120.0 118.0 117.0 119.0 113.0 111.0 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:146.00 stddev:5.64 (3.9%) stddev-sans-first:5.96 15:30:50 INFO - PROCESS | 14863 | Values: 145.0 149.0 146.0 147.0 135.0 136.0 150.0 145.0 146.0 136.0 15:30:50 INFO - PROCESS | 14863 | 15:30:50 INFO - PROCESS | 14863 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:2.27 (3.3%) stddev-sans-first:2.40 15:30:50 INFO - PROCESS | 14863 | Values: 68.0 68.0 70.0 72.0 66.0 66.0 65.0 68.0 66.0 65.0 15:30:50 INFO - PROCESS | 14863 | -------- Summary: end -------- 15:30:50 INFO - PROCESS | 14863 | 15:30:51 INFO - TEST-INFO | 14863: exit 0 15:30:51 INFO - TEST-OK | kraken | took 59600ms 15:30:51 INFO - SUITE-END | took 1171s 15:30:51 INFO - Completed test suite (00:19:31) 15:30:51 INFO - javascript benchmark 15:30:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3262.722668573171, 3342.2312868040335, 3342.8829990950308, 3357.513160591714, 3391.762576619636, 5375.48932851379, 5420.620556561043, 5422.674639521631, 5423.972880135599, 5484.561235101192, 5417.052015897222, 5420.647657902234, 5456.372517160527, 5459.535939445152, 5460.453954604538, 4829.203181475053, 4931.654784165119, 4988.775505102261, 5015.498450154992, 5050.7979680812905, 4876.195427754434, 4892.0, 4951.900961980758, 4961.08219979305, 4964.578010869062, 4912.263160525932, 4976.154053810861, 5020.949790502103, 5049.798008079672, 5057.291979122926, 5043.67216130954, 5048.242763585455, 5058.671186372874, 5061.139606266944, 5092.643514953937, 4558.459822511019, 4868.561829435333, 4916.0, 4918.8278410255825, 4975.477574854624, 5313.335833020872, 5319.441458646825, 5319.893602127974, 5326.893462130774, 5335.0663633863915, 5656.830295091154, 5816.680082595455, 5843.444872737083, 5844.6785426801935, 5886.440788125121, 5917.763289468416, 5954.106883967396, 5956.047032474783, 5967.701614919237, 6003.609765365237, 5486.561075113981, 5518.806841760599, 5518.889622207574, 5518.944810551883, 5521.696306703129, 5797.391273916178, 5940.554458415636, 5971.5222782177325, 5997.010493268649, 6059.1820104286235, 5764.221830052973, 5769.942300577024, 5770.826875193751, 5771.884562308815, 5772.913406298909, 5860.413958604191, 5862.296524417097, 5863.912041319383, 5866.266716660418, 5866.472017518444, 5665.745041473144, 5815.854603634943, 5825.4174582542255, 5905.173275741399, 5907.586468947218, 5886.676232807236, 5907.675077870673, 5908.527317814564, 5915.37888521699, 5917.0, 4493.191225579361, 4506.729596224237, 4506.864794056183, 4516.299973504112, 4535.909281814345, 3923.156521347924, 4018.3369743991916, 4070.6539944105084, 4081.89795255121, 4111.09555897702, 5578.721063946787, 5583.720813959286, 5592.440755924375, 5610.523105535994, 5620.606557540933, 5693.202951586781, 5856.502197313276, 5900.852478687982, 5919.230500034968, 5924.259467566554, 5466.262054622654, 5503.752331145108, 5543.251661025791, 5565.9721701392045, 5605.80379686709, 5079.619028572872, 5097.923531147036, 5099.082165210223, 5101.489851014869, 5128.9230661540105, 5857.7949771757785, 6055.364186760415, 6101.60339577926, 6102.176206212104, 6103.755849765959, 5808.390119037609, 5845.590808643354, 5849.590528662953, 5853.268341457318, 5854.531637469077, 6034.39656034393, 6039.818805435844, 6043.576949613484, 6046.606970546901, 6047.365026672136, 5652.3217213934595, 5732.856678583069, 5753.021986262429, 5789.478946894799, 5838.474537291664, 5911.822645320647, 5929.673867937305, 5933.940660593339, 5935.940640593539, 5942.465178133989, 5713.153724247194, 5733.770649173986, 5779.508741756998, 5780.277465316835, 5795.884082318415, 5557.888842223052, 5740.913886291625, 5780.393058728773, 5798.942010580009, 5831.387704290988, 5626.1842032905815, 5642.915356269577, 5644.0687286598895, 5656.632318899258, 5659.094544872801, 5776.624519406225, 5783.219265399285, 5784.132380143013, 5785.623934444247, 5788.102844059177, 5455.618106732491, 5455.645383050089, 5639.069553523786, 5710.771569137188, 5734.139879018181], "unit": "score", "name": "dojo.html", "value": 5408.062206262708}, {"lowerIsBetter": false, "replicates": [546.6801920876287, 550.2516577454661, 554.5037191713419, 559.6586082489681, 593.7951406764664, 30448.238794030134, 38653.80673096634, 39118.80440597793, 39149.02127446812, 39154.80422597883, 41849.16301673972, 42344.576554234445, 42404.0, 42424.36363454543, 42436.787816060954, 8777.561121943892, 8992.77518062047, 8992.820143597124, 8993.865092023592, 8994.640214391417, 8647.178518040777, 8758.211760941515, 8765.03584605696, 8783.780405489882, 9000.369974101815, 9004.729858104267, 9037.41256818308, 9045.231155351803, 9062.546872656341, 9083.454992700426, 8949.910500895005, 9006.59470323837, 9020.09799020096, 9029.954850225708, 9033.187013168847, 8872.245859101984, 9112.635494580209, 9113.772155696095, 9125.863112053325, 9134.497602631853, 41087.383689244685, 41552.0, 41599.58400415987, 41646.37530437046, 41671.374929376085, 3716.8141592920247, 3724.5158129443, 3767.7550959187565, 3785.867494637702, 3821.503204583414, 30069.69930300691, 31567.210819729462, 31608.525872111935, 31680.524792128137, 32641.020769376955, 3538.2569660371355, 3688.589855880241, 3695.593484716679, 3725.3853114236117, 3785.261873934584, 219799.0, 220680.0, 221429.0, 280528.0, 282697.0, 43643.56356436459, 44159.33760993588, 60901.39098608957, 61684.38315616876, 61752.38247617556, 42325.57674423278, 42341.36487952683, 42404.57595424068, 42410.0, 42502.57497425048, 16200.189990500428, 16272.918635406984, 16288.755668664979, 16299.592510187103, 16348.591285217964, 13205.33973301331, 13210.801837972438, 13263.535776247785, 13341.066125371324, 13342.19946803195, 15311.540653780405, 15348.386064557517, 15356.308966096552, 15356.846431535765, 15406.075635461908, 5661.943380566224, 5714.79998200061, 5791.826245212566, 5793.536517078708, 5818.418158184148, 1010.6816352848829, 1028.8508166315842, 1105.8838821923744, 1106.7067227184803, 1200.1299058182922, 29139.417211655647, 29209.24744515336, 29256.85371573171, 30141.547876781864, 30267.243318917204, 1078.9244752867223, 1098.0940723902813, 1165.854268216473, 1197.0423661071109, 1217.6834023154045, 15496.147711875956, 15617.765733514007, 15689.529314120595, 15715.68568628621, 15959.04245745259, 338225.0, 340007.0, 343124.0, 343558.0, 343606.0, 55672.72163639156, 56534.0, 56565.43434565602, 56597.43402566004, 56601.0, 1269.7650934577132, 1294.9223046617233, 1418.8368337641098, 1460.8393076761547, 1482.3625840888305, 26532.336691582866, 26969.190924272305, 26992.46015079648, 27022.32444188911, 27554.724452755217, 41095.7945210272, 41404.378934315406, 41522.0, 41543.792281038404, 41548.37677434902, 178964.0, 180604.09697951426, 180766.0, 182376.0, 182594.0, 28874.42251154923, 32542.186445339055, 32990.67009329876, 33676.663233367355, 33854.830725846216, 39484.210315794095, 39665.40501892416, 40073.39889901712, 40469.797651012734, 41028.17943641051, 34617.480737789454, 35852.64147358597, 37087.629123708415, 37263.44104838376, 37473.0, 36152.27695446129, 36314.4552831713, 36594.45108323431, 36624.45063323999, 36994.8150259247, 35968.0, 36776.44835327419, 37277.440838387985, 37506.0, 37603.0, 32156.51765223477, 33634.327313453105, 33691.83154084214, 33775.66224337725, 33910.491342629386, 25535.744642553338, 25640.743592563835, 25963.22110336693, 26114.086006990423, 26193.869030654725], "unit": "score", "name": "ext.html", "value": 18068.5633249109}, {"lowerIsBetter": false, "replicates": [344.4953143644561, 383.32917394559536, 389.67267495303946, 390.33837645191414, 392.7878945369497, 17152.313907443702, 17951.371701990432, 19056.809431905676, 19060.523486912833, 19210.615787684237, 17096.743548846745, 17099.31602735889, 17623.295068197258, 17663.82336176638, 17700.203490842912, 5621.8032368867, 5802.680852553108, 5823.12653102036, 5835.153902684108, 5835.474807267345, 4270.871873843789, 5719.59962802604, 6021.277446706401, 6256.37436256373, 6294.055891616271, 6186.226721659793, 6221.440070393686, 6245.843853903643, 6254.874902501947, 6259.499240060807, 6011.458968692817, 6278.748850045993, 6289.276733175652, 6293.55945083842, 6293.590916590407, 3854.710896682732, 5332.573394128461, 5535.335759708821, 5539.196816461631, 5552.611317207797, 19637.116329765195, 19773.110210040584, 19930.70103948442, 20083.0, 20149.697754533692, 2420.298113547069, 2625.789936805051, 2726.4001919577663, 2755.586662000716, 2861.9427611447863, 12602.747945041048, 13123.54067607629, 13173.209607423585, 13339.466421343135, 13341.53304634343, 1955.4915721912264, 1960.372680742163, 2000.3198912369865, 2002.6595478768645, 2096.6016456873144, 62966.37033629651, 64778.3522164777, 64887.35112648908, 64903.0, 64932.3506764931, 10359.533820978075, 10469.476526173661, 10475.738106547245, 10476.952304769462, 10530.420826854597, 14722.190279534729, 14832.81337492998, 14841.480548180762, 14848.703025939421, 14853.628659283604, 7699.884501732478, 7889.0, 7974.641141148662, 8036.0, 8042.798930026796, 7628.694852205849, 7685.654145563463, 7713.807154821062, 7743.225677432211, 7800.609969501502, 4613.0, 4634.420697412824, 4641.976790116096, 4673.976630116827, 4707.929381059287, 1835.4952388093382, 1851.5833937364255, 1853.490290170187, 1964.1946801811189, 2007.959840803205, 942.3921570586933, 970.4419958523877, 974.4104816585864, 1020.698893826323, 1026.6817286641017, 14889.0, 16000.959937604252, 16963.660726785394, 17156.142192890307, 17322.0, 937.2267878999852, 965.7537327981461, 1008.6167256442504, 1014.0771897573173, 1032.7056788815153, 9707.029297070236, 9821.754456138511, 9833.115019648123, 9893.15908147801, 10018.3488073275, 383038.0, 386397.0, 387791.0, 388872.0, 411482.0, 71851.28148718446, 74606.0, 74708.25291747121, 75180.0, 75458.62270688612, 1039.4542864995938, 1043.9739006524899, 1055.456439933435, 1055.6780182044397, 1067.6690226029955, 15213.239338033276, 15390.615234619225, 15481.225938703245, 15495.612609684396, 15863.286152123414, 33566.664333356355, 33780.0, 34749.305013900084, 35187.94436166919, 35192.64807351894, 46185.53814461813, 49832.501674982785, 49871.0, 50059.249111264086, 50150.74924625354, 8358.623861926106, 8592.742217733477, 8602.096779838277, 8772.517511536927, 8862.158094980967, 12402.0, 12581.433835477608, 12628.810567841307, 12633.0, 12696.74606507883, 5277.577793776565, 10796.056709792312, 11547.8267825981, 11696.649100526998, 11796.174267801172, 11429.885701143216, 11665.72687488466, 11667.0, 11692.240004399688, 11826.704332391759, 11047.281926674741, 11393.601223957121, 11466.598669046543, 11653.76692466163, 11713.355765432641, 8222.17778222173, 8355.83288334242, 8753.693620723245, 8794.42836215644, 8836.160564746338, 9198.172164505228, 10974.670759877217, 11400.771984560428, 11605.419729013347, 11654.941725291319], "unit": "score", "name": "jquery.html", "value": 8824.592988359234}, {"lowerIsBetter": false, "replicates": [1456.9635759106015, 1585.9207039648015, 1597.2732406754924, 1752.2552915011117, 1835.908204589771, 7557.622118894061, 8199.71301004465, 8328.208820162075, 8329.167083291675, 8330.583470826465, 8293.460925039868, 8447.873281900776, 8456.83086338273, 8461.153884611536, 8462.788430289245, 2165.545235500547, 2362.29131260622, 2432.8783560821976, 2477.6407420924, 2505.949881002379, 2464.852108873464, 2505.2985164154065, 2505.8747062646794, 2512.962305565418, 2513.836600620954, 2460.5324988252173, 2481.751824817513, 2482.453860150773, 2484.1057219401, 2486.2292689266296, 2354.223106374901, 2416.226807421626, 2423.5637585234826, 2427.2475532584954, 2435.099013365066, 2429.854208747463, 2441.963370549443, 2461.064795377763, 2473.9134130305533, 2474.2206205045354, 8650.178233067849, 8712.303015758724, 8714.869276960851, 8723.040465548784, 8723.38936274461, 5282.022825777243, 5344.732763361816, 5404.054290499186, 5414.756335964891, 5415.539679127279, 3248.545203671488, 3319.867205311785, 3329.900102996914, 3334.4498157803932, 3339.081752518077, 1020.1226944827442, 1029.3978022856638, 1030.0626429948786, 1037.5123691864812, 1037.7924415116931, 12132.454039568152, 12169.817452738216, 12224.14430989831, 12237.510499580007, 12246.142770006103, 4665.160271151225, 4694.741789201558, 4757.215059515211, 4777.402824646919, 4777.9044419112115, 10246.846297305547, 10280.485975701185, 10294.742631434274, 10305.124064454456, 10307.84538231927, 4637.791299391535, 5327.174287985368, 5385.272988146628, 5392.973035134799, 5394.217838413408, 4732.550407711262, 4818.445878723992, 4823.324734537167, 4827.0, 4845.927311090337, 3792.4500947362476, 3844.308024555551, 3878.941815872764, 3933.4689816874356, 3946.131850992777, 1180.8819118088122, 1182.43243243242, 1186.4364426897155, 1194.5042807235075, 1273.3442277227236, 1434.7058852935124, 1443.4875619155048, 1453.2370505484705, 1469.353484466831, 1473.2707309881678, 8020.238077382639, 8041.477303975223, 8065.354771618257, 8082.19178082187, 8090.433669643068, 490.60996507776406, 498.7057635994781, 503.2602074949818, 503.8916632923939, 506.4530307268142, 6280.5289603279025, 6284.874302514016, 6303.432691057827, 6341.524385671001, 6394.808155755335, 10328.845067323997, 10707.304025238334, 10709.303895246783, 10876.075533579577, 10877.292975956696, 10423.895761042444, 10554.47227638615, 10633.0, 10660.733481663021, 10692.251542392114, 8223.95888020556, 8325.8334833303, 8327.375446841512, 8411.579421028924, 8413.873791893126, 7935.603219838869, 7958.0848202455145, 7960.601969901366, 8046.275835174863, 8083.474574152661, 9403.764905877135, 9409.200217981275, 9412.717618471457, 9475.099865512766, 9507.572159252712, 9671.371360861522, 9747.658831940847, 9824.754381140528, 9850.359726617748, 9985.251106166921, 6482.0, 6961.79114626562, 7215.71137154508, 7232.927670723226, 7288.817779555554, 8183.468074575134, 8189.918100819154, 8200.917990820015, 8214.917850821415, 8268.131846156308, 7329.74345897891, 7499.362554182955, 7517.436192285491, 7611.467197296136, 7666.655000524878, 7016.26329235423, 7370.705171793068, 7371.668274927749, 7446.7021319146625, 7468.477206595703, 7965.681372745025, 7970.043594768433, 8000.119986801331, 8006.95996520037, 8013.439059265796, 7144.64276786169, 7162.427005839416, 7306.3789577884345, 7358.0, 7362.852742945218, 7227.674754635948, 7232.710691572278, 7280.672369743268, 7287.2348403419, 7290.088738907637], "unit": "score", "name": "mootools.html", "value": 4819.5580313326345}, {"lowerIsBetter": false, "replicates": [345.5939271356156, 351.89267273481596, 352.4237871080784, 354.3762977160199, 355.53247479564374, 6021.42796434338, 6073.362296958817, 6082.72627731752, 6082.756689732411, 6090.056041313604, 6007.15899774032, 6016.398360163981, 6017.488513476349, 6021.337652858182, 6028.879422411549, 4486.97756511217, 4604.562566556172, 4679.8596042118625, 4705.411823522059, 4732.692374995631, 4682.882927926795, 4708.058388322332, 4712.599429048535, 4723.763811809413, 4726.385569875912, 4671.135839869635, 4676.3920690310215, 4677.158111539921, 4683.203855344583, 4695.8356457524, 4508.864734057984, 4587.839425620121, 4642.0, 4658.091672123937, 4680.625549956029, 4123.0516981094515, 4126.112885729583, 4134.545200027995, 4135.545090040093, 4140.896477588054, 5701.629394089371, 5706.457886500776, 5715.657060576379, 5723.084306510938, 5723.427657234285, 5458.990086833948, 5459.918101228484, 5470.425605311425, 5477.698726570037, 5517.641353312022, 6377.553571250014, 6379.138816259839, 6380.361963803629, 6382.457491113261, 6383.904241436382, 4428.225060614412, 4551.203539380628, 4558.247889098295, 4586.197415452316, 4619.63042956566, 6580.703868325937, 6632.801015969529, 6649.6010239385305, 6670.699818508178, 6672.099266598995, 4737.810487580458, 4739.549742774431, 4748.881277968009, 4752.1683705351425, 4764.6426518011285, 4842.789302674331, 4846.0, 4846.055019271279, 4847.442544107473, 4848.0, 5470.425605311465, 5489.4236105209175, 5491.752871120809, 5493.972530137404, 5497.8075767348755, 6280.842978925563, 6438.549301548846, 6461.838454038687, 6472.288048314682, 6480.222373315232, 1685.9157042147845, 1704.1479260369815, 1719.5787032177197, 1721.672882152387, 1721.9225134868962, 1100.6422912553292, 1149.9827502587468, 1150.7871043856912, 1158.9304641721524, 1179.722765150189, 6118.969405152946, 6126.754929802847, 6128.3565225651555, 6135.355787642234, 6140.416660417253, 6513.934860651428, 6546.443552298013, 6560.081588577603, 6563.638999855054, 6582.736690532325, 6170.228721409824, 6175.135481032659, 6178.073289006685, 6189.381061893865, 6201.534884883652, 3543.0965103898343, 3570.8571657133425, 3570.9285814283567, 3574.4280915053987, 3577.373959557067, 6792.830179245559, 6825.385715285648, 6963.442924566022, 6992.79021629352, 7006.369426751617, 6941.68762405693, 6966.164060312795, 6966.860662786818, 6983.022376867242, 6983.2318444971015, 6979.162500499972, 6984.057152284377, 6988.860222795515, 7004.229534751174, 7037.472189585802, 6703.899441508283, 6710.765123220664, 6721.697523611351, 6725.058491811248, 6735.4274886635185, 6451.41937225652, 6571.474282057519, 6590.9670451647435, 6596.70314835824, 6616.073749674953, 6946.5137440378685, 6962.582245065312, 6983.511154219156, 6984.965075174591, 6988.895166572607, 4535.0, 4552.567506086916, 4553.430821147356, 4557.977210113928, 4561.977190114028, 6716.529842910949, 6723.966380168068, 6735.6295403753265, 6738.59568425896, 6745.662716864039, 6330.303666596578, 6503.089567460464, 6504.902426463512, 6520.054592084027, 6520.836979075371, 6410.775622853178, 6434.388733070538, 6460.35396460369, 6471.06169605414, 6531.934680653133, 6384.776532821329, 6391.265004524539, 6401.839954001187, 6407.487401008001, 6409.615423074631, 6520.9347906520325, 6521.902171467526, 6524.380183882524, 6525.0, 6539.0191471277785, 6062.757489700362, 6145.9692701538, 6381.8085457436355, 6404.423601875854, 6414.422701956846], "unit": "score", "name": "prototype.html", "value": 4908.5225717798185}, {"lowerIsBetter": false, "replicates": [740.3891789273848, 770.1489853711648, 798.161929973528, 827.230675471811, 847.2036285891262, 13221.867781322184, 13376.531821386254, 13419.731605367899, 13429.261390623511, 13442.126261792977, 13857.376418061187, 13878.861211387908, 13880.16718996861, 13914.0, 13972.0, 774.3302043732159, 895.8253140637578, 904.7104926423547, 908.2280061947325, 909.5997760985179, 907.8774365460645, 912.333996182787, 913.7578541686458, 913.995430022849, 914.0950459045564, 961.8076384723048, 969.830279701053, 970.2626004236796, 970.3692599810145, 971.3686104032365, 778.5562229529171, 791.877259024852, 945.8392073347547, 963.2775418436173, 965.0638880286111, 703.5110598134298, 703.6657587645878, 703.954242974205, 707.9946476004087, 708.3235510087853, 13095.279759613217, 13156.144850584682, 13158.14472059313, 13167.078304518687, 13180.406881690347, 12537.498500059986, 12886.0, 13012.934935325262, 13052.477900883954, 13318.667033324147, 11038.227324087316, 11059.447027648666, 11111.777764444747, 11306.886931130666, 11336.829947550794, 3716.9070773230615, 3725.981370093132, 3758.342290099222, 3819.7708137511836, 3852.9614703852885, 44040.55959440397, 44380.0, 49611.50388496105, 52022.99999999962, 52096.73951630218, 10388.636397726195, 10431.739206519898, 10675.893241067646, 10714.41070741101, 10840.186985975926, 17093.743593846102, 17281.39515116965, 17287.308507659553, 17348.045857477708, 17448.563785905455, 7637.4653774236385, 7791.0650721913735, 7983.1578947368425, 8085.514869107872, 8144.0, 4175.290200665894, 4192.91614167721, 4336.653067754635, 4354.9782251088545, 4516.728996260169, 3355.5302257683943, 3388.203772113551, 3393.2025973896116, 3398.0145757730475, 3398.303347813692, 622.6202016769766, 630.7224821078711, 640.8814369341686, 641.2241188162283, 653.0856800479272, 614.8186285045922, 647.1037612906065, 674.4233680203356, 679.5175425447889, 711.0578483509371, 7939.6824127035425, 7981.48120372174, 8195.385346099067, 8262.8347433051, 8554.315654747605, 537.7633841109899, 594.0406243916044, 623.4700504571078, 683.402023229674, 699.8600279944031, 3750.212455384345, 3896.7272290939927, 3966.3257246268204, 4047.514298284225, 4113.979430102891, 54731.45268547343, 55202.44797552053, 55637.44362556404, 55741.0, 56427.0, 50383.24425133626, 50619.0, 52237.21644175341, 53126.0, 53196.0, 45875.77062114601, 46385.07229855384, 46921.5307846924, 47285.0, 47494.287585686245, 8353.0, 8493.193146651058, 8812.339074569305, 8844.690435834715, 8888.866666999871, 35681.0, 36099.27801443904, 36394.8180259097, 37144.814275928446, 37474.8126259367, 46515.302270466644, 46713.0, 46738.532614673415, 47648.761756190994, 47779.28331074967, 11093.778124437627, 11341.829872551752, 11528.250663706833, 11544.769104617693, 11834.467448964646, 11316.15128865355, 11516.136289778467, 11624.070074394198, 11668.591599293984, 11669.941650291694, 11423.143264255048, 11731.589394371156, 11835.881641183478, 12158.75682486363, 12188.451519681814, 11105.500252488819, 11346.375949322866, 11359.375234362189, 11764.35296058725, 11927.582534611247, 11001.394923279297, 11052.723681908017, 11396.0, 11635.418229088342, 11977.820332695192, 9828.901710982798, 9986.709701917496, 10053.04496072872, 10063.849042264226, 10535.525901334611, 9077.500737459502, 9193.862092068759, 9300.302477314364, 9644.18024467928, 9763.560639771085], "unit": "score", "name": "yui.html", "value": 6499.320490540428}], "name": "dromaeo_css", "value": 7140.906262081656}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 106.0, 109.0, 108.0, 110.0, 98.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [168.0, 127.0, 157.0, 184.0, 129.0, 154.0, 162.0, 129.0, 177.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 164.0, 162.0, 159.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 73.0, 161.0, 77.0, 75.0, 75.0, 75.0, 163.0, 73.0], "unit": "score", "name": "audio-fft", "value": 92.3}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 137.0, 93.0, 93.0, 93.0, 150.0, 94.0, 93.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 54.0, 55.0, 54.0, 56.0, 55.0, 63.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 66.0, 80.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [79.0, 82.0, 87.0, 80.0, 82.0, 80.0, 82.0, 81.0, 81.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.4}, {"lowerIsBetter": true, "replicates": [117.0, 122.0, 111.0, 114.0, 120.0, 118.0, 117.0, 119.0, 113.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [145.0, 149.0, 146.0, 147.0, 135.0, 136.0, 150.0, 145.0, 146.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 72.0, 66.0, 66.0, 65.0, 68.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1510.0000000000005}]} 15:30:51 INFO - Return code: 0 15:30:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:30:51 INFO - # TBPL SUCCESS # 15:30:51 INFO - Running post-action listener: _resource_record_post_action 15:30:51 INFO - Running post-run listener: _resource_record_post_run 15:30:52 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 12288; Write bytes: 478027776; Read time: 224; Write time: 606328 15:30:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 149917696; Read time: 124; Write time: 295996 15:30:52 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 249368576; Read time: 100; Write time: 209812 15:30:52 INFO - Running post-run listener: _upload_blobber_files 15:30:52 INFO - Blob upload gear active. 15:30:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:30:52 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 15:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:30:53 INFO - (blobuploader) - INFO - Open directory for files ... 15:30:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:30:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:30:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:53 INFO - (blobuploader) - INFO - Done attempting. 15:30:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:30:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:30:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:54 INFO - (blobuploader) - INFO - Done attempting. 15:30:54 INFO - (blobuploader) - INFO - Iteration through files over. 15:30:54 INFO - Return code: 0 15:30:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:30:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:30:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d344dbdc6d3a7a0158c410d9f54314a66b05e10b42e9d28361eb300b127cfb3fadfbb32f472c6cb2497c1308bb80ad9c80bd825466ed50e4caa975b0d88af25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33baeda9566b8496907d276aeff6ca3ee0c1bcd7f16c32dc6d885de1a6a899daa28d9a88a530016b1152ed7d4cd35a19197dd73fb3fe508a68959589f8e4b183"} 15:30:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:30:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:30:54 INFO - Contents: 15:30:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d344dbdc6d3a7a0158c410d9f54314a66b05e10b42e9d28361eb300b127cfb3fadfbb32f472c6cb2497c1308bb80ad9c80bd825466ed50e4caa975b0d88af25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33baeda9566b8496907d276aeff6ca3ee0c1bcd7f16c32dc6d885de1a6a899daa28d9a88a530016b1152ed7d4cd35a19197dd73fb3fe508a68959589f8e4b183"} 15:30:54 INFO - Running post-run listener: copy_logs_to_upload_dir 15:30:54 INFO - Copying logs to upload dir... 15:30:54 INFO - mkdir: /builds/slave/test/build/upload/logs 15:30:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.445723 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-22 15:30:54.669251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 15:30:54.672393) ========= 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-1461363019.995718-2144899226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d344dbdc6d3a7a0158c410d9f54314a66b05e10b42e9d28361eb300b127cfb3fadfbb32f472c6cb2497c1308bb80ad9c80bd825466ed50e4caa975b0d88af25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33baeda9566b8496907d276aeff6ca3ee0c1bcd7f16c32dc6d885de1a6a899daa28d9a88a530016b1152ed7d4cd35a19197dd73fb3fe508a68959589f8e4b183"} build_url:https://queue.taskcluster.net/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/TDky78zjQ-e66K3bFZZVvw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d344dbdc6d3a7a0158c410d9f54314a66b05e10b42e9d28361eb300b127cfb3fadfbb32f472c6cb2497c1308bb80ad9c80bd825466ed50e4caa975b0d88af25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33baeda9566b8496907d276aeff6ca3ee0c1bcd7f16c32dc6d885de1a6a899daa28d9a88a530016b1152ed7d4cd35a19197dd73fb3fe508a68959589f8e4b183"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 15:30:54.696802) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 15:30:54.697119) ========= 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-1461363019.995718-2144899226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 15:30:54.781537) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 15:30:54.781826) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 15:30:54.782097) ========= ========= Total master_lag: 0.16 =========