builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1461756397.64 results: success (0) buildid: 20160427025907 builduid: 946947c12dd542b49bd94d42b335f8ba revision: ab0044bfa1df858919797bcd6a9aef76a668cd4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:37.643526) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:37.644004) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:37.644278) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:37.662089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:37.662434) ========= 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=ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 04:26:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 81.3M=0s 2016-04-27 04:26:39 (81.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113074 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:37.788538) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:37.788860) ========= 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=ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018882 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:37.838454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:37.838850) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ab0044bfa1df858919797bcd6a9aef76a668cd4a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ab0044bfa1df858919797bcd6a9aef76a668cd4a --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=ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 04:26:39,773 truncating revision to first 12 chars 2016-04-27 04:26:39,773 Setting DEBUG logging. 2016-04-27 04:26:39,773 attempt 1/10 2016-04-27 04:26:39,773 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ab0044bfa1df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 04:26:40,018 unpacking tar archive at: mozilla-central-ab0044bfa1df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.601042 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:38.453666) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:38.453984) ========= script_repo_revision: ab0044bfa1df858919797bcd6a9aef76a668cd4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:38.454455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:38.454889) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 04:26:38.464807) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-27 04:26:38.465099) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:26:40 INFO - MultiFileLogger online at 20160427 04:26:40 in /builds/slave/test 04:26:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:26:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:40 INFO - {'append_to_log': False, 04:26:40 INFO - 'base_work_dir': '/builds/slave/test', 04:26:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:26:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:40 INFO - 'branch': 'Firefox-Non-PGO', 04:26:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:40 INFO - 'config_files': ('talos/linux_config.py',), 04:26:40 INFO - 'default_actions': ('clobber', 04:26:40 INFO - 'read-buildbot-config', 04:26:40 INFO - 'download-and-extract', 04:26:40 INFO - 'populate-webroot', 04:26:40 INFO - 'create-virtualenv', 04:26:40 INFO - 'install', 04:26:40 INFO - 'run-tests'), 04:26:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:40 INFO - 'download_minidump_stackwalk': True, 04:26:40 INFO - 'download_symbols': 'ondemand', 04:26:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:40 INFO - 'installer_path': 'installer.exe', 04:26:40 INFO - 'log_level': 'info', 04:26:40 INFO - 'log_name': 'talos', 04:26:40 INFO - 'log_to_console': True, 04:26:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:26:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:26:40 INFO - 'opt_config_files': (), 04:26:40 INFO - 'pip_index': False, 04:26:40 INFO - 'sps_profile': False, 04:26:40 INFO - 'sps_profile_interval': 0, 04:26:40 INFO - 'suite': 'dromaeojs', 04:26:40 INFO - 'system_bits': '32', 04:26:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:40 INFO - 'title': 'talos-linux64-ix-035', 04:26:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:40 INFO - 'use_talos_json': True, 04:26:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:40 INFO - 'work_dir': 'build'} 04:26:40 INFO - ##### 04:26:40 INFO - ##### Running clobber step. 04:26:40 INFO - ##### 04:26:40 INFO - Running pre-action listener: _resource_record_pre_action 04:26:40 INFO - Running main action method: clobber 04:26:40 INFO - rmtree: /builds/slave/test/build 04:26:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:41 INFO - Running post-action listener: _resource_record_post_action 04:26:41 INFO - ##### 04:26:41 INFO - ##### Running read-buildbot-config step. 04:26:41 INFO - ##### 04:26:41 INFO - Running pre-action listener: _resource_record_pre_action 04:26:41 INFO - Running main action method: read_buildbot_config 04:26:41 INFO - Using buildbot properties: 04:26:41 INFO - { 04:26:41 INFO - "project": "", 04:26:41 INFO - "product": "firefox", 04:26:41 INFO - "script_repo_revision": "production", 04:26:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:26:41 INFO - "repository": "", 04:26:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:26:41 INFO - "buildid": "20160427025907", 04:26:41 INFO - "pgo_build": "False", 04:26:41 INFO - "basedir": "/builds/slave/test", 04:26:41 INFO - "buildnumber": 77, 04:26:41 INFO - "slavename": "talos-linux64-ix-035", 04:26:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:26:41 INFO - "platform": "ubuntu64_hw", 04:26:41 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:26:41 INFO - "branch": "mozilla-central", 04:26:41 INFO - "repo_path": "mozilla-central", 04:26:41 INFO - "revision": "ab0044bfa1df858919797bcd6a9aef76a668cd4a", 04:26:41 INFO - "stage_platform": "linux64", 04:26:41 INFO - "builduid": "946947c12dd542b49bd94d42b335f8ba", 04:26:41 INFO - "slavebuilddir": "test" 04:26:41 INFO - } 04:26:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:26:41 INFO - Running post-action listener: _resource_record_post_action 04:26:41 INFO - ##### 04:26:41 INFO - ##### Running download-and-extract step. 04:26:41 INFO - ##### 04:26:41 INFO - Running pre-action listener: _resource_record_pre_action 04:26:41 INFO - Running main action method: download_and_extract 04:26:41 INFO - mkdir: /builds/slave/test/build/tests 04:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:41 INFO - https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:26:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:26:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:26:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:26:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:26:42 INFO - Downloaded 1361 bytes. 04:26:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:26:42 INFO - Using the following test package requirements: 04:26:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:26:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:26:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'jsshell-linux-x86_64.zip'], 04:26:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:26:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:26:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:26:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:26:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:26:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:26: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')]} 04:26:42 INFO - https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:26:53 INFO - Downloaded 22293773 bytes. 04:26:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:26:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:26:55 INFO - Return code: 0 04:26:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:26: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')]} 04:26:55 INFO - https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:26:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:26:57 INFO - Downloaded 22293773 bytes. 04:26:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:26:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:26:58 INFO - Return code: 0 04:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:58 INFO - https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:26:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:26:59 INFO - Downloaded 10840145 bytes. 04:26:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:26:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:26:59 INFO - Return code: 0 04:26: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')]} 04:26:59 INFO - https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:26:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:26:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:26:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:26:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:27:01 INFO - Downloaded 54817963 bytes. 04:27:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:27:01 INFO - mkdir: /builds/slave/test/properties 04:27:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:27:01 INFO - Writing to file /builds/slave/test/properties/build_url 04:27:01 INFO - Contents: 04:27:01 INFO - build_url:https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:27:02 INFO - Running post-action listener: _resource_record_post_action 04:27:02 INFO - Running post-action listener: set_extra_try_arguments 04:27:02 INFO - ##### 04:27:02 INFO - ##### Running populate-webroot step. 04:27:02 INFO - ##### 04:27:02 INFO - Running pre-action listener: _resource_record_pre_action 04:27:02 INFO - Running main action method: populate_webroot 04:27:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:27:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:27:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:27:02 INFO - '--tppagecycles', 04:27:02 INFO - '7'], 04:27:02 INFO - 'tests': ['tsvgm']}}, 04:27:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:27:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:27:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:27:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:27:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:27:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:27:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:02 INFO - 'talos_options': ['--disable-e10s'], 04:27:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:02 INFO - 'talos_options': ['--disable-e10s'], 04:27:02 INFO - 'tests': ['damp', 'tps']}, 04:27:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:02 INFO - 'tests': ['damp', 'tps']}, 04:27:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:27:02 INFO - 'tests': ['dromaeo_dom']}, 04:27:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:27:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:27:02 INFO - 'tests': ['a11yr', 04:27:02 INFO - 'ts_paint', 04:27:02 INFO - 'tpaint', 04:27:02 INFO - 'sessionrestore', 04:27:02 INFO - 'sessionrestore_no_auto_restore', 04:27:02 INFO - 'tabpaint']}, 04:27:02 INFO - 'other-e10s': {'tests': ['a11yr', 04:27:02 INFO - 'ts_paint', 04:27:02 INFO - 'tpaint', 04:27:02 INFO - 'sessionrestore', 04:27:02 INFO - 'sessionrestore_no_auto_restore', 04:27:02 INFO - 'tabpaint']}, 04:27:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:27:02 INFO - 'ts_paint', 04:27:02 INFO - 'tpaint', 04:27:02 INFO - 'sessionrestore', 04:27:02 INFO - 'sessionrestore_no_auto_restore', 04:27:02 INFO - 'tabpaint']}, 04:27:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:27:02 INFO - 'ts_paint', 04:27:02 INFO - 'tpaint', 04:27:02 INFO - 'sessionrestore', 04:27:02 INFO - 'sessionrestore_no_auto_restore', 04:27:02 INFO - 'tabpaint']}, 04:27:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:27:02 INFO - 'tests': ['a11yr', 04:27:02 INFO - 'ts_paint', 04:27:02 INFO - 'tpaint', 04:27:02 INFO - 'sessionrestore', 04:27:02 INFO - 'sessionrestore_no_auto_restore', 04:27:02 INFO - 'tabpaint']}, 04:27:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:27:02 INFO - 'tests': ['a11yr', 04:27:02 INFO - 'ts_paint', 04:27:02 INFO - 'tpaint', 04:27:02 INFO - 'sessionrestore', 04:27:02 INFO - 'sessionrestore_no_auto_restore', 04:27:02 INFO - 'tabpaint']}, 04:27:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:27:02 INFO - 'tests': ['tsvgx', 04:27:02 INFO - 'tsvgr_opacity', 04:27:02 INFO - 'tart', 04:27:02 INFO - 'tscrollx', 04:27:02 INFO - 'cart']}, 04:27:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:27:02 INFO - 'tsvgr_opacity', 04:27:02 INFO - 'tart', 04:27:02 INFO - 'tscrollx', 04:27:02 INFO - 'cart']}, 04:27:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:02 INFO - 'talos_options': ['--disable-e10s'], 04:27:02 INFO - 'tests': ['tp5o']}, 04:27:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:02 INFO - 'tests': ['tp5o']}, 04:27:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:02 INFO - 'talos_options': ['--disable-e10s', 04:27:02 INFO - '--xperf_path', 04:27:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:02 INFO - 'tests': ['tp5n']}, 04:27:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:02 INFO - 'talos_options': ['--xperf_path', 04:27:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:02 INFO - 'tests': ['tp5n']}}, 04:27:02 INFO - 'talos.zip': {'path': '', 04:27:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:27:02 INFO - Running post-action listener: _resource_record_post_action 04:27:02 INFO - ##### 04:27:02 INFO - ##### Running create-virtualenv step. 04:27:02 INFO - ##### 04:27:02 INFO - Running pre-action listener: _resource_record_pre_action 04:27:02 INFO - Running main action method: create_virtualenv 04:27:02 INFO - Creating virtualenv /builds/slave/test/build/venv 04:27:02 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 04:27:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:27:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:27:02 INFO - Using real prefix '/usr' 04:27:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:27:03 INFO - Installing distribute.............................................................................................................................................................................................done. 04:27:05 INFO - Installing pip.................done. 04:27:05 INFO - Return code: 0 04:27:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57a957ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b3410>, '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 0x14b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b47a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', '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 04:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:27:05 INFO - Using env: {'DISPLAY': ':0', 04:27:05 INFO - 'HOME': '/home/cltbld', 04:27:05 INFO - 'LANG': 'en_US.UTF-8', 04:27:05 INFO - 'LANGUAGE': 'en_US:en', 04:27:05 INFO - 'LOGNAME': 'cltbld', 04:27:05 INFO - 'MAIL': '/var/mail/cltbld', 04:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:05 INFO - 'MOZ_NO_REMOTE': '1', 04:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:05 INFO - 'NO_EM_RESTART': '1', 04:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:05 INFO - 'PWD': '/builds/slave/test', 04:27:05 INFO - 'SHELL': '/bin/bash', 04:27:05 INFO - 'SHLVL': '1', 04:27:05 INFO - 'TERM': 'linux', 04:27:05 INFO - 'TMOUT': '86400', 04:27:05 INFO - 'USER': 'cltbld', 04:27:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', 04:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:05 INFO - '_': '/tools/buildbot/bin/python'} 04:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:05 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 04:27:05 INFO - Cleaning up... 04:27:05 INFO - Return code: 0 04:27:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f57a957ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b3410>, '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 0x14b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b47a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', '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 04:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:27:05 INFO - Using env: {'DISPLAY': ':0', 04:27:05 INFO - 'HOME': '/home/cltbld', 04:27:05 INFO - 'LANG': 'en_US.UTF-8', 04:27:05 INFO - 'LANGUAGE': 'en_US:en', 04:27:05 INFO - 'LOGNAME': 'cltbld', 04:27:05 INFO - 'MAIL': '/var/mail/cltbld', 04:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:05 INFO - 'MOZ_NO_REMOTE': '1', 04:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:05 INFO - 'NO_EM_RESTART': '1', 04:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:05 INFO - 'PWD': '/builds/slave/test', 04:27:05 INFO - 'SHELL': '/bin/bash', 04:27:05 INFO - 'SHLVL': '1', 04:27:05 INFO - 'TERM': 'linux', 04:27:05 INFO - 'TMOUT': '86400', 04:27:05 INFO - 'USER': 'cltbld', 04:27:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', 04:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:05 INFO - '_': '/tools/buildbot/bin/python'} 04:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:05 INFO - Downloading/unpacking psutil>=0.7.1 04:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:07 INFO - Installing collected packages: psutil 04:27:07 INFO - Running setup.py install for psutil 04:27:07 INFO - building 'psutil._psutil_linux' extension 04:27:07 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 04:27:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:27:07 INFO - building 'psutil._psutil_posix' extension 04:27:07 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 04:27:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:27:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:07 INFO - Successfully installed psutil 04:27:07 INFO - Cleaning up... 04:27:07 INFO - Return code: 0 04:27:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57a957ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b3410>, '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 0x14b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b47a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', '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 04:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:27:07 INFO - Using env: {'DISPLAY': ':0', 04:27:07 INFO - 'HOME': '/home/cltbld', 04:27:07 INFO - 'LANG': 'en_US.UTF-8', 04:27:07 INFO - 'LANGUAGE': 'en_US:en', 04:27:07 INFO - 'LOGNAME': 'cltbld', 04:27:07 INFO - 'MAIL': '/var/mail/cltbld', 04:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:07 INFO - 'MOZ_NO_REMOTE': '1', 04:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:07 INFO - 'NO_EM_RESTART': '1', 04:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:07 INFO - 'PWD': '/builds/slave/test', 04:27:07 INFO - 'SHELL': '/bin/bash', 04:27:07 INFO - 'SHLVL': '1', 04:27:07 INFO - 'TERM': 'linux', 04:27:07 INFO - 'TMOUT': '86400', 04:27:07 INFO - 'USER': 'cltbld', 04:27:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', 04:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:07 INFO - '_': '/tools/buildbot/bin/python'} 04:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:27:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:27:10 INFO - Installing collected packages: mozsystemmonitor 04:27:10 INFO - Running setup.py install for mozsystemmonitor 04:27:10 INFO - Successfully installed mozsystemmonitor 04:27:10 INFO - Cleaning up... 04:27:10 INFO - Return code: 0 04:27:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:27:10 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')]} 04:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:10 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')]} 04:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:10 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 0x7f57a957ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b3410>, '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 0x14b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b47a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', '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 04:27:10 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 04:27:10 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 04:27:10 INFO - Using env: {'DISPLAY': ':0', 04:27:10 INFO - 'HOME': '/home/cltbld', 04:27:10 INFO - 'LANG': 'en_US.UTF-8', 04:27:10 INFO - 'LANGUAGE': 'en_US:en', 04:27:10 INFO - 'LOGNAME': 'cltbld', 04:27:10 INFO - 'MAIL': '/var/mail/cltbld', 04:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:10 INFO - 'MOZ_NO_REMOTE': '1', 04:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:10 INFO - 'NO_EM_RESTART': '1', 04:27:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:10 INFO - 'PWD': '/builds/slave/test', 04:27:10 INFO - 'SHELL': '/bin/bash', 04:27:10 INFO - 'SHLVL': '1', 04:27:10 INFO - 'TERM': 'linux', 04:27:10 INFO - 'TMOUT': '86400', 04:27:10 INFO - 'USER': 'cltbld', 04:27:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', 04:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:10 INFO - '_': '/tools/buildbot/bin/python'} 04:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:10 INFO - Downloading/unpacking blobuploader==1.2.4 04:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:12 INFO - Downloading blobuploader-1.2.4.tar.gz 04:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:27:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:27:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:13 INFO - Downloading docopt-0.6.1.tar.gz 04:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:27:13 INFO - Installing collected packages: blobuploader, requests, docopt 04:27:13 INFO - Running setup.py install for blobuploader 04:27:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:27:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:27:13 INFO - Running setup.py install for requests 04:27:13 INFO - Running setup.py install for docopt 04:27:13 INFO - Successfully installed blobuploader requests docopt 04:27:13 INFO - Cleaning up... 04:27:13 INFO - Return code: 0 04:27:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:13 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')]} 04:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:13 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')]} 04:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:13 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 0x7f57a957ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b3410>, '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 0x14b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b47a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', '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 04:27:13 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 04:27:13 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 04:27:13 INFO - Using env: {'DISPLAY': ':0', 04:27:13 INFO - 'HOME': '/home/cltbld', 04:27:13 INFO - 'LANG': 'en_US.UTF-8', 04:27:13 INFO - 'LANGUAGE': 'en_US:en', 04:27:13 INFO - 'LOGNAME': 'cltbld', 04:27:13 INFO - 'MAIL': '/var/mail/cltbld', 04:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:13 INFO - 'MOZ_NO_REMOTE': '1', 04:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:13 INFO - 'NO_EM_RESTART': '1', 04:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:13 INFO - 'PWD': '/builds/slave/test', 04:27:13 INFO - 'SHELL': '/bin/bash', 04:27:13 INFO - 'SHLVL': '1', 04:27:13 INFO - 'TERM': 'linux', 04:27:13 INFO - 'TMOUT': '86400', 04:27:13 INFO - 'USER': 'cltbld', 04:27:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', 04:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:13 INFO - '_': '/tools/buildbot/bin/python'} 04:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:14 INFO - Running setup.py (path:/tmp/pip-TTx4xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:14 INFO - Running setup.py (path:/tmp/pip-HOohuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:14 INFO - Running setup.py (path:/tmp/pip-fPPCyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:14 INFO - Running setup.py (path:/tmp/pip-w64f0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:14 INFO - Running setup.py (path:/tmp/pip-lYx65c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:14 INFO - Running setup.py (path:/tmp/pip-XRcuL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:14 INFO - Running setup.py (path:/tmp/pip-NdX5Oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:14 INFO - Running setup.py (path:/tmp/pip-oo5rDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:14 INFO - Running setup.py (path:/tmp/pip-yXAd8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:14 INFO - Running setup.py (path:/tmp/pip-99Qw95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:14 INFO - Running setup.py (path:/tmp/pip-MrCtvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:14 INFO - Running setup.py (path:/tmp/pip-bRnQx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:15 INFO - Running setup.py (path:/tmp/pip-L2HOBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:15 INFO - Running setup.py (path:/tmp/pip-DPTXC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:15 INFO - Running setup.py (path:/tmp/pip-jigfDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:15 INFO - Running setup.py (path:/tmp/pip-z7NVZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:15 INFO - Running setup.py (path:/tmp/pip-IbSlKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:27:15 INFO - Running setup.py install for manifestparser 04:27:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:27:15 INFO - Running setup.py install for mozcrash 04:27:15 INFO - Running setup.py install for mozdebug 04:27:15 INFO - Running setup.py install for mozdevice 04:27:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:27:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:27:15 INFO - Running setup.py install for mozfile 04:27:15 INFO - Running setup.py install for mozhttpd 04:27:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:27:16 INFO - Running setup.py install for mozinfo 04:27:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:27:16 INFO - Running setup.py install for mozInstall 04:27:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:27:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:27:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:27:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:27:16 INFO - Running setup.py install for mozleak 04:27:16 INFO - Running setup.py install for mozlog 04:27:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:27:16 INFO - Running setup.py install for moznetwork 04:27:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:27:16 INFO - Running setup.py install for mozprocess 04:27:16 INFO - Running setup.py install for mozprofile 04:27:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:27:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:27:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:27:16 INFO - Running setup.py install for mozrunner 04:27:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:27:16 INFO - Running setup.py install for mozscreenshot 04:27:16 INFO - Running setup.py install for moztest 04:27:17 INFO - Running setup.py install for mozversion 04:27:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:27:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:27:17 INFO - Cleaning up... 04:27:17 INFO - Return code: 0 04:27:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:17 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')]} 04:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:17 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')]} 04:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:17 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 0x7f57a957ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b3410>, '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 0x14b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b47a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', '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 04:27:17 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 04:27:17 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 04:27:17 INFO - Using env: {'DISPLAY': ':0', 04:27:17 INFO - 'HOME': '/home/cltbld', 04:27:17 INFO - 'LANG': 'en_US.UTF-8', 04:27:17 INFO - 'LANGUAGE': 'en_US:en', 04:27:17 INFO - 'LOGNAME': 'cltbld', 04:27:17 INFO - 'MAIL': '/var/mail/cltbld', 04:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:17 INFO - 'MOZ_NO_REMOTE': '1', 04:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:17 INFO - 'NO_EM_RESTART': '1', 04:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:17 INFO - 'PWD': '/builds/slave/test', 04:27:17 INFO - 'SHELL': '/bin/bash', 04:27:17 INFO - 'SHLVL': '1', 04:27:17 INFO - 'TERM': 'linux', 04:27:17 INFO - 'TMOUT': '86400', 04:27:17 INFO - 'USER': 'cltbld', 04:27:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', 04:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:17 INFO - '_': '/tools/buildbot/bin/python'} 04:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:17 INFO - Running setup.py (path:/tmp/pip-3vB0HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:17 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)) 04:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:17 INFO - Running setup.py (path:/tmp/pip-q4gj7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:17 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)) 04:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:17 INFO - Running setup.py (path:/tmp/pip-mMPQ6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:17 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)) 04:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:17 INFO - Running setup.py (path:/tmp/pip-mmTN3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:17 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)) 04:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:17 INFO - Running setup.py (path:/tmp/pip-AudREI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:17 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)) 04:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:17 INFO - Running setup.py (path:/tmp/pip-hG_OlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:17 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)) 04:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:17 INFO - Running setup.py (path:/tmp/pip-8PPhPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:17 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)) 04:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:17 INFO - Running setup.py (path:/tmp/pip-w3y2CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:17 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)) 04:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:18 INFO - Running setup.py (path:/tmp/pip-HUqMnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:18 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)) 04:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:18 INFO - Running setup.py (path:/tmp/pip-oKIPNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:18 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)) 04:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:18 INFO - Running setup.py (path:/tmp/pip-MjSZlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:18 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)) 04:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:18 INFO - Running setup.py (path:/tmp/pip-tEJelv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:18 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)) 04:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:18 INFO - Running setup.py (path:/tmp/pip-cBxDfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:18 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)) 04:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:18 INFO - Running setup.py (path:/tmp/pip-8TqnBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:18 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)) 04:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:18 INFO - Running setup.py (path:/tmp/pip-sPg8EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:18 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)) 04:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:18 INFO - Running setup.py (path:/tmp/pip-YFEwlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:18 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)) 04:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:18 INFO - Running setup.py (path:/tmp/pip-Kr49Ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:18 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)) 04:27:18 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)) 04:27:18 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)) 04:27:18 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)) 04:27:18 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)) 04:27:18 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)) 04:27:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:27:18 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 04:27:18 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 04:27:18 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 04:27:18 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 04:27:18 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 04:27:18 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 04:27:20 INFO - Downloading blessings-1.6.tar.gz 04:27:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:27:20 INFO - Installing collected packages: blessings 04:27:20 INFO - Running setup.py install for blessings 04:27:20 INFO - Successfully installed blessings 04:27:20 INFO - Cleaning up... 04:27:20 INFO - Return code: 0 04:27:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:27:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:21 INFO - Reading from file tmpfile_stdout 04:27:21 INFO - Current package versions: 04:27:21 INFO - argparse == 1.2.1 04:27:21 INFO - blessings == 1.6 04:27:21 INFO - blobuploader == 1.2.4 04:27:21 INFO - docopt == 0.6.1 04:27:21 INFO - manifestparser == 1.1 04:27:21 INFO - mozInstall == 1.12 04:27:21 INFO - mozcrash == 0.17 04:27:21 INFO - mozdebug == 0.1 04:27:21 INFO - mozdevice == 0.48 04:27:21 INFO - mozfile == 1.2 04:27:21 INFO - mozhttpd == 0.7 04:27:21 INFO - mozinfo == 0.9 04:27:21 INFO - mozleak == 0.1 04:27:21 INFO - mozlog == 3.1 04:27:21 INFO - moznetwork == 0.27 04:27:21 INFO - mozprocess == 0.22 04:27:21 INFO - mozprofile == 0.28 04:27:21 INFO - mozrunner == 6.11 04:27:21 INFO - mozscreenshot == 0.1 04:27:21 INFO - mozsystemmonitor == 0.0 04:27:21 INFO - moztest == 0.7 04:27:21 INFO - mozversion == 1.4 04:27:21 INFO - psutil == 3.1.1 04:27:21 INFO - requests == 1.2.3 04:27:21 INFO - wsgiref == 0.1.2 04:27:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:21 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')]} 04:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:21 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')]} 04:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:21 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 0x7f57a957ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b3410>, '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 0x14b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b47a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', '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 04:27:21 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 04:27:21 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 04:27:21 INFO - Using env: {'DISPLAY': ':0', 04:27:21 INFO - 'HOME': '/home/cltbld', 04:27:21 INFO - 'LANG': 'en_US.UTF-8', 04:27:21 INFO - 'LANGUAGE': 'en_US:en', 04:27:21 INFO - 'LOGNAME': 'cltbld', 04:27:21 INFO - 'MAIL': '/var/mail/cltbld', 04:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:21 INFO - 'MOZ_NO_REMOTE': '1', 04:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:21 INFO - 'NO_EM_RESTART': '1', 04:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:21 INFO - 'PWD': '/builds/slave/test', 04:27:21 INFO - 'SHELL': '/bin/bash', 04:27:21 INFO - 'SHLVL': '1', 04:27:21 INFO - 'TERM': 'linux', 04:27:21 INFO - 'TMOUT': '86400', 04:27:21 INFO - 'USER': 'cltbld', 04:27:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', 04:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:21 INFO - '_': '/tools/buildbot/bin/python'} 04:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:21 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)) 04:27:21 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)) 04:27:21 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)) 04:27:21 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)) 04:27:21 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)) 04:27:21 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)) 04:27:21 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)) 04:27:21 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)) 04:27:21 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)) 04:27:21 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)) 04:27:21 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)) 04:27:21 INFO - Cleaning up... 04:27:21 INFO - Return code: 0 04:27:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:27:21 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')]} 04:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:21 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')]} 04:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:21 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 0x7f57a957ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b3410>, '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 0x14b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b47a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', '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 04:27:21 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 04:27:21 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 04:27:21 INFO - Using env: {'DISPLAY': ':0', 04:27:21 INFO - 'HOME': '/home/cltbld', 04:27:21 INFO - 'LANG': 'en_US.UTF-8', 04:27:21 INFO - 'LANGUAGE': 'en_US:en', 04:27:21 INFO - 'LOGNAME': 'cltbld', 04:27:21 INFO - 'MAIL': '/var/mail/cltbld', 04:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:21 INFO - 'MOZ_NO_REMOTE': '1', 04:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:21 INFO - 'NO_EM_RESTART': '1', 04:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:21 INFO - 'PWD': '/builds/slave/test', 04:27:21 INFO - 'SHELL': '/bin/bash', 04:27:21 INFO - 'SHLVL': '1', 04:27:21 INFO - 'TERM': 'linux', 04:27:21 INFO - 'TMOUT': '86400', 04:27:21 INFO - 'USER': 'cltbld', 04:27:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', 04:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:21 INFO - '_': '/tools/buildbot/bin/python'} 04:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:21 INFO - Downloading/unpacking jsonschema 04:27:21 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 04:27:21 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 04:27:21 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 04:27:21 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 04:27:21 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 04:27:21 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 04:27:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:27:23 INFO - Downloading/unpacking functools32 (from jsonschema) 04:27:23 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 04:27:23 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 04:27:23 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 04:27:23 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 04:27:23 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 04:27:23 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 04:27:23 INFO - Downloading functools32-3.2.3-2.tar.gz 04:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:27:23 INFO - warning: no files found matching '*.txt' 04:27:23 INFO - no previously-included directories found matching 'build' 04:27:23 INFO - no previously-included directories found matching 'dist' 04:27:23 INFO - no previously-included directories found matching '.git*' 04:27:23 INFO - Installing collected packages: jsonschema, functools32 04:27:23 INFO - Running setup.py install for functools32 04:27:23 INFO - warning: no files found matching '*.txt' 04:27:23 INFO - no previously-included directories found matching 'build' 04:27:23 INFO - no previously-included directories found matching 'dist' 04:27:23 INFO - no previously-included directories found matching '.git*' 04:27:23 INFO - Successfully installed jsonschema functools32 04:27:23 INFO - Cleaning up... 04:27:23 INFO - Return code: 0 04:27:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:27:23 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')]} 04:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:23 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')]} 04:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:23 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 0x7f57a957ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14245a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b3410>, '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 0x14b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b47a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', '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 04:27:23 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 04:27:23 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 04:27:23 INFO - Using env: {'DISPLAY': ':0', 04:27:23 INFO - 'HOME': '/home/cltbld', 04:27:23 INFO - 'LANG': 'en_US.UTF-8', 04:27:23 INFO - 'LANGUAGE': 'en_US:en', 04:27:23 INFO - 'LOGNAME': 'cltbld', 04:27:23 INFO - 'MAIL': '/var/mail/cltbld', 04:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:23 INFO - 'MOZ_NO_REMOTE': '1', 04:27:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:23 INFO - 'NO_EM_RESTART': '1', 04:27:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:23 INFO - 'PWD': '/builds/slave/test', 04:27:23 INFO - 'SHELL': '/bin/bash', 04:27:23 INFO - 'SHLVL': '1', 04:27:23 INFO - 'TERM': 'linux', 04:27:23 INFO - 'TMOUT': '86400', 04:27:23 INFO - 'USER': 'cltbld', 04:27:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', 04:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:23 INFO - '_': '/tools/buildbot/bin/python'} 04:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:24 INFO - Downloading/unpacking flake8 04:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:27:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:27:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:27:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:27:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:27:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:27:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:27:26 INFO - no previously-included directories found matching 'docs/_build' 04:27:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:27:26 INFO - Running setup.py install for pep8 04:27:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:27:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:27:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:27:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:27:26 INFO - no previously-included directories found matching 'docs/_build' 04:27:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:27:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:27:26 INFO - Cleaning up... 04:27:26 INFO - Return code: 0 04:27:26 INFO - Running post-action listener: _resource_record_post_action 04:27:26 INFO - Running post-action listener: _start_resource_monitoring 04:27:26 INFO - Starting resource monitoring. 04:27:26 INFO - ##### 04:27:26 INFO - ##### Running install step. 04:27:26 INFO - ##### 04:27:26 INFO - Running pre-action listener: _resource_record_pre_action 04:27:26 INFO - Running main action method: install 04:27:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:27 INFO - Reading from file tmpfile_stdout 04:27:27 INFO - Detecting whether we're running mozinstall >=1.0... 04:27:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:27:27 INFO - Reading from file tmpfile_stdout 04:27:27 INFO - Output received: 04:27:27 INFO - Usage: mozinstall [options] installer 04:27:27 INFO - Options: 04:27:27 INFO - -h, --help show this help message and exit 04:27:27 INFO - -d DEST, --destination=DEST 04:27:27 INFO - Directory to install application into. [default: 04:27:27 INFO - "/builds/slave/test"] 04:27:27 INFO - --app=APP Application being installed. [default: firefox] 04:27:27 INFO - mkdir: /builds/slave/test/build/application 04:27:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:27:42 INFO - Reading from file tmpfile_stdout 04:27:42 INFO - Output received: 04:27:42 INFO - /builds/slave/test/build/application/firefox/firefox 04:27:42 INFO - Running post-action listener: _resource_record_post_action 04:27:42 INFO - ##### 04:27:42 INFO - ##### Running run-tests step. 04:27:42 INFO - ##### 04:27:42 INFO - Running pre-action listener: _resource_record_pre_action 04:27:42 INFO - Running main action method: run_tests 04:27:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:27:42 INFO - Python 2.7.3 04:27:42 INFO - Return code: 0 04:27:42 INFO - grabbing minidump binary from tooltool 04:27: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')]} 04:27:42 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 0x14b3410>, '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 0x14b4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:27:42 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 04:27:42 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 04:27:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:27:43 INFO - Return code: 0 04:27:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:27:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:27:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:27:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:27:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:27:43 INFO - Return code: 0 04:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 04:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 04:27:43 INFO - Using env: {'DISPLAY': ':0', 04:27:43 INFO - 'HOME': '/home/cltbld', 04:27:43 INFO - 'LANG': 'en_US.UTF-8', 04:27:43 INFO - 'LANGUAGE': 'en_US:en', 04:27:43 INFO - 'LOGNAME': 'cltbld', 04:27:43 INFO - 'MAIL': '/var/mail/cltbld', 04:27:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:27:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:43 INFO - 'MOZ_NO_REMOTE': '1', 04:27:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:43 INFO - 'NO_EM_RESTART': '1', 04:27:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:43 INFO - 'PWD': '/builds/slave/test', 04:27:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:27:43 INFO - 'SHELL': '/bin/bash', 04:27:43 INFO - 'SHLVL': '1', 04:27:43 INFO - 'TERM': 'linux', 04:27:43 INFO - 'TMOUT': '86400', 04:27:43 INFO - 'USER': 'cltbld', 04:27:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475', 04:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:43 INFO - '_': '/tools/buildbot/bin/python'} 04:27:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 04:27:44 INFO - mozversion application_buildid: 20160427025907 04:27:44 INFO - mozversion application_changeset: ab0044bfa1df858919797bcd6a9aef76a668cd4a 04:27:44 INFO - mozversion application_display_name: Nightly 04:27:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:27:44 INFO - mozversion application_name: Firefox 04:27:44 INFO - mozversion application_remotingname: firefox 04:27:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:27:44 INFO - mozversion application_vendor: Mozilla 04:27:44 INFO - mozversion application_version: 49.0a1 04:27:44 INFO - mozversion platform_buildid: 20160427025907 04:27:44 INFO - mozversion platform_changeset: ab0044bfa1df858919797bcd6a9aef76a668cd4a 04:27:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:27:44 INFO - mozversion platform_version: 49.0a1 04:27:44 INFO - using testdate: 1461756464 04:27:44 INFO - actual date: 1461756464 04:27:44 INFO - starting webserver on 'localhost:60468' 04:27:44 INFO - SUITE-START | Running 2 tests 04:27:44 INFO - TEST-START | dromaeo_css 04:27:44 INFO - operating with platform_type : linux_ 04:27:44 INFO - Initialising browser for dromaeo_css test... 04:27:44 INFO - TEST-INFO | started process 26135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ahpm1/profile http://localhost:60468/getInfo.html) 04:27:48 INFO - PROCESS | 26135 | __metrics Screen width/height:1600/1200 04:27:48 INFO - PROCESS | 26135 | colorDepth:24 04:27:48 INFO - PROCESS | 26135 | Browser inner width/height: 1024/697 04:27:48 INFO - PROCESS | 26135 | __metrics 04:27:49 ERROR - PROCESS | 26135 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:27:49 INFO - TEST-INFO | 26135: exit 0 04:27:49 INFO - Browser initialized. 04:27:49 INFO - Running cycle 1/1 for dromaeo_css test... 04:27:49 INFO - TEST-INFO | started process 26215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ahpm1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:01 INFO - PROCESS | 26215 | RSS: Main: 156557312 04:28:01 INFO - PROCESS | 26215 | 04:28:53 INFO - PROCESS | 26215 | 1461756533156 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] 04:31:05 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:60468/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60468/tests/dromaeo/cssquery-ext.html) 04:31:06 INFO - PROCESS | 26215 | RSS: Main: 254128128 04:31:06 INFO - PROCESS | 26215 | 04:34:08 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:60468/tests/dromaeo/cssquery-ext.html (next: http://localhost:60468/tests/dromaeo/cssquery-jquery.html) 04:34:09 INFO - PROCESS | 26215 | RSS: Main: 238223360 04:34:09 INFO - PROCESS | 26215 | 04:37:11 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:60468/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60468/tests/dromaeo/cssquery-mootools.html) 04:37:11 INFO - PROCESS | 26215 | RSS: Main: 233971712 04:37:11 INFO - PROCESS | 26215 | 04:40:14 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:60468/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60468/tests/dromaeo/cssquery-prototype.html) 04:40:14 INFO - PROCESS | 26215 | RSS: Main: 241098752 04:40:14 INFO - PROCESS | 26215 | 04:43:17 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:60468/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60468/tests/dromaeo/cssquery-yui.html) 04:43:18 INFO - PROCESS | 26215 | RSS: Main: 215732224 04:43:18 INFO - PROCESS | 26215 | 04:46:20 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:60468/tests/dromaeo/cssquery-yui.html (next: http://localhost:60468/tests/dromaeo/cssquery-dojo.html) 04:46:21 INFO - PROCESS | 26215 | RSS: Main: 263774208 04:46:21 INFO - PROCESS | 26215 | 04:46:21 INFO - PROCESS | 26215 | __start_tp_report 04:46:21 INFO - PROCESS | 26215 | _x_x_mozilla_page_load 04:46:21 INFO - PROCESS | 26215 | _x_x_mozilla_page_load_details 04:46:21 INFO - PROCESS | 26215 | |i|pagename|runs| 04:46:21 INFO - PROCESS | 26215 | |0;dojo.html;2630.2635262126605;2695.797815163863;2699.4061306512563;2712.1456741126544;2733.712960139186;4615.399998000264;4665.090307390056;4702.177119004177;4719.48085710572;4730.148573256817;4693.953060469403;4714.339992401058;4751.643626727992;4819.590334821535;4826.662133650646;4320.63274621656;4339.284018137011;4350.4344435223375;4378.759168245745;4400.669949753766;4453.510113887486;4480.596746292833;4497.9775101124615;4539.6368290536675;4540.318952157169;4292.205941900758;4363.476382834048;4366.366876802846;4442.3336499525;4503.301988191835;4320.9135817283795;4329.307310830283;4334.436523251989;4334.501532323791;4365.650747940157;4306.0526684129445;4334.45819272591;4351.760653164075;4388.648908087345;4391.934120988188;4617.284320930261;4647.070585882803;4653.511381304948;4654.837080702193;4699.459562150362;4935.851924442272;5062.493750624945;5074.467180945984;5079.339685840817;5137.17805151174;5070.771815268322;5076.44159142494;5080.466551012128;5098.439171691111;5110.080185566597;4718.4809670936165;4720.787564559603;4723.881902952419;4725.716457012591;4736.573708366263;4997.400311962515;5161.793528258902;5192.792288308426;5274.657147285414;5276.155815069647;5012.523810238022;5015.874603134951;5022.924656130161;5038.168702164176;5043.84868453947;5072.416672082684;5080.237964305384;5081.974590127025;5100.974495127575;5131.7177555234075;4911.803527858917;5027.698338099725;5043.722595257223;5054.7978080876355;5104.412992505835;4957.182064959241;4971.37857767779;4972.925406118911;4973.129702302155;5017.949820501822;4190.706650534495;4195.811188496464;4201.180769749931;4242.830286788494;4248.87253382399;3678.043708635774;3713.870014549532;3743.756655817363;3775.7734535927934;3801.3917773156163;4341.327094300388;4362.672799540047;4364.803583838735;4399.318105693623;4412.073464572476;5021.49785021495;5024.924626130611;5029.220470827027;5029.245613158056;5080.644354895196;4301.569843015736;4349.086691794695;4358.128374325148;4414.27164517851;4425.468943726773;4563.863084107482;4567.3377360282575;4590.931136032962;4593.931091033637;4639.489656137822;4855.854324370274;4880.487548807324;4880.585150262267;4887.902241955141;4928.802847886044;4908.509149085063;5003.44962054181;5021.347224860745;5068.6451948363265;5081.695098294114;4767.880802979953;4789.784459699392;4792.664513484023;4800.447948485829;4855.75721213945;4859.198232291774;4946.950530494649;4969.701817890938;4976.726280054631;5026.271190677405;5013.498650134958;5089.592832573459;5094.490550944876;5099.592032637454;5109.284700142058;4889.779959901742;4897.338859253955;4898.559129678346;4909.140900342354;4943.283223932582;4885.047415753894;4885.633577481774;4887.535684110004;4906.9018619626695;4953.801847926043;4732.787024583971;4821.373221481325;4853.80584776605;4884.804607815648;4904.558589726799;4987.650864439454;5012.448630650552;5012.749362531932;5017.247412888096;5068.29043933857;4731.45588257341;4895.388076490439;4901.58336541398;4907.950920490892;4949.82675606352 04:46:21 INFO - PROCESS | 26215 | |1;ext.html;578.1270281874368;595.08060047227;609.9573029887904;614.4807637546274;627.0093252660795;26401.339966500847;26976.190714278604;26979;26997;27029.324266893338;36883;37970.81014594923;37990.62009379905;37995.62004379955;38027.61972380275;7699.384049276073;7881.369490440751;7906.44654874159;7908.565028923407;7912.802179945518;7281.308275713799;7690.2694244046725;7824.413169012319;9460.290478214127;9728.075832795874;9771.26715496337;9876.061774131445;9884.061014203638;9894.30739848211;9896.25778066648;9659.082387173208;9781.90218097817;9791.461469619167;9792.804143917117;9794.314397992144;7282.563046217191;9420.905790942072;9719.708408747678;9720.513974301257;9737.318387712863;32401.351972960645;33005.33989320224;33013.17467063318;33156.50265246023;33162.6683733162;3053.7556995440314;3094.922626934322;3134.4201322755134;3153.3377990622;3540.2919416116624;27605.447891042266;27737.445251094865;28111.156665300074;28172.859135704395;29638.70361296381;3483.3729928613093;3502.124468882779;3530.1704099536587;3535.4166562517153;3635.363811333006;157083;158137;158435;158631;159084;29942.25144371408;51209.743951280005;52675.73662131742;52682.73658631682;52717.736411317695;31557;31667.683323166475;31683.683163168535;31699.04902852918;31721.20696982594;12766;12916.160449570747;13047.543335983195;13055;13078.476860925457;9725.61097556104;10910.290831095954;11062.944685276683;11079.279846809932;11085.889141108486;7640.770776876702;7751.1861254568585;7779.649915753805;7791.532508049535;7839.137694853562;3062.5099984002454;3120.0795765249304;3148.6064241969752;3176.872925083017;3184.601924759405;897.9640814367352;915.8580420034905;929.7071422502025;991.6380521109743;1011.1506334678905;25326;26437.37832576226;26916.730832691814;26978.865105674347;27043.32391690184;973.3624475968252;980.6518685866557;997.0855956563415;1082.7509672775147;1103.3379972016726;13982;14244.359003844851;14397.928010359881;14472;14485.637859053608;266653;271776;272808;273558;273862;46503.5349646506;47029.5297047032;47091.5290847094;47119.29321060187;47139.29291060637;1127.5940661361903;1140.885911408869;1222.1078612612664;1225.3199474291675;1331.7203387288585;24264.757352426957;25257.621135682613;25969.610455842798;27008.59487107734;27117.593236101868;38612;38762;38959.6104038956;38985.41521877117;38994.6100538991;171352;171513;171770;171963;182386;20448.59102817965;22888;23234.651480227472;23406.64890026685;23498.647520286868;35687;35930.28139437144;36557;36567.63432365642;36950.26099478049;31065.204131628263;31097.222569435944;31210.37579248357;31502.36995260128;31761.364772704877;32257.193570160933;34134.8293258542;34162.31675366528;34501;34789;31936.840315799203;33698.83150584231;34047;34180.658193417745;34360.82819585886;27094;27123.86438067797;28798.280042999093;28979.565306520843;29366.85316573489;23934.401639958443;23936.40158996039;24020.87989560041;24201;24607.630885537088 04:46:21 INFO - PROCESS | 26215 | |2;jquery.html;377.46476089781265;377.94962329363216;386.65780784006154;392.81930312056454;395.30821063139507;14834.184119873402;15398.30707618157;16203;16241.675166496663;16270.918645406786;10414.218933579992;10699.625513107043;10711.143108551316;10739.24825262232;11665.941670291637;3493.5109084728033;4627.8148874045;4703.082898834728;4787.976060119712;4815.879603009917;5140.691558506502;5391.218273350361;5412.269343638598;5414.675119492843;5440.455954404568;5399.730013499329;5402.270693456392;5404.891902161954;5424.783008679668;5586.776528938837;5829.912551311733;5973.253343332083;5994.49046831022;5997.760089596411;6004.669743164124;5176.55999240065;5190.870228244324;5196.142636464979;5265.6577322474295;5321.946780532223;17688.557786055324;18668.719969200472;19055.142518586697;19163.425097247105;19183.712244316346;1901.8383437407838;1922.480930148866;1949.4249196487071;2003.0385415000735;2380.8928848085725;8611.181937715906;8686.609102590399;8911.108889111038;9069.863952040725;9354.485503297316;1740.1734176266298;1744.8604111671036;1765.6998310287154;1796.092973048602;1833.4774589242002;58692;60367.094493582634;60408.697956510376;60958;61171.69414152945;9099.81800363989;9121.954390228006;9198.586063627019;9211.63153473867;9354.251659867194;12486.625401237978;12579.371031448574;12614.873851261369;12616.432260548298;12627.042808364718;6790.5246632736225;6825.761098361533;6848.417884479775;6877.105976223159;6957.06079679247;6527.086207930894;6538.411542961061;6627.801165964932;6627.933720662828;6643.833904152435;3844.519435070616;3961.7028722845325;3964.623360780721;4032.213718324957;4051.3517837145914;1593.7290660587728;1766.3994241957796;1853.8609604279734;1860.228005377753;1883.1431698577114;855.7646647172078;881.1937077574077;881.2597418168641;892.4600616626977;961.0869673809908;15194.544163675107;15495.690086198212;15643.530694079196;15714.29285682147;16187.271572779253;875.8423483772982;898.3621628643606;915.4278575890069;928.6424726480353;933.5099072986736;8572.657093716181;9032.548372581345;9075.319351048698;9086.409383390059;9296;277242;281587;363236;365592;367288;59954.40045599488;61585.69207153936;63221.68389158025;63865.361346385944;64087.03869441962;923.2227961174846;947.8483442649281;952.2096659772373;961.8653388525472;963.9710808675751;14062.718745625234;14114.082584631966;14165.150090994573;14239.786403204167;14812.111273323635;31295;32322;32583.185420363734;32909.34181316408;33262.83368583238;39730.40404393994;41113.79443102885;43541.346879797464;43550;44921.32618010798;7113.395361394132;7450.739224127129;7487;7571.280728330799;7605.543667379975;9883;11049.226554141454;11197.552097915992;11244.493997769956;11256.155788315746;9028.864567031369;9344.579493922654;9397.624095036123;9674.951625241829;9780.902190978284;9723.222142228746;9727.319087663796;9770.706878793648;9829.213662907094;9847.359921605073;9329.860052099088;9428.481433520948;9630.566624502055;9751.268654851056;9955.601775929172;7403.777886663193;7443.292887175709;7454.366378857858;7488.625568721651;7507.099148102263;9252.768680783034;9259.953700231725;9496.335256531976;9543.9045609543;9926.205903527556 04:46:21 INFO - PROCESS | 26215 | |3;mootools.html;1260.8739126087398;1438.6403399150208;1460.7589747691632;1562.1252098824652;1723.517415123765;6413.454856337211;6670.666466676665;6904.792856214309;6908.412784913288;6936.514443988923;6559.672016399173;6781.35577120174;6788.796336109925;6793.286704895989;6804.693788779505;1925.894075825829;2151.9139234430604;2159.6112699714045;2198.4943463003438;2232;2211.447138215446;2222.9666555001686;2229.3869185973826;2230.7323121225477;2234.7876951689564;2146.152269853407;2191.736991561007;2206.8013878750908;2208.0726095040122;2209.5801797658473;1915.4923945154544;2146.5384942237415;2224.8665080095248;2230.2863083813186;2230.7546169921297;2084.2600876688707;2127.297991662748;2131.1688441507827;2133.775953524873;2136.1882484655885;6663.800085997428;6791.252962174157;6797.966010169967;6799.048133261347;6832.180138383425;4348.695591308609;4492.393526873863;4493.168763778712;4497.168023915553;4502.144592527409;2811.7891158163015;2841.801073924826;2913.985430072857;2932.29624890027;2968.361802212513;903.7108125399875;923.5151545438631;930.8836395450569;963.6145541783272;966.8308046091976;9017.504037277948;9192.44845309277;9224.8616270756;9229.584668689926;9240.630374785;4151.916961660811;4279.572042795696;4304.80628371724;4382.189294980439;4382.956170438319;8174.427790054639;8199.139090395423;8211.548364839871;8216.301614362726;8222.259996600334;4156.418101465797;4554.0664163847;4559.430071241095;4564.360989461478;4567.840125595588;4073.2057248836786;4179.874603761892;4192.119654872511;4205.3271476563605;4205.726627769246;3464.9653503465147;3514.332276867387;3561.6972557332397;3570.393033184365;3594.191306955914;1227.96930076747;1246.9438875250635;1255.3409460033556;1255.4601521345726;1262.3498898067503;685.5715178013742;832.138736407815;838.2078935405983;846.4117438380266;859.1666083898608;4708.88227794301;4861.222204447272;4869.853904382874;4873.610111191097;4951.984843107154;395.2490268489835;411.77352456149;413.4253387790973;415.7962598326798;426.22852636727623;3166.7149956504027;3341.4820702791108;3368.781029233092;3381.746369022333;3401.8129002904584;8092.878606820902;8429.241368276884;8442.873356899652;8493;8505.787355316166;8366.79083022917;8435.578221088921;8445.155484451505;8459.492430454193;8481.575921203916;6590.176227971504;6752.3922846944015;6755.560888542229;6758.087658166085;6763.966180169067;4651.511591282867;4726.62187025044;4874.147024270809;4895.290182923527;4938.30863679078;7589.506682065648;7882.369410447265;7887.526748395115;7887.763367098996;7972.402069844668;7821.413393995587;8121.715739949073;8130.186981301823;8155;8180.67277308901;5968.731407086779;6217.191765070512;6226.59527130735;6352.396522330371;6414.230292364946;6746.797596072126;6835.179778426621;6844.93155068443;6891.724331026703;6898.896516552356;6130.47890929276;6289.308176100717;6336.493080553637;6393.648349340645;6396.904046439214;5993.460588547052;6139.201903752483;6157.784477543264;6289.96855015722;6339.841503962438;5789.45000224978;5845.1232315153065;5859.824205273849;5876.97152998215;5880.794172203952;4363.127374525045;4368.082702632482;4414.3157810539415;4431.135928493913;4451.866444006685;4357.607815296638;4385.583369579885;4390;4470.038941627566;4547.295169248771 04:46:21 INFO - PROCESS | 26215 | |4;prototype.html;297.9404119176164;313.17634620946905;315.30789916134097;316.6548462176227;319.2848020434228;4512.932306015404;4712.76436178191;4736.573708366246;4767.64242681799;4772.737499437534;4525.456945166585;4669.6731228814;4704.200285951388;4721.693089949151;4724.543237516489;3772.320982223192;3791.33651610967;3794.1083845296334;3809.5238095238096;3812.618738126193;3630.6006339302658;3703.2038111805955;3800.638939300762;3809.56190038145;3838.8080595970227;3798.4872042274214;3805.9809700951455;3816.9045773855737;3817.331966905794;3834.328992426328;3756.1924186300075;3756.9624303756887;3771.924561508782;3772.566154892181;3793.3551296279425;3389.2204792897523;3405.676460736226;3408.386490431721;3412.1128506588216;3433.6223015468277;4475.970526778827;4522.638188944877;4524.61540769035;4527.796249168795;4546.65900057497;4266.146770645883;4294.938429553832;4299.6775241856985;4307.3108302671735;4311.547287534827;4931.605471562267;4948.356713627241;4951.306817045616;4962.851114466572;4964.230544265644;3537.876174333886;3672.3022625701033;3672.338978983782;3679.4848721179055;3682.834272457746;5171.456997015334;5192.402873669501;5209.166533354645;5231.633785635046;5245.160774276135;3768.340540405418;3775.131719704483;3784.110733977513;3786.8863934082024;3790.166163444038;3838.788866612307;3849.5188101487315;3859.614038596118;3859.9035024124623;3860.9227815443533;3936.389859571771;4187.120704652058;4197.916041679149;4203.348480985452;4204.831806727758;4971.627127965345;4985.45450910219;5005.074061298671;5020.924686129711;5030.220315851049;1275.183882315319;1309.541660418865;1346.5690978886857;1350.7973803929292;1355.8440779310308;891.4740303221131;903.9819203615891;910.2217603948661;915.7527467583849;919.1773362840354;4662.650301227422;4668.836590719308;4679.298105284167;4679.344891715163;4680.648951328664;5309.8938021239355;5347.946520534745;5377.7580008899695;5380.973095134499;5397.595180361489;4557.45310562728;4611.723296602215;4623.8844028898875;4624.329472226508;4637.1421287062;2862.799604027698;2865.412590418959;2870.62681851358;2880.524713422262;2894.073896353189;5075.441701412841;5126.615503837227;5132.050570644443;5149.562287205555;5178.559822415062;5009.874753131201;5338.252644629755;5530.446955304518;5544.085225937756;5564.33228012641;4931.827386041399;4971.527704868032;4972.129877271535;4973.477784832613;4975.029869175476;5158.3552055993005;5166.4058633257655;5167.501424586828;5182.507661772125;5184.870378240575;4896.559309662148;5064.240363945438;5065.517896230894;5092.745362731923;5093.567046801063;4921.50784921505;4949.381327334083;4953.628477864103;4969.378827646544;4987.950120498748;3645.908852278714;3663.798491083016;3674.9710081177313;3695.3533131701306;3704.83328250224;4897.95102048975;4934.284528743384;5141.948580514147;5180.922286165635;5187.299714538489;4829.372181616367;4976.929960058605;5036.924446133237;5047.2429135629945;5060.392752869532;5002.974985125051;5007.273945277841;5029.74851257443;5033.697978121178;5056;4840.95159048405;4904.141775189399;4974.129527332775;4976.452590215001;4996.225585034325;5015;5019.0965626187635;5021.146405111067;5036.370453693288;5044.4451110377095;4879;4901.607871370211;4924.581410579997;4946.802127914987;4948.975255123702 04:46:21 INFO - PROCESS | 26215 | |5;yui.html;667.2160211751191;673.0678010954829;750.8798592225244;769.8999130113084;785.8035491127218;11293.548258069677;13146.934265328671;13594.932025339871;13603.727925441484;13628.454861805541;13448.932755336235;13490.392932318045;13519.864801351983;13538.255395953218;13556.728865422685;641.5701480008405;788.7318311773996;812.618069507332;822.7079386817653;829.8921140251758;823.3783493462428;824.5629816197425;825.9876101858476;827.6482494939656;828.7886588919818;850.6554845287668;856.7729551668813;857.0486759696763;857.8670306102564;858;664.40203816565;682.952193346466;683.3371629519359;821.1624143373725;851.5827244650138;618.5391883047114;618.9659568723719;619.1239396254294;619.3837132053635;619.5786864931845;12602.306873121976;12641.810372844415;12643.304618246084;12647.683807904876;12664.6833829155;11338.319700817978;11654.883451165464;11861.347625880573;11994;12178.878211217863;9631;9686.70939871805;9746.171575416098;9830.262730295257;9838.852417213748;3271.4111459937203;3276.705096541299;3308.387948229585;3311.2053107254087;3382.0868365541164;46999.5300047002;47864.5213547867;48046;48400;48523;9466.337356385126;9905.504724763732;9909;10030.348027378197;10039.297249192632;16045.839541604435;16237.431689890796;16237.59406014859;16273.10497922602;16279.348826047062;6490.513211509156;6659.9001014984815;6824.965875170592;6984.511084224056;7136.607486588184;3867.7292589518465;3897.2595206910596;3935.822887970048;3937.7243592948794;3958.762474251554;2787.456445993012;2875.3386721054276;2881.1788640237432;2881.5677648352917;2886.956695649567;491.14785846556197;497.4677095507772;504.17063929835217;508.8015673887187;514.9742512874342;467.48576565777375;592.6088781404253;607.6900780601925;619.1857707115129;626.9373062693694;8571.142885711504;8946.433255628635;9002.86495702565;9122.908770912207;9138.543072846463;614.5513774944316;626.2516293029877;631.009315374857;645.3243721469686;646.4462752734314;3229.4187046331417;3268.1176082457605;3346.5816772903386;3367.9326413471595;3380.2225488137374;51653.741731291106;55597;57057;57146.71426642923;57164.42835571591;48125;49778.75110624496;49921.50078499169;51271.74364128155;51963.48036519662;46735.99999999932;47032;47114.29328560075;47166;47171.52828471671;7179.425645948416;7247.2041180003425;7317.670704818403;7333.926660733538;7407.444441666788;29733.256668583457;29848.850755746083;30338.696613033586;30787;30839.845800770854;36627;37704.43443348297;38056.80971595124;40410.797946011255;41575;10727.19546034035;10759.462026898467;10831.404272765074;10890.945545272223;11212.887871121184;12351.69120771988;12369.196002259825;12428.502859885864;12509;12880.484780608671;9940.850887236842;10597.89402105969;10944.671659850217;11044.226904116957;11536.192466527262;10845.295055821347;11105.167112466435;11503;11615.825762613737;11660.18378713482;11321.150913681342;11332.433378331216;11425.143114266297;11910.821337680116;11973.940130299292;9460.668876589287;9621.56702948355;9796.755081123029;9842.901570984484;10083.092521673085;9794.951025244829;9941.403515789076;9989.700308990452;10026.498675066363;10075.395476271447 04:46:21 INFO - PROCESS | 26215 | __end_tp_report 04:46:21 INFO - PROCESS | 26215 | __start_cc_report 04:46:21 INFO - PROCESS | 26215 | _x_x_mozilla_cycle_collect,922 04:46:21 INFO - PROCESS | 26215 | __end_cc_report 04:46:21 INFO - PROCESS | 26215 | __startTimestamp1461757581233__endTimestamp 04:46:21 INFO - PROCESS | 26215 | 04:46:21 INFO - PROCESS | 26215 | ------- Summary: start ------- 04:46:21 INFO - PROCESS | 26215 | Number of tests: 6 04:46:21 INFO - PROCESS | 26215 | 04:46:21 INFO - PROCESS | 26215 | [#0] dojo.html Cycles:165 Average:4683.08 Median:4853.81 stddev:482.11 (9.9%) stddev-sans-first:455.91 04:46:21 INFO - PROCESS | 26215 | Values: 2630.3 2695.8 2699.4 2712.1 2733.7 4615.4 4665.1 4702.2 4719.5 4730.1 4694.0 4714.3 4751.6 4819.6 4826.7 4320.6 4339.3 4350.4 4378.8 4400.7 4453.5 4480.6 4498.0 4539.6 4540.3 4292.2 4363.5 4366.4 4442.3 4503.3 4320.9 4329.3 4334.4 4334.5 4365.7 4306.1 4334.5 4351.8 4388.6 4391.9 4617.3 4647.1 4653.5 4654.8 4699.5 4935.9 5062.5 5074.5 5079.3 5137.2 5070.8 5076.4 5080.5 5098.4 5110.1 4718.5 4720.8 4723.9 4725.7 4736.6 4997.4 5161.8 5192.8 5274.7 5276.2 5012.5 5015.9 5022.9 5038.2 5043.8 5072.4 5080.2 5082.0 5101.0 5131.7 4911.8 5027.7 5043.7 5054.8 5104.4 4957.2 4971.4 4972.9 4973.1 5017.9 4190.7 4195.8 4201.2 4242.8 4248.9 3678.0 3713.9 3743.8 3775.8 3801.4 4341.3 4362.7 4364.8 4399.3 4412.1 5021.5 5024.9 5029.2 5029.2 5080.6 4301.6 4349.1 4358.1 4414.3 4425.5 4563.9 4567.3 4590.9 4593.9 4639.5 4855.9 4880.5 4880.6 4887.9 4928.8 4908.5 5003.4 5021.3 5068.6 5081.7 4767.9 4789.8 4792.7 4800.4 4855.8 4859.2 4947.0 4969.7 4976.7 5026.3 5013.5 5089.6 5094.5 5099.6 5109.3 4889.8 4897.3 4898.6 4909.1 4943.3 4885.0 4885.6 4887.5 4906.9 4953.8 4732.8 4821.4 4853.8 4884.8 4904.6 4987.7 5012.4 5012.7 5017.2 5068.3 4731.5 4895.4 4901.6 4908.0 4949.8 04:46:21 INFO - PROCESS | 26215 | 04:46:21 INFO - PROCESS | 26215 | [#1] ext.html Cycles:180 Average:35066.75 Median:17472.98 stddev:54115.36 (309.7%) stddev-sans-first:54205.21 04:46:21 INFO - PROCESS | 26215 | Values: 578.1 595.1 610.0 614.5 627.0 26401.3 26976.2 26979.0 26997.0 27029.3 36883.0 37970.8 37990.6 37995.6 38027.6 7699.4 7881.4 7906.4 7908.6 7912.8 7281.3 7690.3 7824.4 9460.3 9728.1 9771.3 9876.1 9884.1 9894.3 9896.3 9659.1 9781.9 9791.5 9792.8 9794.3 7282.6 9420.9 9719.7 9720.5 9737.3 32401.4 33005.3 33013.2 33156.5 33162.7 3053.8 3094.9 3134.4 3153.3 3540.3 27605.4 27737.4 28111.2 28172.9 29638.7 3483.4 3502.1 3530.2 3535.4 3635.4 157083.0 158137.0 158435.0 158631.0 159084.0 29942.3 51209.7 52675.7 52682.7 52717.7 31557.0 31667.7 31683.7 31699.0 31721.2 12766.0 12916.2 13047.5 13055.0 13078.5 9725.6 10910.3 11062.9 11079.3 11085.9 7640.8 7751.2 7779.6 7791.5 7839.1 3062.5 3120.1 3148.6 3176.9 3184.6 898.0 915.9 929.7 991.6 1011.2 25326.0 26437.4 26916.7 26978.9 27043.3 973.4 980.7 997.1 1082.8 1103.3 13982.0 14244.4 14397.9 14472.0 14485.6 266653.0 271776.0 272808.0 273558.0 273862.0 46503.5 47029.5 47091.5 47119.3 47139.3 1127.6 1140.9 1222.1 1225.3 1331.7 24264.8 25257.6 25969.6 27008.6 27117.6 38612.0 38762.0 38959.6 38985.4 38994.6 171352.0 171513.0 171770.0 171963.0 182386.0 20448.6 22888.0 23234.7 23406.6 23498.6 35687.0 35930.3 36557.0 36567.6 36950.3 31065.2 31097.2 31210.4 31502.4 31761.4 32257.2 34134.8 34162.3 34501.0 34789.0 31936.8 33698.8 34047.0 34180.7 34360.8 27094.0 27123.9 28798.3 28979.6 29366.9 23934.4 23936.4 24020.9 24201.0 24607.6 04:46:21 INFO - PROCESS | 26215 | 04:46:21 INFO - PROCESS | 26215 | [#2] jquery.html Cycles:180 Average:21131.83 Median:5419.73 stddev:54953.19 (1013.9%) stddev-sans-first:55085.25 04:46:21 INFO - PROCESS | 26215 | Values: 377.5 377.9 386.7 392.8 395.3 14834.2 15398.3 16203.0 16241.7 16270.9 10414.2 10699.6 10711.1 10739.2 11665.9 3493.5 4627.8 4703.1 4788.0 4815.9 5140.7 5391.2 5412.3 5414.7 5440.5 5399.7 5402.3 5404.9 5424.8 5586.8 5829.9 5973.3 5994.5 5997.8 6004.7 5176.6 5190.9 5196.1 5265.7 5321.9 17688.6 18668.7 19055.1 19163.4 19183.7 1901.8 1922.5 1949.4 2003.0 2380.9 8611.2 8686.6 8911.1 9069.9 9354.5 1740.2 1744.9 1765.7 1796.1 1833.5 58692.0 60367.1 60408.7 60958.0 61171.7 9099.8 9122.0 9198.6 9211.6 9354.3 12486.6 12579.4 12614.9 12616.4 12627.0 6790.5 6825.8 6848.4 6877.1 6957.1 6527.1 6538.4 6627.8 6627.9 6643.8 3844.5 3961.7 3964.6 4032.2 4051.4 1593.7 1766.4 1853.9 1860.2 1883.1 855.8 881.2 881.3 892.5 961.1 15194.5 15495.7 15643.5 15714.3 16187.3 875.8 898.4 915.4 928.6 933.5 8572.7 9032.5 9075.3 9086.4 9296.0 277242.0 281587.0 363236.0 365592.0 367288.0 59954.4 61585.7 63221.7 63865.4 64087.0 923.2 947.8 952.2 961.9 964.0 14062.7 14114.1 14165.2 14239.8 14812.1 31295.0 32322.0 32583.2 32909.3 33262.8 39730.4 41113.8 43541.3 43550.0 44921.3 7113.4 7450.7 7487.0 7571.3 7605.5 9883.0 11049.2 11197.6 11244.5 11256.2 9028.9 9344.6 9397.6 9675.0 9780.9 9723.2 9727.3 9770.7 9829.2 9847.4 9329.9 9428.5 9630.6 9751.3 9955.6 7403.8 7443.3 7454.4 7488.6 7507.1 9252.8 9260.0 9496.3 9543.9 9926.2 04:46:21 INFO - PROCESS | 26215 | 04:46:21 INFO - PROCESS | 26215 | [#3] mootools.html Cycles:180 Average:4722.09 Median:4873.88 stddev:2483.13 (50.9%) stddev-sans-first:2476.47 04:46:21 INFO - PROCESS | 26215 | Values: 1260.9 1438.6 1460.8 1562.1 1723.5 6413.5 6670.7 6904.8 6908.4 6936.5 6559.7 6781.4 6788.8 6793.3 6804.7 1925.9 2151.9 2159.6 2198.5 2232.0 2211.4 2223.0 2229.4 2230.7 2234.8 2146.2 2191.7 2206.8 2208.1 2209.6 1915.5 2146.5 2224.9 2230.3 2230.8 2084.3 2127.3 2131.2 2133.8 2136.2 6663.8 6791.3 6798.0 6799.0 6832.2 4348.7 4492.4 4493.2 4497.2 4502.1 2811.8 2841.8 2914.0 2932.3 2968.4 903.7 923.5 930.9 963.6 966.8 9017.5 9192.4 9224.9 9229.6 9240.6 4151.9 4279.6 4304.8 4382.2 4383.0 8174.4 8199.1 8211.5 8216.3 8222.3 4156.4 4554.1 4559.4 4564.4 4567.8 4073.2 4179.9 4192.1 4205.3 4205.7 3465.0 3514.3 3561.7 3570.4 3594.2 1228.0 1246.9 1255.3 1255.5 1262.3 685.6 832.1 838.2 846.4 859.2 4708.9 4861.2 4869.9 4873.6 4952.0 395.2 411.8 413.4 415.8 426.2 3166.7 3341.5 3368.8 3381.7 3401.8 8092.9 8429.2 8442.9 8493.0 8505.8 8366.8 8435.6 8445.2 8459.5 8481.6 6590.2 6752.4 6755.6 6758.1 6764.0 4651.5 4726.6 4874.1 4895.3 4938.3 7589.5 7882.4 7887.5 7887.8 7972.4 7821.4 8121.7 8130.2 8155.0 8180.7 5968.7 6217.2 6226.6 6352.4 6414.2 6746.8 6835.2 6844.9 6891.7 6898.9 6130.5 6289.3 6336.5 6393.6 6396.9 5993.5 6139.2 6157.8 6290.0 6339.8 5789.5 5845.1 5859.8 5877.0 5880.8 4363.1 4368.1 4414.3 4431.1 4451.9 4357.6 4385.6 4390.0 4470.0 4547.3 04:46:21 INFO - PROCESS | 26215 | 04:46:21 INFO - PROCESS | 26215 | [#4] prototype.html Cycles:180 Average:4214.16 Median:4723.12 stddev:1202.23 (25.5%) stddev-sans-first:1169.12 04:46:21 INFO - PROCESS | 26215 | Values: 297.9 313.2 315.3 316.7 319.3 4512.9 4712.8 4736.6 4767.6 4772.7 4525.5 4669.7 4704.2 4721.7 4724.5 3772.3 3791.3 3794.1 3809.5 3812.6 3630.6 3703.2 3800.6 3809.6 3838.8 3798.5 3806.0 3816.9 3817.3 3834.3 3756.2 3757.0 3771.9 3772.6 3793.4 3389.2 3405.7 3408.4 3412.1 3433.6 4476.0 4522.6 4524.6 4527.8 4546.7 4266.1 4294.9 4299.7 4307.3 4311.5 4931.6 4948.4 4951.3 4962.9 4964.2 3537.9 3672.3 3672.3 3679.5 3682.8 5171.5 5192.4 5209.2 5231.6 5245.2 3768.3 3775.1 3784.1 3786.9 3790.2 3838.8 3849.5 3859.6 3859.9 3860.9 3936.4 4187.1 4197.9 4203.3 4204.8 4971.6 4985.5 5005.1 5020.9 5030.2 1275.2 1309.5 1346.6 1350.8 1355.8 891.5 904.0 910.2 915.8 919.2 4662.7 4668.8 4679.3 4679.3 4680.6 5309.9 5347.9 5377.8 5381.0 5397.6 4557.5 4611.7 4623.9 4624.3 4637.1 2862.8 2865.4 2870.6 2880.5 2894.1 5075.4 5126.6 5132.1 5149.6 5178.6 5009.9 5338.3 5530.4 5544.1 5564.3 4931.8 4971.5 4972.1 4973.5 4975.0 5158.4 5166.4 5167.5 5182.5 5184.9 4896.6 5064.2 5065.5 5092.7 5093.6 4921.5 4949.4 4953.6 4969.4 4988.0 3645.9 3663.8 3675.0 3695.4 3704.8 4898.0 4934.3 5141.9 5180.9 5187.3 4829.4 4976.9 5036.9 5047.2 5060.4 5003.0 5007.3 5029.7 5033.7 5056.0 4841.0 4904.1 4974.1 4976.5 4996.2 5015.0 5019.1 5021.1 5036.4 5044.4 4879.0 4901.6 4924.6 4946.8 4949.0 04:46:21 INFO - PROCESS | 26215 | 04:46:21 INFO - PROCESS | 26215 | [#5] yui.html Cycles:180 Average:13238.74 Median:47518.02 stddev:15371.96 (32.3%) stddev-sans-first:15386.10 04:46:21 INFO - PROCESS | 26215 | Values: 667.2 673.1 750.9 769.9 785.8 11293.5 13146.9 13594.9 13603.7 13628.5 13448.9 13490.4 13519.9 13538.3 13556.7 641.6 788.7 812.6 822.7 829.9 823.4 824.6 826.0 827.6 828.8 850.7 856.8 857.0 857.9 858.0 664.4 683.0 683.3 821.2 851.6 618.5 619.0 619.1 619.4 619.6 12602.3 12641.8 12643.3 12647.7 12664.7 11338.3 11654.9 11861.3 11994.0 12178.9 9631.0 9686.7 9746.2 9830.3 9838.9 3271.4 3276.7 3308.4 3311.2 3382.1 46999.5 47864.5 48046.0 48400.0 48523.0 9466.3 9905.5 9909.0 10030.3 10039.3 16045.8 16237.4 16237.6 16273.1 16279.3 6490.5 6659.9 6825.0 6984.5 7136.6 3867.7 3897.3 3935.8 3937.7 3958.8 2787.5 2875.3 2881.2 2881.6 2887.0 491.1 497.5 504.2 508.8 515.0 467.5 592.6 607.7 619.2 626.9 8571.1 8946.4 9002.9 9122.9 9138.5 614.6 626.3 631.0 645.3 646.4 3229.4 3268.1 3346.6 3367.9 3380.2 51653.7 55597.0 57057.0 57146.7 57164.4 48125.0 49778.8 49921.5 51271.7 51963.5 46736.0 47032.0 47114.3 47166.0 47171.5 7179.4 7247.2 7317.7 7333.9 7407.4 29733.3 29848.9 30338.7 30787.0 30839.8 36627.0 37704.4 38056.8 40410.8 41575.0 10727.2 10759.5 10831.4 10890.9 11212.9 12351.7 12369.2 12428.5 12509.0 12880.5 9940.9 10597.9 10944.7 11044.2 11536.2 10845.3 11105.2 11503.0 11615.8 11660.2 11321.2 11332.4 11425.1 11910.8 11973.9 9460.7 9621.6 9796.8 9842.9 10083.1 9795.0 9941.4 9989.7 10026.5 10075.4 04:46:21 INFO - PROCESS | 26215 | -------- Summary: end -------- 04:46:21 INFO - PROCESS | 26215 | 04:46:21 INFO - TEST-INFO | 26215: exit 0 04:46:21 INFO - TEST-OK | dromaeo_css | took 1117818ms 04:46:21 INFO - TEST-START | kraken 04:46:21 INFO - operating with platform_type : linux_ 04:46:21 INFO - Initialising browser for kraken test... 04:46:21 INFO - TEST-INFO | started process 26389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBFWryK/profile http://localhost:60468/getInfo.html) 04:46:25 INFO - PROCESS | 26389 | __metrics Screen width/height:1600/1200 04:46:25 INFO - PROCESS | 26389 | colorDepth:24 04:46:25 INFO - PROCESS | 26389 | Browser inner width/height: 1024/697 04:46:25 INFO - PROCESS | 26389 | __metrics 04:46:26 ERROR - PROCESS | 26389 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:46:27 INFO - TEST-INFO | 26389: exit 0 04:46:27 INFO - Browser initialized. 04:46:27 INFO - Running cycle 1/1 for kraken test... 04:46:27 INFO - TEST-INFO | started process 26469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBFWryK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:39 INFO - PROCESS | 26469 | RSS: Main: 156635136 04:46:39 INFO - PROCESS | 26469 | 04:46:42 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60468/tests/kraken/driver.html?testName=audio-beat-detection) 04:46:43 INFO - PROCESS | 26469 | RSS: Main: 211623936 04:46:43 INFO - PROCESS | 26469 | 04:46:46 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60468/tests/kraken/driver.html?testName=audio-dft) 04:46:46 INFO - PROCESS | 26469 | RSS: Main: 196485120 04:46:46 INFO - PROCESS | 26469 | 04:46:50 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60468/tests/kraken/driver.html?testName=audio-fft) 04:46:50 INFO - PROCESS | 26469 | RSS: Main: 268042240 04:46:50 INFO - PROCESS | 26469 | 04:46:52 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60468/tests/kraken/driver.html?testName=audio-oscillator) 04:46:53 INFO - PROCESS | 26469 | RSS: Main: 175452160 04:46:53 INFO - PROCESS | 26469 | 04:46:55 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60468/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:46:56 INFO - PROCESS | 26469 | RSS: Main: 179953664 04:46:56 INFO - PROCESS | 26469 | 04:46:59 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60468/tests/kraken/driver.html?testName=imaging-darkroom) 04:46:59 INFO - PROCESS | 26469 | RSS: Main: 216023040 04:46:59 INFO - PROCESS | 26469 | 04:47:03 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60468/tests/kraken/driver.html?testName=imaging-desaturate) 04:47:04 INFO - PROCESS | 26469 | RSS: Main: 217047040 04:47:04 INFO - PROCESS | 26469 | 04:47:06 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60468/tests/kraken/driver.html?testName=json-parse-financial) 04:47:07 INFO - PROCESS | 26469 | RSS: Main: 217268224 04:47:07 INFO - PROCESS | 26469 | 04:47:09 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60468/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:47:09 INFO - PROCESS | 26469 | RSS: Main: 203112448 04:47:09 INFO - PROCESS | 26469 | 04:47:11 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60468/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:47:12 INFO - PROCESS | 26469 | RSS: Main: 206491648 04:47:12 INFO - PROCESS | 26469 | 04:47:14 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60468/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:47:15 INFO - PROCESS | 26469 | RSS: Main: 217788416 04:47:15 INFO - PROCESS | 26469 | 04:47:17 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60468/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:47:18 INFO - PROCESS | 26469 | RSS: Main: 223510528 04:47:18 INFO - PROCESS | 26469 | 04:47:21 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60468/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:22 INFO - PROCESS | 26469 | RSS: Main: 220520448 04:47:22 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:60468/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60468/tests/kraken/driver.html?testName=ai-astar) 04:47:24 INFO - PROCESS | 26469 | RSS: Main: 284246016 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | __start_tp_report 04:47:24 INFO - PROCESS | 26469 | _x_x_mozilla_page_load 04:47:24 INFO - PROCESS | 26469 | _x_x_mozilla_page_load_details 04:47:24 INFO - PROCESS | 26469 | |i|pagename|runs| 04:47:24 INFO - PROCESS | 26469 | |0;ai-astar;111;115;109;114;114;115;103;113;113;112 04:47:24 INFO - PROCESS | 26469 | |1;audio-beat-detection;158;130;159;183;142;153;159;131;190;136 04:47:24 INFO - PROCESS | 26469 | |2;audio-dft;162;161;160;161;160;161;161;162;160;162 04:47:24 INFO - PROCESS | 26469 | |3;audio-fft;77;73;106;121;73;72;74;115;115;73 04:47:24 INFO - PROCESS | 26469 | |4;audio-oscillator;95;96;135;95;94;95;148;93;94;143 04:47:24 INFO - PROCESS | 26469 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;118 04:47:24 INFO - PROCESS | 26469 | |6;imaging-darkroom;146;147;146;146;146;146;146;147;146;146 04:47:24 INFO - PROCESS | 26469 | |7;imaging-desaturate;94;96;94;95;95;95;95;95;95;95 04:47:24 INFO - PROCESS | 26469 | |8;json-parse-financial;63;63;63;64;63;64;67;85;62;61 04:47:24 INFO - PROCESS | 26469 | |9;json-stringify-tinderbox;63;82;63;65;64;64;64;65;64;64 04:47:24 INFO - PROCESS | 26469 | |10;stanford-crypto-aes;80;78;79;78;78;78;81;81;79;80 04:47:24 INFO - PROCESS | 26469 | |11;stanford-crypto-ccm;137;138;138;133;134;133;133;134;179;134 04:47:24 INFO - PROCESS | 26469 | |12;stanford-crypto-pbkdf2;210;219;211;213;212;214;211;212;215;214 04:47:24 INFO - PROCESS | 26469 | |13;stanford-crypto-sha256-iterative;75;83;74;73;73;74;75;73;74;71 04:47:24 INFO - PROCESS | 26469 | __end_tp_report 04:47:24 INFO - PROCESS | 26469 | __start_cc_report 04:47:24 INFO - PROCESS | 26469 | _x_x_mozilla_cycle_collect,1871 04:47:24 INFO - PROCESS | 26469 | __end_cc_report 04:47:24 INFO - PROCESS | 26469 | __startTimestamp1461757644494__endTimestamp 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | ------- Summary: start ------- 04:47:24 INFO - PROCESS | 26469 | Number of tests: 14 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.50 stddev:3.63 (3.2%) stddev-sans-first:3.84 04:47:24 INFO - PROCESS | 26469 | Values: 111.0 115.0 109.0 114.0 114.0 115.0 103.0 113.0 113.0 112.0 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:158.50 stddev:20.49 (12.9%) stddev-sans-first:21.68 04:47:24 INFO - PROCESS | 26469 | Values: 158.0 130.0 159.0 183.0 142.0 153.0 159.0 131.0 190.0 136.0 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 04:47:24 INFO - PROCESS | 26469 | Values: 162.0 161.0 160.0 161.0 160.0 161.0 161.0 162.0 160.0 162.0 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#3] audio-fft Cycles:10 Average:89.90 Median:73.00 stddev:21.30 (29.2%) stddev-sans-first:22.07 04:47:24 INFO - PROCESS | 26469 | Values: 77.0 73.0 106.0 121.0 73.0 72.0 74.0 115.0 115.0 73.0 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:94.50 stddev:23.13 (24.5%) stddev-sans-first:23.99 04:47:24 INFO - PROCESS | 26469 | Values: 95.0 96.0 135.0 95.0 94.0 95.0 148.0 93.0 94.0 143.0 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:47:24 INFO - PROCESS | 26469 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:47:24 INFO - PROCESS | 26469 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 04:47:24 INFO - PROCESS | 26469 | Values: 94.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:63.50 stddev:7.03 (11.1%) stddev-sans-first:7.40 04:47:24 INFO - PROCESS | 26469 | Values: 63.0 63.0 63.0 64.0 63.0 64.0 67.0 85.0 62.0 61.0 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:64.00 stddev:5.73 (9.0%) stddev-sans-first:5.99 04:47:24 INFO - PROCESS | 26469 | Values: 63.0 82.0 63.0 65.0 64.0 64.0 64.0 65.0 64.0 64.0 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.50 stddev:1.23 (1.5%) stddev-sans-first:1.27 04:47:24 INFO - PROCESS | 26469 | Values: 80.0 78.0 79.0 78.0 78.0 78.0 81.0 81.0 79.0 80.0 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:135.50 stddev:14.10 (10.4%) stddev-sans-first:14.93 04:47:24 INFO - PROCESS | 26469 | Values: 137.0 138.0 138.0 133.0 134.0 133.0 133.0 134.0 179.0 134.0 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:213.10 Median:213.50 stddev:2.60 (1.2%) stddev-sans-first:2.51 04:47:24 INFO - PROCESS | 26469 | Values: 210.0 219.0 211.0 213.0 212.0 214.0 211.0 212.0 215.0 214.0 04:47:24 INFO - PROCESS | 26469 | 04:47:24 INFO - PROCESS | 26469 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:74.00 stddev:3.21 (4.3%) stddev-sans-first:3.40 04:47:24 INFO - PROCESS | 26469 | Values: 75.0 83.0 74.0 73.0 73.0 74.0 75.0 73.0 74.0 71.0 04:47:24 INFO - PROCESS | 26469 | -------- Summary: end -------- 04:47:24 INFO - PROCESS | 26469 | 04:47:25 INFO - TEST-INFO | 26469: exit 0 04:47:25 INFO - TEST-OK | kraken | took 63528ms 04:47:25 INFO - SUITE-END | took 1181s 04:47:25 INFO - Completed test suite (00:19:41) 04:47:25 INFO - javascript benchmark 04:47:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2630.2635262126605, 2695.797815163863, 2699.4061306512563, 2712.1456741126544, 2733.712960139186, 4615.399998000264, 4665.090307390056, 4702.177119004177, 4719.48085710572, 4730.148573256817, 4693.953060469403, 4714.339992401058, 4751.643626727992, 4819.590334821535, 4826.662133650646, 4320.63274621656, 4339.284018137011, 4350.4344435223375, 4378.759168245745, 4400.669949753766, 4453.510113887486, 4480.596746292833, 4497.9775101124615, 4539.6368290536675, 4540.318952157169, 4292.205941900758, 4363.476382834048, 4366.366876802846, 4442.3336499525, 4503.301988191835, 4320.9135817283795, 4329.307310830283, 4334.436523251989, 4334.501532323791, 4365.650747940157, 4306.0526684129445, 4334.45819272591, 4351.760653164075, 4388.648908087345, 4391.934120988188, 4617.284320930261, 4647.070585882803, 4653.511381304948, 4654.837080702193, 4699.459562150362, 4935.851924442272, 5062.493750624945, 5074.467180945984, 5079.339685840817, 5137.17805151174, 5070.771815268322, 5076.44159142494, 5080.466551012128, 5098.439171691111, 5110.080185566597, 4718.4809670936165, 4720.787564559603, 4723.881902952419, 4725.716457012591, 4736.573708366263, 4997.400311962515, 5161.793528258902, 5192.792288308426, 5274.657147285414, 5276.155815069647, 5012.523810238022, 5015.874603134951, 5022.924656130161, 5038.168702164176, 5043.84868453947, 5072.416672082684, 5080.237964305384, 5081.974590127025, 5100.974495127575, 5131.7177555234075, 4911.803527858917, 5027.698338099725, 5043.722595257223, 5054.7978080876355, 5104.412992505835, 4957.182064959241, 4971.37857767779, 4972.925406118911, 4973.129702302155, 5017.949820501822, 4190.706650534495, 4195.811188496464, 4201.180769749931, 4242.830286788494, 4248.87253382399, 3678.043708635774, 3713.870014549532, 3743.756655817363, 3775.7734535927934, 3801.3917773156163, 4341.327094300388, 4362.672799540047, 4364.803583838735, 4399.318105693623, 4412.073464572476, 5021.49785021495, 5024.924626130611, 5029.220470827027, 5029.245613158056, 5080.644354895196, 4301.569843015736, 4349.086691794695, 4358.128374325148, 4414.27164517851, 4425.468943726773, 4563.863084107482, 4567.3377360282575, 4590.931136032962, 4593.931091033637, 4639.489656137822, 4855.854324370274, 4880.487548807324, 4880.585150262267, 4887.902241955141, 4928.802847886044, 4908.509149085063, 5003.44962054181, 5021.347224860745, 5068.6451948363265, 5081.695098294114, 4767.880802979953, 4789.784459699392, 4792.664513484023, 4800.447948485829, 4855.75721213945, 4859.198232291774, 4946.950530494649, 4969.701817890938, 4976.726280054631, 5026.271190677405, 5013.498650134958, 5089.592832573459, 5094.490550944876, 5099.592032637454, 5109.284700142058, 4889.779959901742, 4897.338859253955, 4898.559129678346, 4909.140900342354, 4943.283223932582, 4885.047415753894, 4885.633577481774, 4887.535684110004, 4906.9018619626695, 4953.801847926043, 4732.787024583971, 4821.373221481325, 4853.80584776605, 4884.804607815648, 4904.558589726799, 4987.650864439454, 5012.448630650552, 5012.749362531932, 5017.247412888096, 5068.29043933857, 4731.45588257341, 4895.388076490439, 4901.58336541398, 4907.950920490892, 4949.82675606352], "value": 4653.0224386760765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.1270281874368, 595.08060047227, 609.9573029887904, 614.4807637546274, 627.0093252660795, 26401.339966500847, 26976.190714278604, 26979.0, 26997.0, 27029.324266893338, 36883.0, 37970.81014594923, 37990.62009379905, 37995.62004379955, 38027.61972380275, 7699.384049276073, 7881.369490440751, 7906.44654874159, 7908.565028923407, 7912.802179945518, 7281.308275713799, 7690.2694244046725, 7824.413169012319, 9460.290478214127, 9728.075832795874, 9771.26715496337, 9876.061774131445, 9884.061014203638, 9894.30739848211, 9896.25778066648, 9659.082387173208, 9781.90218097817, 9791.461469619167, 9792.804143917117, 9794.314397992144, 7282.563046217191, 9420.905790942072, 9719.708408747678, 9720.513974301257, 9737.318387712863, 32401.351972960645, 33005.33989320224, 33013.17467063318, 33156.50265246023, 33162.6683733162, 3053.7556995440314, 3094.922626934322, 3134.4201322755134, 3153.3377990622, 3540.2919416116624, 27605.447891042266, 27737.445251094865, 28111.156665300074, 28172.859135704395, 29638.70361296381, 3483.3729928613093, 3502.124468882779, 3530.1704099536587, 3535.4166562517153, 3635.363811333006, 157083.0, 158137.0, 158435.0, 158631.0, 159084.0, 29942.25144371408, 51209.743951280005, 52675.73662131742, 52682.73658631682, 52717.736411317695, 31557.0, 31667.683323166475, 31683.683163168535, 31699.04902852918, 31721.20696982594, 12766.0, 12916.160449570747, 13047.543335983195, 13055.0, 13078.476860925457, 9725.61097556104, 10910.290831095954, 11062.944685276683, 11079.279846809932, 11085.889141108486, 7640.770776876702, 7751.1861254568585, 7779.649915753805, 7791.532508049535, 7839.137694853562, 3062.5099984002454, 3120.0795765249304, 3148.6064241969752, 3176.872925083017, 3184.601924759405, 897.9640814367352, 915.8580420034905, 929.7071422502025, 991.6380521109743, 1011.1506334678905, 25326.0, 26437.37832576226, 26916.730832691814, 26978.865105674347, 27043.32391690184, 973.3624475968252, 980.6518685866557, 997.0855956563415, 1082.7509672775147, 1103.3379972016726, 13982.0, 14244.359003844851, 14397.928010359881, 14472.0, 14485.637859053608, 266653.0, 271776.0, 272808.0, 273558.0, 273862.0, 46503.5349646506, 47029.5297047032, 47091.5290847094, 47119.29321060187, 47139.29291060637, 1127.5940661361903, 1140.885911408869, 1222.1078612612664, 1225.3199474291675, 1331.7203387288585, 24264.757352426957, 25257.621135682613, 25969.610455842798, 27008.59487107734, 27117.593236101868, 38612.0, 38762.0, 38959.6104038956, 38985.41521877117, 38994.6100538991, 171352.0, 171513.0, 171770.0, 171963.0, 182386.0, 20448.59102817965, 22888.0, 23234.651480227472, 23406.64890026685, 23498.647520286868, 35687.0, 35930.28139437144, 36557.0, 36567.63432365642, 36950.26099478049, 31065.204131628263, 31097.222569435944, 31210.37579248357, 31502.36995260128, 31761.364772704877, 32257.193570160933, 34134.8293258542, 34162.31675366528, 34501.0, 34789.0, 31936.840315799203, 33698.83150584231, 34047.0, 34180.658193417745, 34360.82819585886, 27094.0, 27123.86438067797, 28798.280042999093, 28979.565306520843, 29366.85316573489, 23934.401639958443, 23936.40158996039, 24020.87989560041, 24201.0, 24607.630885537088], "value": 15443.908074797557, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.46476089781265, 377.94962329363216, 386.65780784006154, 392.81930312056454, 395.30821063139507, 14834.184119873402, 15398.30707618157, 16203.0, 16241.675166496663, 16270.918645406786, 10414.218933579992, 10699.625513107043, 10711.143108551316, 10739.24825262232, 11665.941670291637, 3493.5109084728033, 4627.8148874045, 4703.082898834728, 4787.976060119712, 4815.879603009917, 5140.691558506502, 5391.218273350361, 5412.269343638598, 5414.675119492843, 5440.455954404568, 5399.730013499329, 5402.270693456392, 5404.891902161954, 5424.783008679668, 5586.776528938837, 5829.912551311733, 5973.253343332083, 5994.49046831022, 5997.760089596411, 6004.669743164124, 5176.55999240065, 5190.870228244324, 5196.142636464979, 5265.6577322474295, 5321.946780532223, 17688.557786055324, 18668.719969200472, 19055.142518586697, 19163.425097247105, 19183.712244316346, 1901.8383437407838, 1922.480930148866, 1949.4249196487071, 2003.0385415000735, 2380.8928848085725, 8611.181937715906, 8686.609102590399, 8911.108889111038, 9069.863952040725, 9354.485503297316, 1740.1734176266298, 1744.8604111671036, 1765.6998310287154, 1796.092973048602, 1833.4774589242002, 58692.0, 60367.094493582634, 60408.697956510376, 60958.0, 61171.69414152945, 9099.81800363989, 9121.954390228006, 9198.586063627019, 9211.63153473867, 9354.251659867194, 12486.625401237978, 12579.371031448574, 12614.873851261369, 12616.432260548298, 12627.042808364718, 6790.5246632736225, 6825.761098361533, 6848.417884479775, 6877.105976223159, 6957.06079679247, 6527.086207930894, 6538.411542961061, 6627.801165964932, 6627.933720662828, 6643.833904152435, 3844.519435070616, 3961.7028722845325, 3964.623360780721, 4032.213718324957, 4051.3517837145914, 1593.7290660587728, 1766.3994241957796, 1853.8609604279734, 1860.228005377753, 1883.1431698577114, 855.7646647172078, 881.1937077574077, 881.2597418168641, 892.4600616626977, 961.0869673809908, 15194.544163675107, 15495.690086198212, 15643.530694079196, 15714.29285682147, 16187.271572779253, 875.8423483772982, 898.3621628643606, 915.4278575890069, 928.6424726480353, 933.5099072986736, 8572.657093716181, 9032.548372581345, 9075.319351048698, 9086.409383390059, 9296.0, 277242.0, 281587.0, 363236.0, 365592.0, 367288.0, 59954.40045599488, 61585.69207153936, 63221.68389158025, 63865.361346385944, 64087.03869441962, 923.2227961174846, 947.8483442649281, 952.2096659772373, 961.8653388525472, 963.9710808675751, 14062.718745625234, 14114.082584631966, 14165.150090994573, 14239.786403204167, 14812.111273323635, 31295.0, 32322.0, 32583.185420363734, 32909.34181316408, 33262.83368583238, 39730.40404393994, 41113.79443102885, 43541.346879797464, 43550.0, 44921.32618010798, 7113.395361394132, 7450.739224127129, 7487.0, 7571.280728330799, 7605.543667379975, 9883.0, 11049.226554141454, 11197.552097915992, 11244.493997769956, 11256.155788315746, 9028.864567031369, 9344.579493922654, 9397.624095036123, 9674.951625241829, 9780.902190978284, 9723.222142228746, 9727.319087663796, 9770.706878793648, 9829.213662907094, 9847.359921605073, 9329.860052099088, 9428.481433520948, 9630.566624502055, 9751.268654851056, 9955.601775929172, 7403.777886663193, 7443.292887175709, 7454.366378857858, 7488.625568721651, 7507.099148102263, 9252.768680783034, 9259.953700231725, 9496.335256531976, 9543.9045609543, 9926.205903527556], "value": 7705.201684520979, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1260.8739126087398, 1438.6403399150208, 1460.7589747691632, 1562.1252098824652, 1723.517415123765, 6413.454856337211, 6670.666466676665, 6904.792856214309, 6908.412784913288, 6936.514443988923, 6559.672016399173, 6781.35577120174, 6788.796336109925, 6793.286704895989, 6804.693788779505, 1925.894075825829, 2151.9139234430604, 2159.6112699714045, 2198.4943463003438, 2232.0, 2211.447138215446, 2222.9666555001686, 2229.3869185973826, 2230.7323121225477, 2234.7876951689564, 2146.152269853407, 2191.736991561007, 2206.8013878750908, 2208.0726095040122, 2209.5801797658473, 1915.4923945154544, 2146.5384942237415, 2224.8665080095248, 2230.2863083813186, 2230.7546169921297, 2084.2600876688707, 2127.297991662748, 2131.1688441507827, 2133.775953524873, 2136.1882484655885, 6663.800085997428, 6791.252962174157, 6797.966010169967, 6799.048133261347, 6832.180138383425, 4348.695591308609, 4492.393526873863, 4493.168763778712, 4497.168023915553, 4502.144592527409, 2811.7891158163015, 2841.801073924826, 2913.985430072857, 2932.29624890027, 2968.361802212513, 903.7108125399875, 923.5151545438631, 930.8836395450569, 963.6145541783272, 966.8308046091976, 9017.504037277948, 9192.44845309277, 9224.8616270756, 9229.584668689926, 9240.630374785, 4151.916961660811, 4279.572042795696, 4304.80628371724, 4382.189294980439, 4382.956170438319, 8174.427790054639, 8199.139090395423, 8211.548364839871, 8216.301614362726, 8222.259996600334, 4156.418101465797, 4554.0664163847, 4559.430071241095, 4564.360989461478, 4567.840125595588, 4073.2057248836786, 4179.874603761892, 4192.119654872511, 4205.3271476563605, 4205.726627769246, 3464.9653503465147, 3514.332276867387, 3561.6972557332397, 3570.393033184365, 3594.191306955914, 1227.96930076747, 1246.9438875250635, 1255.3409460033556, 1255.4601521345726, 1262.3498898067503, 685.5715178013742, 832.138736407815, 838.2078935405983, 846.4117438380266, 859.1666083898608, 4708.88227794301, 4861.222204447272, 4869.853904382874, 4873.610111191097, 4951.984843107154, 395.2490268489835, 411.77352456149, 413.4253387790973, 415.7962598326798, 426.22852636727623, 3166.7149956504027, 3341.4820702791108, 3368.781029233092, 3381.746369022333, 3401.8129002904584, 8092.878606820902, 8429.241368276884, 8442.873356899652, 8493.0, 8505.787355316166, 8366.79083022917, 8435.578221088921, 8445.155484451505, 8459.492430454193, 8481.575921203916, 6590.176227971504, 6752.3922846944015, 6755.560888542229, 6758.087658166085, 6763.966180169067, 4651.511591282867, 4726.62187025044, 4874.147024270809, 4895.290182923527, 4938.30863679078, 7589.506682065648, 7882.369410447265, 7887.526748395115, 7887.763367098996, 7972.402069844668, 7821.413393995587, 8121.715739949073, 8130.186981301823, 8155.0, 8180.67277308901, 5968.731407086779, 6217.191765070512, 6226.59527130735, 6352.396522330371, 6414.230292364946, 6746.797596072126, 6835.179778426621, 6844.93155068443, 6891.724331026703, 6898.896516552356, 6130.47890929276, 6289.308176100717, 6336.493080553637, 6393.648349340645, 6396.904046439214, 5993.460588547052, 6139.201903752483, 6157.784477543264, 6289.96855015722, 6339.841503962438, 5789.45000224978, 5845.1232315153065, 5859.824205273849, 5876.97152998215, 5880.794172203952, 4363.127374525045, 4368.082702632482, 4414.3157810539415, 4431.135928493913, 4451.866444006685, 4357.607815296638, 4385.583369579885, 4390.0, 4470.038941627566, 4547.295169248771], "value": 3838.253568811227, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.9404119176164, 313.17634620946905, 315.30789916134097, 316.6548462176227, 319.2848020434228, 4512.932306015404, 4712.76436178191, 4736.573708366246, 4767.64242681799, 4772.737499437534, 4525.456945166585, 4669.6731228814, 4704.200285951388, 4721.693089949151, 4724.543237516489, 3772.320982223192, 3791.33651610967, 3794.1083845296334, 3809.5238095238096, 3812.618738126193, 3630.6006339302658, 3703.2038111805955, 3800.638939300762, 3809.56190038145, 3838.8080595970227, 3798.4872042274214, 3805.9809700951455, 3816.9045773855737, 3817.331966905794, 3834.328992426328, 3756.1924186300075, 3756.9624303756887, 3771.924561508782, 3772.566154892181, 3793.3551296279425, 3389.2204792897523, 3405.676460736226, 3408.386490431721, 3412.1128506588216, 3433.6223015468277, 4475.970526778827, 4522.638188944877, 4524.61540769035, 4527.796249168795, 4546.65900057497, 4266.146770645883, 4294.938429553832, 4299.6775241856985, 4307.3108302671735, 4311.547287534827, 4931.605471562267, 4948.356713627241, 4951.306817045616, 4962.851114466572, 4964.230544265644, 3537.876174333886, 3672.3022625701033, 3672.338978983782, 3679.4848721179055, 3682.834272457746, 5171.456997015334, 5192.402873669501, 5209.166533354645, 5231.633785635046, 5245.160774276135, 3768.340540405418, 3775.131719704483, 3784.110733977513, 3786.8863934082024, 3790.166163444038, 3838.788866612307, 3849.5188101487315, 3859.614038596118, 3859.9035024124623, 3860.9227815443533, 3936.389859571771, 4187.120704652058, 4197.916041679149, 4203.348480985452, 4204.831806727758, 4971.627127965345, 4985.45450910219, 5005.074061298671, 5020.924686129711, 5030.220315851049, 1275.183882315319, 1309.541660418865, 1346.5690978886857, 1350.7973803929292, 1355.8440779310308, 891.4740303221131, 903.9819203615891, 910.2217603948661, 915.7527467583849, 919.1773362840354, 4662.650301227422, 4668.836590719308, 4679.298105284167, 4679.344891715163, 4680.648951328664, 5309.8938021239355, 5347.946520534745, 5377.7580008899695, 5380.973095134499, 5397.595180361489, 4557.45310562728, 4611.723296602215, 4623.8844028898875, 4624.329472226508, 4637.1421287062, 2862.799604027698, 2865.412590418959, 2870.62681851358, 2880.524713422262, 2894.073896353189, 5075.441701412841, 5126.615503837227, 5132.050570644443, 5149.562287205555, 5178.559822415062, 5009.874753131201, 5338.252644629755, 5530.446955304518, 5544.085225937756, 5564.33228012641, 4931.827386041399, 4971.527704868032, 4972.129877271535, 4973.477784832613, 4975.029869175476, 5158.3552055993005, 5166.4058633257655, 5167.501424586828, 5182.507661772125, 5184.870378240575, 4896.559309662148, 5064.240363945438, 5065.517896230894, 5092.745362731923, 5093.567046801063, 4921.50784921505, 4949.381327334083, 4953.628477864103, 4969.378827646544, 4987.950120498748, 3645.908852278714, 3663.798491083016, 3674.9710081177313, 3695.3533131701306, 3704.83328250224, 4897.95102048975, 4934.284528743384, 5141.948580514147, 5180.922286165635, 5187.299714538489, 4829.372181616367, 4976.929960058605, 5036.924446133237, 5047.2429135629945, 5060.392752869532, 5002.974985125051, 5007.273945277841, 5029.74851257443, 5033.697978121178, 5056.0, 4840.95159048405, 4904.141775189399, 4974.129527332775, 4976.452590215001, 4996.225585034325, 5015.0, 5019.0965626187635, 5021.146405111067, 5036.370453693288, 5044.4451110377095, 4879.0, 4901.607871370211, 4924.581410579997, 4946.802127914987, 4948.975255123702], "value": 3839.4247881389865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.2160211751191, 673.0678010954829, 750.8798592225244, 769.8999130113084, 785.8035491127218, 11293.548258069677, 13146.934265328671, 13594.932025339871, 13603.727925441484, 13628.454861805541, 13448.932755336235, 13490.392932318045, 13519.864801351983, 13538.255395953218, 13556.728865422685, 641.5701480008405, 788.7318311773996, 812.618069507332, 822.7079386817653, 829.8921140251758, 823.3783493462428, 824.5629816197425, 825.9876101858476, 827.6482494939656, 828.7886588919818, 850.6554845287668, 856.7729551668813, 857.0486759696763, 857.8670306102564, 858.0, 664.40203816565, 682.952193346466, 683.3371629519359, 821.1624143373725, 851.5827244650138, 618.5391883047114, 618.9659568723719, 619.1239396254294, 619.3837132053635, 619.5786864931845, 12602.306873121976, 12641.810372844415, 12643.304618246084, 12647.683807904876, 12664.6833829155, 11338.319700817978, 11654.883451165464, 11861.347625880573, 11994.0, 12178.878211217863, 9631.0, 9686.70939871805, 9746.171575416098, 9830.262730295257, 9838.852417213748, 3271.4111459937203, 3276.705096541299, 3308.387948229585, 3311.2053107254087, 3382.0868365541164, 46999.5300047002, 47864.5213547867, 48046.0, 48400.0, 48523.0, 9466.337356385126, 9905.504724763732, 9909.0, 10030.348027378197, 10039.297249192632, 16045.839541604435, 16237.431689890796, 16237.59406014859, 16273.10497922602, 16279.348826047062, 6490.513211509156, 6659.9001014984815, 6824.965875170592, 6984.511084224056, 7136.607486588184, 3867.7292589518465, 3897.2595206910596, 3935.822887970048, 3937.7243592948794, 3958.762474251554, 2787.456445993012, 2875.3386721054276, 2881.1788640237432, 2881.5677648352917, 2886.956695649567, 491.14785846556197, 497.4677095507772, 504.17063929835217, 508.8015673887187, 514.9742512874342, 467.48576565777375, 592.6088781404253, 607.6900780601925, 619.1857707115129, 626.9373062693694, 8571.142885711504, 8946.433255628635, 9002.86495702565, 9122.908770912207, 9138.543072846463, 614.5513774944316, 626.2516293029877, 631.009315374857, 645.3243721469686, 646.4462752734314, 3229.4187046331417, 3268.1176082457605, 3346.5816772903386, 3367.9326413471595, 3380.2225488137374, 51653.741731291106, 55597.0, 57057.0, 57146.71426642923, 57164.42835571591, 48125.0, 49778.75110624496, 49921.50078499169, 51271.74364128155, 51963.48036519662, 46735.99999999932, 47032.0, 47114.29328560075, 47166.0, 47171.52828471671, 7179.425645948416, 7247.2041180003425, 7317.670704818403, 7333.926660733538, 7407.444441666788, 29733.256668583457, 29848.850755746083, 30338.696613033586, 30787.0, 30839.845800770854, 36627.0, 37704.43443348297, 38056.80971595124, 40410.797946011255, 41575.0, 10727.19546034035, 10759.462026898467, 10831.404272765074, 10890.945545272223, 11212.887871121184, 12351.69120771988, 12369.196002259825, 12428.502859885864, 12509.0, 12880.484780608671, 9940.850887236842, 10597.89402105969, 10944.671659850217, 11044.226904116957, 11536.192466527262, 10845.295055821347, 11105.167112466435, 11503.0, 11615.825762613737, 11660.18378713482, 11321.150913681342, 11332.433378331216, 11425.143114266297, 11910.821337680116, 11973.940130299292, 9460.668876589287, 9621.56702948355, 9796.755081123029, 9842.901570984484, 10083.092521673085, 9794.951025244829, 9941.403515789076, 9989.700308990452, 10026.498675066363, 10075.395476271447], "value": 6009.446063498514, "unit": "score"}], "name": "dromaeo_css", "value": 6050.05577658376, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 109.0, 114.0, 114.0, 115.0, 103.0, 113.0, 113.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 159.0, 183.0, 142.0, 153.0, 159.0, 131.0, 190.0, 136.0], "value": 154.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 160.0, 161.0, 161.0, 162.0, 160.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 106.0, 121.0, 73.0, 72.0, 74.0, 115.0, 115.0, 73.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 135.0, 95.0, 94.0, 95.0, 148.0, 93.0, 94.0, 143.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 63.0, 64.0, 67.0, 85.0, 62.0, 61.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 82.0, 63.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 78.0, 78.0, 78.0, 81.0, 81.0, 79.0, 80.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 138.0, 133.0, 134.0, 133.0, 133.0, 134.0, 179.0, 134.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 219.0, 211.0, 213.0, 212.0, 214.0, 211.0, 212.0, 215.0, 214.0], "value": 213.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 74.0, 73.0, 73.0, 74.0, 75.0, 73.0, 74.0, 71.0], "value": 74.5, "unit": "score"}], "name": "kraken", "value": 1621.1999999999996, "alertThreshold": 2.0}]} 04:47:25 INFO - Return code: 0 04:47:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:47:25 ERROR - # TBPL SUCCESS # 04:47:25 INFO - Running post-action listener: _resource_record_post_action 04:47:25 INFO - Running post-run listener: _resource_record_post_run 04:47:26 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 518643712; Read time: 176; Write time: 391584 04:47:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 234586112; Read time: 0; Write time: 194976 04:47:26 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284057600; Read time: 176; Write time: 196608 04:47:26 INFO - Running post-run listener: _upload_blobber_files 04:47:26 INFO - Blob upload gear active. 04:47:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:47:26 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 04:47:26 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:47:26 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:47:27 INFO - (blobuploader) - INFO - Open directory for files ... 04:47:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:47:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:47:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:28 INFO - (blobuploader) - INFO - Done attempting. 04:47:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:47:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:47:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:28 INFO - (blobuploader) - INFO - Done attempting. 04:47:28 INFO - (blobuploader) - INFO - Iteration through files over. 04:47:28 INFO - Return code: 0 04:47:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:47:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:47:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d615fc809e413fa22da2c8845f5a3e532457b0b589571baeda8f61d6db130266ec47aaa015d36d2933140888ccc6e07d31b2dafa0c8d6e1fec7b9ba471648ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0709f57f77540e44d3b9589dbabcce0e3a1b89526ca6d04960d0d23cfaf434572dced4a83cf41996960a4d47a90a1776f13e42ae117db947d2d0c0c6a9e23893"} 04:47:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:47:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:47:28 INFO - Contents: 04:47:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d615fc809e413fa22da2c8845f5a3e532457b0b589571baeda8f61d6db130266ec47aaa015d36d2933140888ccc6e07d31b2dafa0c8d6e1fec7b9ba471648ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0709f57f77540e44d3b9589dbabcce0e3a1b89526ca6d04960d0d23cfaf434572dced4a83cf41996960a4d47a90a1776f13e42ae117db947d2d0c0c6a9e23893"} 04:47:28 INFO - Running post-run listener: copy_logs_to_upload_dir 04:47:28 INFO - Copying logs to upload dir... 04:47:28 INFO - mkdir: /builds/slave/test/build/upload/logs 04:47:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.578688 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-27 04:47:27.059185) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:47:27.063088) ========= 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=ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d615fc809e413fa22da2c8845f5a3e532457b0b589571baeda8f61d6db130266ec47aaa015d36d2933140888ccc6e07d31b2dafa0c8d6e1fec7b9ba471648ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0709f57f77540e44d3b9589dbabcce0e3a1b89526ca6d04960d0d23cfaf434572dced4a83cf41996960a4d47a90a1776f13e42ae117db947d2d0c0c6a9e23893"} build_url:https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/P7Aih8UYQuujzYm6VvMKgw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d615fc809e413fa22da2c8845f5a3e532457b0b589571baeda8f61d6db130266ec47aaa015d36d2933140888ccc6e07d31b2dafa0c8d6e1fec7b9ba471648ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0709f57f77540e44d3b9589dbabcce0e3a1b89526ca6d04960d0d23cfaf434572dced4a83cf41996960a4d47a90a1776f13e42ae117db947d2d0c0c6a9e23893"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:47:27.088205) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:47:27.088537) ========= 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=ed14279e38b05397cf4aa391000001a4-1461756398.497112-315772475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:47:27.172676) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:47:27.173280) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:47:27.173605) ========= ========= Total master_lag: 0.17 =========