builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1464431855.01 results: success (0) buildid: 20160525183450 builduid: 63f91898e679451db7d589c242ad058b revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.014492) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.014905) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.015261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.029420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.029671) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 03:37:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-05-28 03:37:35 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084677 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.127622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.127940) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013733 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.180019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.180445) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 03:37:35,473 truncating revision to first 12 chars 2016-05-28 03:37:35,473 Setting DEBUG logging. 2016-05-28 03:37:35,473 attempt 1/10 2016-05-28 03:37:35,473 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:37:35,778 unpacking tar archive at: mozilla-aurora-33693d8bdec1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634115 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.829064) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.829843) ========= script_repo_revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.830333) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.830596) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:35.841885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-28 03:37:35.842671) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:37:36 INFO - MultiFileLogger online at 20160528 03:37:36 in /builds/slave/test 03:37:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:37:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:37:36 INFO - {'append_to_log': False, 03:37:36 INFO - 'base_work_dir': '/builds/slave/test', 03:37:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:37:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:37:36 INFO - 'branch': 'Mozilla-Aurora', 03:37:36 INFO - 'buildbot_json_path': 'buildprops.json', 03:37:36 INFO - 'config_files': ('talos/linux_config.py',), 03:37:36 INFO - 'default_actions': ('clobber', 03:37:36 INFO - 'read-buildbot-config', 03:37:36 INFO - 'download-and-extract', 03:37:36 INFO - 'populate-webroot', 03:37:36 INFO - 'create-virtualenv', 03:37:36 INFO - 'install', 03:37:36 INFO - 'run-tests'), 03:37:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:37:36 INFO - 'download_minidump_stackwalk': True, 03:37:36 INFO - 'download_symbols': 'ondemand', 03:37:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:37:36 INFO - 'tooltool.py': '/tools/tooltool.py', 03:37:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:37:36 INFO - '/tools/misc-python/virtualenv.py')}, 03:37:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:37:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:37:36 INFO - 'installer_path': 'installer.exe', 03:37:36 INFO - 'log_level': 'info', 03:37:36 INFO - 'log_name': 'talos', 03:37:36 INFO - 'log_to_console': True, 03:37:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:37:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:37:36 INFO - 'opt_config_files': (), 03:37:36 INFO - 'pip_index': False, 03:37:36 INFO - 'sps_profile': False, 03:37:36 INFO - 'sps_profile_interval': 0, 03:37:36 INFO - 'suite': 'dromaeojs-e10s', 03:37:36 INFO - 'system_bits': '32', 03:37:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:37:36 INFO - 'title': 'talos-linux64-ix-047', 03:37:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:37:36 INFO - 'use_talos_json': True, 03:37:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:37:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:37:36 INFO - 'work_dir': 'build'} 03:37:36 INFO - ##### 03:37:36 INFO - ##### Running clobber step. 03:37:36 INFO - ##### 03:37:36 INFO - Running pre-action listener: _resource_record_pre_action 03:37:36 INFO - Running main action method: clobber 03:37:36 INFO - rmtree: /builds/slave/test/build 03:37:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:37:37 INFO - Running post-action listener: _resource_record_post_action 03:37:37 INFO - ##### 03:37:37 INFO - ##### Running read-buildbot-config step. 03:37:37 INFO - ##### 03:37:37 INFO - Running pre-action listener: _resource_record_pre_action 03:37:37 INFO - Running main action method: read_buildbot_config 03:37:37 INFO - Using buildbot properties: 03:37:37 INFO - { 03:37:37 INFO - "project": "", 03:37:37 INFO - "product": "firefox", 03:37:37 INFO - "script_repo_revision": "production", 03:37:37 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:37:37 INFO - "repository": "", 03:37:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:37:37 INFO - "buildid": "20160525183450", 03:37:37 INFO - "pgo_build": "True", 03:37:37 INFO - "basedir": "/builds/slave/test", 03:37:37 INFO - "buildnumber": 376, 03:37:37 INFO - "slavename": "talos-linux64-ix-047", 03:37:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:37:37 INFO - "platform": "ubuntu64_hw", 03:37:37 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:37:37 INFO - "branch": "mozilla-aurora", 03:37:37 INFO - "repo_path": "releases/mozilla-aurora", 03:37:37 INFO - "revision": "33693d8bdec17f07fc460ca7cc908ade88f97b86", 03:37:37 INFO - "stage_platform": "linux64-pgo", 03:37:37 INFO - "builduid": "63f91898e679451db7d589c242ad058b", 03:37:37 INFO - "slavebuilddir": "test" 03:37:37 INFO - } 03:37:37 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:37:37 INFO - Running post-action listener: _resource_record_post_action 03:37:37 INFO - ##### 03:37:37 INFO - ##### Running download-and-extract step. 03:37:37 INFO - ##### 03:37:37 INFO - Running pre-action listener: _resource_record_pre_action 03:37:37 INFO - Running main action method: download_and_extract 03:37:37 INFO - mkdir: /builds/slave/test/build/tests 03:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:37 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:37:37 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:37:37 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:37:37 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:37:37 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:37:37 INFO - Downloaded 1361 bytes. 03:37:37 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:37:37 INFO - Using the following test package requirements: 03:37:37 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:37:37 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:37:37 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:37:37 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:37 INFO - u'jsshell-linux-x86_64.zip'], 03:37:37 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:37:37 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:37:37 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:37:37 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:37:37 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:37:37 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:37 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:37:37 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:37 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:37:37 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:37:37 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:37:37 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:37:37 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:37:39 INFO - Downloaded 24140640 bytes. 03:37:39 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:37:39 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:37:40 INFO - Return code: 0 03:37:40 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:37:40 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:37:40 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:37:40 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:37:40 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:37:40 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:37:40 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:37:42 INFO - Downloaded 24140640 bytes. 03:37:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:37:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:37:43 INFO - Return code: 0 03:37:43 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:37:43 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:37:43 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:37:43 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:37:43 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:37:43 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:37:44 INFO - Downloaded 10840145 bytes. 03:37:44 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:37:44 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:37:44 INFO - Return code: 0 03:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:44 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:37:44 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:37:44 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:37:44 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:37:44 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:37:46 INFO - Downloaded 62759817 bytes. 03:37:46 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:37:46 INFO - mkdir: /builds/slave/test/properties 03:37:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:37:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:37:46 INFO - Contents: 03:37:46 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:37:46 INFO - Running post-action listener: _resource_record_post_action 03:37:46 INFO - Running post-action listener: set_extra_try_arguments 03:37:46 INFO - ##### 03:37:46 INFO - ##### Running populate-webroot step. 03:37:46 INFO - ##### 03:37:46 INFO - Running pre-action listener: _resource_record_pre_action 03:37:46 INFO - Running main action method: populate_webroot 03:37:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:37:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:37:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:37:46 INFO - '--tppagecycles', 03:37:46 INFO - '7'], 03:37:46 INFO - 'tests': ['tsvgm']}}, 03:37:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:37:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:37:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:37:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:37:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:37:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:37:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:46 INFO - 'talos_options': ['--disable-e10s'], 03:37:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:46 INFO - 'talos_options': ['--disable-e10s'], 03:37:46 INFO - 'tests': ['damp', 'tps']}, 03:37:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:46 INFO - 'tests': ['damp', 'tps']}, 03:37:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:37:46 INFO - 'tests': ['dromaeo_dom']}, 03:37:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:37:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:37:46 INFO - 'tests': ['a11yr', 03:37:46 INFO - 'ts_paint', 03:37:46 INFO - 'tpaint', 03:37:46 INFO - 'sessionrestore', 03:37:46 INFO - 'sessionrestore_no_auto_restore', 03:37:46 INFO - 'tabpaint']}, 03:37:46 INFO - 'other-e10s': {'tests': ['a11yr', 03:37:46 INFO - 'ts_paint', 03:37:46 INFO - 'tpaint', 03:37:46 INFO - 'sessionrestore', 03:37:46 INFO - 'sessionrestore_no_auto_restore', 03:37:46 INFO - 'tabpaint']}, 03:37:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:37:46 INFO - 'ts_paint', 03:37:46 INFO - 'tpaint', 03:37:46 INFO - 'sessionrestore', 03:37:46 INFO - 'sessionrestore_no_auto_restore', 03:37:46 INFO - 'tabpaint']}, 03:37:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:37:46 INFO - 'ts_paint', 03:37:46 INFO - 'tpaint', 03:37:46 INFO - 'sessionrestore', 03:37:46 INFO - 'sessionrestore_no_auto_restore', 03:37:46 INFO - 'tabpaint']}, 03:37:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:37:46 INFO - 'tests': ['a11yr', 03:37:46 INFO - 'ts_paint', 03:37:46 INFO - 'tpaint', 03:37:46 INFO - 'sessionrestore', 03:37:46 INFO - 'sessionrestore_no_auto_restore', 03:37:46 INFO - 'tabpaint']}, 03:37:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:37:46 INFO - 'tests': ['a11yr', 03:37:46 INFO - 'ts_paint', 03:37:46 INFO - 'tpaint', 03:37:46 INFO - 'sessionrestore', 03:37:46 INFO - 'sessionrestore_no_auto_restore', 03:37:46 INFO - 'tabpaint']}, 03:37:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:37:46 INFO - 'tests': ['tsvgx', 03:37:46 INFO - 'tsvgr_opacity', 03:37:46 INFO - 'tart', 03:37:46 INFO - 'tscrollx', 03:37:46 INFO - 'cart']}, 03:37:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:37:46 INFO - 'tsvgr_opacity', 03:37:46 INFO - 'tart', 03:37:46 INFO - 'tscrollx', 03:37:46 INFO - 'cart']}, 03:37:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:46 INFO - 'talos_options': ['--disable-e10s'], 03:37:46 INFO - 'tests': ['tp5o']}, 03:37:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:46 INFO - 'tests': ['tp5o']}, 03:37:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:46 INFO - 'talos_options': ['--disable-e10s', 03:37:46 INFO - '--xperf_path', 03:37:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:46 INFO - 'tests': ['tp5n']}, 03:37:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:46 INFO - 'talos_options': ['--xperf_path', 03:37:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:46 INFO - 'tests': ['tp5n']}}, 03:37:46 INFO - 'talos.zip': {'path': '', 03:37:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:37:46 INFO - Running post-action listener: _resource_record_post_action 03:37:46 INFO - ##### 03:37:46 INFO - ##### Running create-virtualenv step. 03:37:46 INFO - ##### 03:37:46 INFO - Running pre-action listener: _resource_record_pre_action 03:37:46 INFO - Running main action method: create_virtualenv 03:37:46 INFO - Creating virtualenv /builds/slave/test/build/venv 03:37:46 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:37:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:37:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:37:47 INFO - Using real prefix '/usr' 03:37:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:37:47 INFO - Installing distribute.............................................................................................................................................................................................done. 03:37:49 INFO - Installing pip.................done. 03:37:49 INFO - Return code: 0 03:37:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:37:49 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:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:49 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:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:49 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 0x7fadda9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, '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 0x2656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26567a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', '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:37:49 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:37:49 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:37:49 INFO - Using env: {'DISPLAY': ':0', 03:37:49 INFO - 'HOME': '/home/cltbld', 03:37:49 INFO - 'LANG': 'en_US.UTF-8', 03:37:49 INFO - 'LANGUAGE': 'en_US:en', 03:37:49 INFO - 'LOGNAME': 'cltbld', 03:37:49 INFO - 'MAIL': '/var/mail/cltbld', 03:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:49 INFO - 'MOZ_NO_REMOTE': '1', 03:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:49 INFO - 'NO_EM_RESTART': '1', 03:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:49 INFO - 'PWD': '/builds/slave/test', 03:37:49 INFO - 'SHELL': '/bin/bash', 03:37:49 INFO - 'SHLVL': '1', 03:37:49 INFO - 'TERM': 'linux', 03:37:49 INFO - 'TMOUT': '86400', 03:37:49 INFO - 'USER': 'cltbld', 03:37:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', 03:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:49 INFO - '_': '/tools/buildbot/bin/python'} 03:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:49 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:37:49 INFO - Cleaning up... 03:37:49 INFO - Return code: 0 03:37:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:37:49 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:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:49 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:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:49 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 0x7fadda9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, '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 0x2656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26567a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', '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:37:49 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:37:49 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:37:49 INFO - Using env: {'DISPLAY': ':0', 03:37:49 INFO - 'HOME': '/home/cltbld', 03:37:49 INFO - 'LANG': 'en_US.UTF-8', 03:37:49 INFO - 'LANGUAGE': 'en_US:en', 03:37:49 INFO - 'LOGNAME': 'cltbld', 03:37:49 INFO - 'MAIL': '/var/mail/cltbld', 03:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:49 INFO - 'MOZ_NO_REMOTE': '1', 03:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:49 INFO - 'NO_EM_RESTART': '1', 03:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:49 INFO - 'PWD': '/builds/slave/test', 03:37:49 INFO - 'SHELL': '/bin/bash', 03:37:49 INFO - 'SHLVL': '1', 03:37:49 INFO - 'TERM': 'linux', 03:37:49 INFO - 'TMOUT': '86400', 03:37:49 INFO - 'USER': 'cltbld', 03:37:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', 03:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:49 INFO - '_': '/tools/buildbot/bin/python'} 03:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:49 INFO - Downloading/unpacking psutil>=0.7.1 03:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:37:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:51 INFO - Installing collected packages: psutil 03:37:51 INFO - Running setup.py install for psutil 03:37:51 INFO - building 'psutil._psutil_linux' extension 03:37:51 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:37:52 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:37:52 INFO - building 'psutil._psutil_posix' extension 03:37:52 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:37:52 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:37:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:52 INFO - Successfully installed psutil 03:37:52 INFO - Cleaning up... 03:37:52 INFO - Return code: 0 03:37:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fadda9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, '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 0x2656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26567a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', '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:37:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:37:52 INFO - Using env: {'DISPLAY': ':0', 03:37:52 INFO - 'HOME': '/home/cltbld', 03:37:52 INFO - 'LANG': 'en_US.UTF-8', 03:37:52 INFO - 'LANGUAGE': 'en_US:en', 03:37:52 INFO - 'LOGNAME': 'cltbld', 03:37:52 INFO - 'MAIL': '/var/mail/cltbld', 03:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:52 INFO - 'MOZ_NO_REMOTE': '1', 03:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:52 INFO - 'NO_EM_RESTART': '1', 03:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:52 INFO - 'PWD': '/builds/slave/test', 03:37:52 INFO - 'SHELL': '/bin/bash', 03:37:52 INFO - 'SHLVL': '1', 03:37:52 INFO - 'TERM': 'linux', 03:37:52 INFO - 'TMOUT': '86400', 03:37:52 INFO - 'USER': 'cltbld', 03:37:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', 03:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:52 INFO - '_': '/tools/buildbot/bin/python'} 03:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:37:54 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:37:54 INFO - Installing collected packages: mozsystemmonitor 03:37:54 INFO - Running setup.py install for mozsystemmonitor 03:37:54 INFO - Successfully installed mozsystemmonitor 03:37:54 INFO - Cleaning up... 03:37:54 INFO - Return code: 0 03:37:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fadda9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, '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 0x2656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26567a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', '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:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:37:54 INFO - Using env: {'DISPLAY': ':0', 03:37:54 INFO - 'HOME': '/home/cltbld', 03:37:54 INFO - 'LANG': 'en_US.UTF-8', 03:37:54 INFO - 'LANGUAGE': 'en_US:en', 03:37:54 INFO - 'LOGNAME': 'cltbld', 03:37:54 INFO - 'MAIL': '/var/mail/cltbld', 03:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:54 INFO - 'MOZ_NO_REMOTE': '1', 03:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:54 INFO - 'NO_EM_RESTART': '1', 03:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:54 INFO - 'PWD': '/builds/slave/test', 03:37:54 INFO - 'SHELL': '/bin/bash', 03:37:54 INFO - 'SHLVL': '1', 03:37:54 INFO - 'TERM': 'linux', 03:37:54 INFO - 'TMOUT': '86400', 03:37:54 INFO - 'USER': 'cltbld', 03:37:54 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', 03:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:54 INFO - '_': '/tools/buildbot/bin/python'} 03:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:56 INFO - Downloading blobuploader-1.2.4.tar.gz 03:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:37:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:37: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:37: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:37: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:37: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:37: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:37: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:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:37:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:57 INFO - Downloading docopt-0.6.1.tar.gz 03:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:37:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:37:57 INFO - Running setup.py install for blobuploader 03:37:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:37:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:37:57 INFO - Running setup.py install for requests 03:37:58 INFO - Running setup.py install for docopt 03:37:58 INFO - Successfully installed blobuploader requests docopt 03:37:58 INFO - Cleaning up... 03:37:58 INFO - Return code: 0 03:37:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37: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:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:58 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 0x7fadda9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, '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 0x2656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26567a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', '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:37:58 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:37:58 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:37:58 INFO - Using env: {'DISPLAY': ':0', 03:37:58 INFO - 'HOME': '/home/cltbld', 03:37:58 INFO - 'LANG': 'en_US.UTF-8', 03:37:58 INFO - 'LANGUAGE': 'en_US:en', 03:37:58 INFO - 'LOGNAME': 'cltbld', 03:37:58 INFO - 'MAIL': '/var/mail/cltbld', 03:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:58 INFO - 'MOZ_NO_REMOTE': '1', 03:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:58 INFO - 'NO_EM_RESTART': '1', 03:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:58 INFO - 'PWD': '/builds/slave/test', 03:37:58 INFO - 'SHELL': '/bin/bash', 03:37:58 INFO - 'SHLVL': '1', 03:37:58 INFO - 'TERM': 'linux', 03:37:58 INFO - 'TMOUT': '86400', 03:37:58 INFO - 'USER': 'cltbld', 03:37:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', 03:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:58 INFO - '_': '/tools/buildbot/bin/python'} 03:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:58 INFO - Running setup.py (path:/tmp/pip-PcH2ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:58 INFO - Running setup.py (path:/tmp/pip-q1qpJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:58 INFO - Running setup.py (path:/tmp/pip-T8aTwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:58 INFO - Running setup.py (path:/tmp/pip-9i0wem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:58 INFO - Running setup.py (path:/tmp/pip-IppM1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:58 INFO - Running setup.py (path:/tmp/pip-Ood9vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:58 INFO - Running setup.py (path:/tmp/pip-uZcrNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:58 INFO - Running setup.py (path:/tmp/pip-q0Olm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:58 INFO - Running setup.py (path:/tmp/pip-eiEKmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:59 INFO - Running setup.py (path:/tmp/pip-NAxJpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:59 INFO - Running setup.py (path:/tmp/pip-_DP7JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:59 INFO - Running setup.py (path:/tmp/pip-Z_8hO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:59 INFO - Running setup.py (path:/tmp/pip-4wXAiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:59 INFO - Running setup.py (path:/tmp/pip-SXZWJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:59 INFO - Running setup.py (path:/tmp/pip-ATIdUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:59 INFO - Running setup.py (path:/tmp/pip-4wZhzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:59 INFO - Running setup.py (path:/tmp/pip-EfbHvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:37:59 INFO - Running setup.py install for manifestparser 03:37:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:59 INFO - Running setup.py install for mozcrash 03:37:59 INFO - Running setup.py install for mozdebug 03:37:59 INFO - Running setup.py install for mozdevice 03:38:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:38:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:38:00 INFO - Running setup.py install for mozfile 03:38:00 INFO - Running setup.py install for mozhttpd 03:38:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:38:00 INFO - Running setup.py install for mozinfo 03:38:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:38:00 INFO - Running setup.py install for mozInstall 03:38:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:38:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:38:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:38:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:38:00 INFO - Running setup.py install for mozleak 03:38:00 INFO - Running setup.py install for mozlog 03:38:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:38:00 INFO - Running setup.py install for moznetwork 03:38:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:38:00 INFO - Running setup.py install for mozprocess 03:38:00 INFO - Running setup.py install for mozprofile 03:38:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:38:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:38:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:38:00 INFO - Running setup.py install for mozrunner 03:38:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:38:01 INFO - Running setup.py install for mozscreenshot 03:38:01 INFO - Running setup.py install for moztest 03:38:01 INFO - Running setup.py install for mozversion 03:38:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:38:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:38:01 INFO - Cleaning up... 03:38:01 INFO - Return code: 0 03:38:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38: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:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:01 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 0x7fadda9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, '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 0x2656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26567a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', '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:38:01 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:38:01 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:38:01 INFO - Using env: {'DISPLAY': ':0', 03:38:01 INFO - 'HOME': '/home/cltbld', 03:38:01 INFO - 'LANG': 'en_US.UTF-8', 03:38:01 INFO - 'LANGUAGE': 'en_US:en', 03:38:01 INFO - 'LOGNAME': 'cltbld', 03:38:01 INFO - 'MAIL': '/var/mail/cltbld', 03:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:01 INFO - 'MOZ_NO_REMOTE': '1', 03:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:01 INFO - 'NO_EM_RESTART': '1', 03:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:01 INFO - 'PWD': '/builds/slave/test', 03:38:01 INFO - 'SHELL': '/bin/bash', 03:38:01 INFO - 'SHLVL': '1', 03:38:01 INFO - 'TERM': 'linux', 03:38:01 INFO - 'TMOUT': '86400', 03:38:01 INFO - 'USER': 'cltbld', 03:38:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', 03:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:01 INFO - '_': '/tools/buildbot/bin/python'} 03:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:38:01 INFO - Running setup.py (path:/tmp/pip-GBp6KF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:38:01 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:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:38:01 INFO - Running setup.py (path:/tmp/pip-cBPtvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:38:01 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:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:38:01 INFO - Running setup.py (path:/tmp/pip-JrRgID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:38:01 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:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:38:01 INFO - Running setup.py (path:/tmp/pip-mNqHW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:38:01 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:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:38:01 INFO - Running setup.py (path:/tmp/pip-tyL9sZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:38:01 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:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:38:01 INFO - Running setup.py (path:/tmp/pip-QgCVCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:38:02 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:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:38:02 INFO - Running setup.py (path:/tmp/pip-MS7pf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:38:02 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:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:38:02 INFO - Running setup.py (path:/tmp/pip-zzzuuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:38:02 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:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:38:02 INFO - Running setup.py (path:/tmp/pip-dlygmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:38:02 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:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:38:02 INFO - Running setup.py (path:/tmp/pip-_4iPsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:38:02 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:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:38:02 INFO - Running setup.py (path:/tmp/pip-6dZxtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:38:02 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:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:38:02 INFO - Running setup.py (path:/tmp/pip-1WRg7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:38:02 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:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:38:02 INFO - Running setup.py (path:/tmp/pip-WTg5n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:38:02 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:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:38:02 INFO - Running setup.py (path:/tmp/pip-SdC0hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:38:02 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:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:02 INFO - Running setup.py (path:/tmp/pip-dRm07J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:02 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:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:38:02 INFO - Running setup.py (path:/tmp/pip-oAtgD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:38:02 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:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:38:02 INFO - Running setup.py (path:/tmp/pip-KKwIaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:38:02 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:38:02 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:38:02 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:38:02 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:38:02 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:38:02 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:38:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:04 INFO - Downloading blessings-1.6.tar.gz 03:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:38:04 INFO - Installing collected packages: blessings 03:38:04 INFO - Running setup.py install for blessings 03:38:04 INFO - Successfully installed blessings 03:38:04 INFO - Cleaning up... 03:38:04 INFO - Return code: 0 03:38:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:38:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:38:05 INFO - Reading from file tmpfile_stdout 03:38:05 INFO - Current package versions: 03:38:05 INFO - argparse == 1.2.1 03:38:05 INFO - blessings == 1.6 03:38:05 INFO - blobuploader == 1.2.4 03:38:05 INFO - docopt == 0.6.1 03:38:05 INFO - manifestparser == 1.1 03:38:05 INFO - mozInstall == 1.12 03:38:05 INFO - mozcrash == 0.17 03:38:05 INFO - mozdebug == 0.1 03:38:05 INFO - mozdevice == 0.48 03:38:05 INFO - mozfile == 1.2 03:38:05 INFO - mozhttpd == 0.7 03:38:05 INFO - mozinfo == 0.9 03:38:05 INFO - mozleak == 0.1 03:38:05 INFO - mozlog == 3.1 03:38:05 INFO - moznetwork == 0.27 03:38:05 INFO - mozprocess == 0.22 03:38:05 INFO - mozprofile == 0.28 03:38:05 INFO - mozrunner == 6.11 03:38:05 INFO - mozscreenshot == 0.1 03:38:05 INFO - mozsystemmonitor == 0.0 03:38:05 INFO - moztest == 0.7 03:38:05 INFO - mozversion == 1.4 03:38:05 INFO - psutil == 3.1.1 03:38:05 INFO - requests == 1.2.3 03:38:05 INFO - wsgiref == 0.1.2 03:38:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:05 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 0x7fadda9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, '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 0x2656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26567a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', '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:38:05 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:38:05 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:38:05 INFO - Using env: {'DISPLAY': ':0', 03:38:05 INFO - 'HOME': '/home/cltbld', 03:38:05 INFO - 'LANG': 'en_US.UTF-8', 03:38:05 INFO - 'LANGUAGE': 'en_US:en', 03:38:05 INFO - 'LOGNAME': 'cltbld', 03:38:05 INFO - 'MAIL': '/var/mail/cltbld', 03:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:05 INFO - 'MOZ_NO_REMOTE': '1', 03:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:05 INFO - 'NO_EM_RESTART': '1', 03:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:05 INFO - 'PWD': '/builds/slave/test', 03:38:05 INFO - 'SHELL': '/bin/bash', 03:38:05 INFO - 'SHLVL': '1', 03:38:05 INFO - 'TERM': 'linux', 03:38:05 INFO - 'TMOUT': '86400', 03:38:05 INFO - 'USER': 'cltbld', 03:38:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', 03:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:05 INFO - '_': '/tools/buildbot/bin/python'} 03:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:05 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:38:05 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:38:05 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:38:05 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:38:05 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:38:05 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:38:05 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:38:05 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:38:05 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:38:05 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:38:05 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:38:05 INFO - Cleaning up... 03:38:05 INFO - Return code: 0 03:38:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadda9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, '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 0x2656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26567a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', '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:38:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:38:05 INFO - Using env: {'DISPLAY': ':0', 03:38:05 INFO - 'HOME': '/home/cltbld', 03:38:05 INFO - 'LANG': 'en_US.UTF-8', 03:38:05 INFO - 'LANGUAGE': 'en_US:en', 03:38:05 INFO - 'LOGNAME': 'cltbld', 03:38:05 INFO - 'MAIL': '/var/mail/cltbld', 03:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:05 INFO - 'MOZ_NO_REMOTE': '1', 03:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:05 INFO - 'NO_EM_RESTART': '1', 03:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:05 INFO - 'PWD': '/builds/slave/test', 03:38:05 INFO - 'SHELL': '/bin/bash', 03:38:05 INFO - 'SHLVL': '1', 03:38:05 INFO - 'TERM': 'linux', 03:38:05 INFO - 'TMOUT': '86400', 03:38:05 INFO - 'USER': 'cltbld', 03:38:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', 03:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:05 INFO - '_': '/tools/buildbot/bin/python'} 03:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:05 INFO - Downloading/unpacking jsonschema 03:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:38:07 INFO - Downloading/unpacking functools32 (from jsonschema) 03:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:07 INFO - Downloading functools32-3.2.3-2.tar.gz 03:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:38:07 INFO - warning: no files found matching '*.txt' 03:38:07 INFO - no previously-included directories found matching 'build' 03:38:07 INFO - no previously-included directories found matching 'dist' 03:38:07 INFO - no previously-included directories found matching '.git*' 03:38:07 INFO - Installing collected packages: jsonschema, functools32 03:38:07 INFO - Running setup.py install for functools32 03:38:07 INFO - warning: no files found matching '*.txt' 03:38:07 INFO - no previously-included directories found matching 'build' 03:38:07 INFO - no previously-included directories found matching 'dist' 03:38:07 INFO - no previously-included directories found matching '.git*' 03:38:07 INFO - Successfully installed jsonschema functools32 03:38:07 INFO - Cleaning up... 03:38:07 INFO - Return code: 0 03:38:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:38: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:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadda9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, '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 0x2656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26567a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', '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:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:38:07 INFO - Using env: {'DISPLAY': ':0', 03:38:07 INFO - 'HOME': '/home/cltbld', 03:38:07 INFO - 'LANG': 'en_US.UTF-8', 03:38:07 INFO - 'LANGUAGE': 'en_US:en', 03:38:07 INFO - 'LOGNAME': 'cltbld', 03:38:07 INFO - 'MAIL': '/var/mail/cltbld', 03:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:07 INFO - 'MOZ_NO_REMOTE': '1', 03:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:07 INFO - 'NO_EM_RESTART': '1', 03:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:07 INFO - 'PWD': '/builds/slave/test', 03:38:07 INFO - 'SHELL': '/bin/bash', 03:38:07 INFO - 'SHLVL': '1', 03:38:07 INFO - 'TERM': 'linux', 03:38:07 INFO - 'TMOUT': '86400', 03:38:07 INFO - 'USER': 'cltbld', 03:38:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', 03:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:07 INFO - '_': '/tools/buildbot/bin/python'} 03:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:08 INFO - Downloading/unpacking flake8 03:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:38:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:38:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:38:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:38:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:38:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:38:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:38:10 INFO - no previously-included directories found matching 'docs/_build' 03:38:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:38:10 INFO - Running setup.py install for pep8 03:38:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:38:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:38:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:38:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:38:10 INFO - no previously-included directories found matching 'docs/_build' 03:38:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:38:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:38:10 INFO - Cleaning up... 03:38:11 INFO - Return code: 0 03:38:11 INFO - Running post-action listener: _resource_record_post_action 03:38:11 INFO - Running post-action listener: _start_resource_monitoring 03:38:11 INFO - Starting resource monitoring. 03:38:11 INFO - ##### 03:38:11 INFO - ##### Running install step. 03:38:11 INFO - ##### 03:38:11 INFO - Running pre-action listener: _resource_record_pre_action 03:38:11 INFO - Running main action method: install 03:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:38:11 INFO - Reading from file tmpfile_stdout 03:38:11 INFO - Detecting whether we're running mozinstall >=1.0... 03:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:38:11 INFO - Reading from file tmpfile_stdout 03:38:11 INFO - Output received: 03:38:11 INFO - Usage: mozinstall [options] installer 03:38:11 INFO - Options: 03:38:11 INFO - -h, --help show this help message and exit 03:38:11 INFO - -d DEST, --destination=DEST 03:38:11 INFO - Directory to install application into. [default: 03:38:11 INFO - "/builds/slave/test"] 03:38:11 INFO - --app=APP Application being installed. [default: firefox] 03:38:11 INFO - mkdir: /builds/slave/test/build/application 03:38:11 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:38:11 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:38:26 INFO - Reading from file tmpfile_stdout 03:38:26 INFO - Output received: 03:38:26 INFO - /builds/slave/test/build/application/firefox/firefox 03:38:26 INFO - Running post-action listener: _resource_record_post_action 03:38:26 INFO - ##### 03:38:26 INFO - ##### Running run-tests step. 03:38:26 INFO - ##### 03:38:26 INFO - Running pre-action listener: _resource_record_pre_action 03:38:26 INFO - Running main action method: run_tests 03:38:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:38:26 INFO - Python 2.7.3 03:38:26 INFO - Return code: 0 03:38:26 INFO - grabbing minidump binary from tooltool 03:38:26 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:38:26 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 0x2655410>, '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 0x2656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26567a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:38:26 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:38:26 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:38:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:38:27 INFO - Return code: 0 03:38:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:38:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:38:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:38:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:38:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:38:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:38:27 INFO - Return code: 0 03:38:27 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-e10s', '--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-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:38:27 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-e10s --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-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:38:27 INFO - Using env: {'DISPLAY': ':0', 03:38:27 INFO - 'HOME': '/home/cltbld', 03:38:27 INFO - 'LANG': 'en_US.UTF-8', 03:38:27 INFO - 'LANGUAGE': 'en_US:en', 03:38:27 INFO - 'LOGNAME': 'cltbld', 03:38:27 INFO - 'MAIL': '/var/mail/cltbld', 03:38:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:38:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:27 INFO - 'MOZ_NO_REMOTE': '1', 03:38:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:38:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:27 INFO - 'NO_EM_RESTART': '1', 03:38:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:27 INFO - 'PWD': '/builds/slave/test', 03:38:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:38:27 INFO - 'SHELL': '/bin/bash', 03:38:27 INFO - 'SHLVL': '1', 03:38:27 INFO - 'TERM': 'linux', 03:38:27 INFO - 'TMOUT': '86400', 03:38:27 INFO - 'USER': 'cltbld', 03:38:27 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895', 03:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:27 INFO - '_': '/tools/buildbot/bin/python'} 03:38:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--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-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:38:28 INFO - mozversion application_buildid: 20160525183450 03:38:28 INFO - mozversion application_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:38:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:38:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:38:28 INFO - mozversion application_name: Firefox 03:38:28 INFO - mozversion application_remotingname: firefox-dev 03:38:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:38:28 INFO - mozversion application_vendor: Mozilla 03:38:28 INFO - mozversion application_version: 48.0a2 03:38:28 INFO - mozversion platform_buildid: 20160525183450 03:38:28 INFO - mozversion platform_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:38:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:38:28 INFO - mozversion platform_version: 48.0a2 03:38:28 INFO - using testdate: 1464431908 03:38:28 INFO - actual date: 1464431908 03:38:28 INFO - starting webserver on 'localhost:56663' 03:38:28 INFO - SUITE-START | Running 2 tests 03:38:28 INFO - TEST-START | dromaeo_css 03:38:28 INFO - operating with platform_type : linux_ 03:38:28 INFO - Initialising browser for dromaeo_css test... 03:38:28 INFO - TEST-INFO | started process 20007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU3jXXg/profile http://localhost:56663/getInfo.html) 03:38:31 INFO - PROCESS | 20007 | 03:38:31 INFO - PROCESS | 20007 | (process:20084): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:38:32 INFO - PROCESS | 20007 | __metrics Screen width/height:1600/1200 03:38:32 INFO - PROCESS | 20007 | colorDepth:24 03:38:32 INFO - PROCESS | 20007 | Browser inner width/height: 1024/697 03:38:32 INFO - PROCESS | 20007 | __metrics 03:38:33 ERROR - PROCESS | 20007 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:38:34 INFO - TEST-INFO | 20007: exit 0 03:38:34 INFO - Browser initialized. 03:38:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:38:34 INFO - TEST-INFO | started process 20135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU3jXXg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:36 INFO - PROCESS | 20135 | 03:38:36 INFO - PROCESS | 20135 | (process:20206): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:38:46 INFO - PROCESS | 20135 | RSS: Main: 152240128 03:38:46 INFO - PROCESS | 20135 | 03:39:35 INFO - PROCESS | 20135 | 1464431975589 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:41:43 INFO - PROCESS | 20135 | Cycle 1(1): loaded http://localhost:56663/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56663/tests/dromaeo/cssquery-ext.html) 03:41:44 INFO - PROCESS | 20135 | RSS: Main: 155586560 03:41:44 INFO - PROCESS | 20135 | 03:44:46 INFO - PROCESS | 20135 | Cycle 1(1): loaded http://localhost:56663/tests/dromaeo/cssquery-ext.html (next: http://localhost:56663/tests/dromaeo/cssquery-jquery.html) 03:44:46 INFO - PROCESS | 20135 | RSS: Main: 153911296 03:44:46 INFO - PROCESS | 20135 | 03:47:48 INFO - PROCESS | 20135 | Cycle 1(1): loaded http://localhost:56663/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56663/tests/dromaeo/cssquery-mootools.html) 03:47:48 INFO - PROCESS | 20135 | RSS: Main: 153272320 03:47:48 INFO - PROCESS | 20135 | 03:50:50 INFO - PROCESS | 20135 | Cycle 1(1): loaded http://localhost:56663/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56663/tests/dromaeo/cssquery-prototype.html) 03:50:51 INFO - PROCESS | 20135 | RSS: Main: 153120768 03:50:51 INFO - PROCESS | 20135 | 03:53:53 INFO - PROCESS | 20135 | Cycle 1(1): loaded http://localhost:56663/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56663/tests/dromaeo/cssquery-yui.html) 03:53:54 INFO - PROCESS | 20135 | RSS: Main: 154570752 03:53:54 INFO - PROCESS | 20135 | 03:56:56 INFO - PROCESS | 20135 | Cycle 1(1): loaded http://localhost:56663/tests/dromaeo/cssquery-yui.html (next: http://localhost:56663/tests/dromaeo/cssquery-dojo.html) 03:56:56 INFO - PROCESS | 20135 | RSS: Main: 155467776 03:56:56 INFO - PROCESS | 20135 | 03:56:56 INFO - PROCESS | 20135 | __start_tp_report 03:56:56 INFO - PROCESS | 20135 | _x_x_mozilla_page_load 03:56:56 INFO - PROCESS | 20135 | _x_x_mozilla_page_load_details 03:56:56 INFO - PROCESS | 20135 | |i|pagename|runs| 03:56:56 INFO - PROCESS | 20135 | |0;dojo.html;3394.1005633507116;3443.690067893889;3446.0523356077083;3474.652534746524;3483.773554718943;5712.171735098408;5731.942680573193;5733.942660573393;5738.626989245701;5760.0783874580075;5726.198332233491;5835.708214589275;5838.2702162229725;5839.007368747312;5839.620424672394;5266.447023062571;5306.416294207634;5317.867053323678;5318.2554442377905;5336.439673834249;5126.333576635032;5224.164133738603;5252.65857719247;5342.599305052117;5371.221172929922;5192.013517431676;5197.350331208599;5217.86955326118;5302.496262855042;5307.097793375136;5308.708021058859;5312.07038768214;5315.574754019669;5316.946830531684;5329.6002799789785;5220.425753167148;5225.764840582183;5239.607029472805;5296.073187192264;5296.126139187029;5551.944480555224;5655.236543066716;5703.5152012079025;5710.229119068914;5722.227499287585;6038.547108966801;6064.575479716422;6075.270967483886;6082.1789058477425;6082.482988945945;6008.128821320884;6127.662978536178;6135.110408990671;6139.355367686418;6142.570020098595;5713.514351280146;5771.336296325934;5778.913316300259;5786.189933409326;5844.649321040709;6249.125122482856;6268.4671802896355;6277.623342599459;6303.527235457359;6309.432151106423;6030.939690603125;6058.333583305833;6065.787697430569;6067.089936509559;6070.514358851369;6170.81487555374;6206.435786723651;6220.688965551704;6224.502039836892;6231.532635052389;6137.84655383619;6182.536309776785;6182.814515564541;6189.690515474298;6196.8760624787255;5976.312724036705;6123.724432400552;6138.549551575073;6186.288576813634;6190.1952746142715;4650.046740418206;4653.674242802971;4657.953420465819;4663.160631086369;4711;4199.139176468817;4219.493660760729;4223.767692776927;4230.407742915994;4260.957390426056;5956.344802071769;6007.399260074045;6028.879422411527;6069.848253793602;6111.297200821873;6125.998614523584;6132.325444201134;6155.353687862799;6176.320604733476;6212.751489940442;5939.020061689859;5944.583879128506;5946.821595352147;5948.851278718067;5951.196588460589;5182.352205974254;5230.633855630145;5264.052470555337;5279.656822306538;5297.708626025528;6214.161088253028;6263.4362907338555;6267.749290028348;6280.937190628127;6292.590981586182;6034.63792172471;6082.878342433215;6088.360722124113;6093.756249750138;6097.664628445478;6133.2428548619655;6201.937980620136;6222.782202623068;6251.437370636664;6257.843553911007;6064.545159113172;6069.757209711739;6070.0591408331775;6086.17861935281;6095.603785753912;6095.664738439428;6122.337112246169;6166.229221347332;6171.938280617136;6211.875762484635;6119.908201377072;6143.477804386677;6147.047207682637;6156;6156.353582873913;6089.955753753899;6104.969475152596;6116.938830611637;6118.143459915526;6136.32500424944;5738.22533957927;5799.217105690846;5916.171735957056;5974.342822289458;6000;6050.364711705383;6051.909221361771;6083.087536869505;6099.695015249131;6117.296510901303;5939.554533410098;5943.108533719977;5949.3753155918;5962.940370596239;5970.373110823475 03:56:56 INFO - PROCESS | 20135 | |1;ext.html;610.1397030187434;646.7865604350565;661.2461793555347;670.3363669966734;672.6872004517901;39286;39950.2009959801;40125;40196.59803401965;40303.59696403035;42926.35610465846;43541.56458435415;43626.78186609071;43703.78148109263;43831.34252986208;8865.202131808152;8979.102089791002;8999.685011024616;9023;9037.774055648628;8767.56162191891;8836;8877.51173685447;9071.863922041175;9101.726948191532;9032.819343613124;9087.091290870927;9112.45325280482;9119.63521459144;9147.359684822066;9028.277737780962;9070.365074444791;9072.682456114037;9073.954630226839;9074.954625226897;8883.644654213824;9061.41100828444;9108.043655416152;9108.089191080906;9114.225290850285;44342.33486497705;44825.77587112044;44886.55113448857;44898.32652510215;44971.32543011857;3808.8286027128847;3950.6839452843706;3979.064919743858;4448.733076015417;4587.518310577375;33772;34057.82971085153;34221.657783422095;34273.31453370943;34426.82786586076;4515.390422292981;4582.381378513891;4594.19601569724;4608.4700259470255;4668.6731928765;303253;305747;307133;308912;309807;62468.68765656143;62587;62844;62864;62894.37105628977;70867.64566177136;71645.6417717908;72364.63817680984;72493.637531812;72736.63631681913;18035.549111272325;18145.546361341072;18185.545361366072;18249.543761406072;18268;13423.3959471824;13485.730285394236;13510.324483775772;13536.255505947267;13564.660883477993;20253.987300634908;20338.593228135356;20467.07898144587;20476.488087797625;20993.790062099488;7729.652165652559;7765.495242809199;7841.274919517697;7974.84050319002;8011.238932301422;1098.5736421788765;1157.8436911017072;1200.7058270723553;1229.5204870100667;1229.9791173326118;31109.533356999662;31160.53259201114;31616.683833161835;31681.84159079236;32297.838510807294;1229.9077569182348;1248.7502499500135;1258.7922992706285;1324.3065219867485;1333.8055357418928;16493.835061649468;16557.668846623;16631.91684041596;16776.748348774778;17031.233594488276;515246;857709;879945;890553;915883;64231.67884160643;65011;65046;65320.673396632716;65588;1551.7905082813902;1553.0448774003905;1558.6493039066347;1567.3182165757933;1572.4339237874356;34620;34838.47742283918;35191.29617407689;35278.29443411169;35544.82227588846;57591.712041439525;58540;58633.70683146557;58640;58833.70583147228;475669;476964;478874;480358;480359;30648.080557583307;30768.076957691304;31293.530597041517;31318.217044573157;31628.209294767814;52422.21366679579;52758.2086268714;52867.47132528626;53112.203316949504;53305.4669453316;42372.15255694807;42466.78766606147;42542;43483.56516434795;44153.77923110364;43470;43904;44401.77799110984;44620.12515169534;45049.324260135465;44740.10519789521;45385.319220211066;45523;45803.54196457993;46158;36212.09469763277;36539;37305.81347093247;38119;38219.42670859995;30164.84917575398;30275.545866812456;30585.23536911595;30791.2302192447;30980.845095774377 03:56:56 INFO - PROCESS | 20135 | |2;jquery.html;418.822000649724;423.35227102533133;428.8756260684398;430.43612867144043;436.57652077484846;14437.350319235633;18397.540061498454;19157.137928793203;19161.616767664655;19464.90267548664;17065.40271090512;17322.653546929054;17325.91337043313;18042.5489362766;18325.358612448566;5622.32532096149;5632.957902787977;5853.824385268427;5876.236089308405;5901.026330655437;5688.2605261315975;5756.597038207327;5808.912866307009;5814.941850581504;5835.241418615574;5641.915371269434;5824.417558244184;5834.883302333951;5848.941510584904;5867;5760.395158508338;5801.477866991991;5833.212516310286;5840.445157710032;5846.181534585162;5078.060558796635;5197.532222100029;5197.922031169535;5244.423113457517;5252.028374750684;22627.88686056559;23365;23401.88299058511;23510.177143799883;23617.88191059034;2462.7167875694167;2560.5519034168947;2581.2127301173136;2792.3158826087533;3040.148758347666;14207.644808879757;14307.928460357736;14371.425142994267;14822.481213157487;14976.101433914;2034.4201902457876;2077.1172251792927;2084.8644838085474;2128.9254876079262;2148.2481131603813;74496.25503744947;76151.61924190399;76373.61813190898;76796.23203767947;77015.22385821085;10713.089387402159;11018.11855051594;11129.888701113046;11282.774344513064;11394.430278486043;15219.467318643794;15334.539963801104;15423.688986436055;15436.15101169424;15459.92270038665;8015.078265999368;8365.1216622255;8395.95802020986;8540.402171848034;8580.399372043898;8456.06983231844;8480.830383392298;8535.658573657109;8545;8604.053554109043;4554.157480866051;4595.655325850575;4650.348951146842;4669.976650116796;4702.177119004161;1998.6802111662064;2016.385002574229;2019.6970454431953;2031.5327474680905;2037.1156680071172;1087.276960821061;1107.5071593141136;1134.393099691661;1138.7551676389617;1139.4245905817509;18386.080695965415;19119.235230590897;19396.4181074568;19533.609327813647;19908;1049.3913530152493;1081.6700906223678;1097.5280629329304;1099.6755956992706;1100.6367898593444;10721.195910306758;11154.888451115547;11166.441677916071;11183.944080279709;11273.154513411528;441056;444620;485639;518282;518757;88965.55517222502;98194.5090274544;98261;101262.4936875311;101415.49292253492;1067.3755852826184;1068.4550879051585;1099.7470581766238;1107.6621630402644;1108.706192858893;17203.3978810746;17256.482305530855;17394.73907891408;17402.825971740625;17479.650406992045;28572.714272857007;41352.58647413487;41668.58331416647;41916;42350;60566.697166513884;60727.392726072176;60875.391246088744;61090;61661;8860.601272942604;8950.955245223733;8957.776055598662;9014.368994170345;9125.589348479467;11055.613053543088;13256.602301930572;13388.598342049754;13404.463821447032;13552.59342219735;10728.89271107279;11815.881841181477;11849.526018959144;12007.81988270194;12113;10964.451777411257;11101.000909918146;11495.77008459843;11727.41362931833;11922.76154476923;11792.469338879942;12170.45232964501;12230;12300.81548776787;12306.75386492283;8686.218240358397;8798.912010879809;8883.73348799537;8946.239569636653;8971.596278167628;11657.475413606579;11675.941620292184;11707.239029463057;11997.160198786001;12207.938960305497 03:56:56 INFO - PROCESS | 20135 | |3;mootools.html;1559.3840433028952;1566.6553358261183;1763.497403240076;1822.8450581700554;1851.1669748613128;7365.042544469225;7970.681172753098;8083.676652933883;8339.374546908983;8340.499570025802;7836.647350869211;7901.565413902233;7915.643796029178;7976.2821346078845;7981.361491080714;2285.542891421718;2328.0338659456306;2329.359426157812;2332.125452955142;2334.719833619968;2317.5480781247666;2338.0414030247603;2353.388119089032;2358.1039205102124;2368.86971216583;2268.4555706630454;2276.5105502316997;2291.3927809130596;2300.9884950575224;2304.665823455598;2303.5968705476475;2361.515889242701;2366;2372.1697405907967;2376.1802178248477;2301.0680674326923;2317.7450480447137;2319.478117423583;2325.3140323604575;2331.895064722092;8026.7591972240925;8053.718119865776;8084.7574572762915;8085.312748416332;8090.231428014329;5034.647574669774;5159.948400515985;5173.198154286091;5174.508421699932;5192.844214673566;3260.934781304384;3331.4503106987318;3352.430086885211;3365.074604483762;3375.729941604666;1047.36634336227;1052.899974502421;1112.9443527823576;1115.776844631069;1121.8990290873778;11405.771884562346;11436.256643318158;11436.599719009795;11449.542018319256;11470.598529051444;4500.797464114123;4587.128445595326;4648.163330600524;4661.137689527448;4664.743439110814;9900.108990190918;9929.553170107363;9950.900490995142;9951.15415189717;9962.551685174185;5165.741712914414;5215.7913683453;5221.712805795718;5222.97388513055;5223.582113430916;4164.8125834337525;4645.907081858344;4672.859814205579;4677.4854765975715;4789.042191561702;3959.9802000990385;3997.320455522568;4013.13717550728;4044.716869819143;4091.672666186698;1320.584016034946;1328.2030781531005;1332.140769203858;1332.593558964525;1342.7583035053783;915.1946287267162;1035.880873699519;1054.625607909181;1054.9050585447194;1056.3292309383596;5763.423657634203;5781.248437703156;5785.652860828363;5880.7353669085;5977.910331345033;1030.9793804123876;1033.6640591807693;1066.1364294921138;1077.1329080090602;1090.5256213547132;3904.8047597620007;3924.156306394139;3943.211357728466;3967.206558688274;3999.6400323970984;9826.754331141636;10086.697399078039;10212.08091271789;10213.846792298122;10254.794904102026;9971;9986.950065249772;9994.800103997879;10019.998000199921;10081.042300981395;7616.543007419573;7683.1548529661695;7729.768106956801;8023.277904988579;8027.5584842834205;5623.915641265303;5675.943240567707;5743.1385292206505;5761.337446193741;5860.706964651836;8585.313174945864;8778.122187781171;8929.598168082322;8944.463332200088;9145.634174633205;8947.686830961145;8981.730548083307;9050.683226087056;9070.954645226731;9138.725838224864;6783.762568310085;7071.681774320271;7319.8536029280185;7376.926230737624;7403.259674032553;7842.490238134503;7848.175941526058;7864.134945156143;7865.685372585262;7895.84208315819;6833.350831670983;6871.553349032297;7053.153621565445;7082.256363081802;7185.640717964186;7013.649317534205;7043.683034263573;7109.395701365442;7136.678849451683;7188.029616001772;6582.17722784652;6690.765823196165;6718.865622687616;6726.6972986216715;6798.354156355138;5010.3737032870895;5029.270755740324;5030.547250747451;5102.158143906214;5163.27714120016;4993.15116430215;4999.500049994971;5029.850373441852;5035.5719763819025;5138.614603904647 03:56:56 INFO - PROCESS | 20135 | |4;prototype.html;347.199704680711;356.3745626425623;356.819805997971;358.32455820777824;359.05926472641664;6635.66821658917;6729.461643068555;6855.143107111611;6874.72501099956;6876.690548925298;6682.832929176773;6684.665766711657;6740.52816302859;6741.292164322749;6772.966135169329;4829.9275510867365;4993.700377977315;5004.324416203821;5004.674696144757;5014.147594908856;4955.801767929279;4968.950310496903;4976.601871850261;4976.800927962877;4976.975115124419;4864.7324397158145;4869.561739443449;4874.561289483946;4877.317175595419;4906.337644418011;4888.291197776321;4889.291052797343;4932.999999999982;4954.009198160346;4965.081459929925;4277.465316835395;4278.700490965633;4297.39836422901;4303.246931786956;4309.332053531708;6385.4253117219205;6393.776217832354;6429.292777794439;6444.097826304321;6447.0651755495655;5697.316322041382;5809.04150815115;5816.389279125673;5820.068788993783;5821.67980761058;6978.895316570205;7009.08881845362;7042.084529011247;7044.929550704479;7057.258987806258;4765.809367625291;4782.473927867932;4789.80840766369;4792.0895029944195;4797.208460604031;7303.415726741848;7341.412686985082;7368.336849683501;7383.593902335369;7405.370543503863;4832.220047023665;4909.828156014522;4912.6561140719805;4918.262260660929;4925.532074452921;4878.82924097662;4972.776225069881;4982.850514484571;4989.151844186497;4989.90020199594;5750.827475175752;5774.653520788766;5781.1328300754385;5803.622764520377;5805.303363596311;7094.92905070953;7096.53872498286;7102.112235970504;7106.14726232845;7115.644217789089;1736.0625262358185;1753.509017475109;1754.026515284004;1756.6925787987307;1762.171779263744;1084.219362059316;1109.517359948425;1137.4312843578211;1146.2835727670206;1146.6674664347245;6895.034695142684;6896.344847239504;6896.862062758817;6904.4821638377325;6915.792526224222;7300.707971681073;7363.932229826645;7381.852362952818;7392.96303518479;7393.852122957511;6580.736770529125;6752.324767523307;6827.726890924407;6870.27862074475;6883.793486195422;3977.284088864032;3989.3417586097967;4005.5794141615293;4007.2987227235117;4017.8593749218635;7671.462997590115;7677.539347639159;7680.615969201517;7683;7700.653470593837;7505.6997720090585;7535.284148005931;7542.434317426215;7549.01862757838;7550.697972081055;7397.593132377663;7614.619269036526;7624.885626715603;7677.76966690989;7731;7440;7454;7467.701291948479;7470.850582988419;7474.476786624884;7345.669444874887;7356.080489938758;7358.227386124594;7363.042804435389;7363.631818409165;7701.152873183833;7702.845943081219;7725.652345644572;7748.961255193688;7750.496217745828;4735.644826637947;4866.780994855169;4874;4895.339129217653;4914.483979182134;7244.384227340735;7288.416926645961;7323.084614423197;7332.0834895638045;7357.3746231568775;7092.468064895051;7133.3936615388275;7136.4290856730295;7140.7143714252925;7149.499535032498;7070.505064645631;7099.325564071405;7102.07673002527;7113.893291600527;7121.003059571561;6825.829354266183;6968.79093627192;6995.650217489004;6997.335253150943;7011.614361210182;7148.213696493278;7172.282771722786;7174.641267936478;7178.5692858428665;7185.389241914496;6983.1620205575655;6991.510594258353;6996.860062798817;7007.509474336747;7020.333068358498 03:56:56 INFO - PROCESS | 20135 | |5;yui.html;791.9960400197999;795.8249185179262;869.3002133282707;879.1999280654602;897.0401670212875;13310.600681979531;13489.595312140627;13536;13556.796648050287;13609.591712248635;13607.591772246824;13649.863501364984;13658.521951731667;13683.315834208299;13751.174929504237;742.5655991245114;851.1998721202082;864.1099667342647;878.661715239631;879.1823604048233;883.1257055515058;887.8934527856634;888.2361169394316;890.9465432074064;892.5849479991803;938.7559234598986;942.1897168435174;942.9339946203734;943.627267229444;945.229637845154;942.4298299528755;943.03810113684;943.8301105800988;944.2304521814767;945.6595625574788;685.5749435350115;685.6880119545594;690.775497963164;692.62944324786;695.4471195399669;14289.857101428957;14294.785578216335;14310.427582896671;14359.138451692932;14397.424103035866;13960.162390256617;14231.573052808433;14729;14738;14863;11295.152863535268;11363.14776391774;11958.880411195863;12008.519659213709;12220.266783992989;4624.630029597658;4676.859694209179;4760.857174284777;4783.497732738082;4867.8783030424165;56861.71569142169;58535.707321463546;59222.40777592212;60490.39509604935;60558;11496.77006459866;11540.596079137189;11589;11658.941705291589;11750.588729394602;19872.403827885188;20303.796962030487;20365.287214947406;20494.692579611317;20526.589468210554;8336.958315208385;8574.699885503978;8722.956385218033;8785.736427907173;8842.33682473817;4813.181759100961;5016.135368030625;5059.595232381401;5116.386033675908;5135.281060651511;3438.3123375325035;3485.4423292273113;3488.075659950115;3495.0912762681887;3497.178163131662;673.4343151752552;676.0163961436099;676.5602358466938;678.8811957907346;679.609224695792;763.7937756805743;794.5431376958272;800.1438460846954;812.8455593437228;832.7959649885817;10139.898601014043;10208.336458130198;10219.335743176669;10290.588376464857;10481.842772358421;696.9825754356182;760.866848301545;768.4620765464198;772.1814876231213;804.9034115906129;4628.606568441653;4746.572808447257;4826.831060912851;4837.879053023632;4883.877903052452;63021.05468417978;64515.354846451875;67066;67594.32405675978;68006.65996669985;56951.715241423524;57697.711511442176;58606.706966464895;58658.7067064662;58790.706046470346;50900.49099509032;51944;52759.472405276225;52835.73582132142;53391.19913201305;9488.762780930532;9658.855117173389;9750;9774.12032917041;9841.950790246003;40036.39945400763;40248.1950360997;40571;40675;41165;49130;50486;50642.49357506525;50973.7451312741;52360.738196308776;10664.253502254767;10822.458877055959;11184.328940263611;11240.213185076966;11537.365444900612;12626.747465050465;12732.299723515296;12774;12960.092793504742;13379.331033448094;12132.211406258564;12358.44387002605;12477.625671229878;12737.745245095231;12753.61739147827;12460.937695311466;12493.375331233221;12643.494260229489;13111.541096061592;13690.726185476036;12028.819567706316;12464.501419943463;13741.793873091712;13960.720785584028;14154.292285385896;10751.731206719582;10923.726906827393;11219.439028048402;11235.213535052795;11378.658640240476;11518.020968217796;11660.825087623523;11847.348395838311;11966.102542309187;12026.879731202576 03:56:56 INFO - PROCESS | 20135 | __end_tp_report 03:56:56 INFO - PROCESS | 20135 | __start_cc_report 03:56:56 INFO - PROCESS | 20135 | _x_x_mozilla_cycle_collect,339 03:56:56 INFO - PROCESS | 20135 | __end_cc_report 03:56:56 INFO - PROCESS | 20135 | __startTimestamp1464433016662__endTimestamp 03:56:56 INFO - PROCESS | 20135 | 03:56:56 INFO - PROCESS | 20135 | ------- Summary: start ------- 03:56:56 INFO - PROCESS | 20135 | Number of tests: 6 03:56:56 INFO - PROCESS | 20135 | 03:56:56 INFO - PROCESS | 20135 | [#0] dojo.html Cycles:165 Average:5730.82 Median:6007.40 stddev:628.57 (10.5%) stddev-sans-first:603.17 03:56:56 INFO - PROCESS | 20135 | Values: 3394.1 3443.7 3446.1 3474.7 3483.8 5712.2 5731.9 5733.9 5738.6 5760.1 5726.2 5835.7 5838.3 5839.0 5839.6 5266.4 5306.4 5317.9 5318.3 5336.4 5126.3 5224.2 5252.7 5342.6 5371.2 5192.0 5197.4 5217.9 5302.5 5307.1 5308.7 5312.1 5315.6 5316.9 5329.6 5220.4 5225.8 5239.6 5296.1 5296.1 5551.9 5655.2 5703.5 5710.2 5722.2 6038.5 6064.6 6075.3 6082.2 6082.5 6008.1 6127.7 6135.1 6139.4 6142.6 5713.5 5771.3 5778.9 5786.2 5844.6 6249.1 6268.5 6277.6 6303.5 6309.4 6030.9 6058.3 6065.8 6067.1 6070.5 6170.8 6206.4 6220.7 6224.5 6231.5 6137.8 6182.5 6182.8 6189.7 6196.9 5976.3 6123.7 6138.5 6186.3 6190.2 4650.0 4653.7 4658.0 4663.2 4711.0 4199.1 4219.5 4223.8 4230.4 4261.0 5956.3 6007.4 6028.9 6069.8 6111.3 6126.0 6132.3 6155.4 6176.3 6212.8 5939.0 5944.6 5946.8 5948.9 5951.2 5182.4 5230.6 5264.1 5279.7 5297.7 6214.2 6263.4 6267.7 6280.9 6292.6 6034.6 6082.9 6088.4 6093.8 6097.7 6133.2 6201.9 6222.8 6251.4 6257.8 6064.5 6069.8 6070.1 6086.2 6095.6 6095.7 6122.3 6166.2 6171.9 6211.9 6119.9 6143.5 6147.0 6156.0 6156.4 6090.0 6105.0 6116.9 6118.1 6136.3 5738.2 5799.2 5916.2 5974.3 6000.0 6050.4 6051.9 6083.1 6099.7 6117.3 5939.6 5943.1 5949.4 5962.9 5970.4 03:56:56 INFO - PROCESS | 20135 | 03:56:56 INFO - PROCESS | 20135 | [#1] ext.html Cycles:180 Average:69572.40 Median:44372.06 stddev:155866.34 (351.3%) stddev-sans-first:156217.58 03:56:56 INFO - PROCESS | 20135 | Values: 610.1 646.8 661.2 670.3 672.7 39286.0 39950.2 40125.0 40196.6 40303.6 42926.4 43541.6 43626.8 43703.8 43831.3 8865.2 8979.1 8999.7 9023.0 9037.8 8767.6 8836.0 8877.5 9071.9 9101.7 9032.8 9087.1 9112.5 9119.6 9147.4 9028.3 9070.4 9072.7 9074.0 9075.0 8883.6 9061.4 9108.0 9108.1 9114.2 44342.3 44825.8 44886.6 44898.3 44971.3 3808.8 3950.7 3979.1 4448.7 4587.5 33772.0 34057.8 34221.7 34273.3 34426.8 4515.4 4582.4 4594.2 4608.5 4668.7 303253.0 305747.0 307133.0 308912.0 309807.0 62468.7 62587.0 62844.0 62864.0 62894.4 70867.6 71645.6 72364.6 72493.6 72736.6 18035.5 18145.5 18185.5 18249.5 18268.0 13423.4 13485.7 13510.3 13536.3 13564.7 20254.0 20338.6 20467.1 20476.5 20993.8 7729.7 7765.5 7841.3 7974.8 8011.2 1098.6 1157.8 1200.7 1229.5 1230.0 31109.5 31160.5 31616.7 31681.8 32297.8 1229.9 1248.8 1258.8 1324.3 1333.8 16493.8 16557.7 16631.9 16776.7 17031.2 515246.0 857709.0 879945.0 890553.0 915883.0 64231.7 65011.0 65046.0 65320.7 65588.0 1551.8 1553.0 1558.6 1567.3 1572.4 34620.0 34838.5 35191.3 35278.3 35544.8 57591.7 58540.0 58633.7 58640.0 58833.7 475669.0 476964.0 478874.0 480358.0 480359.0 30648.1 30768.1 31293.5 31318.2 31628.2 52422.2 52758.2 52867.5 53112.2 53305.5 42372.2 42466.8 42542.0 43483.6 44153.8 43470.0 43904.0 44401.8 44620.1 45049.3 44740.1 45385.3 45523.0 45803.5 46158.0 36212.1 36539.0 37305.8 38119.0 38219.4 30164.8 30275.5 30585.2 30791.2 30980.8 03:56:56 INFO - PROCESS | 20135 | 03:56:56 INFO - PROCESS | 20135 | [#2] jquery.html Cycles:180 Average:28937.69 Median:2138.59 stddev:79704.00 (3726.9%) stddev-sans-first:79898.83 03:56:56 INFO - PROCESS | 20135 | Values: 418.8 423.4 428.9 430.4 436.6 14437.4 18397.5 19157.1 19161.6 19464.9 17065.4 17322.7 17325.9 18042.5 18325.4 5622.3 5633.0 5853.8 5876.2 5901.0 5688.3 5756.6 5808.9 5814.9 5835.2 5641.9 5824.4 5834.9 5848.9 5867.0 5760.4 5801.5 5833.2 5840.4 5846.2 5078.1 5197.5 5197.9 5244.4 5252.0 22627.9 23365.0 23401.9 23510.2 23617.9 2462.7 2560.6 2581.2 2792.3 3040.1 14207.6 14307.9 14371.4 14822.5 14976.1 2034.4 2077.1 2084.9 2128.9 2148.2 74496.3 76151.6 76373.6 76796.2 77015.2 10713.1 11018.1 11129.9 11282.8 11394.4 15219.5 15334.5 15423.7 15436.2 15459.9 8015.1 8365.1 8396.0 8540.4 8580.4 8456.1 8480.8 8535.7 8545.0 8604.1 4554.2 4595.7 4650.3 4670.0 4702.2 1998.7 2016.4 2019.7 2031.5 2037.1 1087.3 1107.5 1134.4 1138.8 1139.4 18386.1 19119.2 19396.4 19533.6 19908.0 1049.4 1081.7 1097.5 1099.7 1100.6 10721.2 11154.9 11166.4 11183.9 11273.2 441056.0 444620.0 485639.0 518282.0 518757.0 88965.6 98194.5 98261.0 101262.5 101415.5 1067.4 1068.5 1099.7 1107.7 1108.7 17203.4 17256.5 17394.7 17402.8 17479.7 28572.7 41352.6 41668.6 41916.0 42350.0 60566.7 60727.4 60875.4 61090.0 61661.0 8860.6 8951.0 8957.8 9014.4 9125.6 11055.6 13256.6 13388.6 13404.5 13552.6 10728.9 11815.9 11849.5 12007.8 12113.0 10964.5 11101.0 11495.8 11727.4 11922.8 11792.5 12170.5 12230.0 12300.8 12306.8 8686.2 8798.9 8883.7 8946.2 8971.6 11657.5 11675.9 11707.2 11997.2 12207.9 03:56:56 INFO - PROCESS | 20135 | 03:56:56 INFO - PROCESS | 20135 | [#3] mootools.html Cycles:180 Average:5486.20 Median:5032.60 stddev:2956.04 (58.7%) stddev-sans-first:2949.61 03:56:56 INFO - PROCESS | 20135 | Values: 1559.4 1566.7 1763.5 1822.8 1851.2 7365.0 7970.7 8083.7 8339.4 8340.5 7836.6 7901.6 7915.6 7976.3 7981.4 2285.5 2328.0 2329.4 2332.1 2334.7 2317.5 2338.0 2353.4 2358.1 2368.9 2268.5 2276.5 2291.4 2301.0 2304.7 2303.6 2361.5 2366.0 2372.2 2376.2 2301.1 2317.7 2319.5 2325.3 2331.9 8026.8 8053.7 8084.8 8085.3 8090.2 5034.6 5159.9 5173.2 5174.5 5192.8 3260.9 3331.5 3352.4 3365.1 3375.7 1047.4 1052.9 1112.9 1115.8 1121.9 11405.8 11436.3 11436.6 11449.5 11470.6 4500.8 4587.1 4648.2 4661.1 4664.7 9900.1 9929.6 9950.9 9951.2 9962.6 5165.7 5215.8 5221.7 5223.0 5223.6 4164.8 4645.9 4672.9 4677.5 4789.0 3960.0 3997.3 4013.1 4044.7 4091.7 1320.6 1328.2 1332.1 1332.6 1342.8 915.2 1035.9 1054.6 1054.9 1056.3 5763.4 5781.2 5785.7 5880.7 5977.9 1031.0 1033.7 1066.1 1077.1 1090.5 3904.8 3924.2 3943.2 3967.2 3999.6 9826.8 10086.7 10212.1 10213.8 10254.8 9971.0 9987.0 9994.8 10020.0 10081.0 7616.5 7683.2 7729.8 8023.3 8027.6 5623.9 5675.9 5743.1 5761.3 5860.7 8585.3 8778.1 8929.6 8944.5 9145.6 8947.7 8981.7 9050.7 9071.0 9138.7 6783.8 7071.7 7319.9 7376.9 7403.3 7842.5 7848.2 7864.1 7865.7 7895.8 6833.4 6871.6 7053.2 7082.3 7185.6 7013.6 7043.7 7109.4 7136.7 7188.0 6582.2 6690.8 6718.9 6726.7 6798.4 5010.4 5029.3 5030.5 5102.2 5163.3 4993.2 4999.5 5029.9 5035.6 5138.6 03:56:56 INFO - PROCESS | 20135 | 03:56:56 INFO - PROCESS | 20135 | [#4] prototype.html Cycles:180 Average:5913.25 Median:6841.43 stddev:1838.84 (26.9%) stddev-sans-first:1795.92 03:56:56 INFO - PROCESS | 20135 | Values: 347.2 356.4 356.8 358.3 359.1 6635.7 6729.5 6855.1 6874.7 6876.7 6682.8 6684.7 6740.5 6741.3 6773.0 4829.9 4993.7 5004.3 5004.7 5014.1 4955.8 4969.0 4976.6 4976.8 4977.0 4864.7 4869.6 4874.6 4877.3 4906.3 4888.3 4889.3 4933.0 4954.0 4965.1 4277.5 4278.7 4297.4 4303.2 4309.3 6385.4 6393.8 6429.3 6444.1 6447.1 5697.3 5809.0 5816.4 5820.1 5821.7 6978.9 7009.1 7042.1 7044.9 7057.3 4765.8 4782.5 4789.8 4792.1 4797.2 7303.4 7341.4 7368.3 7383.6 7405.4 4832.2 4909.8 4912.7 4918.3 4925.5 4878.8 4972.8 4982.9 4989.2 4989.9 5750.8 5774.7 5781.1 5803.6 5805.3 7094.9 7096.5 7102.1 7106.1 7115.6 1736.1 1753.5 1754.0 1756.7 1762.2 1084.2 1109.5 1137.4 1146.3 1146.7 6895.0 6896.3 6896.9 6904.5 6915.8 7300.7 7363.9 7381.9 7393.0 7393.9 6580.7 6752.3 6827.7 6870.3 6883.8 3977.3 3989.3 4005.6 4007.3 4017.9 7671.5 7677.5 7680.6 7683.0 7700.7 7505.7 7535.3 7542.4 7549.0 7550.7 7397.6 7614.6 7624.9 7677.8 7731.0 7440.0 7454.0 7467.7 7470.9 7474.5 7345.7 7356.1 7358.2 7363.0 7363.6 7701.2 7702.8 7725.7 7749.0 7750.5 4735.6 4866.8 4874.0 4895.3 4914.5 7244.4 7288.4 7323.1 7332.1 7357.4 7092.5 7133.4 7136.4 7140.7 7149.5 7070.5 7099.3 7102.1 7113.9 7121.0 6825.8 6968.8 6995.7 6997.3 7011.6 7148.2 7172.3 7174.6 7178.6 7185.4 6983.2 6991.5 6996.9 7007.5 7020.3 03:56:56 INFO - PROCESS | 20135 | 03:56:56 INFO - PROCESS | 20135 | [#5] yui.html Cycles:180 Average:15728.28 Median:4798.34 stddev:18448.69 (384.5%) stddev-sans-first:18466.34 03:56:56 INFO - PROCESS | 20135 | Values: 792.0 795.8 869.3 879.2 897.0 13310.6 13489.6 13536.0 13556.8 13609.6 13607.6 13649.9 13658.5 13683.3 13751.2 742.6 851.2 864.1 878.7 879.2 883.1 887.9 888.2 890.9 892.6 938.8 942.2 942.9 943.6 945.2 942.4 943.0 943.8 944.2 945.7 685.6 685.7 690.8 692.6 695.4 14289.9 14294.8 14310.4 14359.1 14397.4 13960.2 14231.6 14729.0 14738.0 14863.0 11295.2 11363.1 11958.9 12008.5 12220.3 4624.6 4676.9 4760.9 4783.5 4867.9 56861.7 58535.7 59222.4 60490.4 60558.0 11496.8 11540.6 11589.0 11658.9 11750.6 19872.4 20303.8 20365.3 20494.7 20526.6 8337.0 8574.7 8723.0 8785.7 8842.3 4813.2 5016.1 5059.6 5116.4 5135.3 3438.3 3485.4 3488.1 3495.1 3497.2 673.4 676.0 676.6 678.9 679.6 763.8 794.5 800.1 812.8 832.8 10139.9 10208.3 10219.3 10290.6 10481.8 697.0 760.9 768.5 772.2 804.9 4628.6 4746.6 4826.8 4837.9 4883.9 63021.1 64515.4 67066.0 67594.3 68006.7 56951.7 57697.7 58606.7 58658.7 58790.7 50900.5 51944.0 52759.5 52835.7 53391.2 9488.8 9658.9 9750.0 9774.1 9842.0 40036.4 40248.2 40571.0 40675.0 41165.0 49130.0 50486.0 50642.5 50973.7 52360.7 10664.3 10822.5 11184.3 11240.2 11537.4 12626.7 12732.3 12774.0 12960.1 13379.3 12132.2 12358.4 12477.6 12737.7 12753.6 12460.9 12493.4 12643.5 13111.5 13690.7 12028.8 12464.5 13741.8 13960.7 14154.3 10751.7 10923.7 11219.4 11235.2 11378.7 11518.0 11660.8 11847.3 11966.1 12026.9 03:56:56 INFO - PROCESS | 20135 | -------- Summary: end -------- 03:56:56 INFO - PROCESS | 20135 | 03:56:57 INFO - TEST-INFO | 20135: exit 0 03:56:57 INFO - TEST-OK | dromaeo_css | took 1109181ms 03:56:57 INFO - TEST-START | kraken 03:56:57 INFO - operating with platform_type : linux_ 03:56:57 INFO - Initialising browser for kraken test... 03:56:57 INFO - TEST-INFO | started process 20377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa1wmH5/profile http://localhost:56663/getInfo.html) 03:57:00 INFO - PROCESS | 20377 | 03:57:00 INFO - PROCESS | 20377 | (process:20453): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:57:01 INFO - PROCESS | 20377 | __metrics Screen width/height:1600/1200 03:57:01 INFO - PROCESS | 20377 | colorDepth:24 03:57:01 INFO - PROCESS | 20377 | Browser inner width/height: 1024/697 03:57:01 INFO - PROCESS | 20377 | __metrics 03:57:02 ERROR - PROCESS | 20377 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:57:03 INFO - TEST-INFO | 20377: exit 0 03:57:03 INFO - Browser initialized. 03:57:03 INFO - Running cycle 1/1 for kraken test... 03:57:03 INFO - TEST-INFO | started process 20504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa1wmH5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:57:05 INFO - PROCESS | 20504 | 03:57:05 INFO - PROCESS | 20504 | (process:20575): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:57:15 INFO - PROCESS | 20504 | RSS: Main: 152190976 03:57:15 INFO - PROCESS | 20504 | 03:57:17 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56663/tests/kraken/driver.html?testName=audio-beat-detection) 03:57:18 INFO - PROCESS | 20504 | RSS: Main: 157184000 03:57:18 INFO - PROCESS | 20504 | 03:57:21 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56663/tests/kraken/driver.html?testName=audio-dft) 03:57:21 INFO - PROCESS | 20504 | RSS: Main: 157147136 03:57:21 INFO - PROCESS | 20504 | 03:57:24 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56663/tests/kraken/driver.html?testName=audio-fft) 03:57:25 INFO - PROCESS | 20504 | RSS: Main: 157347840 03:57:25 INFO - PROCESS | 20504 | 03:57:27 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56663/tests/kraken/driver.html?testName=audio-oscillator) 03:57:27 INFO - PROCESS | 20504 | RSS: Main: 157286400 03:57:27 INFO - PROCESS | 20504 | 03:57:30 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56663/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:57:30 INFO - PROCESS | 20504 | RSS: Main: 157110272 03:57:30 INFO - PROCESS | 20504 | 03:57:33 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56663/tests/kraken/driver.html?testName=imaging-darkroom) 03:57:34 INFO - PROCESS | 20504 | RSS: Main: 157544448 03:57:34 INFO - PROCESS | 20504 | 03:57:37 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56663/tests/kraken/driver.html?testName=imaging-desaturate) 03:57:38 INFO - PROCESS | 20504 | RSS: Main: 157208576 03:57:38 INFO - PROCESS | 20504 | 03:57:41 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56663/tests/kraken/driver.html?testName=json-parse-financial) 03:57:41 INFO - PROCESS | 20504 | RSS: Main: 157913088 03:57:41 INFO - PROCESS | 20504 | 03:57:43 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56663/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:57:43 INFO - PROCESS | 20504 | RSS: Main: 157786112 03:57:43 INFO - PROCESS | 20504 | 03:57:45 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56663/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:57:46 INFO - PROCESS | 20504 | RSS: Main: 157839360 03:57:46 INFO - PROCESS | 20504 | 03:57:48 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56663/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:48 INFO - PROCESS | 20504 | RSS: Main: 157679616 03:57:48 INFO - PROCESS | 20504 | 03:57:51 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:51 INFO - PROCESS | 20504 | RSS: Main: 158154752 03:57:51 INFO - PROCESS | 20504 | 03:57:54 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:55 INFO - PROCESS | 20504 | RSS: Main: 157913088 03:57:55 INFO - PROCESS | 20504 | 03:57:56 INFO - PROCESS | 20504 | Cycle 1(1): loaded http://localhost:56663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56663/tests/kraken/driver.html?testName=ai-astar) 03:57:57 INFO - PROCESS | 20504 | RSS: Main: 159432704 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | __start_tp_report 03:57:57 INFO - PROCESS | 20504 | _x_x_mozilla_page_load 03:57:57 INFO - PROCESS | 20504 | _x_x_mozilla_page_load_details 03:57:57 INFO - PROCESS | 20504 | |i|pagename|runs| 03:57:57 INFO - PROCESS | 20504 | |0;ai-astar;109;110;103;110;113;110;102;110;112;113 03:57:57 INFO - PROCESS | 20504 | |1;audio-beat-detection;153;126;162;187;127;150;161;129;181;136 03:57:57 INFO - PROCESS | 20504 | |2;audio-dft;163;164;163;162;163;169;162;164;165;162 03:57:57 INFO - PROCESS | 20504 | |3;audio-fft;75;77;78;164;77;77;76;76;180;74 03:57:57 INFO - PROCESS | 20504 | |4;audio-oscillator;93;92;155;92;92;93;144;92;93;138 03:57:57 INFO - PROCESS | 20504 | |5;imaging-gaussian-blur;117;118;118;118;118;117;117;117;116;118 03:57:57 INFO - PROCESS | 20504 | |6;imaging-darkroom;147;148;147;146;145;147;146;154;148;147 03:57:57 INFO - PROCESS | 20504 | |7;imaging-desaturate;95;95;95;96;96;95;95;95;95;96 03:57:57 INFO - PROCESS | 20504 | |8;json-parse-financial;55;56;55;58;61;61;55;76;54;58 03:57:57 INFO - PROCESS | 20504 | |9;json-stringify-tinderbox;58;58;58;58;58;57;58;58;57;58 03:57:57 INFO - PROCESS | 20504 | |10;stanford-crypto-aes;82;74;80;74;78;75;75;77;77;76 03:57:57 INFO - PROCESS | 20504 | |11;stanford-crypto-ccm;123;114;114;118;123;124;133;113;141;130 03:57:57 INFO - PROCESS | 20504 | |12;stanford-crypto-pbkdf2;161;164;163;162;162;162;163;158;162;161 03:57:57 INFO - PROCESS | 20504 | |13;stanford-crypto-sha256-iterative;66;67;67;67;67;65;67;66;67;68 03:57:57 INFO - PROCESS | 20504 | __end_tp_report 03:57:57 INFO - PROCESS | 20504 | __start_cc_report 03:57:57 INFO - PROCESS | 20504 | _x_x_mozilla_cycle_collect,869 03:57:57 INFO - PROCESS | 20504 | __end_cc_report 03:57:57 INFO - PROCESS | 20504 | __startTimestamp1464433077230__endTimestamp 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | ------- Summary: start ------- 03:57:57 INFO - PROCESS | 20504 | Number of tests: 14 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:3.79 (3.4%) stddev-sans-first:4.02 03:57:57 INFO - PROCESS | 20504 | Values: 109.0 110.0 103.0 110.0 113.0 110.0 102.0 110.0 112.0 113.0 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:157.00 stddev:21.94 (14.0%) stddev-sans-first:23.26 03:57:57 INFO - PROCESS | 20504 | Values: 153.0 126.0 162.0 187.0 127.0 150.0 161.0 129.0 181.0 136.0 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.11 (1.3%) stddev-sans-first:2.22 03:57:57 INFO - PROCESS | 20504 | Values: 163.0 164.0 163.0 162.0 163.0 169.0 162.0 164.0 165.0 162.0 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.50 stddev:40.56 (53.0%) stddev-sans-first:42.35 03:57:57 INFO - PROCESS | 20504 | Values: 75.0 77.0 78.0 164.0 77.0 77.0 76.0 76.0 180.0 74.0 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:92.00 stddev:26.04 (28.3%) stddev-sans-first:27.02 03:57:57 INFO - PROCESS | 20504 | Values: 93.0 92.0 155.0 92.0 92.0 93.0 144.0 92.0 93.0 138.0 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 03:57:57 INFO - PROCESS | 20504 | Values: 117.0 118.0 118.0 118.0 118.0 117.0 117.0 117.0 116.0 118.0 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:2.46 (1.7%) stddev-sans-first:2.60 03:57:57 INFO - PROCESS | 20504 | Values: 147.0 148.0 147.0 146.0 145.0 147.0 146.0 154.0 148.0 147.0 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:57:57 INFO - PROCESS | 20504 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:58.00 stddev:6.51 (11.2%) stddev-sans-first:6.75 03:57:57 INFO - PROCESS | 20504 | Values: 55.0 56.0 55.0 58.0 61.0 61.0 55.0 76.0 54.0 58.0 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 03:57:57 INFO - PROCESS | 20504 | Values: 58.0 58.0 58.0 58.0 58.0 57.0 58.0 58.0 57.0 58.0 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:77.00 stddev:2.62 (3.4%) stddev-sans-first:1.99 03:57:57 INFO - PROCESS | 20504 | Values: 82.0 74.0 80.0 74.0 78.0 75.0 75.0 77.0 77.0 76.0 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:123.50 stddev:9.19 (7.4%) stddev-sans-first:9.75 03:57:57 INFO - PROCESS | 20504 | Values: 123.0 114.0 114.0 118.0 123.0 124.0 133.0 113.0 141.0 130.0 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:162.00 stddev:1.62 (1.0%) stddev-sans-first:1.69 03:57:57 INFO - PROCESS | 20504 | Values: 161.0 164.0 163.0 162.0 162.0 162.0 163.0 158.0 162.0 161.0 03:57:57 INFO - PROCESS | 20504 | 03:57:57 INFO - PROCESS | 20504 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 03:57:57 INFO - PROCESS | 20504 | Values: 66.0 67.0 67.0 67.0 67.0 65.0 67.0 66.0 67.0 68.0 03:57:57 INFO - PROCESS | 20504 | -------- Summary: end -------- 03:57:57 INFO - PROCESS | 20504 | 03:57:58 INFO - TEST-INFO | 20504: exit 0 03:57:58 INFO - TEST-OK | kraken | took 60826ms 03:57:58 INFO - SUITE-END | took 1170s 03:57:58 INFO - Completed test suite (00:19:30) 03:57:58 INFO - javascript benchmark 03:57:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3394.1005633507116, 3443.690067893889, 3446.0523356077083, 3474.652534746524, 3483.773554718943, 5712.171735098408, 5731.942680573193, 5733.942660573393, 5738.626989245701, 5760.0783874580075, 5726.198332233491, 5835.708214589275, 5838.2702162229725, 5839.007368747312, 5839.620424672394, 5266.447023062571, 5306.416294207634, 5317.867053323678, 5318.2554442377905, 5336.439673834249, 5126.333576635032, 5224.164133738603, 5252.65857719247, 5342.599305052117, 5371.221172929922, 5192.013517431676, 5197.350331208599, 5217.86955326118, 5302.496262855042, 5307.097793375136, 5308.708021058859, 5312.07038768214, 5315.574754019669, 5316.946830531684, 5329.6002799789785, 5220.425753167148, 5225.764840582183, 5239.607029472805, 5296.073187192264, 5296.126139187029, 5551.944480555224, 5655.236543066716, 5703.5152012079025, 5710.229119068914, 5722.227499287585, 6038.547108966801, 6064.575479716422, 6075.270967483886, 6082.1789058477425, 6082.482988945945, 6008.128821320884, 6127.662978536178, 6135.110408990671, 6139.355367686418, 6142.570020098595, 5713.514351280146, 5771.336296325934, 5778.913316300259, 5786.189933409326, 5844.649321040709, 6249.125122482856, 6268.4671802896355, 6277.623342599459, 6303.527235457359, 6309.432151106423, 6030.939690603125, 6058.333583305833, 6065.787697430569, 6067.089936509559, 6070.514358851369, 6170.81487555374, 6206.435786723651, 6220.688965551704, 6224.502039836892, 6231.532635052389, 6137.84655383619, 6182.536309776785, 6182.814515564541, 6189.690515474298, 6196.8760624787255, 5976.312724036705, 6123.724432400552, 6138.549551575073, 6186.288576813634, 6190.1952746142715, 4650.046740418206, 4653.674242802971, 4657.953420465819, 4663.160631086369, 4711.0, 4199.139176468817, 4219.493660760729, 4223.767692776927, 4230.407742915994, 4260.957390426056, 5956.344802071769, 6007.399260074045, 6028.879422411527, 6069.848253793602, 6111.297200821873, 6125.998614523584, 6132.325444201134, 6155.353687862799, 6176.320604733476, 6212.751489940442, 5939.020061689859, 5944.583879128506, 5946.821595352147, 5948.851278718067, 5951.196588460589, 5182.352205974254, 5230.633855630145, 5264.052470555337, 5279.656822306538, 5297.708626025528, 6214.161088253028, 6263.4362907338555, 6267.749290028348, 6280.937190628127, 6292.590981586182, 6034.63792172471, 6082.878342433215, 6088.360722124113, 6093.756249750138, 6097.664628445478, 6133.2428548619655, 6201.937980620136, 6222.782202623068, 6251.437370636664, 6257.843553911007, 6064.545159113172, 6069.757209711739, 6070.0591408331775, 6086.17861935281, 6095.603785753912, 6095.664738439428, 6122.337112246169, 6166.229221347332, 6171.938280617136, 6211.875762484635, 6119.908201377072, 6143.477804386677, 6147.047207682637, 6156.0, 6156.353582873913, 6089.955753753899, 6104.969475152596, 6116.938830611637, 6118.143459915526, 6136.32500424944, 5738.22533957927, 5799.217105690846, 5916.171735957056, 5974.342822289458, 6000.0, 6050.364711705383, 6051.909221361771, 6083.087536869505, 6099.695015249131, 6117.296510901303, 5939.554533410098, 5943.108533719977, 5949.3753155918, 5962.940370596239, 5970.373110823475], "value": 5690.022375532402, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.1397030187434, 646.7865604350565, 661.2461793555347, 670.3363669966734, 672.6872004517901, 39286.0, 39950.2009959801, 40125.0, 40196.59803401965, 40303.59696403035, 42926.35610465846, 43541.56458435415, 43626.78186609071, 43703.78148109263, 43831.34252986208, 8865.202131808152, 8979.102089791002, 8999.685011024616, 9023.0, 9037.774055648628, 8767.56162191891, 8836.0, 8877.51173685447, 9071.863922041175, 9101.726948191532, 9032.819343613124, 9087.091290870927, 9112.45325280482, 9119.63521459144, 9147.359684822066, 9028.277737780962, 9070.365074444791, 9072.682456114037, 9073.954630226839, 9074.954625226897, 8883.644654213824, 9061.41100828444, 9108.043655416152, 9108.089191080906, 9114.225290850285, 44342.33486497705, 44825.77587112044, 44886.55113448857, 44898.32652510215, 44971.32543011857, 3808.8286027128847, 3950.6839452843706, 3979.064919743858, 4448.733076015417, 4587.518310577375, 33772.0, 34057.82971085153, 34221.657783422095, 34273.31453370943, 34426.82786586076, 4515.390422292981, 4582.381378513891, 4594.19601569724, 4608.4700259470255, 4668.6731928765, 303253.0, 305747.0, 307133.0, 308912.0, 309807.0, 62468.68765656143, 62587.0, 62844.0, 62864.0, 62894.37105628977, 70867.64566177136, 71645.6417717908, 72364.63817680984, 72493.637531812, 72736.63631681913, 18035.549111272325, 18145.546361341072, 18185.545361366072, 18249.543761406072, 18268.0, 13423.3959471824, 13485.730285394236, 13510.324483775772, 13536.255505947267, 13564.660883477993, 20253.987300634908, 20338.593228135356, 20467.07898144587, 20476.488087797625, 20993.790062099488, 7729.652165652559, 7765.495242809199, 7841.274919517697, 7974.84050319002, 8011.238932301422, 1098.5736421788765, 1157.8436911017072, 1200.7058270723553, 1229.5204870100667, 1229.9791173326118, 31109.533356999662, 31160.53259201114, 31616.683833161835, 31681.84159079236, 32297.838510807294, 1229.9077569182348, 1248.7502499500135, 1258.7922992706285, 1324.3065219867485, 1333.8055357418928, 16493.835061649468, 16557.668846623, 16631.91684041596, 16776.748348774778, 17031.233594488276, 515246.0, 857709.0, 879945.0, 890553.0, 915883.0, 64231.67884160643, 65011.0, 65046.0, 65320.673396632716, 65588.0, 1551.7905082813902, 1553.0448774003905, 1558.6493039066347, 1567.3182165757933, 1572.4339237874356, 34620.0, 34838.47742283918, 35191.29617407689, 35278.29443411169, 35544.82227588846, 57591.712041439525, 58540.0, 58633.70683146557, 58640.0, 58833.70583147228, 475669.0, 476964.0, 478874.0, 480358.0, 480359.0, 30648.080557583307, 30768.076957691304, 31293.530597041517, 31318.217044573157, 31628.209294767814, 52422.21366679579, 52758.2086268714, 52867.47132528626, 53112.203316949504, 53305.4669453316, 42372.15255694807, 42466.78766606147, 42542.0, 43483.56516434795, 44153.77923110364, 43470.0, 43904.0, 44401.77799110984, 44620.12515169534, 45049.324260135465, 44740.10519789521, 45385.319220211066, 45523.0, 45803.54196457993, 46158.0, 36212.09469763277, 36539.0, 37305.81347093247, 38119.0, 38219.42670859995, 30164.84917575398, 30275.545866812456, 30585.23536911595, 30791.2302192447, 30980.845095774377], "value": 21627.150544651864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.822000649724, 423.35227102533133, 428.8756260684398, 430.43612867144043, 436.57652077484846, 14437.350319235633, 18397.540061498454, 19157.137928793203, 19161.616767664655, 19464.90267548664, 17065.40271090512, 17322.653546929054, 17325.91337043313, 18042.5489362766, 18325.358612448566, 5622.32532096149, 5632.957902787977, 5853.824385268427, 5876.236089308405, 5901.026330655437, 5688.2605261315975, 5756.597038207327, 5808.912866307009, 5814.941850581504, 5835.241418615574, 5641.915371269434, 5824.417558244184, 5834.883302333951, 5848.941510584904, 5867.0, 5760.395158508338, 5801.477866991991, 5833.212516310286, 5840.445157710032, 5846.181534585162, 5078.060558796635, 5197.532222100029, 5197.922031169535, 5244.423113457517, 5252.028374750684, 22627.88686056559, 23365.0, 23401.88299058511, 23510.177143799883, 23617.88191059034, 2462.7167875694167, 2560.5519034168947, 2581.2127301173136, 2792.3158826087533, 3040.148758347666, 14207.644808879757, 14307.928460357736, 14371.425142994267, 14822.481213157487, 14976.101433914, 2034.4201902457876, 2077.1172251792927, 2084.8644838085474, 2128.9254876079262, 2148.2481131603813, 74496.25503744947, 76151.61924190399, 76373.61813190898, 76796.23203767947, 77015.22385821085, 10713.089387402159, 11018.11855051594, 11129.888701113046, 11282.774344513064, 11394.430278486043, 15219.467318643794, 15334.539963801104, 15423.688986436055, 15436.15101169424, 15459.92270038665, 8015.078265999368, 8365.1216622255, 8395.95802020986, 8540.402171848034, 8580.399372043898, 8456.06983231844, 8480.830383392298, 8535.658573657109, 8545.0, 8604.053554109043, 4554.157480866051, 4595.655325850575, 4650.348951146842, 4669.976650116796, 4702.177119004161, 1998.6802111662064, 2016.385002574229, 2019.6970454431953, 2031.5327474680905, 2037.1156680071172, 1087.276960821061, 1107.5071593141136, 1134.393099691661, 1138.7551676389617, 1139.4245905817509, 18386.080695965415, 19119.235230590897, 19396.4181074568, 19533.609327813647, 19908.0, 1049.3913530152493, 1081.6700906223678, 1097.5280629329304, 1099.6755956992706, 1100.6367898593444, 10721.195910306758, 11154.888451115547, 11166.441677916071, 11183.944080279709, 11273.154513411528, 441056.0, 444620.0, 485639.0, 518282.0, 518757.0, 88965.55517222502, 98194.5090274544, 98261.0, 101262.4936875311, 101415.49292253492, 1067.3755852826184, 1068.4550879051585, 1099.7470581766238, 1107.6621630402644, 1108.706192858893, 17203.3978810746, 17256.482305530855, 17394.73907891408, 17402.825971740625, 17479.650406992045, 28572.714272857007, 41352.58647413487, 41668.58331416647, 41916.0, 42350.0, 60566.697166513884, 60727.392726072176, 60875.391246088744, 61090.0, 61661.0, 8860.601272942604, 8950.955245223733, 8957.776055598662, 9014.368994170345, 9125.589348479467, 11055.613053543088, 13256.602301930572, 13388.598342049754, 13404.463821447032, 13552.59342219735, 10728.89271107279, 11815.881841181477, 11849.526018959144, 12007.81988270194, 12113.0, 10964.451777411257, 11101.000909918146, 11495.77008459843, 11727.41362931833, 11922.76154476923, 11792.469338879942, 12170.45232964501, 12230.0, 12300.81548776787, 12306.75386492283, 8686.218240358397, 8798.912010879809, 8883.73348799537, 8946.239569636653, 8971.596278167628, 11657.475413606579, 11675.941620292184, 11707.239029463057, 11997.160198786001, 12207.938960305497], "value": 9480.380536255638, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1559.3840433028952, 1566.6553358261183, 1763.497403240076, 1822.8450581700554, 1851.1669748613128, 7365.042544469225, 7970.681172753098, 8083.676652933883, 8339.374546908983, 8340.499570025802, 7836.647350869211, 7901.565413902233, 7915.643796029178, 7976.2821346078845, 7981.361491080714, 2285.542891421718, 2328.0338659456306, 2329.359426157812, 2332.125452955142, 2334.719833619968, 2317.5480781247666, 2338.0414030247603, 2353.388119089032, 2358.1039205102124, 2368.86971216583, 2268.4555706630454, 2276.5105502316997, 2291.3927809130596, 2300.9884950575224, 2304.665823455598, 2303.5968705476475, 2361.515889242701, 2366.0, 2372.1697405907967, 2376.1802178248477, 2301.0680674326923, 2317.7450480447137, 2319.478117423583, 2325.3140323604575, 2331.895064722092, 8026.7591972240925, 8053.718119865776, 8084.7574572762915, 8085.312748416332, 8090.231428014329, 5034.647574669774, 5159.948400515985, 5173.198154286091, 5174.508421699932, 5192.844214673566, 3260.934781304384, 3331.4503106987318, 3352.430086885211, 3365.074604483762, 3375.729941604666, 1047.36634336227, 1052.899974502421, 1112.9443527823576, 1115.776844631069, 1121.8990290873778, 11405.771884562346, 11436.256643318158, 11436.599719009795, 11449.542018319256, 11470.598529051444, 4500.797464114123, 4587.128445595326, 4648.163330600524, 4661.137689527448, 4664.743439110814, 9900.108990190918, 9929.553170107363, 9950.900490995142, 9951.15415189717, 9962.551685174185, 5165.741712914414, 5215.7913683453, 5221.712805795718, 5222.97388513055, 5223.582113430916, 4164.8125834337525, 4645.907081858344, 4672.859814205579, 4677.4854765975715, 4789.042191561702, 3959.9802000990385, 3997.320455522568, 4013.13717550728, 4044.716869819143, 4091.672666186698, 1320.584016034946, 1328.2030781531005, 1332.140769203858, 1332.593558964525, 1342.7583035053783, 915.1946287267162, 1035.880873699519, 1054.625607909181, 1054.9050585447194, 1056.3292309383596, 5763.423657634203, 5781.248437703156, 5785.652860828363, 5880.7353669085, 5977.910331345033, 1030.9793804123876, 1033.6640591807693, 1066.1364294921138, 1077.1329080090602, 1090.5256213547132, 3904.8047597620007, 3924.156306394139, 3943.211357728466, 3967.206558688274, 3999.6400323970984, 9826.754331141636, 10086.697399078039, 10212.08091271789, 10213.846792298122, 10254.794904102026, 9971.0, 9986.950065249772, 9994.800103997879, 10019.998000199921, 10081.042300981395, 7616.543007419573, 7683.1548529661695, 7729.768106956801, 8023.277904988579, 8027.5584842834205, 5623.915641265303, 5675.943240567707, 5743.1385292206505, 5761.337446193741, 5860.706964651836, 8585.313174945864, 8778.122187781171, 8929.598168082322, 8944.463332200088, 9145.634174633205, 8947.686830961145, 8981.730548083307, 9050.683226087056, 9070.954645226731, 9138.725838224864, 6783.762568310085, 7071.681774320271, 7319.8536029280185, 7376.926230737624, 7403.259674032553, 7842.490238134503, 7848.175941526058, 7864.134945156143, 7865.685372585262, 7895.84208315819, 6833.350831670983, 6871.553349032297, 7053.153621565445, 7082.256363081802, 7185.640717964186, 7013.649317534205, 7043.683034263573, 7109.395701365442, 7136.678849451683, 7188.029616001772, 6582.17722784652, 6690.765823196165, 6718.865622687616, 6726.6972986216715, 6798.354156355138, 5010.3737032870895, 5029.270755740324, 5030.547250747451, 5102.158143906214, 5163.27714120016, 4993.15116430215, 4999.500049994971, 5029.850373441852, 5035.5719763819025, 5138.614603904647], "value": 4500.926367809195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.199704680711, 356.3745626425623, 356.819805997971, 358.32455820777824, 359.05926472641664, 6635.66821658917, 6729.461643068555, 6855.143107111611, 6874.72501099956, 6876.690548925298, 6682.832929176773, 6684.665766711657, 6740.52816302859, 6741.292164322749, 6772.966135169329, 4829.9275510867365, 4993.700377977315, 5004.324416203821, 5004.674696144757, 5014.147594908856, 4955.801767929279, 4968.950310496903, 4976.601871850261, 4976.800927962877, 4976.975115124419, 4864.7324397158145, 4869.561739443449, 4874.561289483946, 4877.317175595419, 4906.337644418011, 4888.291197776321, 4889.291052797343, 4932.999999999982, 4954.009198160346, 4965.081459929925, 4277.465316835395, 4278.700490965633, 4297.39836422901, 4303.246931786956, 4309.332053531708, 6385.4253117219205, 6393.776217832354, 6429.292777794439, 6444.097826304321, 6447.0651755495655, 5697.316322041382, 5809.04150815115, 5816.389279125673, 5820.068788993783, 5821.67980761058, 6978.895316570205, 7009.08881845362, 7042.084529011247, 7044.929550704479, 7057.258987806258, 4765.809367625291, 4782.473927867932, 4789.80840766369, 4792.0895029944195, 4797.208460604031, 7303.415726741848, 7341.412686985082, 7368.336849683501, 7383.593902335369, 7405.370543503863, 4832.220047023665, 4909.828156014522, 4912.6561140719805, 4918.262260660929, 4925.532074452921, 4878.82924097662, 4972.776225069881, 4982.850514484571, 4989.151844186497, 4989.90020199594, 5750.827475175752, 5774.653520788766, 5781.1328300754385, 5803.622764520377, 5805.303363596311, 7094.92905070953, 7096.53872498286, 7102.112235970504, 7106.14726232845, 7115.644217789089, 1736.0625262358185, 1753.509017475109, 1754.026515284004, 1756.6925787987307, 1762.171779263744, 1084.219362059316, 1109.517359948425, 1137.4312843578211, 1146.2835727670206, 1146.6674664347245, 6895.034695142684, 6896.344847239504, 6896.862062758817, 6904.4821638377325, 6915.792526224222, 7300.707971681073, 7363.932229826645, 7381.852362952818, 7392.96303518479, 7393.852122957511, 6580.736770529125, 6752.324767523307, 6827.726890924407, 6870.27862074475, 6883.793486195422, 3977.284088864032, 3989.3417586097967, 4005.5794141615293, 4007.2987227235117, 4017.8593749218635, 7671.462997590115, 7677.539347639159, 7680.615969201517, 7683.0, 7700.653470593837, 7505.6997720090585, 7535.284148005931, 7542.434317426215, 7549.01862757838, 7550.697972081055, 7397.593132377663, 7614.619269036526, 7624.885626715603, 7677.76966690989, 7731.0, 7440.0, 7454.0, 7467.701291948479, 7470.850582988419, 7474.476786624884, 7345.669444874887, 7356.080489938758, 7358.227386124594, 7363.042804435389, 7363.631818409165, 7701.152873183833, 7702.845943081219, 7725.652345644572, 7748.961255193688, 7750.496217745828, 4735.644826637947, 4866.780994855169, 4874.0, 4895.339129217653, 4914.483979182134, 7244.384227340735, 7288.416926645961, 7323.084614423197, 7332.0834895638045, 7357.3746231568775, 7092.468064895051, 7133.3936615388275, 7136.4290856730295, 7140.7143714252925, 7149.499535032498, 7070.505064645631, 7099.325564071405, 7102.07673002527, 7113.893291600527, 7121.003059571561, 6825.829354266183, 6968.79093627192, 6995.650217489004, 6997.335253150943, 7011.614361210182, 7148.213696493278, 7172.282771722786, 7174.641267936478, 7178.5692858428665, 7185.389241914496, 6983.1620205575655, 6991.510594258353, 6996.860062798817, 7007.509474336747, 7020.333068358498], "value": 5303.986615623005, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.9960400197999, 795.8249185179262, 869.3002133282707, 879.1999280654602, 897.0401670212875, 13310.600681979531, 13489.595312140627, 13536.0, 13556.796648050287, 13609.591712248635, 13607.591772246824, 13649.863501364984, 13658.521951731667, 13683.315834208299, 13751.174929504237, 742.5655991245114, 851.1998721202082, 864.1099667342647, 878.661715239631, 879.1823604048233, 883.1257055515058, 887.8934527856634, 888.2361169394316, 890.9465432074064, 892.5849479991803, 938.7559234598986, 942.1897168435174, 942.9339946203734, 943.627267229444, 945.229637845154, 942.4298299528755, 943.03810113684, 943.8301105800988, 944.2304521814767, 945.6595625574788, 685.5749435350115, 685.6880119545594, 690.775497963164, 692.62944324786, 695.4471195399669, 14289.857101428957, 14294.785578216335, 14310.427582896671, 14359.138451692932, 14397.424103035866, 13960.162390256617, 14231.573052808433, 14729.0, 14738.0, 14863.0, 11295.152863535268, 11363.14776391774, 11958.880411195863, 12008.519659213709, 12220.266783992989, 4624.630029597658, 4676.859694209179, 4760.857174284777, 4783.497732738082, 4867.8783030424165, 56861.71569142169, 58535.707321463546, 59222.40777592212, 60490.39509604935, 60558.0, 11496.77006459866, 11540.596079137189, 11589.0, 11658.941705291589, 11750.588729394602, 19872.403827885188, 20303.796962030487, 20365.287214947406, 20494.692579611317, 20526.589468210554, 8336.958315208385, 8574.699885503978, 8722.956385218033, 8785.736427907173, 8842.33682473817, 4813.181759100961, 5016.135368030625, 5059.595232381401, 5116.386033675908, 5135.281060651511, 3438.3123375325035, 3485.4423292273113, 3488.075659950115, 3495.0912762681887, 3497.178163131662, 673.4343151752552, 676.0163961436099, 676.5602358466938, 678.8811957907346, 679.609224695792, 763.7937756805743, 794.5431376958272, 800.1438460846954, 812.8455593437228, 832.7959649885817, 10139.898601014043, 10208.336458130198, 10219.335743176669, 10290.588376464857, 10481.842772358421, 696.9825754356182, 760.866848301545, 768.4620765464198, 772.1814876231213, 804.9034115906129, 4628.606568441653, 4746.572808447257, 4826.831060912851, 4837.879053023632, 4883.877903052452, 63021.05468417978, 64515.354846451875, 67066.0, 67594.32405675978, 68006.65996669985, 56951.715241423524, 57697.711511442176, 58606.706966464895, 58658.7067064662, 58790.706046470346, 50900.49099509032, 51944.0, 52759.472405276225, 52835.73582132142, 53391.19913201305, 9488.762780930532, 9658.855117173389, 9750.0, 9774.12032917041, 9841.950790246003, 40036.39945400763, 40248.1950360997, 40571.0, 40675.0, 41165.0, 49130.0, 50486.0, 50642.49357506525, 50973.7451312741, 52360.738196308776, 10664.253502254767, 10822.458877055959, 11184.328940263611, 11240.213185076966, 11537.365444900612, 12626.747465050465, 12732.299723515296, 12774.0, 12960.092793504742, 13379.331033448094, 12132.211406258564, 12358.44387002605, 12477.625671229878, 12737.745245095231, 12753.61739147827, 12460.937695311466, 12493.375331233221, 12643.494260229489, 13111.541096061592, 13690.726185476036, 12028.819567706316, 12464.501419943463, 13741.793873091712, 13960.720785584028, 14154.292285385896, 10751.731206719582, 10923.726906827393, 11219.439028048402, 11235.213535052795, 11378.658640240476, 11518.020968217796, 11660.825087623523, 11847.348395838311, 11966.102542309187, 12026.879731202576], "value": 7152.876456587157, "unit": "score"}], "name": "dromaeo_css", "value": 7642.358471885862, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 103.0, 110.0, 113.0, 110.0, 102.0, 110.0, 112.0, 113.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 162.0, 187.0, 127.0, 150.0, 161.0, 129.0, 181.0, 136.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 162.0, 163.0, 169.0, 162.0, 164.0, 165.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 164.0, 77.0, 77.0, 76.0, 76.0, 180.0, 74.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 155.0, 92.0, 92.0, 93.0, 144.0, 92.0, 93.0, 138.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 116.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 145.0, 147.0, 146.0, 154.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 58.0, 61.0, 61.0, 55.0, 76.0, 54.0, 58.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 58.0, 57.0, 58.0, 58.0, 57.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 80.0, 74.0, 78.0, 75.0, 75.0, 77.0, 77.0, 76.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 114.0, 114.0, 118.0, 123.0, 124.0, 133.0, 113.0, 141.0, 130.0], "value": 123.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 163.0, 162.0, 162.0, 162.0, 163.0, 158.0, 162.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 65.0, 67.0, 66.0, 67.0, 68.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1533.3999999999999, "alertThreshold": 2.0}]} 03:57:58 INFO - Return code: 0 03:57:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:57:58 ERROR - # TBPL SUCCESS # 03:57:58 INFO - Running post-action listener: _resource_record_post_action 03:57:58 INFO - Running post-run listener: _resource_record_post_run 03:57:59 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 515637248; Read time: 20; Write time: 376496 03:57:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248942592; Read time: 0; Write time: 242292 03:57:59 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 249171968; Read time: 20; Write time: 130000 03:57:59 INFO - Running post-run listener: _upload_blobber_files 03:57:59 INFO - Blob upload gear active. 03:57:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57:59 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:57:59 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:57:59 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:58:00 INFO - (blobuploader) - INFO - Open directory for files ... 03:58:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:58:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:58:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:00 INFO - (blobuploader) - INFO - Done attempting. 03:58:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:58:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:58:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:01 INFO - (blobuploader) - INFO - Done attempting. 03:58:01 INFO - (blobuploader) - INFO - Iteration through files over. 03:58:01 INFO - Return code: 0 03:58:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:58:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:58:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f4cb30e6fa01b5a5452bf824a636fd60e8d714b13e6d49f4ddd512bb2c1a3c3896d830ab5453ba800eefb77bf17698baa22dc6ed1440e98f289a7b111e4a3fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8840fb790db35b6b047952dc4ef2494f12546c705f6ee726fe8c218568d08b1fdac39edfb090255a4b84f1a82425b6181e25d0610e20d5e4efa80ea61bc3a27d"} 03:58:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:58:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:58:01 INFO - Contents: 03:58:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f4cb30e6fa01b5a5452bf824a636fd60e8d714b13e6d49f4ddd512bb2c1a3c3896d830ab5453ba800eefb77bf17698baa22dc6ed1440e98f289a7b111e4a3fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8840fb790db35b6b047952dc4ef2494f12546c705f6ee726fe8c218568d08b1fdac39edfb090255a4b84f1a82425b6181e25d0610e20d5e4efa80ea61bc3a27d"} 03:58:01 INFO - Running post-run listener: copy_logs_to_upload_dir 03:58:01 INFO - Copying logs to upload dir... 03:58:01 INFO - mkdir: /builds/slave/test/build/upload/logs 03:58:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.632377 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-28 03:58:01.503082) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:58:01.506063) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f4cb30e6fa01b5a5452bf824a636fd60e8d714b13e6d49f4ddd512bb2c1a3c3896d830ab5453ba800eefb77bf17698baa22dc6ed1440e98f289a7b111e4a3fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8840fb790db35b6b047952dc4ef2494f12546c705f6ee726fe8c218568d08b1fdac39edfb090255a4b84f1a82425b6181e25d0610e20d5e4efa80ea61bc3a27d"} 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.011415 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f4cb30e6fa01b5a5452bf824a636fd60e8d714b13e6d49f4ddd512bb2c1a3c3896d830ab5453ba800eefb77bf17698baa22dc6ed1440e98f289a7b111e4a3fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8840fb790db35b6b047952dc4ef2494f12546c705f6ee726fe8c218568d08b1fdac39edfb090255a4b84f1a82425b6181e25d0610e20d5e4efa80ea61bc3a27d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:58:01.531461) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:58:01.531787) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464431854.633457-814047895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:58:01.616438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:58:01.616761) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:58:01.617037) ========= ========= Total master_lag: 0.19 =========