builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1461493052.82 results: success (0) buildid: 20160424004019 builduid: 69a4a2db58f0465d9c89914df6199b39 revision: 08791c3d6f713f4032f704e44bae22353bbdae77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:32.824061) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:32.824436) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:32.824698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:32.862975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:32.863215) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-24 03:17:33-- 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% 47.6M=0s 2016-04-24 03:17:33 (47.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:33.022873) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:33.023158) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022149 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:33.072639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:33.072927) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 08791c3d6f713f4032f704e44bae22353bbdae77 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 08791c3d6f713f4032f704e44bae22353bbdae77 --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=a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-24 03:17:33,746 truncating revision to first 12 chars 2016-04-24 03:17:33,746 Setting DEBUG logging. 2016-04-24 03:17:33,746 attempt 1/10 2016-04-24 03:17:33,746 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/08791c3d6f71?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 03:17:34,028 unpacking tar archive at: mozilla-aurora-08791c3d6f71/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616877 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:33.702012) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:33.702310) ========= script_repo_revision: 08791c3d6f713f4032f704e44bae22353bbdae77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:33.702695) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:33.702952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 03:17:33.711612) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-24 03:17:33.711878) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:17:34 INFO - MultiFileLogger online at 20160424 03:17:34 in /builds/slave/test 03:17:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:17:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:17:34 INFO - {'append_to_log': False, 03:17:34 INFO - 'base_work_dir': '/builds/slave/test', 03:17:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:17:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:17:34 INFO - 'branch': 'Mozilla-Aurora', 03:17:34 INFO - 'buildbot_json_path': 'buildprops.json', 03:17:34 INFO - 'config_files': ('talos/linux_config.py',), 03:17:34 INFO - 'default_actions': ('clobber', 03:17:34 INFO - 'read-buildbot-config', 03:17:34 INFO - 'download-and-extract', 03:17:34 INFO - 'populate-webroot', 03:17:34 INFO - 'create-virtualenv', 03:17:34 INFO - 'install', 03:17:34 INFO - 'run-tests'), 03:17:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:17:34 INFO - 'download_minidump_stackwalk': True, 03:17:34 INFO - 'download_symbols': 'ondemand', 03:17:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:17:34 INFO - 'tooltool.py': '/tools/tooltool.py', 03:17:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:17:34 INFO - '/tools/misc-python/virtualenv.py')}, 03:17:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:17:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:17:34 INFO - 'installer_path': 'installer.exe', 03:17:34 INFO - 'log_level': 'info', 03:17:34 INFO - 'log_name': 'talos', 03:17:34 INFO - 'log_to_console': True, 03:17:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:17:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:17:34 INFO - 'opt_config_files': (), 03:17:34 INFO - 'pip_index': False, 03:17:34 INFO - 'sps_profile': False, 03:17:34 INFO - 'sps_profile_interval': 0, 03:17:34 INFO - 'suite': 'dromaeojs', 03:17:34 INFO - 'system_bits': '32', 03:17:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:17:34 INFO - 'title': 'talos-linux64-ix-062', 03:17:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:17:34 INFO - 'use_talos_json': True, 03:17:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:17:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:17:34 INFO - 'work_dir': 'build'} 03:17:34 INFO - ##### 03:17:34 INFO - ##### Running clobber step. 03:17:34 INFO - ##### 03:17:34 INFO - Running pre-action listener: _resource_record_pre_action 03:17:34 INFO - Running main action method: clobber 03:17:34 INFO - rmtree: /builds/slave/test/build 03:17:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:17:34 INFO - Running post-action listener: _resource_record_post_action 03:17:34 INFO - ##### 03:17:34 INFO - ##### Running read-buildbot-config step. 03:17:34 INFO - ##### 03:17:34 INFO - Running pre-action listener: _resource_record_pre_action 03:17:34 INFO - Running main action method: read_buildbot_config 03:17:34 INFO - Using buildbot properties: 03:17:34 INFO - { 03:17:34 INFO - "project": "", 03:17:34 INFO - "product": "firefox", 03:17:34 INFO - "script_repo_revision": "production", 03:17:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:17:34 INFO - "repository": "", 03:17:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:17:34 INFO - "buildid": "20160424004019", 03:17:34 INFO - "stage_platform": "linux64-pgo", 03:17:34 INFO - "basedir": "/builds/slave/test", 03:17:34 INFO - "nightly_build": "True", 03:17:34 INFO - "buildnumber": 281, 03:17:34 INFO - "slavename": "talos-linux64-ix-062", 03:17:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:17:34 INFO - "platform": "ubuntu64_hw", 03:17:34 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:17:34 INFO - "branch": "mozilla-aurora", 03:17:34 INFO - "repo_path": "releases/mozilla-aurora", 03:17:34 INFO - "revision": "08791c3d6f713f4032f704e44bae22353bbdae77", 03:17:34 INFO - "pgo_build": "True", 03:17:34 INFO - "builduid": "69a4a2db58f0465d9c89914df6199b39", 03:17:34 INFO - "slavebuilddir": "test" 03:17:34 INFO - } 03:17:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:17:34 INFO - Running post-action listener: _resource_record_post_action 03:17:34 INFO - ##### 03:17:34 INFO - ##### Running download-and-extract step. 03:17:34 INFO - ##### 03:17:34 INFO - Running pre-action listener: _resource_record_pre_action 03:17:34 INFO - Running main action method: download_and_extract 03:17:34 INFO - mkdir: /builds/slave/test/build/tests 03:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:34 INFO - https://queue.taskcluster.net/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:17:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:17:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:17:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:17:36 INFO - Downloaded 1448 bytes. 03:17:36 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:17:36 INFO - Using the following test package requirements: 03:17:36 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:17:36 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:36 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:17:36 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:36 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:17:36 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:36 INFO - u'jsshell-linux-x86_64.zip'], 03:17:36 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:36 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:17:36 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:17:36 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:36 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:17:36 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:36 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:17:36 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:36 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:17:36 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:17:36 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:36 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:17:36 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:36 INFO - https://queue.taskcluster.net/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:17:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:17:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:17:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:17:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:17:37 INFO - Downloaded 23358873 bytes. 03:17:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:17:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:17:39 INFO - Return code: 0 03:17:39 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:39 INFO - https://queue.taskcluster.net/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:17:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:17:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:17:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:17:40 INFO - Downloaded 23358873 bytes. 03:17:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:17:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:17:41 INFO - Return code: 0 03:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:41 INFO - https://queue.taskcluster.net/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:17:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:17:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:17:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:17:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:17:43 INFO - Downloaded 10845194 bytes. 03:17:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:17:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:17:43 INFO - Return code: 0 03:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:43 INFO - https://queue.taskcluster.net/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:17:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:17:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:17:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:17:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:17:46 INFO - Downloaded 60830786 bytes. 03:17:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:17:46 INFO - mkdir: /builds/slave/test/properties 03:17:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:17:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:17:46 INFO - Contents: 03:17:46 INFO - build_url:https://queue.taskcluster.net/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:17:46 INFO - Running post-action listener: _resource_record_post_action 03:17:46 INFO - Running post-action listener: set_extra_try_arguments 03:17:46 INFO - ##### 03:17:46 INFO - ##### Running populate-webroot step. 03:17:46 INFO - ##### 03:17:46 INFO - Running pre-action listener: _resource_record_pre_action 03:17:46 INFO - Running main action method: populate_webroot 03:17:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:17:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:17:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:17:46 INFO - '--tppagecycles', 03:17:46 INFO - '7'], 03:17:46 INFO - 'tests': ['tsvgm']}}, 03:17:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:17:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:17:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:17:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:17:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'tests': ['damp', 'tps']}, 03:17:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['damp', 'tps']}, 03:17:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:17:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:17:46 INFO - 'other': {'tests': ['a11yr', 03:17:46 INFO - 'ts_paint', 03:17:46 INFO - 'tpaint', 03:17:46 INFO - 'sessionrestore', 03:17:46 INFO - 'sessionrestore_no_auto_restore', 03:17:46 INFO - 'tabpaint']}, 03:17:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['a11yr', 03:17:46 INFO - 'ts_paint', 03:17:46 INFO - 'tpaint', 03:17:46 INFO - 'sessionrestore', 03:17:46 INFO - 'sessionrestore_no_auto_restore', 03:17:46 INFO - 'tabpaint']}, 03:17:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['a11yr', 03:17:46 INFO - 'ts_paint', 03:17:46 INFO - 'tpaint', 03:17:46 INFO - 'sessionrestore', 03:17:46 INFO - 'sessionrestore_no_auto_restore', 03:17:46 INFO - 'tabpaint']}, 03:17:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['a11yr', 03:17:46 INFO - 'ts_paint', 03:17:46 INFO - 'tpaint', 03:17:46 INFO - 'sessionrestore', 03:17:46 INFO - 'sessionrestore_no_auto_restore', 03:17:46 INFO - 'tabpaint']}, 03:17:46 INFO - 'other_l64': {'tests': ['a11yr', 03:17:46 INFO - 'ts_paint', 03:17:46 INFO - 'tpaint', 03:17:46 INFO - 'sessionrestore', 03:17:46 INFO - 'sessionrestore_no_auto_restore', 03:17:46 INFO - 'tabpaint']}, 03:17:46 INFO - 'other_nol64': {'tests': ['a11yr', 03:17:46 INFO - 'ts_paint', 03:17:46 INFO - 'tpaint', 03:17:46 INFO - 'sessionrestore', 03:17:46 INFO - 'sessionrestore_no_auto_restore', 03:17:46 INFO - 'tabpaint']}, 03:17:46 INFO - 'svgr': {'tests': ['tsvgx', 03:17:46 INFO - 'tsvgr_opacity', 03:17:46 INFO - 'tart', 03:17:46 INFO - 'tscrollx', 03:17:46 INFO - 'cart']}, 03:17:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['tsvgx', 03:17:46 INFO - 'tsvgr_opacity', 03:17:46 INFO - 'tart', 03:17:46 INFO - 'tscrollx', 03:17:46 INFO - 'cart']}, 03:17:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'tests': ['tp5o']}, 03:17:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['tp5o']}, 03:17:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'talos_options': ['--xperf_path', 03:17:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:46 INFO - 'tests': ['tp5n']}, 03:17:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'talos_options': ['--e10s', 03:17:46 INFO - '--xperf_path', 03:17:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:46 INFO - 'tests': ['tp5n']}}, 03:17:46 INFO - 'talos.zip': {'path': '', 03:17:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:17:46 INFO - Running post-action listener: _resource_record_post_action 03:17:46 INFO - ##### 03:17:46 INFO - ##### Running create-virtualenv step. 03:17:46 INFO - ##### 03:17:46 INFO - Running pre-action listener: _resource_record_pre_action 03:17:46 INFO - Running main action method: create_virtualenv 03:17:46 INFO - Creating virtualenv /builds/slave/test/build/venv 03:17:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:17:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:17:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:17:47 INFO - Using real prefix '/usr' 03:17:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:17:47 INFO - Installing distribute.............................................................................................................................................................................................done. 03:17:49 INFO - Installing pip.................done. 03:17:49 INFO - Return code: 0 03:17:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8656cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d160>, '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 0x1d3e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:17:49 INFO - Using env: {'DISPLAY': ':0', 03:17:49 INFO - 'HOME': '/home/cltbld', 03:17:49 INFO - 'LANG': 'en_US.UTF-8', 03:17:49 INFO - 'LANGUAGE': 'en_US:en', 03:17:49 INFO - 'LOGNAME': 'cltbld', 03:17:49 INFO - 'MAIL': '/var/mail/cltbld', 03:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:49 INFO - 'MOZ_NO_REMOTE': '1', 03:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:49 INFO - 'NO_EM_RESTART': '1', 03:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:49 INFO - 'PWD': '/builds/slave/test', 03:17:49 INFO - 'SHELL': '/bin/bash', 03:17:49 INFO - 'SHLVL': '1', 03:17:49 INFO - 'TERM': 'linux', 03:17:49 INFO - 'TMOUT': '86400', 03:17:49 INFO - 'USER': 'cltbld', 03:17:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 03:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:49 INFO - '_': '/tools/buildbot/bin/python'} 03:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:17:49 INFO - Cleaning up... 03:17:49 INFO - Return code: 0 03:17:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8656cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d160>, '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 0x1d3e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:17:49 INFO - Using env: {'DISPLAY': ':0', 03:17:49 INFO - 'HOME': '/home/cltbld', 03:17:49 INFO - 'LANG': 'en_US.UTF-8', 03:17:49 INFO - 'LANGUAGE': 'en_US:en', 03:17:49 INFO - 'LOGNAME': 'cltbld', 03:17:49 INFO - 'MAIL': '/var/mail/cltbld', 03:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:49 INFO - 'MOZ_NO_REMOTE': '1', 03:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:49 INFO - 'NO_EM_RESTART': '1', 03:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:49 INFO - 'PWD': '/builds/slave/test', 03:17:49 INFO - 'SHELL': '/bin/bash', 03:17:49 INFO - 'SHLVL': '1', 03:17:49 INFO - 'TERM': 'linux', 03:17:49 INFO - 'TMOUT': '86400', 03:17:49 INFO - 'USER': 'cltbld', 03:17:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 03:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:49 INFO - '_': '/tools/buildbot/bin/python'} 03:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:49 INFO - Downloading/unpacking psutil>=0.7.1 03:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:17:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:51 INFO - Installing collected packages: psutil 03:17:51 INFO - Running setup.py install for psutil 03:17:51 INFO - building 'psutil._psutil_linux' extension 03:17:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:17:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:17:52 INFO - building 'psutil._psutil_posix' extension 03:17:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:17:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:17:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:52 INFO - Successfully installed psutil 03:17:52 INFO - Cleaning up... 03:17:52 INFO - Return code: 0 03:17:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8656cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d160>, '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 0x1d3e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:17:52 INFO - Using env: {'DISPLAY': ':0', 03:17:52 INFO - 'HOME': '/home/cltbld', 03:17:52 INFO - 'LANG': 'en_US.UTF-8', 03:17:52 INFO - 'LANGUAGE': 'en_US:en', 03:17:52 INFO - 'LOGNAME': 'cltbld', 03:17:52 INFO - 'MAIL': '/var/mail/cltbld', 03:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:52 INFO - 'MOZ_NO_REMOTE': '1', 03:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:52 INFO - 'NO_EM_RESTART': '1', 03:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:52 INFO - 'PWD': '/builds/slave/test', 03:17:52 INFO - 'SHELL': '/bin/bash', 03:17:52 INFO - 'SHLVL': '1', 03:17:52 INFO - 'TERM': 'linux', 03:17:52 INFO - 'TMOUT': '86400', 03:17:52 INFO - 'USER': 'cltbld', 03:17:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 03:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:52 INFO - '_': '/tools/buildbot/bin/python'} 03:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:17:54 INFO - Installing collected packages: mozsystemmonitor 03:17:54 INFO - Running setup.py install for mozsystemmonitor 03:17:54 INFO - Successfully installed mozsystemmonitor 03:17:54 INFO - Cleaning up... 03:17:54 INFO - Return code: 0 03:17:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8656cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d160>, '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 0x1d3e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:17:54 INFO - Using env: {'DISPLAY': ':0', 03:17:54 INFO - 'HOME': '/home/cltbld', 03:17:54 INFO - 'LANG': 'en_US.UTF-8', 03:17:54 INFO - 'LANGUAGE': 'en_US:en', 03:17:54 INFO - 'LOGNAME': 'cltbld', 03:17:54 INFO - 'MAIL': '/var/mail/cltbld', 03:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:54 INFO - 'MOZ_NO_REMOTE': '1', 03:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:54 INFO - 'NO_EM_RESTART': '1', 03:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:54 INFO - 'PWD': '/builds/slave/test', 03:17:54 INFO - 'SHELL': '/bin/bash', 03:17:54 INFO - 'SHLVL': '1', 03:17:54 INFO - 'TERM': 'linux', 03:17:54 INFO - 'TMOUT': '86400', 03:17:54 INFO - 'USER': 'cltbld', 03:17:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 03:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:54 INFO - '_': '/tools/buildbot/bin/python'} 03:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:56 INFO - Downloading blobuploader-1.2.4.tar.gz 03:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:17:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:17:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:57 INFO - Downloading docopt-0.6.1.tar.gz 03:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:17:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:17:57 INFO - Running setup.py install for blobuploader 03:17:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:17:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:17:57 INFO - Running setup.py install for requests 03:17:58 INFO - Running setup.py install for docopt 03:17:58 INFO - Successfully installed blobuploader requests docopt 03:17:58 INFO - Cleaning up... 03:17:58 INFO - Return code: 0 03:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8656cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d160>, '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 0x1d3e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:17:58 INFO - Using env: {'DISPLAY': ':0', 03:17:58 INFO - 'HOME': '/home/cltbld', 03:17:58 INFO - 'LANG': 'en_US.UTF-8', 03:17:58 INFO - 'LANGUAGE': 'en_US:en', 03:17:58 INFO - 'LOGNAME': 'cltbld', 03:17:58 INFO - 'MAIL': '/var/mail/cltbld', 03:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:58 INFO - 'MOZ_NO_REMOTE': '1', 03:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:58 INFO - 'NO_EM_RESTART': '1', 03:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:58 INFO - 'PWD': '/builds/slave/test', 03:17:58 INFO - 'SHELL': '/bin/bash', 03:17:58 INFO - 'SHLVL': '1', 03:17:58 INFO - 'TERM': 'linux', 03:17:58 INFO - 'TMOUT': '86400', 03:17:58 INFO - 'USER': 'cltbld', 03:17:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 03:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:58 INFO - '_': '/tools/buildbot/bin/python'} 03:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:58 INFO - Running setup.py (path:/tmp/pip-Iwq2pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:58 INFO - Running setup.py (path:/tmp/pip-Hh15qG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:58 INFO - Running setup.py (path:/tmp/pip-kK9PdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:58 INFO - Running setup.py (path:/tmp/pip-HteIUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:58 INFO - Running setup.py (path:/tmp/pip-Nvgcms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:58 INFO - Running setup.py (path:/tmp/pip-RyoHVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:58 INFO - Running setup.py (path:/tmp/pip-evAh1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:58 INFO - Running setup.py (path:/tmp/pip-Av_LXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:59 INFO - Running setup.py (path:/tmp/pip-F3IGQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:59 INFO - Running setup.py (path:/tmp/pip-yf5v1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:59 INFO - Running setup.py (path:/tmp/pip-qARSS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:59 INFO - Running setup.py (path:/tmp/pip-T95NRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:59 INFO - Running setup.py (path:/tmp/pip-UAJIx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:59 INFO - Running setup.py (path:/tmp/pip-eVYYz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:59 INFO - Running setup.py (path:/tmp/pip-cBdnUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:59 INFO - Running setup.py (path:/tmp/pip-D_oeD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:59 INFO - Running setup.py (path:/tmp/pip-Eke6QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:17:59 INFO - Running setup.py install for manifestparser 03:17:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:17:59 INFO - Running setup.py install for mozcrash 03:17:59 INFO - Running setup.py install for mozdebug 03:17:59 INFO - Running setup.py install for mozdevice 03:18:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Running setup.py install for mozfile 03:18:00 INFO - Running setup.py install for mozhttpd 03:18:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Running setup.py install for mozinfo 03:18:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Running setup.py install for mozInstall 03:18:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Running setup.py install for mozleak 03:18:00 INFO - Running setup.py install for mozlog 03:18:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Running setup.py install for moznetwork 03:18:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Running setup.py install for mozprocess 03:18:00 INFO - Running setup.py install for mozprofile 03:18:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Running setup.py install for mozrunner 03:18:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Running setup.py install for mozscreenshot 03:18:01 INFO - Running setup.py install for moztest 03:18:01 INFO - Running setup.py install for mozversion 03:18:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:18:01 INFO - Cleaning up... 03:18:01 INFO - Return code: 0 03:18:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8656cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d160>, '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 0x1d3e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:18:01 INFO - Using env: {'DISPLAY': ':0', 03:18:01 INFO - 'HOME': '/home/cltbld', 03:18:01 INFO - 'LANG': 'en_US.UTF-8', 03:18:01 INFO - 'LANGUAGE': 'en_US:en', 03:18:01 INFO - 'LOGNAME': 'cltbld', 03:18:01 INFO - 'MAIL': '/var/mail/cltbld', 03:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:01 INFO - 'MOZ_NO_REMOTE': '1', 03:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:01 INFO - 'NO_EM_RESTART': '1', 03:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:01 INFO - 'PWD': '/builds/slave/test', 03:18:01 INFO - 'SHELL': '/bin/bash', 03:18:01 INFO - 'SHLVL': '1', 03:18:01 INFO - 'TERM': 'linux', 03:18:01 INFO - 'TMOUT': '86400', 03:18:01 INFO - 'USER': 'cltbld', 03:18:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 03:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:01 INFO - '_': '/tools/buildbot/bin/python'} 03:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:01 INFO - Running setup.py (path:/tmp/pip-B_Dpdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:01 INFO - Running setup.py (path:/tmp/pip-4GgK60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:01 INFO - Running setup.py (path:/tmp/pip-sW_vOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:01 INFO - Running setup.py (path:/tmp/pip-UpZ91B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:01 INFO - Running setup.py (path:/tmp/pip-fIcmnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:02 INFO - Running setup.py (path:/tmp/pip-J7D0D3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:02 INFO - Running setup.py (path:/tmp/pip-jFaulo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:02 INFO - Running setup.py (path:/tmp/pip-EUpCeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:02 INFO - Running setup.py (path:/tmp/pip-97Vg96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:02 INFO - Running setup.py (path:/tmp/pip-tG5wsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:02 INFO - Running setup.py (path:/tmp/pip-y4Xdb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:02 INFO - Running setup.py (path:/tmp/pip-YiRIvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:02 INFO - Running setup.py (path:/tmp/pip-bOniSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:02 INFO - Running setup.py (path:/tmp/pip-oYvvMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:02 INFO - Running setup.py (path:/tmp/pip-VQooC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:02 INFO - Running setup.py (path:/tmp/pip-nNlD3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:02 INFO - Running setup.py (path:/tmp/pip-xU8Wo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:18:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:04 INFO - Downloading blessings-1.6.tar.gz 03:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:18:04 INFO - Installing collected packages: blessings 03:18:04 INFO - Running setup.py install for blessings 03:18:05 INFO - Successfully installed blessings 03:18:05 INFO - Cleaning up... 03:18:05 INFO - Return code: 0 03:18:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:05 INFO - Reading from file tmpfile_stdout 03:18:05 INFO - Current package versions: 03:18:05 INFO - argparse == 1.2.1 03:18:05 INFO - blessings == 1.6 03:18:05 INFO - blobuploader == 1.2.4 03:18:05 INFO - docopt == 0.6.1 03:18:05 INFO - manifestparser == 1.1 03:18:05 INFO - mozInstall == 1.12 03:18:05 INFO - mozcrash == 0.17 03:18:05 INFO - mozdebug == 0.1 03:18:05 INFO - mozdevice == 0.48 03:18:05 INFO - mozfile == 1.2 03:18:05 INFO - mozhttpd == 0.7 03:18:05 INFO - mozinfo == 0.9 03:18:05 INFO - mozleak == 0.1 03:18:05 INFO - mozlog == 3.1 03:18:05 INFO - moznetwork == 0.27 03:18:05 INFO - mozprocess == 0.22 03:18:05 INFO - mozprofile == 0.28 03:18:05 INFO - mozrunner == 6.11 03:18:05 INFO - mozscreenshot == 0.1 03:18:05 INFO - mozsystemmonitor == 0.0 03:18:05 INFO - moztest == 0.7 03:18:05 INFO - mozversion == 1.4 03:18:05 INFO - psutil == 3.1.1 03:18:05 INFO - requests == 1.2.3 03:18:05 INFO - wsgiref == 0.1.2 03:18:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8656cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d160>, '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 0x1d3e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:18:05 INFO - Using env: {'DISPLAY': ':0', 03:18:05 INFO - 'HOME': '/home/cltbld', 03:18:05 INFO - 'LANG': 'en_US.UTF-8', 03:18:05 INFO - 'LANGUAGE': 'en_US:en', 03:18:05 INFO - 'LOGNAME': 'cltbld', 03:18:05 INFO - 'MAIL': '/var/mail/cltbld', 03:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:05 INFO - 'MOZ_NO_REMOTE': '1', 03:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:05 INFO - 'NO_EM_RESTART': '1', 03:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:05 INFO - 'PWD': '/builds/slave/test', 03:18:05 INFO - 'SHELL': '/bin/bash', 03:18:05 INFO - 'SHLVL': '1', 03:18:05 INFO - 'TERM': 'linux', 03:18:05 INFO - 'TMOUT': '86400', 03:18:05 INFO - 'USER': 'cltbld', 03:18:05 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 03:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:05 INFO - '_': '/tools/buildbot/bin/python'} 03:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:18:05 INFO - Cleaning up... 03:18:05 INFO - Return code: 0 03:18:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8656cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d160>, '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 0x1d3e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:18:05 INFO - Using env: {'DISPLAY': ':0', 03:18:05 INFO - 'HOME': '/home/cltbld', 03:18:05 INFO - 'LANG': 'en_US.UTF-8', 03:18:05 INFO - 'LANGUAGE': 'en_US:en', 03:18:05 INFO - 'LOGNAME': 'cltbld', 03:18:05 INFO - 'MAIL': '/var/mail/cltbld', 03:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:05 INFO - 'MOZ_NO_REMOTE': '1', 03:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:05 INFO - 'NO_EM_RESTART': '1', 03:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:05 INFO - 'PWD': '/builds/slave/test', 03:18:05 INFO - 'SHELL': '/bin/bash', 03:18:05 INFO - 'SHLVL': '1', 03:18:05 INFO - 'TERM': 'linux', 03:18:05 INFO - 'TMOUT': '86400', 03:18:05 INFO - 'USER': 'cltbld', 03:18:05 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 03:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:05 INFO - '_': '/tools/buildbot/bin/python'} 03:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:05 INFO - Downloading/unpacking jsonschema 03:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:18:08 INFO - Downloading/unpacking functools32 (from jsonschema) 03:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:08 INFO - Downloading functools32-3.2.3-2.tar.gz 03:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:18:08 INFO - warning: no files found matching '*.txt' 03:18:08 INFO - no previously-included directories found matching 'build' 03:18:08 INFO - no previously-included directories found matching 'dist' 03:18:08 INFO - no previously-included directories found matching '.git*' 03:18:08 INFO - Installing collected packages: jsonschema, functools32 03:18:08 INFO - Running setup.py install for functools32 03:18:08 INFO - warning: no files found matching '*.txt' 03:18:08 INFO - no previously-included directories found matching 'build' 03:18:08 INFO - no previously-included directories found matching 'dist' 03:18:08 INFO - no previously-included directories found matching '.git*' 03:18:08 INFO - Successfully installed jsonschema functools32 03:18:08 INFO - Cleaning up... 03:18:08 INFO - Return code: 0 03:18:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:08 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 0x7f7f8656cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3d160>, '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 0x1d3e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:18:08 INFO - Using env: {'DISPLAY': ':0', 03:18:08 INFO - 'HOME': '/home/cltbld', 03:18:08 INFO - 'LANG': 'en_US.UTF-8', 03:18:08 INFO - 'LANGUAGE': 'en_US:en', 03:18:08 INFO - 'LOGNAME': 'cltbld', 03:18:08 INFO - 'MAIL': '/var/mail/cltbld', 03:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:08 INFO - 'MOZ_NO_REMOTE': '1', 03:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:08 INFO - 'NO_EM_RESTART': '1', 03:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:08 INFO - 'PWD': '/builds/slave/test', 03:18:08 INFO - 'SHELL': '/bin/bash', 03:18:08 INFO - 'SHLVL': '1', 03:18:08 INFO - 'TERM': 'linux', 03:18:08 INFO - 'TMOUT': '86400', 03:18:08 INFO - 'USER': 'cltbld', 03:18:08 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 03:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:08 INFO - '_': '/tools/buildbot/bin/python'} 03:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:08 INFO - Downloading/unpacking flake8 03:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:18:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:18:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:18:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:18:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:18:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:18:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:18:11 INFO - no previously-included directories found matching 'docs/_build' 03:18:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:18:11 INFO - Running setup.py install for pep8 03:18:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:18:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:18:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:18:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:18:11 INFO - no previously-included directories found matching 'docs/_build' 03:18:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:18:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:18:11 INFO - Cleaning up... 03:18:11 INFO - Return code: 0 03:18:11 INFO - Running post-action listener: _resource_record_post_action 03:18:11 INFO - Running post-action listener: _start_resource_monitoring 03:18:11 INFO - Starting resource monitoring. 03:18:11 INFO - ##### 03:18:11 INFO - ##### Running install step. 03:18:11 INFO - ##### 03:18:11 INFO - Running pre-action listener: _resource_record_pre_action 03:18:11 INFO - Running main action method: install 03:18:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:11 INFO - Reading from file tmpfile_stdout 03:18:11 INFO - Detecting whether we're running mozinstall >=1.0... 03:18:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:18:11 INFO - Reading from file tmpfile_stdout 03:18:11 INFO - Output received: 03:18:11 INFO - Usage: mozinstall [options] installer 03:18:11 INFO - Options: 03:18:11 INFO - -h, --help show this help message and exit 03:18:11 INFO - -d DEST, --destination=DEST 03:18:11 INFO - Directory to install application into. [default: 03:18:11 INFO - "/builds/slave/test"] 03:18:11 INFO - --app=APP Application being installed. [default: firefox] 03:18:11 INFO - mkdir: /builds/slave/test/build/application 03:18:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:18:27 INFO - Reading from file tmpfile_stdout 03:18:27 INFO - Output received: 03:18:27 INFO - /builds/slave/test/build/application/firefox/firefox 03:18:27 INFO - Running post-action listener: _resource_record_post_action 03:18:27 INFO - ##### 03:18:27 INFO - ##### Running run-tests step. 03:18:27 INFO - ##### 03:18:27 INFO - Running pre-action listener: _resource_record_pre_action 03:18:27 INFO - Running main action method: run_tests 03:18:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:18:27 INFO - Python 2.7.3 03:18:27 INFO - Return code: 0 03:18:27 INFO - grabbing minidump binary from tooltool 03:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:27 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 0x1d3d160>, '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 0x1d3e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:18:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:18:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:18:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:18:27 INFO - Return code: 0 03:18:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:18:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:18:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:18:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:18:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:18:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:18:28 INFO - Return code: 0 03:18:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:18:28 INFO - Using env: {'DISPLAY': ':0', 03:18:28 INFO - 'HOME': '/home/cltbld', 03:18:28 INFO - 'LANG': 'en_US.UTF-8', 03:18:28 INFO - 'LANGUAGE': 'en_US:en', 03:18:28 INFO - 'LOGNAME': 'cltbld', 03:18:28 INFO - 'MAIL': '/var/mail/cltbld', 03:18:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:18:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:28 INFO - 'MOZ_NO_REMOTE': '1', 03:18:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:28 INFO - 'NO_EM_RESTART': '1', 03:18:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:28 INFO - 'PWD': '/builds/slave/test', 03:18:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:18:28 INFO - 'SHELL': '/bin/bash', 03:18:28 INFO - 'SHLVL': '1', 03:18:28 INFO - 'TERM': 'linux', 03:18:28 INFO - 'TMOUT': '86400', 03:18:28 INFO - 'USER': 'cltbld', 03:18:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249', 03:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:28 INFO - '_': '/tools/buildbot/bin/python'} 03:18:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:18:28 INFO - mozversion application_buildid: 20160424004019 03:18:28 INFO - mozversion application_changeset: 08791c3d6f713f4032f704e44bae22353bbdae77 03:18:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:18:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:18:28 INFO - mozversion application_name: Firefox 03:18:28 INFO - mozversion application_remotingname: firefox-dev 03:18:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:18:28 INFO - mozversion application_vendor: Mozilla 03:18:28 INFO - mozversion application_version: 47.0a2 03:18:28 INFO - mozversion platform_buildid: 20160424004019 03:18:28 INFO - mozversion platform_changeset: 08791c3d6f713f4032f704e44bae22353bbdae77 03:18:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:18:28 INFO - mozversion platform_version: 47.0a2 03:18:28 INFO - using testdate: 1461493108 03:18:28 INFO - actual date: 1461493108 03:18:28 INFO - starting webserver on 'localhost:54024' 03:18:28 INFO - SUITE-START | Running 2 tests 03:18:28 INFO - TEST-START | dromaeo_css 03:18:28 INFO - operating with platform_type : linux_ 03:18:28 INFO - Initialising browser for dromaeo_css test... 03:18:28 INFO - TEST-INFO | started process 7864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9LSXL4/profile http://localhost:54024/getInfo.html) 03:18:32 INFO - PROCESS | 7864 | __metrics Screen width/height:1600/1200 03:18:32 INFO - PROCESS | 7864 | colorDepth:24 03:18:32 INFO - PROCESS | 7864 | Browser inner width/height: 1024/697 03:18:32 INFO - PROCESS | 7864 | __metrics 03:18:33 INFO - PROCESS | 7864 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:18:33 INFO - TEST-INFO | 7864: exit 0 03:18:33 INFO - Browser initialized. 03:18:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:18:33 INFO - TEST-INFO | started process 7953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9LSXL4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:45 INFO - PROCESS | 7953 | RSS: Main: 142147584 03:18:45 INFO - PROCESS | 7953 | 03:19:36 INFO - PROCESS | 7953 | 1461493176611 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:21:44 INFO - PROCESS | 7953 | Cycle 1(1): loaded http://localhost:54024/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54024/tests/dromaeo/cssquery-ext.html) 03:21:45 INFO - PROCESS | 7953 | RSS: Main: 250580992 03:21:45 INFO - PROCESS | 7953 | 03:24:47 INFO - PROCESS | 7953 | Cycle 1(1): loaded http://localhost:54024/tests/dromaeo/cssquery-ext.html (next: http://localhost:54024/tests/dromaeo/cssquery-jquery.html) 03:24:47 INFO - PROCESS | 7953 | RSS: Main: 218546176 03:24:47 INFO - PROCESS | 7953 | 03:27:49 INFO - PROCESS | 7953 | Cycle 1(1): loaded http://localhost:54024/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54024/tests/dromaeo/cssquery-mootools.html) 03:27:50 INFO - PROCESS | 7953 | RSS: Main: 214822912 03:27:50 INFO - PROCESS | 7953 | 03:30:51 INFO - PROCESS | 7953 | Cycle 1(1): loaded http://localhost:54024/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54024/tests/dromaeo/cssquery-prototype.html) 03:30:52 INFO - PROCESS | 7953 | RSS: Main: 191434752 03:30:52 INFO - PROCESS | 7953 | 03:33:55 INFO - PROCESS | 7953 | Cycle 1(1): loaded http://localhost:54024/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54024/tests/dromaeo/cssquery-yui.html) 03:33:55 INFO - PROCESS | 7953 | RSS: Main: 208646144 03:33:55 INFO - PROCESS | 7953 | 03:36:57 INFO - PROCESS | 7953 | Cycle 1(1): loaded http://localhost:54024/tests/dromaeo/cssquery-yui.html (next: http://localhost:54024/tests/dromaeo/cssquery-dojo.html) 03:36:58 INFO - PROCESS | 7953 | RSS: Main: 257110016 03:36:58 INFO - PROCESS | 7953 | 03:36:58 INFO - PROCESS | 7953 | __start_tp_report 03:36:58 INFO - PROCESS | 7953 | _x_x_mozilla_page_load 03:36:58 INFO - PROCESS | 7953 | _x_x_mozilla_page_load_details 03:36:58 INFO - PROCESS | 7953 | |i|pagename|runs| 03:36:58 INFO - PROCESS | 7953 | |0;dojo.html;3205.0865503331547;3273.4107860585086;3283.835808209589;3284.704376606105;3318.717908977737;5260.4213536511;5270;5283.498067683564;5288.233206185101;5299.443558426363;5296.470352964701;5297.099493086175;5297.152455607104;5302.840914772563;5338.145896656536;4775.928361074587;4837.588804951583;4838.104950584136;4902.97548512257;4959.181735013718;4795.0889331027165;4840.733759643218;4859.951400486003;4879.194932836078;4941.283513890484;4891.804327826882;4941.160002799533;4947.084789313971;4952.380952380952;4978.178600530908;4788.664793464459;4879.072976134558;4903.926441103386;4907.730074845882;4944.60443164546;4725.291206319045;4808.951910480885;4812.181929072066;4837.612990960714;4853.053654537367;5127.769250383742;5129.538341549279;5145.562627176694;5160.535551800356;5163.380394352665;5607.439256074401;5609.793894312702;5619.578531610146;5629.690367029812;5664.546836253131;5670.6030577859565;5686.260786097822;5700.714964251771;5724.971375143139;5746.770129194827;5328.3605967284175;5330.733463326818;5337.866553336159;5347.839564813062;5350.3312085989255;5809.157672137517;5814.215080964101;5821.88356232873;5824.068149096209;5904.881902361929;5608.6073974821375;5621.128725047624;5627.549796016309;5640.323161220597;5660.773569057274;5666.575006874501;5704.172894930211;5721.656700597978;5724.914126288109;5728.51307638847;5606.495415412633;5616.354119276336;5662.235598194274;5692.943070569324;5716.085426331767;5643.379228284885;5676.489115979582;5677.687727174963;5680.573956953245;5693;4363.323684828857;4380.080183161572;4387.210302145644;4395;4425.867223983221;3862.7102967277565;3911.5697273299916;3970.6029397060643;3983.48214732083;3999.8000099994883;5379.892402151935;5390.191471279261;5395.919061214085;5399.514043736004;5404.621676482609;5735.713214339266;5736.024875771129;5736.5123964462655;5737.08206686928;5762.279715035621;5311;5326.893462130735;5360.946390536123;5404.32445944257;5417.783288668488;4945.4807245238735;4970.130227210224;4971.676841005323;4973.502649734997;4991.47589503097;5822.33043200029;5874.765009399576;5896.528277737771;5898.410158984153;5900.291964964146;5583.469570390806;5674.971625141848;5691.686957217393;5719.256496655408;5733.8566535836935;5872.383399742966;5879.118132280192;5884.029135192816;5910.261217347832;5918.023526118142;5556.499915007668;5672.716364181857;5682.176084467646;5682.886342273214;5692.857678558069;5767.538596912321;5772.105323674838;5776.364599893925;5786;5819.447152520504;5551.444855514416;5553.666779993213;5554.861128471821;5555.916661250004;5630.0428927081675;5499.945000550103;5544;5585.860353491195;5613.073842815889;5624.831255062355;5444.101723215784;5447.073997420527;5458.1266997280245;5459.317585301837;5478;5518.310211223597;5522.530584900168;5540.36285827135;5540.445955404427;5568.136938774496;5399.055165346127;5434.347878254634;5451.836444906659;5470.671759694272;5480.3971563128825 03:36:58 INFO - PROCESS | 7953 | |1;ext.html;546.0880329849151;578.942105789421;590.9793157239498;591.4144996453513;600.7747094839434;40981.18037639249;41722;42046.36930446046;42076.36885446717;42148.57851421489;42439;43141.784291078504;43159.136817263636;43877.341839872344;44130;8632.43889147205;8811.559422028906;8811.867821982676;8812.471251724917;8841.204291613754;8826.955865220698;8946.239569636557;8960.372773905829;9073.954630226872;9088.091190880925;9109.45343279402;9130.497822619753;9183.448993060405;9214.493202873839;9221.123993220634;9041.502717350542;9098.044705305914;9115.726528204164;9127.452352858849;9171.358004939657;9035.232005279559;9143.268538516902;9143.405678630868;9159.816803663889;9183.770405739842;43316;43973.78013109946;44048.11903761939;44431.111377772584;44632.330515042304;3647.5075864758182;3740.6259374062647;3841.0397400649836;3886;3971.940420893689;33516.162095947795;33529.497057544155;33824.32351352984;34062;34431;4186.330187170069;4289.420928174688;4297.785110744481;4332.285172946492;4336.154449882274;307464.9999999978;307892;308584;310181;310216;46399;60358.887438939426;60728;60840;61155.08267375993;48948.5105148944;48965.265521017216;48976.265356019685;49035.50964490381;49043.75478122586;15748.133852637986;15905.284262207997;15950.122743249232;15953.202339883192;15989.04065756035;12872.93563532195;12895;12923.353832308347;13116.934415327862;13392.263425511495;15575.454859080104;15747.763783543256;15798.36806527726;15898;15909.443169489012;5921.526277897758;5956.761729530857;6002.459778619946;6071.51427885768;6120.724567394478;1018.1447584029451;1048.7077534791254;1051.9474026298653;1062.9529913035653;1092.6995076353908;28817.56773648397;28970.855145724137;29081.85459072691;29145.12564623065;29848.701512984593;1087.0269812063998;1108.7837871614959;1171.6016554371383;1227.7974134267745;1258.4085479824469;15335.539933802003;15548.611284717972;15837.128957907426;15855.286512106983;16129.435469758502;346808;347411;348012;351117;351589;59612;60106;60271.39728602746;60272;60443.69778151169;1197.0902114393125;1300.7723648361498;1374.7181827725292;1396.8114304568956;1414.816073910385;28971;29317.26706832346;31030;31032.379352413278;31660;50789.74605126951;51875.74062129816;51917.221241682164;52048.21927671012;52113.47886521086;291823;305248;305264;305703;306948;31372;34972.65027349694;35420.46869296911;36003.27993440064;36183.09542261464;44657;45050.54949450595;45506;45681.54318456906;46556.7672161637;40873.38689919594;41277;41501.37747933844;41534.169316614105;41855.58144418517;39420.21159576735;39995.40006899841;40892.59107408888;41163;41931.58068419277;40514.18971620492;41072.1785564293;41202.38196427116;41248;41461.58538414577;34749.652503474645;35842.4623630651;36205.81897090498;37126.628733712314;37494.625053749114;27413;27771.44457110887;28020;28044.71955280421;28081.157565273075 03:36:58 INFO - PROCESS | 7953 | |2;jquery.html;381.80527930755306;383.41912003314974;388.7065265724378;393.6358868047056;396.7044551808903;17550.297988080478;18316.35892743754;18731.71902421463;18749.625007499842;18797.624047519075;11686.590969316076;12001.459934302955;12034.81947770784;12092.576759813408;12096.455659495321;5176.327077479922;5210;5358.973205133969;5364.275822763916;5376.381716102659;5254.842354729364;5296.735163241822;5315.893682126355;5318.1225097858805;5346.465353464642;5296.179092240709;5300.575953923696;5302.284191634138;5490.231367608538;5770.711464426783;5709.143628455723;5739.139129130622;5739.483446489836;5764.07774756037;5791.247137872071;5488.368837583689;5519.448055194489;5562.360328562227;5566.526845218162;5590.776368945238;13375.598732038054;13923.58229253124;13958.371873265625;13996.860031399658;14010.22943738094;2241.60771864923;2398.748131446208;2461.4707837814776;2538.9111381101575;2736.53478908586;9705.175060119898;9724.611015559369;10062.64780732678;10080.445575493344;10398.532066057045;1915.3966500552422;1930.0928563575237;1936.9903150484158;1964.7151163081273;1976.3675623800389;63434;64382.67808660973;65834.3416565833;67971;68491.65754171247;10492.317999330018;10575.524101415454;10655.68032958997;10656.520456579472;10682.786344273227;15046.398144074334;15081.396744130332;15188.848111518744;15240.314185861664;15265.3893844245;7713.65288562016;7750.224977502317;7763.146053934062;7786.727464538827;7897.486663366863;7368.521046131984;7434.405247580181;7489.962550187214;7558.433117516208;7586.165521792598;4642.46611639659;4691.085238378483;4757.215059515142;4769.379980602499;4796.952030479721;1840;1878.5773201029658;1908.9800691731457;1919.0980239287512;2002.8497862660067;968.25444407807;981.7398389426808;1016.4409574733867;1016.6289304403987;1027;17457.30170793154;17624.735628965576;17644.558886027953;17779.555511112325;18340.908295458437;975.1516180922642;979.3095867413457;988.7528117970508;1001.3591301567003;1007.6422869881234;9997.400155990665;10342.948285258526;10390.168786497063;10461.633842815465;10547.736306592396;443396;448762;450098;458474;458954;47472.7626361866;57329.713351432976;66385.67228655399;70389.64805176044;70975;998.7553049502773;1026.2816028780032;1033.1166852341291;1056.8309070548828;1057.751428414322;15249.6187595311;15519.301631426839;15522.991005585052;15610.45363412275;15679;34438;35278.64721352753;35699.28601427905;36023.27953440969;36375;45258.547414525434;48415.5158448411;53130;54440.72779636235;55953.16070259031;10784.406857622906;11490.482928268415;11844;12349.938250309051;12633.2420054797;13071;13305.80041299362;13442.327883605585;13637.249951252776;13690.52083177084;12051.879481205076;12144.878551214375;12279.14046016806;12421.503139874665;12493.875061249635;11768.70578235551;11993.460294286604;12103.273803571814;12203.938980305396;12218.572349967708;12328.260304381765;12421.31682757457;12628.936855315664;12725.872741272839;12763.106582539132;11777.705557361134;11978.64064078079;12367.381630918599;12445.377731113227;12531.18547294423;12407.93796031014;12539.184952978027;12541.811872822098;12550.246985180918;12753.872461275269 03:36:58 INFO - PROCESS | 7953 | |3;mootools.html;1389.0693235532192;1513.894027418081;1521.6652336485972;1671.7743104680865;1769.389560601592;7635.083789945207;8067.435279530428;8230.465019773717;8270.627821748021;8316.625751841166;8313.41806073575;8373.790655233623;8457.78855528612;8466.195711407407;8490.91509084909;2143.4641339665086;2378.595638741414;2418.6251131074623;2440.877196489608;2486.614574740909;2465.494573612405;2468.136152346682;2486.651868738378;2490.476999830038;2494.5260400523935;2479.070348619268;2516.962245566318;2517.3203235126507;2521.848689078652;2523.3060908250286;2364.113457453455;2412.601920683085;2415.794657454101;2416.8429052111555;2417.1781594258036;2433.9756602433927;2445.119756887519;2452.509498100387;2458.852468851857;2474.6288056791627;8417.831643367159;8485.95757021211;8492.53291068991;8502.44734092282;8568.314534837198;5264.710440925747;5362.410134885159;5363.865903352447;5390.595705322077;5394.02907476654;3099;3187.2509960159346;3213.694699003591;3228.4350238708134;3229.6285927118447;1018.251585084962;1044.613493007592;1048;1053.7260312318851;1073.726199819049;12088.576899808553;12123.696907577292;12128.818067728991;12141.271523708605;12214.57248996281;4563.452385713669;4633.189191891473;4693.084848454587;4740.45484769249;4815.7351345676325;10209.234307426825;10277.845832312521;10399.84400233997;10431.94784026075;10433.32183408076;4852.320675105488;5305.124654431976;5320.467953204648;5324.813631522956;5331.280277162611;4709.717416954925;4843.297721830315;4847.684900481458;4859.854204373874;4860.246661767432;3903.551091624443;3958.2083583282883;3967.6627486663956;3988.9229907924696;4053.43251944728;1326.774448343784;1334.5595953335376;1341.4097796969302;1341.5774031180147;1351.2838195756265;1347.1512946843427;1357.755603991291;1367.2890097149625;1402.9127426244743;1421.1970236816167;8097.676092956216;8145.551994640233;8195.221453961984;8218.301444377295;8235.21765432283;546.66926509462;552.1827695011325;555.5333519843351;555.919391688203;557.1559087981711;5912.113183022495;5951.464368206795;5982.910256346158;6006.969965150233;6012.549058820606;10555.894441055645;10754.78490430187;10881;10899.782004360028;10905.073068789083;10079.748006299902;10620.681379558471;10649.84025239622;10650.041496265218;10652.680419587425;7679.539227646359;7744.876992836007;7753.147153813076;7771.378289736807;7868.527888326718;8035.156308587748;8059.3552515799765;8068.031836179696;8076.919230807852;8167.0199576051255;9268.443893366419;9356.345055846026;9366.67216647414;9484.478353690338;9491.905080949378;9711.951440243036;9876.308658394131;9929;10102.949485252526;10309.123724483503;6868.210155832143;7040.119985001875;7569.735059272899;7643.88534171999;7767.689292428466;8095.595220238847;8108.189181081844;8123.431359804993;8149.388795840217;8164.224398682116;7133.251008644018;7327.63361831917;7408.851822963618;7474.2525747424825;7477.66350514239;7257.165425976081;7410;7417.962910185631;7543.245675432413;7555.9244407555225;7721.227877212458;7738.690452381842;7779.416543759127;7786.454948153575;7788.688452461838;6794.422474089758;6863.073485079451;6884.242733299433;6889.242183359726;6898.655067246718;7066.434685225273;7104.467164962752;7148.785536433916;7154.606496642735;7165.820854478471 03:36:58 INFO - PROCESS | 7953 | |4;prototype.html;359.58647555311387;360.20394927210856;366.06835603389374;371.18710025045164;381.0720894621597;5985.371535988724;5996.2504686914135;5999.280086389628;6001.399860013997;6001.729922153508;5891.116332550119;5922.733476993535;5924.88150236995;5950.434708702677;5952.3750006249265;4440.311751678495;4454.710443821157;4521.615662668677;4578.519255478177;4663.183942810003;4582.679212455129;4583.404157459526;4583.793729282173;4585.977070114662;4589.816407343702;4503;4546.181687296285;4559.293309537011;4564.269716845305;4572.428446444194;4435.68950173488;4508.098380323932;4566.954330456686;4573.862784116482;4576.359309696645;4031.21391328691;4032.1330913853367;4040.919181616351;4043.757374557536;4044.6562042226446;5663.546916246691;5669.092945128759;5676.801311954062;5687.829365119053;5697.430256974311;5306.814261500867;5335.9466405336225;5340.305760251143;5341.385740639837;5364.168553874156;6263.561550691454;6300.68496575174;6328.968355158195;6329.113924050636;6342.746290148389;4392.989612389137;4470.932936005963;4528.8867778305475;4554.817807287704;4570.10882877839;6501.317361677003;6517.348265173445;6529.444997175246;6534.967325163391;6545.803625891231;4678.672492925462;4681.602063824613;4687.062587482449;4690.788914498856;4699.201135806853;4768.237082066853;4777.570018698264;4780.282957556325;4782.402199725035;4794.976025119852;5355.919661205085;5359.544438722674;5360.91958620621;5367.168088946141;5367.463253674601;5998.49012833914;6263.968680156661;6276.686165691697;6303.716332765037;6306.770179814984;1587.317453494985;1600.3998500562288;1608.9356425743074;1614.6205641674196;1620.7974003249594;1016.7305663999047;1039.2465462539749;1068.5351871935734;1075.6181555547669;1103.2553026706942;5970.641761494324;6015.157877897011;6016.578839481194;6016.729247183887;6052.426369144055;6418.587910659648;6453.386928241809;6457.160569125984;6457.160569125984;6467.805965821033;6013.6993150342305;6049.0926361046195;6049.697515124226;6049.969750151309;6052.243469566304;3472.5832900052155;3489.685928266468;3492.1967947372245;3503.8423270952867;3505.053635518396;6501;6589.17635295588;6609.405153536205;6730.9326906731285;6740.022696708949;6661.633610151488;6734.797956061326;6749.32506749331;6752.054712340277;6758.797236082925;6609.339066093352;6654.900176497356;6700.564463309966;6715.3620406061345;6722.596644201363;6545.37818907203;6546.24718157418;6549.410553050248;6553.279139294769;6553.705083271169;6274.811755647338;6423.871522569616;6425.389587989133;6429.646369449725;6464.256610489854;6711.731530738911;6738.797836064926;6743.763968261087;6743.865122697421;6749.73001079971;4461.442319710036;4509;4515.367848501147;4515.435570553681;4516.390287311171;6534.150560427114;6536.640484773383;6536.640484773383;6543.116679248241;6557.245916719638;6307.842303942438;6344.746210151542;6355.173827402408;6366.790309841301;6373.203349581302;6168.074788781719;6325.462335701517;6333.95489744187;6337.112804207322;6346.111544383698;6243.562950593597;6273.780417685359;6276.874462510816;6283.937160628335;6341.746330146742;6382.266039405342;6396.936030639634;6398.648074355955;6424.421802037839;6433.8713225736155;5949.494292985145;6102.694865256631;6225.346338634378;6233.065040244;6235.937640623536 03:36:58 INFO - PROCESS | 7953 | |5;yui.html;753.5554023126361;769.3191525499933;844.2275318083949;851.8637018077105;883.5847151838638;14404.27978601071;14744.926275368622;14912.105273683586;14934;14937.477188298411;14252.073615215004;14326.140431574113;14365.49720759771;14385.568432947002;14392.784108238386;654.9017647352912;901.2654686430554;905.3210092430677;923.9584218710174;933.0436302789627;748.8652042632324;752.0035952363113;754.6528596845458;759.5860256160406;764.1403421151205;957.4829592020335;958.520739630185;958.7698952251444;958.9280803939697;972.9659461918834;802.7631848604676;952.347641865321;969.9563519641633;971.3540495570437;971.917387022104;707.1655446573042;712.9429645628337;715.1346870286959;716.7204790131852;720.0243669827413;14693.706125877423;14749.77875331871;14758.114513129247;14775.482858099915;14775.852241477663;13389.397477113553;13606.115602485806;13673.384697688529;13781.724365512733;14168.362423690958;11689.70775730605;11829.467673954692;11847.170698051139;12046.397680115959;12080.15438919276;3923.3526468132723;3953.2686453006286;3991.521017477892;4056.492938382702;4057.5536690963972;47659.52340476585;48206.75896620529;48237.75881120607;48316;48530.51469485295;10422.166226701846;11275.323480591027;11293;11350.54597816078;11363.602273920538;19483.123259453074;19507.219711211677;19517.609647806963;19535.902320488305;19564.315248966217;7737.883931741028;7905.841883162419;7912.367010639135;7969.203079691984;8025.719099831478;4471.374007638933;4474.395956545824;4528.184926713157;4545.840895568639;4619.19164146273;3402.302527981758;3434.244466217428;3440.2947395783804;3449.1549570355423;3461.2558299965126;621.7357623010203;641.0704478506185;667.5527396644163;694.5173104692191;710.9466789990771;633.2211380002531;690.927452617478;718.8490417012381;726.934575888162;739.5969196787763;8437.509353393558;8437.620307086074;8524.70163544273;8562.357823163287;8677.262432693291;686.5400181878153;686.6086330791401;691.9550229235184;697.1355519156311;697.2260790522516;4090.1206240657807;4168.041350489404;4194.602372078626;4242.321228603409;4334.7399156050105;57191;58620.70689646524;58984;58998.11502827461;59000.40999589949;50522.242166367534;51981;53289;53396.73301633467;54670.17994730082;46972.5302746975;47998;48262.5173748258;48274.517254827006;48363.758181209574;8470.957645211734;8716.91283087161;8770.210681038481;8853.070427605266;9045.68340108093;35587.288254234256;35785.821070894475;36014.45978310275;37110.25779484449;37231.25537489289;42806.57193428151;43753.56246437495;44125.77937110294;46758;46943.29585056158;11098;11182.776344473228;11265.662030139109;11454.427278635869;11702.063834893359;12381.62855114348;12544.686382840502;12560.12079154487;13053.804192937303;13128.60614181576;11559.884401155881;11808.645740627795;11954.880451195377;12013.793651739996;12342.259464432163;11238.55045798159;11254.88745112571;11270.774584508428;11406.201565890307;11451.65645030617;11422.543098275975;11647.13887660989;11748.647540573797;11801.940990294994;11865.822012669643;9607.615695372107;9846.507674616383;9968.55141518619;10101.595936162472;10128.594856205964;10022.24833137503;10249;10285.53715082808;10314.48427578603;10316.329438586468 03:36:58 INFO - PROCESS | 7953 | __end_tp_report 03:36:58 INFO - PROCESS | 7953 | __start_cc_report 03:36:58 INFO - PROCESS | 7953 | _x_x_mozilla_cycle_collect,862 03:36:58 INFO - PROCESS | 7953 | __end_cc_report 03:36:58 INFO - PROCESS | 7953 | __startTimestamp1461494218069__endTimestamp 03:36:58 INFO - PROCESS | 7953 | 03:36:58 INFO - PROCESS | 7953 | ------- Summary: start ------- 03:36:58 INFO - PROCESS | 7953 | Number of tests: 6 03:36:58 INFO - PROCESS | 7953 | 03:36:58 INFO - PROCESS | 7953 | [#0] dojo.html Cycles:165 Average:5297.89 Median:5470.67 stddev:569.01 (10.4%) stddev-sans-first:546.56 03:36:58 INFO - PROCESS | 7953 | Values: 3205.1 3273.4 3283.8 3284.7 3318.7 5260.4 5270.0 5283.5 5288.2 5299.4 5296.5 5297.1 5297.2 5302.8 5338.1 4775.9 4837.6 4838.1 4903.0 4959.2 4795.1 4840.7 4860.0 4879.2 4941.3 4891.8 4941.2 4947.1 4952.4 4978.2 4788.7 4879.1 4903.9 4907.7 4944.6 4725.3 4809.0 4812.2 4837.6 4853.1 5127.8 5129.5 5145.6 5160.5 5163.4 5607.4 5609.8 5619.6 5629.7 5664.5 5670.6 5686.3 5700.7 5725.0 5746.8 5328.4 5330.7 5337.9 5347.8 5350.3 5809.2 5814.2 5821.9 5824.1 5904.9 5608.6 5621.1 5627.5 5640.3 5660.8 5666.6 5704.2 5721.7 5724.9 5728.5 5606.5 5616.4 5662.2 5692.9 5716.1 5643.4 5676.5 5677.7 5680.6 5693.0 4363.3 4380.1 4387.2 4395.0 4425.9 3862.7 3911.6 3970.6 3983.5 3999.8 5379.9 5390.2 5395.9 5399.5 5404.6 5735.7 5736.0 5736.5 5737.1 5762.3 5311.0 5326.9 5360.9 5404.3 5417.8 4945.5 4970.1 4971.7 4973.5 4991.5 5822.3 5874.8 5896.5 5898.4 5900.3 5583.5 5675.0 5691.7 5719.3 5733.9 5872.4 5879.1 5884.0 5910.3 5918.0 5556.5 5672.7 5682.2 5682.9 5692.9 5767.5 5772.1 5776.4 5786.0 5819.4 5551.4 5553.7 5554.9 5555.9 5630.0 5499.9 5544.0 5585.9 5613.1 5624.8 5444.1 5447.1 5458.1 5459.3 5478.0 5518.3 5522.5 5540.4 5540.4 5568.1 5399.1 5434.3 5451.8 5470.7 5480.4 03:36:58 INFO - PROCESS | 7953 | 03:36:58 INFO - PROCESS | 7953 | [#1] ext.html Cycles:180 Average:49828.92 Median:41026.68 stddev:83910.08 (204.5%) stddev-sans-first:84063.88 03:36:58 INFO - PROCESS | 7953 | Values: 546.1 578.9 591.0 591.4 600.8 40981.2 41722.0 42046.4 42076.4 42148.6 42439.0 43141.8 43159.1 43877.3 44130.0 8632.4 8811.6 8811.9 8812.5 8841.2 8827.0 8946.2 8960.4 9074.0 9088.1 9109.5 9130.5 9183.4 9214.5 9221.1 9041.5 9098.0 9115.7 9127.5 9171.4 9035.2 9143.3 9143.4 9159.8 9183.8 43316.0 43973.8 44048.1 44431.1 44632.3 3647.5 3740.6 3841.0 3886.0 3971.9 33516.2 33529.5 33824.3 34062.0 34431.0 4186.3 4289.4 4297.8 4332.3 4336.2 307465.0 307892.0 308584.0 310181.0 310216.0 46399.0 60358.9 60728.0 60840.0 61155.1 48948.5 48965.3 48976.3 49035.5 49043.8 15748.1 15905.3 15950.1 15953.2 15989.0 12872.9 12895.0 12923.4 13116.9 13392.3 15575.5 15747.8 15798.4 15898.0 15909.4 5921.5 5956.8 6002.5 6071.5 6120.7 1018.1 1048.7 1051.9 1063.0 1092.7 28817.6 28970.9 29081.9 29145.1 29848.7 1087.0 1108.8 1171.6 1227.8 1258.4 15335.5 15548.6 15837.1 15855.3 16129.4 346808.0 347411.0 348012.0 351117.0 351589.0 59612.0 60106.0 60271.4 60272.0 60443.7 1197.1 1300.8 1374.7 1396.8 1414.8 28971.0 29317.3 31030.0 31032.4 31660.0 50789.7 51875.7 51917.2 52048.2 52113.5 291823.0 305248.0 305264.0 305703.0 306948.0 31372.0 34972.7 35420.5 36003.3 36183.1 44657.0 45050.5 45506.0 45681.5 46556.8 40873.4 41277.0 41501.4 41534.2 41855.6 39420.2 39995.4 40892.6 41163.0 41931.6 40514.2 41072.2 41202.4 41248.0 41461.6 34749.7 35842.5 36205.8 37126.6 37494.6 27413.0 27771.4 28020.0 28044.7 28081.2 03:36:58 INFO - PROCESS | 7953 | 03:36:58 INFO - PROCESS | 7953 | [#2] jquery.html Cycles:180 Average:25976.57 Median:1924.60 stddev:73886.03 (3839.0%) stddev-sans-first:74068.30 03:36:58 INFO - PROCESS | 7953 | Values: 381.8 383.4 388.7 393.6 396.7 17550.3 18316.4 18731.7 18749.6 18797.6 11686.6 12001.5 12034.8 12092.6 12096.5 5176.3 5210.0 5359.0 5364.3 5376.4 5254.8 5296.7 5315.9 5318.1 5346.5 5296.2 5300.6 5302.3 5490.2 5770.7 5709.1 5739.1 5739.5 5764.1 5791.2 5488.4 5519.4 5562.4 5566.5 5590.8 13375.6 13923.6 13958.4 13996.9 14010.2 2241.6 2398.7 2461.5 2538.9 2736.5 9705.2 9724.6 10062.6 10080.4 10398.5 1915.4 1930.1 1937.0 1964.7 1976.4 63434.0 64382.7 65834.3 67971.0 68491.7 10492.3 10575.5 10655.7 10656.5 10682.8 15046.4 15081.4 15188.8 15240.3 15265.4 7713.7 7750.2 7763.1 7786.7 7897.5 7368.5 7434.4 7490.0 7558.4 7586.2 4642.5 4691.1 4757.2 4769.4 4797.0 1840.0 1878.6 1909.0 1919.1 2002.8 968.3 981.7 1016.4 1016.6 1027.0 17457.3 17624.7 17644.6 17779.6 18340.9 975.2 979.3 988.8 1001.4 1007.6 9997.4 10342.9 10390.2 10461.6 10547.7 443396.0 448762.0 450098.0 458474.0 458954.0 47472.8 57329.7 66385.7 70389.6 70975.0 998.8 1026.3 1033.1 1056.8 1057.8 15249.6 15519.3 15523.0 15610.5 15679.0 34438.0 35278.6 35699.3 36023.3 36375.0 45258.5 48415.5 53130.0 54440.7 55953.2 10784.4 11490.5 11844.0 12349.9 12633.2 13071.0 13305.8 13442.3 13637.2 13690.5 12051.9 12144.9 12279.1 12421.5 12493.9 11768.7 11993.5 12103.3 12203.9 12218.6 12328.3 12421.3 12628.9 12725.9 12763.1 11777.7 11978.6 12367.4 12445.4 12531.2 12407.9 12539.2 12541.8 12550.2 12753.9 03:36:58 INFO - PROCESS | 7953 | 03:36:58 INFO - PROCESS | 7953 | [#3] mootools.html Cycles:180 Average:5990.45 Median:5322.64 stddev:3207.78 (60.3%) stddev-sans-first:3198.13 03:36:58 INFO - PROCESS | 7953 | Values: 1389.1 1513.9 1521.7 1671.8 1769.4 7635.1 8067.4 8230.5 8270.6 8316.6 8313.4 8373.8 8457.8 8466.2 8490.9 2143.5 2378.6 2418.6 2440.9 2486.6 2465.5 2468.1 2486.7 2490.5 2494.5 2479.1 2517.0 2517.3 2521.8 2523.3 2364.1 2412.6 2415.8 2416.8 2417.2 2434.0 2445.1 2452.5 2458.9 2474.6 8417.8 8486.0 8492.5 8502.4 8568.3 5264.7 5362.4 5363.9 5390.6 5394.0 3099.0 3187.3 3213.7 3228.4 3229.6 1018.3 1044.6 1048.0 1053.7 1073.7 12088.6 12123.7 12128.8 12141.3 12214.6 4563.5 4633.2 4693.1 4740.5 4815.7 10209.2 10277.8 10399.8 10431.9 10433.3 4852.3 5305.1 5320.5 5324.8 5331.3 4709.7 4843.3 4847.7 4859.9 4860.2 3903.6 3958.2 3967.7 3988.9 4053.4 1326.8 1334.6 1341.4 1341.6 1351.3 1347.2 1357.8 1367.3 1402.9 1421.2 8097.7 8145.6 8195.2 8218.3 8235.2 546.7 552.2 555.5 555.9 557.2 5912.1 5951.5 5982.9 6007.0 6012.5 10555.9 10754.8 10881.0 10899.8 10905.1 10079.7 10620.7 10649.8 10650.0 10652.7 7679.5 7744.9 7753.1 7771.4 7868.5 8035.2 8059.4 8068.0 8076.9 8167.0 9268.4 9356.3 9366.7 9484.5 9491.9 9712.0 9876.3 9929.0 10102.9 10309.1 6868.2 7040.1 7569.7 7643.9 7767.7 8095.6 8108.2 8123.4 8149.4 8164.2 7133.3 7327.6 7408.9 7474.3 7477.7 7257.2 7410.0 7418.0 7543.2 7555.9 7721.2 7738.7 7779.4 7786.5 7788.7 6794.4 6863.1 6884.2 6889.2 6898.7 7066.4 7104.5 7148.8 7154.6 7165.8 03:36:58 INFO - PROCESS | 7953 | 03:36:58 INFO - PROCESS | 7953 | [#4] prototype.html Cycles:180 Average:5302.51 Median:6000.34 stddev:1576.62 (26.3%) stddev-sans-first:1536.77 03:36:58 INFO - PROCESS | 7953 | Values: 359.6 360.2 366.1 371.2 381.1 5985.4 5996.3 5999.3 6001.4 6001.7 5891.1 5922.7 5924.9 5950.4 5952.4 4440.3 4454.7 4521.6 4578.5 4663.2 4582.7 4583.4 4583.8 4586.0 4589.8 4503.0 4546.2 4559.3 4564.3 4572.4 4435.7 4508.1 4567.0 4573.9 4576.4 4031.2 4032.1 4040.9 4043.8 4044.7 5663.5 5669.1 5676.8 5687.8 5697.4 5306.8 5335.9 5340.3 5341.4 5364.2 6263.6 6300.7 6329.0 6329.1 6342.7 4393.0 4470.9 4528.9 4554.8 4570.1 6501.3 6517.3 6529.4 6535.0 6545.8 4678.7 4681.6 4687.1 4690.8 4699.2 4768.2 4777.6 4780.3 4782.4 4795.0 5355.9 5359.5 5360.9 5367.2 5367.5 5998.5 6264.0 6276.7 6303.7 6306.8 1587.3 1600.4 1608.9 1614.6 1620.8 1016.7 1039.2 1068.5 1075.6 1103.3 5970.6 6015.2 6016.6 6016.7 6052.4 6418.6 6453.4 6457.2 6457.2 6467.8 6013.7 6049.1 6049.7 6050.0 6052.2 3472.6 3489.7 3492.2 3503.8 3505.1 6501.0 6589.2 6609.4 6730.9 6740.0 6661.6 6734.8 6749.3 6752.1 6758.8 6609.3 6654.9 6700.6 6715.4 6722.6 6545.4 6546.2 6549.4 6553.3 6553.7 6274.8 6423.9 6425.4 6429.6 6464.3 6711.7 6738.8 6743.8 6743.9 6749.7 4461.4 4509.0 4515.4 4515.4 4516.4 6534.2 6536.6 6536.6 6543.1 6557.2 6307.8 6344.7 6355.2 6366.8 6373.2 6168.1 6325.5 6334.0 6337.1 6346.1 6243.6 6273.8 6276.9 6283.9 6341.7 6382.3 6396.9 6398.6 6424.4 6433.9 5949.5 6102.7 6225.3 6233.1 6235.9 03:36:58 INFO - PROCESS | 7953 | 03:36:58 INFO - PROCESS | 7953 | [#5] yui.html Cycles:180 Average:14349.23 Median:4472.88 stddev:16229.74 (362.8%) stddev-sans-first:16243.15 03:36:58 INFO - PROCESS | 7953 | Values: 753.6 769.3 844.2 851.9 883.6 14404.3 14744.9 14912.1 14934.0 14937.5 14252.1 14326.1 14365.5 14385.6 14392.8 654.9 901.3 905.3 924.0 933.0 748.9 752.0 754.7 759.6 764.1 957.5 958.5 958.8 958.9 973.0 802.8 952.3 970.0 971.4 971.9 707.2 712.9 715.1 716.7 720.0 14693.7 14749.8 14758.1 14775.5 14775.9 13389.4 13606.1 13673.4 13781.7 14168.4 11689.7 11829.5 11847.2 12046.4 12080.2 3923.4 3953.3 3991.5 4056.5 4057.6 47659.5 48206.8 48237.8 48316.0 48530.5 10422.2 11275.3 11293.0 11350.5 11363.6 19483.1 19507.2 19517.6 19535.9 19564.3 7737.9 7905.8 7912.4 7969.2 8025.7 4471.4 4474.4 4528.2 4545.8 4619.2 3402.3 3434.2 3440.3 3449.2 3461.3 621.7 641.1 667.6 694.5 710.9 633.2 690.9 718.8 726.9 739.6 8437.5 8437.6 8524.7 8562.4 8677.3 686.5 686.6 692.0 697.1 697.2 4090.1 4168.0 4194.6 4242.3 4334.7 57191.0 58620.7 58984.0 58998.1 59000.4 50522.2 51981.0 53289.0 53396.7 54670.2 46972.5 47998.0 48262.5 48274.5 48363.8 8471.0 8716.9 8770.2 8853.1 9045.7 35587.3 35785.8 36014.5 37110.3 37231.3 42806.6 43753.6 44125.8 46758.0 46943.3 11098.0 11182.8 11265.7 11454.4 11702.1 12381.6 12544.7 12560.1 13053.8 13128.6 11559.9 11808.6 11954.9 12013.8 12342.3 11238.6 11254.9 11270.8 11406.2 11451.7 11422.5 11647.1 11748.6 11801.9 11865.8 9607.6 9846.5 9968.6 10101.6 10128.6 10022.2 10249.0 10285.5 10314.5 10316.3 03:36:58 INFO - PROCESS | 7953 | -------- Summary: end -------- 03:36:58 INFO - PROCESS | 7953 | 03:36:58 INFO - TEST-INFO | 7953: exit 0 03:36:58 INFO - TEST-OK | dromaeo_css | took 1110293ms 03:36:58 INFO - TEST-START | kraken 03:36:58 INFO - operating with platform_type : linux_ 03:36:58 INFO - Initialising browser for kraken test... 03:36:58 INFO - TEST-INFO | started process 8143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiWSsiO/profile http://localhost:54024/getInfo.html) 03:37:02 INFO - PROCESS | 8143 | __metrics Screen width/height:1600/1200 03:37:02 INFO - PROCESS | 8143 | colorDepth:24 03:37:02 INFO - PROCESS | 8143 | Browser inner width/height: 1024/697 03:37:02 INFO - PROCESS | 8143 | __metrics 03:37:03 INFO - PROCESS | 8143 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:37:04 INFO - TEST-INFO | 8143: exit 0 03:37:04 INFO - Browser initialized. 03:37:04 INFO - Running cycle 1/1 for kraken test... 03:37:04 INFO - TEST-INFO | started process 8230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiWSsiO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:15 INFO - PROCESS | 8230 | RSS: Main: 141668352 03:37:15 INFO - PROCESS | 8230 | 03:37:18 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54024/tests/kraken/driver.html?testName=audio-beat-detection) 03:37:18 INFO - PROCESS | 8230 | RSS: Main: 177950720 03:37:18 INFO - PROCESS | 8230 | 03:37:21 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54024/tests/kraken/driver.html?testName=audio-dft) 03:37:22 INFO - PROCESS | 8230 | RSS: Main: 175820800 03:37:22 INFO - PROCESS | 8230 | 03:37:25 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54024/tests/kraken/driver.html?testName=audio-fft) 03:37:25 INFO - PROCESS | 8230 | RSS: Main: 173101056 03:37:25 INFO - PROCESS | 8230 | 03:37:27 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54024/tests/kraken/driver.html?testName=audio-oscillator) 03:37:28 INFO - PROCESS | 8230 | RSS: Main: 173252608 03:37:28 INFO - PROCESS | 8230 | 03:37:30 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54024/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:37:31 INFO - PROCESS | 8230 | RSS: Main: 170971136 03:37:31 INFO - PROCESS | 8230 | 03:37:34 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54024/tests/kraken/driver.html?testName=imaging-darkroom) 03:37:34 INFO - PROCESS | 8230 | RSS: Main: 171515904 03:37:34 INFO - PROCESS | 8230 | 03:37:38 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54024/tests/kraken/driver.html?testName=imaging-desaturate) 03:37:38 INFO - PROCESS | 8230 | RSS: Main: 172048384 03:37:38 INFO - PROCESS | 8230 | 03:37:41 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54024/tests/kraken/driver.html?testName=json-parse-financial) 03:37:41 INFO - PROCESS | 8230 | RSS: Main: 171589632 03:37:41 INFO - PROCESS | 8230 | 03:37:43 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54024/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:37:44 INFO - PROCESS | 8230 | RSS: Main: 176873472 03:37:44 INFO - PROCESS | 8230 | 03:37:45 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54024/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:37:46 INFO - PROCESS | 8230 | RSS: Main: 175955968 03:37:46 INFO - PROCESS | 8230 | 03:37:48 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54024/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:37:49 INFO - PROCESS | 8230 | RSS: Main: 181338112 03:37:49 INFO - PROCESS | 8230 | 03:37:51 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:37:51 INFO - PROCESS | 8230 | RSS: Main: 188489728 03:37:51 INFO - PROCESS | 8230 | 03:37:54 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:37:55 INFO - PROCESS | 8230 | RSS: Main: 187088896 03:37:55 INFO - PROCESS | 8230 | 03:37:56 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:54024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54024/tests/kraken/driver.html?testName=ai-astar) 03:37:57 INFO - PROCESS | 8230 | RSS: Main: 249110528 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | __start_tp_report 03:37:57 INFO - PROCESS | 8230 | _x_x_mozilla_page_load 03:37:57 INFO - PROCESS | 8230 | _x_x_mozilla_page_load_details 03:37:57 INFO - PROCESS | 8230 | |i|pagename|runs| 03:37:57 INFO - PROCESS | 8230 | |0;ai-astar;110;110;104;110;111;112;102;111;111;110 03:37:57 INFO - PROCESS | 8230 | |1;audio-beat-detection;155;134;163;177;135;153;159;128;173;128 03:37:57 INFO - PROCESS | 8230 | |2;audio-dft;160;163;162;163;160;160;160;163;163;161 03:37:57 INFO - PROCESS | 8230 | |3;audio-fft;76;75;79;164;76;75;75;78;172;77 03:37:57 INFO - PROCESS | 8230 | |4;audio-oscillator;94;95;146;94;94;93;148;95;95;139 03:37:57 INFO - PROCESS | 8230 | |5;imaging-gaussian-blur;117;117;116;118;118;117;116;117;117;117 03:37:57 INFO - PROCESS | 8230 | |6;imaging-darkroom;148;151;146;146;147;145;146;147;147;147 03:37:57 INFO - PROCESS | 8230 | |7;imaging-desaturate;96;97;97;97;96;96;96;96;96;95 03:37:57 INFO - PROCESS | 8230 | |8;json-parse-financial;57;55;54;54;56;55;56;65;53;52 03:37:57 INFO - PROCESS | 8230 | |9;json-stringify-tinderbox;64;65;64;64;64;64;64;65;63;64 03:37:57 INFO - PROCESS | 8230 | |10;stanford-crypto-aes;78;78;79;78;80;79;79;79;79;78 03:37:57 INFO - PROCESS | 8230 | |11;stanford-crypto-ccm;115;117;113;122;113;114;112;114;115;112 03:37:57 INFO - PROCESS | 8230 | |12;stanford-crypto-pbkdf2;147;145;147;148;142;135;138;144;142;144 03:37:57 INFO - PROCESS | 8230 | |13;stanford-crypto-sha256-iterative;69;70;67;67;68;66;70;72;67;65 03:37:57 INFO - PROCESS | 8230 | __end_tp_report 03:37:57 INFO - PROCESS | 8230 | __start_cc_report 03:37:57 INFO - PROCESS | 8230 | _x_x_mozilla_cycle_collect,1079 03:37:57 INFO - PROCESS | 8230 | __end_cc_report 03:37:57 INFO - PROCESS | 8230 | __startTimestamp1461494277043__endTimestamp 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | ------- Summary: start ------- 03:37:57 INFO - PROCESS | 8230 | Number of tests: 14 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.31 (3.0%) stddev-sans-first:3.50 03:37:57 INFO - PROCESS | 8230 | Values: 110.0 110.0 104.0 110.0 111.0 112.0 102.0 111.0 111.0 110.0 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:157.00 stddev:18.22 (11.6%) stddev-sans-first:19.25 03:37:57 INFO - PROCESS | 8230 | Values: 155.0 134.0 163.0 177.0 135.0 153.0 159.0 128.0 173.0 128.0 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.50 stddev:1.43 (0.9%) stddev-sans-first:1.41 03:37:57 INFO - PROCESS | 8230 | Values: 160.0 163.0 162.0 163.0 160.0 160.0 160.0 163.0 163.0 161.0 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:38.70 (50.9%) stddev-sans-first:40.45 03:37:57 INFO - PROCESS | 8230 | Values: 76.0 75.0 79.0 164.0 76.0 75.0 75.0 78.0 172.0 77.0 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:94.00 stddev:24.29 (25.8%) stddev-sans-first:25.12 03:37:57 INFO - PROCESS | 8230 | Values: 94.0 95.0 146.0 94.0 94.0 93.0 148.0 95.0 95.0 139.0 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 03:37:57 INFO - PROCESS | 8230 | Values: 117.0 117.0 116.0 118.0 118.0 117.0 116.0 117.0 117.0 117.0 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.63 (1.1%) stddev-sans-first:1.69 03:37:57 INFO - PROCESS | 8230 | Values: 148.0 151.0 146.0 146.0 147.0 145.0 146.0 147.0 147.0 147.0 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:37:57 INFO - PROCESS | 8230 | Values: 96.0 97.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:3.59 (6.5%) stddev-sans-first:3.78 03:37:57 INFO - PROCESS | 8230 | Values: 57.0 55.0 54.0 54.0 56.0 55.0 56.0 65.0 53.0 52.0 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 03:37:57 INFO - PROCESS | 8230 | Values: 64.0 65.0 64.0 64.0 64.0 64.0 64.0 65.0 63.0 64.0 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:0.67 (0.9%) stddev-sans-first:0.67 03:37:57 INFO - PROCESS | 8230 | Values: 78.0 78.0 79.0 78.0 80.0 79.0 79.0 79.0 79.0 78.0 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#11] stanford-crypto-ccm Cycles:10 Average:114.70 Median:114.50 stddev:2.98 (2.6%) stddev-sans-first:3.16 03:37:57 INFO - PROCESS | 8230 | Values: 115.0 117.0 113.0 122.0 113.0 114.0 112.0 114.0 115.0 112.0 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:144.50 stddev:4.13 (2.9%) stddev-sans-first:4.15 03:37:57 INFO - PROCESS | 8230 | Values: 147.0 145.0 147.0 148.0 142.0 135.0 138.0 144.0 142.0 144.0 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - PROCESS | 8230 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:2.13 (3.1%) stddev-sans-first:2.24 03:37:57 INFO - PROCESS | 8230 | Values: 69.0 70.0 67.0 67.0 68.0 66.0 70.0 72.0 67.0 65.0 03:37:57 INFO - PROCESS | 8230 | -------- Summary: end -------- 03:37:57 INFO - PROCESS | 8230 | 03:37:57 INFO - TEST-INFO | 8230: exit 0 03:37:57 INFO - TEST-OK | kraken | took 59220ms 03:37:57 INFO - SUITE-END | took 1169s 03:37:58 INFO - Completed test suite (00:19:29) 03:37:58 INFO - javascript benchmark 03:37:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3205.0865503331547, 3273.4107860585086, 3283.835808209589, 3284.704376606105, 3318.717908977737, 5260.4213536511, 5270.0, 5283.498067683564, 5288.233206185101, 5299.443558426363, 5296.470352964701, 5297.099493086175, 5297.152455607104, 5302.840914772563, 5338.145896656536, 4775.928361074587, 4837.588804951583, 4838.104950584136, 4902.97548512257, 4959.181735013718, 4795.0889331027165, 4840.733759643218, 4859.951400486003, 4879.194932836078, 4941.283513890484, 4891.804327826882, 4941.160002799533, 4947.084789313971, 4952.380952380952, 4978.178600530908, 4788.664793464459, 4879.072976134558, 4903.926441103386, 4907.730074845882, 4944.60443164546, 4725.291206319045, 4808.951910480885, 4812.181929072066, 4837.612990960714, 4853.053654537367, 5127.769250383742, 5129.538341549279, 5145.562627176694, 5160.535551800356, 5163.380394352665, 5607.439256074401, 5609.793894312702, 5619.578531610146, 5629.690367029812, 5664.546836253131, 5670.6030577859565, 5686.260786097822, 5700.714964251771, 5724.971375143139, 5746.770129194827, 5328.3605967284175, 5330.733463326818, 5337.866553336159, 5347.839564813062, 5350.3312085989255, 5809.157672137517, 5814.215080964101, 5821.88356232873, 5824.068149096209, 5904.881902361929, 5608.6073974821375, 5621.128725047624, 5627.549796016309, 5640.323161220597, 5660.773569057274, 5666.575006874501, 5704.172894930211, 5721.656700597978, 5724.914126288109, 5728.51307638847, 5606.495415412633, 5616.354119276336, 5662.235598194274, 5692.943070569324, 5716.085426331767, 5643.379228284885, 5676.489115979582, 5677.687727174963, 5680.573956953245, 5693.0, 4363.323684828857, 4380.080183161572, 4387.210302145644, 4395.0, 4425.867223983221, 3862.7102967277565, 3911.5697273299916, 3970.6029397060643, 3983.48214732083, 3999.8000099994883, 5379.892402151935, 5390.191471279261, 5395.919061214085, 5399.514043736004, 5404.621676482609, 5735.713214339266, 5736.024875771129, 5736.5123964462655, 5737.08206686928, 5762.279715035621, 5311.0, 5326.893462130735, 5360.946390536123, 5404.32445944257, 5417.783288668488, 4945.4807245238735, 4970.130227210224, 4971.676841005323, 4973.502649734997, 4991.47589503097, 5822.33043200029, 5874.765009399576, 5896.528277737771, 5898.410158984153, 5900.291964964146, 5583.469570390806, 5674.971625141848, 5691.686957217393, 5719.256496655408, 5733.8566535836935, 5872.383399742966, 5879.118132280192, 5884.029135192816, 5910.261217347832, 5918.023526118142, 5556.499915007668, 5672.716364181857, 5682.176084467646, 5682.886342273214, 5692.857678558069, 5767.538596912321, 5772.105323674838, 5776.364599893925, 5786.0, 5819.447152520504, 5551.444855514416, 5553.666779993213, 5554.861128471821, 5555.916661250004, 5630.0428927081675, 5499.945000550103, 5544.0, 5585.860353491195, 5613.073842815889, 5624.831255062355, 5444.101723215784, 5447.073997420527, 5458.1266997280245, 5459.317585301837, 5478.0, 5518.310211223597, 5522.530584900168, 5540.36285827135, 5540.445955404427, 5568.136938774496, 5399.055165346127, 5434.347878254634, 5451.836444906659, 5470.671759694272, 5480.3971563128825], "unit": "score", "name": "dojo.html", "value": 5262.3544616391455}, {"lowerIsBetter": false, "replicates": [546.0880329849151, 578.942105789421, 590.9793157239498, 591.4144996453513, 600.7747094839434, 40981.18037639249, 41722.0, 42046.36930446046, 42076.36885446717, 42148.57851421489, 42439.0, 43141.784291078504, 43159.136817263636, 43877.341839872344, 44130.0, 8632.43889147205, 8811.559422028906, 8811.867821982676, 8812.471251724917, 8841.204291613754, 8826.955865220698, 8946.239569636557, 8960.372773905829, 9073.954630226872, 9088.091190880925, 9109.45343279402, 9130.497822619753, 9183.448993060405, 9214.493202873839, 9221.123993220634, 9041.502717350542, 9098.044705305914, 9115.726528204164, 9127.452352858849, 9171.358004939657, 9035.232005279559, 9143.268538516902, 9143.405678630868, 9159.816803663889, 9183.770405739842, 43316.0, 43973.78013109946, 44048.11903761939, 44431.111377772584, 44632.330515042304, 3647.5075864758182, 3740.6259374062647, 3841.0397400649836, 3886.0, 3971.940420893689, 33516.162095947795, 33529.497057544155, 33824.32351352984, 34062.0, 34431.0, 4186.330187170069, 4289.420928174688, 4297.785110744481, 4332.285172946492, 4336.154449882274, 307464.9999999978, 307892.0, 308584.0, 310181.0, 310216.0, 46399.0, 60358.887438939426, 60728.0, 60840.0, 61155.08267375993, 48948.5105148944, 48965.265521017216, 48976.265356019685, 49035.50964490381, 49043.75478122586, 15748.133852637986, 15905.284262207997, 15950.122743249232, 15953.202339883192, 15989.04065756035, 12872.93563532195, 12895.0, 12923.353832308347, 13116.934415327862, 13392.263425511495, 15575.454859080104, 15747.763783543256, 15798.36806527726, 15898.0, 15909.443169489012, 5921.526277897758, 5956.761729530857, 6002.459778619946, 6071.51427885768, 6120.724567394478, 1018.1447584029451, 1048.7077534791254, 1051.9474026298653, 1062.9529913035653, 1092.6995076353908, 28817.56773648397, 28970.855145724137, 29081.85459072691, 29145.12564623065, 29848.701512984593, 1087.0269812063998, 1108.7837871614959, 1171.6016554371383, 1227.7974134267745, 1258.4085479824469, 15335.539933802003, 15548.611284717972, 15837.128957907426, 15855.286512106983, 16129.435469758502, 346808.0, 347411.0, 348012.0, 351117.0, 351589.0, 59612.0, 60106.0, 60271.39728602746, 60272.0, 60443.69778151169, 1197.0902114393125, 1300.7723648361498, 1374.7181827725292, 1396.8114304568956, 1414.816073910385, 28971.0, 29317.26706832346, 31030.0, 31032.379352413278, 31660.0, 50789.74605126951, 51875.74062129816, 51917.221241682164, 52048.21927671012, 52113.47886521086, 291823.0, 305248.0, 305264.0, 305703.0, 306948.0, 31372.0, 34972.65027349694, 35420.46869296911, 36003.27993440064, 36183.09542261464, 44657.0, 45050.54949450595, 45506.0, 45681.54318456906, 46556.7672161637, 40873.38689919594, 41277.0, 41501.37747933844, 41534.169316614105, 41855.58144418517, 39420.21159576735, 39995.40006899841, 40892.59107408888, 41163.0, 41931.58068419277, 40514.18971620492, 41072.1785564293, 41202.38196427116, 41248.0, 41461.58538414577, 34749.652503474645, 35842.4623630651, 36205.81897090498, 37126.628733712314, 37494.625053749114, 27413.0, 27771.44457110887, 28020.0, 28044.71955280421, 28081.157565273075], "unit": "score", "name": "ext.html", "value": 19391.087662878548}, {"lowerIsBetter": false, "replicates": [381.80527930755306, 383.41912003314974, 388.7065265724378, 393.6358868047056, 396.7044551808903, 17550.297988080478, 18316.35892743754, 18731.71902421463, 18749.625007499842, 18797.624047519075, 11686.590969316076, 12001.459934302955, 12034.81947770784, 12092.576759813408, 12096.455659495321, 5176.327077479922, 5210.0, 5358.973205133969, 5364.275822763916, 5376.381716102659, 5254.842354729364, 5296.735163241822, 5315.893682126355, 5318.1225097858805, 5346.465353464642, 5296.179092240709, 5300.575953923696, 5302.284191634138, 5490.231367608538, 5770.711464426783, 5709.143628455723, 5739.139129130622, 5739.483446489836, 5764.07774756037, 5791.247137872071, 5488.368837583689, 5519.448055194489, 5562.360328562227, 5566.526845218162, 5590.776368945238, 13375.598732038054, 13923.58229253124, 13958.371873265625, 13996.860031399658, 14010.22943738094, 2241.60771864923, 2398.748131446208, 2461.4707837814776, 2538.9111381101575, 2736.53478908586, 9705.175060119898, 9724.611015559369, 10062.64780732678, 10080.445575493344, 10398.532066057045, 1915.3966500552422, 1930.0928563575237, 1936.9903150484158, 1964.7151163081273, 1976.3675623800389, 63434.0, 64382.67808660973, 65834.3416565833, 67971.0, 68491.65754171247, 10492.317999330018, 10575.524101415454, 10655.68032958997, 10656.520456579472, 10682.786344273227, 15046.398144074334, 15081.396744130332, 15188.848111518744, 15240.314185861664, 15265.3893844245, 7713.65288562016, 7750.224977502317, 7763.146053934062, 7786.727464538827, 7897.486663366863, 7368.521046131984, 7434.405247580181, 7489.962550187214, 7558.433117516208, 7586.165521792598, 4642.46611639659, 4691.085238378483, 4757.215059515142, 4769.379980602499, 4796.952030479721, 1840.0, 1878.5773201029658, 1908.9800691731457, 1919.0980239287512, 2002.8497862660067, 968.25444407807, 981.7398389426808, 1016.4409574733867, 1016.6289304403987, 1027.0, 17457.30170793154, 17624.735628965576, 17644.558886027953, 17779.555511112325, 18340.908295458437, 975.1516180922642, 979.3095867413457, 988.7528117970508, 1001.3591301567003, 1007.6422869881234, 9997.400155990665, 10342.948285258526, 10390.168786497063, 10461.633842815465, 10547.736306592396, 443396.0, 448762.0, 450098.0, 458474.0, 458954.0, 47472.7626361866, 57329.713351432976, 66385.67228655399, 70389.64805176044, 70975.0, 998.7553049502773, 1026.2816028780032, 1033.1166852341291, 1056.8309070548828, 1057.751428414322, 15249.6187595311, 15519.301631426839, 15522.991005585052, 15610.45363412275, 15679.0, 34438.0, 35278.64721352753, 35699.28601427905, 36023.27953440969, 36375.0, 45258.547414525434, 48415.5158448411, 53130.0, 54440.72779636235, 55953.16070259031, 10784.406857622906, 11490.482928268415, 11844.0, 12349.938250309051, 12633.2420054797, 13071.0, 13305.80041299362, 13442.327883605585, 13637.249951252776, 13690.52083177084, 12051.879481205076, 12144.878551214375, 12279.14046016806, 12421.503139874665, 12493.875061249635, 11768.70578235551, 11993.460294286604, 12103.273803571814, 12203.938980305396, 12218.572349967708, 12328.260304381765, 12421.31682757457, 12628.936855315664, 12725.872741272839, 12763.106582539132, 11777.705557361134, 11978.64064078079, 12367.381630918599, 12445.377731113227, 12531.18547294423, 12407.93796031014, 12539.184952978027, 12541.811872822098, 12550.246985180918, 12753.872461275269], "unit": "score", "name": "jquery.html", "value": 8817.155366386954}, {"lowerIsBetter": false, "replicates": [1389.0693235532192, 1513.894027418081, 1521.6652336485972, 1671.7743104680865, 1769.389560601592, 7635.083789945207, 8067.435279530428, 8230.465019773717, 8270.627821748021, 8316.625751841166, 8313.41806073575, 8373.790655233623, 8457.78855528612, 8466.195711407407, 8490.91509084909, 2143.4641339665086, 2378.595638741414, 2418.6251131074623, 2440.877196489608, 2486.614574740909, 2465.494573612405, 2468.136152346682, 2486.651868738378, 2490.476999830038, 2494.5260400523935, 2479.070348619268, 2516.962245566318, 2517.3203235126507, 2521.848689078652, 2523.3060908250286, 2364.113457453455, 2412.601920683085, 2415.794657454101, 2416.8429052111555, 2417.1781594258036, 2433.9756602433927, 2445.119756887519, 2452.509498100387, 2458.852468851857, 2474.6288056791627, 8417.831643367159, 8485.95757021211, 8492.53291068991, 8502.44734092282, 8568.314534837198, 5264.710440925747, 5362.410134885159, 5363.865903352447, 5390.595705322077, 5394.02907476654, 3099.0, 3187.2509960159346, 3213.694699003591, 3228.4350238708134, 3229.6285927118447, 1018.251585084962, 1044.613493007592, 1048.0, 1053.7260312318851, 1073.726199819049, 12088.576899808553, 12123.696907577292, 12128.818067728991, 12141.271523708605, 12214.57248996281, 4563.452385713669, 4633.189191891473, 4693.084848454587, 4740.45484769249, 4815.7351345676325, 10209.234307426825, 10277.845832312521, 10399.84400233997, 10431.94784026075, 10433.32183408076, 4852.320675105488, 5305.124654431976, 5320.467953204648, 5324.813631522956, 5331.280277162611, 4709.717416954925, 4843.297721830315, 4847.684900481458, 4859.854204373874, 4860.246661767432, 3903.551091624443, 3958.2083583282883, 3967.6627486663956, 3988.9229907924696, 4053.43251944728, 1326.774448343784, 1334.5595953335376, 1341.4097796969302, 1341.5774031180147, 1351.2838195756265, 1347.1512946843427, 1357.755603991291, 1367.2890097149625, 1402.9127426244743, 1421.1970236816167, 8097.676092956216, 8145.551994640233, 8195.221453961984, 8218.301444377295, 8235.21765432283, 546.66926509462, 552.1827695011325, 555.5333519843351, 555.919391688203, 557.1559087981711, 5912.113183022495, 5951.464368206795, 5982.910256346158, 6006.969965150233, 6012.549058820606, 10555.894441055645, 10754.78490430187, 10881.0, 10899.782004360028, 10905.073068789083, 10079.748006299902, 10620.681379558471, 10649.84025239622, 10650.041496265218, 10652.680419587425, 7679.539227646359, 7744.876992836007, 7753.147153813076, 7771.378289736807, 7868.527888326718, 8035.156308587748, 8059.3552515799765, 8068.031836179696, 8076.919230807852, 8167.0199576051255, 9268.443893366419, 9356.345055846026, 9366.67216647414, 9484.478353690338, 9491.905080949378, 9711.951440243036, 9876.308658394131, 9929.0, 10102.949485252526, 10309.123724483503, 6868.210155832143, 7040.119985001875, 7569.735059272899, 7643.88534171999, 7767.689292428466, 8095.595220238847, 8108.189181081844, 8123.431359804993, 8149.388795840217, 8164.224398682116, 7133.251008644018, 7327.63361831917, 7408.851822963618, 7474.2525747424825, 7477.66350514239, 7257.165425976081, 7410.0, 7417.962910185631, 7543.245675432413, 7555.9244407555225, 7721.227877212458, 7738.690452381842, 7779.416543759127, 7786.454948153575, 7788.688452461838, 6794.422474089758, 6863.073485079451, 6884.242733299433, 6889.242183359726, 6898.655067246718, 7066.434685225273, 7104.467164962752, 7148.785536433916, 7154.606496642735, 7165.820854478471], "unit": "score", "name": "mootools.html", "value": 4806.7169355727}, {"lowerIsBetter": false, "replicates": [359.58647555311387, 360.20394927210856, 366.06835603389374, 371.18710025045164, 381.0720894621597, 5985.371535988724, 5996.2504686914135, 5999.280086389628, 6001.399860013997, 6001.729922153508, 5891.116332550119, 5922.733476993535, 5924.88150236995, 5950.434708702677, 5952.3750006249265, 4440.311751678495, 4454.710443821157, 4521.615662668677, 4578.519255478177, 4663.183942810003, 4582.679212455129, 4583.404157459526, 4583.793729282173, 4585.977070114662, 4589.816407343702, 4503.0, 4546.181687296285, 4559.293309537011, 4564.269716845305, 4572.428446444194, 4435.68950173488, 4508.098380323932, 4566.954330456686, 4573.862784116482, 4576.359309696645, 4031.21391328691, 4032.1330913853367, 4040.919181616351, 4043.757374557536, 4044.6562042226446, 5663.546916246691, 5669.092945128759, 5676.801311954062, 5687.829365119053, 5697.430256974311, 5306.814261500867, 5335.9466405336225, 5340.305760251143, 5341.385740639837, 5364.168553874156, 6263.561550691454, 6300.68496575174, 6328.968355158195, 6329.113924050636, 6342.746290148389, 4392.989612389137, 4470.932936005963, 4528.8867778305475, 4554.817807287704, 4570.10882877839, 6501.317361677003, 6517.348265173445, 6529.444997175246, 6534.967325163391, 6545.803625891231, 4678.672492925462, 4681.602063824613, 4687.062587482449, 4690.788914498856, 4699.201135806853, 4768.237082066853, 4777.570018698264, 4780.282957556325, 4782.402199725035, 4794.976025119852, 5355.919661205085, 5359.544438722674, 5360.91958620621, 5367.168088946141, 5367.463253674601, 5998.49012833914, 6263.968680156661, 6276.686165691697, 6303.716332765037, 6306.770179814984, 1587.317453494985, 1600.3998500562288, 1608.9356425743074, 1614.6205641674196, 1620.7974003249594, 1016.7305663999047, 1039.2465462539749, 1068.5351871935734, 1075.6181555547669, 1103.2553026706942, 5970.641761494324, 6015.157877897011, 6016.578839481194, 6016.729247183887, 6052.426369144055, 6418.587910659648, 6453.386928241809, 6457.160569125984, 6457.160569125984, 6467.805965821033, 6013.6993150342305, 6049.0926361046195, 6049.697515124226, 6049.969750151309, 6052.243469566304, 3472.5832900052155, 3489.685928266468, 3492.1967947372245, 3503.8423270952867, 3505.053635518396, 6501.0, 6589.17635295588, 6609.405153536205, 6730.9326906731285, 6740.022696708949, 6661.633610151488, 6734.797956061326, 6749.32506749331, 6752.054712340277, 6758.797236082925, 6609.339066093352, 6654.900176497356, 6700.564463309966, 6715.3620406061345, 6722.596644201363, 6545.37818907203, 6546.24718157418, 6549.410553050248, 6553.279139294769, 6553.705083271169, 6274.811755647338, 6423.871522569616, 6425.389587989133, 6429.646369449725, 6464.256610489854, 6711.731530738911, 6738.797836064926, 6743.763968261087, 6743.865122697421, 6749.73001079971, 4461.442319710036, 4509.0, 4515.367848501147, 4515.435570553681, 4516.390287311171, 6534.150560427114, 6536.640484773383, 6536.640484773383, 6543.116679248241, 6557.245916719638, 6307.842303942438, 6344.746210151542, 6355.173827402408, 6366.790309841301, 6373.203349581302, 6168.074788781719, 6325.462335701517, 6333.95489744187, 6337.112804207322, 6346.111544383698, 6243.562950593597, 6273.780417685359, 6276.874462510816, 6283.937160628335, 6341.746330146742, 6382.266039405342, 6396.936030639634, 6398.648074355955, 6424.421802037839, 6433.8713225736155, 5949.494292985145, 6102.694865256631, 6225.346338634378, 6233.065040244, 6235.937640623536], "unit": "score", "name": "prototype.html", "value": 4797.179925522913}, {"lowerIsBetter": false, "replicates": [753.5554023126361, 769.3191525499933, 844.2275318083949, 851.8637018077105, 883.5847151838638, 14404.27978601071, 14744.926275368622, 14912.105273683586, 14934.0, 14937.477188298411, 14252.073615215004, 14326.140431574113, 14365.49720759771, 14385.568432947002, 14392.784108238386, 654.9017647352912, 901.2654686430554, 905.3210092430677, 923.9584218710174, 933.0436302789627, 748.8652042632324, 752.0035952363113, 754.6528596845458, 759.5860256160406, 764.1403421151205, 957.4829592020335, 958.520739630185, 958.7698952251444, 958.9280803939697, 972.9659461918834, 802.7631848604676, 952.347641865321, 969.9563519641633, 971.3540495570437, 971.917387022104, 707.1655446573042, 712.9429645628337, 715.1346870286959, 716.7204790131852, 720.0243669827413, 14693.706125877423, 14749.77875331871, 14758.114513129247, 14775.482858099915, 14775.852241477663, 13389.397477113553, 13606.115602485806, 13673.384697688529, 13781.724365512733, 14168.362423690958, 11689.70775730605, 11829.467673954692, 11847.170698051139, 12046.397680115959, 12080.15438919276, 3923.3526468132723, 3953.2686453006286, 3991.521017477892, 4056.492938382702, 4057.5536690963972, 47659.52340476585, 48206.75896620529, 48237.75881120607, 48316.0, 48530.51469485295, 10422.166226701846, 11275.323480591027, 11293.0, 11350.54597816078, 11363.602273920538, 19483.123259453074, 19507.219711211677, 19517.609647806963, 19535.902320488305, 19564.315248966217, 7737.883931741028, 7905.841883162419, 7912.367010639135, 7969.203079691984, 8025.719099831478, 4471.374007638933, 4474.395956545824, 4528.184926713157, 4545.840895568639, 4619.19164146273, 3402.302527981758, 3434.244466217428, 3440.2947395783804, 3449.1549570355423, 3461.2558299965126, 621.7357623010203, 641.0704478506185, 667.5527396644163, 694.5173104692191, 710.9466789990771, 633.2211380002531, 690.927452617478, 718.8490417012381, 726.934575888162, 739.5969196787763, 8437.509353393558, 8437.620307086074, 8524.70163544273, 8562.357823163287, 8677.262432693291, 686.5400181878153, 686.6086330791401, 691.9550229235184, 697.1355519156311, 697.2260790522516, 4090.1206240657807, 4168.041350489404, 4194.602372078626, 4242.321228603409, 4334.7399156050105, 57191.0, 58620.70689646524, 58984.0, 58998.11502827461, 59000.40999589949, 50522.242166367534, 51981.0, 53289.0, 53396.73301633467, 54670.17994730082, 46972.5302746975, 47998.0, 48262.5173748258, 48274.517254827006, 48363.758181209574, 8470.957645211734, 8716.91283087161, 8770.210681038481, 8853.070427605266, 9045.68340108093, 35587.288254234256, 35785.821070894475, 36014.45978310275, 37110.25779484449, 37231.25537489289, 42806.57193428151, 43753.56246437495, 44125.77937110294, 46758.0, 46943.29585056158, 11098.0, 11182.776344473228, 11265.662030139109, 11454.427278635869, 11702.063834893359, 12381.62855114348, 12544.686382840502, 12560.12079154487, 13053.804192937303, 13128.60614181576, 11559.884401155881, 11808.645740627795, 11954.880451195377, 12013.793651739996, 12342.259464432163, 11238.55045798159, 11254.88745112571, 11270.774584508428, 11406.201565890307, 11451.65645030617, 11422.543098275975, 11647.13887660989, 11748.647540573797, 11801.940990294994, 11865.822012669643, 9607.615695372107, 9846.507674616383, 9968.55141518619, 10101.595936162472, 10128.594856205964, 10022.24833137503, 10249.0, 10285.53715082808, 10314.48427578603, 10316.329438586468], "unit": "score", "name": "yui.html", "value": 6691.114387644047}], "name": "dromaeo_css", "value": 7195.819617853481}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 110.0, 111.0, 112.0, 102.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [155.0, 134.0, 163.0, 177.0, 135.0, 153.0, 159.0, 128.0, 173.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 150.5}, {"lowerIsBetter": true, "replicates": [160.0, 163.0, 162.0, 163.0, 160.0, 160.0, 160.0, 163.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 79.0, 164.0, 76.0, 75.0, 75.0, 78.0, 172.0, 77.0], "unit": "score", "name": "audio-fft", "value": 94.7}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 146.0, 94.0, 94.0, 93.0, 148.0, 95.0, 95.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 118.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [148.0, 151.0, 146.0, 146.0, 147.0, 145.0, 146.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 54.0, 54.0, 56.0, 55.0, 56.0, 65.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 63.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 79.0, 78.0, 80.0, 79.0, 79.0, 79.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.7}, {"lowerIsBetter": true, "replicates": [115.0, 117.0, 113.0, 122.0, 113.0, 114.0, 112.0, 114.0, 115.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.7}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 147.0, 148.0, 142.0, 135.0, 138.0, 144.0, 142.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 67.0, 67.0, 68.0, 66.0, 70.0, 72.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1509.8}]} 03:37:58 INFO - Return code: 0 03:37:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:37:58 INFO - # TBPL SUCCESS # 03:37:58 INFO - Running post-action listener: _resource_record_post_action 03:37:58 INFO - Running post-run listener: _resource_record_post_run 03:37:59 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 494993408; Read time: 0; Write time: 517912 03:37:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 185294848; Read time: 0; Write time: 273380 03:37:59 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 238710784; Read time: 0; Write time: 191480 03:37:59 INFO - Running post-run listener: _upload_blobber_files 03:37:59 INFO - Blob upload gear active. 03:37:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:37:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:37:59 INFO - (blobuploader) - INFO - Open directory for files ... 03:37:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:37:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:38:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:00 INFO - (blobuploader) - INFO - Done attempting. 03:38:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:38:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:38:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:01 INFO - (blobuploader) - INFO - Done attempting. 03:38:01 INFO - (blobuploader) - INFO - Iteration through files over. 03:38:01 INFO - Return code: 0 03:38:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:38:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:38:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f005aaa4bf31241db09a6e12018d8bb9e4ab2fd4883575c89f21bbb252d221f47eb55a14ab3b3e868483916b762759afa566301a608023a8155d886fbd8afe88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66127893f657c521098862957d92effb76bce55090e29303f97b4993bb794627a171546e2bb6f4d45e9e780bb4762c9b5ed0b7737211cdce8d8e9ae7cd416e4a"} 03:38:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:38:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:38:01 INFO - Contents: 03:38:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f005aaa4bf31241db09a6e12018d8bb9e4ab2fd4883575c89f21bbb252d221f47eb55a14ab3b3e868483916b762759afa566301a608023a8155d886fbd8afe88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66127893f657c521098862957d92effb76bce55090e29303f97b4993bb794627a171546e2bb6f4d45e9e780bb4762c9b5ed0b7737211cdce8d8e9ae7cd416e4a"} 03:38:01 INFO - Running post-run listener: copy_logs_to_upload_dir 03:38:01 INFO - Copying logs to upload dir... 03:38:01 INFO - mkdir: /builds/slave/test/build/upload/logs 03:38:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.089067 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-24 03:38:00.813099) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 03:38:00.816341) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f005aaa4bf31241db09a6e12018d8bb9e4ab2fd4883575c89f21bbb252d221f47eb55a14ab3b3e868483916b762759afa566301a608023a8155d886fbd8afe88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66127893f657c521098862957d92effb76bce55090e29303f97b4993bb794627a171546e2bb6f4d45e9e780bb4762c9b5ed0b7737211cdce8d8e9ae7cd416e4a"} build_url:https://queue.taskcluster.net/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/WRVU0EMpRHqwK2lceU4rYg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f005aaa4bf31241db09a6e12018d8bb9e4ab2fd4883575c89f21bbb252d221f47eb55a14ab3b3e868483916b762759afa566301a608023a8155d886fbd8afe88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66127893f657c521098862957d92effb76bce55090e29303f97b4993bb794627a171546e2bb6f4d45e9e780bb4762c9b5ed0b7737211cdce8d8e9ae7cd416e4a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 03:38:00.840492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 03:38:00.840786) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461489672.604999-190093249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004727 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 03:38:00.892695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 03:38:00.892977) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 03:38:00.893255) ========= ========= Total master_lag: 0.13 =========