builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1464431750.01 results: success (0) buildid: 20160525183450 builduid: 63f91898e679451db7d589c242ad058b revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.009315) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.009869) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.010218) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.025618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.026125) ========= 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=745a4373a2a16df560f216e000000264-1464431749.720353-1134318009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 03:35:50-- 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% 34.5M=0s 2016-05-28 03:35:50 (34.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111642 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.160164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.160519) ========= 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=745a4373a2a16df560f216e000000264-1464431749.720353-1134318009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021957 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.209785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.210532) ========= 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=745a4373a2a16df560f216e000000264-1464431749.720353-1134318009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 03:35:50,869 truncating revision to first 12 chars 2016-05-28 03:35:50,869 Setting DEBUG logging. 2016-05-28 03:35:50,869 attempt 1/10 2016-05-28 03:35:50,869 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/33693d8bdec1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 03:35:51,185 unpacking tar archive at: mozilla-aurora-33693d8bdec1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674248 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.901641) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.902024) ========= script_repo_revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.902481) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.904094) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:35:50.915164) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-28 03:35:50.915474) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1464431749.720353-1134318009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:35:51 INFO - MultiFileLogger online at 20160528 03:35:51 in /builds/slave/test 03:35:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:35:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:35:51 INFO - {'append_to_log': False, 03:35:51 INFO - 'base_work_dir': '/builds/slave/test', 03:35:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:35:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:35:51 INFO - 'branch': 'Mozilla-Aurora', 03:35:51 INFO - 'buildbot_json_path': 'buildprops.json', 03:35:51 INFO - 'config_files': ('talos/linux_config.py',), 03:35:51 INFO - 'default_actions': ('clobber', 03:35:51 INFO - 'read-buildbot-config', 03:35:51 INFO - 'download-and-extract', 03:35:51 INFO - 'populate-webroot', 03:35:51 INFO - 'create-virtualenv', 03:35:51 INFO - 'install', 03:35:51 INFO - 'run-tests'), 03:35:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:35:51 INFO - 'download_minidump_stackwalk': True, 03:35:51 INFO - 'download_symbols': 'ondemand', 03:35:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:35:51 INFO - 'tooltool.py': '/tools/tooltool.py', 03:35:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:35:51 INFO - '/tools/misc-python/virtualenv.py')}, 03:35:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:35:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:35:51 INFO - 'installer_path': 'installer.exe', 03:35:51 INFO - 'log_level': 'info', 03:35:51 INFO - 'log_name': 'talos', 03:35:51 INFO - 'log_to_console': True, 03:35:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:35:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:35:51 INFO - 'opt_config_files': (), 03:35:51 INFO - 'pip_index': False, 03:35:51 INFO - 'sps_profile': False, 03:35:51 INFO - 'sps_profile_interval': 0, 03:35:51 INFO - 'suite': 'dromaeojs', 03:35:51 INFO - 'system_bits': '32', 03:35:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:35:51 INFO - 'title': 'talos-linux64-ix-032', 03:35:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:35:51 INFO - 'use_talos_json': True, 03:35:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:35:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:35:51 INFO - 'work_dir': 'build'} 03:35:51 INFO - ##### 03:35:51 INFO - ##### Running clobber step. 03:35:51 INFO - ##### 03:35:51 INFO - Running pre-action listener: _resource_record_pre_action 03:35:51 INFO - Running main action method: clobber 03:35:51 INFO - rmtree: /builds/slave/test/build 03:35:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:35:52 INFO - Running post-action listener: _resource_record_post_action 03:35:52 INFO - ##### 03:35:52 INFO - ##### Running read-buildbot-config step. 03:35:52 INFO - ##### 03:35:52 INFO - Running pre-action listener: _resource_record_pre_action 03:35:52 INFO - Running main action method: read_buildbot_config 03:35:52 INFO - Using buildbot properties: 03:35:52 INFO - { 03:35:52 INFO - "project": "", 03:35:52 INFO - "product": "firefox", 03:35:52 INFO - "script_repo_revision": "production", 03:35:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:35:52 INFO - "repository": "", 03:35:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:35:52 INFO - "buildid": "20160525183450", 03:35:52 INFO - "pgo_build": "True", 03:35:52 INFO - "basedir": "/builds/slave/test", 03:35:52 INFO - "buildnumber": 526, 03:35:52 INFO - "slavename": "talos-linux64-ix-032", 03:35:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:35:52 INFO - "platform": "ubuntu64_hw", 03:35:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:35:52 INFO - "branch": "mozilla-aurora", 03:35:52 INFO - "repo_path": "releases/mozilla-aurora", 03:35:52 INFO - "revision": "33693d8bdec17f07fc460ca7cc908ade88f97b86", 03:35:52 INFO - "stage_platform": "linux64-pgo", 03:35:52 INFO - "builduid": "63f91898e679451db7d589c242ad058b", 03:35:52 INFO - "slavebuilddir": "test" 03:35:52 INFO - } 03:35:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:35:52 INFO - Running post-action listener: _resource_record_post_action 03:35:52 INFO - ##### 03:35:52 INFO - ##### Running download-and-extract step. 03:35:52 INFO - ##### 03:35:52 INFO - Running pre-action listener: _resource_record_pre_action 03:35:52 INFO - Running main action method: download_and_extract 03:35:52 INFO - mkdir: /builds/slave/test/build/tests 03:35: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:35:52 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:35:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:35:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:35:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:35:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:35:52 INFO - Downloaded 1361 bytes. 03:35:52 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:35:52 INFO - Using the following test package requirements: 03:35:52 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:35:52 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:35:52 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:35:52 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:52 INFO - u'jsshell-linux-x86_64.zip'], 03:35:52 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:35:52 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:35:52 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:35:52 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:35:52 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:35:52 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:35:52 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:35: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:35:52 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:35:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:35:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:35:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:35:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:35:54 INFO - Downloaded 24140640 bytes. 03:35:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:35:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:35:55 INFO - Return code: 0 03:35:55 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:55 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:35:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:35:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:35:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:35:56 INFO - Downloaded 24140640 bytes. 03:35:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:35:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:35:58 INFO - Return code: 0 03:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:58 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:35:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:35:59 INFO - Downloaded 10840145 bytes. 03:35:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:35:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:35:59 INFO - Return code: 0 03:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:59 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:35:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:35:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:35:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:35:59 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:36:00 INFO - Downloaded 62759817 bytes. 03:36:00 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:36:00 INFO - mkdir: /builds/slave/test/properties 03:36:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:00 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:00 INFO - Contents: 03:36:00 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:36:01 INFO - Running post-action listener: _resource_record_post_action 03:36:01 INFO - Running post-action listener: set_extra_try_arguments 03:36:01 INFO - ##### 03:36:01 INFO - ##### Running populate-webroot step. 03:36:01 INFO - ##### 03:36:01 INFO - Running pre-action listener: _resource_record_pre_action 03:36:01 INFO - Running main action method: populate_webroot 03:36:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:36:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:36:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:36:01 INFO - '--tppagecycles', 03:36:01 INFO - '7'], 03:36:01 INFO - 'tests': ['tsvgm']}}, 03:36:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:36:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:36:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:36:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:36:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:36:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:36:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:01 INFO - 'talos_options': ['--disable-e10s'], 03:36:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:01 INFO - 'talos_options': ['--disable-e10s'], 03:36:01 INFO - 'tests': ['damp', 'tps']}, 03:36:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:01 INFO - 'tests': ['damp', 'tps']}, 03:36:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:36:01 INFO - 'tests': ['dromaeo_dom']}, 03:36:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:36:01 INFO - 'tests': ['a11yr', 03:36:01 INFO - 'ts_paint', 03:36:01 INFO - 'tpaint', 03:36:01 INFO - 'sessionrestore', 03:36:01 INFO - 'sessionrestore_no_auto_restore', 03:36:01 INFO - 'tabpaint']}, 03:36:01 INFO - 'other-e10s': {'tests': ['a11yr', 03:36:01 INFO - 'ts_paint', 03:36:01 INFO - 'tpaint', 03:36:01 INFO - 'sessionrestore', 03:36:01 INFO - 'sessionrestore_no_auto_restore', 03:36:01 INFO - 'tabpaint']}, 03:36:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:36:01 INFO - 'ts_paint', 03:36:01 INFO - 'tpaint', 03:36:01 INFO - 'sessionrestore', 03:36:01 INFO - 'sessionrestore_no_auto_restore', 03:36:01 INFO - 'tabpaint']}, 03:36:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:36:01 INFO - 'ts_paint', 03:36:01 INFO - 'tpaint', 03:36:01 INFO - 'sessionrestore', 03:36:01 INFO - 'sessionrestore_no_auto_restore', 03:36:01 INFO - 'tabpaint']}, 03:36:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:36:01 INFO - 'tests': ['a11yr', 03:36:01 INFO - 'ts_paint', 03:36:01 INFO - 'tpaint', 03:36:01 INFO - 'sessionrestore', 03:36:01 INFO - 'sessionrestore_no_auto_restore', 03:36:01 INFO - 'tabpaint']}, 03:36:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:36:01 INFO - 'tests': ['a11yr', 03:36:01 INFO - 'ts_paint', 03:36:01 INFO - 'tpaint', 03:36:01 INFO - 'sessionrestore', 03:36:01 INFO - 'sessionrestore_no_auto_restore', 03:36:01 INFO - 'tabpaint']}, 03:36:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:36:01 INFO - 'tests': ['tsvgx', 03:36:01 INFO - 'tsvgr_opacity', 03:36:01 INFO - 'tart', 03:36:01 INFO - 'tscrollx', 03:36:01 INFO - 'cart']}, 03:36:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:36:01 INFO - 'tsvgr_opacity', 03:36:01 INFO - 'tart', 03:36:01 INFO - 'tscrollx', 03:36:01 INFO - 'cart']}, 03:36:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:01 INFO - 'talos_options': ['--disable-e10s'], 03:36:01 INFO - 'tests': ['tp5o']}, 03:36:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:01 INFO - 'tests': ['tp5o']}, 03:36:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:01 INFO - 'talos_options': ['--disable-e10s', 03:36:01 INFO - '--xperf_path', 03:36:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:01 INFO - 'tests': ['tp5n']}, 03:36:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:01 INFO - 'talos_options': ['--xperf_path', 03:36:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:01 INFO - 'tests': ['tp5n']}}, 03:36:01 INFO - 'talos.zip': {'path': '', 03:36:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:36:01 INFO - Running post-action listener: _resource_record_post_action 03:36:01 INFO - ##### 03:36:01 INFO - ##### Running create-virtualenv step. 03:36:01 INFO - ##### 03:36:01 INFO - Running pre-action listener: _resource_record_pre_action 03:36:01 INFO - Running main action method: create_virtualenv 03:36:01 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:01 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:36:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:36:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:01 INFO - Using real prefix '/usr' 03:36:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:02 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:04 INFO - Installing pip.................done. 03:36:04 INFO - Return code: 0 03:36:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f159b9ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792410>, '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 0x1793310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17937a0>, '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': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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:36:04 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:36:04 INFO - Using env: {'DISPLAY': ':0', 03:36:04 INFO - 'HOME': '/home/cltbld', 03:36:04 INFO - 'LANG': 'en_US.UTF-8', 03:36:04 INFO - 'LANGUAGE': 'en_US:en', 03:36:04 INFO - 'LOGNAME': 'cltbld', 03:36:04 INFO - 'MAIL': '/var/mail/cltbld', 03:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:04 INFO - 'MOZ_NO_REMOTE': '1', 03:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:04 INFO - 'NO_EM_RESTART': '1', 03:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:04 INFO - 'PWD': '/builds/slave/test', 03:36:04 INFO - 'SHELL': '/bin/bash', 03:36:04 INFO - 'SHLVL': '1', 03:36:04 INFO - 'TERM': 'linux', 03:36:04 INFO - 'TMOUT': '86400', 03:36:04 INFO - 'USER': 'cltbld', 03:36:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 03:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:04 INFO - '_': '/tools/buildbot/bin/python'} 03:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:04 INFO - 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:36:04 INFO - Cleaning up... 03:36:04 INFO - Return code: 0 03:36:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f159b9ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792410>, '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 0x1793310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17937a0>, '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': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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:36:04 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:36:04 INFO - Using env: {'DISPLAY': ':0', 03:36:04 INFO - 'HOME': '/home/cltbld', 03:36:04 INFO - 'LANG': 'en_US.UTF-8', 03:36:04 INFO - 'LANGUAGE': 'en_US:en', 03:36:04 INFO - 'LOGNAME': 'cltbld', 03:36:04 INFO - 'MAIL': '/var/mail/cltbld', 03:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:04 INFO - 'MOZ_NO_REMOTE': '1', 03:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:04 INFO - 'NO_EM_RESTART': '1', 03:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:04 INFO - 'PWD': '/builds/slave/test', 03:36:04 INFO - 'SHELL': '/bin/bash', 03:36:04 INFO - 'SHLVL': '1', 03:36:04 INFO - 'TERM': 'linux', 03:36:04 INFO - 'TMOUT': '86400', 03:36:04 INFO - 'USER': 'cltbld', 03:36:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 03:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:04 INFO - '_': '/tools/buildbot/bin/python'} 03:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:04 INFO - Downloading/unpacking psutil>=0.7.1 03:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:06 INFO - Installing collected packages: psutil 03:36:06 INFO - Running setup.py install for psutil 03:36:06 INFO - building 'psutil._psutil_linux' extension 03:36:06 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:36:06 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:36:06 INFO - building 'psutil._psutil_posix' extension 03:36:06 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:36:07 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:36:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:07 INFO - Successfully installed psutil 03:36:07 INFO - Cleaning up... 03:36:07 INFO - Return code: 0 03:36:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x7f159b9ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792410>, '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 0x1793310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17937a0>, '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': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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:36: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 mozsystemmonitor==0.0.0 03:36:07 INFO - Using env: {'DISPLAY': ':0', 03:36:07 INFO - 'HOME': '/home/cltbld', 03:36:07 INFO - 'LANG': 'en_US.UTF-8', 03:36:07 INFO - 'LANGUAGE': 'en_US:en', 03:36:07 INFO - 'LOGNAME': 'cltbld', 03:36:07 INFO - 'MAIL': '/var/mail/cltbld', 03:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:07 INFO - 'MOZ_NO_REMOTE': '1', 03:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:07 INFO - 'NO_EM_RESTART': '1', 03:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:07 INFO - 'PWD': '/builds/slave/test', 03:36:07 INFO - 'SHELL': '/bin/bash', 03:36:07 INFO - 'SHLVL': '1', 03:36:07 INFO - 'TERM': 'linux', 03:36:07 INFO - 'TMOUT': '86400', 03:36:07 INFO - 'USER': 'cltbld', 03:36:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 03:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:07 INFO - '_': '/tools/buildbot/bin/python'} 03:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:36: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:36: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:36: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:36: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:36: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:36: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:36:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:36:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:36:09 INFO - Installing collected packages: mozsystemmonitor 03:36:09 INFO - Running setup.py install for mozsystemmonitor 03:36:09 INFO - Successfully installed mozsystemmonitor 03:36:09 INFO - Cleaning up... 03:36:09 INFO - Return code: 0 03:36:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:09 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 0x7f159b9ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792410>, '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 0x1793310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17937a0>, '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': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:36:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:36:09 INFO - Using env: {'DISPLAY': ':0', 03:36:09 INFO - 'HOME': '/home/cltbld', 03:36:09 INFO - 'LANG': 'en_US.UTF-8', 03:36:09 INFO - 'LANGUAGE': 'en_US:en', 03:36:09 INFO - 'LOGNAME': 'cltbld', 03:36:09 INFO - 'MAIL': '/var/mail/cltbld', 03:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:09 INFO - 'MOZ_NO_REMOTE': '1', 03:36:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:09 INFO - 'NO_EM_RESTART': '1', 03:36:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:09 INFO - 'PWD': '/builds/slave/test', 03:36:09 INFO - 'SHELL': '/bin/bash', 03:36:09 INFO - 'SHLVL': '1', 03:36:09 INFO - 'TERM': 'linux', 03:36:09 INFO - 'TMOUT': '86400', 03:36:09 INFO - 'USER': 'cltbld', 03:36:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 03:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:09 INFO - '_': '/tools/buildbot/bin/python'} 03:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:09 INFO - Downloading/unpacking blobuploader==1.2.4 03:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:11 INFO - Downloading blobuploader-1.2.4.tar.gz 03:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:36:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:36:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:12 INFO - Downloading docopt-0.6.1.tar.gz 03:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:36:12 INFO - Installing collected packages: blobuploader, requests, docopt 03:36:12 INFO - Running setup.py install for blobuploader 03:36:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:36:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:36:12 INFO - Running setup.py install for requests 03:36:12 INFO - Running setup.py install for docopt 03:36:12 INFO - Successfully installed blobuploader requests docopt 03:36:12 INFO - Cleaning up... 03:36:12 INFO - Return code: 0 03:36:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:12 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 0x7f159b9ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792410>, '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 0x1793310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17937a0>, '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': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:12 INFO - Using env: {'DISPLAY': ':0', 03:36:12 INFO - 'HOME': '/home/cltbld', 03:36:12 INFO - 'LANG': 'en_US.UTF-8', 03:36:12 INFO - 'LANGUAGE': 'en_US:en', 03:36:12 INFO - 'LOGNAME': 'cltbld', 03:36:12 INFO - 'MAIL': '/var/mail/cltbld', 03:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:12 INFO - 'MOZ_NO_REMOTE': '1', 03:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:12 INFO - 'NO_EM_RESTART': '1', 03:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:12 INFO - 'PWD': '/builds/slave/test', 03:36:12 INFO - 'SHELL': '/bin/bash', 03:36:12 INFO - 'SHLVL': '1', 03:36:12 INFO - 'TERM': 'linux', 03:36:12 INFO - 'TMOUT': '86400', 03:36:12 INFO - 'USER': 'cltbld', 03:36:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 03:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:12 INFO - '_': '/tools/buildbot/bin/python'} 03:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:13 INFO - Running setup.py (path:/tmp/pip-z_dBnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:13 INFO - Running setup.py (path:/tmp/pip-PylSjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:13 INFO - Running setup.py (path:/tmp/pip-mqkyyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:13 INFO - Running setup.py (path:/tmp/pip-JGjvMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:13 INFO - Running setup.py (path:/tmp/pip-xPtvCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:13 INFO - Running setup.py (path:/tmp/pip-40VrBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:13 INFO - Running setup.py (path:/tmp/pip-hFxMdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:13 INFO - Running setup.py (path:/tmp/pip-V2CbCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:13 INFO - Running setup.py (path:/tmp/pip-qjM5C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:13 INFO - Running setup.py (path:/tmp/pip-IIcatC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:13 INFO - Running setup.py (path:/tmp/pip-8COcRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:13 INFO - Running setup.py (path:/tmp/pip-E4SZHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:14 INFO - Running setup.py (path:/tmp/pip-tIkDJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:14 INFO - Running setup.py (path:/tmp/pip-Qm0TNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:14 INFO - Running setup.py (path:/tmp/pip-faOJ7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:14 INFO - Running setup.py (path:/tmp/pip-fcUQOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:14 INFO - Running setup.py (path:/tmp/pip-dfui7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:36:14 INFO - Running setup.py install for manifestparser 03:36:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:36:14 INFO - Running setup.py install for mozcrash 03:36:14 INFO - Running setup.py install for mozdebug 03:36:14 INFO - Running setup.py install for mozdevice 03:36:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:36:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:36:14 INFO - Running setup.py install for mozfile 03:36:14 INFO - Running setup.py install for mozhttpd 03:36:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:36:14 INFO - Running setup.py install for mozinfo 03:36:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:36:15 INFO - Running setup.py install for mozInstall 03:36:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:36:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:36:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:36:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:36:15 INFO - Running setup.py install for mozleak 03:36:15 INFO - Running setup.py install for mozlog 03:36:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:36:15 INFO - Running setup.py install for moznetwork 03:36:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:36:15 INFO - Running setup.py install for mozprocess 03:36:15 INFO - Running setup.py install for mozprofile 03:36:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:36:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:36:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:36:15 INFO - Running setup.py install for mozrunner 03:36:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:36:15 INFO - Running setup.py install for mozscreenshot 03:36:15 INFO - Running setup.py install for moztest 03:36:16 INFO - Running setup.py install for mozversion 03:36:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:36:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:36:16 INFO - Cleaning up... 03:36:16 INFO - Return code: 0 03:36:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:16 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 0x7f159b9ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792410>, '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 0x1793310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17937a0>, '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': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:16 INFO - Using env: {'DISPLAY': ':0', 03:36:16 INFO - 'HOME': '/home/cltbld', 03:36:16 INFO - 'LANG': 'en_US.UTF-8', 03:36:16 INFO - 'LANGUAGE': 'en_US:en', 03:36:16 INFO - 'LOGNAME': 'cltbld', 03:36:16 INFO - 'MAIL': '/var/mail/cltbld', 03:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:16 INFO - 'MOZ_NO_REMOTE': '1', 03:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:16 INFO - 'NO_EM_RESTART': '1', 03:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:16 INFO - 'PWD': '/builds/slave/test', 03:36:16 INFO - 'SHELL': '/bin/bash', 03:36:16 INFO - 'SHLVL': '1', 03:36:16 INFO - 'TERM': 'linux', 03:36:16 INFO - 'TMOUT': '86400', 03:36:16 INFO - 'USER': 'cltbld', 03:36:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 03:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:16 INFO - '_': '/tools/buildbot/bin/python'} 03:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:16 INFO - Running setup.py (path:/tmp/pip-_UjTDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:16 INFO - Running setup.py (path:/tmp/pip-kgSVE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:16 INFO - Running setup.py (path:/tmp/pip-RADiWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:16 INFO - Running setup.py (path:/tmp/pip-Q50wB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:16 INFO - Running setup.py (path:/tmp/pip-uX2tCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:16 INFO - Running setup.py (path:/tmp/pip-peyNJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:16 INFO - Running setup.py (path:/tmp/pip-gU9YPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:16 INFO - Running setup.py (path:/tmp/pip-wTMI1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:16 INFO - Running setup.py (path:/tmp/pip-pRpMlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:17 INFO - Running setup.py (path:/tmp/pip-lMBa_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:17 INFO - Running setup.py (path:/tmp/pip-QsiXy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:17 INFO - Running setup.py (path:/tmp/pip-zT4wet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:17 INFO - Running setup.py (path:/tmp/pip-J_TQgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:17 INFO - Running setup.py (path:/tmp/pip-itR6gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:17 INFO - Running setup.py (path:/tmp/pip-7P12u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:17 INFO - Running setup.py (path:/tmp/pip-b2v1Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:17 INFO - Running setup.py (path:/tmp/pip-wvUKjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:36:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:19 INFO - Downloading blessings-1.6.tar.gz 03:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:36:19 INFO - Installing collected packages: blessings 03:36:19 INFO - Running setup.py install for blessings 03:36:19 INFO - Successfully installed blessings 03:36:19 INFO - Cleaning up... 03:36:19 INFO - Return code: 0 03:36:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:36:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:19 INFO - Reading from file tmpfile_stdout 03:36:19 INFO - Current package versions: 03:36:19 INFO - argparse == 1.2.1 03:36:19 INFO - blessings == 1.6 03:36:19 INFO - blobuploader == 1.2.4 03:36:19 INFO - docopt == 0.6.1 03:36:19 INFO - manifestparser == 1.1 03:36:19 INFO - mozInstall == 1.12 03:36:19 INFO - mozcrash == 0.17 03:36:19 INFO - mozdebug == 0.1 03:36:19 INFO - mozdevice == 0.48 03:36:19 INFO - mozfile == 1.2 03:36:19 INFO - mozhttpd == 0.7 03:36:19 INFO - mozinfo == 0.9 03:36:19 INFO - mozleak == 0.1 03:36:19 INFO - mozlog == 3.1 03:36:19 INFO - moznetwork == 0.27 03:36:19 INFO - mozprocess == 0.22 03:36:19 INFO - mozprofile == 0.28 03:36:19 INFO - mozrunner == 6.11 03:36:19 INFO - mozscreenshot == 0.1 03:36:19 INFO - mozsystemmonitor == 0.0 03:36:19 INFO - moztest == 0.7 03:36:19 INFO - mozversion == 1.4 03:36:19 INFO - psutil == 3.1.1 03:36:19 INFO - requests == 1.2.3 03:36:19 INFO - wsgiref == 0.1.2 03:36:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:19 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 0x7f159b9ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792410>, '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 0x1793310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17937a0>, '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': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:19 INFO - Using env: {'DISPLAY': ':0', 03:36:19 INFO - 'HOME': '/home/cltbld', 03:36:19 INFO - 'LANG': 'en_US.UTF-8', 03:36:19 INFO - 'LANGUAGE': 'en_US:en', 03:36:19 INFO - 'LOGNAME': 'cltbld', 03:36:19 INFO - 'MAIL': '/var/mail/cltbld', 03:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:19 INFO - 'MOZ_NO_REMOTE': '1', 03:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:19 INFO - 'NO_EM_RESTART': '1', 03:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:19 INFO - 'PWD': '/builds/slave/test', 03:36:19 INFO - 'SHELL': '/bin/bash', 03:36:19 INFO - 'SHLVL': '1', 03:36:19 INFO - 'TERM': 'linux', 03:36:19 INFO - 'TMOUT': '86400', 03:36:19 INFO - 'USER': 'cltbld', 03:36:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 03:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:19 INFO - '_': '/tools/buildbot/bin/python'} 03:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:36:20 INFO - Cleaning up... 03:36:20 INFO - Return code: 0 03:36:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:20 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 0x7f159b9ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792410>, '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 0x1793310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17937a0>, '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': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:36:20 INFO - Using env: {'DISPLAY': ':0', 03:36:20 INFO - 'HOME': '/home/cltbld', 03:36:20 INFO - 'LANG': 'en_US.UTF-8', 03:36:20 INFO - 'LANGUAGE': 'en_US:en', 03:36:20 INFO - 'LOGNAME': 'cltbld', 03:36:20 INFO - 'MAIL': '/var/mail/cltbld', 03:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:20 INFO - 'MOZ_NO_REMOTE': '1', 03:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:20 INFO - 'NO_EM_RESTART': '1', 03:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:20 INFO - 'PWD': '/builds/slave/test', 03:36:20 INFO - 'SHELL': '/bin/bash', 03:36:20 INFO - 'SHLVL': '1', 03:36:20 INFO - 'TERM': 'linux', 03:36:20 INFO - 'TMOUT': '86400', 03:36:20 INFO - 'USER': 'cltbld', 03:36:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 03:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:20 INFO - '_': '/tools/buildbot/bin/python'} 03:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:20 INFO - Downloading/unpacking jsonschema 03:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:36:22 INFO - Downloading/unpacking functools32 (from jsonschema) 03:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:36:22 INFO - warning: no files found matching '*.txt' 03:36:22 INFO - no previously-included directories found matching 'build' 03:36:22 INFO - no previously-included directories found matching 'dist' 03:36:22 INFO - no previously-included directories found matching '.git*' 03:36:22 INFO - Installing collected packages: jsonschema, functools32 03:36:22 INFO - Running setup.py install for functools32 03:36:22 INFO - warning: no files found matching '*.txt' 03:36:22 INFO - no previously-included directories found matching 'build' 03:36:22 INFO - no previously-included directories found matching 'dist' 03:36:22 INFO - no previously-included directories found matching '.git*' 03:36:22 INFO - Successfully installed jsonschema functools32 03:36:22 INFO - Cleaning up... 03:36:22 INFO - Return code: 0 03:36:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:22 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 0x7f159b9ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792410>, '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 0x1793310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17937a0>, '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': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:36:22 INFO - Using env: {'DISPLAY': ':0', 03:36:22 INFO - 'HOME': '/home/cltbld', 03:36:22 INFO - 'LANG': 'en_US.UTF-8', 03:36:22 INFO - 'LANGUAGE': 'en_US:en', 03:36:22 INFO - 'LOGNAME': 'cltbld', 03:36:22 INFO - 'MAIL': '/var/mail/cltbld', 03:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:22 INFO - 'MOZ_NO_REMOTE': '1', 03:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:22 INFO - 'NO_EM_RESTART': '1', 03:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:22 INFO - 'PWD': '/builds/slave/test', 03:36:22 INFO - 'SHELL': '/bin/bash', 03:36:22 INFO - 'SHLVL': '1', 03:36:22 INFO - 'TERM': 'linux', 03:36:22 INFO - 'TMOUT': '86400', 03:36:22 INFO - 'USER': 'cltbld', 03:36:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 03:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:22 INFO - '_': '/tools/buildbot/bin/python'} 03:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:22 INFO - Downloading/unpacking flake8 03:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:36:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:36:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:36:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:36:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:36:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:36:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:36:25 INFO - no previously-included directories found matching 'docs/_build' 03:36:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:36:25 INFO - Running setup.py install for pep8 03:36:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:36:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:36:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:36:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:36:25 INFO - no previously-included directories found matching 'docs/_build' 03:36:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:36:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:36:25 INFO - Cleaning up... 03:36:25 INFO - Return code: 0 03:36:25 INFO - Running post-action listener: _resource_record_post_action 03:36:25 INFO - Running post-action listener: _start_resource_monitoring 03:36:25 INFO - Starting resource monitoring. 03:36:25 INFO - ##### 03:36:25 INFO - ##### Running install step. 03:36:25 INFO - ##### 03:36:25 INFO - Running pre-action listener: _resource_record_pre_action 03:36:25 INFO - Running main action method: install 03:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:26 INFO - Reading from file tmpfile_stdout 03:36:26 INFO - Detecting whether we're running mozinstall >=1.0... 03:36:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:36:26 INFO - Reading from file tmpfile_stdout 03:36:26 INFO - Output received: 03:36:26 INFO - Usage: mozinstall [options] installer 03:36:26 INFO - Options: 03:36:26 INFO - -h, --help show this help message and exit 03:36:26 INFO - -d DEST, --destination=DEST 03:36:26 INFO - Directory to install application into. [default: 03:36:26 INFO - "/builds/slave/test"] 03:36:26 INFO - --app=APP Application being installed. [default: firefox] 03:36:26 INFO - mkdir: /builds/slave/test/build/application 03:36:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:36:41 INFO - Reading from file tmpfile_stdout 03:36:41 INFO - Output received: 03:36:41 INFO - /builds/slave/test/build/application/firefox/firefox 03:36:41 INFO - Running post-action listener: _resource_record_post_action 03:36:41 INFO - ##### 03:36:41 INFO - ##### Running run-tests step. 03:36:41 INFO - ##### 03:36:41 INFO - Running pre-action listener: _resource_record_pre_action 03:36:41 INFO - Running main action method: run_tests 03:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:36:41 INFO - Python 2.7.3 03:36:41 INFO - Return code: 0 03:36:41 INFO - grabbing minidump binary from tooltool 03:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:41 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 0x1792410>, '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 0x1793310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17937a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:36:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:36:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:36:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:36:41 INFO - Return code: 0 03:36:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:36:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:36:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:36:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:36:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:36:42 INFO - Return code: 0 03:36:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:36:42 INFO - Using env: {'DISPLAY': ':0', 03:36:42 INFO - 'HOME': '/home/cltbld', 03:36:42 INFO - 'LANG': 'en_US.UTF-8', 03:36:42 INFO - 'LANGUAGE': 'en_US:en', 03:36:42 INFO - 'LOGNAME': 'cltbld', 03:36:42 INFO - 'MAIL': '/var/mail/cltbld', 03:36:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:36:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:42 INFO - 'MOZ_NO_REMOTE': '1', 03:36:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:42 INFO - 'NO_EM_RESTART': '1', 03:36:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:42 INFO - 'PWD': '/builds/slave/test', 03:36:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:36:42 INFO - 'SHELL': '/bin/bash', 03:36:42 INFO - 'SHLVL': '1', 03:36:42 INFO - 'TERM': 'linux', 03:36:42 INFO - 'TMOUT': '86400', 03:36:42 INFO - 'USER': 'cltbld', 03:36:42 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464431749.720353-1134318009', 03:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:42 INFO - '_': '/tools/buildbot/bin/python'} 03:36:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:36:43 INFO - mozversion application_buildid: 20160525183450 03:36:43 INFO - mozversion application_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:36:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:36:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:36:43 INFO - mozversion application_name: Firefox 03:36:43 INFO - mozversion application_remotingname: firefox-dev 03:36:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:36:43 INFO - mozversion application_vendor: Mozilla 03:36:43 INFO - mozversion application_version: 48.0a2 03:36:43 INFO - mozversion platform_buildid: 20160525183450 03:36:43 INFO - mozversion platform_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:36:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:36:43 INFO - mozversion platform_version: 48.0a2 03:36:43 INFO - using testdate: 1464431803 03:36:43 INFO - actual date: 1464431803 03:36:43 INFO - starting webserver on 'localhost:59317' 03:36:43 INFO - SUITE-START | Running 2 tests 03:36:43 INFO - TEST-START | dromaeo_css 03:36:43 INFO - operating with platform_type : linux_ 03:36:43 INFO - Initialising browser for dromaeo_css test... 03:36:43 INFO - TEST-INFO | started process 30154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNMZV4u/profile http://localhost:59317/getInfo.html) 03:36:48 INFO - PROCESS | 30154 | __metrics Screen width/height:1600/1200 03:36:48 INFO - PROCESS | 30154 | colorDepth:24 03:36:48 INFO - PROCESS | 30154 | Browser inner width/height: 1024/697 03:36:48 INFO - PROCESS | 30154 | __metrics 03:36:49 ERROR - PROCESS | 30154 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:36:50 INFO - TEST-INFO | 30154: exit 0 03:36:50 INFO - Browser initialized. 03:36:50 INFO - Running cycle 1/1 for dromaeo_css test... 03:36:50 INFO - TEST-INFO | started process 30242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNMZV4u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:01 INFO - PROCESS | 30242 | RSS: Main: 142102528 03:37:01 INFO - PROCESS | 30242 | 03:37:53 INFO - PROCESS | 30242 | 1464431873073 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:40:00 INFO - PROCESS | 30242 | Cycle 1(1): loaded http://localhost:59317/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59317/tests/dromaeo/cssquery-ext.html) 03:40:01 INFO - PROCESS | 30242 | RSS: Main: 252055552 03:40:01 INFO - PROCESS | 30242 | 03:43:04 INFO - PROCESS | 30242 | Cycle 1(1): loaded http://localhost:59317/tests/dromaeo/cssquery-ext.html (next: http://localhost:59317/tests/dromaeo/cssquery-jquery.html) 03:43:04 INFO - PROCESS | 30242 | RSS: Main: 221179904 03:43:04 INFO - PROCESS | 30242 | 03:46:06 INFO - PROCESS | 30242 | Cycle 1(1): loaded http://localhost:59317/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59317/tests/dromaeo/cssquery-mootools.html) 03:46:07 INFO - PROCESS | 30242 | RSS: Main: 224980992 03:46:07 INFO - PROCESS | 30242 | 03:49:09 INFO - PROCESS | 30242 | Cycle 1(1): loaded http://localhost:59317/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59317/tests/dromaeo/cssquery-prototype.html) 03:49:09 INFO - PROCESS | 30242 | RSS: Main: 217235456 03:49:09 INFO - PROCESS | 30242 | 03:52:12 INFO - PROCESS | 30242 | Cycle 1(1): loaded http://localhost:59317/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59317/tests/dromaeo/cssquery-yui.html) 03:52:12 INFO - PROCESS | 30242 | RSS: Main: 209240064 03:52:12 INFO - PROCESS | 30242 | 03:55:14 INFO - PROCESS | 30242 | Cycle 1(1): loaded http://localhost:59317/tests/dromaeo/cssquery-yui.html (next: http://localhost:59317/tests/dromaeo/cssquery-dojo.html) 03:55:15 INFO - PROCESS | 30242 | RSS: Main: 246059008 03:55:15 INFO - PROCESS | 30242 | 03:55:15 INFO - PROCESS | 30242 | __start_tp_report 03:55:15 INFO - PROCESS | 30242 | _x_x_mozilla_page_load 03:55:15 INFO - PROCESS | 30242 | _x_x_mozilla_page_load_details 03:55:15 INFO - PROCESS | 30242 | |i|pagename|runs| 03:55:15 INFO - PROCESS | 30242 | |0;dojo.html;3349.3636209120264;3414.6926776590108;3415.1803567143893;3448.465487849381;3450.4306789379752;5645.5483561315095;5671.659700417978;5680.3467601225875;5687;5692.288463942007;5668.971655141719;5708.857278568038;5717.771289148429;5718.456746609076;5721.799737009205;4993.650444468889;5124.590032797386;5240.397354304247;5273.789048438077;5305.761240744176;5194.766235519411;5204.29741984831;5259.684418934857;5264.6051546134;5266.210068489719;5003.449620541737;5086.21163719624;5099.337086178792;5111.667741596803;5251.369835619731;5262.473752624745;5285.656432331886;5291.126964050927;5295.867603309909;5320.52115309624;5027.698338099725;5036.017976494585;5036.370453693288;5171.870703232449;5193.974030129825;5557.5831812613815;5563.109902415594;5616.129499927518;5621.016322143609;5642.238297829782;6079.726412311456;6099.939000609981;6102.69486525672;6105.511559075263;6108.755649774003;6136.417040381157;6138.38839838597;6176.413240742122;6215.533834962351;6233.407826256498;5681.715914204315;5727.140928860663;5727.828165155052;5729.255196824428;5731.283589551306;6083.9845701836575;6254.9687251563455;6257.468115210167;6264.68676566179;6268.561200715906;5958.493528050078;5960.880782384328;5990.9101363479585;6033.215681961405;6038.124471951543;6029.969850150721;6030.819075427744;6036.094585812163;6087.908681369694;6104.26748790148;5989.131575921467;6030.7889223876955;6030.9445846976605;6031.879362412815;6050.515958723292;6109.358517355702;6158.507319414436;6159.137720719103;6169.537284703665;6172.537059720539;4609.446866376056;4642.907141857144;4646.95353046472;4650.697704649187;4675.789589468414;4055.513338399352;4060.817263223162;4124.319487284564;4168.124693814272;4193.18232944579;5814.127880817911;5822.272215973004;5827.883442331215;5830.271216097988;5831.300243970751;6139.355367686418;6167.136600875881;6189.164462797555;6190.288116866618;6205;5633.8309850704545;5709.7716091356715;5781.075027995501;5806.187133801272;5828.0966450200285;5243.161094224905;5257.710825904612;5260.947390526122;5268.446813084647;5271.314729085195;6367.904481432783;6371.426571608577;6395.968020159869;6411.487081033506;6412.422881940648;5923.614965027259;6110.5587591967305;6121.908171377344;6133.815985520441;6170.413810688067;6315.684215789284;6386.425221730066;6429.260635026844;6429.742810287723;6432.45324147434;6047.516198704006;6078.483328917092;6080.726367313393;6089.634621922699;6089.908651370321;5999.70001499932;6119.197913140594;6232.345603711545;6234.314225435108;6235;6008.068749343859;6018.187544681412;6047.274327080779;6060.937422337024;6085;5850.64896106235;5964.821055368346;6000.459958603747;6029.638221706711;6032;5874.911876321944;5942.405759424023;5946.851328716817;5966.403359663999;5983.730732116978;5953.077273022688;5975.731092100953;5983.401659833982;5983.790567330123;5984.581079324405;5759.107338362561;5837.6497410155525;5844.590878638454;5869.706514674163;5901.734421950937 03:55:15 INFO - PROCESS | 30242 | |1;ext.html;668.5554106519164;673.8416472129052;676.9593824370538;681.1961884975728;738.0294912190473;32982.34035319295;33585.83207083964;39707.816070116096;40129.799351003276;40267.19465610686;44009.7799511002;44452;44498.55501444985;44502.33246501305;44587.33119003218;7975.202479752007;8810.471371717702;8988.55057247135;8990.820183596325;9009;10660.520276587573;10894.128469722404;10898.18263630227;10901.236913416024;10957.397343146124;10630.893691063067;10703.518341674644;10704.839427408595;10707.625233116842;10707.732306692316;8178.550179740112;10406.271560990734;10515.894841051606;10650.201234907412;10654.573817047309;10622.36265824053;10737.83893241602;10748.355098694024;10750.354978701303;10753.946230268877;41712.165756685;42268.57731422677;42277.36583951243;42320;42369.78815105936;3889.961100388988;3972.205558888234;4021.738586991836;4063.1467391847746;4271.431399722839;34536.654633453596;34930.476042859125;35347.823260883786;35380.29239415223;35397.646023539695;4083.448734420845;4134.834606615732;4167.5832416758085;4168.499780026416;4215;347270;348038;350421.24789376144;350443;350648;39989.600103998586;68173.31826681769;69509.30490695129;69585;69642.65178674074;40148.197036059115;40198;40309;40327.39508907369;40351;16496.6700665986;16684.49946501607;16695.83304166967;16705.83294167043;16714.916425417796;12825.807612885814;13577.117487363488;13883.167009979434;13917.58247252584;14007.929960350133;9194.264458843276;9261.861072083924;9326.393784403992;9363.485008324607;9382.24942004638;3633.328668812323;3637.3634613942454;3647.252313275772;3678.172411207457;3698.7965661888857;1070.240129508058;1098.2696506822874;1170.8770579089244;1256.7109564800148;1271.580378475101;32155;33188.3362332752;33323;33480;34136.82931585326;1212.89083982442;1237.4926280225066;1277.1953669188351;1305.4222565580699;1329.1559859489294;17607.383741568985;17842.28630854751;17977.730334044998;17980.55048623795;18340.633187336178;512587;519634;520261;521177;521314;61665;62388;62504.68747656324;62539.68730156411;62573.37426625766;1368.9657758556116;1455.1487379882888;1506.9698606027598;1512.2060918018128;1530.900491468051;30708.385832283675;31490.212744680648;31931.521027184146;32300;32777.344453111284;46020;46130.76934615306;46441;46494.767526162155;46606;321202;323078;323132;324337;324347;27377.31556711098;30652;31083.533746994264;31464.528032079994;31623.367532649678;47977.80365149806;47995;48655;49167;49289.75355123202;38597.80701096589;40333;41054.178916420904;41296.79351603223;41932.58067419287;39465.21069578535;40998.79500602478;41203.175936481704;41374.52723807137;41798.79100604599;41319.1736165281;41600.37599435951;42037;42941.78529107334;43003.56996429995;35837;36508.634913651586;37102.25856309496;37390.62609373871;37482.437763434114;28285.57571636468;28411.289717757223;28426.04579557433;28442.857785710938;28533 03:55:15 INFO - PROCESS | 30242 | |2;jquery.html;415.52630001797957;417.8036322928223;423.6695377605465;426.8378016353785;435.3404592043055;14669.339879705412;18789.060546972665;19353.129109190086;19354;19995.900020499914;19086.33197838076;19564;19893;20787.272445464412;20856.582868342663;5787.305523337205;5917;5924.851878703023;5927.673977931212;5954.642721436706;5853.970730146365;5879.470847623713;5916.881662366772;5923.555733319997;5926.496247818941;4237.131388065439;4412.492563355223;4412.624926881219;6032.517398608101;6382.393672601095;6044.909326360108;6358.268799088095;6364.522660800459;6377.33038031007;6378.585391949531;5717.914231286492;5720.313562372542;5733.455321744427;5735.340435849889;5737.08206686928;22197.445063873372;22242.332730018126;23655.172068977503;24544.386390340384;24608.876955615287;2577.510273048115;2692.8065449466344;2747.5466548019554;2783.958240626392;3224.4357237483346;14771.852281477155;14888.776668349983;15142.242887855673;15384.691992450984;15508.891711654489;2073.8237249833783;2090.686397040441;2311.6879221305076;2333.1950477085547;2340.2511196417154;62586.37413625851;63845.68077159631;67304;70948.29051709469;80569;10262.640807571699;10648.254622176373;10711.303765255388;10728.678139655824;11192.10463162945;14117.576472705836;14167;14230.928845355707;14248.572542823731;14277.92861035709;8083.878741818878;8193.549354785544;8414.410991230678;8564.74305770828;8573.828523429496;8485.95757021211;8504.447210931394;8545.145485451405;8559.144085591392;8624.137586241326;4639.744814035193;4761.6904901181315;4792.9281060784115;4795.928061079087;4831.4685384607665;1820.4538638408424;1871.9344822931132;1946.7079938009413;1965.891875946808;2012.2554654777825;1011.9898801012043;1075.6074032977906;1123.9550417983353;1135.3755434510986;1203.3201241298639;17588.648227035388;19727.309544165884;19846.305379311656;19856.305029324194;20114;1110.9222354435112;1112.4826955465746;1114.916381271408;1137.4256000719583;1153.8096214124744;11006.669799906016;11365.431728413547;11372.658820235407;11412.201145919871;11568.88431115695;479039;490390;495791;503807;504315;88012.5599371999;90329;90364;92983;95031;1063.8244689626124;1085.3054045410943;1097.6981330134277;1104.2601457023814;1107.3798672743128;17112.65774684524;17622.471325860246;17723.734143987593;17826.19782109834;17947.730784037987;39614;39917.201655966135;40161;40350.9912252196;40525.79737101414;54728;55998.1600275988;59299;60186;63925.6803715997;8479.236868681848;8593.82812343762;8603.956980215058;8724.825503490021;8920.776980575538;10702.715674119156;13184.27486488214;13205.801912971505;13348.532801351907;13483.528076517276;7715;11522.711932201762;11704.590339338083;11847.822282665595;11947.402629868646;9482.478463684563;11512.30926144434;11978.341191234218;12022.519099235933;12066.818997715216;10068.39589624625;10992.010719035325;12350.505979760708;12518.061145413949;12719.236845789283;8930.598123084346;8931.553422328987;9041.95479022627;9053.411528250643;9053.59258833341;9410.858837117587;12022.218555793845;12534.310612916377;12602.432890519765;12659.936700316808 03:55:15 INFO - PROCESS | 30242 | |3;mootools.html;1413.0320730299752;1582.0349586752084;1587.1270801059413;1772.680917434862;1913.3398977352808;8043.0348358197025;8208.466449680767;8215.753527394188;8226.58867056647;8237.423380363376;8114.066882308536;8304.418690691638;8312.584370781467;8317.043539992903;8323.75028749137;2048.4059622709397;2315.3285547191294;2372.9406764830846;2384.2727967969763;2398.928032159038;2373.0626402570974;2385.3082606044227;2385.4155731845635;2386.009805930537;2389.9880500597474;2294.8164146868294;2353.8352315337934;2356.0575769692173;2356.929292121239;2358.457554762397;2017.6065667194903;2313.248194336839;2364.1134574534376;2367.621180611103;2367.8579285242768;2330.5105927755194;2365.207655435414;2377.5601513719844;2388.713354397466;2392.2225276785116;8312;8323.334133269385;8357.080721120672;8362.623681934267;8370.372222083308;5006.649534532584;5097.439281679012;5129.666571672867;5147;5149.0474262261605;3326.6839650233187;3334.6498617645284;3345.565076540034;3380.3070370573973;3434.0899661589697;1134.8297755336682;1145.1754736589642;1192.8786940276113;1214.1197631717023;1234.4630085912568;11792.64622061331;11795;11800.586979455764;11820.290782553075;11848.703782405422;4478.596926276586;4540.228161212602;4558.133954548625;4567.657425693086;4657.3246879202325;10151.9492402539;10172.593096276067;10192.082712555906;10204.795904082026;10205;4641.559051890133;5360.758765855546;5364.678119312854;5366;5366.892662146735;4686.179918514246;4732.763361831895;4738.099761045391;4759.16714574948;4769.42766867978;4177.832886684499;4196.391523229115;4235.788210589458;4271.572842715704;4287.957120428756;1328.734253149374;1365.5834970334145;1368.2543014057362;1368.3363568669386;1373.7527245095978;954.2556805691572;1017.8218811707922;1030.7114008077751;1036.8030074285862;1049.4542837724493;5967.5524335675;5979.491743201789;6050.45545900871;6238.282597501346;6250.999840025665;1034.4879284753945;1067.3755852826027;1074.699084256394;1101.4162493878257;1101.8760863918758;4254.851080212177;4313.741175529478;4320.308750599889;4332;4360;10191.286609937382;10629.149668026539;10632.627858024933;10634.787304253872;10655.520501577448;9784.119429251401;10099.192064634812;10400.063994240403;10406.115480184118;10423.697037870266;8074.071481779671;8091.55496447701;8134.186581341818;8185.672573097128;8194.09864914859;5878.3239927407185;5999.5800293979;6013.9699301503215;6032.517398608188;6088.543359247986;8947.910520894708;8993.685221017233;9063.864042039506;9217.216536594464;9219.677311294072;9272.119148680864;9314.44113353201;9373.437593744397;9475.289353298393;9678.419294842332;6936.7572134975035;7344.559326440431;7524.17234104259;7717.768466946;7851.175626559358;8134.796630084058;8154;8160.918390816016;8192.262696357118;8194.057683366489;7183.53307035062;7359.411247100112;7407.148177959603;7466.552006879388;7587.051618547682;7146.285371462812;7149.785506434815;7158.749443769443;7228.566286022856;7337.779866604011;7077.292270772881;7102.112235970504;7127.322904324081;7129;7148.642567871481;5076.18780995039;5214.666124505373;5277.366715993951;5284.154535274338;5301.204819277139;5412.296401467784;5423.647462914898;5512;5550.167474878639;5569.498745112959 03:55:15 INFO - PROCESS | 30242 | |4;prototype.html;344.83964956295347;345.7372396978296;346.4647120199292;346.7139609821896;347.1875810603189;6269.5611307208455;6330.3036665966765;6403.135576697145;6414.166158399407;6426.325235850239;6255.311915689282;6312.6212427254395;6314.989601663735;6316.494680425566;6317.3050964394;4787.80848766049;4791.640626952975;4796.3764710587575;4797.9760101199445;4800.183968725308;4796.712197268175;4797;4798.328234047236;4806.927896081562;4809.543093406139;4776.617870570363;4777.8566643000595;4777.928331075037;4788.856334309976;4790.018046300517;4599.747013914233;4774.73738944358;4775.164346239411;4784.162771514988;4786.21027530457;4140.523839758406;4148.709590328678;4156.189543039109;4161.667066634662;4162.250794856925;6067.484263837579;6068.362821903725;6072.574919755619;6075.7873474428625;6076.665783381913;5522.972385138049;5544.473275038865;5568.081266591008;5581.302337207849;5583.190437386556;6612.239592446882;6659.76690815824;6667.299933507009;6675.899861502033;6692.59844409337;4633.652476064309;4646.279826626878;4648.372469716613;4648.930266046012;4652.651051171176;6644.60132392058;6776.627285499296;6805.659717014179;7018.157821061454;7029.472789540805;4698.389209402756;4729.125111854318;4744.857654270378;4754.168020596382;4767.237242041326;4821.300911367832;4823.855284341475;4826;4829.1307564638;4830.9371938173545;5243.318368612056;5442.12925931849;5551.250581171571;5592.217089607459;5597.188407680945;6719.798406047827;6742.157230346207;6747;6748;6748.7300507979135;1668.7246604310153;1698.3716025070803;1698.3800912666788;1702.540314115182;1704.6761115388038;1092.1481244629201;1114.9498272577753;1119.9944000279947;1122.354646078508;1133.863936327646;6492.67536623167;6526.151600291932;6529.085927970088;6532.150820393318;6535.444487218545;6945.652717364112;6957.095577574883;6960.686769095403;6963.79108626742;6970.337817907291;6515.087887695727;6520;6520.054592084121;6520.510961677893;6530.412262896362;3725.1245957200035;3737.850485980585;3746.0447585865977;3746.812659367021;3766.4162054881535;7118.323759242864;7322.780316590511;7333.1933487316355;7335.706571737071;7344.669489872968;7096.7516136934955;7125.144982602121;7128.6435678215885;7132.429405647639;7162.641867906584;7300.379467745195;7307.451941104438;7311.415086793044;7312.085989251344;7315.4147668186415;6862.553933994274;6998.440124790106;7005.388760585196;7011.088558487364;7012.737707212751;6617.470602351897;6716.764913228014;6850.246472887879;6904.516683832285;6910.7581234656545;7166.140063192451;7238.384737297389;7247.9637601811655;7261.128664560287;7274;4728.361671174485;4764.094821983812;4764.309175169512;4766.737829419415;4771.141194585008;6943.305669433016;6963.6866341013765;6965.233824279224;6972.372486476242;6974.860502789814;6669.966650166718;6805.829854253485;6812.4890633203695;6818.761343353157;6819.352161544645;6749.662516874038;6762.594244345355;6768.661566921733;6773.424258937848;6779.593224406552;6641.402273795382;6645.534812563074;6649.335066493505;6651;6654.733810647714;6764.763233286812;6765.1205343305055;6765.323467653196;6769.255381907888;6773.762918297836;6483.189601299838;6633.038209459505;6642.767503137367;6674.966625166843;6686 03:55:15 INFO - PROCESS | 30242 | |5;yui.html;889.3305179480808;895.4000819450968;898.7708134425721;901.2114399900088;917.7338571814174;14754.926225368872;15202.771958420619;15210.619734506643;16509.09199994;17046.573835654115;14924.029938054045;14974.775378369333;15020.474283400083;15060.698786024273;15061.849381506181;736.8489459660757;855.0295414704293;874.3398733955854;874.637025634361;886.2068448738376;877.5129802959354;882.1443200095897;883.8409086364452;883.9911600883974;885.1900511032397;917.5641570254143;926.666400095965;926.8053708721177;926.8702381666573;927.717046300878;763.1872056260065;767.2825907776219;905.5834316214549;912.8311262416441;921.1571412157934;666.9566478178903;672.0322735261257;672.1530871102398;672.357898207211;672.5090683800853;15081.698366032619;15183.62040948974;15192.088474691443;15232.771508427271;15250;14437.855621443756;14759.557213283619;14782.630434239123;14847.183404912725;15013.3244004019;11653.30080195191;11865.881341186563;11891.643250702406;11923.105767067505;12067.57763478274;3915.706322025831;3962.9009274768073;3990.657190768999;3997.200559888005;4029.879103626896;60392.39607603912;60971;62007.689961549906;62027.37972620261;62052.75894482085;11556.76886462266;11763.588274410355;11829.585964491202;11995.1003674723;12056.336901470504;19542;19726.506837329183;19873.801261987483;19877.204911803656;19910.90044549797;8268.793280167924;8310;8461.069282378934;8702.129787021247;8808.163224493663;4602.424696912886;4677.7193368398;4805.663603547718;4844.491328410466;5011.0479008988905;3580.5524309461316;3644.1618427761764;3664.340418724655;3674.430463278196;3687.7971711555583;598.201401129497;667.2626747444101;668.6322522612641;674.784069097884;687.6733551563068;698.8392669686001;725.1950335128109;772.0812233442298;774.1329710723912;810.2100452059195;9520.666776662922;9671.468069256118;10264.178865690727;10419.218558608134;10468.214883883738;704.7286794584122;759.2293821770907;765.6516285090271;771.5100910921606;787.582581231948;4475.5748203920575;4535.183666939983;4622.6764126510825;4628.907421851544;4652.860414187579;64559;64779.67610161919;64983;65016.34983650103;65265.67367163134;56074.71962640161;59345.10982335269;59510.70244648836;59613;60347;50890;52340;52508.36120401341;52601;53112.203316950276;9553.18797902186;9570.377925434825;9592.76018099553;9714.708558743248;9729.756756081155;37708.43437348387;37722.81138594289;38276;39492.2101557973;41057.384139237336;49853.252201217736;51976;52158.21762673487;52254.47745522496;53314;13041.869581304065;13121.409536571067;13169.868301316865;13187.868121319048;13267.004974626749;14551.92724036373;14850.257487125817;14874.851251487347;14988.775168372702;15390.692186156439;13831.585052448443;13931.930340348234;14132.929335353258;14145.222012789396;14322.856771432153;14041.648958775704;14099.224542650252;14113.858861411254;14253.429862805371;14269.42922283097;13537.187768733907;13761.655958601115;13901.930490347484;14078.155310681392;14146.646333841736;11327.433628318386;11503.194776365573;11545.36500492481;11558.190926635054;11866;11399.601013964471;11543.19197656156;11759.412479315182;11846;12014.33921134346 03:55:15 INFO - PROCESS | 30242 | __end_tp_report 03:55:15 INFO - PROCESS | 30242 | __start_cc_report 03:55:15 INFO - PROCESS | 30242 | _x_x_mozilla_cycle_collect,828 03:55:15 INFO - PROCESS | 30242 | __end_cc_report 03:55:15 INFO - PROCESS | 30242 | __startTimestamp1464432915224__endTimestamp 03:55:15 INFO - PROCESS | 30242 | 03:55:15 INFO - PROCESS | 30242 | ------- Summary: start ------- 03:55:15 INFO - PROCESS | 30242 | Number of tests: 6 03:55:15 INFO - PROCESS | 30242 | 03:55:15 INFO - PROCESS | 30242 | [#0] dojo.html Cycles:165 Average:5680.72 Median:5923.61 stddev:646.85 (10.9%) stddev-sans-first:622.44 03:55:15 INFO - PROCESS | 30242 | Values: 3349.4 3414.7 3415.2 3448.5 3450.4 5645.5 5671.7 5680.3 5687.0 5692.3 5669.0 5708.9 5717.8 5718.5 5721.8 4993.7 5124.6 5240.4 5273.8 5305.8 5194.8 5204.3 5259.7 5264.6 5266.2 5003.4 5086.2 5099.3 5111.7 5251.4 5262.5 5285.7 5291.1 5295.9 5320.5 5027.7 5036.0 5036.4 5171.9 5194.0 5557.6 5563.1 5616.1 5621.0 5642.2 6079.7 6099.9 6102.7 6105.5 6108.8 6136.4 6138.4 6176.4 6215.5 6233.4 5681.7 5727.1 5727.8 5729.3 5731.3 6084.0 6255.0 6257.5 6264.7 6268.6 5958.5 5960.9 5990.9 6033.2 6038.1 6030.0 6030.8 6036.1 6087.9 6104.3 5989.1 6030.8 6030.9 6031.9 6050.5 6109.4 6158.5 6159.1 6169.5 6172.5 4609.4 4642.9 4647.0 4650.7 4675.8 4055.5 4060.8 4124.3 4168.1 4193.2 5814.1 5822.3 5827.9 5830.3 5831.3 6139.4 6167.1 6189.2 6190.3 6205.0 5633.8 5709.8 5781.1 5806.2 5828.1 5243.2 5257.7 5260.9 5268.4 5271.3 6367.9 6371.4 6396.0 6411.5 6412.4 5923.6 6110.6 6121.9 6133.8 6170.4 6315.7 6386.4 6429.3 6429.7 6432.5 6047.5 6078.5 6080.7 6089.6 6089.9 5999.7 6119.2 6232.3 6234.3 6235.0 6008.1 6018.2 6047.3 6060.9 6085.0 5850.6 5964.8 6000.5 6029.6 6032.0 5874.9 5942.4 5946.9 5966.4 5983.7 5953.1 5975.7 5983.4 5983.8 5984.6 5759.1 5837.6 5844.6 5869.7 5901.7 03:55:15 INFO - PROCESS | 30242 | 03:55:15 INFO - PROCESS | 30242 | [#1] ext.html Cycles:180 Average:56147.62 Median:20093.40 stddev:107634.15 (535.7%) stddev-sans-first:107855.49 03:55:15 INFO - PROCESS | 30242 | Values: 668.6 673.8 677.0 681.2 738.0 32982.3 33585.8 39707.8 40129.8 40267.2 44009.8 44452.0 44498.6 44502.3 44587.3 7975.2 8810.5 8988.6 8990.8 9009.0 10660.5 10894.1 10898.2 10901.2 10957.4 10630.9 10703.5 10704.8 10707.6 10707.7 8178.6 10406.3 10515.9 10650.2 10654.6 10622.4 10737.8 10748.4 10750.4 10753.9 41712.2 42268.6 42277.4 42320.0 42369.8 3890.0 3972.2 4021.7 4063.1 4271.4 34536.7 34930.5 35347.8 35380.3 35397.6 4083.4 4134.8 4167.6 4168.5 4215.0 347270.0 348038.0 350421.2 350443.0 350648.0 39989.6 68173.3 69509.3 69585.0 69642.7 40148.2 40198.0 40309.0 40327.4 40351.0 16496.7 16684.5 16695.8 16705.8 16714.9 12825.8 13577.1 13883.2 13917.6 14007.9 9194.3 9261.9 9326.4 9363.5 9382.2 3633.3 3637.4 3647.3 3678.2 3698.8 1070.2 1098.3 1170.9 1256.7 1271.6 32155.0 33188.3 33323.0 33480.0 34136.8 1212.9 1237.5 1277.2 1305.4 1329.2 17607.4 17842.3 17977.7 17980.6 18340.6 512587.0 519634.0 520261.0 521177.0 521314.0 61665.0 62388.0 62504.7 62539.7 62573.4 1369.0 1455.1 1507.0 1512.2 1530.9 30708.4 31490.2 31931.5 32300.0 32777.3 46020.0 46130.8 46441.0 46494.8 46606.0 321202.0 323078.0 323132.0 324337.0 324347.0 27377.3 30652.0 31083.5 31464.5 31623.4 47977.8 47995.0 48655.0 49167.0 49289.8 38597.8 40333.0 41054.2 41296.8 41932.6 39465.2 40998.8 41203.2 41374.5 41798.8 41319.2 41600.4 42037.0 42941.8 43003.6 35837.0 36508.6 37102.3 37390.6 37482.4 28285.6 28411.3 28426.0 28442.9 28533.0 03:55:15 INFO - PROCESS | 30242 | 03:55:15 INFO - PROCESS | 30242 | [#2] jquery.html Cycles:180 Average:28947.25 Median:24576.63 stddev:81317.64 (330.9%) stddev-sans-first:81517.54 03:55:15 INFO - PROCESS | 30242 | Values: 415.5 417.8 423.7 426.8 435.3 14669.3 18789.1 19353.1 19354.0 19995.9 19086.3 19564.0 19893.0 20787.3 20856.6 5787.3 5917.0 5924.9 5927.7 5954.6 5854.0 5879.5 5916.9 5923.6 5926.5 4237.1 4412.5 4412.6 6032.5 6382.4 6044.9 6358.3 6364.5 6377.3 6378.6 5717.9 5720.3 5733.5 5735.3 5737.1 22197.4 22242.3 23655.2 24544.4 24608.9 2577.5 2692.8 2747.5 2784.0 3224.4 14771.9 14888.8 15142.2 15384.7 15508.9 2073.8 2090.7 2311.7 2333.2 2340.3 62586.4 63845.7 67304.0 70948.3 80569.0 10262.6 10648.3 10711.3 10728.7 11192.1 14117.6 14167.0 14230.9 14248.6 14277.9 8083.9 8193.5 8414.4 8564.7 8573.8 8486.0 8504.4 8545.1 8559.1 8624.1 4639.7 4761.7 4792.9 4795.9 4831.5 1820.5 1871.9 1946.7 1965.9 2012.3 1012.0 1075.6 1124.0 1135.4 1203.3 17588.6 19727.3 19846.3 19856.3 20114.0 1110.9 1112.5 1114.9 1137.4 1153.8 11006.7 11365.4 11372.7 11412.2 11568.9 479039.0 490390.0 495791.0 503807.0 504315.0 88012.6 90329.0 90364.0 92983.0 95031.0 1063.8 1085.3 1097.7 1104.3 1107.4 17112.7 17622.5 17723.7 17826.2 17947.7 39614.0 39917.2 40161.0 40351.0 40525.8 54728.0 55998.2 59299.0 60186.0 63925.7 8479.2 8593.8 8604.0 8724.8 8920.8 10702.7 13184.3 13205.8 13348.5 13483.5 7715.0 11522.7 11704.6 11847.8 11947.4 9482.5 11512.3 11978.3 12022.5 12066.8 10068.4 10992.0 12350.5 12518.1 12719.2 8930.6 8931.6 9042.0 9053.4 9053.6 9410.9 12022.2 12534.3 12602.4 12659.9 03:55:15 INFO - PROCESS | 30242 | 03:55:15 INFO - PROCESS | 30242 | [#3] mootools.html Cycles:180 Average:5664.68 Median:4735.43 stddev:3070.86 (64.8%) stddev-sans-first:3062.85 03:55:15 INFO - PROCESS | 30242 | Values: 1413.0 1582.0 1587.1 1772.7 1913.3 8043.0 8208.5 8215.8 8226.6 8237.4 8114.1 8304.4 8312.6 8317.0 8323.8 2048.4 2315.3 2372.9 2384.3 2398.9 2373.1 2385.3 2385.4 2386.0 2390.0 2294.8 2353.8 2356.1 2356.9 2358.5 2017.6 2313.2 2364.1 2367.6 2367.9 2330.5 2365.2 2377.6 2388.7 2392.2 8312.0 8323.3 8357.1 8362.6 8370.4 5006.6 5097.4 5129.7 5147.0 5149.0 3326.7 3334.6 3345.6 3380.3 3434.1 1134.8 1145.2 1192.9 1214.1 1234.5 11792.6 11795.0 11800.6 11820.3 11848.7 4478.6 4540.2 4558.1 4567.7 4657.3 10151.9 10172.6 10192.1 10204.8 10205.0 4641.6 5360.8 5364.7 5366.0 5366.9 4686.2 4732.8 4738.1 4759.2 4769.4 4177.8 4196.4 4235.8 4271.6 4288.0 1328.7 1365.6 1368.3 1368.3 1373.8 954.3 1017.8 1030.7 1036.8 1049.5 5967.6 5979.5 6050.5 6238.3 6251.0 1034.5 1067.4 1074.7 1101.4 1101.9 4254.9 4313.7 4320.3 4332.0 4360.0 10191.3 10629.1 10632.6 10634.8 10655.5 9784.1 10099.2 10400.1 10406.1 10423.7 8074.1 8091.6 8134.2 8185.7 8194.1 5878.3 5999.6 6014.0 6032.5 6088.5 8947.9 8993.7 9063.9 9217.2 9219.7 9272.1 9314.4 9373.4 9475.3 9678.4 6936.8 7344.6 7524.2 7717.8 7851.2 8134.8 8154.0 8160.9 8192.3 8194.1 7183.5 7359.4 7407.1 7466.6 7587.1 7146.3 7149.8 7158.7 7228.6 7337.8 7077.3 7102.1 7127.3 7129.0 7148.6 5076.2 5214.7 5277.4 5284.2 5301.2 5412.3 5423.6 5512.0 5550.2 5569.5 03:55:15 INFO - PROCESS | 30242 | 03:55:15 INFO - PROCESS | 30242 | [#4] prototype.html Cycles:180 Average:5625.00 Median:6487.93 stddev:1715.47 (26.4%) stddev-sans-first:1673.87 03:55:15 INFO - PROCESS | 30242 | Values: 344.8 345.7 346.5 346.7 347.2 6269.6 6330.3 6403.1 6414.2 6426.3 6255.3 6312.6 6315.0 6316.5 6317.3 4787.8 4791.6 4796.4 4798.0 4800.2 4796.7 4797.0 4798.3 4806.9 4809.5 4776.6 4777.9 4777.9 4788.9 4790.0 4599.7 4774.7 4775.2 4784.2 4786.2 4140.5 4148.7 4156.2 4161.7 4162.3 6067.5 6068.4 6072.6 6075.8 6076.7 5523.0 5544.5 5568.1 5581.3 5583.2 6612.2 6659.8 6667.3 6675.9 6692.6 4633.7 4646.3 4648.4 4648.9 4652.7 6644.6 6776.6 6805.7 7018.2 7029.5 4698.4 4729.1 4744.9 4754.2 4767.2 4821.3 4823.9 4826.0 4829.1 4830.9 5243.3 5442.1 5551.3 5592.2 5597.2 6719.8 6742.2 6747.0 6748.0 6748.7 1668.7 1698.4 1698.4 1702.5 1704.7 1092.1 1114.9 1120.0 1122.4 1133.9 6492.7 6526.2 6529.1 6532.2 6535.4 6945.7 6957.1 6960.7 6963.8 6970.3 6515.1 6520.0 6520.1 6520.5 6530.4 3725.1 3737.9 3746.0 3746.8 3766.4 7118.3 7322.8 7333.2 7335.7 7344.7 7096.8 7125.1 7128.6 7132.4 7162.6 7300.4 7307.5 7311.4 7312.1 7315.4 6862.6 6998.4 7005.4 7011.1 7012.7 6617.5 6716.8 6850.2 6904.5 6910.8 7166.1 7238.4 7248.0 7261.1 7274.0 4728.4 4764.1 4764.3 4766.7 4771.1 6943.3 6963.7 6965.2 6972.4 6974.9 6670.0 6805.8 6812.5 6818.8 6819.4 6749.7 6762.6 6768.7 6773.4 6779.6 6641.4 6645.5 6649.3 6651.0 6654.7 6764.8 6765.1 6765.3 6769.3 6773.8 6483.2 6633.0 6642.8 6675.0 6686.0 03:55:15 INFO - PROCESS | 30242 | 03:55:15 INFO - PROCESS | 30242 | [#5] yui.html Cycles:180 Average:16072.13 Median:4612.55 stddev:18550.40 (402.2%) stddev-sans-first:18567.40 03:55:15 INFO - PROCESS | 30242 | Values: 889.3 895.4 898.8 901.2 917.7 14754.9 15202.8 15210.6 16509.1 17046.6 14924.0 14974.8 15020.5 15060.7 15061.8 736.8 855.0 874.3 874.6 886.2 877.5 882.1 883.8 884.0 885.2 917.6 926.7 926.8 926.9 927.7 763.2 767.3 905.6 912.8 921.2 667.0 672.0 672.2 672.4 672.5 15081.7 15183.6 15192.1 15232.8 15250.0 14437.9 14759.6 14782.6 14847.2 15013.3 11653.3 11865.9 11891.6 11923.1 12067.6 3915.7 3962.9 3990.7 3997.2 4029.9 60392.4 60971.0 62007.7 62027.4 62052.8 11556.8 11763.6 11829.6 11995.1 12056.3 19542.0 19726.5 19873.8 19877.2 19910.9 8268.8 8310.0 8461.1 8702.1 8808.2 4602.4 4677.7 4805.7 4844.5 5011.0 3580.6 3644.2 3664.3 3674.4 3687.8 598.2 667.3 668.6 674.8 687.7 698.8 725.2 772.1 774.1 810.2 9520.7 9671.5 10264.2 10419.2 10468.2 704.7 759.2 765.7 771.5 787.6 4475.6 4535.2 4622.7 4628.9 4652.9 64559.0 64779.7 64983.0 65016.3 65265.7 56074.7 59345.1 59510.7 59613.0 60347.0 50890.0 52340.0 52508.4 52601.0 53112.2 9553.2 9570.4 9592.8 9714.7 9729.8 37708.4 37722.8 38276.0 39492.2 41057.4 49853.3 51976.0 52158.2 52254.5 53314.0 13041.9 13121.4 13169.9 13187.9 13267.0 14551.9 14850.3 14874.9 14988.8 15390.7 13831.6 13931.9 14132.9 14145.2 14322.9 14041.6 14099.2 14113.9 14253.4 14269.4 13537.2 13761.7 13901.9 14078.2 14146.6 11327.4 11503.2 11545.4 11558.2 11866.0 11399.6 11543.2 11759.4 11846.0 12014.3 03:55:15 INFO - PROCESS | 30242 | -------- Summary: end -------- 03:55:15 INFO - PROCESS | 30242 | 03:55:15 INFO - TEST-INFO | 30242: exit 0 03:55:15 INFO - TEST-OK | dromaeo_css | took 1112927ms 03:55:15 INFO - TEST-START | kraken 03:55:15 INFO - operating with platform_type : linux_ 03:55:15 INFO - Initialising browser for kraken test... 03:55:15 INFO - TEST-INFO | started process 30428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNbKqd0/profile http://localhost:59317/getInfo.html) 03:55:20 INFO - PROCESS | 30428 | __metrics Screen width/height:1600/1200 03:55:20 INFO - PROCESS | 30428 | colorDepth:24 03:55:20 INFO - PROCESS | 30428 | Browser inner width/height: 1024/697 03:55:20 INFO - PROCESS | 30428 | __metrics 03:55:21 INFO - PROCESS | 30428 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:55:21 ERROR - PROCESS | 30428 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:55:22 INFO - TEST-INFO | 30428: exit 0 03:55:22 INFO - Browser initialized. 03:55:22 INFO - Running cycle 1/1 for kraken test... 03:55:22 INFO - TEST-INFO | started process 30518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNbKqd0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:55:34 INFO - PROCESS | 30518 | RSS: Main: 141864960 03:55:34 INFO - PROCESS | 30518 | 03:55:36 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59317/tests/kraken/driver.html?testName=audio-beat-detection) 03:55:37 INFO - PROCESS | 30518 | RSS: Main: 196571136 03:55:37 INFO - PROCESS | 30518 | 03:55:40 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59317/tests/kraken/driver.html?testName=audio-dft) 03:55:41 INFO - PROCESS | 30518 | RSS: Main: 180858880 03:55:41 INFO - PROCESS | 30518 | 03:55:43 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59317/tests/kraken/driver.html?testName=audio-fft) 03:55:44 INFO - PROCESS | 30518 | RSS: Main: 271536128 03:55:44 INFO - PROCESS | 30518 | 03:55:46 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59317/tests/kraken/driver.html?testName=audio-oscillator) 03:55:47 INFO - PROCESS | 30518 | RSS: Main: 177934336 03:55:47 INFO - PROCESS | 30518 | 03:55:49 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59317/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:55:49 INFO - PROCESS | 30518 | RSS: Main: 176050176 03:55:49 INFO - PROCESS | 30518 | 03:55:52 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59317/tests/kraken/driver.html?testName=imaging-darkroom) 03:55:53 INFO - PROCESS | 30518 | RSS: Main: 210927616 03:55:53 INFO - PROCESS | 30518 | 03:55:56 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59317/tests/kraken/driver.html?testName=imaging-desaturate) 03:55:57 INFO - PROCESS | 30518 | RSS: Main: 211509248 03:55:57 INFO - PROCESS | 30518 | 03:56:00 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59317/tests/kraken/driver.html?testName=json-parse-financial) 03:56:00 INFO - PROCESS | 30518 | RSS: Main: 211197952 03:56:00 INFO - PROCESS | 30518 | 03:56:02 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59317/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:56:02 INFO - PROCESS | 30518 | RSS: Main: 190459904 03:56:02 INFO - PROCESS | 30518 | 03:56:04 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59317/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:56:05 INFO - PROCESS | 30518 | RSS: Main: 195194880 03:56:05 INFO - PROCESS | 30518 | 03:56:07 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59317/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:56:07 INFO - PROCESS | 30518 | RSS: Main: 207585280 03:56:07 INFO - PROCESS | 30518 | 03:56:10 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59317/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:56:10 INFO - PROCESS | 30518 | RSS: Main: 212721664 03:56:10 INFO - PROCESS | 30518 | 03:56:13 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59317/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:56:14 INFO - PROCESS | 30518 | RSS: Main: 209080320 03:56:14 INFO - PROCESS | 30518 | 03:56:15 INFO - PROCESS | 30518 | Cycle 1(1): loaded http://localhost:59317/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59317/tests/kraken/driver.html?testName=ai-astar) 03:56:16 INFO - PROCESS | 30518 | RSS: Main: 273100800 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | __start_tp_report 03:56:16 INFO - PROCESS | 30518 | _x_x_mozilla_page_load 03:56:16 INFO - PROCESS | 30518 | _x_x_mozilla_page_load_details 03:56:16 INFO - PROCESS | 30518 | |i|pagename|runs| 03:56:16 INFO - PROCESS | 30518 | |0;ai-astar;110;110;111;111;110;111;106;112;112;109 03:56:16 INFO - PROCESS | 30518 | |1;audio-beat-detection;152;128;162;173;126;150;154;130;191;133 03:56:16 INFO - PROCESS | 30518 | |2;audio-dft;161;162;160;160;159;161;161;161;161;162 03:56:16 INFO - PROCESS | 30518 | |3;audio-fft;74;76;76;167;76;75;76;78;173;75 03:56:16 INFO - PROCESS | 30518 | |4;audio-oscillator;91;93;160;92;93;92;156;92;93;150 03:56:16 INFO - PROCESS | 30518 | |5;imaging-gaussian-blur;118;116;116;117;116;117;117;117;117;117 03:56:16 INFO - PROCESS | 30518 | |6;imaging-darkroom;144;145;146;145;145;144;144;145;145;145 03:56:16 INFO - PROCESS | 30518 | |7;imaging-desaturate;95;95;95;94;94;94;95;94;96;94 03:56:16 INFO - PROCESS | 30518 | |8;json-parse-financial;55;52;55;53;54;54;54;76;52;52 03:56:16 INFO - PROCESS | 30518 | |9;json-stringify-tinderbox;58;58;58;59;57;57;57;58;57;58 03:56:16 INFO - PROCESS | 30518 | |10;stanford-crypto-aes;80;72;73;73;74;74;73;81;73;73 03:56:16 INFO - PROCESS | 30518 | |11;stanford-crypto-ccm;117;113;111;114;110;111;110;115;131;124 03:56:16 INFO - PROCESS | 30518 | |12;stanford-crypto-pbkdf2;159;157;158;156;158;157;160;158;159;155 03:56:16 INFO - PROCESS | 30518 | |13;stanford-crypto-sha256-iterative;67;65;66;68;66;67;67;66;65;64 03:56:16 INFO - PROCESS | 30518 | __end_tp_report 03:56:16 INFO - PROCESS | 30518 | __start_cc_report 03:56:16 INFO - PROCESS | 30518 | _x_x_mozilla_cycle_collect,1608 03:56:16 INFO - PROCESS | 30518 | __end_cc_report 03:56:16 INFO - PROCESS | 30518 | __startTimestamp1464432976015__endTimestamp 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | ------- Summary: start ------- 03:56:16 INFO - PROCESS | 30518 | Number of tests: 14 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.75 (1.6%) stddev-sans-first:1.86 03:56:16 INFO - PROCESS | 30518 | Values: 110.0 110.0 111.0 111.0 110.0 111.0 106.0 112.0 112.0 109.0 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:153.00 stddev:21.40 (14.0%) stddev-sans-first:22.69 03:56:16 INFO - PROCESS | 30518 | Values: 152.0 128.0 162.0 173.0 126.0 150.0 154.0 130.0 191.0 133.0 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 03:56:16 INFO - PROCESS | 30518 | Values: 161.0 162.0 160.0 160.0 159.0 161.0 161.0 161.0 161.0 162.0 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:39.78 (52.3%) stddev-sans-first:41.49 03:56:16 INFO - PROCESS | 30518 | Values: 74.0 76.0 76.0 167.0 76.0 75.0 76.0 78.0 173.0 75.0 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:92.00 stddev:30.55 (33.2%) stddev-sans-first:31.52 03:56:16 INFO - PROCESS | 30518 | Values: 91.0 93.0 160.0 92.0 93.0 92.0 156.0 92.0 93.0 150.0 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 03:56:16 INFO - PROCESS | 30518 | Values: 118.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#6] imaging-darkroom Cycles:10 Average:144.80 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 03:56:16 INFO - PROCESS | 30518 | Values: 144.0 145.0 146.0 145.0 145.0 144.0 144.0 145.0 145.0 145.0 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 03:56:16 INFO - PROCESS | 30518 | Values: 95.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 96.0 94.0 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:54.00 stddev:7.23 (13.4%) stddev-sans-first:7.66 03:56:16 INFO - PROCESS | 30518 | Values: 55.0 52.0 55.0 53.0 54.0 54.0 54.0 76.0 52.0 52.0 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 03:56:16 INFO - PROCESS | 30518 | Values: 58.0 58.0 58.0 59.0 57.0 57.0 57.0 58.0 57.0 58.0 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:73.50 stddev:3.17 (4.3%) stddev-sans-first:2.69 03:56:16 INFO - PROCESS | 30518 | Values: 80.0 72.0 73.0 73.0 74.0 74.0 73.0 81.0 73.0 73.0 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#11] stanford-crypto-ccm Cycles:10 Average:115.60 Median:114.50 stddev:6.87 (6.0%) stddev-sans-first:7.26 03:56:16 INFO - PROCESS | 30518 | Values: 117.0 113.0 111.0 114.0 110.0 111.0 110.0 115.0 131.0 124.0 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:158.00 stddev:1.49 (0.9%) stddev-sans-first:1.51 03:56:16 INFO - PROCESS | 30518 | Values: 159.0 157.0 158.0 156.0 158.0 157.0 160.0 158.0 159.0 155.0 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - PROCESS | 30518 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.20 (1.8%) stddev-sans-first:1.22 03:56:16 INFO - PROCESS | 30518 | Values: 67.0 65.0 66.0 68.0 66.0 67.0 67.0 66.0 65.0 64.0 03:56:16 INFO - PROCESS | 30518 | -------- Summary: end -------- 03:56:16 INFO - PROCESS | 30518 | 03:56:16 INFO - TEST-INFO | 30518: exit 0 03:56:16 INFO - TEST-OK | kraken | took 61031ms 03:56:16 INFO - SUITE-END | took 1173s 03:56:17 INFO - Completed test suite (00:19:34) 03:56:17 INFO - javascript benchmark 03:56:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.3636209120264, 3414.6926776590108, 3415.1803567143893, 3448.465487849381, 3450.4306789379752, 5645.5483561315095, 5671.659700417978, 5680.3467601225875, 5687.0, 5692.288463942007, 5668.971655141719, 5708.857278568038, 5717.771289148429, 5718.456746609076, 5721.799737009205, 4993.650444468889, 5124.590032797386, 5240.397354304247, 5273.789048438077, 5305.761240744176, 5194.766235519411, 5204.29741984831, 5259.684418934857, 5264.6051546134, 5266.210068489719, 5003.449620541737, 5086.21163719624, 5099.337086178792, 5111.667741596803, 5251.369835619731, 5262.473752624745, 5285.656432331886, 5291.126964050927, 5295.867603309909, 5320.52115309624, 5027.698338099725, 5036.017976494585, 5036.370453693288, 5171.870703232449, 5193.974030129825, 5557.5831812613815, 5563.109902415594, 5616.129499927518, 5621.016322143609, 5642.238297829782, 6079.726412311456, 6099.939000609981, 6102.69486525672, 6105.511559075263, 6108.755649774003, 6136.417040381157, 6138.38839838597, 6176.413240742122, 6215.533834962351, 6233.407826256498, 5681.715914204315, 5727.140928860663, 5727.828165155052, 5729.255196824428, 5731.283589551306, 6083.9845701836575, 6254.9687251563455, 6257.468115210167, 6264.68676566179, 6268.561200715906, 5958.493528050078, 5960.880782384328, 5990.9101363479585, 6033.215681961405, 6038.124471951543, 6029.969850150721, 6030.819075427744, 6036.094585812163, 6087.908681369694, 6104.26748790148, 5989.131575921467, 6030.7889223876955, 6030.9445846976605, 6031.879362412815, 6050.515958723292, 6109.358517355702, 6158.507319414436, 6159.137720719103, 6169.537284703665, 6172.537059720539, 4609.446866376056, 4642.907141857144, 4646.95353046472, 4650.697704649187, 4675.789589468414, 4055.513338399352, 4060.817263223162, 4124.319487284564, 4168.124693814272, 4193.18232944579, 5814.127880817911, 5822.272215973004, 5827.883442331215, 5830.271216097988, 5831.300243970751, 6139.355367686418, 6167.136600875881, 6189.164462797555, 6190.288116866618, 6205.0, 5633.8309850704545, 5709.7716091356715, 5781.075027995501, 5806.187133801272, 5828.0966450200285, 5243.161094224905, 5257.710825904612, 5260.947390526122, 5268.446813084647, 5271.314729085195, 6367.904481432783, 6371.426571608577, 6395.968020159869, 6411.487081033506, 6412.422881940648, 5923.614965027259, 6110.5587591967305, 6121.908171377344, 6133.815985520441, 6170.413810688067, 6315.684215789284, 6386.425221730066, 6429.260635026844, 6429.742810287723, 6432.45324147434, 6047.516198704006, 6078.483328917092, 6080.726367313393, 6089.634621922699, 6089.908651370321, 5999.70001499932, 6119.197913140594, 6232.345603711545, 6234.314225435108, 6235.0, 6008.068749343859, 6018.187544681412, 6047.274327080779, 6060.937422337024, 6085.0, 5850.64896106235, 5964.821055368346, 6000.459958603747, 6029.638221706711, 6032.0, 5874.911876321944, 5942.405759424023, 5946.851328716817, 5966.403359663999, 5983.730732116978, 5953.077273022688, 5975.731092100953, 5983.401659833982, 5983.790567330123, 5984.581079324405, 5759.107338362561, 5837.6497410155525, 5844.590878638454, 5869.706514674163, 5901.734421950937], "value": 5637.621954201597, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.5554106519164, 673.8416472129052, 676.9593824370538, 681.1961884975728, 738.0294912190473, 32982.34035319295, 33585.83207083964, 39707.816070116096, 40129.799351003276, 40267.19465610686, 44009.7799511002, 44452.0, 44498.55501444985, 44502.33246501305, 44587.33119003218, 7975.202479752007, 8810.471371717702, 8988.55057247135, 8990.820183596325, 9009.0, 10660.520276587573, 10894.128469722404, 10898.18263630227, 10901.236913416024, 10957.397343146124, 10630.893691063067, 10703.518341674644, 10704.839427408595, 10707.625233116842, 10707.732306692316, 8178.550179740112, 10406.271560990734, 10515.894841051606, 10650.201234907412, 10654.573817047309, 10622.36265824053, 10737.83893241602, 10748.355098694024, 10750.354978701303, 10753.946230268877, 41712.165756685, 42268.57731422677, 42277.36583951243, 42320.0, 42369.78815105936, 3889.961100388988, 3972.205558888234, 4021.738586991836, 4063.1467391847746, 4271.431399722839, 34536.654633453596, 34930.476042859125, 35347.823260883786, 35380.29239415223, 35397.646023539695, 4083.448734420845, 4134.834606615732, 4167.5832416758085, 4168.499780026416, 4215.0, 347270.0, 348038.0, 350421.24789376144, 350443.0, 350648.0, 39989.600103998586, 68173.31826681769, 69509.30490695129, 69585.0, 69642.65178674074, 40148.197036059115, 40198.0, 40309.0, 40327.39508907369, 40351.0, 16496.6700665986, 16684.49946501607, 16695.83304166967, 16705.83294167043, 16714.916425417796, 12825.807612885814, 13577.117487363488, 13883.167009979434, 13917.58247252584, 14007.929960350133, 9194.264458843276, 9261.861072083924, 9326.393784403992, 9363.485008324607, 9382.24942004638, 3633.328668812323, 3637.3634613942454, 3647.252313275772, 3678.172411207457, 3698.7965661888857, 1070.240129508058, 1098.2696506822874, 1170.8770579089244, 1256.7109564800148, 1271.580378475101, 32155.0, 33188.3362332752, 33323.0, 33480.0, 34136.82931585326, 1212.89083982442, 1237.4926280225066, 1277.1953669188351, 1305.4222565580699, 1329.1559859489294, 17607.383741568985, 17842.28630854751, 17977.730334044998, 17980.55048623795, 18340.633187336178, 512587.0, 519634.0, 520261.0, 521177.0, 521314.0, 61665.0, 62388.0, 62504.68747656324, 62539.68730156411, 62573.37426625766, 1368.9657758556116, 1455.1487379882888, 1506.9698606027598, 1512.2060918018128, 1530.900491468051, 30708.385832283675, 31490.212744680648, 31931.521027184146, 32300.0, 32777.344453111284, 46020.0, 46130.76934615306, 46441.0, 46494.767526162155, 46606.0, 321202.0, 323078.0, 323132.0, 324337.0, 324347.0, 27377.31556711098, 30652.0, 31083.533746994264, 31464.528032079994, 31623.367532649678, 47977.80365149806, 47995.0, 48655.0, 49167.0, 49289.75355123202, 38597.80701096589, 40333.0, 41054.178916420904, 41296.79351603223, 41932.58067419287, 39465.21069578535, 40998.79500602478, 41203.175936481704, 41374.52723807137, 41798.79100604599, 41319.1736165281, 41600.37599435951, 42037.0, 42941.78529107334, 43003.56996429995, 35837.0, 36508.634913651586, 37102.25856309496, 37390.62609373871, 37482.437763434114, 28285.57571636468, 28411.289717757223, 28426.04579557433, 28442.857785710938, 28533.0], "value": 19798.3490371052, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.52630001797957, 417.8036322928223, 423.6695377605465, 426.8378016353785, 435.3404592043055, 14669.339879705412, 18789.060546972665, 19353.129109190086, 19354.0, 19995.900020499914, 19086.33197838076, 19564.0, 19893.0, 20787.272445464412, 20856.582868342663, 5787.305523337205, 5917.0, 5924.851878703023, 5927.673977931212, 5954.642721436706, 5853.970730146365, 5879.470847623713, 5916.881662366772, 5923.555733319997, 5926.496247818941, 4237.131388065439, 4412.492563355223, 4412.624926881219, 6032.517398608101, 6382.393672601095, 6044.909326360108, 6358.268799088095, 6364.522660800459, 6377.33038031007, 6378.585391949531, 5717.914231286492, 5720.313562372542, 5733.455321744427, 5735.340435849889, 5737.08206686928, 22197.445063873372, 22242.332730018126, 23655.172068977503, 24544.386390340384, 24608.876955615287, 2577.510273048115, 2692.8065449466344, 2747.5466548019554, 2783.958240626392, 3224.4357237483346, 14771.852281477155, 14888.776668349983, 15142.242887855673, 15384.691992450984, 15508.891711654489, 2073.8237249833783, 2090.686397040441, 2311.6879221305076, 2333.1950477085547, 2340.2511196417154, 62586.37413625851, 63845.68077159631, 67304.0, 70948.29051709469, 80569.0, 10262.640807571699, 10648.254622176373, 10711.303765255388, 10728.678139655824, 11192.10463162945, 14117.576472705836, 14167.0, 14230.928845355707, 14248.572542823731, 14277.92861035709, 8083.878741818878, 8193.549354785544, 8414.410991230678, 8564.74305770828, 8573.828523429496, 8485.95757021211, 8504.447210931394, 8545.145485451405, 8559.144085591392, 8624.137586241326, 4639.744814035193, 4761.6904901181315, 4792.9281060784115, 4795.928061079087, 4831.4685384607665, 1820.4538638408424, 1871.9344822931132, 1946.7079938009413, 1965.891875946808, 2012.2554654777825, 1011.9898801012043, 1075.6074032977906, 1123.9550417983353, 1135.3755434510986, 1203.3201241298639, 17588.648227035388, 19727.309544165884, 19846.305379311656, 19856.305029324194, 20114.0, 1110.9222354435112, 1112.4826955465746, 1114.916381271408, 1137.4256000719583, 1153.8096214124744, 11006.669799906016, 11365.431728413547, 11372.658820235407, 11412.201145919871, 11568.88431115695, 479039.0, 490390.0, 495791.0, 503807.0, 504315.0, 88012.5599371999, 90329.0, 90364.0, 92983.0, 95031.0, 1063.8244689626124, 1085.3054045410943, 1097.6981330134277, 1104.2601457023814, 1107.3798672743128, 17112.65774684524, 17622.471325860246, 17723.734143987593, 17826.19782109834, 17947.730784037987, 39614.0, 39917.201655966135, 40161.0, 40350.9912252196, 40525.79737101414, 54728.0, 55998.1600275988, 59299.0, 60186.0, 63925.6803715997, 8479.236868681848, 8593.82812343762, 8603.956980215058, 8724.825503490021, 8920.776980575538, 10702.715674119156, 13184.27486488214, 13205.801912971505, 13348.532801351907, 13483.528076517276, 7715.0, 11522.711932201762, 11704.590339338083, 11847.822282665595, 11947.402629868646, 9482.478463684563, 11512.30926144434, 11978.341191234218, 12022.519099235933, 12066.818997715216, 10068.39589624625, 10992.010719035325, 12350.505979760708, 12518.061145413949, 12719.236845789283, 8930.598123084346, 8931.553422328987, 9041.95479022627, 9053.411528250643, 9053.59258833341, 9410.858837117587, 12022.218555793845, 12534.310612916377, 12602.432890519765, 12659.936700316808], "value": 9488.370824157568, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.0320730299752, 1582.0349586752084, 1587.1270801059413, 1772.680917434862, 1913.3398977352808, 8043.0348358197025, 8208.466449680767, 8215.753527394188, 8226.58867056647, 8237.423380363376, 8114.066882308536, 8304.418690691638, 8312.584370781467, 8317.043539992903, 8323.75028749137, 2048.4059622709397, 2315.3285547191294, 2372.9406764830846, 2384.2727967969763, 2398.928032159038, 2373.0626402570974, 2385.3082606044227, 2385.4155731845635, 2386.009805930537, 2389.9880500597474, 2294.8164146868294, 2353.8352315337934, 2356.0575769692173, 2356.929292121239, 2358.457554762397, 2017.6065667194903, 2313.248194336839, 2364.1134574534376, 2367.621180611103, 2367.8579285242768, 2330.5105927755194, 2365.207655435414, 2377.5601513719844, 2388.713354397466, 2392.2225276785116, 8312.0, 8323.334133269385, 8357.080721120672, 8362.623681934267, 8370.372222083308, 5006.649534532584, 5097.439281679012, 5129.666571672867, 5147.0, 5149.0474262261605, 3326.6839650233187, 3334.6498617645284, 3345.565076540034, 3380.3070370573973, 3434.0899661589697, 1134.8297755336682, 1145.1754736589642, 1192.8786940276113, 1214.1197631717023, 1234.4630085912568, 11792.64622061331, 11795.0, 11800.586979455764, 11820.290782553075, 11848.703782405422, 4478.596926276586, 4540.228161212602, 4558.133954548625, 4567.657425693086, 4657.3246879202325, 10151.9492402539, 10172.593096276067, 10192.082712555906, 10204.795904082026, 10205.0, 4641.559051890133, 5360.758765855546, 5364.678119312854, 5366.0, 5366.892662146735, 4686.179918514246, 4732.763361831895, 4738.099761045391, 4759.16714574948, 4769.42766867978, 4177.832886684499, 4196.391523229115, 4235.788210589458, 4271.572842715704, 4287.957120428756, 1328.734253149374, 1365.5834970334145, 1368.2543014057362, 1368.3363568669386, 1373.7527245095978, 954.2556805691572, 1017.8218811707922, 1030.7114008077751, 1036.8030074285862, 1049.4542837724493, 5967.5524335675, 5979.491743201789, 6050.45545900871, 6238.282597501346, 6250.999840025665, 1034.4879284753945, 1067.3755852826027, 1074.699084256394, 1101.4162493878257, 1101.8760863918758, 4254.851080212177, 4313.741175529478, 4320.308750599889, 4332.0, 4360.0, 10191.286609937382, 10629.149668026539, 10632.627858024933, 10634.787304253872, 10655.520501577448, 9784.119429251401, 10099.192064634812, 10400.063994240403, 10406.115480184118, 10423.697037870266, 8074.071481779671, 8091.55496447701, 8134.186581341818, 8185.672573097128, 8194.09864914859, 5878.3239927407185, 5999.5800293979, 6013.9699301503215, 6032.517398608188, 6088.543359247986, 8947.910520894708, 8993.685221017233, 9063.864042039506, 9217.216536594464, 9219.677311294072, 9272.119148680864, 9314.44113353201, 9373.437593744397, 9475.289353298393, 9678.419294842332, 6936.7572134975035, 7344.559326440431, 7524.17234104259, 7717.768466946, 7851.175626559358, 8134.796630084058, 8154.0, 8160.918390816016, 8192.262696357118, 8194.057683366489, 7183.53307035062, 7359.411247100112, 7407.148177959603, 7466.552006879388, 7587.051618547682, 7146.285371462812, 7149.785506434815, 7158.749443769443, 7228.566286022856, 7337.779866604011, 7077.292270772881, 7102.112235970504, 7127.322904324081, 7129.0, 7148.642567871481, 5076.18780995039, 5214.666124505373, 5277.366715993951, 5284.154535274338, 5301.204819277139, 5412.296401467784, 5423.647462914898, 5512.0, 5550.167474878639, 5569.498745112959], "value": 4627.981282085718, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.83964956295347, 345.7372396978296, 346.4647120199292, 346.7139609821896, 347.1875810603189, 6269.5611307208455, 6330.3036665966765, 6403.135576697145, 6414.166158399407, 6426.325235850239, 6255.311915689282, 6312.6212427254395, 6314.989601663735, 6316.494680425566, 6317.3050964394, 4787.80848766049, 4791.640626952975, 4796.3764710587575, 4797.9760101199445, 4800.183968725308, 4796.712197268175, 4797.0, 4798.328234047236, 4806.927896081562, 4809.543093406139, 4776.617870570363, 4777.8566643000595, 4777.928331075037, 4788.856334309976, 4790.018046300517, 4599.747013914233, 4774.73738944358, 4775.164346239411, 4784.162771514988, 4786.21027530457, 4140.523839758406, 4148.709590328678, 4156.189543039109, 4161.667066634662, 4162.250794856925, 6067.484263837579, 6068.362821903725, 6072.574919755619, 6075.7873474428625, 6076.665783381913, 5522.972385138049, 5544.473275038865, 5568.081266591008, 5581.302337207849, 5583.190437386556, 6612.239592446882, 6659.76690815824, 6667.299933507009, 6675.899861502033, 6692.59844409337, 4633.652476064309, 4646.279826626878, 4648.372469716613, 4648.930266046012, 4652.651051171176, 6644.60132392058, 6776.627285499296, 6805.659717014179, 7018.157821061454, 7029.472789540805, 4698.389209402756, 4729.125111854318, 4744.857654270378, 4754.168020596382, 4767.237242041326, 4821.300911367832, 4823.855284341475, 4826.0, 4829.1307564638, 4830.9371938173545, 5243.318368612056, 5442.12925931849, 5551.250581171571, 5592.217089607459, 5597.188407680945, 6719.798406047827, 6742.157230346207, 6747.0, 6748.0, 6748.7300507979135, 1668.7246604310153, 1698.3716025070803, 1698.3800912666788, 1702.540314115182, 1704.6761115388038, 1092.1481244629201, 1114.9498272577753, 1119.9944000279947, 1122.354646078508, 1133.863936327646, 6492.67536623167, 6526.151600291932, 6529.085927970088, 6532.150820393318, 6535.444487218545, 6945.652717364112, 6957.095577574883, 6960.686769095403, 6963.79108626742, 6970.337817907291, 6515.087887695727, 6520.0, 6520.054592084121, 6520.510961677893, 6530.412262896362, 3725.1245957200035, 3737.850485980585, 3746.0447585865977, 3746.812659367021, 3766.4162054881535, 7118.323759242864, 7322.780316590511, 7333.1933487316355, 7335.706571737071, 7344.669489872968, 7096.7516136934955, 7125.144982602121, 7128.6435678215885, 7132.429405647639, 7162.641867906584, 7300.379467745195, 7307.451941104438, 7311.415086793044, 7312.085989251344, 7315.4147668186415, 6862.553933994274, 6998.440124790106, 7005.388760585196, 7011.088558487364, 7012.737707212751, 6617.470602351897, 6716.764913228014, 6850.246472887879, 6904.516683832285, 6910.7581234656545, 7166.140063192451, 7238.384737297389, 7247.9637601811655, 7261.128664560287, 7274.0, 4728.361671174485, 4764.094821983812, 4764.309175169512, 4766.737829419415, 4771.141194585008, 6943.305669433016, 6963.6866341013765, 6965.233824279224, 6972.372486476242, 6974.860502789814, 6669.966650166718, 6805.829854253485, 6812.4890633203695, 6818.761343353157, 6819.352161544645, 6749.662516874038, 6762.594244345355, 6768.661566921733, 6773.424258937848, 6779.593224406552, 6641.402273795382, 6645.534812563074, 6649.335066493505, 6651.0, 6654.733810647714, 6764.763233286812, 6765.1205343305055, 6765.323467653196, 6769.255381907888, 6773.762918297836, 6483.189601299838, 6633.038209459505, 6642.767503137367, 6674.966625166843, 6686.0], "value": 5062.359415153531, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.3305179480808, 895.4000819450968, 898.7708134425721, 901.2114399900088, 917.7338571814174, 14754.926225368872, 15202.771958420619, 15210.619734506643, 16509.09199994, 17046.573835654115, 14924.029938054045, 14974.775378369333, 15020.474283400083, 15060.698786024273, 15061.849381506181, 736.8489459660757, 855.0295414704293, 874.3398733955854, 874.637025634361, 886.2068448738376, 877.5129802959354, 882.1443200095897, 883.8409086364452, 883.9911600883974, 885.1900511032397, 917.5641570254143, 926.666400095965, 926.8053708721177, 926.8702381666573, 927.717046300878, 763.1872056260065, 767.2825907776219, 905.5834316214549, 912.8311262416441, 921.1571412157934, 666.9566478178903, 672.0322735261257, 672.1530871102398, 672.357898207211, 672.5090683800853, 15081.698366032619, 15183.62040948974, 15192.088474691443, 15232.771508427271, 15250.0, 14437.855621443756, 14759.557213283619, 14782.630434239123, 14847.183404912725, 15013.3244004019, 11653.30080195191, 11865.881341186563, 11891.643250702406, 11923.105767067505, 12067.57763478274, 3915.706322025831, 3962.9009274768073, 3990.657190768999, 3997.200559888005, 4029.879103626896, 60392.39607603912, 60971.0, 62007.689961549906, 62027.37972620261, 62052.75894482085, 11556.76886462266, 11763.588274410355, 11829.585964491202, 11995.1003674723, 12056.336901470504, 19542.0, 19726.506837329183, 19873.801261987483, 19877.204911803656, 19910.90044549797, 8268.793280167924, 8310.0, 8461.069282378934, 8702.129787021247, 8808.163224493663, 4602.424696912886, 4677.7193368398, 4805.663603547718, 4844.491328410466, 5011.0479008988905, 3580.5524309461316, 3644.1618427761764, 3664.340418724655, 3674.430463278196, 3687.7971711555583, 598.201401129497, 667.2626747444101, 668.6322522612641, 674.784069097884, 687.6733551563068, 698.8392669686001, 725.1950335128109, 772.0812233442298, 774.1329710723912, 810.2100452059195, 9520.666776662922, 9671.468069256118, 10264.178865690727, 10419.218558608134, 10468.214883883738, 704.7286794584122, 759.2293821770907, 765.6516285090271, 771.5100910921606, 787.582581231948, 4475.5748203920575, 4535.183666939983, 4622.6764126510825, 4628.907421851544, 4652.860414187579, 64559.0, 64779.67610161919, 64983.0, 65016.34983650103, 65265.67367163134, 56074.71962640161, 59345.10982335269, 59510.70244648836, 59613.0, 60347.0, 50890.0, 52340.0, 52508.36120401341, 52601.0, 53112.203316950276, 9553.18797902186, 9570.377925434825, 9592.76018099553, 9714.708558743248, 9729.756756081155, 37708.43437348387, 37722.81138594289, 38276.0, 39492.2101557973, 41057.384139237336, 49853.252201217736, 51976.0, 52158.21762673487, 52254.47745522496, 53314.0, 13041.869581304065, 13121.409536571067, 13169.868301316865, 13187.868121319048, 13267.004974626749, 14551.92724036373, 14850.257487125817, 14874.851251487347, 14988.775168372702, 15390.692186156439, 13831.585052448443, 13931.930340348234, 14132.929335353258, 14145.222012789396, 14322.856771432153, 14041.648958775704, 14099.224542650252, 14113.858861411254, 14253.429862805371, 14269.42922283097, 13537.187768733907, 13761.655958601115, 13901.930490347484, 14078.155310681392, 14146.646333841736, 11327.433628318386, 11503.194776365573, 11545.36500492481, 11558.190926635054, 11866.0, 11399.601013964471, 11543.19197656156, 11759.412479315182, 11846.0, 12014.33921134346], "value": 7255.223931664871, "unit": "score"}], "name": "dromaeo_css", "value": 7514.352593655669, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 111.0, 111.0, 110.0, 111.0, 106.0, 112.0, 112.0, 109.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 162.0, 173.0, 126.0, 150.0, 154.0, 130.0, 191.0, 133.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 159.0, 161.0, 161.0, 161.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 167.0, 76.0, 75.0, 76.0, 78.0, 173.0, 75.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 160.0, 92.0, 93.0, 92.0, 156.0, 92.0, 93.0, 150.0], "value": 111.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 146.0, 145.0, 145.0, 144.0, 144.0, 145.0, 145.0, 145.0], "value": 144.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 96.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 55.0, 53.0, 54.0, 54.0, 54.0, 76.0, 52.0, 52.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 59.0, 57.0, 57.0, 57.0, 58.0, 57.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 72.0, 73.0, 73.0, 74.0, 74.0, 73.0, 81.0, 73.0, 73.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 111.0, 114.0, 110.0, 111.0, 110.0, 115.0, 131.0, 124.0], "value": 115.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 158.0, 156.0, 158.0, 157.0, 160.0, 158.0, 159.0, 155.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 68.0, 66.0, 67.0, 67.0, 66.0, 65.0, 64.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1510.2999999999997, "alertThreshold": 2.0}]} 03:56:17 INFO - Return code: 0 03:56:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:56:17 ERROR - # TBPL SUCCESS # 03:56:17 INFO - Running post-action listener: _resource_record_post_action 03:56:17 INFO - Running post-run listener: _resource_record_post_run 03:56:18 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511299584; Read time: 4; Write time: 994456 03:56:18 INFO - install - Wall time: 16s; CPU: 19.0%; Read bytes: 0; Write bytes: 249282560; Read time: 0; Write time: 695908 03:56:18 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 246353920; Read time: 4; Write time: 293904 03:56:18 INFO - Running post-run listener: _upload_blobber_files 03:56:18 INFO - Blob upload gear active. 03:56:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:56:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:56:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:56:18 INFO - (blobuploader) - INFO - Open directory for files ... 03:56:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:56:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:56:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:19 INFO - (blobuploader) - INFO - Done attempting. 03:56:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:56:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:56:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:20 INFO - (blobuploader) - INFO - Done attempting. 03:56:20 INFO - (blobuploader) - INFO - Iteration through files over. 03:56:20 INFO - Return code: 0 03:56:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:56:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:56:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7338bac93419e1b4de01211f1e3f6b81524acc5ebd5ae5adfbc74069fd849a3dfb5d3ee4c27c3db3f6d0be576b18094928c5d16ca9fe7adcf4969c8a3957ab3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e320efe53b227bc918cb81035964fea6bfda30196cfcab90d57fb27b75337fd55dfb19229d35430d5d67bfd86ec783bf49cd15c3fa5f69af3e6a626cbedbf874"} 03:56:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:56:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:56:20 INFO - Contents: 03:56:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7338bac93419e1b4de01211f1e3f6b81524acc5ebd5ae5adfbc74069fd849a3dfb5d3ee4c27c3db3f6d0be576b18094928c5d16ca9fe7adcf4969c8a3957ab3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e320efe53b227bc918cb81035964fea6bfda30196cfcab90d57fb27b75337fd55dfb19229d35430d5d67bfd86ec783bf49cd15c3fa5f69af3e6a626cbedbf874"} 03:56:20 INFO - Running post-run listener: copy_logs_to_upload_dir 03:56:20 INFO - Copying logs to upload dir... 03:56:20 INFO - mkdir: /builds/slave/test/build/upload/logs 03:56:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.970846 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-28 03:56:19.904390) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:56:19.908156) ========= 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=745a4373a2a16df560f216e000000264-1464431749.720353-1134318009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7338bac93419e1b4de01211f1e3f6b81524acc5ebd5ae5adfbc74069fd849a3dfb5d3ee4c27c3db3f6d0be576b18094928c5d16ca9fe7adcf4969c8a3957ab3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e320efe53b227bc918cb81035964fea6bfda30196cfcab90d57fb27b75337fd55dfb19229d35430d5d67bfd86ec783bf49cd15c3fa5f69af3e6a626cbedbf874"} 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.011263 build_url: 'https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7338bac93419e1b4de01211f1e3f6b81524acc5ebd5ae5adfbc74069fd849a3dfb5d3ee4c27c3db3f6d0be576b18094928c5d16ca9fe7adcf4969c8a3957ab3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e320efe53b227bc918cb81035964fea6bfda30196cfcab90d57fb27b75337fd55dfb19229d35430d5d67bfd86ec783bf49cd15c3fa5f69af3e6a626cbedbf874"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:56:19.933637) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:56:19.934016) ========= 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=745a4373a2a16df560f216e000000264-1464431749.720353-1134318009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:56:20.021291) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:56:20.021808) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:56:20.022272) ========= ========= Total master_lag: 0.18 =========