builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1462800995.82 results: success (0) buildid: 20160509025943 builduid: c99cfa26e31d4e04b813ad347f24c373 revision: 0e7f650568bbd910b20bdf7c8c2f1d193475cf2a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:35.818967) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:35.819404) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:35.819691) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:35.828728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:35.828987) ========= 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=232498196343f89f466a4a9a000001c8-1462800996.839670-724582139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 06:36:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.7M=0.001s 2016-05-09 06:36:38 (16.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077547 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:35.917467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:35.917802) ========= 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=232498196343f89f466a4a9a000001c8-1462800996.839670-724582139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016370 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:35.967405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:35.967770) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0e7f650568bbd910b20bdf7c8c2f1d193475cf2a --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 0e7f650568bbd910b20bdf7c8c2f1d193475cf2a --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=232498196343f89f466a4a9a000001c8-1462800996.839670-724582139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 06:36:38,199 truncating revision to first 12 chars 2016-05-09 06:36:38,199 Setting DEBUG logging. 2016-05-09 06:36:38,199 attempt 1/10 2016-05-09 06:36:38,199 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0e7f650568bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 06:36:38,479 unpacking tar archive at: mozilla-aurora-0e7f650568bb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555804 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:36.536297) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:36.536616) ========= script_repo_revision: 0e7f650568bbd910b20bdf7c8c2f1d193475cf2a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:36.536993) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:36.537258) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:36:36.545965) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-09 06:36:36.546234) ========= /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=232498196343f89f466a4a9a000001c8-1462800996.839670-724582139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:36:38 INFO - MultiFileLogger online at 20160509 06:36:38 in /builds/slave/test 06:36:38 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 06:36:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:36:38 INFO - {'append_to_log': False, 06:36:38 INFO - 'base_work_dir': '/builds/slave/test', 06:36:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:36:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:36:38 INFO - 'branch': 'Mozilla-Aurora', 06:36:38 INFO - 'buildbot_json_path': 'buildprops.json', 06:36:38 INFO - 'config_files': ('talos/linux_config.py',), 06:36:38 INFO - 'default_actions': ('clobber', 06:36:38 INFO - 'read-buildbot-config', 06:36:38 INFO - 'download-and-extract', 06:36:38 INFO - 'populate-webroot', 06:36:38 INFO - 'create-virtualenv', 06:36:38 INFO - 'install', 06:36:38 INFO - 'run-tests'), 06:36:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:36:38 INFO - 'download_minidump_stackwalk': True, 06:36:38 INFO - 'download_symbols': 'ondemand', 06:36:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:36:38 INFO - 'tooltool.py': '/tools/tooltool.py', 06:36:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:36:38 INFO - '/tools/misc-python/virtualenv.py')}, 06:36:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:36:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:36:38 INFO - 'installer_path': 'installer.exe', 06:36:38 INFO - 'log_level': 'info', 06:36:38 INFO - 'log_name': 'talos', 06:36:38 INFO - 'log_to_console': True, 06:36:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:36:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:36:38 INFO - 'opt_config_files': (), 06:36:38 INFO - 'pip_index': False, 06:36:38 INFO - 'sps_profile': False, 06:36:38 INFO - 'sps_profile_interval': 0, 06:36:38 INFO - 'suite': 'dromaeojs', 06:36:38 INFO - 'system_bits': '32', 06:36:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:36:38 INFO - 'title': 'talos-linux64-ix-025', 06:36:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:36:38 INFO - 'use_talos_json': True, 06:36:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:36:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:36:38 INFO - 'work_dir': 'build'} 06:36:38 INFO - ##### 06:36:38 INFO - ##### Running clobber step. 06:36:38 INFO - ##### 06:36:38 INFO - Running pre-action listener: _resource_record_pre_action 06:36:38 INFO - Running main action method: clobber 06:36:38 INFO - rmtree: /builds/slave/test/build 06:36:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:36:39 INFO - Running post-action listener: _resource_record_post_action 06:36:39 INFO - ##### 06:36:39 INFO - ##### Running read-buildbot-config step. 06:36:39 INFO - ##### 06:36:39 INFO - Running pre-action listener: _resource_record_pre_action 06:36:39 INFO - Running main action method: read_buildbot_config 06:36:39 INFO - Using buildbot properties: 06:36:39 INFO - { 06:36:39 INFO - "project": "", 06:36:39 INFO - "product": "firefox", 06:36:39 INFO - "script_repo_revision": "production", 06:36:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:36:39 INFO - "repository": "", 06:36:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 06:36:39 INFO - "buildid": "20160509025943", 06:36:39 INFO - "pgo_build": "True", 06:36:39 INFO - "basedir": "/builds/slave/test", 06:36:39 INFO - "buildnumber": 227, 06:36:39 INFO - "slavename": "talos-linux64-ix-025", 06:36:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:36:39 INFO - "platform": "ubuntu64_hw", 06:36:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:36:39 INFO - "branch": "mozilla-aurora", 06:36:39 INFO - "repo_path": "releases/mozilla-aurora", 06:36:39 INFO - "revision": "0e7f650568bbd910b20bdf7c8c2f1d193475cf2a", 06:36:39 INFO - "stage_platform": "linux64-pgo", 06:36:39 INFO - "builduid": "c99cfa26e31d4e04b813ad347f24c373", 06:36:39 INFO - "slavebuilddir": "test" 06:36:39 INFO - } 06:36:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 06:36:39 INFO - Running post-action listener: _resource_record_post_action 06:36:39 INFO - ##### 06:36:39 INFO - ##### Running download-and-extract step. 06:36:39 INFO - ##### 06:36:39 INFO - Running pre-action listener: _resource_record_pre_action 06:36:39 INFO - Running main action method: download_and_extract 06:36:39 INFO - mkdir: /builds/slave/test/build/tests 06:36:39 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')]} 06:36:39 INFO - https://queue.taskcluster.net/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:36:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:36:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:36:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/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 06:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/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 06:36:39 INFO - Downloaded 1361 bytes. 06:36:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:36:39 INFO - Using the following test package requirements: 06:36:39 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:36:39 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:36:39 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:36:39 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:40 INFO - u'jsshell-linux-x86_64.zip'], 06:36:40 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:36:40 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:36:40 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:36:40 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:36:40 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:36:40 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:36:40 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:40 INFO - https://queue.taskcluster.net/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:36:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:36:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:36:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/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 06:36:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/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 06:36:41 INFO - Downloaded 23799348 bytes. 06:36:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:36:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:36:42 INFO - Return code: 0 06:36:42 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:42 INFO - https://queue.taskcluster.net/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:36:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:36:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:36:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/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 06:36:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/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 06:36:43 INFO - Downloaded 23799348 bytes. 06:36:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:36:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:36:44 INFO - Return code: 0 06:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:44 INFO - https://queue.taskcluster.net/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:36:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:36:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:36:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/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 06:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/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 06:36:45 INFO - Downloaded 10840145 bytes. 06:36:45 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'] 06:36:45 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 06:36:45 INFO - Return code: 0 06:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:45 INFO - https://queue.taskcluster.net/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:36:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:36:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:36:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/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 06:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMADoDpFTc-ZTyVSsUUOog/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 06:36:47 INFO - Downloaded 62709339 bytes. 06:36:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:36:47 INFO - mkdir: /builds/slave/test/properties 06:36:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:36:47 INFO - Writing to file /builds/slave/test/properties/build_url 06:36:47 INFO - Contents: 06:36:47 INFO - build_url:https://queue.taskcluster.net/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:36:48 INFO - Running post-action listener: _resource_record_post_action 06:36:48 INFO - Running post-action listener: set_extra_try_arguments 06:36:48 INFO - ##### 06:36:48 INFO - ##### Running populate-webroot step. 06:36:48 INFO - ##### 06:36:48 INFO - Running pre-action listener: _resource_record_pre_action 06:36:48 INFO - Running main action method: populate_webroot 06:36:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:36:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:36:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:36:48 INFO - '--tppagecycles', 06:36:48 INFO - '7'], 06:36:48 INFO - 'tests': ['tsvgm']}}, 06:36:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:36:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:36:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:36:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:36:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:36:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:36:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:48 INFO - 'talos_options': ['--disable-e10s'], 06:36:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:48 INFO - 'talos_options': ['--disable-e10s'], 06:36:48 INFO - 'tests': ['damp', 'tps']}, 06:36:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:48 INFO - 'tests': ['damp', 'tps']}, 06:36:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:36:48 INFO - 'tests': ['dromaeo_dom']}, 06:36:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:36:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:36:48 INFO - 'tests': ['a11yr', 06:36:48 INFO - 'ts_paint', 06:36:48 INFO - 'tpaint', 06:36:48 INFO - 'sessionrestore', 06:36:48 INFO - 'sessionrestore_no_auto_restore', 06:36:48 INFO - 'tabpaint']}, 06:36:48 INFO - 'other-e10s': {'tests': ['a11yr', 06:36:48 INFO - 'ts_paint', 06:36:48 INFO - 'tpaint', 06:36:48 INFO - 'sessionrestore', 06:36:48 INFO - 'sessionrestore_no_auto_restore', 06:36:48 INFO - 'tabpaint']}, 06:36:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:36:48 INFO - 'ts_paint', 06:36:48 INFO - 'tpaint', 06:36:48 INFO - 'sessionrestore', 06:36:48 INFO - 'sessionrestore_no_auto_restore', 06:36:48 INFO - 'tabpaint']}, 06:36:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:36:48 INFO - 'ts_paint', 06:36:48 INFO - 'tpaint', 06:36:48 INFO - 'sessionrestore', 06:36:48 INFO - 'sessionrestore_no_auto_restore', 06:36:48 INFO - 'tabpaint']}, 06:36:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:36:48 INFO - 'tests': ['a11yr', 06:36:48 INFO - 'ts_paint', 06:36:48 INFO - 'tpaint', 06:36:48 INFO - 'sessionrestore', 06:36:48 INFO - 'sessionrestore_no_auto_restore', 06:36:48 INFO - 'tabpaint']}, 06:36:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:36:48 INFO - 'tests': ['a11yr', 06:36:48 INFO - 'ts_paint', 06:36:48 INFO - 'tpaint', 06:36:48 INFO - 'sessionrestore', 06:36:48 INFO - 'sessionrestore_no_auto_restore', 06:36:48 INFO - 'tabpaint']}, 06:36:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:36:48 INFO - 'tests': ['tsvgx', 06:36:48 INFO - 'tsvgr_opacity', 06:36:48 INFO - 'tart', 06:36:48 INFO - 'tscrollx', 06:36:48 INFO - 'cart']}, 06:36:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:36:48 INFO - 'tsvgr_opacity', 06:36:48 INFO - 'tart', 06:36:48 INFO - 'tscrollx', 06:36:48 INFO - 'cart']}, 06:36:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:48 INFO - 'talos_options': ['--disable-e10s'], 06:36:48 INFO - 'tests': ['tp5o']}, 06:36:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:48 INFO - 'tests': ['tp5o']}, 06:36:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:48 INFO - 'talos_options': ['--disable-e10s', 06:36:48 INFO - '--xperf_path', 06:36:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:48 INFO - 'tests': ['tp5n']}, 06:36:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:48 INFO - 'talos_options': ['--xperf_path', 06:36:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:48 INFO - 'tests': ['tp5n']}}, 06:36:48 INFO - 'talos.zip': {'path': '', 06:36:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:36:48 INFO - Running post-action listener: _resource_record_post_action 06:36:48 INFO - ##### 06:36:48 INFO - ##### Running create-virtualenv step. 06:36:48 INFO - ##### 06:36:48 INFO - Running pre-action listener: _resource_record_pre_action 06:36:48 INFO - Running main action method: create_virtualenv 06:36:48 INFO - Creating virtualenv /builds/slave/test/build/venv 06:36:48 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 06:36:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:36:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:36:48 INFO - Using real prefix '/usr' 06:36:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:36:48 INFO - Installing distribute.............................................................................................................................................................................................done. 06:36:50 INFO - Installing pip.................done. 06:36:50 INFO - Return code: 0 06:36:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:50 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 0x7f0864dc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, '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 0x1499310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14997a0>, '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': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', '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 06:36:50 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 06:36:50 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 06:36:50 INFO - Using env: {'DISPLAY': ':0', 06:36:50 INFO - 'HOME': '/home/cltbld', 06:36:50 INFO - 'LANG': 'en_US.UTF-8', 06:36:50 INFO - 'LANGUAGE': 'en_US:en', 06:36:50 INFO - 'LOGNAME': 'cltbld', 06:36:50 INFO - 'MAIL': '/var/mail/cltbld', 06:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:50 INFO - 'MOZ_NO_REMOTE': '1', 06:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:50 INFO - 'NO_EM_RESTART': '1', 06:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:50 INFO - 'PWD': '/builds/slave/test', 06:36:50 INFO - 'SHELL': '/bin/bash', 06:36:50 INFO - 'SHLVL': '1', 06:36:50 INFO - 'TERM': 'linux', 06:36:50 INFO - 'TMOUT': '86400', 06:36:50 INFO - 'USER': 'cltbld', 06:36:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', 06:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:50 INFO - '_': '/tools/buildbot/bin/python'} 06:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:50 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 06:36:50 INFO - Cleaning up... 06:36:50 INFO - Return code: 0 06:36:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:50 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 0x7f0864dc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, '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 0x1499310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14997a0>, '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': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', '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 06:36:50 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 06:36:50 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 06:36:50 INFO - Using env: {'DISPLAY': ':0', 06:36:50 INFO - 'HOME': '/home/cltbld', 06:36:50 INFO - 'LANG': 'en_US.UTF-8', 06:36:50 INFO - 'LANGUAGE': 'en_US:en', 06:36:50 INFO - 'LOGNAME': 'cltbld', 06:36:50 INFO - 'MAIL': '/var/mail/cltbld', 06:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:50 INFO - 'MOZ_NO_REMOTE': '1', 06:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:50 INFO - 'NO_EM_RESTART': '1', 06:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:50 INFO - 'PWD': '/builds/slave/test', 06:36:50 INFO - 'SHELL': '/bin/bash', 06:36:50 INFO - 'SHLVL': '1', 06:36:50 INFO - 'TERM': 'linux', 06:36:50 INFO - 'TMOUT': '86400', 06:36:50 INFO - 'USER': 'cltbld', 06:36:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', 06:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:50 INFO - '_': '/tools/buildbot/bin/python'} 06:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:51 INFO - Downloading/unpacking psutil>=0.7.1 06:36:51 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 06:36:51 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 06:36:51 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 06:36:51 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 06:36:51 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 06:36:51 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 06:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:36:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:53 INFO - Installing collected packages: psutil 06:36:53 INFO - Running setup.py install for psutil 06:36:53 INFO - building 'psutil._psutil_linux' extension 06:36:53 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 06:36:53 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 06:36:53 INFO - building 'psutil._psutil_posix' extension 06:36:53 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 06:36:53 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 06:36:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:53 INFO - Successfully installed psutil 06:36:53 INFO - Cleaning up... 06:36:53 INFO - Return code: 0 06:36:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:36:53 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')]} 06:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:53 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')]} 06:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:53 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 0x7f0864dc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, '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 0x1499310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14997a0>, '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': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', '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 06:36:53 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 06:36:53 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 06:36:53 INFO - Using env: {'DISPLAY': ':0', 06:36:53 INFO - 'HOME': '/home/cltbld', 06:36:53 INFO - 'LANG': 'en_US.UTF-8', 06:36:53 INFO - 'LANGUAGE': 'en_US:en', 06:36:53 INFO - 'LOGNAME': 'cltbld', 06:36:53 INFO - 'MAIL': '/var/mail/cltbld', 06:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:53 INFO - 'MOZ_NO_REMOTE': '1', 06:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:53 INFO - 'NO_EM_RESTART': '1', 06:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:53 INFO - 'PWD': '/builds/slave/test', 06:36:53 INFO - 'SHELL': '/bin/bash', 06:36:53 INFO - 'SHLVL': '1', 06:36:53 INFO - 'TERM': 'linux', 06:36:53 INFO - 'TMOUT': '86400', 06:36:53 INFO - 'USER': 'cltbld', 06:36:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', 06:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:53 INFO - '_': '/tools/buildbot/bin/python'} 06:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:36:53 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 06:36:53 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 06:36:53 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 06:36:53 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 06:36:53 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 06:36:53 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 06:36:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:36:55 INFO - Installing collected packages: mozsystemmonitor 06:36:55 INFO - Running setup.py install for mozsystemmonitor 06:36:55 INFO - Successfully installed mozsystemmonitor 06:36:55 INFO - Cleaning up... 06:36:55 INFO - Return code: 0 06:36:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0864dc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, '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 0x1499310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14997a0>, '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': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', '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 06:36:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:36:55 INFO - Using env: {'DISPLAY': ':0', 06:36:55 INFO - 'HOME': '/home/cltbld', 06:36:55 INFO - 'LANG': 'en_US.UTF-8', 06:36:55 INFO - 'LANGUAGE': 'en_US:en', 06:36:55 INFO - 'LOGNAME': 'cltbld', 06:36:55 INFO - 'MAIL': '/var/mail/cltbld', 06:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:55 INFO - 'MOZ_NO_REMOTE': '1', 06:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:55 INFO - 'NO_EM_RESTART': '1', 06:36:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:55 INFO - 'PWD': '/builds/slave/test', 06:36:55 INFO - 'SHELL': '/bin/bash', 06:36:55 INFO - 'SHLVL': '1', 06:36:55 INFO - 'TERM': 'linux', 06:36:55 INFO - 'TMOUT': '86400', 06:36:55 INFO - 'USER': 'cltbld', 06:36:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', 06:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:55 INFO - '_': '/tools/buildbot/bin/python'} 06:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:56 INFO - Downloading/unpacking blobuploader==1.2.4 06:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:57 INFO - Downloading blobuploader-1.2.4.tar.gz 06:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:36:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:36:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:58 INFO - Downloading docopt-0.6.1.tar.gz 06:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:36:58 INFO - Installing collected packages: blobuploader, requests, docopt 06:36:58 INFO - Running setup.py install for blobuploader 06:36:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:36:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:36:58 INFO - Running setup.py install for requests 06:36:59 INFO - Running setup.py install for docopt 06:36:59 INFO - Successfully installed blobuploader requests docopt 06:36:59 INFO - Cleaning up... 06:36:59 INFO - Return code: 0 06:36:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:59 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 0x7f0864dc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, '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 0x1499310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14997a0>, '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': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', '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 06:36:59 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 06:36:59 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 06:36:59 INFO - Using env: {'DISPLAY': ':0', 06:36:59 INFO - 'HOME': '/home/cltbld', 06:36:59 INFO - 'LANG': 'en_US.UTF-8', 06:36:59 INFO - 'LANGUAGE': 'en_US:en', 06:36:59 INFO - 'LOGNAME': 'cltbld', 06:36:59 INFO - 'MAIL': '/var/mail/cltbld', 06:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:59 INFO - 'MOZ_NO_REMOTE': '1', 06:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:59 INFO - 'NO_EM_RESTART': '1', 06:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:59 INFO - 'PWD': '/builds/slave/test', 06:36:59 INFO - 'SHELL': '/bin/bash', 06:36:59 INFO - 'SHLVL': '1', 06:36:59 INFO - 'TERM': 'linux', 06:36:59 INFO - 'TMOUT': '86400', 06:36:59 INFO - 'USER': 'cltbld', 06:36:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', 06:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:59 INFO - '_': '/tools/buildbot/bin/python'} 06:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:59 INFO - Running setup.py (path:/tmp/pip-Q0LGwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:59 INFO - Running setup.py (path:/tmp/pip-qNsypl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:59 INFO - Running setup.py (path:/tmp/pip-c7NDii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:59 INFO - Running setup.py (path:/tmp/pip-xsboGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:59 INFO - Running setup.py (path:/tmp/pip-jOcqHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:59 INFO - Running setup.py (path:/tmp/pip-D8vZ2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:59 INFO - Running setup.py (path:/tmp/pip-wqJaHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:00 INFO - Running setup.py (path:/tmp/pip-wEjy2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:00 INFO - Running setup.py (path:/tmp/pip-d0lkqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:00 INFO - Running setup.py (path:/tmp/pip-g__kr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:00 INFO - Running setup.py (path:/tmp/pip-k9vQLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:00 INFO - Running setup.py (path:/tmp/pip-ddG5_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:00 INFO - Running setup.py (path:/tmp/pip-0R5GOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:00 INFO - Running setup.py (path:/tmp/pip-ZEgf30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:00 INFO - Running setup.py (path:/tmp/pip-BUAPw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:00 INFO - Running setup.py (path:/tmp/pip-kMJYs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:00 INFO - Running setup.py (path:/tmp/pip-ftVqxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:37:00 INFO - Running setup.py install for manifestparser 06:37:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:37:00 INFO - Running setup.py install for mozcrash 06:37:00 INFO - Running setup.py install for mozdebug 06:37:01 INFO - Running setup.py install for mozdevice 06:37:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Running setup.py install for mozfile 06:37:01 INFO - Running setup.py install for mozhttpd 06:37:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Running setup.py install for mozinfo 06:37:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Running setup.py install for mozInstall 06:37:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Running setup.py install for mozleak 06:37:01 INFO - Running setup.py install for mozlog 06:37:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Running setup.py install for moznetwork 06:37:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Running setup.py install for mozprocess 06:37:02 INFO - Running setup.py install for mozprofile 06:37:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:37:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:37:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:37:02 INFO - Running setup.py install for mozrunner 06:37:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:37:02 INFO - Running setup.py install for mozscreenshot 06:37:02 INFO - Running setup.py install for moztest 06:37:02 INFO - Running setup.py install for mozversion 06:37:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:37:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:37:02 INFO - Cleaning up... 06:37:02 INFO - Return code: 0 06:37:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:02 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')]} 06:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:02 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')]} 06:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:02 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 0x7f0864dc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, '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 0x1499310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14997a0>, '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': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', '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 06:37:02 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 06:37:02 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 06:37:02 INFO - Using env: {'DISPLAY': ':0', 06:37:02 INFO - 'HOME': '/home/cltbld', 06:37:02 INFO - 'LANG': 'en_US.UTF-8', 06:37:02 INFO - 'LANGUAGE': 'en_US:en', 06:37:02 INFO - 'LOGNAME': 'cltbld', 06:37:02 INFO - 'MAIL': '/var/mail/cltbld', 06:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:02 INFO - 'MOZ_NO_REMOTE': '1', 06:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:02 INFO - 'NO_EM_RESTART': '1', 06:37:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:02 INFO - 'PWD': '/builds/slave/test', 06:37:02 INFO - 'SHELL': '/bin/bash', 06:37:02 INFO - 'SHLVL': '1', 06:37:02 INFO - 'TERM': 'linux', 06:37:02 INFO - 'TMOUT': '86400', 06:37:02 INFO - 'USER': 'cltbld', 06:37:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', 06:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:02 INFO - '_': '/tools/buildbot/bin/python'} 06:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:02 INFO - Running setup.py (path:/tmp/pip-9EHu_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:02 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)) 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:02 INFO - Running setup.py (path:/tmp/pip-RRCJu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:02 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)) 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:02 INFO - Running setup.py (path:/tmp/pip-4NZZD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:03 INFO - Running setup.py (path:/tmp/pip-ukeLwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:03 INFO - Running setup.py (path:/tmp/pip-g86gKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:03 INFO - Running setup.py (path:/tmp/pip-IsQBAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:03 INFO - Running setup.py (path:/tmp/pip-FdneGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:03 INFO - Running setup.py (path:/tmp/pip-kfnTis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:03 INFO - Running setup.py (path:/tmp/pip-yGA2Ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:03 INFO - Running setup.py (path:/tmp/pip-QC0Iw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:03 INFO - Running setup.py (path:/tmp/pip-DIVYmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:03 INFO - Running setup.py (path:/tmp/pip-6uAhi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:03 INFO - Running setup.py (path:/tmp/pip-1LhXgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:03 INFO - Running setup.py (path:/tmp/pip-QCE_MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:03 INFO - Running setup.py (path:/tmp/pip-oH0FyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:03 INFO - Running setup.py (path:/tmp/pip-UDnWHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:03 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)) 06:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:03 INFO - Running setup.py (path:/tmp/pip-01Q29A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:04 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)) 06:37:04 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)) 06:37:04 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)) 06:37:04 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)) 06:37:04 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)) 06:37:04 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)) 06:37:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:06 INFO - Downloading blessings-1.6.tar.gz 06:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:37:06 INFO - Installing collected packages: blessings 06:37:06 INFO - Running setup.py install for blessings 06:37:06 INFO - Successfully installed blessings 06:37:06 INFO - Cleaning up... 06:37:06 INFO - Return code: 0 06:37:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:06 INFO - Reading from file tmpfile_stdout 06:37:06 INFO - Current package versions: 06:37:06 INFO - argparse == 1.2.1 06:37:06 INFO - blessings == 1.6 06:37:06 INFO - blobuploader == 1.2.4 06:37:06 INFO - docopt == 0.6.1 06:37:06 INFO - manifestparser == 1.1 06:37:06 INFO - mozInstall == 1.12 06:37:06 INFO - mozcrash == 0.17 06:37:06 INFO - mozdebug == 0.1 06:37:06 INFO - mozdevice == 0.48 06:37:06 INFO - mozfile == 1.2 06:37:06 INFO - mozhttpd == 0.7 06:37:06 INFO - mozinfo == 0.9 06:37:06 INFO - mozleak == 0.1 06:37:06 INFO - mozlog == 3.1 06:37:06 INFO - moznetwork == 0.27 06:37:06 INFO - mozprocess == 0.22 06:37:06 INFO - mozprofile == 0.28 06:37:06 INFO - mozrunner == 6.11 06:37:06 INFO - mozscreenshot == 0.1 06:37:06 INFO - mozsystemmonitor == 0.0 06:37:06 INFO - moztest == 0.7 06:37:06 INFO - mozversion == 1.4 06:37:06 INFO - psutil == 3.1.1 06:37:06 INFO - requests == 1.2.3 06:37:06 INFO - wsgiref == 0.1.2 06:37:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:06 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')]} 06:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:06 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')]} 06:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:06 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 0x7f0864dc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, '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 0x1499310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14997a0>, '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': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', '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 06:37:06 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 06:37:06 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 06:37:06 INFO - Using env: {'DISPLAY': ':0', 06:37:06 INFO - 'HOME': '/home/cltbld', 06:37:06 INFO - 'LANG': 'en_US.UTF-8', 06:37:06 INFO - 'LANGUAGE': 'en_US:en', 06:37:06 INFO - 'LOGNAME': 'cltbld', 06:37:06 INFO - 'MAIL': '/var/mail/cltbld', 06:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:06 INFO - 'MOZ_NO_REMOTE': '1', 06:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:06 INFO - 'NO_EM_RESTART': '1', 06:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:06 INFO - 'PWD': '/builds/slave/test', 06:37:06 INFO - 'SHELL': '/bin/bash', 06:37:06 INFO - 'SHLVL': '1', 06:37:06 INFO - 'TERM': 'linux', 06:37:06 INFO - 'TMOUT': '86400', 06:37:06 INFO - 'USER': 'cltbld', 06:37:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', 06:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:06 INFO - '_': '/tools/buildbot/bin/python'} 06:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:06 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)) 06:37:06 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)) 06:37:06 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)) 06:37:06 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)) 06:37:06 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)) 06:37:06 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)) 06:37:06 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)) 06:37:06 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)) 06:37:06 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)) 06:37:06 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)) 06:37:06 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)) 06:37:06 INFO - Cleaning up... 06:37:06 INFO - Return code: 0 06:37:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:37:06 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')]} 06:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:06 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')]} 06:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:06 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 0x7f0864dc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, '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 0x1499310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14997a0>, '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': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', '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 06:37:06 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 06:37:06 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 06:37:06 INFO - Using env: {'DISPLAY': ':0', 06:37:06 INFO - 'HOME': '/home/cltbld', 06:37:06 INFO - 'LANG': 'en_US.UTF-8', 06:37:06 INFO - 'LANGUAGE': 'en_US:en', 06:37:06 INFO - 'LOGNAME': 'cltbld', 06:37:06 INFO - 'MAIL': '/var/mail/cltbld', 06:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:06 INFO - 'MOZ_NO_REMOTE': '1', 06:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:06 INFO - 'NO_EM_RESTART': '1', 06:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:06 INFO - 'PWD': '/builds/slave/test', 06:37:06 INFO - 'SHELL': '/bin/bash', 06:37:06 INFO - 'SHLVL': '1', 06:37:06 INFO - 'TERM': 'linux', 06:37:06 INFO - 'TMOUT': '86400', 06:37:06 INFO - 'USER': 'cltbld', 06:37:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', 06:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:06 INFO - '_': '/tools/buildbot/bin/python'} 06:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:07 INFO - Downloading/unpacking jsonschema 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:37:08 INFO - Downloading/unpacking functools32 (from jsonschema) 06:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:09 INFO - Downloading functools32-3.2.3-2.tar.gz 06:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:37:09 INFO - warning: no files found matching '*.txt' 06:37:09 INFO - no previously-included directories found matching 'build' 06:37:09 INFO - no previously-included directories found matching 'dist' 06:37:09 INFO - no previously-included directories found matching '.git*' 06:37:09 INFO - Installing collected packages: jsonschema, functools32 06:37:09 INFO - Running setup.py install for functools32 06:37:09 INFO - warning: no files found matching '*.txt' 06:37:09 INFO - no previously-included directories found matching 'build' 06:37:09 INFO - no previously-included directories found matching 'dist' 06:37:09 INFO - no previously-included directories found matching '.git*' 06:37:09 INFO - Successfully installed jsonschema functools32 06:37:09 INFO - Cleaning up... 06:37:09 INFO - Return code: 0 06:37:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0864dc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14095a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498410>, '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 0x1499310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14997a0>, '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': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', '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 06:37: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', 'flake8'] in /builds/slave/test/build 06:37: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 flake8 06:37:09 INFO - Using env: {'DISPLAY': ':0', 06:37:09 INFO - 'HOME': '/home/cltbld', 06:37:09 INFO - 'LANG': 'en_US.UTF-8', 06:37:09 INFO - 'LANGUAGE': 'en_US:en', 06:37:09 INFO - 'LOGNAME': 'cltbld', 06:37:09 INFO - 'MAIL': '/var/mail/cltbld', 06:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:09 INFO - 'MOZ_NO_REMOTE': '1', 06:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:09 INFO - 'NO_EM_RESTART': '1', 06:37:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:09 INFO - 'PWD': '/builds/slave/test', 06:37:09 INFO - 'SHELL': '/bin/bash', 06:37:09 INFO - 'SHLVL': '1', 06:37:09 INFO - 'TERM': 'linux', 06:37:09 INFO - 'TMOUT': '86400', 06:37:09 INFO - 'USER': 'cltbld', 06:37:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', 06:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:09 INFO - '_': '/tools/buildbot/bin/python'} 06:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:09 INFO - Downloading/unpacking flake8 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:37:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:37:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:37:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:37:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:37:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:37:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:37:12 INFO - no previously-included directories found matching 'docs/_build' 06:37:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:37:12 INFO - Running setup.py install for pep8 06:37:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:37:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:37:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:37:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:37:12 INFO - no previously-included directories found matching 'docs/_build' 06:37:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:37:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:37:12 INFO - Cleaning up... 06:37:12 INFO - Return code: 0 06:37:12 INFO - Running post-action listener: _resource_record_post_action 06:37:12 INFO - Running post-action listener: _start_resource_monitoring 06:37:12 INFO - Starting resource monitoring. 06:37:12 INFO - ##### 06:37:12 INFO - ##### Running install step. 06:37:12 INFO - ##### 06:37:12 INFO - Running pre-action listener: _resource_record_pre_action 06:37:12 INFO - Running main action method: install 06:37:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:12 INFO - Reading from file tmpfile_stdout 06:37:12 INFO - Detecting whether we're running mozinstall >=1.0... 06:37:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:37:12 INFO - Reading from file tmpfile_stdout 06:37:12 INFO - Output received: 06:37:12 INFO - Usage: mozinstall [options] installer 06:37:12 INFO - Options: 06:37:12 INFO - -h, --help show this help message and exit 06:37:12 INFO - -d DEST, --destination=DEST 06:37:12 INFO - Directory to install application into. [default: 06:37:12 INFO - "/builds/slave/test"] 06:37:12 INFO - --app=APP Application being installed. [default: firefox] 06:37:12 INFO - mkdir: /builds/slave/test/build/application 06:37:12 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'] 06:37:12 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 06:37:28 INFO - Reading from file tmpfile_stdout 06:37:28 INFO - Output received: 06:37:28 INFO - /builds/slave/test/build/application/firefox/firefox 06:37:28 INFO - Running post-action listener: _resource_record_post_action 06:37:28 INFO - ##### 06:37:28 INFO - ##### Running run-tests step. 06:37:28 INFO - ##### 06:37:28 INFO - Running pre-action listener: _resource_record_pre_action 06:37:28 INFO - Running main action method: run_tests 06:37:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:37:28 INFO - Python 2.7.3 06:37:28 INFO - Return code: 0 06:37:28 INFO - grabbing minidump binary from tooltool 06:37:28 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')]} 06:37:28 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 0x1498410>, '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 0x1499310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14997a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:37:28 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 06:37:28 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 06:37:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:37:28 INFO - Return code: 0 06:37:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:37:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:37:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:37:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:37:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:37:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:37:29 INFO - Return code: 0 06:37:29 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/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 06:37:29 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/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 06:37:29 INFO - Using env: {'DISPLAY': ':0', 06:37:29 INFO - 'HOME': '/home/cltbld', 06:37:29 INFO - 'LANG': 'en_US.UTF-8', 06:37:29 INFO - 'LANGUAGE': 'en_US:en', 06:37:29 INFO - 'LOGNAME': 'cltbld', 06:37:29 INFO - 'MAIL': '/var/mail/cltbld', 06:37:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:37:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:29 INFO - 'MOZ_NO_REMOTE': '1', 06:37:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:29 INFO - 'NO_EM_RESTART': '1', 06:37:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:29 INFO - 'PWD': '/builds/slave/test', 06:37:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:37:29 INFO - 'SHELL': '/bin/bash', 06:37:29 INFO - 'SHLVL': '1', 06:37:29 INFO - 'TERM': 'linux', 06:37:29 INFO - 'TMOUT': '86400', 06:37:29 INFO - 'USER': 'cltbld', 06:37:29 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462800996.839670-724582139', 06:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:29 INFO - '_': '/tools/buildbot/bin/python'} 06:37:29 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/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 06:37:29 INFO - mozversion application_buildid: 20160509025943 06:37:29 INFO - mozversion application_changeset: 0e7f650568bbd910b20bdf7c8c2f1d193475cf2a 06:37:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:37:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:37:29 INFO - mozversion application_name: Firefox 06:37:29 INFO - mozversion application_remotingname: firefox-dev 06:37:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:37:29 INFO - mozversion application_vendor: Mozilla 06:37:29 INFO - mozversion application_version: 48.0a2 06:37:29 INFO - mozversion platform_buildid: 20160509025943 06:37:29 INFO - mozversion platform_changeset: 0e7f650568bbd910b20bdf7c8c2f1d193475cf2a 06:37:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:37:29 INFO - mozversion platform_version: 48.0a2 06:37:29 INFO - using testdate: 1462801049 06:37:29 INFO - actual date: 1462801049 06:37:29 INFO - starting webserver on 'localhost:55564' 06:37:29 INFO - SUITE-START | Running 2 tests 06:37:29 INFO - TEST-START | dromaeo_css 06:37:29 INFO - operating with platform_type : linux_ 06:37:29 INFO - Initialising browser for dromaeo_css test... 06:37:29 INFO - TEST-INFO | started process 11242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmIGAuG/profile http://localhost:55564/getInfo.html) 06:37:33 INFO - PROCESS | 11242 | __metrics Screen width/height:1600/1200 06:37:33 INFO - PROCESS | 11242 | colorDepth:24 06:37:33 INFO - PROCESS | 11242 | Browser inner width/height: 1024/697 06:37:33 INFO - PROCESS | 11242 | __metrics 06:37:34 ERROR - PROCESS | 11242 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:37:35 INFO - TEST-INFO | 11242: exit 0 06:37:35 INFO - Browser initialized. 06:37:35 INFO - Running cycle 1/1 for dromaeo_css test... 06:37:35 INFO - TEST-INFO | started process 11333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmIGAuG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:47 INFO - PROCESS | 11333 | RSS: Main: 142127104 06:37:47 INFO - PROCESS | 11333 | 06:38:38 INFO - PROCESS | 11333 | 1462801118010 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] 06:40:45 INFO - PROCESS | 11333 | Cycle 1(1): loaded http://localhost:55564/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55564/tests/dromaeo/cssquery-ext.html) 06:40:46 INFO - PROCESS | 11333 | RSS: Main: 249618432 06:40:46 INFO - PROCESS | 11333 | 06:43:48 INFO - PROCESS | 11333 | Cycle 1(1): loaded http://localhost:55564/tests/dromaeo/cssquery-ext.html (next: http://localhost:55564/tests/dromaeo/cssquery-jquery.html) 06:43:49 INFO - PROCESS | 11333 | RSS: Main: 226230272 06:43:49 INFO - PROCESS | 11333 | 06:46:51 INFO - PROCESS | 11333 | Cycle 1(1): loaded http://localhost:55564/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55564/tests/dromaeo/cssquery-mootools.html) 06:46:51 INFO - PROCESS | 11333 | RSS: Main: 217047040 06:46:51 INFO - PROCESS | 11333 | 06:49:53 INFO - PROCESS | 11333 | Cycle 1(1): loaded http://localhost:55564/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55564/tests/dromaeo/cssquery-prototype.html) 06:49:54 INFO - PROCESS | 11333 | RSS: Main: 218472448 06:49:54 INFO - PROCESS | 11333 | 06:52:56 INFO - PROCESS | 11333 | Cycle 1(1): loaded http://localhost:55564/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55564/tests/dromaeo/cssquery-yui.html) 06:52:57 INFO - PROCESS | 11333 | RSS: Main: 185569280 06:52:57 INFO - PROCESS | 11333 | 06:55:59 INFO - PROCESS | 11333 | Cycle 1(1): loaded http://localhost:55564/tests/dromaeo/cssquery-yui.html (next: http://localhost:55564/tests/dromaeo/cssquery-dojo.html) 06:55:59 INFO - PROCESS | 11333 | RSS: Main: 255664128 06:55:59 INFO - PROCESS | 11333 | 06:55:59 INFO - PROCESS | 11333 | __start_tp_report 06:55:59 INFO - PROCESS | 11333 | _x_x_mozilla_page_load 06:55:59 INFO - PROCESS | 11333 | _x_x_mozilla_page_load_details 06:55:59 INFO - PROCESS | 11333 | |i|pagename|runs| 06:55:59 INFO - PROCESS | 11333 | |0;dojo.html;3300.290437555925;3328.8335583220833;3346.297277571709;3356.7314614830816;3379.4761811919147;5433.592480563953;5443.61894667373;5468.343798744147;5470.972645136773;5487.149491828763;5467.125259958408;5492.972535137319;5495.560355171587;5500.28496295481;5520.1167813149905;4900.926486102711;4969.503049695038;5050.646454748169;5080.517350851663;5118.488151184871;4941.160002799515;5020.673656212334;5023.799048038074;5023.924641130386;5033.144365457881;4980.402351717799;5033.723145227011;5041.294218809369;5051.848444546651;5054.317667114948;5064.949350506503;5086.720230387327;5091.41448733393;5102.566281866046;5131.3842338919385;4834.468208497063;4911.5088491150955;4991.825286115005;4999;5004.274380214849;5420.457954204588;5461.69960652164;5476.288082549283;5486.835394938118;5490.149026900836;5803.071508558653;5826.9708651456895;5830.096335068071;5840.620359676607;5841.153032810261;5739.942600573982;5838.591298609099;5873.383294754032;5878.2064421303;5893.322267939199;5492.093804522249;5521;5535.308086489189;5542.3626282977975;5547.0570003099165;5830.3586605473365;6000.849978750479;6005.879882402328;6009.729562169713;6010.579259451796;5749.080147176515;5816.94183058164;5822.70886455684;5824.242848429762;5833.778768002614;5863.091220860773;5876.206712093898;5877.412258774174;5878.735456904449;5883.940890639726;5694.572907031989;5757.13642953552;5850.5612079094235;5858.062709966385;5863.824085277449;5839.737211825478;5863.736131874076;5868.941310586925;5871.706414679249;5901.114832775118;4470.86587402372;4471.19518486669;4474.440694913136;4487.977560112178;4502.324651302265;3970.5433875104154;3982.0443093657314;4019.2765302245293;4034.3948407739076;4080.163566468867;5568.805091821767;5582.91625625616;5587.69267690281;5589.80435684749;5589.944100558942;5927.644341339534;5951.137085122633;5954.4045595440975;5955.047192449188;5962.135490353961;5387.0841956867425;5518.420565840529;5550;5618.157276408571;5630.774769009194;5097.337346144977;5115.514026167508;5119.488051194925;5121.103806833789;5127.897442051138;6152.630842149396;6164.4143806338325;6166.7224974876235;6172.660503672341;6173.876522469525;5817.301923769175;5892.116182572477;5955.076963070817;5996.070609055603;5996.160537524663;6113.419225173601;6126.23422072241;6128.724207410588;6128.754849805958;6133.693315334126;5812.447817457335;5816.534677225727;5818.040023396092;5821.38875418075;5822;5791.739371728367;5874.353821079592;5962.672053037125;5981.910271345846;5999.310079340931;5763.827085187451;5768.423157684198;5775.624584402;5777.24895763548;5783.566232532493;5492.47821456961;5706.229658995982;5740.425957404226;5764.596478246483;5771;5568.443155684399;5647.604667673388;5649.039663257338;5671.914921276101;5679.00617391963;5720.570957178312;5764.423557644202;5772.509336706259;5776.480116789509;5779.797707080232;5554.472325129106;5565.248691426767;5619.803306884403;5625.212470254086;5659.122835960433 06:55:59 INFO - PROCESS | 11333 | |1;ext.html;610.7068607068607;658.2758965138347;666.9528839721639;675.912131422915;677.6306912732557;32575.348493030157;33212.66787332126;33244.16889577762;39913.60086399135;40697.79651101748;43940.340894886605;44341.33487997683;44417.55582444175;44445.55554444455;44500.332495012604;8871.201591856732;9066.954665226665;9070.86393704095;9073.183413492785;9073.863892041625;8863.734087977371;8994.325425593073;9000.234980026706;9000.8649870252;9009.099090091004;8927.866082008775;9001.909980900205;9202;9211.907880921206;9224.215941644969;9124.498152601604;9164.26685865136;9183.265338772882;9191.954040229823;9192.126747958933;9082.909170908273;9201.723948281562;9208.26333893287;9208.723738287863;9211.447313161232;44389.33415998763;44842.55157448416;44958.10083798306;44997.775011125064;45026.54973450289;3804;3832.5999960180748;4062.2078694654556;4355.063661312833;4643.8142474300985;33730;34172.31655366879;34327.485087723704;34351;34539.65460345389;4546.431696037996;4640.721556706609;4650.7209567425725;4651.976740116278;4662.137504561667;311984;313919.4304028488;315440;316440;316641;60163.39836601578;60942.39057609367;61020.42346824006;61040;61082.694586526784;69688.6515567419;70998;71026;71033;71101.64449177722;16935.661286774197;16950.576235593962;16972.32110715582;17008.744868826976;17012.48962531126;14540.27298635064;14686.118832870063;14687.706245875022;14720.116792992454;14730.189839558927;20848.1660733572;21196.682049769264;21228.363149105553;21296.574068518545;21473.248436304653;7483;7608.2391760823475;7626.4832605240135;7688.538687678757;7833.921660783433;1137.1585027079902;1144.3305666185208;1164.545827127421;1188.477070089158;1223.9143259971715;33553;33909;34168.48747268743;34439.65560344364;34546.17636841884;1232.6671798614325;1236.9690757730948;1250.4498020870788;1252.8935040521658;1407.197897198587;17127.229274682668;17988.91005544964;18029.639407212046;18062.5484362892;18117.728234076498;484655;490566;491468;492120;492207;60600;61916.380836191965;61954.380456195766;62112.378876211566;62159.6892015537;1344.1666166976538;1527.7631967045127;1531.3109100904637;1571.363597742916;1583.5961829733574;30453.695463045085;33328.83335583306;33927.4910876342;33952.490712638835;34598.82700586481;49864;49941.50058499514;50089.49910500849;50318;50390;310223;311173;312043;312235;312679;26257.868710657087;30345.848270758506;30391;31868.68131318657;32689.34621307513;48131;48532.5146748528;48914.26628600645;48922.75538622284;49449.25826112539;41005;41040.79479602583;41074.794626026676;42208.57791422046;42536.149277014905;39627.018649068006;40028.799856000536;40660;41190.1761964753;41902.37146442745;41851;42564.5743542573;42664.57335426606;42812.35781463218;42917;35776;36489.452658209615;36777;37021.25957480782;37336;27846.721532784413;28167.282901969113;28464.43071138607;28618.57072143878;28637.856810715813 06:55:59 INFO - PROCESS | 11333 | |2;jquery.html;409.84218091746936;414.61440860000187;416.1365167277898;422.5056683680094;429.4095618524529;13581.523612547406;18715.43853684388;19235.42293731187;19250.22999080035;19883.105260263288;15864.841351586481;19229.711554326663;19482;19811.405657830288;19993.20027198914;5603.271574695284;5746.339170995348;5749.367569567345;5754.82735517933;5778.4799368056865;5695.316562012544;5719.370869204384;5719.714014299289;5729.914051289234;5739.253896993385;5480.6437581557275;5611.410801865806;5638.492535671789;5662.037453632872;5739;5766.509846663039;5774;5805.448482394166;5822.650640961535;5825.941740582603;5115.437301896788;5162.277281180638;5218.66078704883;5222.190560463135;5225.503577160163;23173.88413057941;23631.881840590686;24156;24224.515509689885;24366.634500482505;2615.8692065396654;2717.252755492236;2738.7535121838932;3044.406340763552;3079.538069289602;14496.71006579873;14999.775003374958;15100.169490678009;15379.923100384538;15427.3829046838;2040.4490787487443;2071.2025870039993;2102.127617038927;2115.206797450956;2208.447888027993;75348.62325688337;78375;78548;79674;81035.5948220261;10928.289661171999;10996.450177491253;11001.394923279297;11053.613123540637;11072.723181920355;15795.289211985488;15888.60278493047;15915;15949.282282297325;15979.280932358071;8253.298469630028;8490.066092729794;8497.66009359631;8603.01065377477;8683.305335573139;8579.613917373734;8582;8650;8726.825463490695;8732.650693972297;4315.4605674290715;4850.641820290324;4898.265260210926;4918.631102667314;4958.578520825698;1904.6190761847408;1992.3126521350111;1998.1607724755638;2036.297477370305;2040.4184807329839;991.2763682511807;996.4718699089494;1052.6999805055523;1090.0897750378522;1113.1206346985791;19482.512937176685;19617.90191049064;19755.40733777989;19769;20014.399568012985;1142.5258517715056;1143.3768596115137;1159.7680463907084;1181.3502573584667;1184.2894263441865;11306.886931130583;11382.886171138349;11409.42952852354;11431.771364572662;11585.594504192313;500003;500278;509712;512888;516351;91433.08566914246;92467;92956;93030.53484732533;93237.0676293242;1094.9616763413242;1133.246391149876;1167.5679998400647;1179.6107284596062;1194.0328334049275;17255.82744172542;17759.644807103527;17802.109894505484;17870.5532361692;18139.54651133732;39494.2101157981;39589.80205098956;40233.79883100683;40806.1838763229;41313.79343103385;59133.40866591279;59903.400965989786;59943.70028150006;60005;60127;8507.191816777397;8634.654613815377;8678.392512524062;8737.344699147463;8853.911460885567;9440.811183776148;12178.695532611755;12357.32034738098;13774.586762397144;13818.516351927634;12223;12733.61799146027;12804.871951280367;12920.741585168433;12934.482620695067;12138;12182.817257740964;12397.75204495923;12406.13157079032;12479.625611231677;12996.350182491027;13137.802932956205;13218.933905330412;13222.735545289233;13407.128536645087;8485.703000394957;8682.52246126469;8695.695650652196;8778.14845704751;8985.505797181218;9220.308476864127;11287.887121129012;12359.752804943671;12379.814302785646;12416.379181041093 06:55:59 INFO - PROCESS | 11333 | |3;mootools.html;1435.8564143585636;1562.7343351630223;1571.4107209796327;1789.9528775666236;1913.9138738756756;7962.40281978851;8291.378146638996;8318;8320.292775114114;8322.001359836828;8045.316148127402;8130.186981301867;8180.141085186059;8189.959050204756;8216.301614362786;2064.6077245323418;2334.171369163948;2354.4702441950553;2378.227076200233;2405.6391541268777;2412.0954642009247;2424.2727181845376;2425.9757402425926;2427.1626288930293;2427.2232885476656;2302.5970455170363;2347.0377145370403;2348.3542025942916;2352.388379021458;2353.7999270062064;2068.451860257033;2284.794368506834;2346.8239882008916;2348.365941195876;2350.4241460842204;2328.0338659456306;2355.646653002046;2371.8695471749047;2372.3001714494267;2380.131252092991;8157.673693052271;8211.21993410625;8213.917860821375;8221.136780638066;8226.712065077754;5146.485351464824;5258.027264955996;5300.814471493518;5307.6019298552765;5323.148296272617;3405.880794172192;3417.96582034179;3436.8281585920854;3483.442649176145;3536.6816986471085;1125.7523344864117;1126.317727066941;1129.5425352732157;1132.6828488023366;1166.7958107331267;11825.586104486387;11897.107716921266;11910.46402911871;11917.046636269077;11931.821022684666;4514.232580461329;4542.568455996675;4578.633709303314;4595.517470665532;4627.606653434428;10270;10272.486375681336;10285.9485702571;10299.17606591471;10316.48417579118;4625.167469855391;5294.54996325309;5296.682199068068;5299.152135658276;5303.7348132593215;4598.057398233354;4636.165490211794;4638.0260145369175;4642.837500687459;4678.929816052762;3994.820233089518;4023.5510543376167;4094.877153685394;4105.69207309447;4119.496383819885;1249.843769528809;1287.8969682425384;1310.1418570836117;1313.1727011982389;1322.715616142534;996.9601215951426;1005.4269066632096;1010.9898901010896;1021.7496713305139;1029.891861354562;6075.119107729354;6089.878202435926;6136.631802091889;6165.383461653799;6270.874582508324;425.6594724220611;438.6863392674253;444.1428043875287;444.6509490050295;444.7798339821809;4256.191323648559;4283.550227226158;4285.935710964338;4302.720323178984;4315.546867578859;10222.795544089226;10605.045545900752;10612.734681632866;10639.095676867553;10677.199210059276;10356.533955971849;10364.792704146026;10448.947755261175;10463.738406539745;10472.842907356397;7650;7771.222877712296;8180.46826956246;8180.754577362689;8181.263686268265;5809.24479817621;5820.94179058204;5824.097264923944;5825.184474173704;5901.380355062656;9052;9149.176574108096;9207.40151890125;9217.58520866576;9278.907210927804;8874.955625221832;8887.37788354809;8904.510251936206;9067.637294508146;9430.151286384258;7050.753223637148;7632.274933881273;7744.8451030980195;7954.880676789737;8070.677172913252;7675.462717609714;7694;7797.454178207471;7808.687652493837;7855.33229675484;6924.861502770017;7048.894266585903;7240.96379518099;7375.078115235596;7566.016417865642;7019.613921234381;7200.783976480714;7214.170370407471;7224.422046236184;7230.6384680766805;6867.896981545181;6883.586984780929;6893.103896493624;6950.3049695030095;6955.617441040791;4998.825041123543;5066.518680725325;5154.8969020620125;5194.844154675366;5283.313169287968;5023.824166154167;5053.823116190915;5071.518205770446;5132.409772876018;5151.356080489939 06:55:59 INFO - PROCESS | 11333 | |4;prototype.html;320.12445960298595;327.26365677226244;328.9835508224588;330.5983230375094;332.7338129496403;6052.546059045567;6083.969580152093;6243.687815609218;6247.875042499153;6260.561760676749;6106.847328816782;6220.409061139196;6231.283402408724;6248.562600617958;6259.186305780254;4747.976260118712;4764.190087685084;4772.284157376386;4772.594329481998;4786.880327991811;4516.36770852081;4556.2254416749065;4690.061987602493;4775.570198682118;4778.522147785228;4637.605803506706;4642.257238841786;4647.34937108805;4650.7907144178425;4662.790174442158;4615.976920115411;4630.606398456135;4633.2586786114225;4641.8839529011875;4663.857354948025;3994.0414300567654;4002.779847108408;4009.3785463253244;4017.4777278953547;4040.9897525618594;5870.823875283749;5885.911711324334;5901.29184497863;5903.822885313448;5917.2307600012155;5326.280952071498;5327.840164795023;5329.147336426153;5332.653377530448;5367.597430192712;6268.623882567061;6518.511111666597;6522.086907832907;6531.836704082389;6532.11816404784;4407.823687052514;4419.779011049434;4423.225935461282;4425.579569940851;4427.247367947457;6751.582167744779;6826.010228516837;6837.931620683829;6838.658067096625;6841.965790171067;4500.932486012713;4501.279795232747;4505.7296562206375;4509.616682581952;4514.164879497303;4560.612347950395;4565.885852853638;4572.314152877095;4574.611158051536;4576.084783043405;5158.638895277295;5255.474452554714;5284.894302113936;5301.0723123453245;5336.439673834191;6532.08550802888;6532.6733663316645;6543.411093001652;6555.901661475082;6557.082008518812;1513.530805450314;1548.6825200833803;1554.4870192836338;1556.144120733592;1604.0375774535419;1010.7574182196367;1038.6364772329623;1047.1099565369375;1047.4972013433442;1052.3422860712055;6223.844403889939;6298.433141017331;6299.1811064562235;6336.651484168323;6339.904901426482;6752.696128674222;6753.561018533779;6779.830504237433;6786.287439818847;6787.490938179656;6318.778842740574;6327.683615819191;6334.049892516159;6338;6339.936600634027;3621.1309285771226;3649.5620525536574;3651.6348365163803;3653.0867283179205;3658.835352409148;6856.760013399607;6991.7902462926195;7002.929970700227;7004.649767511604;7009.369156775914;6862.759803406957;6878.071460352889;6880.139982502187;6883.242843287235;6901.275366086589;6984.092068031225;6988.720451181997;6996.440284777205;7006.194287656883;7008.649567521604;6707.731690732316;6753.122094127929;6756.054152418567;6764.729410823709;6773.254941956479;6458.967705161444;6613;6616.90074648871;6638.17022872141;6646.700898459484;6958.3041695832035;6976.093107895941;6991.755288564876;6995.580265184105;7000.229974702676;4522.841700540465;4523.886902827456;4524.5701658342405;4524.5927866492175;4526.796294166837;6540.247871494839;6715.966420167868;6724.226713927961;6731.764388246388;6731.966340168464;6474.902876456763;6542.574732642363;6656.600603963778;6674.098996635586;6682.264950855305;6584.539082264196;6623.503237257321;6632.071509988509;6648.867022659423;6650.567713098633;6534.313897040743;6543.149390579194;6549.279579246374;6549.345065493603;6549.574277671936;6557.245916719447;6689.966550167218;6700.195976482853;6703.597784132968;6710.865782684416;6481.384268494486;6510.153680021567;6510.414062734377;6511.413972742476;6515.934840651723 06:55:59 INFO - PROCESS | 11333 | |5;yui.html;884.9513276769778;889.550776857687;930.1024511346549;935.4013431403907;950.4677380666827;13971.650708732286;15167.089974601518;15389.615259618502;15429.382824687;15466.226688665578;13892.23592702401;14376.424943002268;14376.928115359435;14378.712425751479;14386.712265754679;726.8618962397128;883.1080608585343;884.2042162054171;898.3531857062937;898.8606765951288;892.4288455388556;894.6108442827391;895.7447127568644;896.3098414221046;896.8789213456165;950.5722424908819;955.3885513271512;956.0821611253206;957.683964291782;957.8419560772498;764.1288930619098;952.9761755956088;958.9712308630752;959.8896126945386;960.1071003966308;697.135551915621;700.8353037036293;702.1188408547291;702.7434986229989;703.395080231001;15097.24513774307;15149.469768558158;15158.31787569562;15216.771748423782;15219.467318643794;14185.858141418557;14639.780403293958;14705.338259778335;14714.70570588593;14834.925825370805;11819.527218911233;11912.642620721392;12082.818757718642;12139.210951288138;12206;4634.050019745944;4651.534846515356;4672.836450724209;4675.625949924032;4775.856724298276;51571.742141289425;57888.71055644737;57915.13127303094;58311;58362;11192.160587955936;11332.886671133183;11508.136889733303;11552.6534203974;11768.117391195523;20715.378538643865;20722.378328650164;20743;20792.688109678365;20864.582708345748;8509.234168924702;8837.55812209387;8887.73336799897;9029.36794424384;9131.041240669634;4979.950200497949;4985.102681517289;5035.219540971156;5105.33630628016;5284.682919024794;3596.964030359663;3641.9453708194396;3643;3653.5250417445563;3658.8719394821055;636.7039326713008;642.1010585180784;649.7401039584204;679.4055201698513;707.900893874858;809.4576633655465;821.4660470694097;829.668132746894;832.3050253038659;854.9529775862387;10068.194544436428;10206.183505319557;10279.94860025695;10527.526261318259;10623.787524249472;748.472327009457;795.5902710104301;800.9279164875189;814.4421071565996;816.9387295952828;4851.636127290467;4872.926906096412;4874.341963834908;4926.950730492721;4955.925661115086;68078.97881531781;69341.65329173322;69370.3062969374;69372.3062769376;69454.95817562741;57440.425595744346;58125.70937145372;58437;58661.70669146627;58860.70569647125;52201;52221.7388913053;53034.46965530373;53089.2036619451;53731.19403208955;9414.905850941677;9444.716658500256;9499.905000950179;9565.61737530491;9622.711318660451;38700.22599547937;38701;40286.1942761149;40844.79577602093;41509;47880;50745.23882141845;51686.483135168164;52326.73836630792;52850.20724689056;11601.883981160418;11785.528578856749;11992.760144796881;12109.212901161749;12128.21166624202;13016.739665206833;13430.93284533571;13600.659983500096;13616;13902.096363736326;10866.261398176253;11877.76244475123;12392.256464612152;12671.936640316739;13165.210087394787;11796.41017949082;12214.57248996281;12525.56160534377;13134.474621015052;13983.44066237339;13140.868591313965;13322.933385333012;13359.398827053;13389.598312050653;13441.731165376834;11171.162162837658;11344;11522.942385288019;11670.241434306743;11877.346745929057;11155.330680159217;11307;11526.711832204262;11552.249103808226;11723.296602203554 06:55:59 INFO - PROCESS | 11333 | __end_tp_report 06:55:59 INFO - PROCESS | 11333 | __start_cc_report 06:55:59 INFO - PROCESS | 11333 | _x_x_mozilla_cycle_collect,837 06:55:59 INFO - PROCESS | 11333 | __end_cc_report 06:55:59 INFO - PROCESS | 11333 | __startTimestamp1462802159904__endTimestamp 06:55:59 INFO - PROCESS | 11333 | 06:55:59 INFO - PROCESS | 11333 | ------- Summary: start ------- 06:55:59 INFO - PROCESS | 11333 | Number of tests: 6 06:55:59 INFO - PROCESS | 11333 | 06:55:59 INFO - PROCESS | 11333 | [#0] dojo.html Cycles:165 Average:5470.84 Median:5649.04 stddev:601.69 (10.7%) stddev-sans-first:578.94 06:55:59 INFO - PROCESS | 11333 | Values: 3300.3 3328.8 3346.3 3356.7 3379.5 5433.6 5443.6 5468.3 5471.0 5487.1 5467.1 5493.0 5495.6 5500.3 5520.1 4900.9 4969.5 5050.6 5080.5 5118.5 4941.2 5020.7 5023.8 5023.9 5033.1 4980.4 5033.7 5041.3 5051.8 5054.3 5064.9 5086.7 5091.4 5102.6 5131.4 4834.5 4911.5 4991.8 4999.0 5004.3 5420.5 5461.7 5476.3 5486.8 5490.1 5803.1 5827.0 5830.1 5840.6 5841.2 5739.9 5838.6 5873.4 5878.2 5893.3 5492.1 5521.0 5535.3 5542.4 5547.1 5830.4 6000.8 6005.9 6009.7 6010.6 5749.1 5816.9 5822.7 5824.2 5833.8 5863.1 5876.2 5877.4 5878.7 5883.9 5694.6 5757.1 5850.6 5858.1 5863.8 5839.7 5863.7 5868.9 5871.7 5901.1 4470.9 4471.2 4474.4 4488.0 4502.3 3970.5 3982.0 4019.3 4034.4 4080.2 5568.8 5582.9 5587.7 5589.8 5589.9 5927.6 5951.1 5954.4 5955.0 5962.1 5387.1 5518.4 5550.0 5618.2 5630.8 5097.3 5115.5 5119.5 5121.1 5127.9 6152.6 6164.4 6166.7 6172.7 6173.9 5817.3 5892.1 5955.1 5996.1 5996.2 6113.4 6126.2 6128.7 6128.8 6133.7 5812.4 5816.5 5818.0 5821.4 5822.0 5791.7 5874.4 5962.7 5981.9 5999.3 5763.8 5768.4 5775.6 5777.2 5783.6 5492.5 5706.2 5740.4 5764.6 5771.0 5568.4 5647.6 5649.0 5671.9 5679.0 5720.6 5764.4 5772.5 5776.5 5779.8 5554.5 5565.2 5619.8 5625.2 5659.1 06:55:59 INFO - PROCESS | 11333 | 06:55:59 INFO - PROCESS | 11333 | [#1] ext.html Cycles:180 Average:55364.49 Median:41876.69 stddev:100620.01 (240.3%) stddev-sans-first:100818.30 06:55:59 INFO - PROCESS | 11333 | Values: 610.7 658.3 667.0 675.9 677.6 32575.3 33212.7 33244.2 39913.6 40697.8 43940.3 44341.3 44417.6 44445.6 44500.3 8871.2 9067.0 9070.9 9073.2 9073.9 8863.7 8994.3 9000.2 9000.9 9009.1 8927.9 9001.9 9202.0 9211.9 9224.2 9124.5 9164.3 9183.3 9192.0 9192.1 9082.9 9201.7 9208.3 9208.7 9211.4 44389.3 44842.6 44958.1 44997.8 45026.5 3804.0 3832.6 4062.2 4355.1 4643.8 33730.0 34172.3 34327.5 34351.0 34539.7 4546.4 4640.7 4650.7 4652.0 4662.1 311984.0 313919.4 315440.0 316440.0 316641.0 60163.4 60942.4 61020.4 61040.0 61082.7 69688.7 70998.0 71026.0 71033.0 71101.6 16935.7 16950.6 16972.3 17008.7 17012.5 14540.3 14686.1 14687.7 14720.1 14730.2 20848.2 21196.7 21228.4 21296.6 21473.2 7483.0 7608.2 7626.5 7688.5 7833.9 1137.2 1144.3 1164.5 1188.5 1223.9 33553.0 33909.0 34168.5 34439.7 34546.2 1232.7 1237.0 1250.4 1252.9 1407.2 17127.2 17988.9 18029.6 18062.5 18117.7 484655.0 490566.0 491468.0 492120.0 492207.0 60600.0 61916.4 61954.4 62112.4 62159.7 1344.2 1527.8 1531.3 1571.4 1583.6 30453.7 33328.8 33927.5 33952.5 34598.8 49864.0 49941.5 50089.5 50318.0 50390.0 310223.0 311173.0 312043.0 312235.0 312679.0 26257.9 30345.8 30391.0 31868.7 32689.3 48131.0 48532.5 48914.3 48922.8 49449.3 41005.0 41040.8 41074.8 42208.6 42536.1 39627.0 40028.8 40660.0 41190.2 41902.4 41851.0 42564.6 42664.6 42812.4 42917.0 35776.0 36489.5 36777.0 37021.3 37336.0 27846.7 28167.3 28464.4 28618.6 28637.9 06:55:59 INFO - PROCESS | 11333 | 06:55:59 INFO - PROCESS | 11333 | [#2] jquery.html Cycles:180 Average:29756.66 Median:13491.25 stddev:83568.64 (619.4%) stddev-sans-first:83774.02 06:55:59 INFO - PROCESS | 11333 | Values: 409.8 414.6 416.1 422.5 429.4 13581.5 18715.4 19235.4 19250.2 19883.1 15864.8 19229.7 19482.0 19811.4 19993.2 5603.3 5746.3 5749.4 5754.8 5778.5 5695.3 5719.4 5719.7 5729.9 5739.3 5480.6 5611.4 5638.5 5662.0 5739.0 5766.5 5774.0 5805.4 5822.7 5825.9 5115.4 5162.3 5218.7 5222.2 5225.5 23173.9 23631.9 24156.0 24224.5 24366.6 2615.9 2717.3 2738.8 3044.4 3079.5 14496.7 14999.8 15100.2 15379.9 15427.4 2040.4 2071.2 2102.1 2115.2 2208.4 75348.6 78375.0 78548.0 79674.0 81035.6 10928.3 10996.5 11001.4 11053.6 11072.7 15795.3 15888.6 15915.0 15949.3 15979.3 8253.3 8490.1 8497.7 8603.0 8683.3 8579.6 8582.0 8650.0 8726.8 8732.7 4315.5 4850.6 4898.3 4918.6 4958.6 1904.6 1992.3 1998.2 2036.3 2040.4 991.3 996.5 1052.7 1090.1 1113.1 19482.5 19617.9 19755.4 19769.0 20014.4 1142.5 1143.4 1159.8 1181.4 1184.3 11306.9 11382.9 11409.4 11431.8 11585.6 500003.0 500278.0 509712.0 512888.0 516351.0 91433.1 92467.0 92956.0 93030.5 93237.1 1095.0 1133.2 1167.6 1179.6 1194.0 17255.8 17759.6 17802.1 17870.6 18139.5 39494.2 39589.8 40233.8 40806.2 41313.8 59133.4 59903.4 59943.7 60005.0 60127.0 8507.2 8634.7 8678.4 8737.3 8853.9 9440.8 12178.7 12357.3 13774.6 13818.5 12223.0 12733.6 12804.9 12920.7 12934.5 12138.0 12182.8 12397.8 12406.1 12479.6 12996.4 13137.8 13218.9 13222.7 13407.1 8485.7 8682.5 8695.7 8778.1 8985.5 9220.3 11287.9 12359.8 12379.8 12416.4 06:55:59 INFO - PROCESS | 11333 | 06:55:59 INFO - PROCESS | 11333 | [#3] mootools.html Cycles:180 Average:5601.66 Median:4631.89 stddev:3095.23 (66.8%) stddev-sans-first:3088.07 06:55:59 INFO - PROCESS | 11333 | Values: 1435.9 1562.7 1571.4 1790.0 1913.9 7962.4 8291.4 8318.0 8320.3 8322.0 8045.3 8130.2 8180.1 8190.0 8216.3 2064.6 2334.2 2354.5 2378.2 2405.6 2412.1 2424.3 2426.0 2427.2 2427.2 2302.6 2347.0 2348.4 2352.4 2353.8 2068.5 2284.8 2346.8 2348.4 2350.4 2328.0 2355.6 2371.9 2372.3 2380.1 8157.7 8211.2 8213.9 8221.1 8226.7 5146.5 5258.0 5300.8 5307.6 5323.1 3405.9 3418.0 3436.8 3483.4 3536.7 1125.8 1126.3 1129.5 1132.7 1166.8 11825.6 11897.1 11910.5 11917.0 11931.8 4514.2 4542.6 4578.6 4595.5 4627.6 10270.0 10272.5 10285.9 10299.2 10316.5 4625.2 5294.5 5296.7 5299.2 5303.7 4598.1 4636.2 4638.0 4642.8 4678.9 3994.8 4023.6 4094.9 4105.7 4119.5 1249.8 1287.9 1310.1 1313.2 1322.7 997.0 1005.4 1011.0 1021.7 1029.9 6075.1 6089.9 6136.6 6165.4 6270.9 425.7 438.7 444.1 444.7 444.8 4256.2 4283.6 4285.9 4302.7 4315.5 10222.8 10605.0 10612.7 10639.1 10677.2 10356.5 10364.8 10448.9 10463.7 10472.8 7650.0 7771.2 8180.5 8180.8 8181.3 5809.2 5820.9 5824.1 5825.2 5901.4 9052.0 9149.2 9207.4 9217.6 9278.9 8875.0 8887.4 8904.5 9067.6 9430.2 7050.8 7632.3 7744.8 7954.9 8070.7 7675.5 7694.0 7797.5 7808.7 7855.3 6924.9 7048.9 7241.0 7375.1 7566.0 7019.6 7200.8 7214.2 7224.4 7230.6 6867.9 6883.6 6893.1 6950.3 6955.6 4998.8 5066.5 5154.9 5194.8 5283.3 5023.8 5053.8 5071.5 5132.4 5151.4 06:55:59 INFO - PROCESS | 11333 | 06:55:59 INFO - PROCESS | 11333 | [#4] prototype.html Cycles:180 Average:5452.24 Median:6264.59 stddev:1680.66 (26.8%) stddev-sans-first:1640.64 06:55:59 INFO - PROCESS | 11333 | Values: 320.1 327.3 329.0 330.6 332.7 6052.5 6084.0 6243.7 6247.9 6260.6 6106.8 6220.4 6231.3 6248.6 6259.2 4748.0 4764.2 4772.3 4772.6 4786.9 4516.4 4556.2 4690.1 4775.6 4778.5 4637.6 4642.3 4647.3 4650.8 4662.8 4616.0 4630.6 4633.3 4641.9 4663.9 3994.0 4002.8 4009.4 4017.5 4041.0 5870.8 5885.9 5901.3 5903.8 5917.2 5326.3 5327.8 5329.1 5332.7 5367.6 6268.6 6518.5 6522.1 6531.8 6532.1 4407.8 4419.8 4423.2 4425.6 4427.2 6751.6 6826.0 6837.9 6838.7 6842.0 4500.9 4501.3 4505.7 4509.6 4514.2 4560.6 4565.9 4572.3 4574.6 4576.1 5158.6 5255.5 5284.9 5301.1 5336.4 6532.1 6532.7 6543.4 6555.9 6557.1 1513.5 1548.7 1554.5 1556.1 1604.0 1010.8 1038.6 1047.1 1047.5 1052.3 6223.8 6298.4 6299.2 6336.7 6339.9 6752.7 6753.6 6779.8 6786.3 6787.5 6318.8 6327.7 6334.0 6338.0 6339.9 3621.1 3649.6 3651.6 3653.1 3658.8 6856.8 6991.8 7002.9 7004.6 7009.4 6862.8 6878.1 6880.1 6883.2 6901.3 6984.1 6988.7 6996.4 7006.2 7008.6 6707.7 6753.1 6756.1 6764.7 6773.3 6459.0 6613.0 6616.9 6638.2 6646.7 6958.3 6976.1 6991.8 6995.6 7000.2 4522.8 4523.9 4524.6 4524.6 4526.8 6540.2 6716.0 6724.2 6731.8 6732.0 6474.9 6542.6 6656.6 6674.1 6682.3 6584.5 6623.5 6632.1 6648.9 6650.6 6534.3 6543.1 6549.3 6549.3 6549.6 6557.2 6690.0 6700.2 6703.6 6710.9 6481.4 6510.2 6510.4 6511.4 6515.9 06:55:59 INFO - PROCESS | 11333 | 06:55:59 INFO - PROCESS | 11333 | [#5] yui.html Cycles:180 Average:15912.38 Median:26365.82 stddev:18563.32 (70.4%) stddev-sans-first:18581.09 06:55:59 INFO - PROCESS | 11333 | Values: 885.0 889.6 930.1 935.4 950.5 13971.7 15167.1 15389.6 15429.4 15466.2 13892.2 14376.4 14376.9 14378.7 14386.7 726.9 883.1 884.2 898.4 898.9 892.4 894.6 895.7 896.3 896.9 950.6 955.4 956.1 957.7 957.8 764.1 953.0 959.0 959.9 960.1 697.1 700.8 702.1 702.7 703.4 15097.2 15149.5 15158.3 15216.8 15219.5 14185.9 14639.8 14705.3 14714.7 14834.9 11819.5 11912.6 12082.8 12139.2 12206.0 4634.1 4651.5 4672.8 4675.6 4775.9 51571.7 57888.7 57915.1 58311.0 58362.0 11192.2 11332.9 11508.1 11552.7 11768.1 20715.4 20722.4 20743.0 20792.7 20864.6 8509.2 8837.6 8887.7 9029.4 9131.0 4980.0 4985.1 5035.2 5105.3 5284.7 3597.0 3641.9 3643.0 3653.5 3658.9 636.7 642.1 649.7 679.4 707.9 809.5 821.5 829.7 832.3 855.0 10068.2 10206.2 10279.9 10527.5 10623.8 748.5 795.6 800.9 814.4 816.9 4851.6 4872.9 4874.3 4927.0 4955.9 68079.0 69341.7 69370.3 69372.3 69455.0 57440.4 58125.7 58437.0 58661.7 58860.7 52201.0 52221.7 53034.5 53089.2 53731.2 9414.9 9444.7 9499.9 9565.6 9622.7 38700.2 38701.0 40286.2 40844.8 41509.0 47880.0 50745.2 51686.5 52326.7 52850.2 11601.9 11785.5 11992.8 12109.2 12128.2 13016.7 13430.9 13600.7 13616.0 13902.1 10866.3 11877.8 12392.3 12671.9 13165.2 11796.4 12214.6 12525.6 13134.5 13983.4 13140.9 13322.9 13359.4 13389.6 13441.7 11171.2 11344.0 11522.9 11670.2 11877.3 11155.3 11307.0 11526.7 11552.2 11723.3 06:55:59 INFO - PROCESS | 11333 | -------- Summary: end -------- 06:55:59 INFO - PROCESS | 11333 | 06:56:00 INFO - TEST-INFO | 11333: exit 0 06:56:00 INFO - TEST-OK | dromaeo_css | took 1111024ms 06:56:00 INFO - TEST-START | kraken 06:56:00 INFO - operating with platform_type : linux_ 06:56:00 INFO - Initialising browser for kraken test... 06:56:00 INFO - TEST-INFO | started process 11524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF3ezal/profile http://localhost:55564/getInfo.html) 06:56:04 INFO - PROCESS | 11524 | __metrics Screen width/height:1600/1200 06:56:04 INFO - PROCESS | 11524 | colorDepth:24 06:56:04 INFO - PROCESS | 11524 | Browser inner width/height: 1024/697 06:56:04 INFO - PROCESS | 11524 | __metrics 06:56:05 ERROR - PROCESS | 11524 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:56:06 INFO - TEST-INFO | 11524: exit 0 06:56:06 INFO - Browser initialized. 06:56:06 INFO - Running cycle 1/1 for kraken test... 06:56:06 INFO - TEST-INFO | started process 11618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF3ezal/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:18 INFO - PROCESS | 11618 | RSS: Main: 141389824 06:56:18 INFO - PROCESS | 11618 | 06:56:20 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55564/tests/kraken/driver.html?testName=audio-beat-detection) 06:56:21 INFO - PROCESS | 11618 | RSS: Main: 196595712 06:56:21 INFO - PROCESS | 11618 | 06:56:24 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55564/tests/kraken/driver.html?testName=audio-dft) 06:56:24 INFO - PROCESS | 11618 | RSS: Main: 182460416 06:56:24 INFO - PROCESS | 11618 | 06:56:27 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55564/tests/kraken/driver.html?testName=audio-fft) 06:56:28 INFO - PROCESS | 11618 | RSS: Main: 273657856 06:56:28 INFO - PROCESS | 11618 | 06:56:30 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55564/tests/kraken/driver.html?testName=audio-oscillator) 06:56:30 INFO - PROCESS | 11618 | RSS: Main: 178589696 06:56:30 INFO - PROCESS | 11618 | 06:56:33 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55564/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:56:33 INFO - PROCESS | 11618 | RSS: Main: 177582080 06:56:33 INFO - PROCESS | 11618 | 06:56:36 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55564/tests/kraken/driver.html?testName=imaging-darkroom) 06:56:37 INFO - PROCESS | 11618 | RSS: Main: 212107264 06:56:37 INFO - PROCESS | 11618 | 06:56:40 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55564/tests/kraken/driver.html?testName=imaging-desaturate) 06:56:41 INFO - PROCESS | 11618 | RSS: Main: 212570112 06:56:41 INFO - PROCESS | 11618 | 06:56:43 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55564/tests/kraken/driver.html?testName=json-parse-financial) 06:56:44 INFO - PROCESS | 11618 | RSS: Main: 212426752 06:56:44 INFO - PROCESS | 11618 | 06:56:46 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55564/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:56:46 INFO - PROCESS | 11618 | RSS: Main: 191508480 06:56:46 INFO - PROCESS | 11618 | 06:56:48 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55564/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:56:48 INFO - PROCESS | 11618 | RSS: Main: 194088960 06:56:48 INFO - PROCESS | 11618 | 06:56:50 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55564/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:56:51 INFO - PROCESS | 11618 | RSS: Main: 209833984 06:56:51 INFO - PROCESS | 11618 | 06:56:53 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:56:54 INFO - PROCESS | 11618 | RSS: Main: 214876160 06:56:54 INFO - PROCESS | 11618 | 06:56:57 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:56:57 INFO - PROCESS | 11618 | RSS: Main: 210444288 06:56:57 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:55564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55564/tests/kraken/driver.html?testName=ai-astar) 06:56:59 INFO - PROCESS | 11618 | RSS: Main: 274046976 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | __start_tp_report 06:56:59 INFO - PROCESS | 11618 | _x_x_mozilla_page_load 06:56:59 INFO - PROCESS | 11618 | _x_x_mozilla_page_load_details 06:56:59 INFO - PROCESS | 11618 | |i|pagename|runs| 06:56:59 INFO - PROCESS | 11618 | |0;ai-astar;111;112;111;112;111;111;106;110;112;108 06:56:59 INFO - PROCESS | 11618 | |1;audio-beat-detection;164;127;158;185;132;165;160;126;186;132 06:56:59 INFO - PROCESS | 11618 | |2;audio-dft;161;161;160;161;160;160;161;161;164;160 06:56:59 INFO - PROCESS | 11618 | |3;audio-fft;96;76;74;178;76;76;74;76;167;75 06:56:59 INFO - PROCESS | 11618 | |4;audio-oscillator;92;92;150;91;92;93;150;93;93;153 06:56:59 INFO - PROCESS | 11618 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;118;116 06:56:59 INFO - PROCESS | 11618 | |6;imaging-darkroom;145;146;145;145;145;145;145;145;145;145 06:56:59 INFO - PROCESS | 11618 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;94;95 06:56:59 INFO - PROCESS | 11618 | |8;json-parse-financial;54;57;55;53;54;55;54;77;54;53 06:56:59 INFO - PROCESS | 11618 | |9;json-stringify-tinderbox;60;61;59;60;61;60;60;60;60;61 06:56:59 INFO - PROCESS | 11618 | |10;stanford-crypto-aes;73;72;73;80;73;74;75;73;73;74 06:56:59 INFO - PROCESS | 11618 | |11;stanford-crypto-ccm;116;111;110;111;110;107;111;110;128;129 06:56:59 INFO - PROCESS | 11618 | |12;stanford-crypto-pbkdf2;160;157;154;162;155;161;161;160;157;157 06:56:59 INFO - PROCESS | 11618 | |13;stanford-crypto-sha256-iterative;75;76;66;66;66;65;65;65;65;64 06:56:59 INFO - PROCESS | 11618 | __end_tp_report 06:56:59 INFO - PROCESS | 11618 | __start_cc_report 06:56:59 INFO - PROCESS | 11618 | _x_x_mozilla_cycle_collect,1623 06:56:59 INFO - PROCESS | 11618 | __end_cc_report 06:56:59 INFO - PROCESS | 11618 | __startTimestamp1462802219823__endTimestamp 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | ------- Summary: start ------- 06:56:59 INFO - PROCESS | 11618 | Number of tests: 14 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.96 (1.8%) stddev-sans-first:2.06 06:56:59 INFO - PROCESS | 11618 | Values: 111.0 112.0 111.0 112.0 111.0 111.0 106.0 110.0 112.0 108.0 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:162.00 stddev:22.94 (14.2%) stddev-sans-first:24.02 06:56:59 INFO - PROCESS | 11618 | Values: 164.0 127.0 158.0 185.0 132.0 165.0 160.0 126.0 186.0 132.0 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 06:56:59 INFO - PROCESS | 11618 | Values: 161.0 161.0 160.0 161.0 160.0 160.0 161.0 161.0 164.0 160.0 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#3] audio-fft Cycles:10 Average:96.80 Median:76.00 stddev:40.51 (53.3%) stddev-sans-first:42.96 06:56:59 INFO - PROCESS | 11618 | Values: 96.0 76.0 74.0 178.0 76.0 76.0 74.0 76.0 167.0 75.0 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.00 stddev:28.38 (30.8%) stddev-sans-first:29.35 06:56:59 INFO - PROCESS | 11618 | Values: 92.0 92.0 150.0 91.0 92.0 93.0 150.0 93.0 93.0 153.0 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:56:59 INFO - PROCESS | 11618 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 118.0 116.0 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 06:56:59 INFO - PROCESS | 11618 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:56:59 INFO - PROCESS | 11618 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:54.50 stddev:7.26 (13.3%) stddev-sans-first:7.64 06:56:59 INFO - PROCESS | 11618 | Values: 54.0 57.0 55.0 53.0 54.0 55.0 54.0 77.0 54.0 53.0 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 06:56:59 INFO - PROCESS | 11618 | Values: 60.0 61.0 59.0 60.0 61.0 60.0 60.0 60.0 60.0 61.0 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:73.50 stddev:2.26 (3.1%) stddev-sans-first:2.37 06:56:59 INFO - PROCESS | 11618 | Values: 73.0 72.0 73.0 80.0 73.0 74.0 75.0 73.0 73.0 74.0 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#11] stanford-crypto-ccm Cycles:10 Average:114.30 Median:111.00 stddev:7.80 (7.0%) stddev-sans-first:8.25 06:56:59 INFO - PROCESS | 11618 | Values: 116.0 111.0 110.0 111.0 110.0 107.0 111.0 110.0 128.0 129.0 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:160.00 stddev:2.76 (1.7%) stddev-sans-first:2.86 06:56:59 INFO - PROCESS | 11618 | Values: 160.0 157.0 154.0 162.0 155.0 161.0 161.0 160.0 157.0 157.0 06:56:59 INFO - PROCESS | 11618 | 06:56:59 INFO - PROCESS | 11618 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:66.00 stddev:4.37 (6.6%) stddev-sans-first:3.64 06:56:59 INFO - PROCESS | 11618 | Values: 75.0 76.0 66.0 66.0 66.0 65.0 65.0 65.0 65.0 64.0 06:56:59 INFO - PROCESS | 11618 | -------- Summary: end -------- 06:56:59 INFO - PROCESS | 11618 | 06:57:00 INFO - TEST-INFO | 11618: exit 0 06:57:00 INFO - TEST-OK | kraken | took 60145ms 06:57:00 INFO - SUITE-END | took 1171s 06:57:00 INFO - Completed test suite (00:19:31) 06:57:00 INFO - javascript benchmark 06:57:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3300.290437555925, 3328.8335583220833, 3346.297277571709, 3356.7314614830816, 3379.4761811919147, 5433.592480563953, 5443.61894667373, 5468.343798744147, 5470.972645136773, 5487.149491828763, 5467.125259958408, 5492.972535137319, 5495.560355171587, 5500.28496295481, 5520.1167813149905, 4900.926486102711, 4969.503049695038, 5050.646454748169, 5080.517350851663, 5118.488151184871, 4941.160002799515, 5020.673656212334, 5023.799048038074, 5023.924641130386, 5033.144365457881, 4980.402351717799, 5033.723145227011, 5041.294218809369, 5051.848444546651, 5054.317667114948, 5064.949350506503, 5086.720230387327, 5091.41448733393, 5102.566281866046, 5131.3842338919385, 4834.468208497063, 4911.5088491150955, 4991.825286115005, 4999.0, 5004.274380214849, 5420.457954204588, 5461.69960652164, 5476.288082549283, 5486.835394938118, 5490.149026900836, 5803.071508558653, 5826.9708651456895, 5830.096335068071, 5840.620359676607, 5841.153032810261, 5739.942600573982, 5838.591298609099, 5873.383294754032, 5878.2064421303, 5893.322267939199, 5492.093804522249, 5521.0, 5535.308086489189, 5542.3626282977975, 5547.0570003099165, 5830.3586605473365, 6000.849978750479, 6005.879882402328, 6009.729562169713, 6010.579259451796, 5749.080147176515, 5816.94183058164, 5822.70886455684, 5824.242848429762, 5833.778768002614, 5863.091220860773, 5876.206712093898, 5877.412258774174, 5878.735456904449, 5883.940890639726, 5694.572907031989, 5757.13642953552, 5850.5612079094235, 5858.062709966385, 5863.824085277449, 5839.737211825478, 5863.736131874076, 5868.941310586925, 5871.706414679249, 5901.114832775118, 4470.86587402372, 4471.19518486669, 4474.440694913136, 4487.977560112178, 4502.324651302265, 3970.5433875104154, 3982.0443093657314, 4019.2765302245293, 4034.3948407739076, 4080.163566468867, 5568.805091821767, 5582.91625625616, 5587.69267690281, 5589.80435684749, 5589.944100558942, 5927.644341339534, 5951.137085122633, 5954.4045595440975, 5955.047192449188, 5962.135490353961, 5387.0841956867425, 5518.420565840529, 5550.0, 5618.157276408571, 5630.774769009194, 5097.337346144977, 5115.514026167508, 5119.488051194925, 5121.103806833789, 5127.897442051138, 6152.630842149396, 6164.4143806338325, 6166.7224974876235, 6172.660503672341, 6173.876522469525, 5817.301923769175, 5892.116182572477, 5955.076963070817, 5996.070609055603, 5996.160537524663, 6113.419225173601, 6126.23422072241, 6128.724207410588, 6128.754849805958, 6133.693315334126, 5812.447817457335, 5816.534677225727, 5818.040023396092, 5821.38875418075, 5822.0, 5791.739371728367, 5874.353821079592, 5962.672053037125, 5981.910271345846, 5999.310079340931, 5763.827085187451, 5768.423157684198, 5775.624584402, 5777.24895763548, 5783.566232532493, 5492.47821456961, 5706.229658995982, 5740.425957404226, 5764.596478246483, 5771.0, 5568.443155684399, 5647.604667673388, 5649.039663257338, 5671.914921276101, 5679.00617391963, 5720.570957178312, 5764.423557644202, 5772.509336706259, 5776.480116789509, 5779.797707080232, 5554.472325129106, 5565.248691426767, 5619.803306884403, 5625.212470254086, 5659.122835960433], "value": 5432.2346989965945, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.7068607068607, 658.2758965138347, 666.9528839721639, 675.912131422915, 677.6306912732557, 32575.348493030157, 33212.66787332126, 33244.16889577762, 39913.60086399135, 40697.79651101748, 43940.340894886605, 44341.33487997683, 44417.55582444175, 44445.55554444455, 44500.332495012604, 8871.201591856732, 9066.954665226665, 9070.86393704095, 9073.183413492785, 9073.863892041625, 8863.734087977371, 8994.325425593073, 9000.234980026706, 9000.8649870252, 9009.099090091004, 8927.866082008775, 9001.909980900205, 9202.0, 9211.907880921206, 9224.215941644969, 9124.498152601604, 9164.26685865136, 9183.265338772882, 9191.954040229823, 9192.126747958933, 9082.909170908273, 9201.723948281562, 9208.26333893287, 9208.723738287863, 9211.447313161232, 44389.33415998763, 44842.55157448416, 44958.10083798306, 44997.775011125064, 45026.54973450289, 3804.0, 3832.5999960180748, 4062.2078694654556, 4355.063661312833, 4643.8142474300985, 33730.0, 34172.31655366879, 34327.485087723704, 34351.0, 34539.65460345389, 4546.431696037996, 4640.721556706609, 4650.7209567425725, 4651.976740116278, 4662.137504561667, 311984.0, 313919.4304028488, 315440.0, 316440.0, 316641.0, 60163.39836601578, 60942.39057609367, 61020.42346824006, 61040.0, 61082.694586526784, 69688.6515567419, 70998.0, 71026.0, 71033.0, 71101.64449177722, 16935.661286774197, 16950.576235593962, 16972.32110715582, 17008.744868826976, 17012.48962531126, 14540.27298635064, 14686.118832870063, 14687.706245875022, 14720.116792992454, 14730.189839558927, 20848.1660733572, 21196.682049769264, 21228.363149105553, 21296.574068518545, 21473.248436304653, 7483.0, 7608.2391760823475, 7626.4832605240135, 7688.538687678757, 7833.921660783433, 1137.1585027079902, 1144.3305666185208, 1164.545827127421, 1188.477070089158, 1223.9143259971715, 33553.0, 33909.0, 34168.48747268743, 34439.65560344364, 34546.17636841884, 1232.6671798614325, 1236.9690757730948, 1250.4498020870788, 1252.8935040521658, 1407.197897198587, 17127.229274682668, 17988.91005544964, 18029.639407212046, 18062.5484362892, 18117.728234076498, 484655.0, 490566.0, 491468.0, 492120.0, 492207.0, 60600.0, 61916.380836191965, 61954.380456195766, 62112.378876211566, 62159.6892015537, 1344.1666166976538, 1527.7631967045127, 1531.3109100904637, 1571.363597742916, 1583.5961829733574, 30453.695463045085, 33328.83335583306, 33927.4910876342, 33952.490712638835, 34598.82700586481, 49864.0, 49941.50058499514, 50089.49910500849, 50318.0, 50390.0, 310223.0, 311173.0, 312043.0, 312235.0, 312679.0, 26257.868710657087, 30345.848270758506, 30391.0, 31868.68131318657, 32689.34621307513, 48131.0, 48532.5146748528, 48914.26628600645, 48922.75538622284, 49449.25826112539, 41005.0, 41040.79479602583, 41074.794626026676, 42208.57791422046, 42536.149277014905, 39627.018649068006, 40028.799856000536, 40660.0, 41190.1761964753, 41902.37146442745, 41851.0, 42564.5743542573, 42664.57335426606, 42812.35781463218, 42917.0, 35776.0, 36489.452658209615, 36777.0, 37021.25957480782, 37336.0, 27846.721532784413, 28167.282901969113, 28464.43071138607, 28618.57072143878, 28637.856810715813], "value": 20736.981531066656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.84218091746936, 414.61440860000187, 416.1365167277898, 422.5056683680094, 429.4095618524529, 13581.523612547406, 18715.43853684388, 19235.42293731187, 19250.22999080035, 19883.105260263288, 15864.841351586481, 19229.711554326663, 19482.0, 19811.405657830288, 19993.20027198914, 5603.271574695284, 5746.339170995348, 5749.367569567345, 5754.82735517933, 5778.4799368056865, 5695.316562012544, 5719.370869204384, 5719.714014299289, 5729.914051289234, 5739.253896993385, 5480.6437581557275, 5611.410801865806, 5638.492535671789, 5662.037453632872, 5739.0, 5766.509846663039, 5774.0, 5805.448482394166, 5822.650640961535, 5825.941740582603, 5115.437301896788, 5162.277281180638, 5218.66078704883, 5222.190560463135, 5225.503577160163, 23173.88413057941, 23631.881840590686, 24156.0, 24224.515509689885, 24366.634500482505, 2615.8692065396654, 2717.252755492236, 2738.7535121838932, 3044.406340763552, 3079.538069289602, 14496.71006579873, 14999.775003374958, 15100.169490678009, 15379.923100384538, 15427.3829046838, 2040.4490787487443, 2071.2025870039993, 2102.127617038927, 2115.206797450956, 2208.447888027993, 75348.62325688337, 78375.0, 78548.0, 79674.0, 81035.5948220261, 10928.289661171999, 10996.450177491253, 11001.394923279297, 11053.613123540637, 11072.723181920355, 15795.289211985488, 15888.60278493047, 15915.0, 15949.282282297325, 15979.280932358071, 8253.298469630028, 8490.066092729794, 8497.66009359631, 8603.01065377477, 8683.305335573139, 8579.613917373734, 8582.0, 8650.0, 8726.825463490695, 8732.650693972297, 4315.4605674290715, 4850.641820290324, 4898.265260210926, 4918.631102667314, 4958.578520825698, 1904.6190761847408, 1992.3126521350111, 1998.1607724755638, 2036.297477370305, 2040.4184807329839, 991.2763682511807, 996.4718699089494, 1052.6999805055523, 1090.0897750378522, 1113.1206346985791, 19482.512937176685, 19617.90191049064, 19755.40733777989, 19769.0, 20014.399568012985, 1142.5258517715056, 1143.3768596115137, 1159.7680463907084, 1181.3502573584667, 1184.2894263441865, 11306.886931130583, 11382.886171138349, 11409.42952852354, 11431.771364572662, 11585.594504192313, 500003.0, 500278.0, 509712.0, 512888.0, 516351.0, 91433.08566914246, 92467.0, 92956.0, 93030.53484732533, 93237.0676293242, 1094.9616763413242, 1133.246391149876, 1167.5679998400647, 1179.6107284596062, 1194.0328334049275, 17255.82744172542, 17759.644807103527, 17802.109894505484, 17870.5532361692, 18139.54651133732, 39494.2101157981, 39589.80205098956, 40233.79883100683, 40806.1838763229, 41313.79343103385, 59133.40866591279, 59903.400965989786, 59943.70028150006, 60005.0, 60127.0, 8507.191816777397, 8634.654613815377, 8678.392512524062, 8737.344699147463, 8853.911460885567, 9440.811183776148, 12178.695532611755, 12357.32034738098, 13774.586762397144, 13818.516351927634, 12223.0, 12733.61799146027, 12804.871951280367, 12920.741585168433, 12934.482620695067, 12138.0, 12182.817257740964, 12397.75204495923, 12406.13157079032, 12479.625611231677, 12996.350182491027, 13137.802932956205, 13218.933905330412, 13222.735545289233, 13407.128536645087, 8485.703000394957, 8682.52246126469, 8695.695650652196, 8778.14845704751, 8985.505797181218, 9220.308476864127, 11287.887121129012, 12359.752804943671, 12379.814302785646, 12416.379181041093], "value": 9607.833512745965, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.8564143585636, 1562.7343351630223, 1571.4107209796327, 1789.9528775666236, 1913.9138738756756, 7962.40281978851, 8291.378146638996, 8318.0, 8320.292775114114, 8322.001359836828, 8045.316148127402, 8130.186981301867, 8180.141085186059, 8189.959050204756, 8216.301614362786, 2064.6077245323418, 2334.171369163948, 2354.4702441950553, 2378.227076200233, 2405.6391541268777, 2412.0954642009247, 2424.2727181845376, 2425.9757402425926, 2427.1626288930293, 2427.2232885476656, 2302.5970455170363, 2347.0377145370403, 2348.3542025942916, 2352.388379021458, 2353.7999270062064, 2068.451860257033, 2284.794368506834, 2346.8239882008916, 2348.365941195876, 2350.4241460842204, 2328.0338659456306, 2355.646653002046, 2371.8695471749047, 2372.3001714494267, 2380.131252092991, 8157.673693052271, 8211.21993410625, 8213.917860821375, 8221.136780638066, 8226.712065077754, 5146.485351464824, 5258.027264955996, 5300.814471493518, 5307.6019298552765, 5323.148296272617, 3405.880794172192, 3417.96582034179, 3436.8281585920854, 3483.442649176145, 3536.6816986471085, 1125.7523344864117, 1126.317727066941, 1129.5425352732157, 1132.6828488023366, 1166.7958107331267, 11825.586104486387, 11897.107716921266, 11910.46402911871, 11917.046636269077, 11931.821022684666, 4514.232580461329, 4542.568455996675, 4578.633709303314, 4595.517470665532, 4627.606653434428, 10270.0, 10272.486375681336, 10285.9485702571, 10299.17606591471, 10316.48417579118, 4625.167469855391, 5294.54996325309, 5296.682199068068, 5299.152135658276, 5303.7348132593215, 4598.057398233354, 4636.165490211794, 4638.0260145369175, 4642.837500687459, 4678.929816052762, 3994.820233089518, 4023.5510543376167, 4094.877153685394, 4105.69207309447, 4119.496383819885, 1249.843769528809, 1287.8969682425384, 1310.1418570836117, 1313.1727011982389, 1322.715616142534, 996.9601215951426, 1005.4269066632096, 1010.9898901010896, 1021.7496713305139, 1029.891861354562, 6075.119107729354, 6089.878202435926, 6136.631802091889, 6165.383461653799, 6270.874582508324, 425.6594724220611, 438.6863392674253, 444.1428043875287, 444.6509490050295, 444.7798339821809, 4256.191323648559, 4283.550227226158, 4285.935710964338, 4302.720323178984, 4315.546867578859, 10222.795544089226, 10605.045545900752, 10612.734681632866, 10639.095676867553, 10677.199210059276, 10356.533955971849, 10364.792704146026, 10448.947755261175, 10463.738406539745, 10472.842907356397, 7650.0, 7771.222877712296, 8180.46826956246, 8180.754577362689, 8181.263686268265, 5809.24479817621, 5820.94179058204, 5824.097264923944, 5825.184474173704, 5901.380355062656, 9052.0, 9149.176574108096, 9207.40151890125, 9217.58520866576, 9278.907210927804, 8874.955625221832, 8887.37788354809, 8904.510251936206, 9067.637294508146, 9430.151286384258, 7050.753223637148, 7632.274933881273, 7744.8451030980195, 7954.880676789737, 8070.677172913252, 7675.462717609714, 7694.0, 7797.454178207471, 7808.687652493837, 7855.33229675484, 6924.861502770017, 7048.894266585903, 7240.96379518099, 7375.078115235596, 7566.016417865642, 7019.613921234381, 7200.783976480714, 7214.170370407471, 7224.422046236184, 7230.6384680766805, 6867.896981545181, 6883.586984780929, 6893.103896493624, 6950.3049695030095, 6955.617441040791, 4998.825041123543, 5066.518680725325, 5154.8969020620125, 5194.844154675366, 5283.313169287968, 5023.824166154167, 5053.823116190915, 5071.518205770446, 5132.409772876018, 5151.356080489939], "value": 4473.01749872519, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.12445960298595, 327.26365677226244, 328.9835508224588, 330.5983230375094, 332.7338129496403, 6052.546059045567, 6083.969580152093, 6243.687815609218, 6247.875042499153, 6260.561760676749, 6106.847328816782, 6220.409061139196, 6231.283402408724, 6248.562600617958, 6259.186305780254, 4747.976260118712, 4764.190087685084, 4772.284157376386, 4772.594329481998, 4786.880327991811, 4516.36770852081, 4556.2254416749065, 4690.061987602493, 4775.570198682118, 4778.522147785228, 4637.605803506706, 4642.257238841786, 4647.34937108805, 4650.7907144178425, 4662.790174442158, 4615.976920115411, 4630.606398456135, 4633.2586786114225, 4641.8839529011875, 4663.857354948025, 3994.0414300567654, 4002.779847108408, 4009.3785463253244, 4017.4777278953547, 4040.9897525618594, 5870.823875283749, 5885.911711324334, 5901.29184497863, 5903.822885313448, 5917.2307600012155, 5326.280952071498, 5327.840164795023, 5329.147336426153, 5332.653377530448, 5367.597430192712, 6268.623882567061, 6518.511111666597, 6522.086907832907, 6531.836704082389, 6532.11816404784, 4407.823687052514, 4419.779011049434, 4423.225935461282, 4425.579569940851, 4427.247367947457, 6751.582167744779, 6826.010228516837, 6837.931620683829, 6838.658067096625, 6841.965790171067, 4500.932486012713, 4501.279795232747, 4505.7296562206375, 4509.616682581952, 4514.164879497303, 4560.612347950395, 4565.885852853638, 4572.314152877095, 4574.611158051536, 4576.084783043405, 5158.638895277295, 5255.474452554714, 5284.894302113936, 5301.0723123453245, 5336.439673834191, 6532.08550802888, 6532.6733663316645, 6543.411093001652, 6555.901661475082, 6557.082008518812, 1513.530805450314, 1548.6825200833803, 1554.4870192836338, 1556.144120733592, 1604.0375774535419, 1010.7574182196367, 1038.6364772329623, 1047.1099565369375, 1047.4972013433442, 1052.3422860712055, 6223.844403889939, 6298.433141017331, 6299.1811064562235, 6336.651484168323, 6339.904901426482, 6752.696128674222, 6753.561018533779, 6779.830504237433, 6786.287439818847, 6787.490938179656, 6318.778842740574, 6327.683615819191, 6334.049892516159, 6338.0, 6339.936600634027, 3621.1309285771226, 3649.5620525536574, 3651.6348365163803, 3653.0867283179205, 3658.835352409148, 6856.760013399607, 6991.7902462926195, 7002.929970700227, 7004.649767511604, 7009.369156775914, 6862.759803406957, 6878.071460352889, 6880.139982502187, 6883.242843287235, 6901.275366086589, 6984.092068031225, 6988.720451181997, 6996.440284777205, 7006.194287656883, 7008.649567521604, 6707.731690732316, 6753.122094127929, 6756.054152418567, 6764.729410823709, 6773.254941956479, 6458.967705161444, 6613.0, 6616.90074648871, 6638.17022872141, 6646.700898459484, 6958.3041695832035, 6976.093107895941, 6991.755288564876, 6995.580265184105, 7000.229974702676, 4522.841700540465, 4523.886902827456, 4524.5701658342405, 4524.5927866492175, 4526.796294166837, 6540.247871494839, 6715.966420167868, 6724.226713927961, 6731.764388246388, 6731.966340168464, 6474.902876456763, 6542.574732642363, 6656.600603963778, 6674.098996635586, 6682.264950855305, 6584.539082264196, 6623.503237257321, 6632.071509988509, 6648.867022659423, 6650.567713098633, 6534.313897040743, 6543.149390579194, 6549.279579246374, 6549.345065493603, 6549.574277671936, 6557.245916719447, 6689.966550167218, 6700.195976482853, 6703.597784132968, 6710.865782684416, 6481.384268494486, 6510.153680021567, 6510.414062734377, 6511.413972742476, 6515.934840651723], "value": 4891.931945904392, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [884.9513276769778, 889.550776857687, 930.1024511346549, 935.4013431403907, 950.4677380666827, 13971.650708732286, 15167.089974601518, 15389.615259618502, 15429.382824687, 15466.226688665578, 13892.23592702401, 14376.424943002268, 14376.928115359435, 14378.712425751479, 14386.712265754679, 726.8618962397128, 883.1080608585343, 884.2042162054171, 898.3531857062937, 898.8606765951288, 892.4288455388556, 894.6108442827391, 895.7447127568644, 896.3098414221046, 896.8789213456165, 950.5722424908819, 955.3885513271512, 956.0821611253206, 957.683964291782, 957.8419560772498, 764.1288930619098, 952.9761755956088, 958.9712308630752, 959.8896126945386, 960.1071003966308, 697.135551915621, 700.8353037036293, 702.1188408547291, 702.7434986229989, 703.395080231001, 15097.24513774307, 15149.469768558158, 15158.31787569562, 15216.771748423782, 15219.467318643794, 14185.858141418557, 14639.780403293958, 14705.338259778335, 14714.70570588593, 14834.925825370805, 11819.527218911233, 11912.642620721392, 12082.818757718642, 12139.210951288138, 12206.0, 4634.050019745944, 4651.534846515356, 4672.836450724209, 4675.625949924032, 4775.856724298276, 51571.742141289425, 57888.71055644737, 57915.13127303094, 58311.0, 58362.0, 11192.160587955936, 11332.886671133183, 11508.136889733303, 11552.6534203974, 11768.117391195523, 20715.378538643865, 20722.378328650164, 20743.0, 20792.688109678365, 20864.582708345748, 8509.234168924702, 8837.55812209387, 8887.73336799897, 9029.36794424384, 9131.041240669634, 4979.950200497949, 4985.102681517289, 5035.219540971156, 5105.33630628016, 5284.682919024794, 3596.964030359663, 3641.9453708194396, 3643.0, 3653.5250417445563, 3658.8719394821055, 636.7039326713008, 642.1010585180784, 649.7401039584204, 679.4055201698513, 707.900893874858, 809.4576633655465, 821.4660470694097, 829.668132746894, 832.3050253038659, 854.9529775862387, 10068.194544436428, 10206.183505319557, 10279.94860025695, 10527.526261318259, 10623.787524249472, 748.472327009457, 795.5902710104301, 800.9279164875189, 814.4421071565996, 816.9387295952828, 4851.636127290467, 4872.926906096412, 4874.341963834908, 4926.950730492721, 4955.925661115086, 68078.97881531781, 69341.65329173322, 69370.3062969374, 69372.3062769376, 69454.95817562741, 57440.425595744346, 58125.70937145372, 58437.0, 58661.70669146627, 58860.70569647125, 52201.0, 52221.7388913053, 53034.46965530373, 53089.2036619451, 53731.19403208955, 9414.905850941677, 9444.716658500256, 9499.905000950179, 9565.61737530491, 9622.711318660451, 38700.22599547937, 38701.0, 40286.1942761149, 40844.79577602093, 41509.0, 47880.0, 50745.23882141845, 51686.483135168164, 52326.73836630792, 52850.20724689056, 11601.883981160418, 11785.528578856749, 11992.760144796881, 12109.212901161749, 12128.21166624202, 13016.739665206833, 13430.93284533571, 13600.659983500096, 13616.0, 13902.096363736326, 10866.261398176253, 11877.76244475123, 12392.256464612152, 12671.936640316739, 13165.210087394787, 11796.41017949082, 12214.57248996281, 12525.56160534377, 13134.474621015052, 13983.44066237339, 13140.868591313965, 13322.933385333012, 13359.398827053, 13389.598312050653, 13441.731165376834, 11171.162162837658, 11344.0, 11522.942385288019, 11670.241434306743, 11877.346745929057, 11155.330680159217, 11307.0, 11526.711832204262, 11552.249103808226, 11723.296602203554], "value": 7273.9621637575365, "unit": "score"}], "name": "dromaeo_css", "value": 7459.458777803147, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 112.0, 111.0, 111.0, 106.0, 110.0, 112.0, 108.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 127.0, 158.0, 185.0, 132.0, 165.0, 160.0, 126.0, 186.0, 132.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 164.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 76.0, 74.0, 178.0, 76.0, 76.0, 74.0, 76.0, 167.0, 75.0], "value": 96.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 91.0, 92.0, 93.0, 150.0, 93.0, 93.0, 153.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 55.0, 53.0, 54.0, 55.0, 54.0, 77.0, 54.0, 53.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 80.0, 73.0, 74.0, 75.0, 73.0, 73.0, 74.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 110.0, 111.0, 110.0, 107.0, 111.0, 110.0, 128.0, 129.0], "value": 114.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 154.0, 162.0, 155.0, 161.0, 161.0, 160.0, 157.0, 157.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 64.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1519.1, "alertThreshold": 2.0}]} 06:57:01 INFO - Return code: 0 06:57:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:57:01 ERROR - # TBPL SUCCESS # 06:57:01 INFO - Running post-action listener: _resource_record_post_action 06:57:01 INFO - Running post-run listener: _resource_record_post_run 06:57:02 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 502915072; Read time: 0; Write time: 496044 06:57:02 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 254943232; Read time: 0; Write time: 339000 06:57:02 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 243920896; Read time: 0; Write time: 156244 06:57:02 INFO - Running post-run listener: _upload_blobber_files 06:57:02 INFO - Blob upload gear active. 06:57:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:57:02 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 06:57:02 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'] 06:57:02 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 06:57:02 INFO - (blobuploader) - INFO - Open directory for files ... 06:57:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:57:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:57:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:03 INFO - (blobuploader) - INFO - Done attempting. 06:57:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:57:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:57:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:04 INFO - (blobuploader) - INFO - Done attempting. 06:57:04 INFO - (blobuploader) - INFO - Iteration through files over. 06:57:04 INFO - Return code: 0 06:57:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:57:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:57:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c8a180157b03dfc5e67f2310cd8837874f3ebf36d8a55365d87c36bf0ac62aa10dbbd2770da32eece745584618c8ff941b6f13ed2502dee9c570c5cd412b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1caed076a762b1647f9f42513525e4b42b581c68f055d317a68cf1212b43423ba7bd22fe7d354240661df9cb4d20b80f74d94d494cd49462589e53cffc8ae3c"} 06:57:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:57:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:57:04 INFO - Contents: 06:57:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c8a180157b03dfc5e67f2310cd8837874f3ebf36d8a55365d87c36bf0ac62aa10dbbd2770da32eece745584618c8ff941b6f13ed2502dee9c570c5cd412b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1caed076a762b1647f9f42513525e4b42b581c68f055d317a68cf1212b43423ba7bd22fe7d354240661df9cb4d20b80f74d94d494cd49462589e53cffc8ae3c"} 06:57:04 INFO - Running post-run listener: copy_logs_to_upload_dir 06:57:04 INFO - Copying logs to upload dir... 06:57:04 INFO - mkdir: /builds/slave/test/build/upload/logs 06:57:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.725448 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-09 06:57:02.275030) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:57:02.278862) ========= 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=232498196343f89f466a4a9a000001c8-1462800996.839670-724582139 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/f6c8a180157b03dfc5e67f2310cd8837874f3ebf36d8a55365d87c36bf0ac62aa10dbbd2770da32eece745584618c8ff941b6f13ed2502dee9c570c5cd412b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1caed076a762b1647f9f42513525e4b42b581c68f055d317a68cf1212b43423ba7bd22fe7d354240661df9cb4d20b80f74d94d494cd49462589e53cffc8ae3c"} build_url:https://queue.taskcluster.net/v1/task/cMADoDpFTc-ZTyVSsUUOog/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011211 build_url: 'https://queue.taskcluster.net/v1/task/cMADoDpFTc-ZTyVSsUUOog/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/f6c8a180157b03dfc5e67f2310cd8837874f3ebf36d8a55365d87c36bf0ac62aa10dbbd2770da32eece745584618c8ff941b6f13ed2502dee9c570c5cd412b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1caed076a762b1647f9f42513525e4b42b581c68f055d317a68cf1212b43423ba7bd22fe7d354240661df9cb4d20b80f74d94d494cd49462589e53cffc8ae3c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:57:02.303220) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:57:02.303541) ========= 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=232498196343f89f466a4a9a000001c8-1462800996.839670-724582139 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:57:02.389384) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:57:02.389730) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:57:02.390027) ========= ========= Total master_lag: 0.15 =========