builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1464381339.24 results: success (0) buildid: 20160527104445 builduid: a0036f18b45749a0a28771d2b4556006 revision: 65badb6bff1ea4b79837500e1a8b5969ea7fe489 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:39.240566) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:39.241045) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:39.241335) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:39.256435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:39.256833) ========= 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=62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 13:35:39-- 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% 223M=0s 2016-05-27 13:35:39 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072644 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:39.346059) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:39.346594) ========= 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=62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016384 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:39.396772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:39.397315) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 65badb6bff1ea4b79837500e1a8b5969ea7fe489 --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 65badb6bff1ea4b79837500e1a8b5969ea7fe489 --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=62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 13:35:39,467 truncating revision to first 12 chars 2016-05-27 13:35:39,467 Setting DEBUG logging. 2016-05-27 13:35:39,467 attempt 1/10 2016-05-27 13:35:39,467 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/65badb6bff1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 13:35:40,067 unpacking tar archive at: mozilla-aurora-65badb6bff1e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.969326 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:40.382198) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:40.382585) ========= script_repo_revision: 65badb6bff1ea4b79837500e1a8b5969ea7fe489 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:40.383046) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:40.383335) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 13:35:40.392822) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-27 13:35:40.393238) ========= /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=62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:35:40 INFO - MultiFileLogger online at 20160527 13:35:40 in /builds/slave/test 13:35:40 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 13:35:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:35:40 INFO - {'append_to_log': False, 13:35:40 INFO - 'base_work_dir': '/builds/slave/test', 13:35:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:35:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:35:40 INFO - 'branch': 'Mozilla-Aurora', 13:35:40 INFO - 'buildbot_json_path': 'buildprops.json', 13:35:40 INFO - 'config_files': ('talos/linux_config.py',), 13:35:40 INFO - 'default_actions': ('clobber', 13:35:40 INFO - 'read-buildbot-config', 13:35:40 INFO - 'download-and-extract', 13:35:40 INFO - 'populate-webroot', 13:35:40 INFO - 'create-virtualenv', 13:35:40 INFO - 'install', 13:35:40 INFO - 'run-tests'), 13:35:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:35:40 INFO - 'download_minidump_stackwalk': True, 13:35:40 INFO - 'download_symbols': 'ondemand', 13:35:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:35:40 INFO - 'tooltool.py': '/tools/tooltool.py', 13:35:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:35:40 INFO - '/tools/misc-python/virtualenv.py')}, 13:35:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:35:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:35:40 INFO - 'installer_path': 'installer.exe', 13:35:40 INFO - 'log_level': 'info', 13:35:40 INFO - 'log_name': 'talos', 13:35:40 INFO - 'log_to_console': True, 13:35:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:35:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:35:40 INFO - 'opt_config_files': (), 13:35:40 INFO - 'pip_index': False, 13:35:40 INFO - 'sps_profile': False, 13:35:40 INFO - 'sps_profile_interval': 0, 13:35:40 INFO - 'suite': 'dromaeojs', 13:35:40 INFO - 'system_bits': '32', 13:35:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:35:40 INFO - 'title': 'talos-linux64-ix-018', 13:35:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:35:40 INFO - 'use_talos_json': True, 13:35:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:35:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:35:40 INFO - 'work_dir': 'build'} 13:35:40 INFO - ##### 13:35:40 INFO - ##### Running clobber step. 13:35:40 INFO - ##### 13:35:40 INFO - Running pre-action listener: _resource_record_pre_action 13:35:40 INFO - Running main action method: clobber 13:35:40 INFO - rmtree: /builds/slave/test/build 13:35:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:35:41 INFO - Running post-action listener: _resource_record_post_action 13:35:41 INFO - ##### 13:35:41 INFO - ##### Running read-buildbot-config step. 13:35:41 INFO - ##### 13:35:41 INFO - Running pre-action listener: _resource_record_pre_action 13:35:41 INFO - Running main action method: read_buildbot_config 13:35:41 INFO - Using buildbot properties: 13:35:41 INFO - { 13:35:41 INFO - "project": "", 13:35:41 INFO - "product": "firefox", 13:35:41 INFO - "script_repo_revision": "production", 13:35:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:35:41 INFO - "repository": "", 13:35:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:35:41 INFO - "buildid": "20160527104445", 13:35:41 INFO - "pgo_build": "True", 13:35:41 INFO - "basedir": "/builds/slave/test", 13:35:41 INFO - "buildnumber": 347, 13:35:41 INFO - "slavename": "talos-linux64-ix-018", 13:35:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:35:41 INFO - "platform": "ubuntu64_hw", 13:35:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:35:41 INFO - "branch": "mozilla-aurora", 13:35:41 INFO - "repo_path": "releases/mozilla-aurora", 13:35:41 INFO - "revision": "65badb6bff1ea4b79837500e1a8b5969ea7fe489", 13:35:41 INFO - "stage_platform": "linux64-pgo", 13:35:41 INFO - "builduid": "a0036f18b45749a0a28771d2b4556006", 13:35:41 INFO - "slavebuilddir": "test" 13:35:41 INFO - } 13:35:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 13:35:41 INFO - Running post-action listener: _resource_record_post_action 13:35:41 INFO - ##### 13:35:41 INFO - ##### Running download-and-extract step. 13:35:41 INFO - ##### 13:35:41 INFO - Running pre-action listener: _resource_record_pre_action 13:35:41 INFO - Running main action method: download_and_extract 13:35:41 INFO - mkdir: /builds/slave/test/build/tests 13:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:41 INFO - https://queue.taskcluster.net/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:35:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:35:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:35:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/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 13:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/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 13:35:41 INFO - Downloaded 1361 bytes. 13:35:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:35:41 INFO - Using the following test package requirements: 13:35:41 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:35:41 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:35:41 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:35:41 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:41 INFO - u'jsshell-linux-x86_64.zip'], 13:35:41 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:35:41 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:35:41 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:35:41 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:35:41 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:35:41 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:35:41 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:41 INFO - https://queue.taskcluster.net/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:35:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:35:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:35:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/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 13:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/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 13:35:42 INFO - Downloaded 24136265 bytes. 13:35:42 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'] 13:35:42 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 13:35:44 INFO - Return code: 0 13:35:44 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 13:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:44 INFO - https://queue.taskcluster.net/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:35:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:35:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:35:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/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 13:35:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/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 13:35:45 INFO - Downloaded 24136265 bytes. 13:35:45 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'] 13:35:45 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 13:35:47 INFO - Return code: 0 13:35: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')]} 13:35:47 INFO - https://queue.taskcluster.net/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:35:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:35:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:35:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/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 13:35:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/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 13:35:48 INFO - Downloaded 10840145 bytes. 13:35:48 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'] 13:35:48 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 13:35:48 INFO - Return code: 0 13:35:48 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')]} 13:35:48 INFO - https://queue.taskcluster.net/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:35:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:35:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:35:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/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 13:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH6aSQuWRsahaIdiw2IrtQ/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 13:35:53 INFO - Downloaded 62758057 bytes. 13:35:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:35:53 INFO - mkdir: /builds/slave/test/properties 13:35:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:35:53 INFO - Writing to file /builds/slave/test/properties/build_url 13:35:53 INFO - Contents: 13:35:53 INFO - build_url:https://queue.taskcluster.net/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:35:54 INFO - Running post-action listener: _resource_record_post_action 13:35:54 INFO - Running post-action listener: set_extra_try_arguments 13:35:54 INFO - ##### 13:35:54 INFO - ##### Running populate-webroot step. 13:35:54 INFO - ##### 13:35:54 INFO - Running pre-action listener: _resource_record_pre_action 13:35:54 INFO - Running main action method: populate_webroot 13:35:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:35:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:35:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:35:54 INFO - '--tppagecycles', 13:35:54 INFO - '7'], 13:35:54 INFO - 'tests': ['tsvgm']}}, 13:35:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:35:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:35:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:35:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:35:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:35:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:35:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:54 INFO - 'talos_options': ['--disable-e10s'], 13:35:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:35:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:35:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:54 INFO - 'talos_options': ['--disable-e10s'], 13:35:54 INFO - 'tests': ['damp', 'tps']}, 13:35:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:54 INFO - 'tests': ['damp', 'tps']}, 13:35:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:35:54 INFO - 'tests': ['dromaeo_dom']}, 13:35:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:35:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:35:54 INFO - 'tests': ['a11yr', 13:35:54 INFO - 'ts_paint', 13:35:54 INFO - 'tpaint', 13:35:54 INFO - 'sessionrestore', 13:35:54 INFO - 'sessionrestore_no_auto_restore', 13:35:54 INFO - 'tabpaint']}, 13:35:54 INFO - 'other-e10s': {'tests': ['a11yr', 13:35:54 INFO - 'ts_paint', 13:35:54 INFO - 'tpaint', 13:35:54 INFO - 'sessionrestore', 13:35:54 INFO - 'sessionrestore_no_auto_restore', 13:35:54 INFO - 'tabpaint']}, 13:35:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:35:54 INFO - 'ts_paint', 13:35:54 INFO - 'tpaint', 13:35:54 INFO - 'sessionrestore', 13:35:54 INFO - 'sessionrestore_no_auto_restore', 13:35:54 INFO - 'tabpaint']}, 13:35:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:35:54 INFO - 'ts_paint', 13:35:54 INFO - 'tpaint', 13:35:54 INFO - 'sessionrestore', 13:35:54 INFO - 'sessionrestore_no_auto_restore', 13:35:54 INFO - 'tabpaint']}, 13:35:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:35:54 INFO - 'tests': ['a11yr', 13:35:54 INFO - 'ts_paint', 13:35:54 INFO - 'tpaint', 13:35:54 INFO - 'sessionrestore', 13:35:54 INFO - 'sessionrestore_no_auto_restore', 13:35:54 INFO - 'tabpaint']}, 13:35:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:35:54 INFO - 'tests': ['a11yr', 13:35:54 INFO - 'ts_paint', 13:35:54 INFO - 'tpaint', 13:35:54 INFO - 'sessionrestore', 13:35:54 INFO - 'sessionrestore_no_auto_restore', 13:35:54 INFO - 'tabpaint']}, 13:35:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:35:54 INFO - 'tests': ['tsvgx', 13:35:54 INFO - 'tsvgr_opacity', 13:35:54 INFO - 'tart', 13:35:54 INFO - 'tscrollx', 13:35:54 INFO - 'cart']}, 13:35:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:35:54 INFO - 'tsvgr_opacity', 13:35:54 INFO - 'tart', 13:35:54 INFO - 'tscrollx', 13:35:54 INFO - 'cart']}, 13:35:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:54 INFO - 'talos_options': ['--disable-e10s'], 13:35:54 INFO - 'tests': ['tp5o']}, 13:35:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:54 INFO - 'tests': ['tp5o']}, 13:35:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:54 INFO - 'talos_options': ['--disable-e10s', 13:35:54 INFO - '--xperf_path', 13:35:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:35:54 INFO - 'tests': ['tp5n']}, 13:35:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:54 INFO - 'talos_options': ['--xperf_path', 13:35:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:35:54 INFO - 'tests': ['tp5n']}}, 13:35:54 INFO - 'talos.zip': {'path': '', 13:35:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:35:54 INFO - Running post-action listener: _resource_record_post_action 13:35:54 INFO - ##### 13:35:54 INFO - ##### Running create-virtualenv step. 13:35:54 INFO - ##### 13:35:54 INFO - Running pre-action listener: _resource_record_pre_action 13:35:54 INFO - Running main action method: create_virtualenv 13:35:54 INFO - Creating virtualenv /builds/slave/test/build/venv 13:35:54 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 13:35:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:35:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:35:54 INFO - Using real prefix '/usr' 13:35:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:35:54 INFO - Installing distribute.............................................................................................................................................................................................done. 13:35:56 INFO - Installing pip.................done. 13:35:56 INFO - Return code: 0 13:35:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:35:56 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')]} 13:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:56 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')]} 13:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:56 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 0x7f8a8b37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac410>, '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 0x15ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ad7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', '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 13:35:56 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 13:35:56 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 13:35:56 INFO - Using env: {'DISPLAY': ':0', 13:35:56 INFO - 'HOME': '/home/cltbld', 13:35:56 INFO - 'LANG': 'en_US.UTF-8', 13:35:56 INFO - 'LANGUAGE': 'en_US:en', 13:35:56 INFO - 'LOGNAME': 'cltbld', 13:35:56 INFO - 'MAIL': '/var/mail/cltbld', 13:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:56 INFO - 'MOZ_NO_REMOTE': '1', 13:35:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:56 INFO - 'NO_EM_RESTART': '1', 13:35:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:56 INFO - 'PWD': '/builds/slave/test', 13:35:56 INFO - 'SHELL': '/bin/bash', 13:35:56 INFO - 'SHLVL': '1', 13:35:56 INFO - 'TERM': 'linux', 13:35:56 INFO - 'TMOUT': '86400', 13:35:56 INFO - 'USER': 'cltbld', 13:35:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', 13:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:56 INFO - '_': '/tools/buildbot/bin/python'} 13:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:56 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 13:35:56 INFO - Cleaning up... 13:35:56 INFO - Return code: 0 13:35:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:35:56 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')]} 13:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:56 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')]} 13:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:56 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 0x7f8a8b37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac410>, '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 0x15ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ad7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', '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 13:35:56 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 13:35:56 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 13:35:56 INFO - Using env: {'DISPLAY': ':0', 13:35:56 INFO - 'HOME': '/home/cltbld', 13:35:56 INFO - 'LANG': 'en_US.UTF-8', 13:35:56 INFO - 'LANGUAGE': 'en_US:en', 13:35:56 INFO - 'LOGNAME': 'cltbld', 13:35:56 INFO - 'MAIL': '/var/mail/cltbld', 13:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:56 INFO - 'MOZ_NO_REMOTE': '1', 13:35:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:56 INFO - 'NO_EM_RESTART': '1', 13:35:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:56 INFO - 'PWD': '/builds/slave/test', 13:35:56 INFO - 'SHELL': '/bin/bash', 13:35:56 INFO - 'SHLVL': '1', 13:35:56 INFO - 'TERM': 'linux', 13:35:56 INFO - 'TMOUT': '86400', 13:35:56 INFO - 'USER': 'cltbld', 13:35:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', 13:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:56 INFO - '_': '/tools/buildbot/bin/python'} 13:35:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:57 INFO - Downloading/unpacking psutil>=0.7.1 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:35:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:35:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:35:59 INFO - Installing collected packages: psutil 13:35:59 INFO - Running setup.py install for psutil 13:35:59 INFO - building 'psutil._psutil_linux' extension 13:35:59 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 13:35:59 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 13:35:59 INFO - building 'psutil._psutil_posix' extension 13:35:59 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 13:35:59 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 13:35:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:35:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:35:59 INFO - Successfully installed psutil 13:35:59 INFO - Cleaning up... 13:35:59 INFO - Return code: 0 13:35:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:35:59 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')]} 13:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:59 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')]} 13:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:59 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 0x7f8a8b37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac410>, '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 0x15ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ad7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', '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 13:35:59 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 13:35:59 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 13:35:59 INFO - Using env: {'DISPLAY': ':0', 13:35:59 INFO - 'HOME': '/home/cltbld', 13:35:59 INFO - 'LANG': 'en_US.UTF-8', 13:35:59 INFO - 'LANGUAGE': 'en_US:en', 13:35:59 INFO - 'LOGNAME': 'cltbld', 13:35:59 INFO - 'MAIL': '/var/mail/cltbld', 13:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:59 INFO - 'MOZ_NO_REMOTE': '1', 13:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:59 INFO - 'NO_EM_RESTART': '1', 13:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:59 INFO - 'PWD': '/builds/slave/test', 13:35:59 INFO - 'SHELL': '/bin/bash', 13:35:59 INFO - 'SHLVL': '1', 13:35:59 INFO - 'TERM': 'linux', 13:35:59 INFO - 'TMOUT': '86400', 13:35:59 INFO - 'USER': 'cltbld', 13:35:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', 13:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:59 INFO - '_': '/tools/buildbot/bin/python'} 13:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:36:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:36:01 INFO - Installing collected packages: mozsystemmonitor 13:36:01 INFO - Running setup.py install for mozsystemmonitor 13:36:01 INFO - Successfully installed mozsystemmonitor 13:36:01 INFO - Cleaning up... 13:36:01 INFO - Return code: 0 13:36:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:36:01 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')]} 13:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:01 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')]} 13:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:01 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 0x7f8a8b37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac410>, '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 0x15ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ad7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', '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 13:36:01 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 13:36:01 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 13:36:01 INFO - Using env: {'DISPLAY': ':0', 13:36:01 INFO - 'HOME': '/home/cltbld', 13:36:01 INFO - 'LANG': 'en_US.UTF-8', 13:36:01 INFO - 'LANGUAGE': 'en_US:en', 13:36:01 INFO - 'LOGNAME': 'cltbld', 13:36:01 INFO - 'MAIL': '/var/mail/cltbld', 13:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:01 INFO - 'MOZ_NO_REMOTE': '1', 13:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:01 INFO - 'NO_EM_RESTART': '1', 13:36:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:01 INFO - 'PWD': '/builds/slave/test', 13:36:01 INFO - 'SHELL': '/bin/bash', 13:36:01 INFO - 'SHLVL': '1', 13:36:01 INFO - 'TERM': 'linux', 13:36:01 INFO - 'TMOUT': '86400', 13:36:01 INFO - 'USER': 'cltbld', 13:36:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', 13:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:01 INFO - '_': '/tools/buildbot/bin/python'} 13:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:02 INFO - Downloading/unpacking blobuploader==1.2.4 13:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:03 INFO - Downloading blobuploader-1.2.4.tar.gz 13:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:36:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:36:04 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 13:36:04 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 13:36:04 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 13:36:04 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 13:36:04 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 13:36:04 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 13:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:36:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:36:04 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 13:36:04 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 13:36:04 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 13:36:04 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 13:36:04 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 13:36:04 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 13:36:04 INFO - Downloading docopt-0.6.1.tar.gz 13:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:36:04 INFO - Installing collected packages: blobuploader, requests, docopt 13:36:04 INFO - Running setup.py install for blobuploader 13:36:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:36:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:36:04 INFO - Running setup.py install for requests 13:36:05 INFO - Running setup.py install for docopt 13:36:05 INFO - Successfully installed blobuploader requests docopt 13:36:05 INFO - Cleaning up... 13:36:05 INFO - Return code: 0 13:36:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:05 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 0x7f8a8b37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac410>, '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 0x15ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ad7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', '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 13:36:05 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 13:36:05 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 13:36:05 INFO - Using env: {'DISPLAY': ':0', 13:36:05 INFO - 'HOME': '/home/cltbld', 13:36:05 INFO - 'LANG': 'en_US.UTF-8', 13:36:05 INFO - 'LANGUAGE': 'en_US:en', 13:36:05 INFO - 'LOGNAME': 'cltbld', 13:36:05 INFO - 'MAIL': '/var/mail/cltbld', 13:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:05 INFO - 'MOZ_NO_REMOTE': '1', 13:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:05 INFO - 'NO_EM_RESTART': '1', 13:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:05 INFO - 'PWD': '/builds/slave/test', 13:36:05 INFO - 'SHELL': '/bin/bash', 13:36:05 INFO - 'SHLVL': '1', 13:36:05 INFO - 'TERM': 'linux', 13:36:05 INFO - 'TMOUT': '86400', 13:36:05 INFO - 'USER': 'cltbld', 13:36:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', 13:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:05 INFO - '_': '/tools/buildbot/bin/python'} 13:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:36:05 INFO - Running setup.py (path:/tmp/pip-_nYo4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:36:05 INFO - Running setup.py (path:/tmp/pip-qtKKlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:36:05 INFO - Running setup.py (path:/tmp/pip-MvT2wQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:36:05 INFO - Running setup.py (path:/tmp/pip-34TcuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:36:05 INFO - Running setup.py (path:/tmp/pip-czsud5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:36:05 INFO - Running setup.py (path:/tmp/pip-vTShwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:36:06 INFO - Running setup.py (path:/tmp/pip-NG20zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:36:06 INFO - Running setup.py (path:/tmp/pip-p2x7yY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:36:06 INFO - Running setup.py (path:/tmp/pip-exfrNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:36:06 INFO - Running setup.py (path:/tmp/pip-yFgKEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:36:06 INFO - Running setup.py (path:/tmp/pip-BqM2Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:36:06 INFO - Running setup.py (path:/tmp/pip-UFezsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:36:06 INFO - Running setup.py (path:/tmp/pip-uNl3a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:36:06 INFO - Running setup.py (path:/tmp/pip-qAti1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:06 INFO - Running setup.py (path:/tmp/pip-jX7u3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:36:06 INFO - Running setup.py (path:/tmp/pip-nDyies-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:36:06 INFO - Running setup.py (path:/tmp/pip-CYXwrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:36:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:36:06 INFO - Running setup.py install for manifestparser 13:36:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:36:06 INFO - Running setup.py install for mozcrash 13:36:06 INFO - Running setup.py install for mozdebug 13:36:07 INFO - Running setup.py install for mozdevice 13:36:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:36:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:36:07 INFO - Running setup.py install for mozfile 13:36:07 INFO - Running setup.py install for mozhttpd 13:36:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:36:07 INFO - Running setup.py install for mozinfo 13:36:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:36:07 INFO - Running setup.py install for mozInstall 13:36:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:36:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:36:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:36:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:36:07 INFO - Running setup.py install for mozleak 13:36:07 INFO - Running setup.py install for mozlog 13:36:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:36:07 INFO - Running setup.py install for moznetwork 13:36:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:36:07 INFO - Running setup.py install for mozprocess 13:36:08 INFO - Running setup.py install for mozprofile 13:36:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:36:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:36:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:36:08 INFO - Running setup.py install for mozrunner 13:36:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:36:08 INFO - Running setup.py install for mozscreenshot 13:36:08 INFO - Running setup.py install for moztest 13:36:08 INFO - Running setup.py install for mozversion 13:36:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:36:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:36:08 INFO - Cleaning up... 13:36:08 INFO - Return code: 0 13:36:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:08 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 0x7f8a8b37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac410>, '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 0x15ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ad7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', '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 13:36:08 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 13:36:08 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 13:36:08 INFO - Using env: {'DISPLAY': ':0', 13:36:08 INFO - 'HOME': '/home/cltbld', 13:36:08 INFO - 'LANG': 'en_US.UTF-8', 13:36:08 INFO - 'LANGUAGE': 'en_US:en', 13:36:08 INFO - 'LOGNAME': 'cltbld', 13:36:08 INFO - 'MAIL': '/var/mail/cltbld', 13:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:08 INFO - 'MOZ_NO_REMOTE': '1', 13:36:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:08 INFO - 'NO_EM_RESTART': '1', 13:36:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:08 INFO - 'PWD': '/builds/slave/test', 13:36:08 INFO - 'SHELL': '/bin/bash', 13:36:08 INFO - 'SHLVL': '1', 13:36:08 INFO - 'TERM': 'linux', 13:36:08 INFO - 'TMOUT': '86400', 13:36:08 INFO - 'USER': 'cltbld', 13:36:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', 13:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:08 INFO - '_': '/tools/buildbot/bin/python'} 13:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:36:08 INFO - Running setup.py (path:/tmp/pip-oEhF6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:36:08 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)) 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:36:08 INFO - Running setup.py (path:/tmp/pip-ehh0dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:36:08 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)) 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:36:08 INFO - Running setup.py (path:/tmp/pip-URa2Iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:36:09 INFO - Running setup.py (path:/tmp/pip-lNlVr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:36:09 INFO - Running setup.py (path:/tmp/pip-L9lB8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:36:09 INFO - Running setup.py (path:/tmp/pip-tqIwTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:36:09 INFO - Running setup.py (path:/tmp/pip-fHdCMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:36:09 INFO - Running setup.py (path:/tmp/pip-33SMyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:36:09 INFO - Running setup.py (path:/tmp/pip-7Kk0Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:36:09 INFO - Running setup.py (path:/tmp/pip-8cBfCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:36:09 INFO - Running setup.py (path:/tmp/pip-HqB4DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:36:09 INFO - Running setup.py (path:/tmp/pip-Z0cqko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:36:09 INFO - Running setup.py (path:/tmp/pip-kBGP_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:36:09 INFO - Running setup.py (path:/tmp/pip-rqRGCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:09 INFO - Running setup.py (path:/tmp/pip-fGFb9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:36:09 INFO - Running setup.py (path:/tmp/pip-NAjMnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:36:09 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)) 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:36:09 INFO - Running setup.py (path:/tmp/pip-UA89ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:36:10 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)) 13:36:10 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)) 13:36:10 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)) 13:36:10 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)) 13:36:10 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)) 13:36:10 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)) 13:36:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36:11 INFO - Downloading blessings-1.6.tar.gz 13:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:36:12 INFO - Installing collected packages: blessings 13:36:12 INFO - Running setup.py install for blessings 13:36:12 INFO - Successfully installed blessings 13:36:12 INFO - Cleaning up... 13:36:12 INFO - Return code: 0 13:36:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:36:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:36:12 INFO - Reading from file tmpfile_stdout 13:36:12 INFO - Current package versions: 13:36:12 INFO - argparse == 1.2.1 13:36:12 INFO - blessings == 1.6 13:36:12 INFO - blobuploader == 1.2.4 13:36:12 INFO - docopt == 0.6.1 13:36:12 INFO - manifestparser == 1.1 13:36:12 INFO - mozInstall == 1.12 13:36:12 INFO - mozcrash == 0.17 13:36:12 INFO - mozdebug == 0.1 13:36:12 INFO - mozdevice == 0.48 13:36:12 INFO - mozfile == 1.2 13:36:12 INFO - mozhttpd == 0.7 13:36:12 INFO - mozinfo == 0.9 13:36:12 INFO - mozleak == 0.1 13:36:12 INFO - mozlog == 3.1 13:36:12 INFO - moznetwork == 0.27 13:36:12 INFO - mozprocess == 0.22 13:36:12 INFO - mozprofile == 0.28 13:36:12 INFO - mozrunner == 6.11 13:36:12 INFO - mozscreenshot == 0.1 13:36:12 INFO - mozsystemmonitor == 0.0 13:36:12 INFO - moztest == 0.7 13:36:12 INFO - mozversion == 1.4 13:36:12 INFO - psutil == 3.1.1 13:36:12 INFO - requests == 1.2.3 13:36:12 INFO - wsgiref == 0.1.2 13:36:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:12 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')]} 13:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:12 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')]} 13:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:12 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 0x7f8a8b37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac410>, '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 0x15ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ad7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', '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 13:36:12 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 13:36:12 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 13:36:12 INFO - Using env: {'DISPLAY': ':0', 13:36:12 INFO - 'HOME': '/home/cltbld', 13:36:12 INFO - 'LANG': 'en_US.UTF-8', 13:36:12 INFO - 'LANGUAGE': 'en_US:en', 13:36:12 INFO - 'LOGNAME': 'cltbld', 13:36:12 INFO - 'MAIL': '/var/mail/cltbld', 13:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:12 INFO - 'MOZ_NO_REMOTE': '1', 13:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:12 INFO - 'NO_EM_RESTART': '1', 13:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:12 INFO - 'PWD': '/builds/slave/test', 13:36:12 INFO - 'SHELL': '/bin/bash', 13:36:12 INFO - 'SHLVL': '1', 13:36:12 INFO - 'TERM': 'linux', 13:36:12 INFO - 'TMOUT': '86400', 13:36:12 INFO - 'USER': 'cltbld', 13:36:12 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', 13:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:12 INFO - '_': '/tools/buildbot/bin/python'} 13:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:12 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)) 13:36:12 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)) 13:36:12 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)) 13:36:12 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)) 13:36:12 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)) 13:36:12 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)) 13:36:12 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)) 13:36:12 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)) 13:36:12 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)) 13:36:12 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)) 13:36:12 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)) 13:36:12 INFO - Cleaning up... 13:36:12 INFO - Return code: 0 13:36:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:36:12 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')]} 13:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:12 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')]} 13:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:12 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 0x7f8a8b37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac410>, '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 0x15ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ad7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', '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 13:36:12 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 13:36:12 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 13:36:12 INFO - Using env: {'DISPLAY': ':0', 13:36:12 INFO - 'HOME': '/home/cltbld', 13:36:12 INFO - 'LANG': 'en_US.UTF-8', 13:36:12 INFO - 'LANGUAGE': 'en_US:en', 13:36:12 INFO - 'LOGNAME': 'cltbld', 13:36:12 INFO - 'MAIL': '/var/mail/cltbld', 13:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:12 INFO - 'MOZ_NO_REMOTE': '1', 13:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:12 INFO - 'NO_EM_RESTART': '1', 13:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:12 INFO - 'PWD': '/builds/slave/test', 13:36:12 INFO - 'SHELL': '/bin/bash', 13:36:12 INFO - 'SHLVL': '1', 13:36:12 INFO - 'TERM': 'linux', 13:36:12 INFO - 'TMOUT': '86400', 13:36:12 INFO - 'USER': 'cltbld', 13:36:12 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', 13:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:12 INFO - '_': '/tools/buildbot/bin/python'} 13:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:12 INFO - Downloading/unpacking jsonschema 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:36:14 INFO - Downloading/unpacking functools32 (from jsonschema) 13:36:14 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 13:36:14 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 13:36:14 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 13:36:14 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 13:36:14 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 13:36:14 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 13:36:14 INFO - Downloading functools32-3.2.3-2.tar.gz 13:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:36:14 INFO - warning: no files found matching '*.txt' 13:36:14 INFO - no previously-included directories found matching 'build' 13:36:14 INFO - no previously-included directories found matching 'dist' 13:36:14 INFO - no previously-included directories found matching '.git*' 13:36:14 INFO - Installing collected packages: jsonschema, functools32 13:36:15 INFO - Running setup.py install for functools32 13:36:15 INFO - warning: no files found matching '*.txt' 13:36:15 INFO - no previously-included directories found matching 'build' 13:36:15 INFO - no previously-included directories found matching 'dist' 13:36:15 INFO - no previously-included directories found matching '.git*' 13:36:15 INFO - Successfully installed jsonschema functools32 13:36:15 INFO - Cleaning up... 13:36:15 INFO - Return code: 0 13:36:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:36:15 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')]} 13:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:15 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')]} 13:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:15 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 0x7f8a8b37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac410>, '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 0x15ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ad7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', '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 13:36:15 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 13:36:15 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 13:36:15 INFO - Using env: {'DISPLAY': ':0', 13:36:15 INFO - 'HOME': '/home/cltbld', 13:36:15 INFO - 'LANG': 'en_US.UTF-8', 13:36:15 INFO - 'LANGUAGE': 'en_US:en', 13:36:15 INFO - 'LOGNAME': 'cltbld', 13:36:15 INFO - 'MAIL': '/var/mail/cltbld', 13:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:15 INFO - 'MOZ_NO_REMOTE': '1', 13:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:15 INFO - 'NO_EM_RESTART': '1', 13:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:15 INFO - 'PWD': '/builds/slave/test', 13:36:15 INFO - 'SHELL': '/bin/bash', 13:36:15 INFO - 'SHLVL': '1', 13:36:15 INFO - 'TERM': 'linux', 13:36:15 INFO - 'TMOUT': '86400', 13:36:15 INFO - 'USER': 'cltbld', 13:36:15 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', 13:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:15 INFO - '_': '/tools/buildbot/bin/python'} 13:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:15 INFO - Downloading/unpacking flake8 13:36:15 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 13:36:15 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 13:36:15 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 13:36:15 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 13:36:15 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 13:36:15 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 13:36:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:36:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:36:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:36:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:36:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:36:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:36:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:36:18 INFO - no previously-included directories found matching 'docs/_build' 13:36:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:36:18 INFO - Running setup.py install for pep8 13:36:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:36:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:36:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:36:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:36:18 INFO - no previously-included directories found matching 'docs/_build' 13:36:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:36:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:36:18 INFO - Cleaning up... 13:36:18 INFO - Return code: 0 13:36:18 INFO - Running post-action listener: _resource_record_post_action 13:36:18 INFO - Running post-action listener: _start_resource_monitoring 13:36:18 INFO - Starting resource monitoring. 13:36:18 INFO - ##### 13:36:18 INFO - ##### Running install step. 13:36:18 INFO - ##### 13:36:18 INFO - Running pre-action listener: _resource_record_pre_action 13:36:18 INFO - Running main action method: install 13:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:36:18 INFO - Reading from file tmpfile_stdout 13:36:18 INFO - Detecting whether we're running mozinstall >=1.0... 13:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:36:18 INFO - Reading from file tmpfile_stdout 13:36:18 INFO - Output received: 13:36:18 INFO - Usage: mozinstall [options] installer 13:36:18 INFO - Options: 13:36:18 INFO - -h, --help show this help message and exit 13:36:18 INFO - -d DEST, --destination=DEST 13:36:18 INFO - Directory to install application into. [default: 13:36:18 INFO - "/builds/slave/test"] 13:36:18 INFO - --app=APP Application being installed. [default: firefox] 13:36:18 INFO - mkdir: /builds/slave/test/build/application 13:36:18 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'] 13:36:18 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 13:36:34 INFO - Reading from file tmpfile_stdout 13:36:34 INFO - Output received: 13:36:34 INFO - /builds/slave/test/build/application/firefox/firefox 13:36:34 INFO - Running post-action listener: _resource_record_post_action 13:36:34 INFO - ##### 13:36:34 INFO - ##### Running run-tests step. 13:36:34 INFO - ##### 13:36:34 INFO - Running pre-action listener: _resource_record_pre_action 13:36:34 INFO - Running main action method: run_tests 13:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:36:34 INFO - Python 2.7.3 13:36:34 INFO - Return code: 0 13:36:34 INFO - grabbing minidump binary from tooltool 13:36: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')]} 13:36:34 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 0x15ac410>, '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 0x15ad310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ad7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:36:34 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 13:36:34 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 13:36:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:36:34 INFO - Return code: 0 13:36:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:36:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:36:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:36:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:36:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:36:35 INFO - Return code: 0 13:36:35 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/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 13:36:35 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/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 13:36:35 INFO - Using env: {'DISPLAY': ':0', 13:36:35 INFO - 'HOME': '/home/cltbld', 13:36:35 INFO - 'LANG': 'en_US.UTF-8', 13:36:35 INFO - 'LANGUAGE': 'en_US:en', 13:36:35 INFO - 'LOGNAME': 'cltbld', 13:36:35 INFO - 'MAIL': '/var/mail/cltbld', 13:36:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:36:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:35 INFO - 'MOZ_NO_REMOTE': '1', 13:36:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:35 INFO - 'NO_EM_RESTART': '1', 13:36:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:35 INFO - 'PWD': '/builds/slave/test', 13:36:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:36:35 INFO - 'SHELL': '/bin/bash', 13:36:35 INFO - 'SHLVL': '1', 13:36:35 INFO - 'TERM': 'linux', 13:36:35 INFO - 'TMOUT': '86400', 13:36:35 INFO - 'USER': 'cltbld', 13:36:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802', 13:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:35 INFO - '_': '/tools/buildbot/bin/python'} 13:36:35 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/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 13:36:35 INFO - mozversion application_buildid: 20160527104445 13:36:35 INFO - mozversion application_changeset: 65badb6bff1ea4b79837500e1a8b5969ea7fe489 13:36:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:36:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:36:35 INFO - mozversion application_name: Firefox 13:36:35 INFO - mozversion application_remotingname: firefox-dev 13:36:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:36:35 INFO - mozversion application_vendor: Mozilla 13:36:35 INFO - mozversion application_version: 48.0a2 13:36:35 INFO - mozversion platform_buildid: 20160527104445 13:36:35 INFO - mozversion platform_changeset: 65badb6bff1ea4b79837500e1a8b5969ea7fe489 13:36:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:36:35 INFO - mozversion platform_version: 48.0a2 13:36:35 INFO - using testdate: 1464381395 13:36:35 INFO - actual date: 1464381395 13:36:35 INFO - starting webserver on 'localhost:42318' 13:36:35 INFO - SUITE-START | Running 2 tests 13:36:35 INFO - TEST-START | dromaeo_css 13:36:35 INFO - operating with platform_type : linux_ 13:36:35 INFO - Initialising browser for dromaeo_css test... 13:36:35 INFO - TEST-INFO | started process 5079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQdVGP0/profile http://localhost:42318/getInfo.html) 13:36:39 INFO - PROCESS | 5079 | __metrics Screen width/height:1600/1200 13:36:39 INFO - PROCESS | 5079 | colorDepth:24 13:36:39 INFO - PROCESS | 5079 | Browser inner width/height: 1024/697 13:36:39 INFO - PROCESS | 5079 | __metrics 13:36:40 ERROR - PROCESS | 5079 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:36:41 INFO - TEST-INFO | 5079: exit 0 13:36:41 INFO - Browser initialized. 13:36:41 INFO - Running cycle 1/1 for dromaeo_css test... 13:36:41 INFO - TEST-INFO | started process 5168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQdVGP0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:36:52 INFO - PROCESS | 5168 | RSS: Main: 141979648 13:36:52 INFO - PROCESS | 5168 | 13:37:43 INFO - PROCESS | 5168 | 1464381463762 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] 13:39:51 INFO - PROCESS | 5168 | Cycle 1(1): loaded http://localhost:42318/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42318/tests/dromaeo/cssquery-ext.html) 13:39:52 INFO - PROCESS | 5168 | RSS: Main: 253247488 13:39:52 INFO - PROCESS | 5168 | 13:42:54 INFO - PROCESS | 5168 | Cycle 1(1): loaded http://localhost:42318/tests/dromaeo/cssquery-ext.html (next: http://localhost:42318/tests/dromaeo/cssquery-jquery.html) 13:42:54 INFO - PROCESS | 5168 | RSS: Main: 219906048 13:42:54 INFO - PROCESS | 5168 | 13:45:56 INFO - PROCESS | 5168 | Cycle 1(1): loaded http://localhost:42318/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42318/tests/dromaeo/cssquery-mootools.html) 13:45:57 INFO - PROCESS | 5168 | RSS: Main: 217350144 13:45:57 INFO - PROCESS | 5168 | 13:48:58 INFO - PROCESS | 5168 | Cycle 1(1): loaded http://localhost:42318/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42318/tests/dromaeo/cssquery-prototype.html) 13:48:59 INFO - PROCESS | 5168 | RSS: Main: 217980928 13:48:59 INFO - PROCESS | 5168 | 13:52:02 INFO - PROCESS | 5168 | Cycle 1(1): loaded http://localhost:42318/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42318/tests/dromaeo/cssquery-yui.html) 13:52:02 INFO - PROCESS | 5168 | RSS: Main: 212180992 13:52:02 INFO - PROCESS | 5168 | 13:55:04 INFO - PROCESS | 5168 | Cycle 1(1): loaded http://localhost:42318/tests/dromaeo/cssquery-yui.html (next: http://localhost:42318/tests/dromaeo/cssquery-dojo.html) 13:55:05 INFO - PROCESS | 5168 | RSS: Main: 254132224 13:55:05 INFO - PROCESS | 5168 | 13:55:05 INFO - PROCESS | 5168 | __start_tp_report 13:55:05 INFO - PROCESS | 5168 | _x_x_mozilla_page_load 13:55:05 INFO - PROCESS | 5168 | _x_x_mozilla_page_load_details 13:55:05 INFO - PROCESS | 5168 | |i|pagename|runs| 13:55:05 INFO - PROCESS | 5168 | |0;dojo.html;3338.2488939988507;3362.1762668146307;3368.4610462326027;3398.8470518826666;3417.350703366362;5527.060399732045;5562.3047119110115;5572.498475137237;5602;5605.131204663278;5532.197831314457;5601.943980560193;5604.383517813048;5605.747741351639;5653.802116925908;4785.1147537705465;5018.247262910565;5132.923006154911;5173.663711858717;5209.1404918188455;4962.057209130272;5062.822801201959;5064.746762661871;5074.822381216658;5079.466656001122;5001.14980453322;5026.019926114409;5042.798288068473;5060.443351231362;5060.54455099041;5053.115704751672;5074.010567939254;5081.060003899253;5081.466446023188;5118.744062796864;4912.164931961575;4939.876503087416;4976.129177393942;4981.302617633498;5001.124803159469;5327.920081198785;5368.141097424433;5389.272448219519;5398.946010539884;5401.621886467949;5839;5866.2373891393845;5867.677277749722;5868.4718375346;5869.383714709937;5921.851953701149;5933.050711886078;5974.731137098841;6027.246594175728;6030.33666296707;5515.558755299567;5549.250851135085;5561.77752889884;5563.499285064364;5568.9443105568835;5981.641101533922;6062.2725272966645;6094.116353128771;6099.298580663191;6100.450959413585;5705.686187259657;5775.451332123442;5782.074868021181;5783.94216057834;5792.797252096157;5884.941150588439;5899.380565040695;5900.1149827526215;5900.675462849585;5901.29184497863;5748.827535173951;5860.326062502867;5868.794592189253;5882.558808089325;5892.175095486636;5838.095095260242;5866.882662346729;5877.324107727581;5880.176775251468;5909.23179986599;4484.865454036319;4488.5960263576435;4489.483709373399;4489.955100448954;4515.029268707178;4002.0995276063236;4009.7594144351433;4017.738846974937;4028.7582745035393;4058.553559108496;5575.0522411190195;5590.357108932443;5601.355844077902;5603.15952607104;5606.523445507178;5936.287645482484;5943.31651860033;5954.523638108941;5957.851053723605;5958.493528050078;5546.77812887488;5559.916601250984;5578.8047418340975;5615.101583746663;5709.115087161496;5065.898682026339;5101.8724531887;5107.387113546398;5112.693238405707;5114.3095682083185;6106.328303886569;6110.725017374229;6116.785912493041;6122.908156377658;6134.9079763803575;5824.242848429762;5963.224780778644;6037.124616930609;6061.333253342217;6064.151018857452;6080.817575472743;6082.36135205797;6084.056971169476;6090.451859332681;6092.208012958465;5725.828225153252;5779;5779.393163717749;5788.9131663024245;5789.652620842763;5964.463198312173;6004.339522652592;6013.098035294741;6035.758569657341;6062;5722.17028530869;5767.048437008015;5770.769169233184;5771.249737534094;5771.538276937751;5628.380878103323;5695.715214239354;5750.194972703908;5771.480566749013;5820.039693450533;5755.021646320052;5800.796972105956;5808.970955145197;5816.243888294494;5861.238039054895;5876.44173803488;5888.352281248974;5913.2608423947;5914.34942156371;5918.911216331672;5549.611527193219;5705.828825135252;5793.594448388741;5798.362180160263;5802.883942321046 13:55:05 INFO - PROCESS | 5168 | |1;ext.html;657.0997733105646;671.1375881991642;673.2056173715017;673.7237732529663;716.8458781362008;31757.841210793944;39366.40950385743;40000.79999599998;40135.39796903049;40149.59850401495;41789.164216715646;42523.57476425242;42545;42581.7870910645;42617.78691106548;8745.86881196781;8927.732168034969;8932.598033088494;8933.285337173043;8935.374523783337;8746.825063498727;8864.512451815148;8864.73405797824;8871.911280887172;8873.378863479527;9055.547222638874;9098.63605455781;9113.043130471304;9122.179003889649;9122.908770912305;9024.8646270306;9082.909170908273;9086;9087.545622718872;9091.454512729224;8996.460212387277;9099.272058235325;9102.954485227598;9104.8634270486;9105.772355691095;42710.35934460985;43339.56660433387;43352;43394.78302608467;43396.783016085035;3532.6290739472242;3733.383991641403;3754.906127346811;3755.4179102239195;3805.2579746949355;29587.85206073956;29839.850800746073;30247.697523024708;30493.542596861065;30551.694483055107;4628.051680405806;4654.906901861944;4680.087382960324;4687.320338550925;4690.249560070372;279345;279941;280457.99999999796;281474;282703;37683.24633507314;61788;62405;62466.687666562284;62480;36640;36692.08269793277;36757;36819.63180368162;36827.26345473075;13929.442822287197;14001.71996560063;14004.579862604138;14018.719625607431;14030.929845350707;13678.589642310746;13691.110077844909;13732;13735.519256825963;13737.656558585915;8898.754174415588;8931.240844528158;8935.463872167691;9081.273498120134;9145.268378529701;3435.7766745161484;3538.380783362901;3545.2732189901008;3604.9098772530897;3605.2068544920076;1044.9007344302279;1074.387599068539;1078.6009176604707;1115.275071203724;1193.773183095209;34018.14954626154;34243.315133697186;34402.65597344044;34482;34708;1123.4045955643521;1150.1259043127284;1185.3776767197292;1196.7068068323142;1277.118788036252;17678.734818977468;18065.458036258933;18160.636787264182;18201.180946857425;18218.36235731743;483708;484388;486743;487040;487453;61448.69275653593;62367.68816155981;62449.37550624526;62481.062784058275;62524;1410.189141243789;1474.727175472541;1487.8437764034836;1496.5959191018364;1579.755137953642;30412.5438118424;32646.51030234596;33149.33701326008;33399.83300083484;34392.14019649529;58327;59933.10100348411;59935.100973486304;59955;60066.39933600608;422922;431403;432536;433222;436039;39002.804985974886;45394.77302613466;47472.28791568198;47656;49198.26202606892;47664.28503572519;48503.5149648499;48530;49525.25712114249;50927.745361274436;36829.63170368262;37348.439773402875;39742.40386394264;40383.3942490857;41755;39372.60627393804;39381;39440.64754495785;40263;41082.383764242964;41233.1753364937;41813.163736725706;41815;42447.3632895513;42710.57289427066;34874.65125348714;36300;36952.81523592365;37249;37260.81369593135;28706.856465717538;28814.6986332067;29088.7091129086;29275.268118297212;29327.413451731274 13:55:05 INFO - PROCESS | 5168 | |2;jquery.html;424.9022724773302;425.73817102481985;429.42457107475974;431.96112349888546;442.49997502821805;18333.816661833393;18869.71695424568;18911.905440472794;19340.61318773624;20168.294109706163;12717.745645087092;12993.675158121028;14451.554844515544;20142.194312227493;20181;5116.309298244736;5197.974010129944;5322.787088516474;5327;5355.758990845402;5385.057614917393;5424.864378390533;5430.809921652743;5468.808591699291;5470.617056806025;5463.071277882749;5465.316835395575;5466.207399927008;5477.917831232535;5479.068558345071;5448.727563621803;5682.090865461506;5700.686462244575;5701.0878259478495;5702.77188912443;5317.893642127175;5549.916751248735;5554.1113421852715;5558.888822223533;5576.71735500833;13950.511732089328;13984.510542130976;14208.289585520786;18876.81123188778;22312.776872231232;2576.265764257196;2656.8405895646324;2729.56326987683;2862.169970708492;3114.1903105192587;10028.59885604575;10053.145482633985;10334.224933130045;10481.423521706303;10666.413347265974;2018.8384929205629;2043.540203454211;2109.4726318420394;2117.2166298469665;2136.529963408048;73741.63129184373;78702.60648696776;82210.58894705548;83698;85289;11338.603148889913;11689.941550292195;11755.88244117548;11870.643880683594;11882.346470944181;16405.753913691304;16622.168891555375;16625.334986600643;16671;16702.832971670126;8480.575971201415;8630.741077767678;8649.913500865037;8691.652333906573;8748.737537873874;8092.352611791042;8214.548199848947;8226.794330141794;8256.711015114563;8364.498130112213;4529.909401811945;4894.486078961658;5026.1204289249235;5103.260027296022;5116;2022.1304838919111;2044.2231951858496;2053.8254248389053;2101.506146055676;2103.3689893032333;974.9658761943298;993.8260804359353;1014.523174108168;1015.7409860485677;1120.8542889424486;19002.904985474983;19450.124744386536;19598.314059008153;19925.402237932885;20138.59722805565;996.8355221388534;1014.949252537385;1039.5538788914873;1058.5977328615077;1116.6761639124563;10571.735706607396;11051.668449946514;11103.44482775858;11170.720731981766;11180.664580062612;503377;509760;510659;519028;520938;51110.48889511132;76099.23900760921;79076.60461697655;90877.54561227151;95208.52395737977;1055.4353420919924;1063.2557209953063;1077.946102694862;1082.691432941608;1095.2880627592128;16432.83567164313;16875.493735187963;16933;17329.82670173282;17624.206910688794;39015.41476877906;39442.605573943896;39816;40113.1977360457;40402.1919561613;55245.44754552403;56222.43777562336;56437.435625643215;56580;56911;8821;8824.647014119364;9035.367524273237;9054.728358149267;9067.410618309788;9403.4828084456;11727.47226374798;12530.997520198545;12763.744725105631;13117.73764524685;10569.471526423802;10760.3543787373;10937.179711521509;11027.61403350879;11028.889711102785;10868.347899126078;11047.447627618747;11134.777304454028;11168.720781980515;11259.605913792979;10523.526441310007;11043.558257669925;11096.389698566656;11205.495752691311;11968.640940771442;8555.786105347415;8609;8909.465432074096;8970;9042.186203241477;8174.509529428254;10954;11005.449727513753;11052.889471105185;11498.827517587075 13:55:05 INFO - PROCESS | 5168 | |3;mootools.html;1394.4422231107549;1539.1303913288991;1552.5963249555116;1714.7942246930363;1851.9074046297683;7469.327760501554;7564.243575642433;7607.923920760791;7612.391008719303;7614.8857767133395;8293.751187464371;8482.91517084829;8486;8490.193431624002;8498.6175622097;2366.2428023032635;2399.760023997595;2400.0399840063938;2401.3036219496325;2402.3633737059695;2187.1579441914896;2246.6630005499223;2252.5044490212126;2268.4895898422806;2269.4893648929024;2378.583747844129;2378.940526486834;2403.2790162951046;2438.3904023994;2443.2303824295377;2357.9882100589557;2372.2764556810166;2379.0602711928864;2383.7377888432256;2445.8287919845616;2350.224425939453;2376.6910301660846;2383.13015749252;2383.8212134090013;2384.6423036544484;8141.307988820958;8459.830803383898;8470.534120623362;8492.447990880635;8506.362022848249;5198;5221.477852214786;5256.894862102775;5269.604779641542;5278.709670968095;3287.7041066304146;3335.666433356669;3378.864845406181;3380.188754698879;3418.1967237699123;1135.3585224348217;1148.500402324983;1171.8457319540246;1178.63462326679;1186.7626474705094;11300.660980170607;11356.545738170464;11362.545498180145;11383.430828458544;11385;4401.581849724335;4414.646828253732;4493.820247190141;4525.027119169395;4541.72749635023;9174.724758257264;9205.309601779893;9215.493147876798;9224.7693807654;9227.123423274777;5255.500727430888;5260.079486089995;5263.894722105613;5268.051750684914;5268.525832675077;4261.552536983634;4746.121967436035;4895.926561101586;4918.458969513351;4922.483139270396;3798.7910664913143;3802.866899658499;3849.9230015400094;3875.1862108957434;3882.650561449483;1155.0701685143372;1161.5818305410046;1162.5291756838494;1162.7965106106396;1179.1274456902001;804.8792681097765;1043.5147656339839;1045.5033858917106;1051.8632577764995;1076.9983914959164;5697.487226149667;5833.358330583633;6050.45545900871;6058.848528786727;6148.077788331697;485.51691067388174;509.2844553402475;516.651260399229;516.9483051694875;660.9603423794491;4239;4351.151525452507;4357.346398040256;4367.912641747147;4370.497392799869;10385.896141038493;10864.619738309279;10908.781824363468;10950.616728414467;10984.176186785864;10736.355818650905;10788.40663763485;10793.67618971432;10820.89179108199;10831.458427078614;8084.514929104273;8196.057453392936;8226.629801658939;8249.463784853966;8327.375446841512;5970.194023806731;6099.085137229451;6113.388661133851;6165.414285642857;6241.750329986749;9353.719388418358;9401.294902882175;9429.52852357393;9521.333506654468;9655.22758179358;9425.293103017164;9729.659461918798;9734.853977190489;9739.41563506192;9885.159761420073;6803.9659801702655;7502.399808015237;7627.618619068913;7794.4543881929985;7941.166177551274;8220.671173153007;8226.095129535866;8247.752567422987;8263.917360826315;8278.503289802631;7404.666789994355;7647.961760191163;7657.349125324187;7669.578173200527;7670.8082297943;7066.152061752623;7089.149302083783;7108.822279443055;7197.208307086112;7242.565446073252;7149.928500715135;7174.174969878531;7178.425725941807;7184.748533801292;7230.313120253568;5191.636585439134;5222.060029194781;5233.790648374023;5354.973225133849;5424.674519528841;5466.3986961435;5476.315460567429;5543.057680194296;5584.050711379156;5635.154726791015 13:55:05 INFO - PROCESS | 5168 | |4;prototype.html;342.98285085745704;356.8768774772702;360.87549795320615;363.5128927237501;363.71266699307546;6100.877982440348;6112.69436528174;6143.047827586725;6160.106784516242;6192.690365481731;6097.634141951486;6112.6638034908065;6123.173371594833;6128.356522565122;6133.81598552043;4506.616937560311;4594.563516465931;4667.18324293249;4672.929906051412;4675.696079754805;4631.722096674193;4663.207254766681;4675.392199014123;4677.532246775329;4685.344051832729;4453.77731113443;4626.467956185048;4634.745089020103;4637.327587499811;4639.512851150631;4515.525869783674;4519.706219095749;4526.8682829292675;4613.100445413146;4626.074785043005;4049.817758200888;4057.3102572562734;4063.3295506241434;4067.247559201557;4073.551909289976;5857.326407463153;5903.616264942765;5906.084556893688;5913.438223368773;5917.852053698692;5375.623706340558;5377.274068000848;5385.434529374437;5392.541633961118;5397.082495975694;6407.487401007908;6411.1024456576115;6419.229692436891;6424.646644434554;6425.45383642391;4340.175366680352;4442.2892337225885;4443.511213766483;4444.6666500012625;4449.199144154051;6423.100765892778;6559.540832141752;6566.310537393552;6574.506911981573;6586.835329116762;4510.075434535912;4510.345999830006;4515.345274935116;4516.16450956574;4520.118576877478;4565.155446242389;4573.0396616710195;4577.496475387705;4577.702449340783;4583.197940360424;5285.445028271976;5287.947120528823;5291.126964050965;5291.576673866081;5309.123994540858;6246.219222597176;6383.425491705769;6387.808365749035;6399.8080057598345;6401.103845461639;1584.128729198936;1605.8956167849053;1614.9273282702306;1620.4490473239155;1620.9027458352537;1001.399160503692;1033.493588141805;1044.1959691037857;1070.3898777696638;1071.1056268016139;6180.938190618036;6254.15568898202;6284.748610055546;6284.937150628435;6287.717052732638;6641.900371494431;6645.900311495331;6673.866522669519;6727.428168605723;6736.225334086643;6309.621422714652;6318.715657795318;6322.683865806784;6328.145700330397;6342.746290148435;3558.217192217708;3574.7140228781636;3585.7489975701974;3590.8025058621506;3606.2246616977477;6794.150731158606;6918.135233095863;6935.029095926574;6949;6970.965145174242;6770.796876093725;6790.0493930849725;6793.72825086991;6796.694148763318;6801.843686573295;6928.272531384233;6929.133858267716;6934.687939042755;6940.548864323803;6949.5830250184135;6679.465642748665;6680.164979377578;6688.665566721742;6693.196816382066;6694.698738556679;6386.648734319657;6586.4401525870835;6590.340965903371;6600.405963463311;6604.603723776397;6902.137232845895;6928.549644273106;6939.132608423947;6944.2708515607155;6946.340097690711;4584.656150788771;4586.174488591952;4590.196715574828;4592;4598.080383923296;6653.866922661617;6654;6661.367170118831;6661.46708263328;6664.3335666434905;6318.399752023551;6461.741530338733;6494.74021039172;6516.250631177475;6529.99620174725;6425;6431.228252609717;6434.4852411806005;6485.772997945238;6489.1888513935755;6357.23713154406;6383.808485745435;6423.068655044899;6426.325235850169;6434.099226108442;6550.050242714875;6562.507811914221;6565.080888675494;6578.605283682994;6579.276279609335;6030.095485677183;6126.5711400203345;6372.235331760218;6408.743650253938;6411.102445657705 13:55:05 INFO - PROCESS | 5168 | |5;yui.html;887.2813021452623;889.2885691446841;903.9457632542052;909.6907051602453;940.5344354544497;15506.612334691637;15527.844721552781;15710.528684139466;15754.448594299201;15755.684886302268;13184.077114601982;13367.933160334185;13398.330083495835;13413.932930335359;13414.26221557814;738.4387865222443;856.4304737349655;872.293442311728;883.0727735877335;888.0764005434373;873.0134947509306;875.295387213293;879.9516026618534;880.3925291548843;880.5993273060742;918.8254231695956;920.0753242990785;925.121134921827;926.0507979321183;926.4117285523707;755.5089192025173;894.4365050018512;911.3074063711593;913.9268858491338;922.299052719931;676.3507033248088;676.577139287945;677.1501765284536;677.1501765284586;677.3192941094218;14218.217998010105;14224.928875355557;14234.572962811133;14252.218472690914;14287.357068931922;14707.485238016725;15444.150571718552;15812.683746325009;15873.206339682969;15913.681726365523;12400.627981160489;12401.813972790414;12416.56542021034;12554.309512976874;12728.74542509154;4678.274867395559;4737.052589482118;4742.881427964328;4755.548222918817;4938.950610493885;61118.999999999556;62024.37975620231;62112.378876211566;62145.689271553354;62571.37428625701;11719.88280117188;11734.119941004288;11760.941195293968;11872.643820685393;12197.268163910194;19768.60462790736;19776.406707798502;19789.406317810488;19802.50493737668;19814.801851981585;8436.620352084172;8485.236328730443;8539.316854651614;8624;8695.608697608623;4931.630127740434;4971.229459433794;4987.1771157759285;4997.85006449807;4998.525140111684;3421.1789170599377;3488.9825550872083;3566.589842168132;3568.3576956148145;3575.4279315309427;637.1271358239242;644.2333622988629;658.2035736758576;662.3045801907978;668.2482207516543;787.3425689549291;793.9364850811921;806.899137607799;806.9717559885376;817.3052905030795;9432.52837358143;9663.27525435595;9908.603655853829;10024.649137280307;10042.096211341015;620.2742790934617;663.5521023309246;680.2279412866334;774.9496282741604;787.8069872881066;4398.252297109499;4430.379746835446;4446.510883802844;4531.3882625845745;4639.37368455261;71193;72394;72644;72796.63601681958;72957.6352118236;61266.38733612607;62898.37101629017;62958.37041629525;63387;63644;55643;55957.720211398686;55985.16022259588;56595.434045659014;57323.71338143366;9027.322950778587;9051.95474022652;9113.77215569616;9177.47619404669;9190.988991210828;40751;41063.7946810276;42161;42266.1546769069;42438;49335.28655923815;52129.47870521246;52521;53146.73426632842;53593.73203133959;11221.158413118885;11319.09447244202;11405.315681059163;11512;11545.595904143314;12630.87369126297;12775.23348599087;12891.904188144114;12933;13558.661033474242;11627.709307267047;12755.93622031884;12771.425285861973;12874.291913944822;12900.41948112356;12344.3827808611;12375.195612285173;12395.256284622952;12505.499780008699;12509.812352814897;12068;12140.514379424723;12174.817377739519;12199.14605977573;12373.814392784296;9375.156235938526;9465.016478647578;9537.475438850652;9660.516974151406;9681.37071090377;10103.797924041624;10270.794584108426;10275.229357798344;10275.7431064221;10350.378977261389 13:55:05 INFO - PROCESS | 5168 | __end_tp_report 13:55:05 INFO - PROCESS | 5168 | __start_cc_report 13:55:05 INFO - PROCESS | 5168 | _x_x_mozilla_cycle_collect,807 13:55:05 INFO - PROCESS | 5168 | __end_cc_report 13:55:05 INFO - PROCESS | 5168 | __startTimestamp1464382505188__endTimestamp 13:55:05 INFO - PROCESS | 5168 | 13:55:05 INFO - PROCESS | 5168 | ------- Summary: start ------- 13:55:05 INFO - PROCESS | 5168 | Number of tests: 6 13:55:05 INFO - PROCESS | 5168 | 13:55:05 INFO - PROCESS | 5168 | [#0] dojo.html Cycles:165 Average:5504.65 Median:5748.83 stddev:609.09 (10.6%) stddev-sans-first:586.77 13:55:05 INFO - PROCESS | 5168 | Values: 3338.2 3362.2 3368.5 3398.8 3417.4 5527.1 5562.3 5572.5 5602.0 5605.1 5532.2 5601.9 5604.4 5605.7 5653.8 4785.1 5018.2 5132.9 5173.7 5209.1 4962.1 5062.8 5064.7 5074.8 5079.5 5001.1 5026.0 5042.8 5060.4 5060.5 5053.1 5074.0 5081.1 5081.5 5118.7 4912.2 4939.9 4976.1 4981.3 5001.1 5327.9 5368.1 5389.3 5398.9 5401.6 5839.0 5866.2 5867.7 5868.5 5869.4 5921.9 5933.1 5974.7 6027.2 6030.3 5515.6 5549.3 5561.8 5563.5 5568.9 5981.6 6062.3 6094.1 6099.3 6100.5 5705.7 5775.5 5782.1 5783.9 5792.8 5884.9 5899.4 5900.1 5900.7 5901.3 5748.8 5860.3 5868.8 5882.6 5892.2 5838.1 5866.9 5877.3 5880.2 5909.2 4484.9 4488.6 4489.5 4490.0 4515.0 4002.1 4009.8 4017.7 4028.8 4058.6 5575.1 5590.4 5601.4 5603.2 5606.5 5936.3 5943.3 5954.5 5957.9 5958.5 5546.8 5559.9 5578.8 5615.1 5709.1 5065.9 5101.9 5107.4 5112.7 5114.3 6106.3 6110.7 6116.8 6122.9 6134.9 5824.2 5963.2 6037.1 6061.3 6064.2 6080.8 6082.4 6084.1 6090.5 6092.2 5725.8 5779.0 5779.4 5788.9 5789.7 5964.5 6004.3 6013.1 6035.8 6062.0 5722.2 5767.0 5770.8 5771.2 5771.5 5628.4 5695.7 5750.2 5771.5 5820.0 5755.0 5800.8 5809.0 5816.2 5861.2 5876.4 5888.4 5913.3 5914.3 5918.9 5549.6 5705.8 5793.6 5798.4 5802.9 13:55:05 INFO - PROCESS | 5168 | 13:55:05 INFO - PROCESS | 5168 | [#1] ext.html Cycles:180 Average:56465.56 Median:41157.78 stddev:108239.42 (263.0%) stddev-sans-first:108461.95 13:55:05 INFO - PROCESS | 5168 | Values: 657.1 671.1 673.2 673.7 716.8 31757.8 39366.4 40000.8 40135.4 40149.6 41789.2 42523.6 42545.0 42581.8 42617.8 8745.9 8927.7 8932.6 8933.3 8935.4 8746.8 8864.5 8864.7 8871.9 8873.4 9055.5 9098.6 9113.0 9122.2 9122.9 9024.9 9082.9 9086.0 9087.5 9091.5 8996.5 9099.3 9103.0 9104.9 9105.8 42710.4 43339.6 43352.0 43394.8 43396.8 3532.6 3733.4 3754.9 3755.4 3805.3 29587.9 29839.9 30247.7 30493.5 30551.7 4628.1 4654.9 4680.1 4687.3 4690.2 279345.0 279941.0 280458.0 281474.0 282703.0 37683.2 61788.0 62405.0 62466.7 62480.0 36640.0 36692.1 36757.0 36819.6 36827.3 13929.4 14001.7 14004.6 14018.7 14030.9 13678.6 13691.1 13732.0 13735.5 13737.7 8898.8 8931.2 8935.5 9081.3 9145.3 3435.8 3538.4 3545.3 3604.9 3605.2 1044.9 1074.4 1078.6 1115.3 1193.8 34018.1 34243.3 34402.7 34482.0 34708.0 1123.4 1150.1 1185.4 1196.7 1277.1 17678.7 18065.5 18160.6 18201.2 18218.4 483708.0 484388.0 486743.0 487040.0 487453.0 61448.7 62367.7 62449.4 62481.1 62524.0 1410.2 1474.7 1487.8 1496.6 1579.8 30412.5 32646.5 33149.3 33399.8 34392.1 58327.0 59933.1 59935.1 59955.0 60066.4 422922.0 431403.0 432536.0 433222.0 436039.0 39002.8 45394.8 47472.3 47656.0 49198.3 47664.3 48503.5 48530.0 49525.3 50927.7 36829.6 37348.4 39742.4 40383.4 41755.0 39372.6 39381.0 39440.6 40263.0 41082.4 41233.2 41813.2 41815.0 42447.4 42710.6 34874.7 36300.0 36952.8 37249.0 37260.8 28706.9 28814.7 29088.7 29275.3 29327.4 13:55:05 INFO - PROCESS | 5168 | 13:55:05 INFO - PROCESS | 5168 | [#2] jquery.html Cycles:180 Average:28866.21 Median:2616.55 stddev:84231.09 (3219.2%) stddev-sans-first:84440.31 13:55:05 INFO - PROCESS | 5168 | Values: 424.9 425.7 429.4 432.0 442.5 18333.8 18869.7 18911.9 19340.6 20168.3 12717.7 12993.7 14451.6 20142.2 20181.0 5116.3 5198.0 5322.8 5327.0 5355.8 5385.1 5424.9 5430.8 5468.8 5470.6 5463.1 5465.3 5466.2 5477.9 5479.1 5448.7 5682.1 5700.7 5701.1 5702.8 5317.9 5549.9 5554.1 5558.9 5576.7 13950.5 13984.5 14208.3 18876.8 22312.8 2576.3 2656.8 2729.6 2862.2 3114.2 10028.6 10053.1 10334.2 10481.4 10666.4 2018.8 2043.5 2109.5 2117.2 2136.5 73741.6 78702.6 82210.6 83698.0 85289.0 11338.6 11689.9 11755.9 11870.6 11882.3 16405.8 16622.2 16625.3 16671.0 16702.8 8480.6 8630.7 8649.9 8691.7 8748.7 8092.4 8214.5 8226.8 8256.7 8364.5 4529.9 4894.5 5026.1 5103.3 5116.0 2022.1 2044.2 2053.8 2101.5 2103.4 975.0 993.8 1014.5 1015.7 1120.9 19002.9 19450.1 19598.3 19925.4 20138.6 996.8 1014.9 1039.6 1058.6 1116.7 10571.7 11051.7 11103.4 11170.7 11180.7 503377.0 509760.0 510659.0 519028.0 520938.0 51110.5 76099.2 79076.6 90877.5 95208.5 1055.4 1063.3 1077.9 1082.7 1095.3 16432.8 16875.5 16933.0 17329.8 17624.2 39015.4 39442.6 39816.0 40113.2 40402.2 55245.4 56222.4 56437.4 56580.0 56911.0 8821.0 8824.6 9035.4 9054.7 9067.4 9403.5 11727.5 12531.0 12763.7 13117.7 10569.5 10760.4 10937.2 11027.6 11028.9 10868.3 11047.4 11134.8 11168.7 11259.6 10523.5 11043.6 11096.4 11205.5 11968.6 8555.8 8609.0 8909.5 8970.0 9042.2 8174.5 10954.0 11005.4 11052.9 11498.8 13:55:05 INFO - PROCESS | 5168 | 13:55:05 INFO - PROCESS | 5168 | [#3] mootools.html Cycles:180 Average:5644.21 Median:5221.77 stddev:3108.56 (59.5%) stddev-sans-first:3100.87 13:55:05 INFO - PROCESS | 5168 | Values: 1394.4 1539.1 1552.6 1714.8 1851.9 7469.3 7564.2 7607.9 7612.4 7614.9 8293.8 8482.9 8486.0 8490.2 8498.6 2366.2 2399.8 2400.0 2401.3 2402.4 2187.2 2246.7 2252.5 2268.5 2269.5 2378.6 2378.9 2403.3 2438.4 2443.2 2358.0 2372.3 2379.1 2383.7 2445.8 2350.2 2376.7 2383.1 2383.8 2384.6 8141.3 8459.8 8470.5 8492.4 8506.4 5198.0 5221.5 5256.9 5269.6 5278.7 3287.7 3335.7 3378.9 3380.2 3418.2 1135.4 1148.5 1171.8 1178.6 1186.8 11300.7 11356.5 11362.5 11383.4 11385.0 4401.6 4414.6 4493.8 4525.0 4541.7 9174.7 9205.3 9215.5 9224.8 9227.1 5255.5 5260.1 5263.9 5268.1 5268.5 4261.6 4746.1 4895.9 4918.5 4922.5 3798.8 3802.9 3849.9 3875.2 3882.7 1155.1 1161.6 1162.5 1162.8 1179.1 804.9 1043.5 1045.5 1051.9 1077.0 5697.5 5833.4 6050.5 6058.8 6148.1 485.5 509.3 516.7 516.9 661.0 4239.0 4351.2 4357.3 4367.9 4370.5 10385.9 10864.6 10908.8 10950.6 10984.2 10736.4 10788.4 10793.7 10820.9 10831.5 8084.5 8196.1 8226.6 8249.5 8327.4 5970.2 6099.1 6113.4 6165.4 6241.8 9353.7 9401.3 9429.5 9521.3 9655.2 9425.3 9729.7 9734.9 9739.4 9885.2 6804.0 7502.4 7627.6 7794.5 7941.2 8220.7 8226.1 8247.8 8263.9 8278.5 7404.7 7648.0 7657.3 7669.6 7670.8 7066.2 7089.1 7108.8 7197.2 7242.6 7149.9 7174.2 7178.4 7184.7 7230.3 5191.6 5222.1 5233.8 5355.0 5424.7 5466.4 5476.3 5543.1 5584.1 5635.2 13:55:05 INFO - PROCESS | 5168 | 13:55:05 INFO - PROCESS | 5168 | [#4] prototype.html Cycles:180 Average:5396.42 Median:6170.52 stddev:1639.33 (26.6%) stddev-sans-first:1599.45 13:55:05 INFO - PROCESS | 5168 | Values: 343.0 356.9 360.9 363.5 363.7 6100.9 6112.7 6143.0 6160.1 6192.7 6097.6 6112.7 6123.2 6128.4 6133.8 4506.6 4594.6 4667.2 4672.9 4675.7 4631.7 4663.2 4675.4 4677.5 4685.3 4453.8 4626.5 4634.7 4637.3 4639.5 4515.5 4519.7 4526.9 4613.1 4626.1 4049.8 4057.3 4063.3 4067.2 4073.6 5857.3 5903.6 5906.1 5913.4 5917.9 5375.6 5377.3 5385.4 5392.5 5397.1 6407.5 6411.1 6419.2 6424.6 6425.5 4340.2 4442.3 4443.5 4444.7 4449.2 6423.1 6559.5 6566.3 6574.5 6586.8 4510.1 4510.3 4515.3 4516.2 4520.1 4565.2 4573.0 4577.5 4577.7 4583.2 5285.4 5287.9 5291.1 5291.6 5309.1 6246.2 6383.4 6387.8 6399.8 6401.1 1584.1 1605.9 1614.9 1620.4 1620.9 1001.4 1033.5 1044.2 1070.4 1071.1 6180.9 6254.2 6284.7 6284.9 6287.7 6641.9 6645.9 6673.9 6727.4 6736.2 6309.6 6318.7 6322.7 6328.1 6342.7 3558.2 3574.7 3585.7 3590.8 3606.2 6794.2 6918.1 6935.0 6949.0 6971.0 6770.8 6790.0 6793.7 6796.7 6801.8 6928.3 6929.1 6934.7 6940.5 6949.6 6679.5 6680.2 6688.7 6693.2 6694.7 6386.6 6586.4 6590.3 6600.4 6604.6 6902.1 6928.5 6939.1 6944.3 6946.3 4584.7 4586.2 4590.2 4592.0 4598.1 6653.9 6654.0 6661.4 6661.5 6664.3 6318.4 6461.7 6494.7 6516.3 6530.0 6425.0 6431.2 6434.5 6485.8 6489.2 6357.2 6383.8 6423.1 6426.3 6434.1 6550.1 6562.5 6565.1 6578.6 6579.3 6030.1 6126.6 6372.2 6408.7 6411.1 13:55:05 INFO - PROCESS | 5168 | 13:55:05 INFO - PROCESS | 5168 | [#5] yui.html Cycles:180 Average:16228.63 Median:4992.51 stddev:19801.94 (396.6%) stddev-sans-first:19823.98 13:55:05 INFO - PROCESS | 5168 | Values: 887.3 889.3 903.9 909.7 940.5 15506.6 15527.8 15710.5 15754.4 15755.7 13184.1 13367.9 13398.3 13413.9 13414.3 738.4 856.4 872.3 883.1 888.1 873.0 875.3 880.0 880.4 880.6 918.8 920.1 925.1 926.1 926.4 755.5 894.4 911.3 913.9 922.3 676.4 676.6 677.2 677.2 677.3 14218.2 14224.9 14234.6 14252.2 14287.4 14707.5 15444.2 15812.7 15873.2 15913.7 12400.6 12401.8 12416.6 12554.3 12728.7 4678.3 4737.1 4742.9 4755.5 4939.0 61119.0 62024.4 62112.4 62145.7 62571.4 11719.9 11734.1 11760.9 11872.6 12197.3 19768.6 19776.4 19789.4 19802.5 19814.8 8436.6 8485.2 8539.3 8624.0 8695.6 4931.6 4971.2 4987.2 4997.9 4998.5 3421.2 3489.0 3566.6 3568.4 3575.4 637.1 644.2 658.2 662.3 668.2 787.3 793.9 806.9 807.0 817.3 9432.5 9663.3 9908.6 10024.6 10042.1 620.3 663.6 680.2 774.9 787.8 4398.3 4430.4 4446.5 4531.4 4639.4 71193.0 72394.0 72644.0 72796.6 72957.6 61266.4 62898.4 62958.4 63387.0 63644.0 55643.0 55957.7 55985.2 56595.4 57323.7 9027.3 9052.0 9113.8 9177.5 9191.0 40751.0 41063.8 42161.0 42266.2 42438.0 49335.3 52129.5 52521.0 53146.7 53593.7 11221.2 11319.1 11405.3 11512.0 11545.6 12630.9 12775.2 12891.9 12933.0 13558.7 11627.7 12755.9 12771.4 12874.3 12900.4 12344.4 12375.2 12395.3 12505.5 12509.8 12068.0 12140.5 12174.8 12199.1 12373.8 9375.2 9465.0 9537.5 9660.5 9681.4 10103.8 10270.8 10275.2 10275.7 10350.4 13:55:05 INFO - PROCESS | 5168 | -------- Summary: end -------- 13:55:05 INFO - PROCESS | 5168 | 13:55:05 INFO - TEST-INFO | 5168: exit 0 13:55:05 INFO - TEST-OK | dromaeo_css | took 1110553ms 13:55:05 INFO - TEST-START | kraken 13:55:05 INFO - operating with platform_type : linux_ 13:55:05 INFO - Initialising browser for kraken test... 13:55:05 INFO - TEST-INFO | started process 5354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjI6c2S/profile http://localhost:42318/getInfo.html) 13:55:09 INFO - PROCESS | 5354 | __metrics Screen width/height:1600/1200 13:55:09 INFO - PROCESS | 5354 | colorDepth:24 13:55:09 INFO - PROCESS | 5354 | Browser inner width/height: 1024/697 13:55:09 INFO - PROCESS | 5354 | __metrics 13:55:10 ERROR - PROCESS | 5354 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:55:11 INFO - TEST-INFO | 5354: exit 0 13:55:11 INFO - Browser initialized. 13:55:11 INFO - Running cycle 1/1 for kraken test... 13:55:11 INFO - TEST-INFO | started process 5451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjI6c2S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:55:23 INFO - PROCESS | 5451 | RSS: Main: 142184448 13:55:23 INFO - PROCESS | 5451 | 13:55:25 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42318/tests/kraken/driver.html?testName=audio-beat-detection) 13:55:26 INFO - PROCESS | 5451 | RSS: Main: 197152768 13:55:26 INFO - PROCESS | 5451 | 13:55:29 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42318/tests/kraken/driver.html?testName=audio-dft) 13:55:29 INFO - PROCESS | 5451 | RSS: Main: 182976512 13:55:29 INFO - PROCESS | 5451 | 13:55:32 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42318/tests/kraken/driver.html?testName=audio-fft) 13:55:33 INFO - PROCESS | 5451 | RSS: Main: 273178624 13:55:33 INFO - PROCESS | 5451 | 13:55:35 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42318/tests/kraken/driver.html?testName=audio-oscillator) 13:55:35 INFO - PROCESS | 5451 | RSS: Main: 179056640 13:55:35 INFO - PROCESS | 5451 | 13:55:37 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42318/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:55:38 INFO - PROCESS | 5451 | RSS: Main: 177586176 13:55:38 INFO - PROCESS | 5451 | 13:55:41 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42318/tests/kraken/driver.html?testName=imaging-darkroom) 13:55:42 INFO - PROCESS | 5451 | RSS: Main: 212533248 13:55:42 INFO - PROCESS | 5451 | 13:55:45 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42318/tests/kraken/driver.html?testName=imaging-desaturate) 13:55:46 INFO - PROCESS | 5451 | RSS: Main: 212930560 13:55:46 INFO - PROCESS | 5451 | 13:55:48 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42318/tests/kraken/driver.html?testName=json-parse-financial) 13:55:49 INFO - PROCESS | 5451 | RSS: Main: 213188608 13:55:49 INFO - PROCESS | 5451 | 13:55:50 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42318/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:55:51 INFO - PROCESS | 5451 | RSS: Main: 191262720 13:55:51 INFO - PROCESS | 5451 | 13:55:53 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42318/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:55:53 INFO - PROCESS | 5451 | RSS: Main: 192520192 13:55:53 INFO - PROCESS | 5451 | 13:55:55 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42318/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:55:56 INFO - PROCESS | 5451 | RSS: Main: 206766080 13:55:56 INFO - PROCESS | 5451 | 13:55:58 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:55:59 INFO - PROCESS | 5451 | RSS: Main: 208433152 13:55:59 INFO - PROCESS | 5451 | 13:56:02 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:56:02 INFO - PROCESS | 5451 | RSS: Main: 207618048 13:56:02 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | Cycle 1(1): loaded http://localhost:42318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42318/tests/kraken/driver.html?testName=ai-astar) 13:56:04 INFO - PROCESS | 5451 | RSS: Main: 271777792 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | __start_tp_report 13:56:04 INFO - PROCESS | 5451 | _x_x_mozilla_page_load 13:56:04 INFO - PROCESS | 5451 | _x_x_mozilla_page_load_details 13:56:04 INFO - PROCESS | 5451 | |i|pagename|runs| 13:56:04 INFO - PROCESS | 5451 | |0;ai-astar;110;110;112;113;108;109;105;110;108;109 13:56:04 INFO - PROCESS | 5451 | |1;audio-beat-detection;148;133;156;169;126;156;159;127;183;125 13:56:04 INFO - PROCESS | 5451 | |2;audio-dft;161;160;161;160;160;161;162;161;161;160 13:56:04 INFO - PROCESS | 5451 | |3;audio-fft;76;77;73;177;74;75;76;75;173;75 13:56:04 INFO - PROCESS | 5451 | |4;audio-oscillator;92;91;143;92;92;92;148;93;92;151 13:56:04 INFO - PROCESS | 5451 | |5;imaging-gaussian-blur;116;117;117;116;117;116;116;116;116;117 13:56:04 INFO - PROCESS | 5451 | |6;imaging-darkroom;147;145;145;145;146;145;147;145;146;145 13:56:04 INFO - PROCESS | 5451 | |7;imaging-desaturate;95;94;96;94;94;94;94;94;95;95 13:56:04 INFO - PROCESS | 5451 | |8;json-parse-financial;54;54;54;54;54;55;56;73;53;53 13:56:04 INFO - PROCESS | 5451 | |9;json-stringify-tinderbox;58;59;58;59;59;60;59;59;60;60 13:56:04 INFO - PROCESS | 5451 | |10;stanford-crypto-aes;71;71;73;73;73;72;72;74;72;72 13:56:04 INFO - PROCESS | 5451 | |11;stanford-crypto-ccm;129;123;119;111;114;109;121;113;158;124 13:56:04 INFO - PROCESS | 5451 | |12;stanford-crypto-pbkdf2;159;155;156;152;158;159;157;157;155;156 13:56:04 INFO - PROCESS | 5451 | |13;stanford-crypto-sha256-iterative;65;66;65;72;66;66;64;64;64;62 13:56:04 INFO - PROCESS | 5451 | __end_tp_report 13:56:04 INFO - PROCESS | 5451 | __start_cc_report 13:56:04 INFO - PROCESS | 5451 | _x_x_mozilla_cycle_collect,1568 13:56:04 INFO - PROCESS | 5451 | __end_cc_report 13:56:04 INFO - PROCESS | 5451 | __startTimestamp1464382564588__endTimestamp 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | ------- Summary: start ------- 13:56:04 INFO - PROCESS | 5451 | Number of tests: 14 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.22 (2.0%) stddev-sans-first:2.35 13:56:04 INFO - PROCESS | 5451 | Values: 110.0 110.0 112.0 113.0 108.0 109.0 105.0 110.0 108.0 109.0 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:156.00 stddev:19.98 (12.8%) stddev-sans-first:21.19 13:56:04 INFO - PROCESS | 5451 | Values: 148.0 133.0 156.0 169.0 126.0 156.0 159.0 127.0 183.0 125.0 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 13:56:04 INFO - PROCESS | 5451 | Values: 161.0 160.0 161.0 160.0 160.0 161.0 162.0 161.0 161.0 160.0 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#3] audio-fft Cycles:10 Average:95.10 Median:75.00 stddev:42.14 (56.2%) stddev-sans-first:44.12 13:56:04 INFO - PROCESS | 5451 | Values: 76.0 77.0 73.0 177.0 74.0 75.0 76.0 75.0 173.0 75.0 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:92.00 stddev:26.80 (29.1%) stddev-sans-first:27.74 13:56:04 INFO - PROCESS | 5451 | Values: 92.0 91.0 143.0 92.0 92.0 92.0 148.0 93.0 92.0 151.0 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:56:04 INFO - PROCESS | 5451 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 116.0 116.0 116.0 117.0 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 13:56:04 INFO - PROCESS | 5451 | Values: 147.0 145.0 145.0 145.0 146.0 145.0 147.0 145.0 146.0 145.0 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 13:56:04 INFO - PROCESS | 5451 | Values: 95.0 94.0 96.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:54.00 stddev:6.04 (11.2%) stddev-sans-first:6.36 13:56:04 INFO - PROCESS | 5451 | Values: 54.0 54.0 54.0 54.0 54.0 55.0 56.0 73.0 53.0 53.0 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 13:56:04 INFO - PROCESS | 5451 | Values: 58.0 59.0 58.0 59.0 59.0 60.0 59.0 59.0 60.0 60.0 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.50 stddev:0.95 (1.3%) stddev-sans-first:0.88 13:56:04 INFO - PROCESS | 5451 | Values: 71.0 71.0 73.0 73.0 73.0 72.0 72.0 74.0 72.0 72.0 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:122.00 stddev:14.12 (11.6%) stddev-sans-first:14.76 13:56:04 INFO - PROCESS | 5451 | Values: 129.0 123.0 119.0 111.0 114.0 109.0 121.0 113.0 158.0 124.0 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.40 Median:157.00 stddev:2.12 (1.3%) stddev-sans-first:2.03 13:56:04 INFO - PROCESS | 5451 | Values: 159.0 155.0 156.0 152.0 158.0 159.0 157.0 157.0 155.0 156.0 13:56:04 INFO - PROCESS | 5451 | 13:56:04 INFO - PROCESS | 5451 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:2.63 (4.0%) stddev-sans-first:2.79 13:56:04 INFO - PROCESS | 5451 | Values: 65.0 66.0 65.0 72.0 66.0 66.0 64.0 64.0 64.0 62.0 13:56:04 INFO - PROCESS | 5451 | -------- Summary: end -------- 13:56:04 INFO - PROCESS | 5451 | 13:56:05 INFO - TEST-INFO | 5451: exit 0 13:56:05 INFO - TEST-OK | kraken | took 59553ms 13:56:05 INFO - SUITE-END | took 1170s 13:56:05 INFO - Completed test suite (00:19:30) 13:56:05 INFO - javascript benchmark 13:56:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.2488939988507, 3362.1762668146307, 3368.4610462326027, 3398.8470518826666, 3417.350703366362, 5527.060399732045, 5562.3047119110115, 5572.498475137237, 5602.0, 5605.131204663278, 5532.197831314457, 5601.943980560193, 5604.383517813048, 5605.747741351639, 5653.802116925908, 4785.1147537705465, 5018.247262910565, 5132.923006154911, 5173.663711858717, 5209.1404918188455, 4962.057209130272, 5062.822801201959, 5064.746762661871, 5074.822381216658, 5079.466656001122, 5001.14980453322, 5026.019926114409, 5042.798288068473, 5060.443351231362, 5060.54455099041, 5053.115704751672, 5074.010567939254, 5081.060003899253, 5081.466446023188, 5118.744062796864, 4912.164931961575, 4939.876503087416, 4976.129177393942, 4981.302617633498, 5001.124803159469, 5327.920081198785, 5368.141097424433, 5389.272448219519, 5398.946010539884, 5401.621886467949, 5839.0, 5866.2373891393845, 5867.677277749722, 5868.4718375346, 5869.383714709937, 5921.851953701149, 5933.050711886078, 5974.731137098841, 6027.246594175728, 6030.33666296707, 5515.558755299567, 5549.250851135085, 5561.77752889884, 5563.499285064364, 5568.9443105568835, 5981.641101533922, 6062.2725272966645, 6094.116353128771, 6099.298580663191, 6100.450959413585, 5705.686187259657, 5775.451332123442, 5782.074868021181, 5783.94216057834, 5792.797252096157, 5884.941150588439, 5899.380565040695, 5900.1149827526215, 5900.675462849585, 5901.29184497863, 5748.827535173951, 5860.326062502867, 5868.794592189253, 5882.558808089325, 5892.175095486636, 5838.095095260242, 5866.882662346729, 5877.324107727581, 5880.176775251468, 5909.23179986599, 4484.865454036319, 4488.5960263576435, 4489.483709373399, 4489.955100448954, 4515.029268707178, 4002.0995276063236, 4009.7594144351433, 4017.738846974937, 4028.7582745035393, 4058.553559108496, 5575.0522411190195, 5590.357108932443, 5601.355844077902, 5603.15952607104, 5606.523445507178, 5936.287645482484, 5943.31651860033, 5954.523638108941, 5957.851053723605, 5958.493528050078, 5546.77812887488, 5559.916601250984, 5578.8047418340975, 5615.101583746663, 5709.115087161496, 5065.898682026339, 5101.8724531887, 5107.387113546398, 5112.693238405707, 5114.3095682083185, 6106.328303886569, 6110.725017374229, 6116.785912493041, 6122.908156377658, 6134.9079763803575, 5824.242848429762, 5963.224780778644, 6037.124616930609, 6061.333253342217, 6064.151018857452, 6080.817575472743, 6082.36135205797, 6084.056971169476, 6090.451859332681, 6092.208012958465, 5725.828225153252, 5779.0, 5779.393163717749, 5788.9131663024245, 5789.652620842763, 5964.463198312173, 6004.339522652592, 6013.098035294741, 6035.758569657341, 6062.0, 5722.17028530869, 5767.048437008015, 5770.769169233184, 5771.249737534094, 5771.538276937751, 5628.380878103323, 5695.715214239354, 5750.194972703908, 5771.480566749013, 5820.039693450533, 5755.021646320052, 5800.796972105956, 5808.970955145197, 5816.243888294494, 5861.238039054895, 5876.44173803488, 5888.352281248974, 5913.2608423947, 5914.34942156371, 5918.911216331672, 5549.611527193219, 5705.828825135252, 5793.594448388741, 5798.362180160263, 5802.883942321046], "value": 5465.398851384138, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.0997733105646, 671.1375881991642, 673.2056173715017, 673.7237732529663, 716.8458781362008, 31757.841210793944, 39366.40950385743, 40000.79999599998, 40135.39796903049, 40149.59850401495, 41789.164216715646, 42523.57476425242, 42545.0, 42581.7870910645, 42617.78691106548, 8745.86881196781, 8927.732168034969, 8932.598033088494, 8933.285337173043, 8935.374523783337, 8746.825063498727, 8864.512451815148, 8864.73405797824, 8871.911280887172, 8873.378863479527, 9055.547222638874, 9098.63605455781, 9113.043130471304, 9122.179003889649, 9122.908770912305, 9024.8646270306, 9082.909170908273, 9086.0, 9087.545622718872, 9091.454512729224, 8996.460212387277, 9099.272058235325, 9102.954485227598, 9104.8634270486, 9105.772355691095, 42710.35934460985, 43339.56660433387, 43352.0, 43394.78302608467, 43396.783016085035, 3532.6290739472242, 3733.383991641403, 3754.906127346811, 3755.4179102239195, 3805.2579746949355, 29587.85206073956, 29839.850800746073, 30247.697523024708, 30493.542596861065, 30551.694483055107, 4628.051680405806, 4654.906901861944, 4680.087382960324, 4687.320338550925, 4690.249560070372, 279345.0, 279941.0, 280457.99999999796, 281474.0, 282703.0, 37683.24633507314, 61788.0, 62405.0, 62466.687666562284, 62480.0, 36640.0, 36692.08269793277, 36757.0, 36819.63180368162, 36827.26345473075, 13929.442822287197, 14001.71996560063, 14004.579862604138, 14018.719625607431, 14030.929845350707, 13678.589642310746, 13691.110077844909, 13732.0, 13735.519256825963, 13737.656558585915, 8898.754174415588, 8931.240844528158, 8935.463872167691, 9081.273498120134, 9145.268378529701, 3435.7766745161484, 3538.380783362901, 3545.2732189901008, 3604.9098772530897, 3605.2068544920076, 1044.9007344302279, 1074.387599068539, 1078.6009176604707, 1115.275071203724, 1193.773183095209, 34018.14954626154, 34243.315133697186, 34402.65597344044, 34482.0, 34708.0, 1123.4045955643521, 1150.1259043127284, 1185.3776767197292, 1196.7068068323142, 1277.118788036252, 17678.734818977468, 18065.458036258933, 18160.636787264182, 18201.180946857425, 18218.36235731743, 483708.0, 484388.0, 486743.0, 487040.0, 487453.0, 61448.69275653593, 62367.68816155981, 62449.37550624526, 62481.062784058275, 62524.0, 1410.189141243789, 1474.727175472541, 1487.8437764034836, 1496.5959191018364, 1579.755137953642, 30412.5438118424, 32646.51030234596, 33149.33701326008, 33399.83300083484, 34392.14019649529, 58327.0, 59933.10100348411, 59935.100973486304, 59955.0, 60066.39933600608, 422922.0, 431403.0, 432536.0, 433222.0, 436039.0, 39002.804985974886, 45394.77302613466, 47472.28791568198, 47656.0, 49198.26202606892, 47664.28503572519, 48503.5149648499, 48530.0, 49525.25712114249, 50927.745361274436, 36829.63170368262, 37348.439773402875, 39742.40386394264, 40383.3942490857, 41755.0, 39372.60627393804, 39381.0, 39440.64754495785, 40263.0, 41082.383764242964, 41233.1753364937, 41813.163736725706, 41815.0, 42447.3632895513, 42710.57289427066, 34874.65125348714, 36300.0, 36952.81523592365, 37249.0, 37260.81369593135, 28706.856465717538, 28814.6986332067, 29088.7091129086, 29275.268118297212, 29327.413451731274], "value": 19463.365155174342, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.9022724773302, 425.73817102481985, 429.42457107475974, 431.96112349888546, 442.49997502821805, 18333.816661833393, 18869.71695424568, 18911.905440472794, 19340.61318773624, 20168.294109706163, 12717.745645087092, 12993.675158121028, 14451.554844515544, 20142.194312227493, 20181.0, 5116.309298244736, 5197.974010129944, 5322.787088516474, 5327.0, 5355.758990845402, 5385.057614917393, 5424.864378390533, 5430.809921652743, 5468.808591699291, 5470.617056806025, 5463.071277882749, 5465.316835395575, 5466.207399927008, 5477.917831232535, 5479.068558345071, 5448.727563621803, 5682.090865461506, 5700.686462244575, 5701.0878259478495, 5702.77188912443, 5317.893642127175, 5549.916751248735, 5554.1113421852715, 5558.888822223533, 5576.71735500833, 13950.511732089328, 13984.510542130976, 14208.289585520786, 18876.81123188778, 22312.776872231232, 2576.265764257196, 2656.8405895646324, 2729.56326987683, 2862.169970708492, 3114.1903105192587, 10028.59885604575, 10053.145482633985, 10334.224933130045, 10481.423521706303, 10666.413347265974, 2018.8384929205629, 2043.540203454211, 2109.4726318420394, 2117.2166298469665, 2136.529963408048, 73741.63129184373, 78702.60648696776, 82210.58894705548, 83698.0, 85289.0, 11338.603148889913, 11689.941550292195, 11755.88244117548, 11870.643880683594, 11882.346470944181, 16405.753913691304, 16622.168891555375, 16625.334986600643, 16671.0, 16702.832971670126, 8480.575971201415, 8630.741077767678, 8649.913500865037, 8691.652333906573, 8748.737537873874, 8092.352611791042, 8214.548199848947, 8226.794330141794, 8256.711015114563, 8364.498130112213, 4529.909401811945, 4894.486078961658, 5026.1204289249235, 5103.260027296022, 5116.0, 2022.1304838919111, 2044.2231951858496, 2053.8254248389053, 2101.506146055676, 2103.3689893032333, 974.9658761943298, 993.8260804359353, 1014.523174108168, 1015.7409860485677, 1120.8542889424486, 19002.904985474983, 19450.124744386536, 19598.314059008153, 19925.402237932885, 20138.59722805565, 996.8355221388534, 1014.949252537385, 1039.5538788914873, 1058.5977328615077, 1116.6761639124563, 10571.735706607396, 11051.668449946514, 11103.44482775858, 11170.720731981766, 11180.664580062612, 503377.0, 509760.0, 510659.0, 519028.0, 520938.0, 51110.48889511132, 76099.23900760921, 79076.60461697655, 90877.54561227151, 95208.52395737977, 1055.4353420919924, 1063.2557209953063, 1077.946102694862, 1082.691432941608, 1095.2880627592128, 16432.83567164313, 16875.493735187963, 16933.0, 17329.82670173282, 17624.206910688794, 39015.41476877906, 39442.605573943896, 39816.0, 40113.1977360457, 40402.1919561613, 55245.44754552403, 56222.43777562336, 56437.435625643215, 56580.0, 56911.0, 8821.0, 8824.647014119364, 9035.367524273237, 9054.728358149267, 9067.410618309788, 9403.4828084456, 11727.47226374798, 12530.997520198545, 12763.744725105631, 13117.73764524685, 10569.471526423802, 10760.3543787373, 10937.179711521509, 11027.61403350879, 11028.889711102785, 10868.347899126078, 11047.447627618747, 11134.777304454028, 11168.720781980515, 11259.605913792979, 10523.526441310007, 11043.558257669925, 11096.389698566656, 11205.495752691311, 11968.640940771442, 8555.786105347415, 8609.0, 8909.465432074096, 8970.0, 9042.186203241477, 8174.509529428254, 10954.0, 11005.449727513753, 11052.889471105185, 11498.827517587075], "value": 9128.933424813295, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.4422231107549, 1539.1303913288991, 1552.5963249555116, 1714.7942246930363, 1851.9074046297683, 7469.327760501554, 7564.243575642433, 7607.923920760791, 7612.391008719303, 7614.8857767133395, 8293.751187464371, 8482.91517084829, 8486.0, 8490.193431624002, 8498.6175622097, 2366.2428023032635, 2399.760023997595, 2400.0399840063938, 2401.3036219496325, 2402.3633737059695, 2187.1579441914896, 2246.6630005499223, 2252.5044490212126, 2268.4895898422806, 2269.4893648929024, 2378.583747844129, 2378.940526486834, 2403.2790162951046, 2438.3904023994, 2443.2303824295377, 2357.9882100589557, 2372.2764556810166, 2379.0602711928864, 2383.7377888432256, 2445.8287919845616, 2350.224425939453, 2376.6910301660846, 2383.13015749252, 2383.8212134090013, 2384.6423036544484, 8141.307988820958, 8459.830803383898, 8470.534120623362, 8492.447990880635, 8506.362022848249, 5198.0, 5221.477852214786, 5256.894862102775, 5269.604779641542, 5278.709670968095, 3287.7041066304146, 3335.666433356669, 3378.864845406181, 3380.188754698879, 3418.1967237699123, 1135.3585224348217, 1148.500402324983, 1171.8457319540246, 1178.63462326679, 1186.7626474705094, 11300.660980170607, 11356.545738170464, 11362.545498180145, 11383.430828458544, 11385.0, 4401.581849724335, 4414.646828253732, 4493.820247190141, 4525.027119169395, 4541.72749635023, 9174.724758257264, 9205.309601779893, 9215.493147876798, 9224.7693807654, 9227.123423274777, 5255.500727430888, 5260.079486089995, 5263.894722105613, 5268.051750684914, 5268.525832675077, 4261.552536983634, 4746.121967436035, 4895.926561101586, 4918.458969513351, 4922.483139270396, 3798.7910664913143, 3802.866899658499, 3849.9230015400094, 3875.1862108957434, 3882.650561449483, 1155.0701685143372, 1161.5818305410046, 1162.5291756838494, 1162.7965106106396, 1179.1274456902001, 804.8792681097765, 1043.5147656339839, 1045.5033858917106, 1051.8632577764995, 1076.9983914959164, 5697.487226149667, 5833.358330583633, 6050.45545900871, 6058.848528786727, 6148.077788331697, 485.51691067388174, 509.2844553402475, 516.651260399229, 516.9483051694875, 660.9603423794491, 4239.0, 4351.151525452507, 4357.346398040256, 4367.912641747147, 4370.497392799869, 10385.896141038493, 10864.619738309279, 10908.781824363468, 10950.616728414467, 10984.176186785864, 10736.355818650905, 10788.40663763485, 10793.67618971432, 10820.89179108199, 10831.458427078614, 8084.514929104273, 8196.057453392936, 8226.629801658939, 8249.463784853966, 8327.375446841512, 5970.194023806731, 6099.085137229451, 6113.388661133851, 6165.414285642857, 6241.750329986749, 9353.719388418358, 9401.294902882175, 9429.52852357393, 9521.333506654468, 9655.22758179358, 9425.293103017164, 9729.659461918798, 9734.853977190489, 9739.41563506192, 9885.159761420073, 6803.9659801702655, 7502.399808015237, 7627.618619068913, 7794.4543881929985, 7941.166177551274, 8220.671173153007, 8226.095129535866, 8247.752567422987, 8263.917360826315, 8278.503289802631, 7404.666789994355, 7647.961760191163, 7657.349125324187, 7669.578173200527, 7670.8082297943, 7066.152061752623, 7089.149302083783, 7108.822279443055, 7197.208307086112, 7242.565446073252, 7149.928500715135, 7174.174969878531, 7178.425725941807, 7184.748533801292, 7230.313120253568, 5191.636585439134, 5222.060029194781, 5233.790648374023, 5354.973225133849, 5424.674519528841, 5466.3986961435, 5476.315460567429, 5543.057680194296, 5584.050711379156, 5635.154726791015], "value": 4514.174948466071, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.98285085745704, 356.8768774772702, 360.87549795320615, 363.5128927237501, 363.71266699307546, 6100.877982440348, 6112.69436528174, 6143.047827586725, 6160.106784516242, 6192.690365481731, 6097.634141951486, 6112.6638034908065, 6123.173371594833, 6128.356522565122, 6133.81598552043, 4506.616937560311, 4594.563516465931, 4667.18324293249, 4672.929906051412, 4675.696079754805, 4631.722096674193, 4663.207254766681, 4675.392199014123, 4677.532246775329, 4685.344051832729, 4453.77731113443, 4626.467956185048, 4634.745089020103, 4637.327587499811, 4639.512851150631, 4515.525869783674, 4519.706219095749, 4526.8682829292675, 4613.100445413146, 4626.074785043005, 4049.817758200888, 4057.3102572562734, 4063.3295506241434, 4067.247559201557, 4073.551909289976, 5857.326407463153, 5903.616264942765, 5906.084556893688, 5913.438223368773, 5917.852053698692, 5375.623706340558, 5377.274068000848, 5385.434529374437, 5392.541633961118, 5397.082495975694, 6407.487401007908, 6411.1024456576115, 6419.229692436891, 6424.646644434554, 6425.45383642391, 4340.175366680352, 4442.2892337225885, 4443.511213766483, 4444.6666500012625, 4449.199144154051, 6423.100765892778, 6559.540832141752, 6566.310537393552, 6574.506911981573, 6586.835329116762, 4510.075434535912, 4510.345999830006, 4515.345274935116, 4516.16450956574, 4520.118576877478, 4565.155446242389, 4573.0396616710195, 4577.496475387705, 4577.702449340783, 4583.197940360424, 5285.445028271976, 5287.947120528823, 5291.126964050965, 5291.576673866081, 5309.123994540858, 6246.219222597176, 6383.425491705769, 6387.808365749035, 6399.8080057598345, 6401.103845461639, 1584.128729198936, 1605.8956167849053, 1614.9273282702306, 1620.4490473239155, 1620.9027458352537, 1001.399160503692, 1033.493588141805, 1044.1959691037857, 1070.3898777696638, 1071.1056268016139, 6180.938190618036, 6254.15568898202, 6284.748610055546, 6284.937150628435, 6287.717052732638, 6641.900371494431, 6645.900311495331, 6673.866522669519, 6727.428168605723, 6736.225334086643, 6309.621422714652, 6318.715657795318, 6322.683865806784, 6328.145700330397, 6342.746290148435, 3558.217192217708, 3574.7140228781636, 3585.7489975701974, 3590.8025058621506, 3606.2246616977477, 6794.150731158606, 6918.135233095863, 6935.029095926574, 6949.0, 6970.965145174242, 6770.796876093725, 6790.0493930849725, 6793.72825086991, 6796.694148763318, 6801.843686573295, 6928.272531384233, 6929.133858267716, 6934.687939042755, 6940.548864323803, 6949.5830250184135, 6679.465642748665, 6680.164979377578, 6688.665566721742, 6693.196816382066, 6694.698738556679, 6386.648734319657, 6586.4401525870835, 6590.340965903371, 6600.405963463311, 6604.603723776397, 6902.137232845895, 6928.549644273106, 6939.132608423947, 6944.2708515607155, 6946.340097690711, 4584.656150788771, 4586.174488591952, 4590.196715574828, 4592.0, 4598.080383923296, 6653.866922661617, 6654.0, 6661.367170118831, 6661.46708263328, 6664.3335666434905, 6318.399752023551, 6461.741530338733, 6494.74021039172, 6516.250631177475, 6529.99620174725, 6425.0, 6431.228252609717, 6434.4852411806005, 6485.772997945238, 6489.1888513935755, 6357.23713154406, 6383.808485745435, 6423.068655044899, 6426.325235850169, 6434.099226108442, 6550.050242714875, 6562.507811914221, 6565.080888675494, 6578.605283682994, 6579.276279609335, 6030.095485677183, 6126.5711400203345, 6372.235331760218, 6408.743650253938, 6411.102445657705], "value": 4863.941301440515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [887.2813021452623, 889.2885691446841, 903.9457632542052, 909.6907051602453, 940.5344354544497, 15506.612334691637, 15527.844721552781, 15710.528684139466, 15754.448594299201, 15755.684886302268, 13184.077114601982, 13367.933160334185, 13398.330083495835, 13413.932930335359, 13414.26221557814, 738.4387865222443, 856.4304737349655, 872.293442311728, 883.0727735877335, 888.0764005434373, 873.0134947509306, 875.295387213293, 879.9516026618534, 880.3925291548843, 880.5993273060742, 918.8254231695956, 920.0753242990785, 925.121134921827, 926.0507979321183, 926.4117285523707, 755.5089192025173, 894.4365050018512, 911.3074063711593, 913.9268858491338, 922.299052719931, 676.3507033248088, 676.577139287945, 677.1501765284536, 677.1501765284586, 677.3192941094218, 14218.217998010105, 14224.928875355557, 14234.572962811133, 14252.218472690914, 14287.357068931922, 14707.485238016725, 15444.150571718552, 15812.683746325009, 15873.206339682969, 15913.681726365523, 12400.627981160489, 12401.813972790414, 12416.56542021034, 12554.309512976874, 12728.74542509154, 4678.274867395559, 4737.052589482118, 4742.881427964328, 4755.548222918817, 4938.950610493885, 61118.999999999556, 62024.37975620231, 62112.378876211566, 62145.689271553354, 62571.37428625701, 11719.88280117188, 11734.119941004288, 11760.941195293968, 11872.643820685393, 12197.268163910194, 19768.60462790736, 19776.406707798502, 19789.406317810488, 19802.50493737668, 19814.801851981585, 8436.620352084172, 8485.236328730443, 8539.316854651614, 8624.0, 8695.608697608623, 4931.630127740434, 4971.229459433794, 4987.1771157759285, 4997.85006449807, 4998.525140111684, 3421.1789170599377, 3488.9825550872083, 3566.589842168132, 3568.3576956148145, 3575.4279315309427, 637.1271358239242, 644.2333622988629, 658.2035736758576, 662.3045801907978, 668.2482207516543, 787.3425689549291, 793.9364850811921, 806.899137607799, 806.9717559885376, 817.3052905030795, 9432.52837358143, 9663.27525435595, 9908.603655853829, 10024.649137280307, 10042.096211341015, 620.2742790934617, 663.5521023309246, 680.2279412866334, 774.9496282741604, 787.8069872881066, 4398.252297109499, 4430.379746835446, 4446.510883802844, 4531.3882625845745, 4639.37368455261, 71193.0, 72394.0, 72644.0, 72796.63601681958, 72957.6352118236, 61266.38733612607, 62898.37101629017, 62958.37041629525, 63387.0, 63644.0, 55643.0, 55957.720211398686, 55985.16022259588, 56595.434045659014, 57323.71338143366, 9027.322950778587, 9051.95474022652, 9113.77215569616, 9177.47619404669, 9190.988991210828, 40751.0, 41063.7946810276, 42161.0, 42266.1546769069, 42438.0, 49335.28655923815, 52129.47870521246, 52521.0, 53146.73426632842, 53593.73203133959, 11221.158413118885, 11319.09447244202, 11405.315681059163, 11512.0, 11545.595904143314, 12630.87369126297, 12775.23348599087, 12891.904188144114, 12933.0, 13558.661033474242, 11627.709307267047, 12755.93622031884, 12771.425285861973, 12874.291913944822, 12900.41948112356, 12344.3827808611, 12375.195612285173, 12395.256284622952, 12505.499780008699, 12509.812352814897, 12068.0, 12140.514379424723, 12174.817377739519, 12199.14605977573, 12373.814392784296, 9375.156235938526, 9465.016478647578, 9537.475438850652, 9660.516974151406, 9681.37071090377, 10103.797924041624, 10270.794584108426, 10275.229357798344, 10275.7431064221, 10350.378977261389], "value": 7130.134846620603, "unit": "score"}], "name": "dromaeo_css", "value": 7305.678544475274, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 112.0, 113.0, 108.0, 109.0, 105.0, 110.0, 108.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 133.0, 156.0, 169.0, 126.0, 156.0, 159.0, 127.0, 183.0, 125.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 161.0, 162.0, 161.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 73.0, 177.0, 74.0, 75.0, 76.0, 75.0, 173.0, 75.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 143.0, 92.0, 92.0, 92.0, 148.0, 93.0, 92.0, 151.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 147.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 56.0, 73.0, 53.0, 53.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 59.0, 60.0, 59.0, 59.0, 60.0, 60.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 73.0, 73.0, 73.0, 72.0, 72.0, 74.0, 72.0, 72.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 123.0, 119.0, 111.0, 114.0, 109.0, 121.0, 113.0, 158.0, 124.0], "value": 122.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 156.0, 152.0, 158.0, 159.0, 157.0, 157.0, 155.0, 156.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 72.0, 66.0, 66.0, 64.0, 64.0, 64.0, 62.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1509.8, "alertThreshold": 2.0}]} 13:56:05 INFO - Return code: 0 13:56:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:56:05 ERROR - # TBPL SUCCESS # 13:56:05 INFO - Running post-action listener: _resource_record_post_action 13:56:05 INFO - Running post-run listener: _resource_record_post_run 13:56:06 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 486785024; Read time: 4; Write time: 472740 13:56:06 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233951232; Read time: 0; Write time: 285900 13:56:07 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252833792; Read time: 4; Write time: 186840 13:56:07 INFO - Running post-run listener: _upload_blobber_files 13:56:07 INFO - Blob upload gear active. 13:56:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:56:07 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 13:56:07 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'] 13:56:07 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 13:56:07 INFO - (blobuploader) - INFO - Open directory for files ... 13:56:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:56:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:56:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:56:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:56:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:56:08 INFO - (blobuploader) - INFO - Done attempting. 13:56:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:56:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:56:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:56:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:56:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:56:09 INFO - (blobuploader) - INFO - Done attempting. 13:56:09 INFO - (blobuploader) - INFO - Iteration through files over. 13:56:09 INFO - Return code: 0 13:56:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:56:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:56:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b799101e9da5dd85048647058153576850e0785b4ab4fa1ba9f0237059694024d79596027b19e6e3097cdee5226a617d2af3bf57c59731e03378cdd8623e668", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f32987d6d267a48e0469f3babeeb2960b29421fc6962adccc661feeb4f4fe22e2adebe9366721dfab179bf3c5897a4b39de310322f422ae3aa771f82d049d0a"} 13:56:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:56:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:56:09 INFO - Contents: 13:56:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b799101e9da5dd85048647058153576850e0785b4ab4fa1ba9f0237059694024d79596027b19e6e3097cdee5226a617d2af3bf57c59731e03378cdd8623e668", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f32987d6d267a48e0469f3babeeb2960b29421fc6962adccc661feeb4f4fe22e2adebe9366721dfab179bf3c5897a4b39de310322f422ae3aa771f82d049d0a"} 13:56:09 INFO - Running post-run listener: copy_logs_to_upload_dir 13:56:09 INFO - Copying logs to upload dir... 13:56:09 INFO - mkdir: /builds/slave/test/build/upload/logs 13:56:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.689709 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-27 13:56:09.108828) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 13:56:09.111880) ========= 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=62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802 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/6b799101e9da5dd85048647058153576850e0785b4ab4fa1ba9f0237059694024d79596027b19e6e3097cdee5226a617d2af3bf57c59731e03378cdd8623e668", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f32987d6d267a48e0469f3babeeb2960b29421fc6962adccc661feeb4f4fe22e2adebe9366721dfab179bf3c5897a4b39de310322f422ae3aa771f82d049d0a"} build_url:https://queue.taskcluster.net/v1/task/bH6aSQuWRsahaIdiw2IrtQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/bH6aSQuWRsahaIdiw2IrtQ/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/6b799101e9da5dd85048647058153576850e0785b4ab4fa1ba9f0237059694024d79596027b19e6e3097cdee5226a617d2af3bf57c59731e03378cdd8623e668", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f32987d6d267a48e0469f3babeeb2960b29421fc6962adccc661feeb4f4fe22e2adebe9366721dfab179bf3c5897a4b39de310322f422ae3aa771f82d049d0a"}' ========= master_lag: 0.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 13:56:09.230952) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:56:09.231280) ========= 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=62c568580acbfdaac3eec7be000001dc-1464381338.438247-1721202802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:56:09.316544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 13:56:09.316859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 13:56:09.317158) ========= ========= Total master_lag: 0.28 =========