builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1464431740.2 results: success (0) buildid: 20160525183450 builduid: 63f91898e679451db7d589c242ad058b revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:40.199898) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:40.200301) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:40.200585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:40.217962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:40.218245) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 03:35:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-05-28 03:35:40 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073869 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:40.305528) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:40.305889) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016010 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:40.355210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:35:40.355539) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33693d8bdec17f07fc460ca7cc908ade88f97b86 --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 33693d8bdec17f07fc460ca7cc908ade88f97b86 --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=2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 03:35:40,449 truncating revision to first 12 chars 2016-05-28 03:35:40,449 Setting DEBUG logging. 2016-05-28 03:35:40,449 attempt 1/10 2016-05-28 03:35:40,449 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/33693d8bdec1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 03:35:41,213 unpacking tar archive at: mozilla-aurora-33693d8bdec1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.086341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:35:41.462371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:41.463167) ========= script_repo_revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:41.464095) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:41.464810) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:41.477111) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-28 03:35:41.477418) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:35:41 INFO - MultiFileLogger online at 20160528 03:35:41 in /builds/slave/test 03:35:41 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 03:35:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:35:41 INFO - {'append_to_log': False, 03:35:41 INFO - 'base_work_dir': '/builds/slave/test', 03:35:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:35:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:35:41 INFO - 'branch': 'Mozilla-Aurora', 03:35:41 INFO - 'buildbot_json_path': 'buildprops.json', 03:35:41 INFO - 'config_files': ('talos/linux_config.py',), 03:35:41 INFO - 'default_actions': ('clobber', 03:35:41 INFO - 'read-buildbot-config', 03:35:41 INFO - 'download-and-extract', 03:35:41 INFO - 'populate-webroot', 03:35:41 INFO - 'create-virtualenv', 03:35:41 INFO - 'install', 03:35:41 INFO - 'run-tests'), 03:35:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:35:41 INFO - 'download_minidump_stackwalk': True, 03:35:41 INFO - 'download_symbols': 'ondemand', 03:35:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:35:41 INFO - 'tooltool.py': '/tools/tooltool.py', 03:35:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:35:41 INFO - '/tools/misc-python/virtualenv.py')}, 03:35:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:35:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:35:41 INFO - 'installer_path': 'installer.exe', 03:35:41 INFO - 'log_level': 'info', 03:35:41 INFO - 'log_name': 'talos', 03:35:41 INFO - 'log_to_console': True, 03:35:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:35:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:35:41 INFO - 'opt_config_files': (), 03:35:41 INFO - 'pip_index': False, 03:35:41 INFO - 'sps_profile': False, 03:35:41 INFO - 'sps_profile_interval': 0, 03:35:41 INFO - 'suite': 'dromaeojs', 03:35:41 INFO - 'system_bits': '32', 03:35:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:35:41 INFO - 'title': 'talos-linux64-ix-012', 03:35:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:35:41 INFO - 'use_talos_json': True, 03:35:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:35:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:35:41 INFO - 'work_dir': 'build'} 03:35:41 INFO - ##### 03:35:41 INFO - ##### Running clobber step. 03:35:41 INFO - ##### 03:35:41 INFO - Running pre-action listener: _resource_record_pre_action 03:35:41 INFO - Running main action method: clobber 03:35:41 INFO - rmtree: /builds/slave/test/build 03:35:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:35:42 INFO - Running post-action listener: _resource_record_post_action 03:35:42 INFO - ##### 03:35:42 INFO - ##### Running read-buildbot-config step. 03:35:42 INFO - ##### 03:35:42 INFO - Running pre-action listener: _resource_record_pre_action 03:35:42 INFO - Running main action method: read_buildbot_config 03:35:42 INFO - Using buildbot properties: 03:35:42 INFO - { 03:35:42 INFO - "project": "", 03:35:42 INFO - "product": "firefox", 03:35:42 INFO - "script_repo_revision": "production", 03:35:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:35:42 INFO - "repository": "", 03:35:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:35:42 INFO - "buildid": "20160525183450", 03:35:42 INFO - "pgo_build": "True", 03:35:42 INFO - "basedir": "/builds/slave/test", 03:35:42 INFO - "buildnumber": 525, 03:35:42 INFO - "slavename": "talos-linux64-ix-012", 03:35:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:35:42 INFO - "platform": "ubuntu64_hw", 03:35:42 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:35:42 INFO - "branch": "mozilla-aurora", 03:35:42 INFO - "repo_path": "releases/mozilla-aurora", 03:35:42 INFO - "revision": "33693d8bdec17f07fc460ca7cc908ade88f97b86", 03:35:42 INFO - "stage_platform": "linux64-pgo", 03:35:42 INFO - "builduid": "63f91898e679451db7d589c242ad058b", 03:35:42 INFO - "slavebuilddir": "test" 03:35:42 INFO - } 03:35:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:35:42 INFO - Running post-action listener: _resource_record_post_action 03:35:42 INFO - ##### 03:35:42 INFO - ##### Running download-and-extract step. 03:35:42 INFO - ##### 03:35:42 INFO - Running pre-action listener: _resource_record_pre_action 03:35:42 INFO - Running main action method: download_and_extract 03:35:42 INFO - mkdir: /builds/slave/test/build/tests 03:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:42 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:35:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:35:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:35:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:35:42 INFO - Downloaded 1361 bytes. 03:35:42 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:35:42 INFO - Using the following test package requirements: 03:35:42 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:35:42 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:35:42 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:35:42 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'jsshell-linux-x86_64.zip'], 03:35:42 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:35:42 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:35:42 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:35:42 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:35:42 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:35:42 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:35:42 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:42 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:35:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:35:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:35:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:35:43 INFO - Downloaded 24140640 bytes. 03:35:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:35:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:35:45 INFO - Return code: 0 03:35:45 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 03:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:45 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:35:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:35:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:35:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:35:47 INFO - Downloaded 24140640 bytes. 03:35:47 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'] 03:35:47 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 03:35:48 INFO - Return code: 0 03: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')]} 03:35:48 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:35:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:35:49 INFO - Downloaded 10840145 bytes. 03:35:49 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'] 03:35:49 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 03:35:50 INFO - Return code: 0 03:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:50 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:35:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:35:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:35:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:35:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/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 03:35:52 INFO - Downloaded 62759817 bytes. 03:35:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:35:52 INFO - mkdir: /builds/slave/test/properties 03:35:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:35:52 INFO - Writing to file /builds/slave/test/properties/build_url 03:35:52 INFO - Contents: 03:35:52 INFO - build_url:https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:35:53 INFO - Running post-action listener: _resource_record_post_action 03:35:53 INFO - Running post-action listener: set_extra_try_arguments 03:35:53 INFO - ##### 03:35:53 INFO - ##### Running populate-webroot step. 03:35:53 INFO - ##### 03:35:53 INFO - Running pre-action listener: _resource_record_pre_action 03:35:53 INFO - Running main action method: populate_webroot 03:35:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:35:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:35:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:35:53 INFO - '--tppagecycles', 03:35:53 INFO - '7'], 03:35:53 INFO - 'tests': ['tsvgm']}}, 03:35:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:35:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:35:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:35:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:35:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:35:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:35:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:53 INFO - 'talos_options': ['--disable-e10s'], 03:35:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:53 INFO - 'talos_options': ['--disable-e10s'], 03:35:53 INFO - 'tests': ['damp', 'tps']}, 03:35:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:53 INFO - 'tests': ['damp', 'tps']}, 03:35:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:35:53 INFO - 'tests': ['dromaeo_dom']}, 03:35:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:35:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:35:53 INFO - 'tests': ['a11yr', 03:35:53 INFO - 'ts_paint', 03:35:53 INFO - 'tpaint', 03:35:53 INFO - 'sessionrestore', 03:35:53 INFO - 'sessionrestore_no_auto_restore', 03:35:53 INFO - 'tabpaint']}, 03:35:53 INFO - 'other-e10s': {'tests': ['a11yr', 03:35:53 INFO - 'ts_paint', 03:35:53 INFO - 'tpaint', 03:35:53 INFO - 'sessionrestore', 03:35:53 INFO - 'sessionrestore_no_auto_restore', 03:35:53 INFO - 'tabpaint']}, 03:35:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:35:53 INFO - 'ts_paint', 03:35:53 INFO - 'tpaint', 03:35:53 INFO - 'sessionrestore', 03:35:53 INFO - 'sessionrestore_no_auto_restore', 03:35:53 INFO - 'tabpaint']}, 03:35:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:35:53 INFO - 'ts_paint', 03:35:53 INFO - 'tpaint', 03:35:53 INFO - 'sessionrestore', 03:35:53 INFO - 'sessionrestore_no_auto_restore', 03:35:53 INFO - 'tabpaint']}, 03:35:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:35:53 INFO - 'tests': ['a11yr', 03:35:53 INFO - 'ts_paint', 03:35:53 INFO - 'tpaint', 03:35:53 INFO - 'sessionrestore', 03:35:53 INFO - 'sessionrestore_no_auto_restore', 03:35:53 INFO - 'tabpaint']}, 03:35:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:35:53 INFO - 'tests': ['a11yr', 03:35:53 INFO - 'ts_paint', 03:35:53 INFO - 'tpaint', 03:35:53 INFO - 'sessionrestore', 03:35:53 INFO - 'sessionrestore_no_auto_restore', 03:35:53 INFO - 'tabpaint']}, 03:35:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:35:53 INFO - 'tests': ['tsvgx', 03:35:53 INFO - 'tsvgr_opacity', 03:35:53 INFO - 'tart', 03:35:53 INFO - 'tscrollx', 03:35:53 INFO - 'cart']}, 03:35:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:35:53 INFO - 'tsvgr_opacity', 03:35:53 INFO - 'tart', 03:35:53 INFO - 'tscrollx', 03:35:53 INFO - 'cart']}, 03:35:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:53 INFO - 'talos_options': ['--disable-e10s'], 03:35:53 INFO - 'tests': ['tp5o']}, 03:35:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:53 INFO - 'tests': ['tp5o']}, 03:35:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:53 INFO - 'talos_options': ['--disable-e10s', 03:35:53 INFO - '--xperf_path', 03:35:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:53 INFO - 'tests': ['tp5n']}, 03:35:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:53 INFO - 'talos_options': ['--xperf_path', 03:35:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:53 INFO - 'tests': ['tp5n']}}, 03:35:53 INFO - 'talos.zip': {'path': '', 03:35:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:35:53 INFO - Running post-action listener: _resource_record_post_action 03:35:53 INFO - ##### 03:35:53 INFO - ##### Running create-virtualenv step. 03:35:53 INFO - ##### 03:35:53 INFO - Running pre-action listener: _resource_record_pre_action 03:35:53 INFO - Running main action method: create_virtualenv 03:35:53 INFO - Creating virtualenv /builds/slave/test/build/venv 03:35:53 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 03:35:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:35:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:35:53 INFO - Using real prefix '/usr' 03:35:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:35:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:35:55 INFO - Installing pip.................done. 03:35:55 INFO - Return code: 0 03:35:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:35:55 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')]} 03:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:55 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')]} 03:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:55 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 0x7fc0bee11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198b640>, '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 0x198c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198c9d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', '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 03:35:55 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 03:35:55 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 03:35:55 INFO - Using env: {'DISPLAY': ':0', 03:35:55 INFO - 'HOME': '/home/cltbld', 03:35:55 INFO - 'LANG': 'en_US.UTF-8', 03:35:55 INFO - 'LANGUAGE': 'en_US:en', 03:35:55 INFO - 'LOGNAME': 'cltbld', 03:35:55 INFO - 'MAIL': '/var/mail/cltbld', 03:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:55 INFO - 'MOZ_NO_REMOTE': '1', 03:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:55 INFO - 'NO_EM_RESTART': '1', 03:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:55 INFO - 'PWD': '/builds/slave/test', 03:35:55 INFO - 'SHELL': '/bin/bash', 03:35:55 INFO - 'SHLVL': '1', 03:35:55 INFO - 'TERM': 'linux', 03:35:55 INFO - 'TMOUT': '86400', 03:35:55 INFO - 'USER': 'cltbld', 03:35:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', 03:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:55 INFO - '_': '/tools/buildbot/bin/python'} 03:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:55 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 03:35:55 INFO - Cleaning up... 03:35:56 INFO - Return code: 0 03:35:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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 0x7fc0bee11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198b640>, '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 0x198c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198c9d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', '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 03: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 03: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 03:35:56 INFO - Using env: {'DISPLAY': ':0', 03:35:56 INFO - 'HOME': '/home/cltbld', 03:35:56 INFO - 'LANG': 'en_US.UTF-8', 03:35:56 INFO - 'LANGUAGE': 'en_US:en', 03:35:56 INFO - 'LOGNAME': 'cltbld', 03:35:56 INFO - 'MAIL': '/var/mail/cltbld', 03:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:56 INFO - 'MOZ_NO_REMOTE': '1', 03:35:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:56 INFO - 'NO_EM_RESTART': '1', 03:35:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:56 INFO - 'PWD': '/builds/slave/test', 03:35:56 INFO - 'SHELL': '/bin/bash', 03:35:56 INFO - 'SHLVL': '1', 03:35:56 INFO - 'TERM': 'linux', 03:35:56 INFO - 'TMOUT': '86400', 03:35:56 INFO - 'USER': 'cltbld', 03:35:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', 03:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:56 INFO - '_': '/tools/buildbot/bin/python'} 03:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:56 INFO - Downloading/unpacking psutil>=0.7.1 03:35:56 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 03:35:56 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 03:35:56 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 03:35:56 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 03:35:56 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 03:35:56 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 03:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:35:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:35:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:35:58 INFO - Installing collected packages: psutil 03:35:58 INFO - Running setup.py install for psutil 03:35:58 INFO - building 'psutil._psutil_linux' extension 03:35:58 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 03:35:58 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 03:35:58 INFO - building 'psutil._psutil_posix' extension 03:35:58 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 03:35:58 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 03:35:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:35:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:35:58 INFO - Successfully installed psutil 03:35:58 INFO - Cleaning up... 03:35:58 INFO - Return code: 0 03:35:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:58 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 0x7fc0bee11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198b640>, '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 0x198c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198c9d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', '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 03:35:58 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 03:35:58 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 03:35:58 INFO - Using env: {'DISPLAY': ':0', 03:35:58 INFO - 'HOME': '/home/cltbld', 03:35:58 INFO - 'LANG': 'en_US.UTF-8', 03:35:58 INFO - 'LANGUAGE': 'en_US:en', 03:35:58 INFO - 'LOGNAME': 'cltbld', 03:35:58 INFO - 'MAIL': '/var/mail/cltbld', 03:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:58 INFO - 'MOZ_NO_REMOTE': '1', 03:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:58 INFO - 'NO_EM_RESTART': '1', 03:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:58 INFO - 'PWD': '/builds/slave/test', 03:35:58 INFO - 'SHELL': '/bin/bash', 03:35:58 INFO - 'SHLVL': '1', 03:35:58 INFO - 'TERM': 'linux', 03:35:58 INFO - 'TMOUT': '86400', 03:35:58 INFO - 'USER': 'cltbld', 03:35:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', 03:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:58 INFO - '_': '/tools/buildbot/bin/python'} 03:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:35:58 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 03:35:58 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 03:35:58 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 03:35:58 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 03:35:58 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 03:35:58 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 03:36:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:36:00 INFO - Installing collected packages: mozsystemmonitor 03:36:00 INFO - Running setup.py install for mozsystemmonitor 03:36:00 INFO - Successfully installed mozsystemmonitor 03:36:00 INFO - Cleaning up... 03:36:01 INFO - Return code: 0 03:36:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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 0x7fc0bee11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198b640>, '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 0x198c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198c9d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', '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 03: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 03: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 03:36:01 INFO - Using env: {'DISPLAY': ':0', 03:36:01 INFO - 'HOME': '/home/cltbld', 03:36:01 INFO - 'LANG': 'en_US.UTF-8', 03:36:01 INFO - 'LANGUAGE': 'en_US:en', 03:36:01 INFO - 'LOGNAME': 'cltbld', 03:36:01 INFO - 'MAIL': '/var/mail/cltbld', 03:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:01 INFO - 'MOZ_NO_REMOTE': '1', 03:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:01 INFO - 'NO_EM_RESTART': '1', 03:36:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:01 INFO - 'PWD': '/builds/slave/test', 03:36:01 INFO - 'SHELL': '/bin/bash', 03:36:01 INFO - 'SHLVL': '1', 03:36:01 INFO - 'TERM': 'linux', 03:36:01 INFO - 'TMOUT': '86400', 03:36:01 INFO - 'USER': 'cltbld', 03:36:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', 03:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:01 INFO - '_': '/tools/buildbot/bin/python'} 03:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:36:01 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 03:36:01 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 03:36:01 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 03:36:01 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 03:36:01 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 03:36:01 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 03:36:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:36:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:36:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:03 INFO - Downloading docopt-0.6.1.tar.gz 03:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:36:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:36:04 INFO - Running setup.py install for blobuploader 03:36:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:36:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:36:04 INFO - Running setup.py install for requests 03:36:04 INFO - Running setup.py install for docopt 03:36:04 INFO - Successfully installed blobuploader requests docopt 03:36:04 INFO - Cleaning up... 03:36:04 INFO - Return code: 0 03:36:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:04 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 0x7fc0bee11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198b640>, '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 0x198c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198c9d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', '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 03:36:04 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 03:36:04 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 03:36:04 INFO - Using env: {'DISPLAY': ':0', 03:36:04 INFO - 'HOME': '/home/cltbld', 03:36:04 INFO - 'LANG': 'en_US.UTF-8', 03:36:04 INFO - 'LANGUAGE': 'en_US:en', 03:36:04 INFO - 'LOGNAME': 'cltbld', 03:36:04 INFO - 'MAIL': '/var/mail/cltbld', 03:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:04 INFO - 'MOZ_NO_REMOTE': '1', 03:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:04 INFO - 'NO_EM_RESTART': '1', 03:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:04 INFO - 'PWD': '/builds/slave/test', 03:36:04 INFO - 'SHELL': '/bin/bash', 03:36:04 INFO - 'SHLVL': '1', 03:36:04 INFO - 'TERM': 'linux', 03:36:04 INFO - 'TMOUT': '86400', 03:36:04 INFO - 'USER': 'cltbld', 03:36:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', 03:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:04 INFO - '_': '/tools/buildbot/bin/python'} 03:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:04 INFO - Running setup.py (path:/tmp/pip-en6tgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:04 INFO - Running setup.py (path:/tmp/pip-WhLymq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:04 INFO - Running setup.py (path:/tmp/pip-qZKRz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:05 INFO - Running setup.py (path:/tmp/pip-ZWNPUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:05 INFO - Running setup.py (path:/tmp/pip-eYh2_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:05 INFO - Running setup.py (path:/tmp/pip-y43fEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:05 INFO - Running setup.py (path:/tmp/pip-F5UTVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:05 INFO - Running setup.py (path:/tmp/pip-1F5erT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:05 INFO - Running setup.py (path:/tmp/pip-aW2FJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:05 INFO - Running setup.py (path:/tmp/pip-Sk5p_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:05 INFO - Running setup.py (path:/tmp/pip-tUIGkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:05 INFO - Running setup.py (path:/tmp/pip-Xm62OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:05 INFO - Running setup.py (path:/tmp/pip-uyk1eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:05 INFO - Running setup.py (path:/tmp/pip-jDlHPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:05 INFO - Running setup.py (path:/tmp/pip-A4SYWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:05 INFO - Running setup.py (path:/tmp/pip-LA3c8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:05 INFO - Running setup.py (path:/tmp/pip-5NYtGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:36:06 INFO - Running setup.py install for manifestparser 03:36:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:36:06 INFO - Running setup.py install for mozcrash 03:36:06 INFO - Running setup.py install for mozdebug 03:36:06 INFO - Running setup.py install for mozdevice 03:36:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:36:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:36:06 INFO - Running setup.py install for mozfile 03:36:06 INFO - Running setup.py install for mozhttpd 03:36:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:36:06 INFO - Running setup.py install for mozinfo 03:36:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:36:06 INFO - Running setup.py install for mozInstall 03:36:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:36:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:36:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:36:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:36:06 INFO - Running setup.py install for mozleak 03:36:06 INFO - Running setup.py install for mozlog 03:36:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:36:07 INFO - Running setup.py install for moznetwork 03:36:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:36:07 INFO - Running setup.py install for mozprocess 03:36:07 INFO - Running setup.py install for mozprofile 03:36:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:36:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:36:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:36:07 INFO - Running setup.py install for mozrunner 03:36:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:36:07 INFO - Running setup.py install for mozscreenshot 03:36:07 INFO - Running setup.py install for moztest 03:36:07 INFO - Running setup.py install for mozversion 03:36:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:36:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:36:07 INFO - Cleaning up... 03:36:07 INFO - Return code: 0 03:36:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:07 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 0x7fc0bee11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198b640>, '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 0x198c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198c9d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', '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 03:36:07 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 03:36:07 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 03:36:07 INFO - Using env: {'DISPLAY': ':0', 03:36:07 INFO - 'HOME': '/home/cltbld', 03:36:07 INFO - 'LANG': 'en_US.UTF-8', 03:36:07 INFO - 'LANGUAGE': 'en_US:en', 03:36:07 INFO - 'LOGNAME': 'cltbld', 03:36:07 INFO - 'MAIL': '/var/mail/cltbld', 03:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:07 INFO - 'MOZ_NO_REMOTE': '1', 03:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:07 INFO - 'NO_EM_RESTART': '1', 03:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:07 INFO - 'PWD': '/builds/slave/test', 03:36:07 INFO - 'SHELL': '/bin/bash', 03:36:07 INFO - 'SHLVL': '1', 03:36:07 INFO - 'TERM': 'linux', 03:36:07 INFO - 'TMOUT': '86400', 03:36:07 INFO - 'USER': 'cltbld', 03:36:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', 03:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:07 INFO - '_': '/tools/buildbot/bin/python'} 03:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:08 INFO - Running setup.py (path:/tmp/pip-JqjBVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03: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)) 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:08 INFO - Running setup.py (path:/tmp/pip-UvhDSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03: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)) 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:08 INFO - Running setup.py (path:/tmp/pip-7VeR2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:08 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)) 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:08 INFO - Running setup.py (path:/tmp/pip-TmNysW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:08 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)) 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:08 INFO - Running setup.py (path:/tmp/pip-oT5kDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:08 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)) 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:08 INFO - Running setup.py (path:/tmp/pip-_hZ7cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:08 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)) 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:08 INFO - Running setup.py (path:/tmp/pip-FNeonE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:08 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)) 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:08 INFO - Running setup.py (path:/tmp/pip-ROd_Jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:08 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)) 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:08 INFO - Running setup.py (path:/tmp/pip-5Um9oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:08 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)) 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:08 INFO - Running setup.py (path:/tmp/pip-vHj7x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:08 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)) 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:08 INFO - Running setup.py (path:/tmp/pip-_FHcOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:08 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)) 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:08 INFO - Running setup.py (path:/tmp/pip-fprMhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:08 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)) 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:08 INFO - Running setup.py (path:/tmp/pip-cTiJ5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:08 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)) 03:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:08 INFO - Running setup.py (path:/tmp/pip-zwPs0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03: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)) 03:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:09 INFO - Running setup.py (path:/tmp/pip-VPOiYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03: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)) 03:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:09 INFO - Running setup.py (path:/tmp/pip-Su08Yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03: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)) 03:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:09 INFO - Running setup.py (path:/tmp/pip-dkN99V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:09 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)) 03:36:09 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)) 03:36:09 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)) 03:36:09 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)) 03:36:09 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)) 03:36:09 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)) 03:36:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:11 INFO - Downloading blessings-1.6.tar.gz 03:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:36:11 INFO - Installing collected packages: blessings 03:36:11 INFO - Running setup.py install for blessings 03:36:11 INFO - Successfully installed blessings 03:36:11 INFO - Cleaning up... 03:36:11 INFO - Return code: 0 03:36:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:36:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:11 INFO - Reading from file tmpfile_stdout 03:36:11 INFO - Current package versions: 03:36:11 INFO - argparse == 1.2.1 03:36:11 INFO - blessings == 1.6 03:36:11 INFO - blobuploader == 1.2.4 03:36:11 INFO - docopt == 0.6.1 03:36:11 INFO - manifestparser == 1.1 03:36:11 INFO - mozInstall == 1.12 03:36:11 INFO - mozcrash == 0.17 03:36:11 INFO - mozdebug == 0.1 03:36:11 INFO - mozdevice == 0.48 03:36:11 INFO - mozfile == 1.2 03:36:11 INFO - mozhttpd == 0.7 03:36:11 INFO - mozinfo == 0.9 03:36:11 INFO - mozleak == 0.1 03:36:11 INFO - mozlog == 3.1 03:36:11 INFO - moznetwork == 0.27 03:36:11 INFO - mozprocess == 0.22 03:36:11 INFO - mozprofile == 0.28 03:36:11 INFO - mozrunner == 6.11 03:36:11 INFO - mozscreenshot == 0.1 03:36:11 INFO - mozsystemmonitor == 0.0 03:36:11 INFO - moztest == 0.7 03:36:11 INFO - mozversion == 1.4 03:36:11 INFO - psutil == 3.1.1 03:36:11 INFO - requests == 1.2.3 03:36:11 INFO - wsgiref == 0.1.2 03:36:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:11 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 0x7fc0bee11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198b640>, '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 0x198c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198c9d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', '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 03:36:11 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 03:36:11 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 03:36:11 INFO - Using env: {'DISPLAY': ':0', 03:36:11 INFO - 'HOME': '/home/cltbld', 03:36:11 INFO - 'LANG': 'en_US.UTF-8', 03:36:11 INFO - 'LANGUAGE': 'en_US:en', 03:36:11 INFO - 'LOGNAME': 'cltbld', 03:36:11 INFO - 'MAIL': '/var/mail/cltbld', 03:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:11 INFO - 'MOZ_NO_REMOTE': '1', 03:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:11 INFO - 'NO_EM_RESTART': '1', 03:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:11 INFO - 'PWD': '/builds/slave/test', 03:36:11 INFO - 'SHELL': '/bin/bash', 03:36:11 INFO - 'SHLVL': '1', 03:36:11 INFO - 'TERM': 'linux', 03:36:11 INFO - 'TMOUT': '86400', 03:36:11 INFO - 'USER': 'cltbld', 03:36:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', 03:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:11 INFO - '_': '/tools/buildbot/bin/python'} 03:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:11 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)) 03:36:11 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)) 03:36:11 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)) 03:36:11 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)) 03:36:11 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)) 03:36:11 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)) 03:36:11 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)) 03:36:11 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)) 03:36:11 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)) 03:36:11 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)) 03:36:11 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)) 03:36:11 INFO - Cleaning up... 03:36:11 INFO - Return code: 0 03:36:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:11 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 0x7fc0bee11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198b640>, '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 0x198c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198c9d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', '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 03:36:11 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 03:36:11 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 03:36:11 INFO - Using env: {'DISPLAY': ':0', 03:36:11 INFO - 'HOME': '/home/cltbld', 03:36:11 INFO - 'LANG': 'en_US.UTF-8', 03:36:11 INFO - 'LANGUAGE': 'en_US:en', 03:36:11 INFO - 'LOGNAME': 'cltbld', 03:36:11 INFO - 'MAIL': '/var/mail/cltbld', 03:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:11 INFO - 'MOZ_NO_REMOTE': '1', 03:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:11 INFO - 'NO_EM_RESTART': '1', 03:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:11 INFO - 'PWD': '/builds/slave/test', 03:36:11 INFO - 'SHELL': '/bin/bash', 03:36:11 INFO - 'SHLVL': '1', 03:36:11 INFO - 'TERM': 'linux', 03:36:11 INFO - 'TMOUT': '86400', 03:36:11 INFO - 'USER': 'cltbld', 03:36:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', 03:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:11 INFO - '_': '/tools/buildbot/bin/python'} 03:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:12 INFO - Downloading/unpacking jsonschema 03: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 03: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 03: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 03: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 03: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 03: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 03:36:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:36:13 INFO - Downloading/unpacking functools32 (from jsonschema) 03:36:13 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 03:36:13 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 03:36:13 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 03:36:13 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 03:36:13 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 03:36:13 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 03:36:14 INFO - Downloading functools32-3.2.3-2.tar.gz 03:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:36:14 INFO - warning: no files found matching '*.txt' 03:36:14 INFO - no previously-included directories found matching 'build' 03:36:14 INFO - no previously-included directories found matching 'dist' 03:36:14 INFO - no previously-included directories found matching '.git*' 03:36:14 INFO - Installing collected packages: jsonschema, functools32 03:36:14 INFO - Running setup.py install for functools32 03:36:14 INFO - warning: no files found matching '*.txt' 03:36:14 INFO - no previously-included directories found matching 'build' 03:36:14 INFO - no previously-included directories found matching 'dist' 03:36:14 INFO - no previously-included directories found matching '.git*' 03:36:14 INFO - Successfully installed jsonschema functools32 03:36:14 INFO - Cleaning up... 03:36:14 INFO - Return code: 0 03:36:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:14 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 0x7fc0bee11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198b640>, '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 0x198c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198c9d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', '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 03:36:14 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 03:36:14 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 03:36:14 INFO - Using env: {'DISPLAY': ':0', 03:36:14 INFO - 'HOME': '/home/cltbld', 03:36:14 INFO - 'LANG': 'en_US.UTF-8', 03:36:14 INFO - 'LANGUAGE': 'en_US:en', 03:36:14 INFO - 'LOGNAME': 'cltbld', 03:36:14 INFO - 'MAIL': '/var/mail/cltbld', 03:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:14 INFO - 'MOZ_NO_REMOTE': '1', 03:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:14 INFO - 'NO_EM_RESTART': '1', 03:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:14 INFO - 'PWD': '/builds/slave/test', 03:36:14 INFO - 'SHELL': '/bin/bash', 03:36:14 INFO - 'SHLVL': '1', 03:36:14 INFO - 'TERM': 'linux', 03:36:14 INFO - 'TMOUT': '86400', 03:36:14 INFO - 'USER': 'cltbld', 03:36:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', 03:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:14 INFO - '_': '/tools/buildbot/bin/python'} 03:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:14 INFO - Downloading/unpacking flake8 03: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 03: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 03: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 03: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 03: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 03: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 03:36:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:36:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:36:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:36:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:36:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:36:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:36:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:36:17 INFO - no previously-included directories found matching 'docs/_build' 03:36:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:36:17 INFO - Running setup.py install for pep8 03:36:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:36:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:36:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:36:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:36:17 INFO - no previously-included directories found matching 'docs/_build' 03:36:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:36:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:36:17 INFO - Cleaning up... 03:36:17 INFO - Return code: 0 03:36:17 INFO - Running post-action listener: _resource_record_post_action 03:36:17 INFO - Running post-action listener: _start_resource_monitoring 03:36:17 INFO - Starting resource monitoring. 03:36:17 INFO - ##### 03:36:17 INFO - ##### Running install step. 03:36:17 INFO - ##### 03:36:17 INFO - Running pre-action listener: _resource_record_pre_action 03:36:17 INFO - Running main action method: install 03:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:17 INFO - Reading from file tmpfile_stdout 03:36:17 INFO - Detecting whether we're running mozinstall >=1.0... 03:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:36:17 INFO - Reading from file tmpfile_stdout 03:36:17 INFO - Output received: 03:36:17 INFO - Usage: mozinstall [options] installer 03:36:17 INFO - Options: 03:36:17 INFO - -h, --help show this help message and exit 03:36:17 INFO - -d DEST, --destination=DEST 03:36:17 INFO - Directory to install application into. [default: 03:36:17 INFO - "/builds/slave/test"] 03:36:17 INFO - --app=APP Application being installed. [default: firefox] 03:36:17 INFO - mkdir: /builds/slave/test/build/application 03:36:17 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'] 03:36:17 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 03:36:33 INFO - Reading from file tmpfile_stdout 03:36:33 INFO - Output received: 03:36:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:36:33 INFO - Running post-action listener: _resource_record_post_action 03:36:33 INFO - ##### 03:36:33 INFO - ##### Running run-tests step. 03:36:33 INFO - ##### 03:36:33 INFO - Running pre-action listener: _resource_record_pre_action 03:36:33 INFO - Running main action method: run_tests 03:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:36:33 INFO - Python 2.7.3 03:36:33 INFO - Return code: 0 03:36:33 INFO - grabbing minidump binary from tooltool 03:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:33 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 0x198b640>, '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 0x198c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x198c9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:36:33 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 03:36:33 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 03:36:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:36:33 INFO - Return code: 0 03:36:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:36:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:36:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:36:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:36:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:36:34 INFO - Return code: 0 03:36:34 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/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 03:36:34 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/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 03:36:34 INFO - Using env: {'DISPLAY': ':0', 03:36:34 INFO - 'HOME': '/home/cltbld', 03:36:34 INFO - 'LANG': 'en_US.UTF-8', 03:36:34 INFO - 'LANGUAGE': 'en_US:en', 03:36:34 INFO - 'LOGNAME': 'cltbld', 03:36:34 INFO - 'MAIL': '/var/mail/cltbld', 03:36:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:36:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:34 INFO - 'MOZ_NO_REMOTE': '1', 03:36:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:34 INFO - 'NO_EM_RESTART': '1', 03:36:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:34 INFO - 'PWD': '/builds/slave/test', 03:36:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:36:34 INFO - 'SHELL': '/bin/bash', 03:36:34 INFO - 'SHLVL': '1', 03:36:34 INFO - 'TERM': 'linux', 03:36:34 INFO - 'TMOUT': '86400', 03:36:34 INFO - 'USER': 'cltbld', 03:36:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491', 03:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:34 INFO - '_': '/tools/buildbot/bin/python'} 03:36:34 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/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 03:36:34 INFO - mozversion application_buildid: 20160525183450 03:36:34 INFO - mozversion application_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:36:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:36:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:36:34 INFO - mozversion application_name: Firefox 03:36:34 INFO - mozversion application_remotingname: firefox-dev 03:36:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:36:34 INFO - mozversion application_vendor: Mozilla 03:36:34 INFO - mozversion application_version: 48.0a2 03:36:34 INFO - mozversion platform_buildid: 20160525183450 03:36:34 INFO - mozversion platform_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:36:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:36:34 INFO - mozversion platform_version: 48.0a2 03:36:34 INFO - using testdate: 1464431794 03:36:34 INFO - actual date: 1464431794 03:36:34 INFO - starting webserver on 'localhost:49727' 03:36:34 INFO - SUITE-START | Running 2 tests 03:36:34 INFO - TEST-START | dromaeo_css 03:36:34 INFO - operating with platform_type : linux_ 03:36:34 INFO - Initialising browser for dromaeo_css test... 03:36:34 INFO - TEST-INFO | started process 11509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8tUDo8/profile http://localhost:49727/getInfo.html) 03:36:37 INFO - PROCESS | 11509 | __metrics Screen width/height:1600/1200 03:36:37 INFO - PROCESS | 11509 | colorDepth:24 03:36:37 INFO - PROCESS | 11509 | Browser inner width/height: 1024/697 03:36:37 INFO - PROCESS | 11509 | __metrics 03:36:38 ERROR - PROCESS | 11509 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:36:39 INFO - TEST-INFO | 11509: exit 0 03:36:39 INFO - Browser initialized. 03:36:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:36:39 INFO - TEST-INFO | started process 11605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8tUDo8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:51 INFO - PROCESS | 11605 | RSS: Main: 141742080 03:36:51 INFO - PROCESS | 11605 | 03:37:42 INFO - PROCESS | 11605 | 1464431862152 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] 03:39:49 INFO - PROCESS | 11605 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49727/tests/dromaeo/cssquery-ext.html) 03:39:50 INFO - PROCESS | 11605 | RSS: Main: 252932096 03:39:50 INFO - PROCESS | 11605 | 03:42:52 INFO - PROCESS | 11605 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-ext.html (next: http://localhost:49727/tests/dromaeo/cssquery-jquery.html) 03:42:53 INFO - PROCESS | 11605 | RSS: Main: 223711232 03:42:53 INFO - PROCESS | 11605 | 03:45:55 INFO - PROCESS | 11605 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49727/tests/dromaeo/cssquery-mootools.html) 03:45:55 INFO - PROCESS | 11605 | RSS: Main: 219869184 03:45:55 INFO - PROCESS | 11605 | 03:48:57 INFO - PROCESS | 11605 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49727/tests/dromaeo/cssquery-prototype.html) 03:48:58 INFO - PROCESS | 11605 | RSS: Main: 215126016 03:48:58 INFO - PROCESS | 11605 | 03:52:00 INFO - PROCESS | 11605 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49727/tests/dromaeo/cssquery-yui.html) 03:52:01 INFO - PROCESS | 11605 | RSS: Main: 187637760 03:52:01 INFO - PROCESS | 11605 | 03:55:03 INFO - PROCESS | 11605 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-yui.html (next: http://localhost:49727/tests/dromaeo/cssquery-dojo.html) 03:55:04 INFO - PROCESS | 11605 | RSS: Main: 245809152 03:55:04 INFO - PROCESS | 11605 | 03:55:04 INFO - PROCESS | 11605 | __start_tp_report 03:55:04 INFO - PROCESS | 11605 | _x_x_mozilla_page_load 03:55:04 INFO - PROCESS | 11605 | _x_x_mozilla_page_load_details 03:55:04 INFO - PROCESS | 11605 | |i|pagename|runs| 03:55:04 INFO - PROCESS | 11605 | |0;dojo.html;3323.484859846724;3362.562866827312;3365.2259980204553;3389.2204792897646;3407.2333724911896;5523.751431185597;5526.281583394159;5536.889262214753;5546.556275497961;5551;5510.173473978905;5515.172724091388;5552.555795536357;5555.611107222496;5593.356763972144;5020.548150666457;5042.84871453857;5107.208382700687;5175.741212939338;5179.482051794828;5062.190049592066;5158.174692049273;5162.483751624845;5163.793448262084;5165.940982098661;5056.241563765428;5102.489751024887;5117.130087885069;5138.2806407103035;5152.330197074375;5201.973990130044;5206.76569554371;5241.344831896013;5243.947560524384;5259.368875734898;4999.950000500021;5029.069622119883;5099.617528685363;5115.514026167508;5129.333186685744;5503.944960550383;5560.582956278296;5565.053940830068;5577.414371490976;5581.6930068846195;5925.111233314994;5928.644281343133;5931.139984702194;5931.940680593182;5937.8812423751715;5974.163617093611;5978.163057172;6047.909281360783;6061.782789435708;6075.665838378887;5590.18942253371;5637.013522633563;5640.294963129609;5642.181883626851;5658.151277308396;6010.819675409744;6140.846478838065;6141.881051037385;6142.293636231801;6145.293291271471;5934.080217566284;5961.910571341434;5967.940320596826;5972.8805423892145;5979.730912108878;5964.671943043088;5967.1347654589845;5967.224260846149;5974.701264936736;5975;5754.223179870663;5842.795502157404;5938.257717785277;5941.55438342126;5951.196588460502;5974.40255974399;5985.610935289193;5986.790462333797;5999.1901093351835;6021.6989150542295;4538.228501154812;4539.228331183706;4544.136614043321;4545.38637283969;4570.65720070996;3975.3043217436834;4058.5332686740812;4074.5517993020744;4099.385092236188;4108.301588729923;5686.715664216773;5705.229793977843;5721.742521586539;5722.399148089391;5733.140028995684;6013.609115407485;6057.636541807506;6068.696565171724;6070.453659170696;6072.635641861502;5585.357683866326;5684.118961560965;5698.914516282259;5773.5958482906635;5783.94216057834;5179.19722443022;5199.11615025439;5203.245529398216;5203.60972927032;5208;6254.437100660963;6259.4679452246155;6272.8118156455375;6274.749010039639;6277.027060805583;5855.151003104526;6010.459058684739;6089.786857459968;6092.421219984094;6137.539684523589;6205.572718274912;6254.718537665907;6256.280527739368;6258;6272.059191121369;5835.153902684002;5942.64344139353;5948.078047902582;5952.8809423812145;5991.610545314541;6063.484603808725;6078.969605151946;6081.969590152021;6105.114758360101;6112.327643959072;5812.680302583399;5850.590458668023;5859.94140058594;5861;5876.882462350643;5718.170865224436;5777.971110144591;5821.970890145522;5841;5890.558208134493;5834.241548598655;5857.414258574108;5862.589618726648;5864.413558644272;5896.557758168069;5950.9702451487465;5959.28488581373;5962.672053036951;5963.821085367446;5970.462658360769;5727.4845263926445;5784.479396854304;5819.5053420459735;5841.9707901461925;5867.383924687846 03:55:04 INFO - PROCESS | 11605 | |1;ext.html;666.9199696036474;670.9563878347907;675.6992788881402;679.9592024478532;740.156221907026;33363.833180834095;42184.57815421845;42988.57011429885;43036;43165.13669726603;44414.555854441445;44992.32511512322;45000.77499612505;45148.54851451484;45200.321995170016;8072.152423995484;8913.376063675529;9099.317551183654;10342.120919721796;10551.736206594858;10572.78854422911;10703.518341674604;10704.46477676117;10706.732331691692;10714.51784669688;10747.731306717316;10829.133669306437;10831.025207731303;10832.891671083307;10841.945790271038;8284.212999765012;8536.8719469208;10452.268341216119;10654.147668186526;10659.946700266488;10599.947000264949;10785.406802625852;10792;10796.136309095253;10799.352038877692;40836;41890.37164442536;41932.580674193174;41985.790071049756;42032.579674203174;3859.247446747885;3896.9220615587815;3929.155231625214;3957.1096503286817;4030.234255491447;33954.66045339564;34837.30325393478;34969.825150874334;34981;35022.64977350219;4545.499995000548;4606.88482787933;4640.141573808856;4659.673822832403;4678.906421871578;326409;329933;330841;330944;332951;40129.79935100306;41006;41063.58936410657;69528.65235673891;70161.2983870165;38759;38776.418353724715;38914.41628375577;38927.41608875869;39190.41214381786;15846.841531584536;15894.443694470638;15910.68178636444;15918.602034948988;16013.519594412186;12313.630591082281;13532.120412173177;13694;13697.109687870257;13710.931445342909;9232.907670923205;9380.812383752287;9383.906160938302;9415.811683766286;9433.669821556212;3575.4458059000895;3634;3641.235340578455;3695.5565332160313;3698.0569954661387;1097.7969075721016;1120.4957769003981;1130.3444002478543;1151.0963893343853;1186.0985650905202;33799.83100084484;34317.82841085779;34382;34863.12842178966;35383.64616353803;1190.476190476205;1195.4022988505747;1261.6278197931633;1280.9423575939104;1298.4092238031674;17433.12834358277;17796.55508612295;18000.549986250448;18212.271509139486;18390.63218735618;526658;535234;537640;540829;542065;64500;65200;65243.34756652467;65266.67366663231;65355.34644653588;1417.4188582681052;1432.4914655297428;1480.2006916265095;1497.079296232809;1546.3350759173438;31692.5246121313;33887.49168762421;33910.491342629386;34111.4883276756;34184.48723269203;52533;52873.471265286855;53182;53213;53313.73343133259;311008;311676;312041;313787;314208;28146.155615331572;31728.524072138476;32050.83974580112;32529;32857;47175.05649886914;54113.458865412416;54525;54848.725756370965;55922;43349.349759753;43550.782246088565;43604.34593481164;43675.56324436715;44832;43324;43342.29489191131;43788.562114379725;43811.561884380746;44733.329000064376;45500.54499454963;45848;46025.079498410516;46257.30614040725;47592.2861157076;36817.447738284485;39160.80419597884;39399.89230370328;39414.605853941095;39974.2005159901;29804.70195298019;30087;30213.244668882573;30232.84883575568;30552.694473055875 03:55:04 INFO - PROCESS | 11605 | |2;jquery.html;423.4960397127416;425.2664154333773;430.77599648182934;438.7060669351536;439.3695047606684;18528.722069168958;19130.23479060836;19137.904310478447;19314;20295.797042029575;12264.325462099581;12506.937465312662;13188.802167967488;19954.600907981832;19999.20003199874;5378.951104534617;5516.172574113875;5526;5549.5837812164045;5668.093105103184;5853.385394533577;5957.255343082114;5986.401359864022;6006.948783962811;6011.128386383972;5750.137479378106;5945.137954996523;5946.018906880359;5949.643021418707;5949.85125371867;5914;5942.019566771499;5943.52451803859;5949.286085669725;5951.018082016484;5353.598480114007;5401.297831281948;5403.135498320289;5414.8917021659345;5559.444055594448;23283.7671623285;23425.648615270784;23448.296551103493;23868;24014.75985240143;2682.141714651312;2758.600002999554;2821.8730157142772;2868.7131286871354;3147.118806734118;10594.205434592359;10661.147108231324;10941;11032.669019929415;12047.337396443192;2064.5251592133895;2075.242536474191;2133.9359819205447;2150.032485381569;2168.056895250571;59214.70392648009;61238.693806531126;61664.38335616631;77640.22359776443;80115.19884801193;9019.909800901907;9812.412672301838;10269.7432564185;10686.57253709843;10728.678139655824;14974.47589334368;15101.244937753068;15127.470538531099;15145.924270378577;15154.318055687521;8107.391945604103;8168.2240187183315;8237.217464340878;8307.875381869277;8398.622062007224;7948.364130869517;7986.520808751494;8080.757577272691;8117.47236429642;8275.54484503346;4749.976250118796;4884.975575122173;4904.803807847647;4915.139850526144;4948.208286674187;1948.9805101949082;1974.4076776966851;2006.959860802805;2012.2152360579387;2030.7461567304088;993.8757655293089;1038.7974345002651;1048.7378155461136;1104.6575561575937;1141.9885801141882;19375.4187374379;19510.5122371939;19521.804781952284;19650.410487685393;19748.802511974696;1081.378207530673;1102.3165637304762;1128.232801694839;1144.2848219862585;1181.9349935753444;10782.245242833083;10863.293885897392;10896.945515272531;10977.560897564008;11034.613788517523;198381;200447;388913;396774;507816;102103;103860.48069759754;104721.47639261908;104974;109263;1036.1503567074926;1068.4390694885092;1095.1840878545534;1110.2894147745449;1118.558169523034;14357.641058973191;16469.670606588043;17223.741643875102;17544.649107018042;17610.82389176092;38215.61784382121;39332.21335573215;39347.606523934395;40091.19817603573;40722.1855562893;59396.406035939086;60154.39845601488;60271.39728602658;60519.69740151271;60527.69736151291;8793.868091978753;9158.267338612763;9191.448513089235;9219.585118669542;9414.340996130206;9909.752256193653;10885.619003334845;13202.867971320164;13480.93259533696;13607.183568985893;11771.705707357385;12119.091068170099;12389.93805030969;12423.068269879976;12807.103502754717;11985.041196704417;12154.392280386122;12274.447649855956;12417.875821241672;12580.685482863002;12272.570460033856;12384.75230495403;12433.689157771129;12441.564545240873;13037.934810325887;8661.480311181349;8722.389432739647;8920.598573064357;8959.686410975584;9082.682106126254;9183.219426348835;11515.481803318704;12372.13395062337;12647.114701970773;13042.347882606022 03:55:04 INFO - PROCESS | 11605 | |3;mootools.html;1385.1066062389752;1528.4268399350244;1545.6676814484883;1745.9563510912226;1856.512273553439;7104.9644751776295;8039.276465118138;8205.999999999993;8209.91790082099;8225.259726624603;7916.287534121942;8085.959570202141;8088.91911080889;8093.39299552533;8103.432759706823;2033.074950897338;2350.9177178798786;2356.15178535727;2378.2746262389965;2403.218953840009;2390.95218095638;2395.4250979764906;2402.2432933625937;2403.7836594706473;2404.483036147228;2252.549490101986;2321.779430954057;2324.8256380771427;2329.2779238436055;2329.5457385809773;2037.8165965063142;2315.4674424882287;2366.7988221001237;2370.12305446984;2376.097083108425;2313.144136669426;2347.143292698153;2362.976370236293;2368.609179485383;2369.57347677418;8155.918440815575;8187.426880118394;8198.672053117869;8205.220504052106;8218.21926916942;5110.565601923841;5251.842444726664;5255.500727430888;5258.079836028718;5303.416624171338;3266.248762784549;3289.7697161198726;3309.321589074234;3396.558447401822;3448.051785758911;1130.37829193943;1142.9314241145557;1144.6279959013355;1224.179799534314;1248.993755031219;11452.484638191218;11496.540138394454;11500;11526.020288275507;11557.537698492135;4435.024294655171;4505.166544189336;4522.728636281768;4527.456705195332;4701.600363969101;9926;9927.950360248296;9931.50342482873;9939.105480506645;9949;4739.052189562101;5258.658187217895;5259.47405259471;5262.868428289324;5265.6050796189675;4836.153673107192;4901.656884018084;4914.0908931847725;4930.383702037246;4935.407751069823;3984.4222587724616;3987.5613682494904;4054.959450405517;4153.210889930903;4188.099558594856;1285.749278890626;1296.6758310422395;1301.5509649171022;1303.1399276477669;1313.894888408925;1006.8842083160383;1081.9621313254;1093.8468614393992;1095.479647167589;1108.3349990005931;5969.880602387928;6072.939270607326;6079.96960015206;6101.328853826076;6202.72087756052;462.51898026053203;473.5344109979608;474.0731869195714;475.1281398633477;478.09878379255355;4073.6944729145434;4114.341705327193;4115.403266526337;4125.731827431207;4166.979165104155;10090;10403.947980260202;10543.103836174012;10550.366977981346;10551.47242637865;10259.794804104025;10342.586296548205;10373.170146388422;10387.68836934893;10408.219383546264;7876.527408355517;8044.235797599219;8154.14381489935;8221.876671849926;8233.50598964052;5957.225560677084;5975.312839023568;6078.787242446493;6079.452849243412;6141.263048434216;9143.908560914306;9303.395279306824;9440.527973601429;9622.230221582397;9652.420854748738;9292.535373231447;9419.434833909987;9589.136977672042;9612.471314077513;9665.371750836173;6878.484113691393;7111.53775004623;7279.781606551812;7501.474896757393;7580.938668586513;7738.806529836799;7751.961240193763;7782.883256751266;7788.766337009899;7806.41451891099;6809.489288303298;6920.792376228721;6968.128983877015;7057.36483716468;7090.6100164491445;6979.96510017467;7029.472789540702;7047.6828542714675;7087.929120708727;7120.323569260912;6724.966375168093;6902.516823822485;6934.06390137325;6948.652567371712;6950.374466298057;5147.073526765069;5164.948350516447;5182.196759502283;5198.74006299676;5215.426303106731;5170.819021334235;5243.082460569462;5256.421793602777;5267.57859371257;5348.572114230775 03:55:04 INFO - PROCESS | 11605 | |4;prototype.html;351.32545512615775;363.89810852961165;365.30956492229683;369.3941935226228;372.89186136020555;6267.43593076623;6280.560360774748;6287.025511045789;6289.433950944414;6423.0686550450155;5954.077118046699;6052.878942421149;6198.566100372976;6256.280527739312;6270.216222972129;4777.761111944389;4797.568218860302;4801.975990120044;4802.471728109905;4821.4937431569615;4802.471728109905;4805.90388192236;4812.711237325754;4818.494058123882;4819.180739274314;4545.795439205243;4655.255159174532;4677.228257337535;4720.952790472103;4737.692050016738;4740.549647783455;4763.523647635244;4765.547273009059;4771.28430735389;4773.427188737373;4192.664586833046;4218.641415479688;4219.261629214906;4228.619424251801;4250.53244143144;6011.428914253139;6018.8194354169445;6018.8495287617725;6035.668038257894;6035.939640603582;5608.158776183605;5620.494155525981;5635;5641.379448260688;5643.633163844337;6494.5453818232745;6604.669766511655;6629.9337006630285;6630.73477060917;6632.005199220107;4722.527747225285;4747.715137091785;4751.95248047522;4753.738544380058;4756.762161891892;6879.759208427681;6925.896111558331;6927.515073944826;6934.375906168469;6944.131983502062;4850.490698476679;4861.368022157168;4863;4866.245731911559;4866.5376789205675;4912.754362281871;4916.483769204254;4918.975405122951;4919.3604831371695;4929.901401971941;5501.862453438696;5619.353774316006;5619.43805619443;5624.746886390122;5627.099664053731;6657.23441804189;6672;6679.532432729662;6681.933180668131;6694.966525167343;1631.7878675772074;1680.9915950420414;1717.2358300556132;1733.9336308170384;1738.9740053368573;1162.2387336294742;1172.1091970102614;1174.6593487888588;1177.252444697623;1179.8525184351956;6273.7176827042895;6281.120643109968;6358.237011558643;6374.266959299647;6386.84032899172;6837.076994605764;6853.588784672936;6867.450603951672;6892.965535172292;6896.655167241618;6383.968080159662;6386.776462823779;6399.680015999182;6403.327650596713;6403.391677790602;3674.761140525857;3706.240220754739;3707.1844194277214;3710.3321402147335;3712.6844218241213;6953.79138625842;7025.578465292099;7121.145462544528;7122.8603423452;7125.287471252833;6925.3074692530345;6937.167539895245;6953.930460695429;6962.060121883481;6982.93017069833;7091.6454177290925;7092.184398794101;7108.999999999896;7109.573425594481;7115.89326160108;6873.862522749617;6880.243173251039;6882.483813713891;6886.827829304107;6895.34494223048;6647.60114393138;6746.898796518154;6854.862902742017;6900.930990690029;6902.06822079033;7215.278472152742;7224.89162662571;7231.204567497676;7233.638318083969;7244.420446364384;4696.8121275148615;4698.7415692137265;4734.33719279308;4737.715737055788;4737.8341758038305;6671.633060181736;6789.219239787488;6938.167419909643;6951.965240173767;6958.165020197609;6751.122354093936;6752.122224110834;6765.086713293643;6785.457163427012;6800.625965571743;6725.663716814041;6735.797926062226;6736.427403670743;6737.258901520927;6741.696623651849;6593.901091483535;6607.975763756625;6617.900731489128;6619.238787539494;6622.536422450382;6588.308227636221;6765.797026089028;6767.763128290683;6809;6829.214640316427;6541.6075035498025;6621.33786621334;6641.900371494335;6642.535022548375;6653.168353955755 03:55:04 INFO - PROCESS | 11605 | |5;yui.html;811.6509900742682;815.522919092331;834.2283387866222;876.2420506262083;899.1503029636991;14924.776128358084;15058.849411505882;15113.09321440713;15133.697326053487;15138.54584362468;13523.526676566322;13560.45758169672;13561.593152205425;13623.114497557652;13634.181949083062;718.0844423360205;735.5035351137988;739.5377888819488;739.5932237269507;873.7902903303193;890.4167770110588;893.9853266542489;894.5706061090681;895.552223888056;897.0536084430922;932.3892850183107;945.645382981382;946.8769060022222;949.7910459698855;949.9620015199419;940.9059094090604;941.5809964565736;942.688912658821;942.9858552121724;943.2218419803621;569.5016860247283;683.993160068398;692.9168499780059;699.6641612026204;700.3661686174021;14066;14117.505887293895;14153.504627337994;14221.075630084011;14251.928740356336;13860;14460.49388271416;14592.781108283385;14660.633484162874;14716.484923027643;11187.105031597453;11287.887121128766;11345.716357091056;11386.430678466044;11576.53693852245;3971.98014009931;4086.7139300248996;4101.610347017028;4110.527289361732;4134.793260337001;58439;58691;58704.41295587075;58801.7059914702;59099.40900590982;10922.672319830417;11256;12170.330631815335;12326.876731232573;12458.12793104492;20535.38393848157;20566.485837854172;20727.067281972348;20776.06507707157;20806.479838004172;7645.273698998586;8469.915300847037;8527.18991695788;8696.478211307342;8839.60221790021;4733.715977041388;4791.784369703371;4791.832285869978;4817.807287708452;4948.035133149074;3353.4466812975584;3434.278801451673;3435.124043368925;3440.9827950860085;3445.586529616462;663.6880666086931;674.1337381464795;674.8076798112514;690.6822861483673;695.3012222716138;682.0655701688718;734.1337222077999;756.8221467955026;781.1602527283193;795.5703919883314;9112.225460835904;9732.026797320212;10087.00488657571;10983.176261780398;11270.661880143609;704.9436045116379;719.3346154806887;812.3582369927809;818.7011740714596;821.5317269156524;4660.440747110369;4823.782929768169;4826.638002149853;4858.319835223072;4858.611311095104;60937.69531152405;63346.36653633497;63354.68322658357;63368.683156583924;63495;54799.452005480234;55146.72426637841;55977.16034259489;55988.44011559832;56082.43917560854;51222.23166652503;51716.48283517192;51862;52274.738626307386;52615.73692131515;9433.716988490356;9582.90417095848;9613.182879455046;9622.230221582116;9635.470049147083;37663.43504847484;37694.62305377021;38110.237795244495;38861.6682999021;39067.41398878962;46076.539234608565;47565.28652070291;49787.25319120144;49880.25179622381;50833.23750143677;11678.766424671288;12795.744085118431;12879.098463107868;13089;13183.53857614979;13097;13710.65723356924;14152;14328.49850255236;15019.098854068354;13833.79249311241;13870.217230619934;14124.2937853109;14152.504662336769;14255.429782808986;12925.547605834126;13854.238016908763;13885;14108.506202282872;14122.50571230002;13275.668108296983;13742.65643358924;13777.862221377658;13989.720205596035;14193.361298741374;10241.129503992244;10426;10429.26995110335;10522.631707890187;10579.841302380317;11229.38238396896;11278.266912650652;11412.429378531206;11415.486303116546;11427.885721142682 03:55:04 INFO - PROCESS | 11605 | __end_tp_report 03:55:04 INFO - PROCESS | 11605 | __start_cc_report 03:55:04 INFO - PROCESS | 11605 | _x_x_mozilla_cycle_collect,860 03:55:04 INFO - PROCESS | 11605 | __end_cc_report 03:55:04 INFO - PROCESS | 11605 | __startTimestamp1464432904004__endTimestamp 03:55:04 INFO - PROCESS | 11605 | 03:55:04 INFO - PROCESS | 11605 | ------- Summary: start ------- 03:55:04 INFO - PROCESS | 11605 | Number of tests: 6 03:55:04 INFO - PROCESS | 11605 | 03:55:04 INFO - PROCESS | 11605 | [#0] dojo.html Cycles:165 Average:5586.45 Median:5821.97 stddev:625.22 (10.7%) stddev-sans-first:601.41 03:55:04 INFO - PROCESS | 11605 | Values: 3323.5 3362.6 3365.2 3389.2 3407.2 5523.8 5526.3 5536.9 5546.6 5551.0 5510.2 5515.2 5552.6 5555.6 5593.4 5020.5 5042.8 5107.2 5175.7 5179.5 5062.2 5158.2 5162.5 5163.8 5165.9 5056.2 5102.5 5117.1 5138.3 5152.3 5202.0 5206.8 5241.3 5243.9 5259.4 5000.0 5029.1 5099.6 5115.5 5129.3 5503.9 5560.6 5565.1 5577.4 5581.7 5925.1 5928.6 5931.1 5931.9 5937.9 5974.2 5978.2 6047.9 6061.8 6075.7 5590.2 5637.0 5640.3 5642.2 5658.2 6010.8 6140.8 6141.9 6142.3 6145.3 5934.1 5961.9 5967.9 5972.9 5979.7 5964.7 5967.1 5967.2 5974.7 5975.0 5754.2 5842.8 5938.3 5941.6 5951.2 5974.4 5985.6 5986.8 5999.2 6021.7 4538.2 4539.2 4544.1 4545.4 4570.7 3975.3 4058.5 4074.6 4099.4 4108.3 5686.7 5705.2 5721.7 5722.4 5733.1 6013.6 6057.6 6068.7 6070.5 6072.6 5585.4 5684.1 5698.9 5773.6 5783.9 5179.2 5199.1 5203.2 5203.6 5208.0 6254.4 6259.5 6272.8 6274.7 6277.0 5855.2 6010.5 6089.8 6092.4 6137.5 6205.6 6254.7 6256.3 6258.0 6272.1 5835.2 5942.6 5948.1 5952.9 5991.6 6063.5 6079.0 6082.0 6105.1 6112.3 5812.7 5850.6 5859.9 5861.0 5876.9 5718.2 5778.0 5822.0 5841.0 5890.6 5834.2 5857.4 5862.6 5864.4 5896.6 5951.0 5959.3 5962.7 5963.8 5970.5 5727.5 5784.5 5819.5 5842.0 5867.4 03:55:04 INFO - PROCESS | 11605 | 03:55:04 INFO - PROCESS | 11605 | [#1] ext.html Cycles:180 Average:56435.69 Median:3696.81 stddev:107549.71 (2909.3%) stddev-sans-first:107769.91 03:55:04 INFO - PROCESS | 11605 | Values: 666.9 671.0 675.7 680.0 740.2 33363.8 42184.6 42988.6 43036.0 43165.1 44414.6 44992.3 45000.8 45148.5 45200.3 8072.2 8913.4 9099.3 10342.1 10551.7 10572.8 10703.5 10704.5 10706.7 10714.5 10747.7 10829.1 10831.0 10832.9 10841.9 8284.2 8536.9 10452.3 10654.1 10659.9 10599.9 10785.4 10792.0 10796.1 10799.4 40836.0 41890.4 41932.6 41985.8 42032.6 3859.2 3896.9 3929.2 3957.1 4030.2 33954.7 34837.3 34969.8 34981.0 35022.6 4545.5 4606.9 4640.1 4659.7 4678.9 326409.0 329933.0 330841.0 330944.0 332951.0 40129.8 41006.0 41063.6 69528.7 70161.3 38759.0 38776.4 38914.4 38927.4 39190.4 15846.8 15894.4 15910.7 15918.6 16013.5 12313.6 13532.1 13694.0 13697.1 13710.9 9232.9 9380.8 9383.9 9415.8 9433.7 3575.4 3634.0 3641.2 3695.6 3698.1 1097.8 1120.5 1130.3 1151.1 1186.1 33799.8 34317.8 34382.0 34863.1 35383.6 1190.5 1195.4 1261.6 1280.9 1298.4 17433.1 17796.6 18000.5 18212.3 18390.6 526658.0 535234.0 537640.0 540829.0 542065.0 64500.0 65200.0 65243.3 65266.7 65355.3 1417.4 1432.5 1480.2 1497.1 1546.3 31692.5 33887.5 33910.5 34111.5 34184.5 52533.0 52873.5 53182.0 53213.0 53313.7 311008.0 311676.0 312041.0 313787.0 314208.0 28146.2 31728.5 32050.8 32529.0 32857.0 47175.1 54113.5 54525.0 54848.7 55922.0 43349.3 43550.8 43604.3 43675.6 44832.0 43324.0 43342.3 43788.6 43811.6 44733.3 45500.5 45848.0 46025.1 46257.3 47592.3 36817.4 39160.8 39399.9 39414.6 39974.2 29804.7 30087.0 30213.2 30232.8 30552.7 03:55:04 INFO - PROCESS | 11605 | 03:55:04 INFO - PROCESS | 11605 | [#2] jquery.html Cycles:180 Average:24798.05 Median:2159.04 stddev:60645.86 (2808.9%) stddev-sans-first:60788.37 03:55:04 INFO - PROCESS | 11605 | Values: 423.5 425.3 430.8 438.7 439.4 18528.7 19130.2 19137.9 19314.0 20295.8 12264.3 12506.9 13188.8 19954.6 19999.2 5379.0 5516.2 5526.0 5549.6 5668.1 5853.4 5957.3 5986.4 6006.9 6011.1 5750.1 5945.1 5946.0 5949.6 5949.9 5914.0 5942.0 5943.5 5949.3 5951.0 5353.6 5401.3 5403.1 5414.9 5559.4 23283.8 23425.6 23448.3 23868.0 24014.8 2682.1 2758.6 2821.9 2868.7 3147.1 10594.2 10661.1 10941.0 11032.7 12047.3 2064.5 2075.2 2133.9 2150.0 2168.1 59214.7 61238.7 61664.4 77640.2 80115.2 9019.9 9812.4 10269.7 10686.6 10728.7 14974.5 15101.2 15127.5 15145.9 15154.3 8107.4 8168.2 8237.2 8307.9 8398.6 7948.4 7986.5 8080.8 8117.5 8275.5 4750.0 4885.0 4904.8 4915.1 4948.2 1949.0 1974.4 2007.0 2012.2 2030.7 993.9 1038.8 1048.7 1104.7 1142.0 19375.4 19510.5 19521.8 19650.4 19748.8 1081.4 1102.3 1128.2 1144.3 1181.9 10782.2 10863.3 10896.9 10977.6 11034.6 198381.0 200447.0 388913.0 396774.0 507816.0 102103.0 103860.5 104721.5 104974.0 109263.0 1036.2 1068.4 1095.2 1110.3 1118.6 14357.6 16469.7 17223.7 17544.6 17610.8 38215.6 39332.2 39347.6 40091.2 40722.2 59396.4 60154.4 60271.4 60519.7 60527.7 8793.9 9158.3 9191.4 9219.6 9414.3 9909.8 10885.6 13202.9 13480.9 13607.2 11771.7 12119.1 12389.9 12423.1 12807.1 11985.0 12154.4 12274.4 12417.9 12580.7 12272.6 12384.8 12433.7 12441.6 13037.9 8661.5 8722.4 8920.6 8959.7 9082.7 9183.2 11515.5 12372.1 12647.1 13042.3 03:55:04 INFO - PROCESS | 11605 | 03:55:04 INFO - PROCESS | 11605 | [#3] mootools.html Cycles:180 Average:5574.62 Median:5022.99 stddev:3055.69 (60.8%) stddev-sans-first:3048.04 03:55:04 INFO - PROCESS | 11605 | Values: 1385.1 1528.4 1545.7 1746.0 1856.5 7105.0 8039.3 8206.0 8209.9 8225.3 7916.3 8086.0 8088.9 8093.4 8103.4 2033.1 2350.9 2356.2 2378.3 2403.2 2391.0 2395.4 2402.2 2403.8 2404.5 2252.5 2321.8 2324.8 2329.3 2329.5 2037.8 2315.5 2366.8 2370.1 2376.1 2313.1 2347.1 2363.0 2368.6 2369.6 8155.9 8187.4 8198.7 8205.2 8218.2 5110.6 5251.8 5255.5 5258.1 5303.4 3266.2 3289.8 3309.3 3396.6 3448.1 1130.4 1142.9 1144.6 1224.2 1249.0 11452.5 11496.5 11500.0 11526.0 11557.5 4435.0 4505.2 4522.7 4527.5 4701.6 9926.0 9928.0 9931.5 9939.1 9949.0 4739.1 5258.7 5259.5 5262.9 5265.6 4836.2 4901.7 4914.1 4930.4 4935.4 3984.4 3987.6 4055.0 4153.2 4188.1 1285.7 1296.7 1301.6 1303.1 1313.9 1006.9 1082.0 1093.8 1095.5 1108.3 5969.9 6072.9 6080.0 6101.3 6202.7 462.5 473.5 474.1 475.1 478.1 4073.7 4114.3 4115.4 4125.7 4167.0 10090.0 10403.9 10543.1 10550.4 10551.5 10259.8 10342.6 10373.2 10387.7 10408.2 7876.5 8044.2 8154.1 8221.9 8233.5 5957.2 5975.3 6078.8 6079.5 6141.3 9143.9 9303.4 9440.5 9622.2 9652.4 9292.5 9419.4 9589.1 9612.5 9665.4 6878.5 7111.5 7279.8 7501.5 7580.9 7738.8 7752.0 7782.9 7788.8 7806.4 6809.5 6920.8 6968.1 7057.4 7090.6 6980.0 7029.5 7047.7 7087.9 7120.3 6725.0 6902.5 6934.1 6948.7 6950.4 5147.1 5164.9 5182.2 5198.7 5215.4 5170.8 5243.1 5256.4 5267.6 5348.6 03:55:04 INFO - PROCESS | 11605 | 03:55:04 INFO - PROCESS | 11605 | [#4] prototype.html Cycles:180 Average:5593.38 Median:6323.84 stddev:1675.17 (26.5%) stddev-sans-first:1633.00 03:55:04 INFO - PROCESS | 11605 | Values: 351.3 363.9 365.3 369.4 372.9 6267.4 6280.6 6287.0 6289.4 6423.1 5954.1 6052.9 6198.6 6256.3 6270.2 4777.8 4797.6 4802.0 4802.5 4821.5 4802.5 4805.9 4812.7 4818.5 4819.2 4545.8 4655.3 4677.2 4721.0 4737.7 4740.5 4763.5 4765.5 4771.3 4773.4 4192.7 4218.6 4219.3 4228.6 4250.5 6011.4 6018.8 6018.8 6035.7 6035.9 5608.2 5620.5 5635.0 5641.4 5643.6 6494.5 6604.7 6629.9 6630.7 6632.0 4722.5 4747.7 4752.0 4753.7 4756.8 6879.8 6925.9 6927.5 6934.4 6944.1 4850.5 4861.4 4863.0 4866.2 4866.5 4912.8 4916.5 4919.0 4919.4 4929.9 5501.9 5619.4 5619.4 5624.7 5627.1 6657.2 6672.0 6679.5 6681.9 6695.0 1631.8 1681.0 1717.2 1733.9 1739.0 1162.2 1172.1 1174.7 1177.3 1179.9 6273.7 6281.1 6358.2 6374.3 6386.8 6837.1 6853.6 6867.5 6893.0 6896.7 6384.0 6386.8 6399.7 6403.3 6403.4 3674.8 3706.2 3707.2 3710.3 3712.7 6953.8 7025.6 7121.1 7122.9 7125.3 6925.3 6937.2 6953.9 6962.1 6982.9 7091.6 7092.2 7109.0 7109.6 7115.9 6873.9 6880.2 6882.5 6886.8 6895.3 6647.6 6746.9 6854.9 6900.9 6902.1 7215.3 7224.9 7231.2 7233.6 7244.4 4696.8 4698.7 4734.3 4737.7 4737.8 6671.6 6789.2 6938.2 6952.0 6958.2 6751.1 6752.1 6765.1 6785.5 6800.6 6725.7 6735.8 6736.4 6737.3 6741.7 6593.9 6608.0 6617.9 6619.2 6622.5 6588.3 6765.8 6767.8 6809.0 6829.2 6541.6 6621.3 6641.9 6642.5 6653.2 03:55:04 INFO - PROCESS | 11605 | 03:55:04 INFO - PROCESS | 11605 | [#5] yui.html Cycles:180 Average:15563.17 Median:26149.50 stddev:17825.11 (68.2%) stddev-sans-first:17840.69 03:55:04 INFO - PROCESS | 11605 | Values: 811.7 815.5 834.2 876.2 899.2 14924.8 15058.8 15113.1 15133.7 15138.5 13523.5 13560.5 13561.6 13623.1 13634.2 718.1 735.5 739.5 739.6 873.8 890.4 894.0 894.6 895.6 897.1 932.4 945.6 946.9 949.8 950.0 940.9 941.6 942.7 943.0 943.2 569.5 684.0 692.9 699.7 700.4 14066.0 14117.5 14153.5 14221.1 14251.9 13860.0 14460.5 14592.8 14660.6 14716.5 11187.1 11287.9 11345.7 11386.4 11576.5 3972.0 4086.7 4101.6 4110.5 4134.8 58439.0 58691.0 58704.4 58801.7 59099.4 10922.7 11256.0 12170.3 12326.9 12458.1 20535.4 20566.5 20727.1 20776.1 20806.5 7645.3 8469.9 8527.2 8696.5 8839.6 4733.7 4791.8 4791.8 4817.8 4948.0 3353.4 3434.3 3435.1 3441.0 3445.6 663.7 674.1 674.8 690.7 695.3 682.1 734.1 756.8 781.2 795.6 9112.2 9732.0 10087.0 10983.2 11270.7 704.9 719.3 812.4 818.7 821.5 4660.4 4823.8 4826.6 4858.3 4858.6 60937.7 63346.4 63354.7 63368.7 63495.0 54799.5 55146.7 55977.2 55988.4 56082.4 51222.2 51716.5 51862.0 52274.7 52615.7 9433.7 9582.9 9613.2 9622.2 9635.5 37663.4 37694.6 38110.2 38861.7 39067.4 46076.5 47565.3 49787.3 49880.3 50833.2 11678.8 12795.7 12879.1 13089.0 13183.5 13097.0 13710.7 14152.0 14328.5 15019.1 13833.8 13870.2 14124.3 14152.5 14255.4 12925.5 13854.2 13885.0 14108.5 14122.5 13275.7 13742.7 13777.9 13989.7 14193.4 10241.1 10426.0 10429.3 10522.6 10579.8 11229.4 11278.3 11412.4 11415.5 11427.9 03:55:04 INFO - PROCESS | 11605 | -------- Summary: end -------- 03:55:04 INFO - PROCESS | 11605 | 03:55:04 INFO - TEST-INFO | 11605: exit 0 03:55:04 INFO - TEST-OK | dromaeo_css | took 1110174ms 03:55:04 INFO - TEST-START | kraken 03:55:04 INFO - operating with platform_type : linux_ 03:55:04 INFO - Initialising browser for kraken test... 03:55:04 INFO - TEST-INFO | started process 11796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpltuIO1/profile http://localhost:49727/getInfo.html) 03:55:07 INFO - PROCESS | 11796 | __metrics Screen width/height:1600/1200 03:55:07 INFO - PROCESS | 11796 | colorDepth:24 03:55:07 INFO - PROCESS | 11796 | Browser inner width/height: 1024/697 03:55:07 INFO - PROCESS | 11796 | __metrics 03:55:08 ERROR - PROCESS | 11796 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:55:09 INFO - TEST-INFO | 11796: exit 0 03:55:09 INFO - Browser initialized. 03:55:09 INFO - Running cycle 1/1 for kraken test... 03:55:09 INFO - TEST-INFO | started process 11890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpltuIO1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:55:21 INFO - PROCESS | 11890 | RSS: Main: 142209024 03:55:21 INFO - PROCESS | 11890 | 03:55:23 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49727/tests/kraken/driver.html?testName=audio-beat-detection) 03:55:24 INFO - PROCESS | 11890 | RSS: Main: 196788224 03:55:24 INFO - PROCESS | 11890 | 03:55:27 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49727/tests/kraken/driver.html?testName=audio-dft) 03:55:27 INFO - PROCESS | 11890 | RSS: Main: 181256192 03:55:27 INFO - PROCESS | 11890 | 03:55:30 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49727/tests/kraken/driver.html?testName=audio-fft) 03:55:31 INFO - PROCESS | 11890 | RSS: Main: 272138240 03:55:31 INFO - PROCESS | 11890 | 03:55:33 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49727/tests/kraken/driver.html?testName=audio-oscillator) 03:55:33 INFO - PROCESS | 11890 | RSS: Main: 178049024 03:55:33 INFO - PROCESS | 11890 | 03:55:36 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49727/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:55:36 INFO - PROCESS | 11890 | RSS: Main: 177016832 03:55:36 INFO - PROCESS | 11890 | 03:55:39 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49727/tests/kraken/driver.html?testName=imaging-darkroom) 03:55:40 INFO - PROCESS | 11890 | RSS: Main: 211558400 03:55:40 INFO - PROCESS | 11890 | 03:55:43 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49727/tests/kraken/driver.html?testName=imaging-desaturate) 03:55:44 INFO - PROCESS | 11890 | RSS: Main: 212197376 03:55:44 INFO - PROCESS | 11890 | 03:55:46 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49727/tests/kraken/driver.html?testName=json-parse-financial) 03:55:47 INFO - PROCESS | 11890 | RSS: Main: 211750912 03:55:47 INFO - PROCESS | 11890 | 03:55:48 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49727/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:55:49 INFO - PROCESS | 11890 | RSS: Main: 190607360 03:55:49 INFO - PROCESS | 11890 | 03:55:51 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:55:51 INFO - PROCESS | 11890 | RSS: Main: 194490368 03:55:51 INFO - PROCESS | 11890 | 03:55:53 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:55:54 INFO - PROCESS | 11890 | RSS: Main: 207011840 03:55:54 INFO - PROCESS | 11890 | 03:55:56 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:55:57 INFO - PROCESS | 11890 | RSS: Main: 213430272 03:55:57 INFO - PROCESS | 11890 | 03:56:00 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:56:00 INFO - PROCESS | 11890 | RSS: Main: 210444288 03:56:00 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49727/tests/kraken/driver.html?testName=ai-astar) 03:56:02 INFO - PROCESS | 11890 | RSS: Main: 274096128 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | __start_tp_report 03:56:02 INFO - PROCESS | 11890 | _x_x_mozilla_page_load 03:56:02 INFO - PROCESS | 11890 | _x_x_mozilla_page_load_details 03:56:02 INFO - PROCESS | 11890 | |i|pagename|runs| 03:56:02 INFO - PROCESS | 11890 | |0;ai-astar;109;109;109;110;110;109;105;110;109;111 03:56:02 INFO - PROCESS | 11890 | |1;audio-beat-detection;157;124;150;173;126;150;158;127;177;127 03:56:02 INFO - PROCESS | 11890 | |2;audio-dft;161;160;161;161;160;161;162;163;164;160 03:56:02 INFO - PROCESS | 11890 | |3;audio-fft;77;78;77;173;79;75;75;76;168;75 03:56:02 INFO - PROCESS | 11890 | |4;audio-oscillator;93;92;149;92;92;93;153;93;93;148 03:56:02 INFO - PROCESS | 11890 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;116;116;117 03:56:02 INFO - PROCESS | 11890 | |6;imaging-darkroom;145;145;145;145;146;145;147;145;145;144 03:56:02 INFO - PROCESS | 11890 | |7;imaging-desaturate;94;94;94;94;94;94;95;94;94;94 03:56:02 INFO - PROCESS | 11890 | |8;json-parse-financial;55;53;54;53;54;54;54;74;52;51 03:56:02 INFO - PROCESS | 11890 | |9;json-stringify-tinderbox;57;57;57;58;58;57;57;58;58;58 03:56:02 INFO - PROCESS | 11890 | |10;stanford-crypto-aes;72;72;72;72;82;75;75;74;74;74 03:56:02 INFO - PROCESS | 11890 | |11;stanford-crypto-ccm;117;114;116;113;113;120;114;115;130;123 03:56:02 INFO - PROCESS | 11890 | |12;stanford-crypto-pbkdf2;160;161;163;160;161;156;155;156;155;162 03:56:02 INFO - PROCESS | 11890 | |13;stanford-crypto-sha256-iterative;67;65;66;65;66;65;65;68;65;70 03:56:02 INFO - PROCESS | 11890 | __end_tp_report 03:56:02 INFO - PROCESS | 11890 | __start_cc_report 03:56:02 INFO - PROCESS | 11890 | _x_x_mozilla_cycle_collect,1589 03:56:02 INFO - PROCESS | 11890 | __end_cc_report 03:56:02 INFO - PROCESS | 11890 | __startTimestamp1464432962650__endTimestamp 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | ------- Summary: start ------- 03:56:02 INFO - PROCESS | 11890 | Number of tests: 14 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#0] ai-astar Cycles:10 Average:109.10 Median:109.50 stddev:1.60 (1.5%) stddev-sans-first:1.69 03:56:02 INFO - PROCESS | 11890 | Values: 109.0 109.0 109.0 110.0 110.0 109.0 105.0 110.0 109.0 111.0 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:153.50 stddev:19.96 (13.0%) stddev-sans-first:20.83 03:56:02 INFO - PROCESS | 11890 | Values: 157.0 124.0 150.0 173.0 126.0 150.0 158.0 127.0 177.0 127.0 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 03:56:02 INFO - PROCESS | 11890 | Values: 161.0 160.0 161.0 161.0 160.0 161.0 162.0 163.0 164.0 160.0 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.50 stddev:39.67 (51.9%) stddev-sans-first:41.52 03:56:02 INFO - PROCESS | 11890 | Values: 77.0 78.0 77.0 173.0 79.0 75.0 75.0 76.0 168.0 75.0 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.50 stddev:27.77 (30.0%) stddev-sans-first:28.78 03:56:02 INFO - PROCESS | 11890 | Values: 93.0 92.0 149.0 92.0 92.0 93.0 153.0 93.0 93.0 148.0 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:56:02 INFO - PROCESS | 11890 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 116.0 117.0 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:56:02 INFO - PROCESS | 11890 | Values: 145.0 145.0 145.0 145.0 146.0 145.0 147.0 145.0 145.0 144.0 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:56:02 INFO - PROCESS | 11890 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.00 stddev:6.64 (12.3%) stddev-sans-first:7.04 03:56:02 INFO - PROCESS | 11890 | Values: 55.0 53.0 54.0 53.0 54.0 54.0 54.0 74.0 52.0 51.0 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:58.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 03:56:02 INFO - PROCESS | 11890 | Values: 57.0 57.0 57.0 58.0 58.0 57.0 57.0 58.0 58.0 58.0 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.00 stddev:3.01 (4.1%) stddev-sans-first:3.09 03:56:02 INFO - PROCESS | 11890 | Values: 72.0 72.0 72.0 72.0 82.0 75.0 75.0 74.0 74.0 74.0 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#11] stanford-crypto-ccm Cycles:10 Average:117.50 Median:116.50 stddev:5.44 (4.7%) stddev-sans-first:5.77 03:56:02 INFO - PROCESS | 11890 | Values: 117.0 114.0 116.0 113.0 113.0 120.0 114.0 115.0 130.0 123.0 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:160.50 stddev:3.07 (1.9%) stddev-sans-first:3.23 03:56:02 INFO - PROCESS | 11890 | Values: 160.0 161.0 163.0 160.0 161.0 156.0 155.0 156.0 155.0 162.0 03:56:02 INFO - PROCESS | 11890 | 03:56:02 INFO - PROCESS | 11890 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.69 (2.6%) stddev-sans-first:1.76 03:56:02 INFO - PROCESS | 11890 | Values: 67.0 65.0 66.0 65.0 66.0 65.0 65.0 68.0 65.0 70.0 03:56:02 INFO - PROCESS | 11890 | -------- Summary: end -------- 03:56:02 INFO - PROCESS | 11890 | 03:56:03 INFO - TEST-INFO | 11890: exit 0 03:56:03 INFO - TEST-OK | kraken | took 58858ms 03:56:03 INFO - SUITE-END | took 1169s 03:56:03 INFO - Completed test suite (00:19:29) 03:56:03 INFO - javascript benchmark 03:56:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3323.484859846724, 3362.562866827312, 3365.2259980204553, 3389.2204792897646, 3407.2333724911896, 5523.751431185597, 5526.281583394159, 5536.889262214753, 5546.556275497961, 5551.0, 5510.173473978905, 5515.172724091388, 5552.555795536357, 5555.611107222496, 5593.356763972144, 5020.548150666457, 5042.84871453857, 5107.208382700687, 5175.741212939338, 5179.482051794828, 5062.190049592066, 5158.174692049273, 5162.483751624845, 5163.793448262084, 5165.940982098661, 5056.241563765428, 5102.489751024887, 5117.130087885069, 5138.2806407103035, 5152.330197074375, 5201.973990130044, 5206.76569554371, 5241.344831896013, 5243.947560524384, 5259.368875734898, 4999.950000500021, 5029.069622119883, 5099.617528685363, 5115.514026167508, 5129.333186685744, 5503.944960550383, 5560.582956278296, 5565.053940830068, 5577.414371490976, 5581.6930068846195, 5925.111233314994, 5928.644281343133, 5931.139984702194, 5931.940680593182, 5937.8812423751715, 5974.163617093611, 5978.163057172, 6047.909281360783, 6061.782789435708, 6075.665838378887, 5590.18942253371, 5637.013522633563, 5640.294963129609, 5642.181883626851, 5658.151277308396, 6010.819675409744, 6140.846478838065, 6141.881051037385, 6142.293636231801, 6145.293291271471, 5934.080217566284, 5961.910571341434, 5967.940320596826, 5972.8805423892145, 5979.730912108878, 5964.671943043088, 5967.1347654589845, 5967.224260846149, 5974.701264936736, 5975.0, 5754.223179870663, 5842.795502157404, 5938.257717785277, 5941.55438342126, 5951.196588460502, 5974.40255974399, 5985.610935289193, 5986.790462333797, 5999.1901093351835, 6021.6989150542295, 4538.228501154812, 4539.228331183706, 4544.136614043321, 4545.38637283969, 4570.65720070996, 3975.3043217436834, 4058.5332686740812, 4074.5517993020744, 4099.385092236188, 4108.301588729923, 5686.715664216773, 5705.229793977843, 5721.742521586539, 5722.399148089391, 5733.140028995684, 6013.609115407485, 6057.636541807506, 6068.696565171724, 6070.453659170696, 6072.635641861502, 5585.357683866326, 5684.118961560965, 5698.914516282259, 5773.5958482906635, 5783.94216057834, 5179.19722443022, 5199.11615025439, 5203.245529398216, 5203.60972927032, 5208.0, 6254.437100660963, 6259.4679452246155, 6272.8118156455375, 6274.749010039639, 6277.027060805583, 5855.151003104526, 6010.459058684739, 6089.786857459968, 6092.421219984094, 6137.539684523589, 6205.572718274912, 6254.718537665907, 6256.280527739368, 6258.0, 6272.059191121369, 5835.153902684002, 5942.64344139353, 5948.078047902582, 5952.8809423812145, 5991.610545314541, 6063.484603808725, 6078.969605151946, 6081.969590152021, 6105.114758360101, 6112.327643959072, 5812.680302583399, 5850.590458668023, 5859.94140058594, 5861.0, 5876.882462350643, 5718.170865224436, 5777.971110144591, 5821.970890145522, 5841.0, 5890.558208134493, 5834.241548598655, 5857.414258574108, 5862.589618726648, 5864.413558644272, 5896.557758168069, 5950.9702451487465, 5959.28488581373, 5962.672053036951, 5963.821085367446, 5970.462658360769, 5727.4845263926445, 5784.479396854304, 5819.5053420459735, 5841.9707901461925, 5867.383924687846], "value": 5545.321321994642, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.9199696036474, 670.9563878347907, 675.6992788881402, 679.9592024478532, 740.156221907026, 33363.833180834095, 42184.57815421845, 42988.57011429885, 43036.0, 43165.13669726603, 44414.555854441445, 44992.32511512322, 45000.77499612505, 45148.54851451484, 45200.321995170016, 8072.152423995484, 8913.376063675529, 9099.317551183654, 10342.120919721796, 10551.736206594858, 10572.78854422911, 10703.518341674604, 10704.46477676117, 10706.732331691692, 10714.51784669688, 10747.731306717316, 10829.133669306437, 10831.025207731303, 10832.891671083307, 10841.945790271038, 8284.212999765012, 8536.8719469208, 10452.268341216119, 10654.147668186526, 10659.946700266488, 10599.947000264949, 10785.406802625852, 10792.0, 10796.136309095253, 10799.352038877692, 40836.0, 41890.37164442536, 41932.580674193174, 41985.790071049756, 42032.579674203174, 3859.247446747885, 3896.9220615587815, 3929.155231625214, 3957.1096503286817, 4030.234255491447, 33954.66045339564, 34837.30325393478, 34969.825150874334, 34981.0, 35022.64977350219, 4545.499995000548, 4606.88482787933, 4640.141573808856, 4659.673822832403, 4678.906421871578, 326409.0, 329933.0, 330841.0, 330944.0, 332951.0, 40129.79935100306, 41006.0, 41063.58936410657, 69528.65235673891, 70161.2983870165, 38759.0, 38776.418353724715, 38914.41628375577, 38927.41608875869, 39190.41214381786, 15846.841531584536, 15894.443694470638, 15910.68178636444, 15918.602034948988, 16013.519594412186, 12313.630591082281, 13532.120412173177, 13694.0, 13697.109687870257, 13710.931445342909, 9232.907670923205, 9380.812383752287, 9383.906160938302, 9415.811683766286, 9433.669821556212, 3575.4458059000895, 3634.0, 3641.235340578455, 3695.5565332160313, 3698.0569954661387, 1097.7969075721016, 1120.4957769003981, 1130.3444002478543, 1151.0963893343853, 1186.0985650905202, 33799.83100084484, 34317.82841085779, 34382.0, 34863.12842178966, 35383.64616353803, 1190.476190476205, 1195.4022988505747, 1261.6278197931633, 1280.9423575939104, 1298.4092238031674, 17433.12834358277, 17796.55508612295, 18000.549986250448, 18212.271509139486, 18390.63218735618, 526658.0, 535234.0, 537640.0, 540829.0, 542065.0, 64500.0, 65200.0, 65243.34756652467, 65266.67366663231, 65355.34644653588, 1417.4188582681052, 1432.4914655297428, 1480.2006916265095, 1497.079296232809, 1546.3350759173438, 31692.5246121313, 33887.49168762421, 33910.491342629386, 34111.4883276756, 34184.48723269203, 52533.0, 52873.471265286855, 53182.0, 53213.0, 53313.73343133259, 311008.0, 311676.0, 312041.0, 313787.0, 314208.0, 28146.155615331572, 31728.524072138476, 32050.83974580112, 32529.0, 32857.0, 47175.05649886914, 54113.458865412416, 54525.0, 54848.725756370965, 55922.0, 43349.349759753, 43550.782246088565, 43604.34593481164, 43675.56324436715, 44832.0, 43324.0, 43342.29489191131, 43788.562114379725, 43811.561884380746, 44733.329000064376, 45500.54499454963, 45848.0, 46025.079498410516, 46257.30614040725, 47592.2861157076, 36817.447738284485, 39160.80419597884, 39399.89230370328, 39414.605853941095, 39974.2005159901, 29804.70195298019, 30087.0, 30213.244668882573, 30232.84883575568, 30552.694473055875], "value": 20099.216462883458, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.4960397127416, 425.2664154333773, 430.77599648182934, 438.7060669351536, 439.3695047606684, 18528.722069168958, 19130.23479060836, 19137.904310478447, 19314.0, 20295.797042029575, 12264.325462099581, 12506.937465312662, 13188.802167967488, 19954.600907981832, 19999.20003199874, 5378.951104534617, 5516.172574113875, 5526.0, 5549.5837812164045, 5668.093105103184, 5853.385394533577, 5957.255343082114, 5986.401359864022, 6006.948783962811, 6011.128386383972, 5750.137479378106, 5945.137954996523, 5946.018906880359, 5949.643021418707, 5949.85125371867, 5914.0, 5942.019566771499, 5943.52451803859, 5949.286085669725, 5951.018082016484, 5353.598480114007, 5401.297831281948, 5403.135498320289, 5414.8917021659345, 5559.444055594448, 23283.7671623285, 23425.648615270784, 23448.296551103493, 23868.0, 24014.75985240143, 2682.141714651312, 2758.600002999554, 2821.8730157142772, 2868.7131286871354, 3147.118806734118, 10594.205434592359, 10661.147108231324, 10941.0, 11032.669019929415, 12047.337396443192, 2064.5251592133895, 2075.242536474191, 2133.9359819205447, 2150.032485381569, 2168.056895250571, 59214.70392648009, 61238.693806531126, 61664.38335616631, 77640.22359776443, 80115.19884801193, 9019.909800901907, 9812.412672301838, 10269.7432564185, 10686.57253709843, 10728.678139655824, 14974.47589334368, 15101.244937753068, 15127.470538531099, 15145.924270378577, 15154.318055687521, 8107.391945604103, 8168.2240187183315, 8237.217464340878, 8307.875381869277, 8398.622062007224, 7948.364130869517, 7986.520808751494, 8080.757577272691, 8117.47236429642, 8275.54484503346, 4749.976250118796, 4884.975575122173, 4904.803807847647, 4915.139850526144, 4948.208286674187, 1948.9805101949082, 1974.4076776966851, 2006.959860802805, 2012.2152360579387, 2030.7461567304088, 993.8757655293089, 1038.7974345002651, 1048.7378155461136, 1104.6575561575937, 1141.9885801141882, 19375.4187374379, 19510.5122371939, 19521.804781952284, 19650.410487685393, 19748.802511974696, 1081.378207530673, 1102.3165637304762, 1128.232801694839, 1144.2848219862585, 1181.9349935753444, 10782.245242833083, 10863.293885897392, 10896.945515272531, 10977.560897564008, 11034.613788517523, 198381.0, 200447.0, 388913.0, 396774.0, 507816.0, 102103.0, 103860.48069759754, 104721.47639261908, 104974.0, 109263.0, 1036.1503567074926, 1068.4390694885092, 1095.1840878545534, 1110.2894147745449, 1118.558169523034, 14357.641058973191, 16469.670606588043, 17223.741643875102, 17544.649107018042, 17610.82389176092, 38215.61784382121, 39332.21335573215, 39347.606523934395, 40091.19817603573, 40722.1855562893, 59396.406035939086, 60154.39845601488, 60271.39728602658, 60519.69740151271, 60527.69736151291, 8793.868091978753, 9158.267338612763, 9191.448513089235, 9219.585118669542, 9414.340996130206, 9909.752256193653, 10885.619003334845, 13202.867971320164, 13480.93259533696, 13607.183568985893, 11771.705707357385, 12119.091068170099, 12389.93805030969, 12423.068269879976, 12807.103502754717, 11985.041196704417, 12154.392280386122, 12274.447649855956, 12417.875821241672, 12580.685482863002, 12272.570460033856, 12384.75230495403, 12433.689157771129, 12441.564545240873, 13037.934810325887, 8661.480311181349, 8722.389432739647, 8920.598573064357, 8959.686410975584, 9082.682106126254, 9183.219426348835, 11515.481803318704, 12372.13395062337, 12647.114701970773, 13042.347882606022], "value": 9305.89700445313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.1066062389752, 1528.4268399350244, 1545.6676814484883, 1745.9563510912226, 1856.512273553439, 7104.9644751776295, 8039.276465118138, 8205.999999999993, 8209.91790082099, 8225.259726624603, 7916.287534121942, 8085.959570202141, 8088.91911080889, 8093.39299552533, 8103.432759706823, 2033.074950897338, 2350.9177178798786, 2356.15178535727, 2378.2746262389965, 2403.218953840009, 2390.95218095638, 2395.4250979764906, 2402.2432933625937, 2403.7836594706473, 2404.483036147228, 2252.549490101986, 2321.779430954057, 2324.8256380771427, 2329.2779238436055, 2329.5457385809773, 2037.8165965063142, 2315.4674424882287, 2366.7988221001237, 2370.12305446984, 2376.097083108425, 2313.144136669426, 2347.143292698153, 2362.976370236293, 2368.609179485383, 2369.57347677418, 8155.918440815575, 8187.426880118394, 8198.672053117869, 8205.220504052106, 8218.21926916942, 5110.565601923841, 5251.842444726664, 5255.500727430888, 5258.079836028718, 5303.416624171338, 3266.248762784549, 3289.7697161198726, 3309.321589074234, 3396.558447401822, 3448.051785758911, 1130.37829193943, 1142.9314241145557, 1144.6279959013355, 1224.179799534314, 1248.993755031219, 11452.484638191218, 11496.540138394454, 11500.0, 11526.020288275507, 11557.537698492135, 4435.024294655171, 4505.166544189336, 4522.728636281768, 4527.456705195332, 4701.600363969101, 9926.0, 9927.950360248296, 9931.50342482873, 9939.105480506645, 9949.0, 4739.052189562101, 5258.658187217895, 5259.47405259471, 5262.868428289324, 5265.6050796189675, 4836.153673107192, 4901.656884018084, 4914.0908931847725, 4930.383702037246, 4935.407751069823, 3984.4222587724616, 3987.5613682494904, 4054.959450405517, 4153.210889930903, 4188.099558594856, 1285.749278890626, 1296.6758310422395, 1301.5509649171022, 1303.1399276477669, 1313.894888408925, 1006.8842083160383, 1081.9621313254, 1093.8468614393992, 1095.479647167589, 1108.3349990005931, 5969.880602387928, 6072.939270607326, 6079.96960015206, 6101.328853826076, 6202.72087756052, 462.51898026053203, 473.5344109979608, 474.0731869195714, 475.1281398633477, 478.09878379255355, 4073.6944729145434, 4114.341705327193, 4115.403266526337, 4125.731827431207, 4166.979165104155, 10090.0, 10403.947980260202, 10543.103836174012, 10550.366977981346, 10551.47242637865, 10259.794804104025, 10342.586296548205, 10373.170146388422, 10387.68836934893, 10408.219383546264, 7876.527408355517, 8044.235797599219, 8154.14381489935, 8221.876671849926, 8233.50598964052, 5957.225560677084, 5975.312839023568, 6078.787242446493, 6079.452849243412, 6141.263048434216, 9143.908560914306, 9303.395279306824, 9440.527973601429, 9622.230221582397, 9652.420854748738, 9292.535373231447, 9419.434833909987, 9589.136977672042, 9612.471314077513, 9665.371750836173, 6878.484113691393, 7111.53775004623, 7279.781606551812, 7501.474896757393, 7580.938668586513, 7738.806529836799, 7751.961240193763, 7782.883256751266, 7788.766337009899, 7806.41451891099, 6809.489288303298, 6920.792376228721, 6968.128983877015, 7057.36483716468, 7090.6100164491445, 6979.96510017467, 7029.472789540702, 7047.6828542714675, 7087.929120708727, 7120.323569260912, 6724.966375168093, 6902.516823822485, 6934.06390137325, 6948.652567371712, 6950.374466298057, 5147.073526765069, 5164.948350516447, 5182.196759502283, 5198.74006299676, 5215.426303106731, 5170.819021334235, 5243.082460569462, 5256.421793602777, 5267.57859371257, 5348.572114230775], "value": 4473.708644415215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.32545512615775, 363.89810852961165, 365.30956492229683, 369.3941935226228, 372.89186136020555, 6267.43593076623, 6280.560360774748, 6287.025511045789, 6289.433950944414, 6423.0686550450155, 5954.077118046699, 6052.878942421149, 6198.566100372976, 6256.280527739312, 6270.216222972129, 4777.761111944389, 4797.568218860302, 4801.975990120044, 4802.471728109905, 4821.4937431569615, 4802.471728109905, 4805.90388192236, 4812.711237325754, 4818.494058123882, 4819.180739274314, 4545.795439205243, 4655.255159174532, 4677.228257337535, 4720.952790472103, 4737.692050016738, 4740.549647783455, 4763.523647635244, 4765.547273009059, 4771.28430735389, 4773.427188737373, 4192.664586833046, 4218.641415479688, 4219.261629214906, 4228.619424251801, 4250.53244143144, 6011.428914253139, 6018.8194354169445, 6018.8495287617725, 6035.668038257894, 6035.939640603582, 5608.158776183605, 5620.494155525981, 5635.0, 5641.379448260688, 5643.633163844337, 6494.5453818232745, 6604.669766511655, 6629.9337006630285, 6630.73477060917, 6632.005199220107, 4722.527747225285, 4747.715137091785, 4751.95248047522, 4753.738544380058, 4756.762161891892, 6879.759208427681, 6925.896111558331, 6927.515073944826, 6934.375906168469, 6944.131983502062, 4850.490698476679, 4861.368022157168, 4863.0, 4866.245731911559, 4866.5376789205675, 4912.754362281871, 4916.483769204254, 4918.975405122951, 4919.3604831371695, 4929.901401971941, 5501.862453438696, 5619.353774316006, 5619.43805619443, 5624.746886390122, 5627.099664053731, 6657.23441804189, 6672.0, 6679.532432729662, 6681.933180668131, 6694.966525167343, 1631.7878675772074, 1680.9915950420414, 1717.2358300556132, 1733.9336308170384, 1738.9740053368573, 1162.2387336294742, 1172.1091970102614, 1174.6593487888588, 1177.252444697623, 1179.8525184351956, 6273.7176827042895, 6281.120643109968, 6358.237011558643, 6374.266959299647, 6386.84032899172, 6837.076994605764, 6853.588784672936, 6867.450603951672, 6892.965535172292, 6896.655167241618, 6383.968080159662, 6386.776462823779, 6399.680015999182, 6403.327650596713, 6403.391677790602, 3674.761140525857, 3706.240220754739, 3707.1844194277214, 3710.3321402147335, 3712.6844218241213, 6953.79138625842, 7025.578465292099, 7121.145462544528, 7122.8603423452, 7125.287471252833, 6925.3074692530345, 6937.167539895245, 6953.930460695429, 6962.060121883481, 6982.93017069833, 7091.6454177290925, 7092.184398794101, 7108.999999999896, 7109.573425594481, 7115.89326160108, 6873.862522749617, 6880.243173251039, 6882.483813713891, 6886.827829304107, 6895.34494223048, 6647.60114393138, 6746.898796518154, 6854.862902742017, 6900.930990690029, 6902.06822079033, 7215.278472152742, 7224.89162662571, 7231.204567497676, 7233.638318083969, 7244.420446364384, 4696.8121275148615, 4698.7415692137265, 4734.33719279308, 4737.715737055788, 4737.8341758038305, 6671.633060181736, 6789.219239787488, 6938.167419909643, 6951.965240173767, 6958.165020197609, 6751.122354093936, 6752.122224110834, 6765.086713293643, 6785.457163427012, 6800.625965571743, 6725.663716814041, 6735.797926062226, 6736.427403670743, 6737.258901520927, 6741.696623651849, 6593.901091483535, 6607.975763756625, 6617.900731489128, 6619.238787539494, 6622.536422450382, 6588.308227636221, 6765.797026089028, 6767.763128290683, 6809.0, 6829.214640316427, 6541.6075035498025, 6621.33786621334, 6641.900371494335, 6642.535022548375, 6653.168353955755], "value": 5054.258194846049, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.6509900742682, 815.522919092331, 834.2283387866222, 876.2420506262083, 899.1503029636991, 14924.776128358084, 15058.849411505882, 15113.09321440713, 15133.697326053487, 15138.54584362468, 13523.526676566322, 13560.45758169672, 13561.593152205425, 13623.114497557652, 13634.181949083062, 718.0844423360205, 735.5035351137988, 739.5377888819488, 739.5932237269507, 873.7902903303193, 890.4167770110588, 893.9853266542489, 894.5706061090681, 895.552223888056, 897.0536084430922, 932.3892850183107, 945.645382981382, 946.8769060022222, 949.7910459698855, 949.9620015199419, 940.9059094090604, 941.5809964565736, 942.688912658821, 942.9858552121724, 943.2218419803621, 569.5016860247283, 683.993160068398, 692.9168499780059, 699.6641612026204, 700.3661686174021, 14066.0, 14117.505887293895, 14153.504627337994, 14221.075630084011, 14251.928740356336, 13860.0, 14460.49388271416, 14592.781108283385, 14660.633484162874, 14716.484923027643, 11187.105031597453, 11287.887121128766, 11345.716357091056, 11386.430678466044, 11576.53693852245, 3971.98014009931, 4086.7139300248996, 4101.610347017028, 4110.527289361732, 4134.793260337001, 58439.0, 58691.0, 58704.41295587075, 58801.7059914702, 59099.40900590982, 10922.672319830417, 11256.0, 12170.330631815335, 12326.876731232573, 12458.12793104492, 20535.38393848157, 20566.485837854172, 20727.067281972348, 20776.06507707157, 20806.479838004172, 7645.273698998586, 8469.915300847037, 8527.18991695788, 8696.478211307342, 8839.60221790021, 4733.715977041388, 4791.784369703371, 4791.832285869978, 4817.807287708452, 4948.035133149074, 3353.4466812975584, 3434.278801451673, 3435.124043368925, 3440.9827950860085, 3445.586529616462, 663.6880666086931, 674.1337381464795, 674.8076798112514, 690.6822861483673, 695.3012222716138, 682.0655701688718, 734.1337222077999, 756.8221467955026, 781.1602527283193, 795.5703919883314, 9112.225460835904, 9732.026797320212, 10087.00488657571, 10983.176261780398, 11270.661880143609, 704.9436045116379, 719.3346154806887, 812.3582369927809, 818.7011740714596, 821.5317269156524, 4660.440747110369, 4823.782929768169, 4826.638002149853, 4858.319835223072, 4858.611311095104, 60937.69531152405, 63346.36653633497, 63354.68322658357, 63368.683156583924, 63495.0, 54799.452005480234, 55146.72426637841, 55977.16034259489, 55988.44011559832, 56082.43917560854, 51222.23166652503, 51716.48283517192, 51862.0, 52274.738626307386, 52615.73692131515, 9433.716988490356, 9582.90417095848, 9613.182879455046, 9622.230221582116, 9635.470049147083, 37663.43504847484, 37694.62305377021, 38110.237795244495, 38861.6682999021, 39067.41398878962, 46076.539234608565, 47565.28652070291, 49787.25319120144, 49880.25179622381, 50833.23750143677, 11678.766424671288, 12795.744085118431, 12879.098463107868, 13089.0, 13183.53857614979, 13097.0, 13710.65723356924, 14152.0, 14328.49850255236, 15019.098854068354, 13833.79249311241, 13870.217230619934, 14124.2937853109, 14152.504662336769, 14255.429782808986, 12925.547605834126, 13854.238016908763, 13885.0, 14108.506202282872, 14122.50571230002, 13275.668108296983, 13742.65643358924, 13777.862221377658, 13989.720205596035, 14193.361298741374, 10241.129503992244, 10426.0, 10429.26995110335, 10522.631707890187, 10579.841302380317, 11229.38238396896, 11278.266912650652, 11412.429378531206, 11415.486303116546, 11427.885721142682], "value": 7117.147837553985, "unit": "score"}], "name": "dromaeo_css", "value": 7420.31665970834, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 105.0, 110.0, 109.0, 111.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 150.0, 173.0, 126.0, 150.0, 158.0, 127.0, 177.0, 127.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 162.0, 163.0, 164.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 173.0, 79.0, 75.0, 75.0, 76.0, 168.0, 75.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 149.0, 92.0, 92.0, 93.0, 153.0, 93.0, 93.0, 148.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 147.0, 145.0, 145.0, 144.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 53.0, 54.0, 54.0, 54.0, 74.0, 52.0, 51.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 58.0, 58.0, 57.0, 57.0, 58.0, 58.0, 58.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 72.0, 82.0, 75.0, 75.0, 74.0, 74.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 116.0, 113.0, 113.0, 120.0, 114.0, 115.0, 130.0, 123.0], "value": 117.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 163.0, 160.0, 161.0, 156.0, 155.0, 156.0, 155.0, 162.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 68.0, 65.0, 70.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1508.0000000000002, "alertThreshold": 2.0}]} 03:56:03 INFO - Return code: 0 03:56:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:56:03 ERROR - # TBPL SUCCESS # 03:56:03 INFO - Running post-action listener: _resource_record_post_action 03:56:03 INFO - Running post-run listener: _resource_record_post_run 03:56:05 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 491917312; Read time: 12; Write time: 445496 03:56:05 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 254922752; Read time: 0; Write time: 303836 03:56:05 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 236396544; Read time: 12; Write time: 141660 03:56:05 INFO - Running post-run listener: _upload_blobber_files 03:56:05 INFO - Blob upload gear active. 03:56:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:56:05 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 03:56:05 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'] 03:56:05 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 03:56:05 INFO - (blobuploader) - INFO - Open directory for files ... 03:56:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:56:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:56:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:06 INFO - (blobuploader) - INFO - Done attempting. 03:56:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:56:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:56:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:06 INFO - (blobuploader) - INFO - Done attempting. 03:56:06 INFO - (blobuploader) - INFO - Iteration through files over. 03:56:06 INFO - Return code: 0 03:56:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:56:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:56:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db83f495031c12de2e6cf3fbeff808ade73b6f28db481f2a9ccbaf089cd64593bc19791bd37085e8e47f859b12346923da64c4af7eab71060f2b80df7e9a2b21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae6a8c2e1ba7b98d3ee0c839d6c0294a7d941d07713f40dfce8dcb47faf48ea909964a7f8f403cf11e8c93e709911cb654ed7a37ff17a2c1568d836080370bb8"} 03:56:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:56:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:56:06 INFO - Contents: 03:56:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db83f495031c12de2e6cf3fbeff808ade73b6f28db481f2a9ccbaf089cd64593bc19791bd37085e8e47f859b12346923da64c4af7eab71060f2b80df7e9a2b21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae6a8c2e1ba7b98d3ee0c839d6c0294a7d941d07713f40dfce8dcb47faf48ea909964a7f8f403cf11e8c93e709911cb654ed7a37ff17a2c1568d836080370bb8"} 03:56:06 INFO - Running post-run listener: copy_logs_to_upload_dir 03:56:06 INFO - Copying logs to upload dir... 03:56:06 INFO - mkdir: /builds/slave/test/build/upload/logs 03:56:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.481179 ========= master_lag: 0.84 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-28 03:56:07.798483) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:56:07.803188) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491 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/db83f495031c12de2e6cf3fbeff808ade73b6f28db481f2a9ccbaf089cd64593bc19791bd37085e8e47f859b12346923da64c4af7eab71060f2b80df7e9a2b21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae6a8c2e1ba7b98d3ee0c839d6c0294a7d941d07713f40dfce8dcb47faf48ea909964a7f8f403cf11e8c93e709911cb654ed7a37ff17a2c1568d836080370bb8"} build_url:https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011874 build_url: 'https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/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/db83f495031c12de2e6cf3fbeff808ade73b6f28db481f2a9ccbaf089cd64593bc19791bd37085e8e47f859b12346923da64c4af7eab71060f2b80df7e9a2b21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae6a8c2e1ba7b98d3ee0c839d6c0294a7d941d07713f40dfce8dcb47faf48ea909964a7f8f403cf11e8c93e709911cb654ed7a37ff17a2c1568d836080370bb8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:56:07.834426) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:56:07.834808) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464431736.434824-6398491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:56:07.884563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:56:07.887973) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:56:07.888365) ========= ========= Total master_lag: 0.97 =========