builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1464396452.97 results: success (0) buildid: 20160527151144 builduid: 5f3e6f6a3dc94ab6a9ca5b77e66fbee2 revision: f8e493cd1e87a482c0246f4a8fe4229142bc1ccc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:32.970084) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:32.970542) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:32.970868) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:32.995252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:32.995603) ========= 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=00204705a9daa57ed339a427000001b9-1464395356.936537-509041690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 17:47:33-- 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% 38.1M=0s 2016-05-27 17:47:33 (38.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099439 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:33.109164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:33.109517) ========= 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=00204705a9daa57ed339a427000001b9-1464395356.936537-509041690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018950 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:33.159328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:33.159698) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f8e493cd1e87a482c0246f4a8fe4229142bc1ccc --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 f8e493cd1e87a482c0246f4a8fe4229142bc1ccc --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=00204705a9daa57ed339a427000001b9-1464395356.936537-509041690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 17:47:33,435 truncating revision to first 12 chars 2016-05-27 17:47:33,435 Setting DEBUG logging. 2016-05-27 17:47:33,435 attempt 1/10 2016-05-27 17:47:33,435 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f8e493cd1e87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 17:47:33,734 unpacking tar archive at: mozilla-aurora-f8e493cd1e87/testing/mozharness/ program finished with exit code 0 elapsedTime=0.914821 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:34.088081) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:34.088419) ========= script_repo_revision: f8e493cd1e87a482c0246f4a8fe4229142bc1ccc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:34.088889) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:34.089175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 17:47:34.100813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-27 17:47:34.101088) ========= /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=00204705a9daa57ed339a427000001b9-1464395356.936537-509041690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:47:34 INFO - MultiFileLogger online at 20160527 17:47:34 in /builds/slave/test 17:47:34 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 17:47:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:47:34 INFO - {'append_to_log': False, 17:47:34 INFO - 'base_work_dir': '/builds/slave/test', 17:47:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:47:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:47:34 INFO - 'branch': 'Mozilla-Aurora', 17:47:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:47:34 INFO - 'config_files': ('talos/linux_config.py',), 17:47:34 INFO - 'default_actions': ('clobber', 17:47:34 INFO - 'read-buildbot-config', 17:47:34 INFO - 'download-and-extract', 17:47:34 INFO - 'populate-webroot', 17:47:34 INFO - 'create-virtualenv', 17:47:34 INFO - 'install', 17:47:34 INFO - 'run-tests'), 17:47:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:47:34 INFO - 'download_minidump_stackwalk': True, 17:47:34 INFO - 'download_symbols': 'ondemand', 17:47:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:47:34 INFO - 'tooltool.py': '/tools/tooltool.py', 17:47:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:47:34 INFO - '/tools/misc-python/virtualenv.py')}, 17:47:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:47:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:47:34 INFO - 'installer_path': 'installer.exe', 17:47:34 INFO - 'log_level': 'info', 17:47:34 INFO - 'log_name': 'talos', 17:47:34 INFO - 'log_to_console': True, 17:47:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:47:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:47:34 INFO - 'opt_config_files': (), 17:47:34 INFO - 'pip_index': False, 17:47:34 INFO - 'sps_profile': False, 17:47:34 INFO - 'sps_profile_interval': 0, 17:47:34 INFO - 'suite': 'dromaeojs', 17:47:34 INFO - 'system_bits': '32', 17:47:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:47:34 INFO - 'title': 'talos-linux64-ix-016', 17:47:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:47:34 INFO - 'use_talos_json': True, 17:47:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:47:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:47:34 INFO - 'work_dir': 'build'} 17:47:34 INFO - ##### 17:47:34 INFO - ##### Running clobber step. 17:47:34 INFO - ##### 17:47:34 INFO - Running pre-action listener: _resource_record_pre_action 17:47:34 INFO - Running main action method: clobber 17:47:34 INFO - rmtree: /builds/slave/test/build 17:47:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:47:34 INFO - Running post-action listener: _resource_record_post_action 17:47:34 INFO - ##### 17:47:34 INFO - ##### Running read-buildbot-config step. 17:47:34 INFO - ##### 17:47:34 INFO - Running pre-action listener: _resource_record_pre_action 17:47:34 INFO - Running main action method: read_buildbot_config 17:47:34 INFO - Using buildbot properties: 17:47:34 INFO - { 17:47:34 INFO - "project": "", 17:47:34 INFO - "product": "firefox", 17:47:34 INFO - "script_repo_revision": "production", 17:47:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:47:34 INFO - "repository": "", 17:47:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:47:34 INFO - "buildid": "20160527151144", 17:47:34 INFO - "pgo_build": "True", 17:47:34 INFO - "basedir": "/builds/slave/test", 17:47:34 INFO - "buildnumber": 348, 17:47:34 INFO - "slavename": "talos-linux64-ix-016", 17:47:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:47:34 INFO - "platform": "ubuntu64_hw", 17:47:34 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:47:34 INFO - "branch": "mozilla-aurora", 17:47:34 INFO - "repo_path": "releases/mozilla-aurora", 17:47:34 INFO - "revision": "f8e493cd1e87a482c0246f4a8fe4229142bc1ccc", 17:47:34 INFO - "stage_platform": "linux64-pgo", 17:47:34 INFO - "builduid": "5f3e6f6a3dc94ab6a9ca5b77e66fbee2", 17:47:34 INFO - "slavebuilddir": "test" 17:47:34 INFO - } 17:47:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 17:47:34 INFO - Running post-action listener: _resource_record_post_action 17:47:34 INFO - ##### 17:47:34 INFO - ##### Running download-and-extract step. 17:47:34 INFO - ##### 17:47:34 INFO - Running pre-action listener: _resource_record_pre_action 17:47:34 INFO - Running main action method: download_and_extract 17:47:34 INFO - mkdir: /builds/slave/test/build/tests 17:47:34 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')]} 17:47:34 INFO - https://queue.taskcluster.net/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:47:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 17:47:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 17:47:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 17:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:47:38 INFO - Downloaded 1361 bytes. 17:47:38 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 17:47:38 INFO - Using the following test package requirements: 17:47:38 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 17:47:38 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 17:47:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:47:38 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 17:47:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:47:38 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 17:47:38 INFO - u'jsshell-linux-x86_64.zip'], 17:47:38 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 17:47:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:47:38 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 17:47:38 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 17:47:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:47:38 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 17:47:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:47:38 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 17:47:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:47:38 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 17:47:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:47:38 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:47:38 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')]} 17:47:38 INFO - https://queue.taskcluster.net/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:47:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 17:47:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 17:47:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 17:47:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:47:41 INFO - Downloaded 24135393 bytes. 17:47:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:47:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:47:42 INFO - Return code: 0 17:47:42 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:42 INFO - https://queue.taskcluster.net/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:47:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 17:47:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 17:47:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 17:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:47:43 INFO - Downloaded 24135393 bytes. 17:47:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:47:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:47:45 INFO - Return code: 0 17:47:45 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')]} 17:47:45 INFO - https://queue.taskcluster.net/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:47:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 17:47:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 17:47:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 17:47:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:47:46 INFO - Downloaded 10840145 bytes. 17:47:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:47:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:47:47 INFO - Return code: 0 17:47:47 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')]} 17:47:47 INFO - https://queue.taskcluster.net/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:47:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 17:47:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 17:47:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 17:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:47:48 INFO - Downloaded 62774544 bytes. 17:47:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 17:47:48 INFO - mkdir: /builds/slave/test/properties 17:47:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:47:48 INFO - Writing to file /builds/slave/test/properties/build_url 17:47:48 INFO - Contents: 17:47:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 17:47:49 INFO - Running post-action listener: _resource_record_post_action 17:47:49 INFO - Running post-action listener: set_extra_try_arguments 17:47:49 INFO - ##### 17:47:49 INFO - ##### Running populate-webroot step. 17:47:49 INFO - ##### 17:47:49 INFO - Running pre-action listener: _resource_record_pre_action 17:47:49 INFO - Running main action method: populate_webroot 17:47:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:47:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:47:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:47:49 INFO - '--tppagecycles', 17:47:49 INFO - '7'], 17:47:49 INFO - 'tests': ['tsvgm']}}, 17:47:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:47:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:47:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:47:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:47:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:47:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:47:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:49 INFO - 'talos_options': ['--disable-e10s'], 17:47:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:47:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:47:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:49 INFO - 'talos_options': ['--disable-e10s'], 17:47:49 INFO - 'tests': ['damp', 'tps']}, 17:47:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:49 INFO - 'tests': ['damp', 'tps']}, 17:47:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:47:49 INFO - 'tests': ['dromaeo_dom']}, 17:47:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:47:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:47:49 INFO - 'tests': ['a11yr', 17:47:49 INFO - 'ts_paint', 17:47:49 INFO - 'tpaint', 17:47:49 INFO - 'sessionrestore', 17:47:49 INFO - 'sessionrestore_no_auto_restore', 17:47:49 INFO - 'tabpaint']}, 17:47:49 INFO - 'other-e10s': {'tests': ['a11yr', 17:47:49 INFO - 'ts_paint', 17:47:49 INFO - 'tpaint', 17:47:49 INFO - 'sessionrestore', 17:47:49 INFO - 'sessionrestore_no_auto_restore', 17:47:49 INFO - 'tabpaint']}, 17:47:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:47:49 INFO - 'ts_paint', 17:47:49 INFO - 'tpaint', 17:47:49 INFO - 'sessionrestore', 17:47:49 INFO - 'sessionrestore_no_auto_restore', 17:47:49 INFO - 'tabpaint']}, 17:47:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:47:49 INFO - 'ts_paint', 17:47:49 INFO - 'tpaint', 17:47:49 INFO - 'sessionrestore', 17:47:49 INFO - 'sessionrestore_no_auto_restore', 17:47:49 INFO - 'tabpaint']}, 17:47:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:47:49 INFO - 'tests': ['a11yr', 17:47:49 INFO - 'ts_paint', 17:47:49 INFO - 'tpaint', 17:47:49 INFO - 'sessionrestore', 17:47:49 INFO - 'sessionrestore_no_auto_restore', 17:47:49 INFO - 'tabpaint']}, 17:47:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:47:49 INFO - 'tests': ['a11yr', 17:47:49 INFO - 'ts_paint', 17:47:49 INFO - 'tpaint', 17:47:49 INFO - 'sessionrestore', 17:47:49 INFO - 'sessionrestore_no_auto_restore', 17:47:49 INFO - 'tabpaint']}, 17:47:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:47:49 INFO - 'tests': ['tsvgx', 17:47:49 INFO - 'tsvgr_opacity', 17:47:49 INFO - 'tart', 17:47:49 INFO - 'tscrollx', 17:47:49 INFO - 'cart']}, 17:47:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:47:49 INFO - 'tsvgr_opacity', 17:47:49 INFO - 'tart', 17:47:49 INFO - 'tscrollx', 17:47:49 INFO - 'cart']}, 17:47:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:49 INFO - 'talos_options': ['--disable-e10s'], 17:47:49 INFO - 'tests': ['tp5o']}, 17:47:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:49 INFO - 'tests': ['tp5o']}, 17:47:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:49 INFO - 'talos_options': ['--disable-e10s', 17:47:49 INFO - '--xperf_path', 17:47:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:47:49 INFO - 'tests': ['tp5n']}, 17:47:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:49 INFO - 'talos_options': ['--xperf_path', 17:47:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:47:49 INFO - 'tests': ['tp5n']}}, 17:47:49 INFO - 'talos.zip': {'path': '', 17:47:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:47:49 INFO - Running post-action listener: _resource_record_post_action 17:47:49 INFO - ##### 17:47:49 INFO - ##### Running create-virtualenv step. 17:47:49 INFO - ##### 17:47:49 INFO - Running pre-action listener: _resource_record_pre_action 17:47:49 INFO - Running main action method: create_virtualenv 17:47:49 INFO - Creating virtualenv /builds/slave/test/build/venv 17:47:49 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 17:47:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:47:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:47:49 INFO - Using real prefix '/usr' 17:47:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:47:49 INFO - Installing distribute.............................................................................................................................................................................................done. 17:47:51 INFO - Installing pip.................done. 17:47:51 INFO - Return code: 0 17:47:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:51 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 0x7f3c2e232f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2577410>, '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 0x2578310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25787a0>, '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': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', '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 17:47:51 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 17:47:51 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 17:47:51 INFO - Using env: {'DISPLAY': ':0', 17:47:51 INFO - 'HOME': '/home/cltbld', 17:47:51 INFO - 'LANG': 'en_US.UTF-8', 17:47:51 INFO - 'LANGUAGE': 'en_US:en', 17:47:51 INFO - 'LOGNAME': 'cltbld', 17:47:51 INFO - 'MAIL': '/var/mail/cltbld', 17:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:51 INFO - 'MOZ_NO_REMOTE': '1', 17:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:51 INFO - 'NO_EM_RESTART': '1', 17:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:51 INFO - 'PWD': '/builds/slave/test', 17:47:51 INFO - 'SHELL': '/bin/bash', 17:47:51 INFO - 'SHLVL': '1', 17:47:51 INFO - 'TERM': 'linux', 17:47:51 INFO - 'TMOUT': '86400', 17:47:51 INFO - 'USER': 'cltbld', 17:47:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', 17:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:51 INFO - '_': '/tools/buildbot/bin/python'} 17:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:52 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 17:47:52 INFO - Cleaning up... 17:47:52 INFO - Return code: 0 17:47:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:47:52 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')]} 17:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:52 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')]} 17:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:52 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 0x7f3c2e232f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2577410>, '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 0x2578310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25787a0>, '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': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', '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 17:47:52 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 17:47:52 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 17:47:52 INFO - Using env: {'DISPLAY': ':0', 17:47:52 INFO - 'HOME': '/home/cltbld', 17:47:52 INFO - 'LANG': 'en_US.UTF-8', 17:47:52 INFO - 'LANGUAGE': 'en_US:en', 17:47:52 INFO - 'LOGNAME': 'cltbld', 17:47:52 INFO - 'MAIL': '/var/mail/cltbld', 17:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:52 INFO - 'MOZ_NO_REMOTE': '1', 17:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:52 INFO - 'NO_EM_RESTART': '1', 17:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:52 INFO - 'PWD': '/builds/slave/test', 17:47:52 INFO - 'SHELL': '/bin/bash', 17:47:52 INFO - 'SHLVL': '1', 17:47:52 INFO - 'TERM': 'linux', 17:47:52 INFO - 'TMOUT': '86400', 17:47:52 INFO - 'USER': 'cltbld', 17:47:52 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', 17:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:52 INFO - '_': '/tools/buildbot/bin/python'} 17:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:52 INFO - Downloading/unpacking psutil>=0.7.1 17:47:52 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 17:47:52 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 17:47:52 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 17:47:52 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 17:47:52 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 17:47:52 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 17:47:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:47:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:54 INFO - Installing collected packages: psutil 17:47:54 INFO - Running setup.py install for psutil 17:47:54 INFO - building 'psutil._psutil_linux' extension 17:47:54 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 17:47:54 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 17:47:54 INFO - building 'psutil._psutil_posix' extension 17:47:54 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 17:47:54 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 17:47:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:54 INFO - Successfully installed psutil 17:47:54 INFO - Cleaning up... 17:47:54 INFO - Return code: 0 17:47:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:54 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 0x7f3c2e232f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2577410>, '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 0x2578310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25787a0>, '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': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', '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 17:47:54 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 17:47:54 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 17:47:54 INFO - Using env: {'DISPLAY': ':0', 17:47:54 INFO - 'HOME': '/home/cltbld', 17:47:54 INFO - 'LANG': 'en_US.UTF-8', 17:47:54 INFO - 'LANGUAGE': 'en_US:en', 17:47:54 INFO - 'LOGNAME': 'cltbld', 17:47:54 INFO - 'MAIL': '/var/mail/cltbld', 17:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:54 INFO - 'MOZ_NO_REMOTE': '1', 17:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:54 INFO - 'NO_EM_RESTART': '1', 17:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:54 INFO - 'PWD': '/builds/slave/test', 17:47:54 INFO - 'SHELL': '/bin/bash', 17:47:54 INFO - 'SHLVL': '1', 17:47:54 INFO - 'TERM': 'linux', 17:47:54 INFO - 'TMOUT': '86400', 17:47:54 INFO - 'USER': 'cltbld', 17:47:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', 17:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:54 INFO - '_': '/tools/buildbot/bin/python'} 17:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:47:54 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 17:47:54 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 17:47:54 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 17:47:54 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 17:47:54 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 17:47:54 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 17:47:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:47:56 INFO - Installing collected packages: mozsystemmonitor 17:47:56 INFO - Running setup.py install for mozsystemmonitor 17:47:57 INFO - Successfully installed mozsystemmonitor 17:47:57 INFO - Cleaning up... 17:47:57 INFO - Return code: 0 17:47:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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')]} 17:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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', '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 0x7f3c2e232f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2577410>, '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 0x2578310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25787a0>, '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': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', '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 17:47: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:47: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 blobuploader==1.2.4 17:47:57 INFO - Using env: {'DISPLAY': ':0', 17:47:57 INFO - 'HOME': '/home/cltbld', 17:47:57 INFO - 'LANG': 'en_US.UTF-8', 17:47:57 INFO - 'LANGUAGE': 'en_US:en', 17:47:57 INFO - 'LOGNAME': 'cltbld', 17:47:57 INFO - 'MAIL': '/var/mail/cltbld', 17:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:57 INFO - 'MOZ_NO_REMOTE': '1', 17:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:57 INFO - 'NO_EM_RESTART': '1', 17:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:57 INFO - 'PWD': '/builds/slave/test', 17:47:57 INFO - 'SHELL': '/bin/bash', 17:47:57 INFO - 'SHLVL': '1', 17:47:57 INFO - 'TERM': 'linux', 17:47:57 INFO - 'TMOUT': '86400', 17:47:57 INFO - 'USER': 'cltbld', 17:47:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', 17:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:57 INFO - '_': '/tools/buildbot/bin/python'} 17:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:57 INFO - Downloading/unpacking blobuploader==1.2.4 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47:59 INFO - Downloading blobuploader-1.2.4.tar.gz 17:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:47:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:47:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47:59 INFO - Downloading docopt-0.6.1.tar.gz 17:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:47:59 INFO - Installing collected packages: blobuploader, requests, docopt 17:47:59 INFO - Running setup.py install for blobuploader 17:47:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:48:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:48:00 INFO - Running setup.py install for requests 17:48:00 INFO - Running setup.py install for docopt 17:48:00 INFO - Successfully installed blobuploader requests docopt 17:48:00 INFO - Cleaning up... 17:48:00 INFO - Return code: 0 17:48:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:48: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')]} 17:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48: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')]} 17:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:00 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 0x7f3c2e232f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2577410>, '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 0x2578310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25787a0>, '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': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', '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 17:48:00 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 17:48:00 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 17:48:00 INFO - Using env: {'DISPLAY': ':0', 17:48:00 INFO - 'HOME': '/home/cltbld', 17:48:00 INFO - 'LANG': 'en_US.UTF-8', 17:48:00 INFO - 'LANGUAGE': 'en_US:en', 17:48:00 INFO - 'LOGNAME': 'cltbld', 17:48:00 INFO - 'MAIL': '/var/mail/cltbld', 17:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:00 INFO - 'MOZ_NO_REMOTE': '1', 17:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:00 INFO - 'NO_EM_RESTART': '1', 17:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:00 INFO - 'PWD': '/builds/slave/test', 17:48:00 INFO - 'SHELL': '/bin/bash', 17:48:00 INFO - 'SHLVL': '1', 17:48:00 INFO - 'TERM': 'linux', 17:48:00 INFO - 'TMOUT': '86400', 17:48:00 INFO - 'USER': 'cltbld', 17:48:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', 17:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:00 INFO - '_': '/tools/buildbot/bin/python'} 17:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:48:00 INFO - Running setup.py (path:/tmp/pip-IF66pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:48:00 INFO - Running setup.py (path:/tmp/pip-rQvmf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:48:00 INFO - Running setup.py (path:/tmp/pip-8e6Yxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:48:00 INFO - Running setup.py (path:/tmp/pip-xgW5HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:48:01 INFO - Running setup.py (path:/tmp/pip-bE0K6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:48:01 INFO - Running setup.py (path:/tmp/pip-MO0njg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:48:01 INFO - Running setup.py (path:/tmp/pip-RlWMMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:48:01 INFO - Running setup.py (path:/tmp/pip-doXedq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:48:01 INFO - Running setup.py (path:/tmp/pip-moAvBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:48:01 INFO - Running setup.py (path:/tmp/pip-36fNIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:48:01 INFO - Running setup.py (path:/tmp/pip-ADsg8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:48:01 INFO - Running setup.py (path:/tmp/pip-zhJ400-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:48:01 INFO - Running setup.py (path:/tmp/pip-2Zbd2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:48:01 INFO - Running setup.py (path:/tmp/pip-6P1HBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:48:01 INFO - Running setup.py (path:/tmp/pip-wn442J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:48:01 INFO - Running setup.py (path:/tmp/pip-PnNbyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:48:01 INFO - Running setup.py (path:/tmp/pip-_Wgn55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:48:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:48:01 INFO - Running setup.py install for manifestparser 17:48:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:48:02 INFO - Running setup.py install for mozcrash 17:48:02 INFO - Running setup.py install for mozdebug 17:48:02 INFO - Running setup.py install for mozdevice 17:48:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:48:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:48:02 INFO - Running setup.py install for mozfile 17:48:02 INFO - Running setup.py install for mozhttpd 17:48:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:48:02 INFO - Running setup.py install for mozinfo 17:48:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:48:02 INFO - Running setup.py install for mozInstall 17:48:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:48:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:48:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:48:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:48:02 INFO - Running setup.py install for mozleak 17:48:02 INFO - Running setup.py install for mozlog 17:48:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:48:02 INFO - Running setup.py install for moznetwork 17:48:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:48:03 INFO - Running setup.py install for mozprocess 17:48:03 INFO - Running setup.py install for mozprofile 17:48:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:48:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:48:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:48:03 INFO - Running setup.py install for mozrunner 17:48:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:48:03 INFO - Running setup.py install for mozscreenshot 17:48:03 INFO - Running setup.py install for moztest 17:48:03 INFO - Running setup.py install for mozversion 17:48:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:48:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:48:03 INFO - Cleaning up... 17:48:03 INFO - Return code: 0 17:48:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:03 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 0x7f3c2e232f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2577410>, '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 0x2578310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25787a0>, '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': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', '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 17:48:03 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 17:48:03 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 17:48:03 INFO - Using env: {'DISPLAY': ':0', 17:48:03 INFO - 'HOME': '/home/cltbld', 17:48:03 INFO - 'LANG': 'en_US.UTF-8', 17:48:03 INFO - 'LANGUAGE': 'en_US:en', 17:48:03 INFO - 'LOGNAME': 'cltbld', 17:48:03 INFO - 'MAIL': '/var/mail/cltbld', 17:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:03 INFO - 'MOZ_NO_REMOTE': '1', 17:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:03 INFO - 'NO_EM_RESTART': '1', 17:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:03 INFO - 'PWD': '/builds/slave/test', 17:48:03 INFO - 'SHELL': '/bin/bash', 17:48:03 INFO - 'SHLVL': '1', 17:48:03 INFO - 'TERM': 'linux', 17:48:03 INFO - 'TMOUT': '86400', 17:48:03 INFO - 'USER': 'cltbld', 17:48:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', 17:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:03 INFO - '_': '/tools/buildbot/bin/python'} 17:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:48:03 INFO - Running setup.py (path:/tmp/pip-HaOHcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:48:04 INFO - Running setup.py (path:/tmp/pip-IlVQ6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:48:04 INFO - Running setup.py (path:/tmp/pip-HN0SiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:48:04 INFO - Running setup.py (path:/tmp/pip-aWqTF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:48:04 INFO - Running setup.py (path:/tmp/pip-Yqn_V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:48:04 INFO - Running setup.py (path:/tmp/pip-XEPaqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:48:04 INFO - Running setup.py (path:/tmp/pip-U0dawL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:48:04 INFO - Running setup.py (path:/tmp/pip-UPrucg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:48:04 INFO - Running setup.py (path:/tmp/pip-0H0x91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:48:04 INFO - Running setup.py (path:/tmp/pip-vwzP2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:48:04 INFO - Running setup.py (path:/tmp/pip-nowhOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:48:04 INFO - Running setup.py (path:/tmp/pip-0Oth9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:48:04 INFO - Running setup.py (path:/tmp/pip-lhSH94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:48:04 INFO - Running setup.py (path:/tmp/pip-YB2508-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:48:04 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)) 17:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:48:04 INFO - Running setup.py (path:/tmp/pip-oP4Bhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:48:05 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)) 17:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:48:05 INFO - Running setup.py (path:/tmp/pip-kgWcHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:48:05 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)) 17:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:48:05 INFO - Running setup.py (path:/tmp/pip-17wfMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:48:05 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)) 17:48:05 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)) 17:48:05 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)) 17:48:05 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)) 17:48:05 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)) 17:48:05 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)) 17:48:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:07 INFO - Downloading blessings-1.6.tar.gz 17:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:48:07 INFO - Installing collected packages: blessings 17:48:07 INFO - Running setup.py install for blessings 17:48:07 INFO - Successfully installed blessings 17:48:07 INFO - Cleaning up... 17:48:07 INFO - Return code: 0 17:48:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:48:07 INFO - Reading from file tmpfile_stdout 17:48:07 INFO - Current package versions: 17:48:07 INFO - argparse == 1.2.1 17:48:07 INFO - blessings == 1.6 17:48:07 INFO - blobuploader == 1.2.4 17:48:07 INFO - docopt == 0.6.1 17:48:07 INFO - manifestparser == 1.1 17:48:07 INFO - mozInstall == 1.12 17:48:07 INFO - mozcrash == 0.17 17:48:07 INFO - mozdebug == 0.1 17:48:07 INFO - mozdevice == 0.48 17:48:07 INFO - mozfile == 1.2 17:48:07 INFO - mozhttpd == 0.7 17:48:07 INFO - mozinfo == 0.9 17:48:07 INFO - mozleak == 0.1 17:48:07 INFO - mozlog == 3.1 17:48:07 INFO - moznetwork == 0.27 17:48:07 INFO - mozprocess == 0.22 17:48:07 INFO - mozprofile == 0.28 17:48:07 INFO - mozrunner == 6.11 17:48:07 INFO - mozscreenshot == 0.1 17:48:07 INFO - mozsystemmonitor == 0.0 17:48:07 INFO - moztest == 0.7 17:48:07 INFO - mozversion == 1.4 17:48:07 INFO - psutil == 3.1.1 17:48:07 INFO - requests == 1.2.3 17:48:07 INFO - wsgiref == 0.1.2 17:48:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:07 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 0x7f3c2e232f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2577410>, '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 0x2578310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25787a0>, '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': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', '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 17:48:07 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 17:48:07 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 17:48:07 INFO - Using env: {'DISPLAY': ':0', 17:48:07 INFO - 'HOME': '/home/cltbld', 17:48:07 INFO - 'LANG': 'en_US.UTF-8', 17:48:07 INFO - 'LANGUAGE': 'en_US:en', 17:48:07 INFO - 'LOGNAME': 'cltbld', 17:48:07 INFO - 'MAIL': '/var/mail/cltbld', 17:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:07 INFO - 'MOZ_NO_REMOTE': '1', 17:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:07 INFO - 'NO_EM_RESTART': '1', 17:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:07 INFO - 'PWD': '/builds/slave/test', 17:48:07 INFO - 'SHELL': '/bin/bash', 17:48:07 INFO - 'SHLVL': '1', 17:48:07 INFO - 'TERM': 'linux', 17:48:07 INFO - 'TMOUT': '86400', 17:48:07 INFO - 'USER': 'cltbld', 17:48:07 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', 17:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:07 INFO - '_': '/tools/buildbot/bin/python'} 17:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:07 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)) 17:48:07 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)) 17:48:07 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)) 17:48:07 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)) 17:48:07 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)) 17:48:07 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)) 17:48:07 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)) 17:48:07 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)) 17:48:07 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)) 17:48:07 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)) 17:48:07 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)) 17:48:07 INFO - Cleaning up... 17:48:07 INFO - Return code: 0 17:48:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c2e232f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2577410>, '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 0x2578310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25787a0>, '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': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', '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 17:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:48:07 INFO - Using env: {'DISPLAY': ':0', 17:48:07 INFO - 'HOME': '/home/cltbld', 17:48:07 INFO - 'LANG': 'en_US.UTF-8', 17:48:07 INFO - 'LANGUAGE': 'en_US:en', 17:48:07 INFO - 'LOGNAME': 'cltbld', 17:48:07 INFO - 'MAIL': '/var/mail/cltbld', 17:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:07 INFO - 'MOZ_NO_REMOTE': '1', 17:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:07 INFO - 'NO_EM_RESTART': '1', 17:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:07 INFO - 'PWD': '/builds/slave/test', 17:48:07 INFO - 'SHELL': '/bin/bash', 17:48:07 INFO - 'SHLVL': '1', 17:48:07 INFO - 'TERM': 'linux', 17:48:07 INFO - 'TMOUT': '86400', 17:48:07 INFO - 'USER': 'cltbld', 17:48:07 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', 17:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:07 INFO - '_': '/tools/buildbot/bin/python'} 17:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:07 INFO - Downloading/unpacking jsonschema 17:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:48:09 INFO - Downloading/unpacking functools32 (from jsonschema) 17:48:09 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 17:48:09 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 17:48:09 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 17:48:09 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 17:48:09 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 17:48:09 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 17:48:10 INFO - Downloading functools32-3.2.3-2.tar.gz 17:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:48:10 INFO - warning: no files found matching '*.txt' 17:48:10 INFO - no previously-included directories found matching 'build' 17:48:10 INFO - no previously-included directories found matching 'dist' 17:48:10 INFO - no previously-included directories found matching '.git*' 17:48:10 INFO - Installing collected packages: jsonschema, functools32 17:48:10 INFO - Running setup.py install for functools32 17:48:10 INFO - warning: no files found matching '*.txt' 17:48:10 INFO - no previously-included directories found matching 'build' 17:48:10 INFO - no previously-included directories found matching 'dist' 17:48:10 INFO - no previously-included directories found matching '.git*' 17:48:10 INFO - Successfully installed jsonschema functools32 17:48:10 INFO - Cleaning up... 17:48:10 INFO - Return code: 0 17:48:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:10 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 0x7f3c2e232f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2577410>, '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 0x2578310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25787a0>, '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': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', '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 17:48:10 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 17:48:10 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 17:48:10 INFO - Using env: {'DISPLAY': ':0', 17:48:10 INFO - 'HOME': '/home/cltbld', 17:48:10 INFO - 'LANG': 'en_US.UTF-8', 17:48:10 INFO - 'LANGUAGE': 'en_US:en', 17:48:10 INFO - 'LOGNAME': 'cltbld', 17:48:10 INFO - 'MAIL': '/var/mail/cltbld', 17:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:10 INFO - 'MOZ_NO_REMOTE': '1', 17:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:10 INFO - 'NO_EM_RESTART': '1', 17:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:10 INFO - 'PWD': '/builds/slave/test', 17:48:10 INFO - 'SHELL': '/bin/bash', 17:48:10 INFO - 'SHLVL': '1', 17:48:10 INFO - 'TERM': 'linux', 17:48:10 INFO - 'TMOUT': '86400', 17:48:10 INFO - 'USER': 'cltbld', 17:48:10 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', 17:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:10 INFO - '_': '/tools/buildbot/bin/python'} 17:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:10 INFO - Downloading/unpacking flake8 17:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:48:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:48:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:48:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:48:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:48:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:48:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:48:13 INFO - no previously-included directories found matching 'docs/_build' 17:48:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:48:13 INFO - Running setup.py install for pep8 17:48:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:48:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:48:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:48:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:48:13 INFO - no previously-included directories found matching 'docs/_build' 17:48:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:48:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:48:13 INFO - Cleaning up... 17:48:13 INFO - Return code: 0 17:48:13 INFO - Running post-action listener: _resource_record_post_action 17:48:13 INFO - Running post-action listener: _start_resource_monitoring 17:48:13 INFO - Starting resource monitoring. 17:48:13 INFO - ##### 17:48:13 INFO - ##### Running install step. 17:48:13 INFO - ##### 17:48:13 INFO - Running pre-action listener: _resource_record_pre_action 17:48:13 INFO - Running main action method: install 17:48:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:48:13 INFO - Reading from file tmpfile_stdout 17:48:13 INFO - Detecting whether we're running mozinstall >=1.0... 17:48:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:48:13 INFO - Reading from file tmpfile_stdout 17:48:13 INFO - Output received: 17:48:13 INFO - Usage: mozinstall [options] installer 17:48:13 INFO - Options: 17:48:13 INFO - -h, --help show this help message and exit 17:48:13 INFO - -d DEST, --destination=DEST 17:48:13 INFO - Directory to install application into. [default: 17:48:13 INFO - "/builds/slave/test"] 17:48:13 INFO - --app=APP Application being installed. [default: firefox] 17:48:13 INFO - mkdir: /builds/slave/test/build/application 17:48:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:48:29 INFO - Reading from file tmpfile_stdout 17:48:29 INFO - Output received: 17:48:29 INFO - /builds/slave/test/build/application/firefox/firefox 17:48:29 INFO - Running post-action listener: _resource_record_post_action 17:48:29 INFO - ##### 17:48:29 INFO - ##### Running run-tests step. 17:48:29 INFO - ##### 17:48:29 INFO - Running pre-action listener: _resource_record_pre_action 17:48:29 INFO - Running main action method: run_tests 17:48:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:48:29 INFO - Python 2.7.3 17:48:29 INFO - Return code: 0 17:48:29 INFO - grabbing minidump binary from tooltool 17:48:29 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')]} 17:48:29 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 0x2577410>, '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 0x2578310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25787a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:48:29 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 17:48:29 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 17:48:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:48:29 INFO - Return code: 0 17:48:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:48:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:48:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:48:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:48:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:48:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:48:30 INFO - Return code: 0 17:48:30 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/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 17:48:30 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/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 17:48:30 INFO - Using env: {'DISPLAY': ':0', 17:48:30 INFO - 'HOME': '/home/cltbld', 17:48:30 INFO - 'LANG': 'en_US.UTF-8', 17:48:30 INFO - 'LANGUAGE': 'en_US:en', 17:48:30 INFO - 'LOGNAME': 'cltbld', 17:48:30 INFO - 'MAIL': '/var/mail/cltbld', 17:48:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:48:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:30 INFO - 'MOZ_NO_REMOTE': '1', 17:48:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:30 INFO - 'NO_EM_RESTART': '1', 17:48:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:30 INFO - 'PWD': '/builds/slave/test', 17:48:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:48:30 INFO - 'SHELL': '/bin/bash', 17:48:30 INFO - 'SHLVL': '1', 17:48:30 INFO - 'TERM': 'linux', 17:48:30 INFO - 'TMOUT': '86400', 17:48:30 INFO - 'USER': 'cltbld', 17:48:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464395356.936537-509041690', 17:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:30 INFO - '_': '/tools/buildbot/bin/python'} 17:48:30 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/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 17:48:30 INFO - mozversion application_buildid: 20160527151144 17:48:30 INFO - mozversion application_changeset: f8e493cd1e87a482c0246f4a8fe4229142bc1ccc 17:48:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:48:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:48:30 INFO - mozversion application_name: Firefox 17:48:30 INFO - mozversion application_remotingname: firefox-dev 17:48:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:48:30 INFO - mozversion application_vendor: Mozilla 17:48:30 INFO - mozversion application_version: 48.0a2 17:48:30 INFO - mozversion platform_buildid: 20160527151144 17:48:30 INFO - mozversion platform_changeset: f8e493cd1e87a482c0246f4a8fe4229142bc1ccc 17:48:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:48:30 INFO - mozversion platform_version: 48.0a2 17:48:30 INFO - using testdate: 1464396510 17:48:30 INFO - actual date: 1464396510 17:48:30 INFO - starting webserver on 'localhost:46750' 17:48:30 INFO - SUITE-START | Running 2 tests 17:48:30 INFO - TEST-START | dromaeo_css 17:48:30 INFO - operating with platform_type : linux_ 17:48:30 INFO - Initialising browser for dromaeo_css test... 17:48:30 INFO - TEST-INFO | started process 31610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppAbW_2/profile http://localhost:46750/getInfo.html) 17:48:34 INFO - PROCESS | 31610 | __metrics Screen width/height:1600/1200 17:48:34 INFO - PROCESS | 31610 | colorDepth:24 17:48:34 INFO - PROCESS | 31610 | Browser inner width/height: 1024/697 17:48:34 INFO - PROCESS | 31610 | __metrics 17:48:35 ERROR - PROCESS | 31610 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:48:36 INFO - TEST-INFO | 31610: exit 0 17:48:36 INFO - Browser initialized. 17:48:36 INFO - Running cycle 1/1 for dromaeo_css test... 17:48:36 INFO - TEST-INFO | started process 31699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppAbW_2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:48:48 INFO - PROCESS | 31699 | RSS: Main: 142077952 17:48:48 INFO - PROCESS | 31699 | 17:49:39 INFO - PROCESS | 31699 | 1464396579301 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] 17:51:47 INFO - PROCESS | 31699 | Cycle 1(1): loaded http://localhost:46750/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46750/tests/dromaeo/cssquery-ext.html) 17:51:48 INFO - PROCESS | 31699 | RSS: Main: 251092992 17:51:48 INFO - PROCESS | 31699 | 17:54:50 INFO - PROCESS | 31699 | Cycle 1(1): loaded http://localhost:46750/tests/dromaeo/cssquery-ext.html (next: http://localhost:46750/tests/dromaeo/cssquery-jquery.html) 17:54:50 INFO - PROCESS | 31699 | RSS: Main: 232222720 17:54:50 INFO - PROCESS | 31699 | 17:57:52 INFO - PROCESS | 31699 | Cycle 1(1): loaded http://localhost:46750/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46750/tests/dromaeo/cssquery-mootools.html) 17:57:53 INFO - PROCESS | 31699 | RSS: Main: 219828224 17:57:53 INFO - PROCESS | 31699 | 18:00:55 INFO - PROCESS | 31699 | Cycle 1(1): loaded http://localhost:46750/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46750/tests/dromaeo/cssquery-prototype.html) 18:00:55 INFO - PROCESS | 31699 | RSS: Main: 213327872 18:00:55 INFO - PROCESS | 31699 | 18:03:58 INFO - PROCESS | 31699 | Cycle 1(1): loaded http://localhost:46750/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46750/tests/dromaeo/cssquery-yui.html) 18:03:59 INFO - PROCESS | 31699 | RSS: Main: 190439424 18:03:59 INFO - PROCESS | 31699 | 18:07:01 INFO - PROCESS | 31699 | Cycle 1(1): loaded http://localhost:46750/tests/dromaeo/cssquery-yui.html (next: http://localhost:46750/tests/dromaeo/cssquery-dojo.html) 18:07:01 INFO - PROCESS | 31699 | RSS: Main: 232542208 18:07:01 INFO - PROCESS | 31699 | 18:07:01 INFO - PROCESS | 31699 | __start_tp_report 18:07:01 INFO - PROCESS | 31699 | _x_x_mozilla_page_load 18:07:01 INFO - PROCESS | 31699 | _x_x_mozilla_page_load_details 18:07:01 INFO - PROCESS | 31699 | |i|pagename|runs| 18:07:01 INFO - PROCESS | 31699 | |0;dojo.html;3336.549565808616;3371.4942758586217;3385.9322813543713;3418.1625501752073;3435.1412146963257;5578.776848926043;5663.915041274379;5673.347565030022;5695.601307908448;5711.428857114286;5607.4112218217115;5619.943800561993;5666.801661941833;5696.145578163278;5699.971500142494;4904.803807847699;5124.590032797377;5215.348081489814;5276.657017293883;5295.576353891699;5030.320906677606;5062.114130027249;5065.265536497206;5069.188929771238;5069.315642388267;5077.873053173682;5172.146595811705;5193.870153246161;5213.087709650796;5225.346831646044;5193.896122077556;5207.583393328562;5224.111900976805;5225.947740522584;5254.422013578523;4874.268859671042;4991.875203119915;5065.746712664352;5123.513266239701;5130.281760553526;5398.514133727944;5424.620276580641;5426.538744206708;5431.809886653988;5449.945500544984;6026.698665066773;6059.151718759377;6067.848303792396;6072;6074.331823499456;6037.577369584131;6079.750492317827;6080.665563394012;6098.512119030467;6098.54260930432;5657.603967722261;5700.885982280372;5702.942970570324;5705.286839145107;5710.2576665033275;5922.644641321534;6214.40963108504;6233.96883015582;6240.095186197976;6241.625502469867;5930.614510056833;5979.1629171915965;5987.341392446828;5994.190784244071;5998.310194327621;6025.728842202111;6038.33578306386;6043.335233124353;6045.123457098696;6046.727897244635;5866.1494083357675;5901.704914754245;5980.641161530322;5991.970040149771;5995.280566332068;6054.031354983182;6064.090386442069;6068.6358818471035;6072.271327440647;6108;4600.4479462464715;4611.100835337077;4611.584957353854;4615.123126605934;4643.349931009661;4027.859024934113;4055.1281474483126;4074.0629655179473;4116.320807066801;4134.627883490441;5501.5323697486165;5584;5607.018771715015;5621.072523033654;5666.121751128499;5900.0264956281735;5900.262467191601;5901.439363260483;5901.527877769854;5919.852003699856;5558.805441809598;5572.4706152915405;5656.745446454919;5669.659820410789;5692.686902220417;5062.11413002723;5101.642884998015;5103.260027296095;5104.03023425548;5104.591632669378;6199.318075011745;6209.937900620936;6214.316425193225;6221.2845522764555;6227.408396202353;5716.399778023248;5949.970250148722;5969.462748352582;6032.607880487754;6063.878722425615;6209.534284928739;6213.068039794067;6226.25284965807;6246.063090536456;6252.062190671436;5860.706964651665;5861.7655293787775;5864.44287792659;5869.735861886311;5906.173135761082;5804.506616937608;5920.259967504062;5976.491998180029;5979.910301345571;5990.251218597676;5840.1531777892815;5841.1238314253205;5845.532357411312;5863.530917526673;5865.208196893535;5727.226824378656;5799;5838.065909454467;5851.561132914963;5859.44335288147;5741.770329186953;5748.109043098327;5763.7118144093465;5771.509421699203;5794.7102644866745;5880.500157486662;5885.234919460443;5896.233489646319;5904.852378690567;5905.43898329658;5641.15382692583;5684.545236381162;5775.884482310415;5785.623934444247;5822.155787410887 18:07:01 INFO - PROCESS | 31699 | |1;ext.html;667.2993356975174;670.9664516774161;681.6796105830261;748.3190296829882;765.0207734100353;32828.67171328286;40062;40552;40593.39109913346;40685.79657101718;42266.78866605663;42762;42928.14143717124;42930.78534607323;42938.78530607351;8090.757277281691;8236.258736713695;8810.559472026405;9004.369694121415;10387.22095842811;10334.948325258401;10463.215258855578;10469.214808889326;10476.790464190712;10485.68542943713;10519.05328520433;10576.10103141234;10576.735581610483;10577.418241996687;10586.735331616694;8284.792880178014;10478.947605262001;10579.418132002736;10588.841167382496;10614.893851061468;10643.254972151952;10737.785244295148;10742.570297188182;10744.516496757664;10746.838797418044;40581.39127913054;40787;41064.38403423951;41161.588384116076;41201.58798412007;3797.0886987123167;3838.500994870677;3971.344728119857;3996.500437445319;4335.479742430897;34621;34904.47643285353;35042;35982.46026309607;36931.4460283096;4002.1795531915886;4019.075612609087;4089.2230476209725;4124.381342798574;4167.91664166715;335633;335765;338721;338755;342300;41216.79391603023;42069.78965105155;42095.15809683789;68653.65673171602;69442.3055769446;39341;39508;39601.20797584032;39603.80198098991;39732.801335993136;16317.918410407872;16882.15589220534;17087.231074601674;17102.914485427493;17140.314387424613;14835.703285934222;15171.468998584996;15172.089674619338;15188.164650944083;15204.543863683886;9482.38364506305;9552.188064014637;9558.426494410358;9597.136257736698;9600.039996000343;3630.40098383769;3660.633936606371;3699.9260014800093;3795.6204379561823;3833.501644786216;1143.988560114405;1191.4995701805262;1192.6839387562302;1222.9633111006683;1283.5058502476613;32963;34026.82986585101;34363.4845477318;34405.82797085999;34430.82784586061;1254.4731212890608;1258.6224132760135;1307.9673008174682;1324.2385628263787;1403.3123769352944;17473.47579572615;17574.12129393525;17820.821791782175;17861;17879.463616091278;466538;470438;471521;471567;471596;62126.378736212966;63005.68497157576;63040.684796575726;63071.053934191026;63364.36635633585;1504.353128154882;1515.0303805564447;1549.8295187529363;1555.7977462929973;1641.2696350124081;30600;31355.216119597193;31853.681463186;32735.18162045968;32817.67182328146;48298.75850620725;49070.263946040126;49187.50812491829;49207.50792492172;49264;246904;250229;250543;250839;251480;28602.85698571577;30686.386272273983;30851.382972340878;31472.527912081794;31479.84260078685;44372.55627443813;44459.777701111285;44803.10393792171;44849;45108.77445612751;35596.82201588975;36825;37624.811875940446;37971.81014094912;38203;37301.440478393386;40134.397984030846;41237.38143927904;41368;41776.1644767109;41399.7930010348;41453.17093658049;42746.78626606847;42783;42795.35806962836;34533.82733086318;35625.643743562236;35819;35873.46189807103;36402.817985909904;28102.85948570326;28173;28275.71724282813;28401.43197136087;28570 18:07:01 INFO - PROCESS | 31699 | |2;jquery.html;407.9755214687119;410.9280875846726;413.8675623800384;422.2800125785534;422.44659496060166;14093.577192684235;19135.617287654237;19817.306394276202;19836.50408739782;20057.498562535944;15469.1491967942;17594.472165835014;18217.817821821776;18284.177212025457;18681.159347829347;5514.0901751211;5644.774209031634;5657.9717101414435;5660.745266463019;5677.48902598766;5582.609217354787;5598.2442370280105;5605.579581531381;5616.69108199051;5643.858903527424;4244.448221731171;4379;6017;6245.032020036879;6246.875062498747;6014;6200.131981522591;6209.410106039919;6238.625682459067;6244.937550624481;5543.473370029841;5576.302962129734;5581.05122129239;5589.580781441408;5591.580631452657;22769;22889.77110228893;23419.765802341928;23616;23660.526789464286;2474.4061425257987;2503.486785209028;2530.8101892357963;2574.6652935118314;2868.268591509152;14361.353739081766;14847.480338188112;15020.849791502163;15410.460633877761;15454.459093931771;1896.8861868287809;1922.5097600111883;1997.4107638246753;2013.9496512587157;2114.270576651053;80286.59856700679;81427.59286203531;82709;82893;83334.58332708298;10395.428251446092;10831.945840270906;10893.183011274186;10914.727131821768;10941.28881622692;15067.397304107932;15174.544763657108;15286.235688215767;15318.923405382902;15336.616584585252;8344.916550834414;8415.747527574182;8472.74581762548;8676.696315628922;8772.473651580925;8854.690085846965;8963.641454341754;8980.191782739585;9060.95469522648;9073.22877555402;6018.2176317079375;6335.334789847092;6687.297833727486;6895.862082758316;6974.860502789916;1802.4322338463342;1812.3566134022233;1824.333682898358;1829.1494455078453;1832.1572076844534;1082.680609220282;1144.9542018319173;1183.615325019355;1195.2410219510673;1250.2873362183468;18968.715469267972;19050.904745476462;19664.901675491532;19802.801971980385;19861.98769673243;1123.8707548631849;1124.7300647844459;1159.1480262007417;1203.253982530819;1253.3357320620087;11094.223404361617;11281.661550153509;11306.265092769108;11364.431778411046;11532.308061516336;448014;451341;451993;467880;496034;78799.60600196962;79886.20113798903;80816.59591702122;81296.18703813004;81932.59033704794;1098.4782228441586;1126.6676330482528;1167.5913430299327;1181.2676140792591;1188.5958774016876;17148.055037709746;17395.217215225093;17429.215685293937;17481.912590436965;17508.562285942953;37404.81297593495;37497;37962.24075518419;38913.41629875611;38968;51058.48941510686;51319.74340128276;51443.48556514387;51530.48469515257;51657.74171129271;8658.696945606873;8749.65001399937;8818.206361427503;8907.866382004146;9005.279577633904;12549.372531373578;13519.188848669111;13602.319884005563;13732.65668358299;14191;11729.237599556001;12360.196587221802;12399.566015189424;12451.937740311241;12798.424070917017;11598.88401115978;11604.419779011185;11951.462184201559;12131.514739410324;12290.815637765261;12258.71283515218;12270.81593776112;12301.876981230072;12474.251544907334;12853.93573032129;8243.381746368927;8392.664293428195;8429.662813487392;8591.570421479026;8763.561821908752;10436.269461137648;10761.192910531585;10828.566857325619;10847.511861966388;11082.113430925669 18:07:01 INFO - PROCESS | 31699 | |3;mootools.html;1336.725971175909;1552.4643997820751;1578.4317645647568;1792.7759030121235;1940.8253257206857;8004.519728816268;8225.38309626779;8226.958865205666;8247.711330103448;8263.33893288537;8200.138985406536;8414.116517765622;8426.410151289398;8427.410081294312;8439.240468357846;2187.3547303545492;2403.3751224681623;2454.754524547549;2471.616899380599;2482.6648402465707;2482.1808803094937;2494.538510375586;2537.6320433537126;2538.9111381101666;2543.923682289534;2476.2199907029226;2484.8757562121914;2485.291691867818;2489.2034548944343;2493.13986674597;2142.6143294207036;2364.8344615876895;2379.6430535419654;2385.248646676309;2388.5939390303515;2348.213348528245;2348.43637526994;2351.306364622423;2361;2426.745191754858;8178.263956243907;8257.298129658926;8266.256036956642;8267.090620031791;8269.751907442786;5332.840014799563;5478.397376288605;5483.917741233885;5520.337559492847;5526;3615.6384361563896;3661.6521430464063;3711.795851228181;3722;3722.0694826293425;1170.631251155883;1173.7124404520862;1187.234233919126;1202.1044321980094;1216.4282787090142;11685.298882067103;11856.46645900928;11858.051355891508;11881.881181188164;11890.28658280506;4636.884077898079;4769.57073863354;4793.9041219176115;4802.423709154924;4893.486183950705;10420.11429028541;10430.634927777492;10438.63464778729;10444.63443779464;10445.68662940113;4876.4879687633;5430.8913821723345;5432.239486471897;5436.592255580847;5436.7553460093595;4475.619572336323;4481.910361792746;4483.663725220556;4935.037667654773;4954.058728841508;3981.7411868228473;4036.334004889219;4075.2460794753065;4075.2460794753065;4138.751674899456;1332.1673953778889;1335.5392389625563;1342.3690865293297;1343.7245364700213;1362.1214316765631;993.6621548673342;1028.8816786069697;1036.5180191210973;1051.1013083813382;1055.8205105132147;5707.46280488106;5770;5775.537956963517;5840.386759390288;5932.644041357532;456.2175868385734;461.6722127289595;462.13811242034035;482.6573133075486;483.8209862350953;3821.082940094357;3975.92048159041;4000.19996000801;4002.9199416011515;4015.156817068448;10183.54174062169;10510.842337364946;10529.526171322155;10577.524011419504;10680.839787403194;10379.11777498906;10421.270511064153;10421.791564168674;10423.895761042444;10428.374297542172;7811.453198276066;8010.078840933367;8111;8158.184181581794;8164.836703265902;5254.264402983509;5273.6044796639635;5360.571154307724;5422.728863556727;5436.075867102523;9021.37615229265;9189.448633082036;9202.953985230031;9343.112404321579;9371.718848434557;9244.075592440702;9350.392224505385;9504.952475237857;9673.177779888789;9699.70900872975;6895.310468953065;7080.716771329089;7448.14346350155;7518.398528117847;7702.229777022253;8268.586570671563;8277.95861020691;8321.916780832114;8349.373796965374;8354.45696029756;7408.370288525536;7469.290417410337;7543.132539757778;7604.315611594983;7660.502067365604;7356.558606483628;7385;7430.182679905314;7514.436417268617;7521.5111017783665;6742.494312926452;6775.051492790914;6796.93203067963;6868.7252509901045;6897.620630865351;5040.420351659606;5106.872328191825;5191.740412979411;5346.43862394443;5391.703456309784;5096.898838807414;5115.462876398074;5123.692578445305;5174.094533456555;5266.868328291824 18:07:01 INFO - PROCESS | 31699 | |4;prototype.html;331.05648900633184;333.7080054951917;341.26798018250855;341.60203363082013;346.1139482923714;6382.457491113255;6405.167328247333;6412.615243085413;6424.903626445601;6458.2895881453005;6032.487238584715;6139.324674285825;6322.272938612049;6372.139761132245;6398.648074355909;4874;4899.583535399495;4902.264660300948;4908.067467181242;4912.410510738717;4888.095702295069;4890.437599676029;4892.363992680965;4894.41267047953;4906.803727850899;4591.885202869938;4650.697704649204;4724.48816378759;4797.664163508556;4841.927371089437;4731.290306454025;4776.641751868624;4785.401824771903;4787.94665173663;4789.784459699322;4140.23405669952;4144.834206631731;4151.543330233671;4151.750894946283;4161.500619925598;6131.662758548278;6136.325004249529;6144.754209831602;6150.477209437203;6158.353372895826;5556.91664625031;5561.499465048165;5562.749676264578;5568.136938774496;5572.665640061609;6469.51478639104;6700.296468870796;6702.497312701518;6721.563098398588;6727.293634168391;4513.616342610882;4535.206338890681;4575.6568257380495;4579.702319349265;4583.610393116589;6960.164780226405;7018;7033.788986330418;7036;7045.823854403629;4635.304704294383;4637.840539865034;4641.976790116028;4645.442546894395;4653.418322709661;4676.672632915731;4698.506656801055;4700.059988002413;4700.412448443944;4701.95298047022;5396.487333703292;5514.393416724157;5518.061929471999;5521;5554.583406244547;6782.152230971129;6813.080234168423;6815.011823285596;6824.965875170592;6841.931580684229;1570.8507691769264;1630.6005028768027;1648.4312912045325;1648.9670206595802;1650.4718490083299;1053.9894601054045;1055.1189756553365;1073.4257172412722;1074.1943542343242;1080.103514083309;6465.288818230085;6501.382368674968;6502.902456463157;6503.057056726842;6508.056331831858;6939.757108501179;6942;6942.8611427772175;6944.965275173693;6953.89569156463;6487.416132547999;6503.154589903377;6503.479721622259;6507.772227972093;6511.967440162769;3707.4994875691436;3746.5129533160516;3752.2307926874923;3755.3803622402543;3756.1736417988;7072.8939065914055;7214.062171917617;7336.633168341668;7359.521631093961;7365.116186057708;7162.068931038932;7201.819954501075;7221.494495385377;7223.530470519399;7249.311315425026;7330.486865919441;7332.96333518329;7336.339729424378;7337.88993165103;7340.229275926058;7034.577925324497;7048.471364647569;7057.024033270693;7063.364297213276;7145.214026456982;6811.182658081062;6934.965325173342;6935.687894044881;6936.271691472322;6951.513394062367;7310.6710198040155;7314.890276645748;7316.634168291671;7341.963290183515;7342.082239720035;4606.769661516978;4647.4655414626395;4648.535146485459;4648.790804413742;4650.674452788272;7010.75462358815;7019.929800702132;7024.506300263537;7024.5434046786795;7037.929620703728;6461.2892581816905;6549.050387693663;6789.388954994074;6790.830229244309;6827.965860170667;6772.55978361405;6793.762218322335;6801.353871382211;6801.5238933274195;6808.046873437822;6628.105205797348;6672.099266598947;6680.331966803281;6696.966515167393;6698.5980841149685;6597.109390232449;6702.162229721285;6834.726610935507;6866.313368663094;6877.724891004304;6677.76627818024;6679.165104361955;6686.364795344434;6688.2977287386075;6688.4983626229205 18:07:01 INFO - PROCESS | 31699 | |5;yui.html;864.7319331007388;901.6348378906541;911.9863202051969;933.5425641435698;938.7183844846544;13853.792193117099;14198.432062717491;14220.857791422082;14290.142591444508;14870.182139982297;14459;14464.566063018126;14639.707205855877;14658.193799341032;14689.045212061208;787.3976408047848;914.4376208631677;921.764949937765;937.3485427627801;943.7310366545536;929.2380248196481;932.4451951089125;933.8272419602362;935.0555938502127;935.5789894547447;972.246508955558;974.1962880623479;979.045430705064;979.8628192053118;982.4252812104927;819.2340161948567;827.5531213144925;829.0672992883007;963.9951800241024;974.9951250243739;722.2163952111965;723.106962900817;723.1466869094467;723.2514347650209;723.7177500774702;14842.703145937021;14954.925225373912;14993.700125997419;15010.849891501055;15030.699386012328;14411.423543058265;14436.78344824818;14807.111573305636;15169.24153792306;15502.61243468911;11799.764004719944;11830.290182589073;11846.703832404173;12346.320952347618;12415.44130514129;4059.3505039193587;4086.3053280942313;4110.547839737626;4172.436721042681;4236.597523235288;55747.44252557504;55902.440975590536;56245.71877140629;56616.71691641516;56973.71513142408;11799.88200118005;11809.763804723858;11821.586244481401;11993.160478766576;12103.394830258629;21009.159633614483;21061;21412.678809817866;21467.67798483024;21469.57060858774;8761.474311541328;8772.824543509221;9005.279577633773;9116.498592577473;9147.131022552847;5091.669041512364;5154.175331946871;5189.3253876996505;5189.584833213334;5223.555997740159;3517.050396393011;3566.982165089158;3569.37535931211;3572.160542272564;3574.267275208576;633.1547384242089;635.6249812610582;646.0664340028708;657.6185812228896;665.2848188197706;759.5594555157995;784.1178673991759;805.3436449293807;805.5569436809732;816.808050108236;9242.768930776785;9274.814503710022;9303.674371396968;9440.90559094414;9466.1953733932;643.5816719132602;704.4962851561158;779.2324560308092;795.2861583288023;797.5175019113353;4329.6969212154845;4550.271956486946;4558.544145585415;4572.7942242599165;4644.419447569054;62390.376096239364;62461.68769156125;62544.37455625476;64981;66094.66952665205;57052.144217836765;58605.41394586;58798;58843.99826014751;58871;50639.746801265755;51594.484055159715;51613.74193129085;51940.740296298274;52598.73700631549;8619.310455163697;8694.130586941508;8852.911470885208;8930.687425940061;9030.593623286837;37973.81013094917;38971.6102838968;39346.213075738895;39536.40695389514;40085.398719019824;46597.06805863796;46939.76530117328;50367;50875.491245087076;50942;11959.760804783682;12061.51753929868;12192.390380481118;12994.80507792365;13151.934240328737;13703.177809331472;14471.49349772753;14597.270136493345;14644.853551464348;15364.308606112976;10523.4738263085;13265.270410127536;13319.733605327645;13453.192808431526;13812.585622431343;12498.875011250135;12604.180728253;13330.666733331744;13405.932970335087;13419.530316438877;12494.812577811523;12662.366881656064;12701.555445559361;12748;12767.808482872579;10925.781484370427;11057.944710276397;11221.831672525082;11245.71885702864;11267.211295209258;10749.516271767945;11177.317443813588;11201.71995700114;11251.7749645005;11325.773484530428 18:07:01 INFO - PROCESS | 31699 | __end_tp_report 18:07:01 INFO - PROCESS | 31699 | __start_cc_report 18:07:01 INFO - PROCESS | 31699 | _x_x_mozilla_cycle_collect,869 18:07:01 INFO - PROCESS | 31699 | __end_cc_report 18:07:01 INFO - PROCESS | 31699 | __startTimestamp1464397621530__endTimestamp 18:07:01 INFO - PROCESS | 31699 | 18:07:01 INFO - PROCESS | 31699 | ------- Summary: start ------- 18:07:01 INFO - PROCESS | 31699 | Number of tests: 6 18:07:01 INFO - PROCESS | 31699 | 18:07:01 INFO - PROCESS | 31699 | [#0] dojo.html Cycles:165 Average:5576.56 Median:5771.51 stddev:617.93 (10.7%) stddev-sans-first:594.31 18:07:01 INFO - PROCESS | 31699 | Values: 3336.5 3371.5 3385.9 3418.2 3435.1 5578.8 5663.9 5673.3 5695.6 5711.4 5607.4 5619.9 5666.8 5696.1 5700.0 4904.8 5124.6 5215.3 5276.7 5295.6 5030.3 5062.1 5065.3 5069.2 5069.3 5077.9 5172.1 5193.9 5213.1 5225.3 5193.9 5207.6 5224.1 5225.9 5254.4 4874.3 4991.9 5065.7 5123.5 5130.3 5398.5 5424.6 5426.5 5431.8 5449.9 6026.7 6059.2 6067.8 6072.0 6074.3 6037.6 6079.8 6080.7 6098.5 6098.5 5657.6 5700.9 5702.9 5705.3 5710.3 5922.6 6214.4 6234.0 6240.1 6241.6 5930.6 5979.2 5987.3 5994.2 5998.3 6025.7 6038.3 6043.3 6045.1 6046.7 5866.1 5901.7 5980.6 5992.0 5995.3 6054.0 6064.1 6068.6 6072.3 6108.0 4600.4 4611.1 4611.6 4615.1 4643.3 4027.9 4055.1 4074.1 4116.3 4134.6 5501.5 5584.0 5607.0 5621.1 5666.1 5900.0 5900.3 5901.4 5901.5 5919.9 5558.8 5572.5 5656.7 5669.7 5692.7 5062.1 5101.6 5103.3 5104.0 5104.6 6199.3 6209.9 6214.3 6221.3 6227.4 5716.4 5950.0 5969.5 6032.6 6063.9 6209.5 6213.1 6226.3 6246.1 6252.1 5860.7 5861.8 5864.4 5869.7 5906.2 5804.5 5920.3 5976.5 5979.9 5990.3 5840.2 5841.1 5845.5 5863.5 5865.2 5727.2 5799.0 5838.1 5851.6 5859.4 5741.8 5748.1 5763.7 5771.5 5794.7 5880.5 5885.2 5896.2 5904.9 5905.4 5641.2 5684.5 5775.9 5785.6 5822.2 18:07:01 INFO - PROCESS | 31699 | 18:07:01 INFO - PROCESS | 31699 | [#1] ext.html Cycles:180 Average:52016.06 Median:20016.61 stddev:96210.15 (480.7%) stddev-sans-first:96402.80 18:07:01 INFO - PROCESS | 31699 | Values: 667.3 671.0 681.7 748.3 765.0 32828.7 40062.0 40552.0 40593.4 40685.8 42266.8 42762.0 42928.1 42930.8 42938.8 8090.8 8236.3 8810.6 9004.4 10387.2 10334.9 10463.2 10469.2 10476.8 10485.7 10519.1 10576.1 10576.7 10577.4 10586.7 8284.8 10478.9 10579.4 10588.8 10614.9 10643.3 10737.8 10742.6 10744.5 10746.8 40581.4 40787.0 41064.4 41161.6 41201.6 3797.1 3838.5 3971.3 3996.5 4335.5 34621.0 34904.5 35042.0 35982.5 36931.4 4002.2 4019.1 4089.2 4124.4 4167.9 335633.0 335765.0 338721.0 338755.0 342300.0 41216.8 42069.8 42095.2 68653.7 69442.3 39341.0 39508.0 39601.2 39603.8 39732.8 16317.9 16882.2 17087.2 17102.9 17140.3 14835.7 15171.5 15172.1 15188.2 15204.5 9482.4 9552.2 9558.4 9597.1 9600.0 3630.4 3660.6 3699.9 3795.6 3833.5 1144.0 1191.5 1192.7 1223.0 1283.5 32963.0 34026.8 34363.5 34405.8 34430.8 1254.5 1258.6 1308.0 1324.2 1403.3 17473.5 17574.1 17820.8 17861.0 17879.5 466538.0 470438.0 471521.0 471567.0 471596.0 62126.4 63005.7 63040.7 63071.1 63364.4 1504.4 1515.0 1549.8 1555.8 1641.3 30600.0 31355.2 31853.7 32735.2 32817.7 48298.8 49070.3 49187.5 49207.5 49264.0 246904.0 250229.0 250543.0 250839.0 251480.0 28602.9 30686.4 30851.4 31472.5 31479.8 44372.6 44459.8 44803.1 44849.0 45108.8 35596.8 36825.0 37624.8 37971.8 38203.0 37301.4 40134.4 41237.4 41368.0 41776.2 41399.8 41453.2 42746.8 42783.0 42795.4 34533.8 35625.6 35819.0 35873.5 36402.8 28102.9 28173.0 28275.7 28401.4 28570.0 18:07:01 INFO - PROCESS | 31699 | 18:07:01 INFO - PROCESS | 31699 | [#2] jquery.html Cycles:180 Average:27921.57 Median:22829.39 stddev:76200.01 (333.8%) stddev-sans-first:76385.77 18:07:01 INFO - PROCESS | 31699 | Values: 408.0 410.9 413.9 422.3 422.4 14093.6 19135.6 19817.3 19836.5 20057.5 15469.1 17594.5 18217.8 18284.2 18681.2 5514.1 5644.8 5658.0 5660.7 5677.5 5582.6 5598.2 5605.6 5616.7 5643.9 4244.4 4379.0 6017.0 6245.0 6246.9 6014.0 6200.1 6209.4 6238.6 6244.9 5543.5 5576.3 5581.1 5589.6 5591.6 22769.0 22889.8 23419.8 23616.0 23660.5 2474.4 2503.5 2530.8 2574.7 2868.3 14361.4 14847.5 15020.8 15410.5 15454.5 1896.9 1922.5 1997.4 2013.9 2114.3 80286.6 81427.6 82709.0 82893.0 83334.6 10395.4 10831.9 10893.2 10914.7 10941.3 15067.4 15174.5 15286.2 15318.9 15336.6 8344.9 8415.7 8472.7 8676.7 8772.5 8854.7 8963.6 8980.2 9061.0 9073.2 6018.2 6335.3 6687.3 6895.9 6974.9 1802.4 1812.4 1824.3 1829.1 1832.2 1082.7 1145.0 1183.6 1195.2 1250.3 18968.7 19050.9 19664.9 19802.8 19862.0 1123.9 1124.7 1159.1 1203.3 1253.3 11094.2 11281.7 11306.3 11364.4 11532.3 448014.0 451341.0 451993.0 467880.0 496034.0 78799.6 79886.2 80816.6 81296.2 81932.6 1098.5 1126.7 1167.6 1181.3 1188.6 17148.1 17395.2 17429.2 17481.9 17508.6 37404.8 37497.0 37962.2 38913.4 38968.0 51058.5 51319.7 51443.5 51530.5 51657.7 8658.7 8749.7 8818.2 8907.9 9005.3 12549.4 13519.2 13602.3 13732.7 14191.0 11729.2 12360.2 12399.6 12451.9 12798.4 11598.9 11604.4 11951.5 12131.5 12290.8 12258.7 12270.8 12301.9 12474.3 12853.9 8243.4 8392.7 8429.7 8591.6 8763.6 10436.3 10761.2 10828.6 10847.5 11082.1 18:07:01 INFO - PROCESS | 31699 | 18:07:01 INFO - PROCESS | 31699 | [#3] mootools.html Cycles:180 Average:5651.87 Median:2680.15 stddev:3110.27 (116.0%) stddev-sans-first:3102.08 18:07:01 INFO - PROCESS | 31699 | Values: 1336.7 1552.5 1578.4 1792.8 1940.8 8004.5 8225.4 8227.0 8247.7 8263.3 8200.1 8414.1 8426.4 8427.4 8439.2 2187.4 2403.4 2454.8 2471.6 2482.7 2482.2 2494.5 2537.6 2538.9 2543.9 2476.2 2484.9 2485.3 2489.2 2493.1 2142.6 2364.8 2379.6 2385.2 2388.6 2348.2 2348.4 2351.3 2361.0 2426.7 8178.3 8257.3 8266.3 8267.1 8269.8 5332.8 5478.4 5483.9 5520.3 5526.0 3615.6 3661.7 3711.8 3722.0 3722.1 1170.6 1173.7 1187.2 1202.1 1216.4 11685.3 11856.5 11858.1 11881.9 11890.3 4636.9 4769.6 4793.9 4802.4 4893.5 10420.1 10430.6 10438.6 10444.6 10445.7 4876.5 5430.9 5432.2 5436.6 5436.8 4475.6 4481.9 4483.7 4935.0 4954.1 3981.7 4036.3 4075.2 4075.2 4138.8 1332.2 1335.5 1342.4 1343.7 1362.1 993.7 1028.9 1036.5 1051.1 1055.8 5707.5 5770.0 5775.5 5840.4 5932.6 456.2 461.7 462.1 482.7 483.8 3821.1 3975.9 4000.2 4002.9 4015.2 10183.5 10510.8 10529.5 10577.5 10680.8 10379.1 10421.3 10421.8 10423.9 10428.4 7811.5 8010.1 8111.0 8158.2 8164.8 5254.3 5273.6 5360.6 5422.7 5436.1 9021.4 9189.4 9203.0 9343.1 9371.7 9244.1 9350.4 9505.0 9673.2 9699.7 6895.3 7080.7 7448.1 7518.4 7702.2 8268.6 8278.0 8321.9 8349.4 8354.5 7408.4 7469.3 7543.1 7604.3 7660.5 7356.6 7385.0 7430.2 7514.4 7521.5 6742.5 6775.1 6796.9 6868.7 6897.6 5040.4 5106.9 5191.7 5346.4 5391.7 5096.9 5115.5 5123.7 5174.1 5266.9 18:07:01 INFO - PROCESS | 31699 | 18:07:01 INFO - PROCESS | 31699 | [#4] prototype.html Cycles:180 Average:5634.43 Median:6463.29 stddev:1743.56 (27.0%) stddev-sans-first:1702.40 18:07:01 INFO - PROCESS | 31699 | Values: 331.1 333.7 341.3 341.6 346.1 6382.5 6405.2 6412.6 6424.9 6458.3 6032.5 6139.3 6322.3 6372.1 6398.6 4874.0 4899.6 4902.3 4908.1 4912.4 4888.1 4890.4 4892.4 4894.4 4906.8 4591.9 4650.7 4724.5 4797.7 4841.9 4731.3 4776.6 4785.4 4787.9 4789.8 4140.2 4144.8 4151.5 4151.8 4161.5 6131.7 6136.3 6144.8 6150.5 6158.4 5556.9 5561.5 5562.7 5568.1 5572.7 6469.5 6700.3 6702.5 6721.6 6727.3 4513.6 4535.2 4575.7 4579.7 4583.6 6960.2 7018.0 7033.8 7036.0 7045.8 4635.3 4637.8 4642.0 4645.4 4653.4 4676.7 4698.5 4700.1 4700.4 4702.0 5396.5 5514.4 5518.1 5521.0 5554.6 6782.2 6813.1 6815.0 6825.0 6841.9 1570.9 1630.6 1648.4 1649.0 1650.5 1054.0 1055.1 1073.4 1074.2 1080.1 6465.3 6501.4 6502.9 6503.1 6508.1 6939.8 6942.0 6942.9 6945.0 6953.9 6487.4 6503.2 6503.5 6507.8 6512.0 3707.5 3746.5 3752.2 3755.4 3756.2 7072.9 7214.1 7336.6 7359.5 7365.1 7162.1 7201.8 7221.5 7223.5 7249.3 7330.5 7333.0 7336.3 7337.9 7340.2 7034.6 7048.5 7057.0 7063.4 7145.2 6811.2 6935.0 6935.7 6936.3 6951.5 7310.7 7314.9 7316.6 7342.0 7342.1 4606.8 4647.5 4648.5 4648.8 4650.7 7010.8 7019.9 7024.5 7024.5 7037.9 6461.3 6549.1 6789.4 6790.8 6828.0 6772.6 6793.8 6801.4 6801.5 6808.0 6628.1 6672.1 6680.3 6697.0 6698.6 6597.1 6702.2 6834.7 6866.3 6877.7 6677.8 6679.2 6686.4 6688.3 6688.5 18:07:01 INFO - PROCESS | 31699 | 18:07:01 INFO - PROCESS | 31699 | [#5] yui.html Cycles:180 Average:15620.07 Median:46768.42 stddev:17947.73 (38.4%) stddev-sans-first:17963.87 18:07:01 INFO - PROCESS | 31699 | Values: 864.7 901.6 912.0 933.5 938.7 13853.8 14198.4 14220.9 14290.1 14870.2 14459.0 14464.6 14639.7 14658.2 14689.0 787.4 914.4 921.8 937.3 943.7 929.2 932.4 933.8 935.1 935.6 972.2 974.2 979.0 979.9 982.4 819.2 827.6 829.1 964.0 975.0 722.2 723.1 723.1 723.3 723.7 14842.7 14954.9 14993.7 15010.8 15030.7 14411.4 14436.8 14807.1 15169.2 15502.6 11799.8 11830.3 11846.7 12346.3 12415.4 4059.4 4086.3 4110.5 4172.4 4236.6 55747.4 55902.4 56245.7 56616.7 56973.7 11799.9 11809.8 11821.6 11993.2 12103.4 21009.2 21061.0 21412.7 21467.7 21469.6 8761.5 8772.8 9005.3 9116.5 9147.1 5091.7 5154.2 5189.3 5189.6 5223.6 3517.1 3567.0 3569.4 3572.2 3574.3 633.2 635.6 646.1 657.6 665.3 759.6 784.1 805.3 805.6 816.8 9242.8 9274.8 9303.7 9440.9 9466.2 643.6 704.5 779.2 795.3 797.5 4329.7 4550.3 4558.5 4572.8 4644.4 62390.4 62461.7 62544.4 64981.0 66094.7 57052.1 58605.4 58798.0 58844.0 58871.0 50639.7 51594.5 51613.7 51940.7 52598.7 8619.3 8694.1 8852.9 8930.7 9030.6 37973.8 38971.6 39346.2 39536.4 40085.4 46597.1 46939.8 50367.0 50875.5 50942.0 11959.8 12061.5 12192.4 12994.8 13151.9 13703.2 14471.5 14597.3 14644.9 15364.3 10523.5 13265.3 13319.7 13453.2 13812.6 12498.9 12604.2 13330.7 13405.9 13419.5 12494.8 12662.4 12701.6 12748.0 12767.8 10925.8 11057.9 11221.8 11245.7 11267.2 10749.5 11177.3 11201.7 11251.8 11325.8 18:07:01 INFO - PROCESS | 31699 | -------- Summary: end -------- 18:07:01 INFO - PROCESS | 31699 | 18:07:02 INFO - TEST-INFO | 31699: exit 0 18:07:02 INFO - TEST-OK | dromaeo_css | took 1111417ms 18:07:02 INFO - TEST-START | kraken 18:07:02 INFO - operating with platform_type : linux_ 18:07:02 INFO - Initialising browser for kraken test... 18:07:02 INFO - TEST-INFO | started process 31886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSePbop/profile http://localhost:46750/getInfo.html) 18:07:06 INFO - PROCESS | 31886 | __metrics Screen width/height:1600/1200 18:07:06 INFO - PROCESS | 31886 | colorDepth:24 18:07:06 INFO - PROCESS | 31886 | Browser inner width/height: 1024/697 18:07:06 INFO - PROCESS | 31886 | __metrics 18:07:06 ERROR - PROCESS | 31886 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:07:07 INFO - TEST-INFO | 31886: exit 0 18:07:07 INFO - Browser initialized. 18:07:07 INFO - Running cycle 1/1 for kraken test... 18:07:07 INFO - TEST-INFO | started process 31977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSePbop/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:07:19 INFO - PROCESS | 31977 | RSS: Main: 141983744 18:07:19 INFO - PROCESS | 31977 | 18:07:21 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46750/tests/kraken/driver.html?testName=audio-beat-detection) 18:07:22 INFO - PROCESS | 31977 | RSS: Main: 196796416 18:07:22 INFO - PROCESS | 31977 | 18:07:25 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46750/tests/kraken/driver.html?testName=audio-dft) 18:07:25 INFO - PROCESS | 31977 | RSS: Main: 181850112 18:07:25 INFO - PROCESS | 31977 | 18:07:28 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46750/tests/kraken/driver.html?testName=audio-fft) 18:07:29 INFO - PROCESS | 31977 | RSS: Main: 272576512 18:07:29 INFO - PROCESS | 31977 | 18:07:31 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46750/tests/kraken/driver.html?testName=audio-oscillator) 18:07:31 INFO - PROCESS | 31977 | RSS: Main: 177422336 18:07:31 INFO - PROCESS | 31977 | 18:07:34 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46750/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:07:34 INFO - PROCESS | 31977 | RSS: Main: 176820224 18:07:34 INFO - PROCESS | 31977 | 18:07:37 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46750/tests/kraken/driver.html?testName=imaging-darkroom) 18:07:38 INFO - PROCESS | 31977 | RSS: Main: 211996672 18:07:38 INFO - PROCESS | 31977 | 18:07:41 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46750/tests/kraken/driver.html?testName=imaging-desaturate) 18:07:42 INFO - PROCESS | 31977 | RSS: Main: 211935232 18:07:42 INFO - PROCESS | 31977 | 18:07:44 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46750/tests/kraken/driver.html?testName=json-parse-financial) 18:07:45 INFO - PROCESS | 31977 | RSS: Main: 211763200 18:07:45 INFO - PROCESS | 31977 | 18:07:47 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46750/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:07:47 INFO - PROCESS | 31977 | RSS: Main: 190980096 18:07:47 INFO - PROCESS | 31977 | 18:07:49 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:07:50 INFO - PROCESS | 31977 | RSS: Main: 198172672 18:07:50 INFO - PROCESS | 31977 | 18:07:51 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:07:52 INFO - PROCESS | 31977 | RSS: Main: 208875520 18:07:52 INFO - PROCESS | 31977 | 18:07:55 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:07:55 INFO - PROCESS | 31977 | RSS: Main: 211058688 18:07:55 INFO - PROCESS | 31977 | 18:07:58 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:07:59 INFO - PROCESS | 31977 | RSS: Main: 208330752 18:07:59 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | Cycle 1(1): loaded http://localhost:46750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46750/tests/kraken/driver.html?testName=ai-astar) 18:08:00 INFO - PROCESS | 31977 | RSS: Main: 272293888 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | __start_tp_report 18:08:00 INFO - PROCESS | 31977 | _x_x_mozilla_page_load 18:08:00 INFO - PROCESS | 31977 | _x_x_mozilla_page_load_details 18:08:00 INFO - PROCESS | 31977 | |i|pagename|runs| 18:08:00 INFO - PROCESS | 31977 | |0;ai-astar;111;110;111;111;110;110;105;111;109;110 18:08:00 INFO - PROCESS | 31977 | |1;audio-beat-detection;158;135;155;182;125;162;151;128;177;126 18:08:00 INFO - PROCESS | 31977 | |2;audio-dft;162;160;160;162;160;161;160;162;162;162 18:08:00 INFO - PROCESS | 31977 | |3;audio-fft;75;75;75;173;77;77;75;75;155;75 18:08:00 INFO - PROCESS | 31977 | |4;audio-oscillator;92;92;157;92;92;93;145;92;92;146 18:08:00 INFO - PROCESS | 31977 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;116;116;117 18:08:00 INFO - PROCESS | 31977 | |6;imaging-darkroom;145;145;145;146;145;146;145;145;146;146 18:08:00 INFO - PROCESS | 31977 | |7;imaging-desaturate;95;95;96;95;95;94;95;94;94;94 18:08:00 INFO - PROCESS | 31977 | |8;json-parse-financial;55;59;55;59;57;62;57;73;55;54 18:08:00 INFO - PROCESS | 31977 | |9;json-stringify-tinderbox;59;60;58;59;58;58;58;57;59;59 18:08:00 INFO - PROCESS | 31977 | |10;stanford-crypto-aes;74;73;72;73;75;75;74;75;75;75 18:08:00 INFO - PROCESS | 31977 | |11;stanford-crypto-ccm;116;117;116;122;113;110;119;113;161;125 18:08:00 INFO - PROCESS | 31977 | |12;stanford-crypto-pbkdf2;170;162;171;162;166;161;158;158;159;162 18:08:00 INFO - PROCESS | 31977 | |13;stanford-crypto-sha256-iterative;68;67;69;66;66;68;70;74;70;66 18:08:00 INFO - PROCESS | 31977 | __end_tp_report 18:08:00 INFO - PROCESS | 31977 | __start_cc_report 18:08:00 INFO - PROCESS | 31977 | _x_x_mozilla_cycle_collect,1565 18:08:00 INFO - PROCESS | 31977 | __end_cc_report 18:08:00 INFO - PROCESS | 31977 | __startTimestamp1464397680968__endTimestamp 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | ------- Summary: start ------- 18:08:00 INFO - PROCESS | 31977 | Number of tests: 14 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:1.81 (1.6%) stddev-sans-first:1.87 18:08:00 INFO - PROCESS | 31977 | Values: 111.0 110.0 111.0 111.0 110.0 110.0 105.0 111.0 109.0 110.0 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:156.50 stddev:20.81 (13.3%) stddev-sans-first:21.86 18:08:00 INFO - PROCESS | 31977 | Values: 158.0 135.0 155.0 182.0 125.0 162.0 151.0 128.0 177.0 126.0 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#2] audio-dft Cycles:10 Average:161.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 18:08:00 INFO - PROCESS | 31977 | Values: 162.0 160.0 160.0 162.0 160.0 161.0 160.0 162.0 162.0 162.0 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:37.56 (50.1%) stddev-sans-first:39.26 18:08:00 INFO - PROCESS | 31977 | Values: 75.0 75.0 75.0 173.0 77.0 77.0 75.0 75.0 155.0 75.0 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:92.00 stddev:27.81 (30.2%) stddev-sans-first:28.78 18:08:00 INFO - PROCESS | 31977 | Values: 92.0 92.0 157.0 92.0 92.0 93.0 145.0 92.0 92.0 146.0 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:08:00 INFO - PROCESS | 31977 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:08:00 INFO - PROCESS | 31977 | Values: 145.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 18:08:00 INFO - PROCESS | 31977 | Values: 95.0 95.0 96.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.00 stddev:5.62 (9.7%) stddev-sans-first:5.81 18:08:00 INFO - PROCESS | 31977 | Values: 55.0 59.0 55.0 59.0 57.0 62.0 57.0 73.0 55.0 54.0 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 18:08:00 INFO - PROCESS | 31977 | Values: 59.0 60.0 58.0 59.0 58.0 58.0 58.0 57.0 59.0 59.0 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:75.00 stddev:1.10 (1.5%) stddev-sans-first:1.17 18:08:00 INFO - PROCESS | 31977 | Values: 74.0 73.0 72.0 73.0 75.0 75.0 74.0 75.0 75.0 75.0 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:118.00 stddev:14.67 (12.4%) stddev-sans-first:15.43 18:08:00 INFO - PROCESS | 31977 | Values: 116.0 117.0 116.0 122.0 113.0 110.0 119.0 113.0 161.0 125.0 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:162.00 stddev:4.65 (2.9%) stddev-sans-first:4.17 18:08:00 INFO - PROCESS | 31977 | Values: 170.0 162.0 171.0 162.0 166.0 161.0 158.0 158.0 159.0 162.0 18:08:00 INFO - PROCESS | 31977 | 18:08:00 INFO - PROCESS | 31977 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:2.50 (3.7%) stddev-sans-first:2.65 18:08:00 INFO - PROCESS | 31977 | Values: 68.0 67.0 69.0 66.0 66.0 68.0 70.0 74.0 70.0 66.0 18:08:00 INFO - PROCESS | 31977 | -------- Summary: end -------- 18:08:00 INFO - PROCESS | 31977 | 18:08:01 INFO - TEST-INFO | 31977: exit 0 18:08:02 INFO - TEST-OK | kraken | took 59820ms 18:08:02 INFO - SUITE-END | took 1171s 18:08:02 INFO - Completed test suite (00:19:31) 18:08:02 INFO - javascript benchmark 18:08:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3336.549565808616, 3371.4942758586217, 3385.9322813543713, 3418.1625501752073, 3435.1412146963257, 5578.776848926043, 5663.915041274379, 5673.347565030022, 5695.601307908448, 5711.428857114286, 5607.4112218217115, 5619.943800561993, 5666.801661941833, 5696.145578163278, 5699.971500142494, 4904.803807847699, 5124.590032797377, 5215.348081489814, 5276.657017293883, 5295.576353891699, 5030.320906677606, 5062.114130027249, 5065.265536497206, 5069.188929771238, 5069.315642388267, 5077.873053173682, 5172.146595811705, 5193.870153246161, 5213.087709650796, 5225.346831646044, 5193.896122077556, 5207.583393328562, 5224.111900976805, 5225.947740522584, 5254.422013578523, 4874.268859671042, 4991.875203119915, 5065.746712664352, 5123.513266239701, 5130.281760553526, 5398.514133727944, 5424.620276580641, 5426.538744206708, 5431.809886653988, 5449.945500544984, 6026.698665066773, 6059.151718759377, 6067.848303792396, 6072.0, 6074.331823499456, 6037.577369584131, 6079.750492317827, 6080.665563394012, 6098.512119030467, 6098.54260930432, 5657.603967722261, 5700.885982280372, 5702.942970570324, 5705.286839145107, 5710.2576665033275, 5922.644641321534, 6214.40963108504, 6233.96883015582, 6240.095186197976, 6241.625502469867, 5930.614510056833, 5979.1629171915965, 5987.341392446828, 5994.190784244071, 5998.310194327621, 6025.728842202111, 6038.33578306386, 6043.335233124353, 6045.123457098696, 6046.727897244635, 5866.1494083357675, 5901.704914754245, 5980.641161530322, 5991.970040149771, 5995.280566332068, 6054.031354983182, 6064.090386442069, 6068.6358818471035, 6072.271327440647, 6108.0, 4600.4479462464715, 4611.100835337077, 4611.584957353854, 4615.123126605934, 4643.349931009661, 4027.859024934113, 4055.1281474483126, 4074.0629655179473, 4116.320807066801, 4134.627883490441, 5501.5323697486165, 5584.0, 5607.018771715015, 5621.072523033654, 5666.121751128499, 5900.0264956281735, 5900.262467191601, 5901.439363260483, 5901.527877769854, 5919.852003699856, 5558.805441809598, 5572.4706152915405, 5656.745446454919, 5669.659820410789, 5692.686902220417, 5062.11413002723, 5101.642884998015, 5103.260027296095, 5104.03023425548, 5104.591632669378, 6199.318075011745, 6209.937900620936, 6214.316425193225, 6221.2845522764555, 6227.408396202353, 5716.399778023248, 5949.970250148722, 5969.462748352582, 6032.607880487754, 6063.878722425615, 6209.534284928739, 6213.068039794067, 6226.25284965807, 6246.063090536456, 6252.062190671436, 5860.706964651665, 5861.7655293787775, 5864.44287792659, 5869.735861886311, 5906.173135761082, 5804.506616937608, 5920.259967504062, 5976.491998180029, 5979.910301345571, 5990.251218597676, 5840.1531777892815, 5841.1238314253205, 5845.532357411312, 5863.530917526673, 5865.208196893535, 5727.226824378656, 5799.0, 5838.065909454467, 5851.561132914963, 5859.44335288147, 5741.770329186953, 5748.109043098327, 5763.7118144093465, 5771.509421699203, 5794.7102644866745, 5880.500157486662, 5885.234919460443, 5896.233489646319, 5904.852378690567, 5905.43898329658, 5641.15382692583, 5684.545236381162, 5775.884482310415, 5785.623934444247, 5822.155787410887], "value": 5536.64758561029, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.2993356975174, 670.9664516774161, 681.6796105830261, 748.3190296829882, 765.0207734100353, 32828.67171328286, 40062.0, 40552.0, 40593.39109913346, 40685.79657101718, 42266.78866605663, 42762.0, 42928.14143717124, 42930.78534607323, 42938.78530607351, 8090.757277281691, 8236.258736713695, 8810.559472026405, 9004.369694121415, 10387.22095842811, 10334.948325258401, 10463.215258855578, 10469.214808889326, 10476.790464190712, 10485.68542943713, 10519.05328520433, 10576.10103141234, 10576.735581610483, 10577.418241996687, 10586.735331616694, 8284.792880178014, 10478.947605262001, 10579.418132002736, 10588.841167382496, 10614.893851061468, 10643.254972151952, 10737.785244295148, 10742.570297188182, 10744.516496757664, 10746.838797418044, 40581.39127913054, 40787.0, 41064.38403423951, 41161.588384116076, 41201.58798412007, 3797.0886987123167, 3838.500994870677, 3971.344728119857, 3996.500437445319, 4335.479742430897, 34621.0, 34904.47643285353, 35042.0, 35982.46026309607, 36931.4460283096, 4002.1795531915886, 4019.075612609087, 4089.2230476209725, 4124.381342798574, 4167.91664166715, 335633.0, 335765.0, 338721.0, 338755.0, 342300.0, 41216.79391603023, 42069.78965105155, 42095.15809683789, 68653.65673171602, 69442.3055769446, 39341.0, 39508.0, 39601.20797584032, 39603.80198098991, 39732.801335993136, 16317.918410407872, 16882.15589220534, 17087.231074601674, 17102.914485427493, 17140.314387424613, 14835.703285934222, 15171.468998584996, 15172.089674619338, 15188.164650944083, 15204.543863683886, 9482.38364506305, 9552.188064014637, 9558.426494410358, 9597.136257736698, 9600.039996000343, 3630.40098383769, 3660.633936606371, 3699.9260014800093, 3795.6204379561823, 3833.501644786216, 1143.988560114405, 1191.4995701805262, 1192.6839387562302, 1222.9633111006683, 1283.5058502476613, 32963.0, 34026.82986585101, 34363.4845477318, 34405.82797085999, 34430.82784586061, 1254.4731212890608, 1258.6224132760135, 1307.9673008174682, 1324.2385628263787, 1403.3123769352944, 17473.47579572615, 17574.12129393525, 17820.821791782175, 17861.0, 17879.463616091278, 466538.0, 470438.0, 471521.0, 471567.0, 471596.0, 62126.378736212966, 63005.68497157576, 63040.684796575726, 63071.053934191026, 63364.36635633585, 1504.353128154882, 1515.0303805564447, 1549.8295187529363, 1555.7977462929973, 1641.2696350124081, 30600.0, 31355.216119597193, 31853.681463186, 32735.18162045968, 32817.67182328146, 48298.75850620725, 49070.263946040126, 49187.50812491829, 49207.50792492172, 49264.0, 246904.0, 250229.0, 250543.0, 250839.0, 251480.0, 28602.85698571577, 30686.386272273983, 30851.382972340878, 31472.527912081794, 31479.84260078685, 44372.55627443813, 44459.777701111285, 44803.10393792171, 44849.0, 45108.77445612751, 35596.82201588975, 36825.0, 37624.811875940446, 37971.81014094912, 38203.0, 37301.440478393386, 40134.397984030846, 41237.38143927904, 41368.0, 41776.1644767109, 41399.7930010348, 41453.17093658049, 42746.78626606847, 42783.0, 42795.35806962836, 34533.82733086318, 35625.643743562236, 35819.0, 35873.46189807103, 36402.817985909904, 28102.85948570326, 28173.0, 28275.71724282813, 28401.43197136087, 28570.0], "value": 19520.337594761415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.9755214687119, 410.9280875846726, 413.8675623800384, 422.2800125785534, 422.44659496060166, 14093.577192684235, 19135.617287654237, 19817.306394276202, 19836.50408739782, 20057.498562535944, 15469.1491967942, 17594.472165835014, 18217.817821821776, 18284.177212025457, 18681.159347829347, 5514.0901751211, 5644.774209031634, 5657.9717101414435, 5660.745266463019, 5677.48902598766, 5582.609217354787, 5598.2442370280105, 5605.579581531381, 5616.69108199051, 5643.858903527424, 4244.448221731171, 4379.0, 6017.0, 6245.032020036879, 6246.875062498747, 6014.0, 6200.131981522591, 6209.410106039919, 6238.625682459067, 6244.937550624481, 5543.473370029841, 5576.302962129734, 5581.05122129239, 5589.580781441408, 5591.580631452657, 22769.0, 22889.77110228893, 23419.765802341928, 23616.0, 23660.526789464286, 2474.4061425257987, 2503.486785209028, 2530.8101892357963, 2574.6652935118314, 2868.268591509152, 14361.353739081766, 14847.480338188112, 15020.849791502163, 15410.460633877761, 15454.459093931771, 1896.8861868287809, 1922.5097600111883, 1997.4107638246753, 2013.9496512587157, 2114.270576651053, 80286.59856700679, 81427.59286203531, 82709.0, 82893.0, 83334.58332708298, 10395.428251446092, 10831.945840270906, 10893.183011274186, 10914.727131821768, 10941.28881622692, 15067.397304107932, 15174.544763657108, 15286.235688215767, 15318.923405382902, 15336.616584585252, 8344.916550834414, 8415.747527574182, 8472.74581762548, 8676.696315628922, 8772.473651580925, 8854.690085846965, 8963.641454341754, 8980.191782739585, 9060.95469522648, 9073.22877555402, 6018.2176317079375, 6335.334789847092, 6687.297833727486, 6895.862082758316, 6974.860502789916, 1802.4322338463342, 1812.3566134022233, 1824.333682898358, 1829.1494455078453, 1832.1572076844534, 1082.680609220282, 1144.9542018319173, 1183.615325019355, 1195.2410219510673, 1250.2873362183468, 18968.715469267972, 19050.904745476462, 19664.901675491532, 19802.801971980385, 19861.98769673243, 1123.8707548631849, 1124.7300647844459, 1159.1480262007417, 1203.253982530819, 1253.3357320620087, 11094.223404361617, 11281.661550153509, 11306.265092769108, 11364.431778411046, 11532.308061516336, 448014.0, 451341.0, 451993.0, 467880.0, 496034.0, 78799.60600196962, 79886.20113798903, 80816.59591702122, 81296.18703813004, 81932.59033704794, 1098.4782228441586, 1126.6676330482528, 1167.5913430299327, 1181.2676140792591, 1188.5958774016876, 17148.055037709746, 17395.217215225093, 17429.215685293937, 17481.912590436965, 17508.562285942953, 37404.81297593495, 37497.0, 37962.24075518419, 38913.41629875611, 38968.0, 51058.48941510686, 51319.74340128276, 51443.48556514387, 51530.48469515257, 51657.74171129271, 8658.696945606873, 8749.65001399937, 8818.206361427503, 8907.866382004146, 9005.279577633904, 12549.372531373578, 13519.188848669111, 13602.319884005563, 13732.65668358299, 14191.0, 11729.237599556001, 12360.196587221802, 12399.566015189424, 12451.937740311241, 12798.424070917017, 11598.88401115978, 11604.419779011185, 11951.462184201559, 12131.514739410324, 12290.815637765261, 12258.71283515218, 12270.81593776112, 12301.876981230072, 12474.251544907334, 12853.93573032129, 8243.381746368927, 8392.664293428195, 8429.662813487392, 8591.570421479026, 8763.561821908752, 10436.269461137648, 10761.192910531585, 10828.566857325619, 10847.511861966388, 11082.113430925669], "value": 9504.539598219077, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.725971175909, 1552.4643997820751, 1578.4317645647568, 1792.7759030121235, 1940.8253257206857, 8004.519728816268, 8225.38309626779, 8226.958865205666, 8247.711330103448, 8263.33893288537, 8200.138985406536, 8414.116517765622, 8426.410151289398, 8427.410081294312, 8439.240468357846, 2187.3547303545492, 2403.3751224681623, 2454.754524547549, 2471.616899380599, 2482.6648402465707, 2482.1808803094937, 2494.538510375586, 2537.6320433537126, 2538.9111381101666, 2543.923682289534, 2476.2199907029226, 2484.8757562121914, 2485.291691867818, 2489.2034548944343, 2493.13986674597, 2142.6143294207036, 2364.8344615876895, 2379.6430535419654, 2385.248646676309, 2388.5939390303515, 2348.213348528245, 2348.43637526994, 2351.306364622423, 2361.0, 2426.745191754858, 8178.263956243907, 8257.298129658926, 8266.256036956642, 8267.090620031791, 8269.751907442786, 5332.840014799563, 5478.397376288605, 5483.917741233885, 5520.337559492847, 5526.0, 3615.6384361563896, 3661.6521430464063, 3711.795851228181, 3722.0, 3722.0694826293425, 1170.631251155883, 1173.7124404520862, 1187.234233919126, 1202.1044321980094, 1216.4282787090142, 11685.298882067103, 11856.46645900928, 11858.051355891508, 11881.881181188164, 11890.28658280506, 4636.884077898079, 4769.57073863354, 4793.9041219176115, 4802.423709154924, 4893.486183950705, 10420.11429028541, 10430.634927777492, 10438.63464778729, 10444.63443779464, 10445.68662940113, 4876.4879687633, 5430.8913821723345, 5432.239486471897, 5436.592255580847, 5436.7553460093595, 4475.619572336323, 4481.910361792746, 4483.663725220556, 4935.037667654773, 4954.058728841508, 3981.7411868228473, 4036.334004889219, 4075.2460794753065, 4075.2460794753065, 4138.751674899456, 1332.1673953778889, 1335.5392389625563, 1342.3690865293297, 1343.7245364700213, 1362.1214316765631, 993.6621548673342, 1028.8816786069697, 1036.5180191210973, 1051.1013083813382, 1055.8205105132147, 5707.46280488106, 5770.0, 5775.537956963517, 5840.386759390288, 5932.644041357532, 456.2175868385734, 461.6722127289595, 462.13811242034035, 482.6573133075486, 483.8209862350953, 3821.082940094357, 3975.92048159041, 4000.19996000801, 4002.9199416011515, 4015.156817068448, 10183.54174062169, 10510.842337364946, 10529.526171322155, 10577.524011419504, 10680.839787403194, 10379.11777498906, 10421.270511064153, 10421.791564168674, 10423.895761042444, 10428.374297542172, 7811.453198276066, 8010.078840933367, 8111.0, 8158.184181581794, 8164.836703265902, 5254.264402983509, 5273.6044796639635, 5360.571154307724, 5422.728863556727, 5436.075867102523, 9021.37615229265, 9189.448633082036, 9202.953985230031, 9343.112404321579, 9371.718848434557, 9244.075592440702, 9350.392224505385, 9504.952475237857, 9673.177779888789, 9699.70900872975, 6895.310468953065, 7080.716771329089, 7448.14346350155, 7518.398528117847, 7702.229777022253, 8268.586570671563, 8277.95861020691, 8321.916780832114, 8349.373796965374, 8354.45696029756, 7408.370288525536, 7469.290417410337, 7543.132539757778, 7604.315611594983, 7660.502067365604, 7356.558606483628, 7385.0, 7430.182679905314, 7514.436417268617, 7521.5111017783665, 6742.494312926452, 6775.051492790914, 6796.93203067963, 6868.7252509901045, 6897.620630865351, 5040.420351659606, 5106.872328191825, 5191.740412979411, 5346.43862394443, 5391.703456309784, 5096.898838807414, 5115.462876398074, 5123.692578445305, 5174.094533456555, 5266.868328291824], "value": 4533.355748052869, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.05648900633184, 333.7080054951917, 341.26798018250855, 341.60203363082013, 346.1139482923714, 6382.457491113255, 6405.167328247333, 6412.615243085413, 6424.903626445601, 6458.2895881453005, 6032.487238584715, 6139.324674285825, 6322.272938612049, 6372.139761132245, 6398.648074355909, 4874.0, 4899.583535399495, 4902.264660300948, 4908.067467181242, 4912.410510738717, 4888.095702295069, 4890.437599676029, 4892.363992680965, 4894.41267047953, 4906.803727850899, 4591.885202869938, 4650.697704649204, 4724.48816378759, 4797.664163508556, 4841.927371089437, 4731.290306454025, 4776.641751868624, 4785.401824771903, 4787.94665173663, 4789.784459699322, 4140.23405669952, 4144.834206631731, 4151.543330233671, 4151.750894946283, 4161.500619925598, 6131.662758548278, 6136.325004249529, 6144.754209831602, 6150.477209437203, 6158.353372895826, 5556.91664625031, 5561.499465048165, 5562.749676264578, 5568.136938774496, 5572.665640061609, 6469.51478639104, 6700.296468870796, 6702.497312701518, 6721.563098398588, 6727.293634168391, 4513.616342610882, 4535.206338890681, 4575.6568257380495, 4579.702319349265, 4583.610393116589, 6960.164780226405, 7018.0, 7033.788986330418, 7036.0, 7045.823854403629, 4635.304704294383, 4637.840539865034, 4641.976790116028, 4645.442546894395, 4653.418322709661, 4676.672632915731, 4698.506656801055, 4700.059988002413, 4700.412448443944, 4701.95298047022, 5396.487333703292, 5514.393416724157, 5518.061929471999, 5521.0, 5554.583406244547, 6782.152230971129, 6813.080234168423, 6815.011823285596, 6824.965875170592, 6841.931580684229, 1570.8507691769264, 1630.6005028768027, 1648.4312912045325, 1648.9670206595802, 1650.4718490083299, 1053.9894601054045, 1055.1189756553365, 1073.4257172412722, 1074.1943542343242, 1080.103514083309, 6465.288818230085, 6501.382368674968, 6502.902456463157, 6503.057056726842, 6508.056331831858, 6939.757108501179, 6942.0, 6942.8611427772175, 6944.965275173693, 6953.89569156463, 6487.416132547999, 6503.154589903377, 6503.479721622259, 6507.772227972093, 6511.967440162769, 3707.4994875691436, 3746.5129533160516, 3752.2307926874923, 3755.3803622402543, 3756.1736417988, 7072.8939065914055, 7214.062171917617, 7336.633168341668, 7359.521631093961, 7365.116186057708, 7162.068931038932, 7201.819954501075, 7221.494495385377, 7223.530470519399, 7249.311315425026, 7330.486865919441, 7332.96333518329, 7336.339729424378, 7337.88993165103, 7340.229275926058, 7034.577925324497, 7048.471364647569, 7057.024033270693, 7063.364297213276, 7145.214026456982, 6811.182658081062, 6934.965325173342, 6935.687894044881, 6936.271691472322, 6951.513394062367, 7310.6710198040155, 7314.890276645748, 7316.634168291671, 7341.963290183515, 7342.082239720035, 4606.769661516978, 4647.4655414626395, 4648.535146485459, 4648.790804413742, 4650.674452788272, 7010.75462358815, 7019.929800702132, 7024.506300263537, 7024.5434046786795, 7037.929620703728, 6461.2892581816905, 6549.050387693663, 6789.388954994074, 6790.830229244309, 6827.965860170667, 6772.55978361405, 6793.762218322335, 6801.353871382211, 6801.5238933274195, 6808.046873437822, 6628.105205797348, 6672.099266598947, 6680.331966803281, 6696.966515167393, 6698.5980841149685, 6597.109390232449, 6702.162229721285, 6834.726610935507, 6866.313368663094, 6877.724891004304, 6677.76627818024, 6679.165104361955, 6686.364795344434, 6688.2977287386075, 6688.4983626229205], "value": 5054.1556889020885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.7319331007388, 901.6348378906541, 911.9863202051969, 933.5425641435698, 938.7183844846544, 13853.792193117099, 14198.432062717491, 14220.857791422082, 14290.142591444508, 14870.182139982297, 14459.0, 14464.566063018126, 14639.707205855877, 14658.193799341032, 14689.045212061208, 787.3976408047848, 914.4376208631677, 921.764949937765, 937.3485427627801, 943.7310366545536, 929.2380248196481, 932.4451951089125, 933.8272419602362, 935.0555938502127, 935.5789894547447, 972.246508955558, 974.1962880623479, 979.045430705064, 979.8628192053118, 982.4252812104927, 819.2340161948567, 827.5531213144925, 829.0672992883007, 963.9951800241024, 974.9951250243739, 722.2163952111965, 723.106962900817, 723.1466869094467, 723.2514347650209, 723.7177500774702, 14842.703145937021, 14954.925225373912, 14993.700125997419, 15010.849891501055, 15030.699386012328, 14411.423543058265, 14436.78344824818, 14807.111573305636, 15169.24153792306, 15502.61243468911, 11799.764004719944, 11830.290182589073, 11846.703832404173, 12346.320952347618, 12415.44130514129, 4059.3505039193587, 4086.3053280942313, 4110.547839737626, 4172.436721042681, 4236.597523235288, 55747.44252557504, 55902.440975590536, 56245.71877140629, 56616.71691641516, 56973.71513142408, 11799.88200118005, 11809.763804723858, 11821.586244481401, 11993.160478766576, 12103.394830258629, 21009.159633614483, 21061.0, 21412.678809817866, 21467.67798483024, 21469.57060858774, 8761.474311541328, 8772.824543509221, 9005.279577633773, 9116.498592577473, 9147.131022552847, 5091.669041512364, 5154.175331946871, 5189.3253876996505, 5189.584833213334, 5223.555997740159, 3517.050396393011, 3566.982165089158, 3569.37535931211, 3572.160542272564, 3574.267275208576, 633.1547384242089, 635.6249812610582, 646.0664340028708, 657.6185812228896, 665.2848188197706, 759.5594555157995, 784.1178673991759, 805.3436449293807, 805.5569436809732, 816.808050108236, 9242.768930776785, 9274.814503710022, 9303.674371396968, 9440.90559094414, 9466.1953733932, 643.5816719132602, 704.4962851561158, 779.2324560308092, 795.2861583288023, 797.5175019113353, 4329.6969212154845, 4550.271956486946, 4558.544145585415, 4572.7942242599165, 4644.419447569054, 62390.376096239364, 62461.68769156125, 62544.37455625476, 64981.0, 66094.66952665205, 57052.144217836765, 58605.41394586, 58798.0, 58843.99826014751, 58871.0, 50639.746801265755, 51594.484055159715, 51613.74193129085, 51940.740296298274, 52598.73700631549, 8619.310455163697, 8694.130586941508, 8852.911470885208, 8930.687425940061, 9030.593623286837, 37973.81013094917, 38971.6102838968, 39346.213075738895, 39536.40695389514, 40085.398719019824, 46597.06805863796, 46939.76530117328, 50367.0, 50875.491245087076, 50942.0, 11959.760804783682, 12061.51753929868, 12192.390380481118, 12994.80507792365, 13151.934240328737, 13703.177809331472, 14471.49349772753, 14597.270136493345, 14644.853551464348, 15364.308606112976, 10523.4738263085, 13265.270410127536, 13319.733605327645, 13453.192808431526, 13812.585622431343, 12498.875011250135, 12604.180728253, 13330.666733331744, 13405.932970335087, 13419.530316438877, 12494.812577811523, 12662.366881656064, 12701.555445559361, 12748.0, 12767.808482872579, 10925.781484370427, 11057.944710276397, 11221.831672525082, 11245.71885702864, 11267.211295209258, 10749.516271767945, 11177.317443813588, 11201.71995700114, 11251.7749645005, 11325.773484530428], "value": 7181.064641315954, "unit": "score"}], "name": "dromaeo_css", "value": 7435.784258806603, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 111.0, 111.0, 110.0, 110.0, 105.0, 111.0, 109.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 135.0, 155.0, 182.0, 125.0, 162.0, 151.0, 128.0, 177.0, 126.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 162.0, 160.0, 161.0, 160.0, 162.0, 162.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 173.0, 77.0, 77.0, 75.0, 75.0, 155.0, 75.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 157.0, 92.0, 92.0, 93.0, 145.0, 92.0, 92.0, 146.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 55.0, 59.0, 57.0, 62.0, 57.0, 73.0, 55.0, 54.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 59.0, 58.0, 58.0, 58.0, 57.0, 59.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 73.0, 75.0, 75.0, 74.0, 75.0, 75.0, 75.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 122.0, 113.0, 110.0, 119.0, 113.0, 161.0, 125.0], "value": 121.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 162.0, 171.0, 162.0, 166.0, 161.0, 158.0, 158.0, 159.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 66.0, 66.0, 68.0, 70.0, 74.0, 70.0, 66.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1523.7, "alertThreshold": 2.0}]} 18:08:02 INFO - Return code: 0 18:08:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:08:02 ERROR - # TBPL SUCCESS # 18:08:02 INFO - Running post-action listener: _resource_record_post_action 18:08:02 INFO - Running post-run listener: _resource_record_post_run 18:08:03 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 501362688; Read time: 16; Write time: 383668 18:08:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249200640; Read time: 0; Write time: 267560 18:08:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252100608; Read time: 16; Write time: 116108 18:08:03 INFO - Running post-run listener: _upload_blobber_files 18:08:03 INFO - Blob upload gear active. 18:08:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:08:03 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 18:08:03 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'] 18:08:03 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 18:08:03 INFO - (blobuploader) - INFO - Open directory for files ... 18:08:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:08:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:08:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:08:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:08:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:08:04 INFO - (blobuploader) - INFO - Done attempting. 18:08:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:08:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:08:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:08:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:08:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:08:06 INFO - (blobuploader) - INFO - Done attempting. 18:08:06 INFO - (blobuploader) - INFO - Iteration through files over. 18:08:06 INFO - Return code: 0 18:08:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:08:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:08:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a8f2bae78946a758651660e4eda465986650f63d40ddfc7b2ba144fd2e53ff27c92b9f2383478fd30628106a0d897f1ee2b9ef63cc8ad0b55b6d9ff697ad9e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a829a35534ac83693b39faf2d8d983229ef4b8e5dd74311bb4c4bcc11a3ceb2eb366312788a0a59f02a45eafbb4faeb5b308670af65dfab0fb3c6d1dba7b1b54"} 18:08:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:08:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:08:06 INFO - Contents: 18:08:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a8f2bae78946a758651660e4eda465986650f63d40ddfc7b2ba144fd2e53ff27c92b9f2383478fd30628106a0d897f1ee2b9ef63cc8ad0b55b6d9ff697ad9e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a829a35534ac83693b39faf2d8d983229ef4b8e5dd74311bb4c4bcc11a3ceb2eb366312788a0a59f02a45eafbb4faeb5b308670af65dfab0fb3c6d1dba7b1b54"} 18:08:06 INFO - Running post-run listener: copy_logs_to_upload_dir 18:08:06 INFO - Copying logs to upload dir... 18:08:06 INFO - mkdir: /builds/slave/test/build/upload/logs 18:08:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.542848 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-27 18:08:06.669806) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 18:08:06.672981) ========= 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=00204705a9daa57ed339a427000001b9-1464395356.936537-509041690 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/2a8f2bae78946a758651660e4eda465986650f63d40ddfc7b2ba144fd2e53ff27c92b9f2383478fd30628106a0d897f1ee2b9ef63cc8ad0b55b6d9ff697ad9e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a829a35534ac83693b39faf2d8d983229ef4b8e5dd74311bb4c4bcc11a3ceb2eb366312788a0a59f02a45eafbb4faeb5b308670af65dfab0fb3c6d1dba7b1b54"} build_url:https://queue.taskcluster.net/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/Fc21BMUJR-SnFrt53Aaf6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a8f2bae78946a758651660e4eda465986650f63d40ddfc7b2ba144fd2e53ff27c92b9f2383478fd30628106a0d897f1ee2b9ef63cc8ad0b55b6d9ff697ad9e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a829a35534ac83693b39faf2d8d983229ef4b8e5dd74311bb4c4bcc11a3ceb2eb366312788a0a59f02a45eafbb4faeb5b308670af65dfab0fb3c6d1dba7b1b54"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 18:08:06.698717) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 18:08:06.699082) ========= 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=00204705a9daa57ed339a427000001b9-1464395356.936537-509041690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 18:08:06.783667) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 18:08:06.784014) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 18:08:06.784353) ========= ========= Total master_lag: 0.18 =========