builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1461754615.19 results: success (0) buildid: 20160425042155 builduid: 3cafbae6ee4445cbb07d61c2d398d690 revision: f328ac32af6a3d0ce1593c41fd18edf7216a1652 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:55.191262) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:55.191806) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:55.192093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:55.206438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:55.206773) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 03:56:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-04-27 03:56:57 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:55.343422) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:55.343758) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017174 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:55.393843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:55.394260) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f328ac32af6a3d0ce1593c41fd18edf7216a1652 --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 f328ac32af6a3d0ce1593c41fd18edf7216a1652 --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=a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 03:56:57,572 truncating revision to first 12 chars 2016-04-27 03:56:57,572 Setting DEBUG logging. 2016-04-27 03:56:57,572 attempt 1/10 2016-04-27 03:56:57,572 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f328ac32af6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 03:56:57,886 unpacking tar archive at: mozilla-aurora-f328ac32af6a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596129 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:56.005702) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:56.006248) ========= script_repo_revision: f328ac32af6a3d0ce1593c41fd18edf7216a1652 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:56.006907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:56.007349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:56:56.018384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-04-27 03:56:56.018734) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:56:58 INFO - MultiFileLogger online at 20160427 03:56:58 in /builds/slave/test 03:56:58 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:56:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:56:58 INFO - {'append_to_log': False, 03:56:58 INFO - 'base_work_dir': '/builds/slave/test', 03:56:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:56:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:56:58 INFO - 'branch': 'Mozilla-Aurora', 03:56:58 INFO - 'buildbot_json_path': 'buildprops.json', 03:56:58 INFO - 'config_files': ('talos/linux_config.py',), 03:56:58 INFO - 'default_actions': ('clobber', 03:56:58 INFO - 'read-buildbot-config', 03:56:58 INFO - 'download-and-extract', 03:56:58 INFO - 'populate-webroot', 03:56:58 INFO - 'create-virtualenv', 03:56:58 INFO - 'install', 03:56:58 INFO - 'run-tests'), 03:56:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:56:58 INFO - 'download_minidump_stackwalk': True, 03:56:58 INFO - 'download_symbols': 'ondemand', 03:56:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:56:58 INFO - 'tooltool.py': '/tools/tooltool.py', 03:56:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:56:58 INFO - '/tools/misc-python/virtualenv.py')}, 03:56:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:56:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:56:58 INFO - 'installer_path': 'installer.exe', 03:56:58 INFO - 'log_level': 'info', 03:56:58 INFO - 'log_name': 'talos', 03:56:58 INFO - 'log_to_console': True, 03:56:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:56:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:56:58 INFO - 'opt_config_files': (), 03:56:58 INFO - 'pip_index': False, 03:56:58 INFO - 'sps_profile': False, 03:56:58 INFO - 'sps_profile_interval': 0, 03:56:58 INFO - 'suite': 'dromaeojs', 03:56:58 INFO - 'system_bits': '32', 03:56:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:56:58 INFO - 'title': 'talos-linux64-ix-064', 03:56:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:56:58 INFO - 'use_talos_json': True, 03:56:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:56:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:56:58 INFO - 'work_dir': 'build'} 03:56:58 INFO - ##### 03:56:58 INFO - ##### Running clobber step. 03:56:58 INFO - ##### 03:56:58 INFO - Running pre-action listener: _resource_record_pre_action 03:56:58 INFO - Running main action method: clobber 03:56:58 INFO - rmtree: /builds/slave/test/build 03:56:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:56:58 INFO - Running post-action listener: _resource_record_post_action 03:56:58 INFO - ##### 03:56:58 INFO - ##### Running read-buildbot-config step. 03:56:58 INFO - ##### 03:56:58 INFO - Running pre-action listener: _resource_record_pre_action 03:56:58 INFO - Running main action method: read_buildbot_config 03:56:58 INFO - Using buildbot properties: 03:56:58 INFO - { 03:56:58 INFO - "project": "", 03:56:58 INFO - "product": "firefox", 03:56:58 INFO - "script_repo_revision": "production", 03:56:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:56:58 INFO - "repository": "", 03:56:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:56:58 INFO - "buildid": "20160425042155", 03:56:58 INFO - "pgo_build": "True", 03:56:58 INFO - "basedir": "/builds/slave/test", 03:56:58 INFO - "buildnumber": 200, 03:56:58 INFO - "slavename": "talos-linux64-ix-064", 03:56:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:56:58 INFO - "platform": "ubuntu64_hw", 03:56:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:56:58 INFO - "branch": "mozilla-aurora", 03:56:58 INFO - "repo_path": "releases/mozilla-aurora", 03:56:58 INFO - "revision": "f328ac32af6a3d0ce1593c41fd18edf7216a1652", 03:56:58 INFO - "stage_platform": "linux64-pgo", 03:56:58 INFO - "builduid": "3cafbae6ee4445cbb07d61c2d398d690", 03:56:58 INFO - "slavebuilddir": "test" 03:56:58 INFO - } 03:56:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:56:58 INFO - Running post-action listener: _resource_record_post_action 03:56:58 INFO - ##### 03:56:58 INFO - ##### Running download-and-extract step. 03:56:58 INFO - ##### 03:56:58 INFO - Running pre-action listener: _resource_record_pre_action 03:56:58 INFO - Running main action method: download_and_extract 03:56:58 INFO - mkdir: /builds/slave/test/build/tests 03:56: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:56:58 INFO - https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:56:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:56:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:56:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/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:56:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/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:56:59 INFO - Downloaded 1448 bytes. 03:56:59 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:56:59 INFO - Using the following test package requirements: 03:56:59 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:56:59 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:56:59 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:56:59 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:56:59 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:56:59 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:56:59 INFO - u'jsshell-linux-x86_64.zip'], 03:56:59 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:56:59 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:56:59 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:56:59 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:56:59 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:56:59 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:56:59 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:56:59 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:56:59 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:56:59 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:56:59 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:56:59 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:56:59 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:59 INFO - https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:56:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:56:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:56:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/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:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/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:57:00 INFO - Downloaded 23359883 bytes. 03:57:00 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:57:00 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:57:01 INFO - Return code: 0 03:57:01 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:57: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:57:01 INFO - https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:57:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:57:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:57:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/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:57:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/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:57:02 INFO - Downloaded 23359883 bytes. 03:57:02 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:57:02 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:57:04 INFO - Return code: 0 03:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:04 INFO - https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:57:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:57:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:57:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/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:57:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/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:57:05 INFO - Downloaded 10845194 bytes. 03:57:05 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:57:05 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:57:05 INFO - Return code: 0 03:57: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:57:05 INFO - https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:57:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:57:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:57:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/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:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/flbnhoNVSWK3J8Ku8n48-A/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:57:07 INFO - Downloaded 60838843 bytes. 03:57:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:57:07 INFO - mkdir: /builds/slave/test/properties 03:57:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:57:07 INFO - Writing to file /builds/slave/test/properties/build_url 03:57:07 INFO - Contents: 03:57:07 INFO - build_url:https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:57:08 INFO - Running post-action listener: _resource_record_post_action 03:57:08 INFO - Running post-action listener: set_extra_try_arguments 03:57:08 INFO - ##### 03:57:08 INFO - ##### Running populate-webroot step. 03:57:08 INFO - ##### 03:57:08 INFO - Running pre-action listener: _resource_record_pre_action 03:57:08 INFO - Running main action method: populate_webroot 03:57:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:57:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:57:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:57:08 INFO - '--tppagecycles', 03:57:08 INFO - '7'], 03:57:08 INFO - 'tests': ['tsvgm']}}, 03:57:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:57:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:57:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:57:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:57:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:57:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:57:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:57:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:08 INFO - 'talos_options': ['--e10s'], 03:57:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:57:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:08 INFO - 'tests': ['damp', 'tps']}, 03:57:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:08 INFO - 'talos_options': ['--e10s'], 03:57:08 INFO - 'tests': ['damp', 'tps']}, 03:57:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:57:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:57:08 INFO - 'other': {'tests': ['a11yr', 03:57:08 INFO - 'ts_paint', 03:57:08 INFO - 'tpaint', 03:57:08 INFO - 'sessionrestore', 03:57:08 INFO - 'sessionrestore_no_auto_restore', 03:57:08 INFO - 'tabpaint']}, 03:57:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:57:08 INFO - 'tests': ['a11yr', 03:57:08 INFO - 'ts_paint', 03:57:08 INFO - 'tpaint', 03:57:08 INFO - 'sessionrestore', 03:57:08 INFO - 'sessionrestore_no_auto_restore', 03:57:08 INFO - 'tabpaint']}, 03:57:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:57:08 INFO - 'tests': ['a11yr', 03:57:08 INFO - 'ts_paint', 03:57:08 INFO - 'tpaint', 03:57:08 INFO - 'sessionrestore', 03:57:08 INFO - 'sessionrestore_no_auto_restore', 03:57:08 INFO - 'tabpaint']}, 03:57:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:57:08 INFO - 'tests': ['a11yr', 03:57:08 INFO - 'ts_paint', 03:57:08 INFO - 'tpaint', 03:57:08 INFO - 'sessionrestore', 03:57:08 INFO - 'sessionrestore_no_auto_restore', 03:57:08 INFO - 'tabpaint']}, 03:57:08 INFO - 'other_l64': {'tests': ['a11yr', 03:57:08 INFO - 'ts_paint', 03:57:08 INFO - 'tpaint', 03:57:08 INFO - 'sessionrestore', 03:57:08 INFO - 'sessionrestore_no_auto_restore', 03:57:08 INFO - 'tabpaint']}, 03:57:08 INFO - 'other_nol64': {'tests': ['a11yr', 03:57:08 INFO - 'ts_paint', 03:57:08 INFO - 'tpaint', 03:57:08 INFO - 'sessionrestore', 03:57:08 INFO - 'sessionrestore_no_auto_restore', 03:57:08 INFO - 'tabpaint']}, 03:57:08 INFO - 'svgr': {'tests': ['tsvgx', 03:57:08 INFO - 'tsvgr_opacity', 03:57:08 INFO - 'tart', 03:57:08 INFO - 'tscrollx', 03:57:08 INFO - 'cart']}, 03:57:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:57:08 INFO - 'tests': ['tsvgx', 03:57:08 INFO - 'tsvgr_opacity', 03:57:08 INFO - 'tart', 03:57:08 INFO - 'tscrollx', 03:57:08 INFO - 'cart']}, 03:57:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:08 INFO - 'tests': ['tp5o']}, 03:57:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:08 INFO - 'talos_options': ['--e10s'], 03:57:08 INFO - 'tests': ['tp5o']}, 03:57:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:08 INFO - 'talos_options': ['--xperf_path', 03:57:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:57:08 INFO - 'tests': ['tp5n']}, 03:57:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:08 INFO - 'talos_options': ['--e10s', 03:57:08 INFO - '--xperf_path', 03:57:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:57:08 INFO - 'tests': ['tp5n']}}, 03:57:08 INFO - 'talos.zip': {'path': '', 03:57:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:57:08 INFO - Running post-action listener: _resource_record_post_action 03:57:08 INFO - ##### 03:57:08 INFO - ##### Running create-virtualenv step. 03:57:08 INFO - ##### 03:57:08 INFO - Running pre-action listener: _resource_record_pre_action 03:57:08 INFO - Running main action method: create_virtualenv 03:57:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:57:08 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:57:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:57:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:57:08 INFO - Using real prefix '/usr' 03:57:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:57:08 INFO - Installing distribute.............................................................................................................................................................................................done. 03:57:10 INFO - Installing pip.................done. 03:57:10 INFO - Return code: 0 03:57:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff855adbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c45410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd4160>, '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 0x1cd5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', '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:57:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:57:10 INFO - Using env: {'DISPLAY': ':0', 03:57:10 INFO - 'HOME': '/home/cltbld', 03:57:10 INFO - 'LANG': 'en_US.UTF-8', 03:57:10 INFO - 'LANGUAGE': 'en_US:en', 03:57:10 INFO - 'LOGNAME': 'cltbld', 03:57:10 INFO - 'MAIL': '/var/mail/cltbld', 03:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:10 INFO - 'MOZ_NO_REMOTE': '1', 03:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:10 INFO - 'NO_EM_RESTART': '1', 03:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:10 INFO - 'PWD': '/builds/slave/test', 03:57:10 INFO - 'SHELL': '/bin/bash', 03:57:10 INFO - 'SHLVL': '1', 03:57:10 INFO - 'TERM': 'linux', 03:57:10 INFO - 'TMOUT': '86400', 03:57:10 INFO - 'USER': 'cltbld', 03:57:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', 03:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:10 INFO - '_': '/tools/buildbot/bin/python'} 03:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:11 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:57:11 INFO - Cleaning up... 03:57:11 INFO - Return code: 0 03:57:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:57:11 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:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:11 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:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:11 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 0x7ff855adbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c45410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd4160>, '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 0x1cd5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', '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:57:11 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:57:11 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:57:11 INFO - Using env: {'DISPLAY': ':0', 03:57:11 INFO - 'HOME': '/home/cltbld', 03:57:11 INFO - 'LANG': 'en_US.UTF-8', 03:57:11 INFO - 'LANGUAGE': 'en_US:en', 03:57:11 INFO - 'LOGNAME': 'cltbld', 03:57:11 INFO - 'MAIL': '/var/mail/cltbld', 03:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:11 INFO - 'MOZ_NO_REMOTE': '1', 03:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:11 INFO - 'NO_EM_RESTART': '1', 03:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:11 INFO - 'PWD': '/builds/slave/test', 03:57:11 INFO - 'SHELL': '/bin/bash', 03:57:11 INFO - 'SHLVL': '1', 03:57:11 INFO - 'TERM': 'linux', 03:57:11 INFO - 'TMOUT': '86400', 03:57:11 INFO - 'USER': 'cltbld', 03:57:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', 03:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:11 INFO - '_': '/tools/buildbot/bin/python'} 03:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:11 INFO - Downloading/unpacking psutil>=0.7.1 03:57: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:57: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:57: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:57: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:57: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:57: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:57:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:57:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:13 INFO - Installing collected packages: psutil 03:57:13 INFO - Running setup.py install for psutil 03:57:13 INFO - building 'psutil._psutil_linux' extension 03:57:13 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:57:13 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:57:13 INFO - building 'psutil._psutil_posix' extension 03:57:13 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:57:13 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:57:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:13 INFO - Successfully installed psutil 03:57:13 INFO - Cleaning up... 03:57:13 INFO - Return code: 0 03:57:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:13 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 0x7ff855adbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c45410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd4160>, '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 0x1cd5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', '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:57:13 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:57:13 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:57:13 INFO - Using env: {'DISPLAY': ':0', 03:57:13 INFO - 'HOME': '/home/cltbld', 03:57:13 INFO - 'LANG': 'en_US.UTF-8', 03:57:13 INFO - 'LANGUAGE': 'en_US:en', 03:57:13 INFO - 'LOGNAME': 'cltbld', 03:57:13 INFO - 'MAIL': '/var/mail/cltbld', 03:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:13 INFO - 'MOZ_NO_REMOTE': '1', 03:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:13 INFO - 'NO_EM_RESTART': '1', 03:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:13 INFO - 'PWD': '/builds/slave/test', 03:57:13 INFO - 'SHELL': '/bin/bash', 03:57:13 INFO - 'SHLVL': '1', 03:57:13 INFO - 'TERM': 'linux', 03:57:13 INFO - 'TMOUT': '86400', 03:57:13 INFO - 'USER': 'cltbld', 03:57:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', 03:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:13 INFO - '_': '/tools/buildbot/bin/python'} 03:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:57:13 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:57:13 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:57:13 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:57:13 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:57:13 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:57:13 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:57:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:57:15 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:57:15 INFO - Installing collected packages: mozsystemmonitor 03:57:15 INFO - Running setup.py install for mozsystemmonitor 03:57:15 INFO - Successfully installed mozsystemmonitor 03:57:15 INFO - Cleaning up... 03:57:16 INFO - Return code: 0 03:57:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:16 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 0x7ff855adbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c45410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd4160>, '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 0x1cd5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', '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:57:16 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:57:16 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:57:16 INFO - Using env: {'DISPLAY': ':0', 03:57:16 INFO - 'HOME': '/home/cltbld', 03:57:16 INFO - 'LANG': 'en_US.UTF-8', 03:57:16 INFO - 'LANGUAGE': 'en_US:en', 03:57:16 INFO - 'LOGNAME': 'cltbld', 03:57:16 INFO - 'MAIL': '/var/mail/cltbld', 03:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:16 INFO - 'MOZ_NO_REMOTE': '1', 03:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:16 INFO - 'NO_EM_RESTART': '1', 03:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:16 INFO - 'PWD': '/builds/slave/test', 03:57:16 INFO - 'SHELL': '/bin/bash', 03:57:16 INFO - 'SHLVL': '1', 03:57:16 INFO - 'TERM': 'linux', 03:57:16 INFO - 'TMOUT': '86400', 03:57:16 INFO - 'USER': 'cltbld', 03:57:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', 03:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:16 INFO - '_': '/tools/buildbot/bin/python'} 03:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:16 INFO - Downloading/unpacking blobuploader==1.2.4 03:57:16 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:57:16 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:57:16 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:57:16 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:57:16 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:57:16 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:57:18 INFO - Downloading blobuploader-1.2.4.tar.gz 03:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:57:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:57:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:18 INFO - Downloading docopt-0.6.1.tar.gz 03:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:57:19 INFO - Installing collected packages: blobuploader, requests, docopt 03:57:19 INFO - Running setup.py install for blobuploader 03:57:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:57:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:57:19 INFO - Running setup.py install for requests 03:57:19 INFO - Running setup.py install for docopt 03:57:19 INFO - Successfully installed blobuploader requests docopt 03:57:19 INFO - Cleaning up... 03:57:19 INFO - Return code: 0 03:57:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:19 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 0x7ff855adbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c45410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd4160>, '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 0x1cd5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', '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:57:19 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:57:19 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:57:19 INFO - Using env: {'DISPLAY': ':0', 03:57:19 INFO - 'HOME': '/home/cltbld', 03:57:19 INFO - 'LANG': 'en_US.UTF-8', 03:57:19 INFO - 'LANGUAGE': 'en_US:en', 03:57:19 INFO - 'LOGNAME': 'cltbld', 03:57:19 INFO - 'MAIL': '/var/mail/cltbld', 03:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:19 INFO - 'MOZ_NO_REMOTE': '1', 03:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:19 INFO - 'NO_EM_RESTART': '1', 03:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:19 INFO - 'PWD': '/builds/slave/test', 03:57:19 INFO - 'SHELL': '/bin/bash', 03:57:19 INFO - 'SHLVL': '1', 03:57:19 INFO - 'TERM': 'linux', 03:57:19 INFO - 'TMOUT': '86400', 03:57:19 INFO - 'USER': 'cltbld', 03:57:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', 03:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:19 INFO - '_': '/tools/buildbot/bin/python'} 03:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:19 INFO - Running setup.py (path:/tmp/pip-au3_Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:19 INFO - Running setup.py (path:/tmp/pip-1rA0NS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:20 INFO - Running setup.py (path:/tmp/pip-4W0zv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:20 INFO - Running setup.py (path:/tmp/pip-0GmAIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:20 INFO - Running setup.py (path:/tmp/pip-ysJb7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:20 INFO - Running setup.py (path:/tmp/pip-0Uz2VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:20 INFO - Running setup.py (path:/tmp/pip-ioEvgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:20 INFO - Running setup.py (path:/tmp/pip-mwl64s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:20 INFO - Running setup.py (path:/tmp/pip-xHY62o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:20 INFO - Running setup.py (path:/tmp/pip-a9UBLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:20 INFO - Running setup.py (path:/tmp/pip-kpXcPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:20 INFO - Running setup.py (path:/tmp/pip-RHaH1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:20 INFO - Running setup.py (path:/tmp/pip-sVfAjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:20 INFO - Running setup.py (path:/tmp/pip-V5Eb67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:20 INFO - Running setup.py (path:/tmp/pip-Qrdn4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:20 INFO - Running setup.py (path:/tmp/pip-XLximD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:21 INFO - Running setup.py (path:/tmp/pip-zIvczG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:57:21 INFO - Running setup.py install for manifestparser 03:57:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:57:21 INFO - Running setup.py install for mozcrash 03:57:21 INFO - Running setup.py install for mozdebug 03:57:21 INFO - Running setup.py install for mozdevice 03:57:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:57:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:57:21 INFO - Running setup.py install for mozfile 03:57:21 INFO - Running setup.py install for mozhttpd 03:57:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:57:21 INFO - Running setup.py install for mozinfo 03:57:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:57:21 INFO - Running setup.py install for mozInstall 03:57:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:57:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:57:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:57:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:57:21 INFO - Running setup.py install for mozleak 03:57:21 INFO - Running setup.py install for mozlog 03:57:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:57:22 INFO - Running setup.py install for moznetwork 03:57:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:57:22 INFO - Running setup.py install for mozprocess 03:57:22 INFO - Running setup.py install for mozprofile 03:57:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:57:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:57:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:57:22 INFO - Running setup.py install for mozrunner 03:57:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:57:22 INFO - Running setup.py install for mozscreenshot 03:57:22 INFO - Running setup.py install for moztest 03:57:22 INFO - Running setup.py install for mozversion 03:57:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:57:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:57:22 INFO - Cleaning up... 03:57:22 INFO - Return code: 0 03:57:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:22 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 0x7ff855adbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c45410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd4160>, '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 0x1cd5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', '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:57:22 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:57:22 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:57:22 INFO - Using env: {'DISPLAY': ':0', 03:57:22 INFO - 'HOME': '/home/cltbld', 03:57:22 INFO - 'LANG': 'en_US.UTF-8', 03:57:22 INFO - 'LANGUAGE': 'en_US:en', 03:57:22 INFO - 'LOGNAME': 'cltbld', 03:57:22 INFO - 'MAIL': '/var/mail/cltbld', 03:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:22 INFO - 'MOZ_NO_REMOTE': '1', 03:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:22 INFO - 'NO_EM_RESTART': '1', 03:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:22 INFO - 'PWD': '/builds/slave/test', 03:57:22 INFO - 'SHELL': '/bin/bash', 03:57:22 INFO - 'SHLVL': '1', 03:57:22 INFO - 'TERM': 'linux', 03:57:22 INFO - 'TMOUT': '86400', 03:57:22 INFO - 'USER': 'cltbld', 03:57:22 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', 03:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:22 INFO - '_': '/tools/buildbot/bin/python'} 03:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:23 INFO - Running setup.py (path:/tmp/pip-OroAUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:23 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:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:23 INFO - Running setup.py (path:/tmp/pip-vlbHQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:23 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:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:23 INFO - Running setup.py (path:/tmp/pip-cRZRfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:23 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:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:23 INFO - Running setup.py (path:/tmp/pip-gEjWY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:23 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:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:23 INFO - Running setup.py (path:/tmp/pip-6UNcq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:23 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:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:23 INFO - Running setup.py (path:/tmp/pip-CDol3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:23 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:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:23 INFO - Running setup.py (path:/tmp/pip-ZcDujx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:23 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:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:23 INFO - Running setup.py (path:/tmp/pip-L96eo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:23 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:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:23 INFO - Running setup.py (path:/tmp/pip-1Fx0kB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:23 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:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:23 INFO - Running setup.py (path:/tmp/pip-LeWTUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:23 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:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:23 INFO - Running setup.py (path:/tmp/pip-pPk5hV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:23 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:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:23 INFO - Running setup.py (path:/tmp/pip-s9b0D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:23 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:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:23 INFO - Running setup.py (path:/tmp/pip-mo1T7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:24 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:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:24 INFO - Running setup.py (path:/tmp/pip-sxAk63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:24 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:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:24 INFO - Running setup.py (path:/tmp/pip-5qz9Wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:24 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:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:24 INFO - Running setup.py (path:/tmp/pip-qUhJ7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:24 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:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:24 INFO - Running setup.py (path:/tmp/pip-1ohwVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:24 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:57:24 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:57:24 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:57:24 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:57:24 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:57:24 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:57:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:26 INFO - Downloading blessings-1.6.tar.gz 03:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:57:26 INFO - Installing collected packages: blessings 03:57:26 INFO - Running setup.py install for blessings 03:57:26 INFO - Successfully installed blessings 03:57:26 INFO - Cleaning up... 03:57:26 INFO - Return code: 0 03:57:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:57:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:26 INFO - Reading from file tmpfile_stdout 03:57:26 INFO - Current package versions: 03:57:26 INFO - argparse == 1.2.1 03:57:26 INFO - blessings == 1.6 03:57:26 INFO - blobuploader == 1.2.4 03:57:26 INFO - docopt == 0.6.1 03:57:26 INFO - manifestparser == 1.1 03:57:26 INFO - mozInstall == 1.12 03:57:26 INFO - mozcrash == 0.17 03:57:26 INFO - mozdebug == 0.1 03:57:26 INFO - mozdevice == 0.48 03:57:26 INFO - mozfile == 1.2 03:57:26 INFO - mozhttpd == 0.7 03:57:26 INFO - mozinfo == 0.9 03:57:26 INFO - mozleak == 0.1 03:57:26 INFO - mozlog == 3.1 03:57:26 INFO - moznetwork == 0.27 03:57:26 INFO - mozprocess == 0.22 03:57:26 INFO - mozprofile == 0.28 03:57:26 INFO - mozrunner == 6.11 03:57:26 INFO - mozscreenshot == 0.1 03:57:26 INFO - mozsystemmonitor == 0.0 03:57:26 INFO - moztest == 0.7 03:57:26 INFO - mozversion == 1.4 03:57:26 INFO - psutil == 3.1.1 03:57:26 INFO - requests == 1.2.3 03:57:26 INFO - wsgiref == 0.1.2 03:57:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:26 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 0x7ff855adbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c45410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd4160>, '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 0x1cd5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', '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:57:26 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:57:26 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:57:26 INFO - Using env: {'DISPLAY': ':0', 03:57:26 INFO - 'HOME': '/home/cltbld', 03:57:26 INFO - 'LANG': 'en_US.UTF-8', 03:57:26 INFO - 'LANGUAGE': 'en_US:en', 03:57:26 INFO - 'LOGNAME': 'cltbld', 03:57:26 INFO - 'MAIL': '/var/mail/cltbld', 03:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:26 INFO - 'MOZ_NO_REMOTE': '1', 03:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:26 INFO - 'NO_EM_RESTART': '1', 03:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:26 INFO - 'PWD': '/builds/slave/test', 03:57:26 INFO - 'SHELL': '/bin/bash', 03:57:26 INFO - 'SHLVL': '1', 03:57:26 INFO - 'TERM': 'linux', 03:57:26 INFO - 'TMOUT': '86400', 03:57:26 INFO - 'USER': 'cltbld', 03:57:26 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', 03:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:26 INFO - '_': '/tools/buildbot/bin/python'} 03:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:26 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:57:26 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:57:26 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:57:26 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:57:26 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:57:26 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:57:26 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:57:26 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:57:26 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:57:26 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:57:26 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:57:26 INFO - Cleaning up... 03:57:26 INFO - Return code: 0 03:57:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:26 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 0x7ff855adbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c45410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd4160>, '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 0x1cd5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', '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:57:26 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:57:26 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:57:26 INFO - Using env: {'DISPLAY': ':0', 03:57:26 INFO - 'HOME': '/home/cltbld', 03:57:26 INFO - 'LANG': 'en_US.UTF-8', 03:57:26 INFO - 'LANGUAGE': 'en_US:en', 03:57:26 INFO - 'LOGNAME': 'cltbld', 03:57:26 INFO - 'MAIL': '/var/mail/cltbld', 03:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:26 INFO - 'MOZ_NO_REMOTE': '1', 03:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:26 INFO - 'NO_EM_RESTART': '1', 03:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:26 INFO - 'PWD': '/builds/slave/test', 03:57:26 INFO - 'SHELL': '/bin/bash', 03:57:26 INFO - 'SHLVL': '1', 03:57:26 INFO - 'TERM': 'linux', 03:57:26 INFO - 'TMOUT': '86400', 03:57:26 INFO - 'USER': 'cltbld', 03:57:26 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', 03:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:26 INFO - '_': '/tools/buildbot/bin/python'} 03:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:27 INFO - Downloading/unpacking jsonschema 03:57:27 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:57:27 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:57:27 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:57:27 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:57:27 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:57:27 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:57:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:57:28 INFO - Downloading/unpacking functools32 (from jsonschema) 03:57:28 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:57:28 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:57:28 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:57:28 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:57:28 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:57:28 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:57:29 INFO - Downloading functools32-3.2.3-2.tar.gz 03:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:57:29 INFO - warning: no files found matching '*.txt' 03:57:29 INFO - no previously-included directories found matching 'build' 03:57:29 INFO - no previously-included directories found matching 'dist' 03:57:29 INFO - no previously-included directories found matching '.git*' 03:57:29 INFO - Installing collected packages: jsonschema, functools32 03:57:29 INFO - Running setup.py install for functools32 03:57:29 INFO - warning: no files found matching '*.txt' 03:57:29 INFO - no previously-included directories found matching 'build' 03:57:29 INFO - no previously-included directories found matching 'dist' 03:57:29 INFO - no previously-included directories found matching '.git*' 03:57:29 INFO - Successfully installed jsonschema functools32 03:57:29 INFO - Cleaning up... 03:57:29 INFO - Return code: 0 03:57:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:57:29 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:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:29 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:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:29 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 0x7ff855adbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c45410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd4160>, '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 0x1cd5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd54f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', '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:57:29 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:57:29 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:57:29 INFO - Using env: {'DISPLAY': ':0', 03:57:29 INFO - 'HOME': '/home/cltbld', 03:57:29 INFO - 'LANG': 'en_US.UTF-8', 03:57:29 INFO - 'LANGUAGE': 'en_US:en', 03:57:29 INFO - 'LOGNAME': 'cltbld', 03:57:29 INFO - 'MAIL': '/var/mail/cltbld', 03:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:29 INFO - 'MOZ_NO_REMOTE': '1', 03:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:29 INFO - 'NO_EM_RESTART': '1', 03:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:29 INFO - 'PWD': '/builds/slave/test', 03:57:29 INFO - 'SHELL': '/bin/bash', 03:57:29 INFO - 'SHLVL': '1', 03:57:29 INFO - 'TERM': 'linux', 03:57:29 INFO - 'TMOUT': '86400', 03:57:29 INFO - 'USER': 'cltbld', 03:57:29 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', 03:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:29 INFO - '_': '/tools/buildbot/bin/python'} 03:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:29 INFO - Downloading/unpacking flake8 03:57:29 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:57:29 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:57:29 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:57:29 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:57:29 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:57:29 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:57:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:57:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:57:31 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:57:31 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:57:31 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:57:31 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:57:31 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:57:31 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:57:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:57:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:57:31 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:57:31 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:57:31 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:57:31 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:57:31 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:57:31 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:57:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:57:31 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:57:31 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:57:31 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:57:31 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:57:31 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:57:31 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:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:57:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:57:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:57:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:57:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:57:32 INFO - no previously-included directories found matching 'docs/_build' 03:57:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:57:32 INFO - Running setup.py install for pep8 03:57:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:57:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:57:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:57:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:57:32 INFO - no previously-included directories found matching 'docs/_build' 03:57:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:57:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:57:32 INFO - Cleaning up... 03:57:32 INFO - Return code: 0 03:57:32 INFO - Running post-action listener: _resource_record_post_action 03:57:32 INFO - Running post-action listener: _start_resource_monitoring 03:57:32 INFO - Starting resource monitoring. 03:57:32 INFO - ##### 03:57:32 INFO - ##### Running install step. 03:57:32 INFO - ##### 03:57:32 INFO - Running pre-action listener: _resource_record_pre_action 03:57:32 INFO - Running main action method: install 03:57:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:32 INFO - Reading from file tmpfile_stdout 03:57:32 INFO - Detecting whether we're running mozinstall >=1.0... 03:57:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:57:32 INFO - Reading from file tmpfile_stdout 03:57:32 INFO - Output received: 03:57:32 INFO - Usage: mozinstall [options] installer 03:57:32 INFO - Options: 03:57:32 INFO - -h, --help show this help message and exit 03:57:32 INFO - -d DEST, --destination=DEST 03:57:32 INFO - Directory to install application into. [default: 03:57:32 INFO - "/builds/slave/test"] 03:57:32 INFO - --app=APP Application being installed. [default: firefox] 03:57:32 INFO - mkdir: /builds/slave/test/build/application 03:57:32 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:57:32 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:57:47 INFO - Reading from file tmpfile_stdout 03:57:47 INFO - Output received: 03:57:47 INFO - /builds/slave/test/build/application/firefox/firefox 03:57:47 INFO - Running post-action listener: _resource_record_post_action 03:57:47 INFO - ##### 03:57:47 INFO - ##### Running run-tests step. 03:57:47 INFO - ##### 03:57:47 INFO - Running pre-action listener: _resource_record_pre_action 03:57:47 INFO - Running main action method: run_tests 03:57:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:57:48 INFO - Python 2.7.3 03:57:48 INFO - Return code: 0 03:57:48 INFO - grabbing minidump binary from tooltool 03:57:48 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:57:48 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 0x1cd4160>, '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 0x1cd5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd54f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:57:48 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:57:48 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:57:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:57:48 INFO - Return code: 0 03:57:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:57:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:57:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:57:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:57:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:57:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:57:49 INFO - Return code: 0 03:57:49 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/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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:57:49 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/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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:57:49 INFO - Using env: {'DISPLAY': ':0', 03:57:49 INFO - 'HOME': '/home/cltbld', 03:57:49 INFO - 'LANG': 'en_US.UTF-8', 03:57:49 INFO - 'LANGUAGE': 'en_US:en', 03:57:49 INFO - 'LOGNAME': 'cltbld', 03:57:49 INFO - 'MAIL': '/var/mail/cltbld', 03:57:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:57:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:49 INFO - 'MOZ_NO_REMOTE': '1', 03:57:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:49 INFO - 'NO_EM_RESTART': '1', 03:57:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:49 INFO - 'PWD': '/builds/slave/test', 03:57:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:57:49 INFO - 'SHELL': '/bin/bash', 03:57:49 INFO - 'SHLVL': '1', 03:57:49 INFO - 'TERM': 'linux', 03:57:49 INFO - 'TMOUT': '86400', 03:57:49 INFO - 'USER': 'cltbld', 03:57:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584', 03:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:49 INFO - '_': '/tools/buildbot/bin/python'} 03:57:49 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/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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:57:49 INFO - mozversion application_buildid: 20160425042155 03:57:49 INFO - mozversion application_changeset: f328ac32af6a3d0ce1593c41fd18edf7216a1652 03:57:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:57:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:57:49 INFO - mozversion application_name: Firefox 03:57:49 INFO - mozversion application_remotingname: firefox-dev 03:57:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:57:49 INFO - mozversion application_vendor: Mozilla 03:57:49 INFO - mozversion application_version: 47.0a2 03:57:49 INFO - mozversion platform_buildid: 20160425042155 03:57:49 INFO - mozversion platform_changeset: f328ac32af6a3d0ce1593c41fd18edf7216a1652 03:57:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:57:49 INFO - mozversion platform_version: 47.0a2 03:57:49 INFO - using testdate: 1461754669 03:57:49 INFO - actual date: 1461754669 03:57:49 INFO - starting webserver on 'localhost:38547' 03:57:49 INFO - SUITE-START | Running 2 tests 03:57:49 INFO - TEST-START | dromaeo_css 03:57:49 INFO - operating with platform_type : linux_ 03:57:49 INFO - Initialising browser for dromaeo_css test... 03:57:49 INFO - TEST-INFO | started process 24505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJjVEvC/profile http://localhost:38547/getInfo.html) 03:57:53 INFO - PROCESS | 24505 | __metrics Screen width/height:1600/1200 03:57:53 INFO - PROCESS | 24505 | colorDepth:24 03:57:53 INFO - PROCESS | 24505 | Browser inner width/height: 1024/697 03:57:53 INFO - PROCESS | 24505 | __metrics 03:57:54 INFO - PROCESS | 24505 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:57:55 INFO - TEST-INFO | 24505: exit 0 03:57:55 INFO - Browser initialized. 03:57:55 INFO - Running cycle 1/1 for dromaeo_css test... 03:57:55 INFO - TEST-INFO | started process 24596 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJjVEvC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:58:07 INFO - PROCESS | 24596 | RSS: Main: 141819904 03:58:07 INFO - PROCESS | 24596 | 03:58:59 INFO - PROCESS | 24596 | 1461754739099 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:01:06 INFO - PROCESS | 24596 | Cycle 1(1): loaded http://localhost:38547/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38547/tests/dromaeo/cssquery-ext.html) 04:01:07 INFO - PROCESS | 24596 | RSS: Main: 217751552 04:01:07 INFO - PROCESS | 24596 | 04:04:09 INFO - PROCESS | 24596 | Cycle 1(1): loaded http://localhost:38547/tests/dromaeo/cssquery-ext.html (next: http://localhost:38547/tests/dromaeo/cssquery-jquery.html) 04:04:10 INFO - PROCESS | 24596 | RSS: Main: 218554368 04:04:10 INFO - PROCESS | 24596 | 04:07:12 INFO - PROCESS | 24596 | Cycle 1(1): loaded http://localhost:38547/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38547/tests/dromaeo/cssquery-mootools.html) 04:07:12 INFO - PROCESS | 24596 | RSS: Main: 213680128 04:07:12 INFO - PROCESS | 24596 | 04:10:14 INFO - PROCESS | 24596 | Cycle 1(1): loaded http://localhost:38547/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38547/tests/dromaeo/cssquery-prototype.html) 04:10:15 INFO - PROCESS | 24596 | RSS: Main: 191823872 04:10:15 INFO - PROCESS | 24596 | 04:13:17 INFO - PROCESS | 24596 | Cycle 1(1): loaded http://localhost:38547/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38547/tests/dromaeo/cssquery-yui.html) 04:13:18 INFO - PROCESS | 24596 | RSS: Main: 209244160 04:13:18 INFO - PROCESS | 24596 | 04:16:20 INFO - PROCESS | 24596 | Cycle 1(1): loaded http://localhost:38547/tests/dromaeo/cssquery-yui.html (next: http://localhost:38547/tests/dromaeo/cssquery-dojo.html) 04:16:20 INFO - PROCESS | 24596 | RSS: Main: 256065536 04:16:20 INFO - PROCESS | 24596 | 04:16:20 INFO - PROCESS | 24596 | __start_tp_report 04:16:20 INFO - PROCESS | 24596 | _x_x_mozilla_page_load 04:16:20 INFO - PROCESS | 24596 | _x_x_mozilla_page_load_details 04:16:20 INFO - PROCESS | 24596 | |i|pagename|runs| 04:16:20 INFO - PROCESS | 24596 | |0;dojo.html;3306.801591904486;3338.616059153198;3392.830358482077;3394.0157354367234;3405.0976491229812;5442.265294185284;5458.481444262794;5480.780768769255;5482.150266708666;5492.286002819628;5461.644993075457;5500.42245564216;5506.476884695958;5507.614466987313;5508.807191748289;4855.955969466564;4981.277714731353;4998.329568629794;5074.720890351029;5085.23721441783;4994.650374473788;5091.643584949055;5093.439721630618;5098.107831129556;5100.107481190796;5019.749012549376;5084.3136176616235;5086.287919691246;5092;5131.1277082895995;4874.65877388583;5042.747862606891;5125.641205115643;5133.845984620468;5139.280500729901;4753.904921901577;4940.28365886948;4962.082014827269;4995.725235112068;5007.948330850526;5296.549793267577;5355.973220133913;5369.194620806871;5379.031774280667;5397.298351214317;5758.596898217126;5794.159846822229;5799.4780469757925;5805.245318108661;5809.506191973687;5746.511546518509;5788.363280039192;5819.825405237807;5841.47426731592;5843.649381037151;5577.024020796385;5595.496405323581;5602.831915042555;5605.971970140124;5629.549636029108;6094.573379863456;6110.358412366726;6113.419225173601;6117.938820611737;6117.96941015292;5718.68547229898;5838.9124163137585;5864.03243464832;5922.230110085661;5934.6142500737315;5942.58401911862;5965.910511342333;5973.731182096816;5974.044152935509;5976.223090998229;5884.264466941632;5885.882282354329;5925.466707996301;5945.732442040118;5947;5697.572682048863;5821.330546987066;5831.795887144014;5946.07835785454;5946.1972633693895;4472.932906006413;4508.098380323949;4508.549145085465;4511.233090374644;4534.410526631583;4035.7982100894837;4047.0894048839364;4052.65552428041;4055.8986025349013;4060.39094135882;5398.703071331036;5443.510084092451;5475.06923822951;5515.200295957064;5531.8893622128135;5935.080062590306;5987.491063259672;5996.0406334987065;6000.399960003964;6001.3098493672915;5605.607607467438;5631.63394379364;5640.0693885508435;5647.350554686263;5655.745491452894;4979.502049795064;5062.139436295838;5105.2342148678;5109.4379618241965;5147.5881929446305;6103.206583144251;6108.877822443526;6112.358202388774;6123.632582045091;6126.326104128542;5759.539236861125;5940.28716553999;5952.166696662557;5954;5957.225560677258;6045.969770151297;6113.020255720276;6118.694065296806;6131.0708424985305;6131.136251353645;5811.4479124483105;5838;5853.326867410132;5865.237519122486;5870.412958704095;5714.971425142848;5918.644881307136;5919.763209471573;5922.170896074639;5931.051031834886;5714.742836572447;5756.481916627524;5757.9424205757405;5761.913571296518;5790.044642633919;5697;5737.741801618854;5747.827565173052;5753.223314852441;5761.596688231783;5587.0502014656795;5631.380548139783;5649.12438572022;5651.943480565142;5706.201131841629;5707.800226992035;5766.163906233489;5845.3277873045145;5891.410858914074;5893.145493903446;5715.371309155907;5736.68448235351;5754.827355179351;5763.423657634203;5781.682007489629 04:16:20 INFO - PROCESS | 24596 | |1;ext.html;549.3188446326557;551.9448055194481;585.3824215452698;592.9641402506003;621.7533844641493;32191.356172876556;40586.376544938204;41238;41298;41341.3798793018;43879;44585.7770711146;44596.554034459645;44656.77671611637;44734;7984.920150798475;8768.69309574165;8979.371443998923;10335.793284134314;10493.422861742602;10348.482575871214;10465.529051192714;10493.160547156247;10498.947505262464;10500.054995050445;10476.1095306899;10538.262321637489;10557.155427565776;10560.26078174528;10562.947185264102;10404;10518.263721539495;10520.947395262974;10523.368597884075;10532.789344213112;10716.035556799847;10783.245172837904;10789;10793.352398856094;10840.945795271053;43842;44237.77881110606;44370.112597748186;44387.778061109486;44424.3336349955;3532.2405682778326;3821.216650586623;4015.859444919443;4113.938290925638;4518.254488009507;29769.702302977126;30156.69843301561;30298.697013029807;30473.695263047306;30718.078457646305;3636.181859081712;3732.8880133596035;3761.793101379423;3767.6609105180664;3776.527934008249;300580;304648.9999999978;304774;304889;304919;46509.76745116253;69772.3022769776;70217.64891175511;70226.29773702197;70246;45223.321650175276;45507.77246113814;45512.544874551495;45815.54184458113;45825;14158.079724817853;14224.502142424966;14523.854761452461;14656.193909334876;14694.706105878036;11939.880601193878;11949.283043017273;11951.34267615272;12229.082818788449;12258.14193006481;15368.615784605474;15377.692446151239;15455.227238638023;15526.611834703997;15552.377904883904;5842.211301474332;5900.793472228452;5928.739193443589;6068.302145253352;6070.2108725865355;979.740368802268;1027.5889644142253;1084.6583326252205;1093.2238110941162;1116.1349953785882;29826;29864.70135298619;30042.54936175959;31029.8448507756;31090.844545777127;1105.9391733454738;1106.8616422947132;1170.7365842685329;1171.912106592009;1199.7120691034088;15801.525954221392;15898.205089745466;16091.919540402223;16263.756043659354;16503.17484125789;364136;366660;367164;368394;368453;60257.698711506164;60851.39148608546;60878.39121608816;60981;61047.38952610506;1329.6409969308427;1440.2366745624836;1454.0984589554544;1472.146155229964;1496.5585152379856;28029;29971.70028299689;30219;30410.847945760128;30811.383772324876;48008.27987580259;48046.75976620094;48432.757836212004;48527.51472485371;48668;197925;198740;200417;211392;435596;34400.31199375948;34470.82764586161;35046.29907401888;35103.64896351004;35104.29791404209;42334.7883260594;42798.71603851889;42834;42901.78549107359;42976.14047719091;36012.81993590015;36331.63668363282;36496.452553211195;36759.08102297464;36880.26239475249;35232.29535409329;35528;36043.639563604025;38089;38710.806445968716;38575.6142438572;38747.225055498166;39123.413148802225;39371.409428858016;39428.80285598554;33292.833535832164;34556.82721586376;35266.647333526336;35283;35618.287634246655;26296.73703262943;26761.197164085108;26978.865105674347;27174.320641984108;27500.862495687394 04:16:20 INFO - PROCESS | 24596 | |2;jquery.html;342.61798095123936;381.90261483321757;396.96427321541074;399.04229848363923;406.1491175986311;17506.29974801008;18840.52898677532;19332.3233686821;19485.415437536896;19543.120559574836;12028.158028937956;12640.17838840477;12643.178193417421;12647.367631618405;12655.430505627246;5216.165413533826;5388.811391601294;5688.374278829346;5693.345265294482;5697.088465845465;5574.944250557503;5690.890276396104;5702.543796496291;5703.9714801425935;5708.71456427177;5473.534749546293;5670.659760414368;5703.17303990921;5708.4291570843;5711.885762284752;5639.436056394369;5691.146328050784;5706.771729130809;5707.914381284284;5716.685582292972;5080.034793389244;5089.694618322876;5091.3126727892;5114.693118412907;5119;21315;21602.67595986046;21944.561108777896;22038.559228815335;22135.335939921828;2297.9770202298096;2318.7565305642834;2418.5767490689236;2427.8786060696893;2550.821442499026;10539.367637941748;11840.171188016842;12753.681157971032;13473.797893031613;13664.931675341659;1895.3271588585992;1898.3355825461117;1904.5143488410506;1911.7801452832964;1954.853385996056;50825;60840.391596083915;62119.68940155316;70307;72660.27339726641;9002.954985225031;9487.952560237154;9495.335326527076;9557.856632150524;9771;13826.723465530633;14476.782848257284;14526.854731452762;14539.20034398097;14560.708785824225;7420.5176663516695;7433.219511951275;7588.468807183554;7695.115061767857;7725.652345644459;7170.426365890717;7216;7268.709251629982;7282.907563865357;7401.185869554345;4197.895052623709;4230.61924426803;4258.808353624095;4297.39836422901;4330.566943305645;1724.5085150732232;1808.9457316280532;1812.338496448813;1812.3928483958023;1817.5001874484622;922.041077279635;952.9809403811885;954.0697819625809;999.9850002249972;1025.395016939994;11339.94330028361;11458.255213411101;11653.00949419309;11755.764884702257;11914.404279785977;488.9511048895082;494.4363425694711;494.47832536674156;502.7260143221953;506.23052959501354;6079.665618391031;6265.185525881606;6367.904481432783;6633.170853643294;6694.129763130762;440362;445195;447520;451813;471163;76591.2340876584;80045;80567.597162015;80595.59702201451;81871.5906420464;496.78638185579825;497.7411745892188;502.87176769923434;502.95473407393513;504.40984048663154;10953.068989136013;10997.12023038139;11068.114550836075;11104.611338603434;11152.330860148417;35182.82408587941;36087.27825443424;36401.45397818982;36534.269314613026;36636.633633663325;50334.49665503298;50368.496315036384;50659;50720.74639626778;51835.48164518306;8513.531755753493;8523.190296921783;8526.275266602408;8543.572821358783;8778.648854046021;9655.179309758749;11947.641570752892;12663.113582049167;12917.418716157983;12926.159799612995;11129.16531260175;11141.777164456827;11164.497597607964;11351;11620.012298954345;10872.782544349227;11269.887301127212;11313.264637798517;11380.317180969168;11539.19225654196;11424.714382140513;11524.711882203012;11633.825492617787;11794.46924888365;11826.172167948162;8673.392862499564;8701.347398944978;8788.472691638523;8885.333599979898;8928.598213080297;10792.136629069813;11028.669139925814;11045.447727613748;11177.16171287173;11419.486123124645 04:16:20 INFO - PROCESS | 24596 | |3;mootools.html;1390.1520072755623;1581.2093953023489;1595.7765912772213;1824.498262977681;1950.0542237015045;7718.3825293976415;8446.324294056476;8612.784680382994;8675.132486751321;8689.04420513743;8433.831323373528;8622.267107295887;8630.352723545728;8634.093420190868;8634.352423568225;2073.0774805211686;2342.648602709599;2372.9644055339186;2400.099962514057;2400.9639855402183;2415.9637605435933;2428.8421252618614;2432.7323994360604;2434.0385547708643;2435.5007223519224;2391.988040059797;2458.60662294033;2462.1628646260356;2462.56905041617;2463.285647162321;2426.1265944260053;2435.07467162478;2468.3829042739317;2474.591692370757;2474.7401522840114;2413.263954493879;2449.2407353720405;2450.130203777669;2459.286806826018;2462.5567397868376;8431.578421078983;8539.957300213522;8543.871841922377;8546.871796923051;8557.871631925525;5210.687358758487;5374.2476053352175;5396.028714831329;5396.082665946798;5402.189671549259;3162.398709877123;3168.762342824274;3188.1551388881967;3198.2484116232667;3214.7267482264037;1006.4213077480405;1031.551275195285;1039.6465201831338;1043.4209013997229;1048.5438834107188;12436.129470937038;12506.18709783861;12524.81212781809;12529.43617537213;12565.93717031409;4591.770411479412;4662.254039353687;4668.206404911173;4727.628987593628;4752.239641657318;10586.629467968583;10608.787824243625;10614.840777388345;10642.308249963728;10651.627193048205;4689.413823272091;5295.4969277918535;5334.013207556614;5336.306280183551;5348.652337598043;4633.86098417048;4760.785764640599;4780.330753694486;4800.711957282574;4812.831550895702;4036.1322315702264;4092.4066010428323;4099.323611604052;4117.032497363117;4122.484689413824;1309.6005718256024;1341.463414634154;1345.9992257526476;1348.1237195822794;1348.4336578636996;1077.5312738958578;1077.956881724738;1090.432974853088;1097.5829184909683;1098.8296813993843;8356.874646880302;8369.539675317916;8413.242808147295;8417.70538031166;8440.873386899202;526.2868812758734;534.4868925831167;546.9425710300441;549.2063967566908;557.8103444828778;6376.7130479128555;6429.9678501607195;6453.032045193165;6505.316941721146;6509.869802603921;10530.36817790935;10841.13270938323;10850.62022829213;11009.724756881142;11013;10528.842067368996;10705.785884282272;10765.24643274979;10769.56921723138;10993.340399576051;8423.073461919184;8446.282066024456;8496.915030849736;8505.65977360911;8508.532030738368;8009.479383840032;8011.839763204586;8043.19568043191;8154.918450815653;8183;9123.49820759838;9210.585523651318;9301.441913484941;9356.157945784911;9488.33581649278;9476.431414115175;9634.90365096368;9760.41437513723;9779.706608801747;9799.755006124904;6379.106925030406;6892.586444813327;7065.293470652894;7147.106611673541;7192.964035179791;8253.009638843378;8262.545559994258;8280.668773249003;8321.459105158145;8329.125441828763;7092.787216383516;7305.41556675454;7349.375303099297;7386.48294619393;7432.070991126109;7409.962950185214;7453.925460745323;7475.1029876413;7491.4006879448425;7601.543907365576;7790.415718821225;7819.100803407681;7873.09459412175;7882.290593846581;7896.170902055431;6989.161300643956;7059.117610298713;7073.2219455858785;7109.146902371748;7129.7861064168155;7340.082489688789;7342.412606991535;7400.888986665312;7450.217727138789;7450.8882366763455 04:16:20 INFO - PROCESS | 24596 | |4;prototype.html;361.6925613228755;363.429415817167;367.88043885737125;369.7892201445174;375.5943580932593;6128.417800308969;6133.601315914462;6152.784652537162;6194.566380353377;6196.442320191182;6049.546284028705;6050.848728781772;6051.818445446633;6068.787592434266;6072;4543.432070991126;4590.081983603292;4703.200455922484;4726.4328280606205;4760.42874855017;4729.101470720552;4730.0066985933;4754.286856971447;4763.261694437368;4764.332993380929;4705.058988202356;4712.0811441768865;4713.9057218855605;4721.433427988646;4727.692699974491;4511.481179664332;4557.951671115628;4712.128256272601;4715.1512727709;4732.313814496913;4185.414042034117;4198.181354635817;4198.6011328923705;4200.432941552882;4214.157168566299;5769.826905192851;5778.711064446761;5781.4507621775865;5787.276590426197;5806.506446952014;5513.696746678931;5514.531264842493;5520.7302320466515;5522.806701765459;5525.751341189656;6400.39196276353;6402.519811014193;6407.647579383132;6418.229812422539;6419;4390.27560452525;4510.436195475566;4522.909541809178;4529.094181163748;4662.533746625344;6629.303923088055;6677.732890684367;6702.564333318367;6710.93289067108;6713.530052896299;4631.652626053059;4633.698809577367;4642.210824159901;4643.883902902455;4644.698094623838;4698.976505117521;4699.859004229878;4701.412323459567;4701.848047228383;4704.976475117603;5391.2747920665015;5394.541463975606;5396.784128634889;5398.784048638089;5402.810901618424;6315.8105256841445;6399.520035997319;6449.484041276686;6460.160179176677;6462.386073323027;1634.3299247308785;1653.79327584052;1657.3287818433553;1662.5843539115222;1663.6173680053655;1034.6585626743308;1087.396494945313;1090.2041509697965;1107.2470719910377;1113.4043286841502;6209.316975132731;6231.4391704746795;6235.314115447297;6240.5319601030105;6244.313125556185;6617.437517810944;6618;6623.7350505980185;6635.170603674541;6637.734490620321;6216.222972128484;6220.035894436279;6223.1287619733275;6224.315325314212;6249.78125765596;3544.8936531904083;3572.089117275078;3573.6783689468075;3580.480830279647;3585.46218067292;6597.538172327987;6802.931970680329;6817.829554261183;6825.419839313615;6828.214755303204;6719.630420326831;6737.764178253738;6742.595444273359;6751.324867513307;6751.594904305757;6795.762148324785;6814.250432452525;6816.250212476623;6818.659067046727;6825.829354266183;6593.505487088391;6599.307072757483;6601.108850305147;6604.801855944329;6605.174353205849;6332.525060620564;6446.419822216023;6469.935300646934;6471.708773105127;6499.7400103995315;6771.966140169267;6798.728050878108;6801.285864984304;6809.625470599165;6814.93185068143;4629.907401852011;4636.582707556337;4638.582527572535;4639.86080417588;4641.605463535638;6603.735850565923;6611.809874222686;6618.7352505899225;6625.4699624029;6625.469962403093;6260.092286618506;6418.743250269937;6428.967855160694;6434.260060092962;6436.420722135031;6328.335524769833;6358.237011558643;6362.6818659067785;6363.459105976044;6408.391202835724;6267.843303917439;6336.619802811846;6378.52161087911;6382.521310901794;6391.744330226739;6437.935620643921;6440.774572889926;6449.064885591469;6451.451626611791;6457.3865482779065;6152.169457123231;6235.844103897439;6277.71750271248;6299.779507717208;6317.778877739257 04:16:20 INFO - PROCESS | 24596 | |5;yui.html;752.2026651749146;820.6717313074771;838.513662075996;899.1098812175948;945.5697657565809;13932.860671393295;14459.13245205287;14492.565223043299;14587.124772513656;14666.70666586669;13803.930980345109;13943;13967.65080872976;13970;13984.580462586113;774.0517865614634;900.3472482450237;911.8313112074271;913.9268858491338;917.2295271971543;917.3991035871514;931.3434029009532;935.0836180543038;935.0836180543072;936.2089034765612;965.2133511188395;980.2941881845096;980.36276420327;982.3123813330661;982.3565564555228;809.720646376999;953.8044700836347;962.7544976031068;973;973.4500007495812;719.0185396933201;719.2663483247059;719.2879049740772;719.3669570777735;719.8128486593471;14462.783058254134;14466.855331446655;14496.85503144976;14520.927395363062;14530.12819230839;14525.636859078502;14595.78106328406;14901.850981490155;14926.70146597062;14947.925260373737;11237.3257604544;11326;11348.14888883337;11351.943240283746;11920.22518536301;3942.743721658083;3959.6238357356006;3995.5005624296964;4006.4991876015497;4032.0323122450695;51597.74201129008;51705.48294517044;51729.48270517284;52142.217866732026;52175.217371739454;11084.833727494093;11378.715532111597;11469.082473402108;11534.134939879543;11745.530178792924;18734.250629974922;18747.437576872715;18755.156017978952;18756.71864922027;18840.246390144242;7610.200928902496;7813.218678132255;7882.132965373804;8080.151584083704;8250.876236856451;4460.665450091256;4508.391367165456;4514.458265008155;4538.364628951949;4551.6813823032735;3375.780574262665;3382.2389962258294;3393.440082386428;3397.0658069031215;3401.1837159081642;562.535907876004;621.3972446726668;634.520936692794;656.7602824968852;674.9932500675029;529.5869222006841;612.0665984373866;642.9710663020081;647.5499527828114;679.4768028617937;8868.955655221682;8952.328575356743;8965.013848476663;8979.416337938013;9087.727368178965;600.5315853634172;643.2024289880515;652.9934700653027;653.9247986481521;673.8685956238486;4189.874303770892;4204.138151678899;4229.873103806891;4257.042165512735;4311.33174357975;59517;59576;59579;60088.69955650194;60136.69931650314;53107.73446132822;53282.73358633259;53715.19427208595;53739;54734;47955.760221198674;48126.759366203645;48638.756806215744;49111;49238;8325.16748325187;8337.166283371856;8404.411691181558;8553.57232138403;8561.871571926302;36532;36992.81503592573;37719;38298;38345.61654383421;42720.572794272906;46232.53767462282;46670.76664616791;46695.76652116854;46850.29724554066;10505.242136794808;10700.30448020876;10731.517081731185;10767.407792571485;10878.23852330361;11570.537178512765;11610.6516804496;11708.941455292668;11782.234154779911;12052.457639406073;10469.371837689763;10607.045365917105;10707.946460267649;10824.783504330027;10942.945285273523;11331.32012079278;11600.013998809858;11982.041436685218;12195.817062744243;12539.435725392561;11801.232919860182;11801.763964720485;11812.40937953116;11833.763324733285;11853.940730296294;10465.162786977176;10504.10715089226;10561.841572376266;10584.4707764613;10766.354018758899;9802.313838031268;9863.556139973862;9922.900770992486;10066.496675166067;10160.847587286344 04:16:20 INFO - PROCESS | 24596 | __end_tp_report 04:16:20 INFO - PROCESS | 24596 | __start_cc_report 04:16:20 INFO - PROCESS | 24596 | _x_x_mozilla_cycle_collect,686 04:16:20 INFO - PROCESS | 24596 | __end_cc_report 04:16:20 INFO - PROCESS | 24596 | __startTimestamp1461755780492__endTimestamp 04:16:20 INFO - PROCESS | 24596 | 04:16:20 INFO - PROCESS | 24596 | ------- Summary: start ------- 04:16:20 INFO - PROCESS | 24596 | Number of tests: 6 04:16:20 INFO - PROCESS | 24596 | 04:16:20 INFO - PROCESS | 24596 | [#0] dojo.html Cycles:165 Average:5486.62 Median:5707.80 stddev:604.23 (10.6%) stddev-sans-first:581.38 04:16:20 INFO - PROCESS | 24596 | Values: 3306.8 3338.6 3392.8 3394.0 3405.1 5442.3 5458.5 5480.8 5482.2 5492.3 5461.6 5500.4 5506.5 5507.6 5508.8 4856.0 4981.3 4998.3 5074.7 5085.2 4994.7 5091.6 5093.4 5098.1 5100.1 5019.7 5084.3 5086.3 5092.0 5131.1 4874.7 5042.7 5125.6 5133.8 5139.3 4753.9 4940.3 4962.1 4995.7 5007.9 5296.5 5356.0 5369.2 5379.0 5397.3 5758.6 5794.2 5799.5 5805.2 5809.5 5746.5 5788.4 5819.8 5841.5 5843.6 5577.0 5595.5 5602.8 5606.0 5629.5 6094.6 6110.4 6113.4 6117.9 6118.0 5718.7 5838.9 5864.0 5922.2 5934.6 5942.6 5965.9 5973.7 5974.0 5976.2 5884.3 5885.9 5925.5 5945.7 5947.0 5697.6 5821.3 5831.8 5946.1 5946.2 4472.9 4508.1 4508.5 4511.2 4534.4 4035.8 4047.1 4052.7 4055.9 4060.4 5398.7 5443.5 5475.1 5515.2 5531.9 5935.1 5987.5 5996.0 6000.4 6001.3 5605.6 5631.6 5640.1 5647.4 5655.7 4979.5 5062.1 5105.2 5109.4 5147.6 6103.2 6108.9 6112.4 6123.6 6126.3 5759.5 5940.3 5952.2 5954.0 5957.2 6046.0 6113.0 6118.7 6131.1 6131.1 5811.4 5838.0 5853.3 5865.2 5870.4 5715.0 5918.6 5919.8 5922.2 5931.1 5714.7 5756.5 5757.9 5761.9 5790.0 5697.0 5737.7 5747.8 5753.2 5761.6 5587.1 5631.4 5649.1 5651.9 5706.2 5707.8 5766.2 5845.3 5891.4 5893.1 5715.4 5736.7 5754.8 5763.4 5781.7 04:16:20 INFO - PROCESS | 24596 | 04:16:20 INFO - PROCESS | 24596 | [#1] ext.html Cycles:180 Average:48268.90 Median:35074.97 stddev:82758.15 (235.9%) stddev-sans-first:82912.75 04:16:20 INFO - PROCESS | 24596 | Values: 549.3 551.9 585.4 593.0 621.8 32191.4 40586.4 41238.0 41298.0 41341.4 43879.0 44585.8 44596.6 44656.8 44734.0 7984.9 8768.7 8979.4 10335.8 10493.4 10348.5 10465.5 10493.2 10498.9 10500.1 10476.1 10538.3 10557.2 10560.3 10562.9 10404.0 10518.3 10520.9 10523.4 10532.8 10716.0 10783.2 10789.0 10793.4 10840.9 43842.0 44237.8 44370.1 44387.8 44424.3 3532.2 3821.2 4015.9 4113.9 4518.3 29769.7 30156.7 30298.7 30473.7 30718.1 3636.2 3732.9 3761.8 3767.7 3776.5 300580.0 304649.0 304774.0 304889.0 304919.0 46509.8 69772.3 70217.6 70226.3 70246.0 45223.3 45507.8 45512.5 45815.5 45825.0 14158.1 14224.5 14523.9 14656.2 14694.7 11939.9 11949.3 11951.3 12229.1 12258.1 15368.6 15377.7 15455.2 15526.6 15552.4 5842.2 5900.8 5928.7 6068.3 6070.2 979.7 1027.6 1084.7 1093.2 1116.1 29826.0 29864.7 30042.5 31029.8 31090.8 1105.9 1106.9 1170.7 1171.9 1199.7 15801.5 15898.2 16091.9 16263.8 16503.2 364136.0 366660.0 367164.0 368394.0 368453.0 60257.7 60851.4 60878.4 60981.0 61047.4 1329.6 1440.2 1454.1 1472.1 1496.6 28029.0 29971.7 30219.0 30410.8 30811.4 48008.3 48046.8 48432.8 48527.5 48668.0 197925.0 198740.0 200417.0 211392.0 435596.0 34400.3 34470.8 35046.3 35103.6 35104.3 42334.8 42798.7 42834.0 42901.8 42976.1 36012.8 36331.6 36496.5 36759.1 36880.3 35232.3 35528.0 36043.6 38089.0 38710.8 38575.6 38747.2 39123.4 39371.4 39428.8 33292.8 34556.8 35266.6 35283.0 35618.3 26296.7 26761.2 26978.9 27174.3 27500.9 04:16:20 INFO - PROCESS | 24596 | 04:16:20 INFO - PROCESS | 24596 | [#2] jquery.html Cycles:180 Average:25833.91 Median:442778.50 stddev:74158.44 (16.7%) stddev-sans-first:74341.78 04:16:20 INFO - PROCESS | 24596 | Values: 342.6 381.9 397.0 399.0 406.1 17506.3 18840.5 19332.3 19485.4 19543.1 12028.2 12640.2 12643.2 12647.4 12655.4 5216.2 5388.8 5688.4 5693.3 5697.1 5574.9 5690.9 5702.5 5704.0 5708.7 5473.5 5670.7 5703.2 5708.4 5711.9 5639.4 5691.1 5706.8 5707.9 5716.7 5080.0 5089.7 5091.3 5114.7 5119.0 21315.0 21602.7 21944.6 22038.6 22135.3 2298.0 2318.8 2418.6 2427.9 2550.8 10539.4 11840.2 12753.7 13473.8 13664.9 1895.3 1898.3 1904.5 1911.8 1954.9 50825.0 60840.4 62119.7 70307.0 72660.3 9003.0 9488.0 9495.3 9557.9 9771.0 13826.7 14476.8 14526.9 14539.2 14560.7 7420.5 7433.2 7588.5 7695.1 7725.7 7170.4 7216.0 7268.7 7282.9 7401.2 4197.9 4230.6 4258.8 4297.4 4330.6 1724.5 1808.9 1812.3 1812.4 1817.5 922.0 953.0 954.1 1000.0 1025.4 11339.9 11458.3 11653.0 11755.8 11914.4 489.0 494.4 494.5 502.7 506.2 6079.7 6265.2 6367.9 6633.2 6694.1 440362.0 445195.0 447520.0 451813.0 471163.0 76591.2 80045.0 80567.6 80595.6 81871.6 496.8 497.7 502.9 503.0 504.4 10953.1 10997.1 11068.1 11104.6 11152.3 35182.8 36087.3 36401.5 36534.3 36636.6 50334.5 50368.5 50659.0 50720.7 51835.5 8513.5 8523.2 8526.3 8543.6 8778.6 9655.2 11947.6 12663.1 12917.4 12926.2 11129.2 11141.8 11164.5 11351.0 11620.0 10872.8 11269.9 11313.3 11380.3 11539.2 11424.7 11524.7 11633.8 11794.5 11826.2 8673.4 8701.3 8788.5 8885.3 8928.6 10792.1 11028.7 11045.4 11177.2 11419.5 04:16:20 INFO - PROCESS | 24596 | 04:16:20 INFO - PROCESS | 24596 | [#3] mootools.html Cycles:180 Average:6057.39 Median:2935.40 stddev:3282.58 (111.8%) stddev-sans-first:3273.04 04:16:20 INFO - PROCESS | 24596 | Values: 1390.2 1581.2 1595.8 1824.5 1950.1 7718.4 8446.3 8612.8 8675.1 8689.0 8433.8 8622.3 8630.4 8634.1 8634.4 2073.1 2342.6 2373.0 2400.1 2401.0 2416.0 2428.8 2432.7 2434.0 2435.5 2392.0 2458.6 2462.2 2462.6 2463.3 2426.1 2435.1 2468.4 2474.6 2474.7 2413.3 2449.2 2450.1 2459.3 2462.6 8431.6 8540.0 8543.9 8546.9 8557.9 5210.7 5374.2 5396.0 5396.1 5402.2 3162.4 3168.8 3188.2 3198.2 3214.7 1006.4 1031.6 1039.6 1043.4 1048.5 12436.1 12506.2 12524.8 12529.4 12565.9 4591.8 4662.3 4668.2 4727.6 4752.2 10586.6 10608.8 10614.8 10642.3 10651.6 4689.4 5295.5 5334.0 5336.3 5348.7 4633.9 4760.8 4780.3 4800.7 4812.8 4036.1 4092.4 4099.3 4117.0 4122.5 1309.6 1341.5 1346.0 1348.1 1348.4 1077.5 1078.0 1090.4 1097.6 1098.8 8356.9 8369.5 8413.2 8417.7 8440.9 526.3 534.5 546.9 549.2 557.8 6376.7 6430.0 6453.0 6505.3 6509.9 10530.4 10841.1 10850.6 11009.7 11013.0 10528.8 10705.8 10765.2 10769.6 10993.3 8423.1 8446.3 8496.9 8505.7 8508.5 8009.5 8011.8 8043.2 8154.9 8183.0 9123.5 9210.6 9301.4 9356.2 9488.3 9476.4 9634.9 9760.4 9779.7 9799.8 6379.1 6892.6 7065.3 7147.1 7193.0 8253.0 8262.5 8280.7 8321.5 8329.1 7092.8 7305.4 7349.4 7386.5 7432.1 7410.0 7453.9 7475.1 7491.4 7601.5 7790.4 7819.1 7873.1 7882.3 7896.2 6989.2 7059.1 7073.2 7109.1 7129.8 7340.1 7342.4 7400.9 7450.2 7450.9 04:16:20 INFO - PROCESS | 24596 | 04:16:20 INFO - PROCESS | 24596 | [#4] prototype.html Cycles:180 Average:5396.69 Median:6202.88 stddev:1596.94 (25.7%) stddev-sans-first:1556.06 04:16:20 INFO - PROCESS | 24596 | Values: 361.7 363.4 367.9 369.8 375.6 6128.4 6133.6 6152.8 6194.6 6196.4 6049.5 6050.8 6051.8 6068.8 6072.0 4543.4 4590.1 4703.2 4726.4 4760.4 4729.1 4730.0 4754.3 4763.3 4764.3 4705.1 4712.1 4713.9 4721.4 4727.7 4511.5 4558.0 4712.1 4715.2 4732.3 4185.4 4198.2 4198.6 4200.4 4214.2 5769.8 5778.7 5781.5 5787.3 5806.5 5513.7 5514.5 5520.7 5522.8 5525.8 6400.4 6402.5 6407.6 6418.2 6419.0 4390.3 4510.4 4522.9 4529.1 4662.5 6629.3 6677.7 6702.6 6710.9 6713.5 4631.7 4633.7 4642.2 4643.9 4644.7 4699.0 4699.9 4701.4 4701.8 4705.0 5391.3 5394.5 5396.8 5398.8 5402.8 6315.8 6399.5 6449.5 6460.2 6462.4 1634.3 1653.8 1657.3 1662.6 1663.6 1034.7 1087.4 1090.2 1107.2 1113.4 6209.3 6231.4 6235.3 6240.5 6244.3 6617.4 6618.0 6623.7 6635.2 6637.7 6216.2 6220.0 6223.1 6224.3 6249.8 3544.9 3572.1 3573.7 3580.5 3585.5 6597.5 6802.9 6817.8 6825.4 6828.2 6719.6 6737.8 6742.6 6751.3 6751.6 6795.8 6814.3 6816.3 6818.7 6825.8 6593.5 6599.3 6601.1 6604.8 6605.2 6332.5 6446.4 6469.9 6471.7 6499.7 6772.0 6798.7 6801.3 6809.6 6814.9 4629.9 4636.6 4638.6 4639.9 4641.6 6603.7 6611.8 6618.7 6625.5 6625.5 6260.1 6418.7 6429.0 6434.3 6436.4 6328.3 6358.2 6362.7 6363.5 6408.4 6267.8 6336.6 6378.5 6382.5 6391.7 6437.9 6440.8 6449.1 6451.5 6457.4 6152.2 6235.8 6277.7 6299.8 6317.8 04:16:20 INFO - PROCESS | 24596 | 04:16:20 INFO - PROCESS | 24596 | [#5] yui.html Cycles:180 Average:14522.08 Median:4526.41 stddev:16737.72 (369.8%) stddev-sans-first:16752.73 04:16:20 INFO - PROCESS | 24596 | Values: 752.2 820.7 838.5 899.1 945.6 13932.9 14459.1 14492.6 14587.1 14666.7 13803.9 13943.0 13967.7 13970.0 13984.6 774.1 900.3 911.8 913.9 917.2 917.4 931.3 935.1 935.1 936.2 965.2 980.3 980.4 982.3 982.4 809.7 953.8 962.8 973.0 973.5 719.0 719.3 719.3 719.4 719.8 14462.8 14466.9 14496.9 14520.9 14530.1 14525.6 14595.8 14901.9 14926.7 14947.9 11237.3 11326.0 11348.1 11351.9 11920.2 3942.7 3959.6 3995.5 4006.5 4032.0 51597.7 51705.5 51729.5 52142.2 52175.2 11084.8 11378.7 11469.1 11534.1 11745.5 18734.3 18747.4 18755.2 18756.7 18840.2 7610.2 7813.2 7882.1 8080.2 8250.9 4460.7 4508.4 4514.5 4538.4 4551.7 3375.8 3382.2 3393.4 3397.1 3401.2 562.5 621.4 634.5 656.8 675.0 529.6 612.1 643.0 647.5 679.5 8869.0 8952.3 8965.0 8979.4 9087.7 600.5 643.2 653.0 653.9 673.9 4189.9 4204.1 4229.9 4257.0 4311.3 59517.0 59576.0 59579.0 60088.7 60136.7 53107.7 53282.7 53715.2 53739.0 54734.0 47955.8 48126.8 48638.8 49111.0 49238.0 8325.2 8337.2 8404.4 8553.6 8561.9 36532.0 36992.8 37719.0 38298.0 38345.6 42720.6 46232.5 46670.8 46695.8 46850.3 10505.2 10700.3 10731.5 10767.4 10878.2 11570.5 11610.7 11708.9 11782.2 12052.5 10469.4 10607.0 10707.9 10824.8 10942.9 11331.3 11600.0 11982.0 12195.8 12539.4 11801.2 11801.8 11812.4 11833.8 11853.9 10465.2 10504.1 10561.8 10584.5 10766.4 9802.3 9863.6 9922.9 10066.5 10160.8 04:16:20 INFO - PROCESS | 24596 | -------- Summary: end -------- 04:16:20 INFO - PROCESS | 24596 | 04:16:21 INFO - TEST-INFO | 24596: exit 0 04:16:21 INFO - TEST-OK | dromaeo_css | took 1111930ms 04:16:21 INFO - TEST-START | kraken 04:16:21 INFO - operating with platform_type : linux_ 04:16:21 INFO - Initialising browser for kraken test... 04:16:21 INFO - TEST-INFO | started process 24800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO2nOU9/profile http://localhost:38547/getInfo.html) 04:16:25 INFO - PROCESS | 24800 | __metrics Screen width/height:1600/1200 04:16:25 INFO - PROCESS | 24800 | colorDepth:24 04:16:25 INFO - PROCESS | 24800 | Browser inner width/height: 1024/697 04:16:25 INFO - PROCESS | 24800 | __metrics 04:16:26 INFO - PROCESS | 24800 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:16:27 INFO - TEST-INFO | 24800: exit 0 04:16:27 INFO - Browser initialized. 04:16:27 INFO - Running cycle 1/1 for kraken test... 04:16:27 INFO - TEST-INFO | started process 24892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO2nOU9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:39 INFO - PROCESS | 24892 | RSS: Main: 142262272 04:16:39 INFO - PROCESS | 24892 | 04:16:41 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38547/tests/kraken/driver.html?testName=audio-beat-detection) 04:16:42 INFO - PROCESS | 24892 | RSS: Main: 177975296 04:16:42 INFO - PROCESS | 24892 | 04:16:44 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38547/tests/kraken/driver.html?testName=audio-dft) 04:16:45 INFO - PROCESS | 24892 | RSS: Main: 176635904 04:16:45 INFO - PROCESS | 24892 | 04:16:48 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38547/tests/kraken/driver.html?testName=audio-fft) 04:16:48 INFO - PROCESS | 24892 | RSS: Main: 173301760 04:16:48 INFO - PROCESS | 24892 | 04:16:51 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38547/tests/kraken/driver.html?testName=audio-oscillator) 04:16:51 INFO - PROCESS | 24892 | RSS: Main: 174600192 04:16:51 INFO - PROCESS | 24892 | 04:16:53 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38547/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:16:54 INFO - PROCESS | 24892 | RSS: Main: 171655168 04:16:54 INFO - PROCESS | 24892 | 04:16:57 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38547/tests/kraken/driver.html?testName=imaging-darkroom) 04:16:57 INFO - PROCESS | 24892 | RSS: Main: 171548672 04:16:57 INFO - PROCESS | 24892 | 04:17:01 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38547/tests/kraken/driver.html?testName=imaging-desaturate) 04:17:01 INFO - PROCESS | 24892 | RSS: Main: 172048384 04:17:01 INFO - PROCESS | 24892 | 04:17:04 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38547/tests/kraken/driver.html?testName=json-parse-financial) 04:17:05 INFO - PROCESS | 24892 | RSS: Main: 171610112 04:17:05 INFO - PROCESS | 24892 | 04:17:06 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38547/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:17:07 INFO - PROCESS | 24892 | RSS: Main: 177086464 04:17:07 INFO - PROCESS | 24892 | 04:17:09 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38547/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:17:09 INFO - PROCESS | 24892 | RSS: Main: 175108096 04:17:09 INFO - PROCESS | 24892 | 04:17:11 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38547/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:17:12 INFO - PROCESS | 24892 | RSS: Main: 185466880 04:17:12 INFO - PROCESS | 24892 | 04:17:14 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:17:15 INFO - PROCESS | 24892 | RSS: Main: 189165568 04:17:15 INFO - PROCESS | 24892 | 04:17:17 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:17:18 INFO - PROCESS | 24892 | RSS: Main: 188641280 04:17:18 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | Cycle 1(1): loaded http://localhost:38547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38547/tests/kraken/driver.html?testName=ai-astar) 04:17:20 INFO - PROCESS | 24892 | RSS: Main: 250327040 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | __start_tp_report 04:17:20 INFO - PROCESS | 24892 | _x_x_mozilla_page_load 04:17:20 INFO - PROCESS | 24892 | _x_x_mozilla_page_load_details 04:17:20 INFO - PROCESS | 24892 | |i|pagename|runs| 04:17:20 INFO - PROCESS | 24892 | |0;ai-astar;107;109;103;109;110;110;97;109;110;109 04:17:20 INFO - PROCESS | 24892 | |1;audio-beat-detection;154;127;152;163;136;151;160;134;177;126 04:17:20 INFO - PROCESS | 24892 | |2;audio-dft;160;162;163;162;165;163;165;170;161;160 04:17:20 INFO - PROCESS | 24892 | |3;audio-fft;76;77;75;168;77;73;77;76;167;75 04:17:20 INFO - PROCESS | 24892 | |4;audio-oscillator;93;92;146;93;93;94;153;93;93;148 04:17:20 INFO - PROCESS | 24892 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;116 04:17:20 INFO - PROCESS | 24892 | |6;imaging-darkroom;145;145;145;145;146;145;146;146;145;149 04:17:20 INFO - PROCESS | 24892 | |7;imaging-desaturate;95;95;95;96;96;96;95;95;96;96 04:17:20 INFO - PROCESS | 24892 | |8;json-parse-financial;54;55;53;55;54;54;55;65;52;52 04:17:20 INFO - PROCESS | 24892 | |9;json-stringify-tinderbox;65;67;66;66;66;67;67;66;66;66 04:17:20 INFO - PROCESS | 24892 | |10;stanford-crypto-aes;86;80;80;80;82;80;79;80;81;80 04:17:20 INFO - PROCESS | 24892 | |11;stanford-crypto-ccm;118;114;113;112;112;115;121;112;138;111 04:17:20 INFO - PROCESS | 24892 | |12;stanford-crypto-pbkdf2;143;134;134;140;141;138;154;141;146;141 04:17:20 INFO - PROCESS | 24892 | |13;stanford-crypto-sha256-iterative;67;68;67;68;65;67;67;66;64;65 04:17:20 INFO - PROCESS | 24892 | __end_tp_report 04:17:20 INFO - PROCESS | 24892 | __start_cc_report 04:17:20 INFO - PROCESS | 24892 | _x_x_mozilla_cycle_collect,1082 04:17:20 INFO - PROCESS | 24892 | __end_cc_report 04:17:20 INFO - PROCESS | 24892 | __startTimestamp1461755840355__endTimestamp 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | ------- Summary: start ------- 04:17:20 INFO - PROCESS | 24892 | Number of tests: 14 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#0] ai-astar Cycles:10 Average:107.30 Median:109.50 stddev:4.19 (3.8%) stddev-sans-first:4.44 04:17:20 INFO - PROCESS | 24892 | Values: 107.0 109.0 103.0 109.0 110.0 110.0 97.0 109.0 110.0 109.0 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:153.00 stddev:16.79 (11.0%) stddev-sans-first:17.66 04:17:20 INFO - PROCESS | 24892 | Values: 154.0 127.0 152.0 163.0 136.0 151.0 160.0 134.0 177.0 126.0 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:3.00 (1.8%) stddev-sans-first:2.96 04:17:20 INFO - PROCESS | 24892 | Values: 160.0 162.0 163.0 162.0 165.0 163.0 165.0 170.0 161.0 160.0 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:38.71 (50.9%) stddev-sans-first:40.50 04:17:20 INFO - PROCESS | 24892 | Values: 76.0 77.0 75.0 168.0 77.0 73.0 77.0 76.0 167.0 75.0 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:93.00 stddev:27.11 (29.1%) stddev-sans-first:28.06 04:17:20 INFO - PROCESS | 24892 | Values: 93.0 92.0 146.0 93.0 93.0 94.0 153.0 93.0 93.0 148.0 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:17:20 INFO - PROCESS | 24892 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:145.50 stddev:1.25 (0.9%) stddev-sans-first:1.30 04:17:20 INFO - PROCESS | 24892 | Values: 145.0 145.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 149.0 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:17:20 INFO - PROCESS | 24892 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:3.73 (6.8%) stddev-sans-first:3.94 04:17:20 INFO - PROCESS | 24892 | Values: 54.0 55.0 53.0 55.0 54.0 54.0 55.0 65.0 52.0 52.0 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 04:17:20 INFO - PROCESS | 24892 | Values: 65.0 67.0 66.0 66.0 66.0 67.0 67.0 66.0 66.0 66.0 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:1.99 (2.5%) stddev-sans-first:0.83 04:17:20 INFO - PROCESS | 24892 | Values: 86.0 80.0 80.0 80.0 82.0 80.0 79.0 80.0 81.0 80.0 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#11] stanford-crypto-ccm Cycles:10 Average:116.60 Median:114.50 stddev:8.14 (7.1%) stddev-sans-first:8.62 04:17:20 INFO - PROCESS | 24892 | Values: 118.0 114.0 113.0 112.0 112.0 115.0 121.0 112.0 138.0 111.0 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.20 Median:141.00 stddev:5.83 (4.1%) stddev-sans-first:6.14 04:17:20 INFO - PROCESS | 24892 | Values: 143.0 134.0 134.0 140.0 141.0 138.0 154.0 141.0 146.0 141.0 04:17:20 INFO - PROCESS | 24892 | 04:17:20 INFO - PROCESS | 24892 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.41 04:17:20 INFO - PROCESS | 24892 | Values: 67.0 68.0 67.0 68.0 65.0 67.0 67.0 66.0 64.0 65.0 04:17:20 INFO - PROCESS | 24892 | -------- Summary: end -------- 04:17:20 INFO - PROCESS | 24892 | 04:17:21 INFO - TEST-INFO | 24892: exit 0 04:17:21 INFO - TEST-OK | kraken | took 60095ms 04:17:21 INFO - SUITE-END | took 1172s 04:17:21 INFO - Completed test suite (00:19:32) 04:17:21 INFO - javascript benchmark 04:17:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3306.801591904486, 3338.616059153198, 3392.830358482077, 3394.0157354367234, 3405.0976491229812, 5442.265294185284, 5458.481444262794, 5480.780768769255, 5482.150266708666, 5492.286002819628, 5461.644993075457, 5500.42245564216, 5506.476884695958, 5507.614466987313, 5508.807191748289, 4855.955969466564, 4981.277714731353, 4998.329568629794, 5074.720890351029, 5085.23721441783, 4994.650374473788, 5091.643584949055, 5093.439721630618, 5098.107831129556, 5100.107481190796, 5019.749012549376, 5084.3136176616235, 5086.287919691246, 5092.0, 5131.1277082895995, 4874.65877388583, 5042.747862606891, 5125.641205115643, 5133.845984620468, 5139.280500729901, 4753.904921901577, 4940.28365886948, 4962.082014827269, 4995.725235112068, 5007.948330850526, 5296.549793267577, 5355.973220133913, 5369.194620806871, 5379.031774280667, 5397.298351214317, 5758.596898217126, 5794.159846822229, 5799.4780469757925, 5805.245318108661, 5809.506191973687, 5746.511546518509, 5788.363280039192, 5819.825405237807, 5841.47426731592, 5843.649381037151, 5577.024020796385, 5595.496405323581, 5602.831915042555, 5605.971970140124, 5629.549636029108, 6094.573379863456, 6110.358412366726, 6113.419225173601, 6117.938820611737, 6117.96941015292, 5718.68547229898, 5838.9124163137585, 5864.03243464832, 5922.230110085661, 5934.6142500737315, 5942.58401911862, 5965.910511342333, 5973.731182096816, 5974.044152935509, 5976.223090998229, 5884.264466941632, 5885.882282354329, 5925.466707996301, 5945.732442040118, 5947.0, 5697.572682048863, 5821.330546987066, 5831.795887144014, 5946.07835785454, 5946.1972633693895, 4472.932906006413, 4508.098380323949, 4508.549145085465, 4511.233090374644, 4534.410526631583, 4035.7982100894837, 4047.0894048839364, 4052.65552428041, 4055.8986025349013, 4060.39094135882, 5398.703071331036, 5443.510084092451, 5475.06923822951, 5515.200295957064, 5531.8893622128135, 5935.080062590306, 5987.491063259672, 5996.0406334987065, 6000.399960003964, 6001.3098493672915, 5605.607607467438, 5631.63394379364, 5640.0693885508435, 5647.350554686263, 5655.745491452894, 4979.502049795064, 5062.139436295838, 5105.2342148678, 5109.4379618241965, 5147.5881929446305, 6103.206583144251, 6108.877822443526, 6112.358202388774, 6123.632582045091, 6126.326104128542, 5759.539236861125, 5940.28716553999, 5952.166696662557, 5954.0, 5957.225560677258, 6045.969770151297, 6113.020255720276, 6118.694065296806, 6131.0708424985305, 6131.136251353645, 5811.4479124483105, 5838.0, 5853.326867410132, 5865.237519122486, 5870.412958704095, 5714.971425142848, 5918.644881307136, 5919.763209471573, 5922.170896074639, 5931.051031834886, 5714.742836572447, 5756.481916627524, 5757.9424205757405, 5761.913571296518, 5790.044642633919, 5697.0, 5737.741801618854, 5747.827565173052, 5753.223314852441, 5761.596688231783, 5587.0502014656795, 5631.380548139783, 5649.12438572022, 5651.943480565142, 5706.201131841629, 5707.800226992035, 5766.163906233489, 5845.3277873045145, 5891.410858914074, 5893.145493903446, 5715.371309155907, 5736.68448235351, 5754.827355179351, 5763.423657634203, 5781.682007489629], "unit": "score", "name": "dojo.html", "value": 5448.028914848473}, {"lowerIsBetter": false, "replicates": [549.3188446326557, 551.9448055194481, 585.3824215452698, 592.9641402506003, 621.7533844641493, 32191.356172876556, 40586.376544938204, 41238.0, 41298.0, 41341.3798793018, 43879.0, 44585.7770711146, 44596.554034459645, 44656.77671611637, 44734.0, 7984.920150798475, 8768.69309574165, 8979.371443998923, 10335.793284134314, 10493.422861742602, 10348.482575871214, 10465.529051192714, 10493.160547156247, 10498.947505262464, 10500.054995050445, 10476.1095306899, 10538.262321637489, 10557.155427565776, 10560.26078174528, 10562.947185264102, 10404.0, 10518.263721539495, 10520.947395262974, 10523.368597884075, 10532.789344213112, 10716.035556799847, 10783.245172837904, 10789.0, 10793.352398856094, 10840.945795271053, 43842.0, 44237.77881110606, 44370.112597748186, 44387.778061109486, 44424.3336349955, 3532.2405682778326, 3821.216650586623, 4015.859444919443, 4113.938290925638, 4518.254488009507, 29769.702302977126, 30156.69843301561, 30298.697013029807, 30473.695263047306, 30718.078457646305, 3636.181859081712, 3732.8880133596035, 3761.793101379423, 3767.6609105180664, 3776.527934008249, 300580.0, 304648.9999999978, 304774.0, 304889.0, 304919.0, 46509.76745116253, 69772.3022769776, 70217.64891175511, 70226.29773702197, 70246.0, 45223.321650175276, 45507.77246113814, 45512.544874551495, 45815.54184458113, 45825.0, 14158.079724817853, 14224.502142424966, 14523.854761452461, 14656.193909334876, 14694.706105878036, 11939.880601193878, 11949.283043017273, 11951.34267615272, 12229.082818788449, 12258.14193006481, 15368.615784605474, 15377.692446151239, 15455.227238638023, 15526.611834703997, 15552.377904883904, 5842.211301474332, 5900.793472228452, 5928.739193443589, 6068.302145253352, 6070.2108725865355, 979.740368802268, 1027.5889644142253, 1084.6583326252205, 1093.2238110941162, 1116.1349953785882, 29826.0, 29864.70135298619, 30042.54936175959, 31029.8448507756, 31090.844545777127, 1105.9391733454738, 1106.8616422947132, 1170.7365842685329, 1171.912106592009, 1199.7120691034088, 15801.525954221392, 15898.205089745466, 16091.919540402223, 16263.756043659354, 16503.17484125789, 364136.0, 366660.0, 367164.0, 368394.0, 368453.0, 60257.698711506164, 60851.39148608546, 60878.39121608816, 60981.0, 61047.38952610506, 1329.6409969308427, 1440.2366745624836, 1454.0984589554544, 1472.146155229964, 1496.5585152379856, 28029.0, 29971.70028299689, 30219.0, 30410.847945760128, 30811.383772324876, 48008.27987580259, 48046.75976620094, 48432.757836212004, 48527.51472485371, 48668.0, 197925.0, 198740.0, 200417.0, 211392.0, 435596.0, 34400.31199375948, 34470.82764586161, 35046.29907401888, 35103.64896351004, 35104.29791404209, 42334.7883260594, 42798.71603851889, 42834.0, 42901.78549107359, 42976.14047719091, 36012.81993590015, 36331.63668363282, 36496.452553211195, 36759.08102297464, 36880.26239475249, 35232.29535409329, 35528.0, 36043.639563604025, 38089.0, 38710.806445968716, 38575.6142438572, 38747.225055498166, 39123.413148802225, 39371.409428858016, 39428.80285598554, 33292.833535832164, 34556.82721586376, 35266.647333526336, 35283.0, 35618.287634246655, 26296.73703262943, 26761.197164085108, 26978.865105674347, 27174.320641984108, 27500.862495687394], "unit": "score", "name": "ext.html", "value": 19251.312333651396}, {"lowerIsBetter": false, "replicates": [342.61798095123936, 381.90261483321757, 396.96427321541074, 399.04229848363923, 406.1491175986311, 17506.29974801008, 18840.52898677532, 19332.3233686821, 19485.415437536896, 19543.120559574836, 12028.158028937956, 12640.17838840477, 12643.178193417421, 12647.367631618405, 12655.430505627246, 5216.165413533826, 5388.811391601294, 5688.374278829346, 5693.345265294482, 5697.088465845465, 5574.944250557503, 5690.890276396104, 5702.543796496291, 5703.9714801425935, 5708.71456427177, 5473.534749546293, 5670.659760414368, 5703.17303990921, 5708.4291570843, 5711.885762284752, 5639.436056394369, 5691.146328050784, 5706.771729130809, 5707.914381284284, 5716.685582292972, 5080.034793389244, 5089.694618322876, 5091.3126727892, 5114.693118412907, 5119.0, 21315.0, 21602.67595986046, 21944.561108777896, 22038.559228815335, 22135.335939921828, 2297.9770202298096, 2318.7565305642834, 2418.5767490689236, 2427.8786060696893, 2550.821442499026, 10539.367637941748, 11840.171188016842, 12753.681157971032, 13473.797893031613, 13664.931675341659, 1895.3271588585992, 1898.3355825461117, 1904.5143488410506, 1911.7801452832964, 1954.853385996056, 50825.0, 60840.391596083915, 62119.68940155316, 70307.0, 72660.27339726641, 9002.954985225031, 9487.952560237154, 9495.335326527076, 9557.856632150524, 9771.0, 13826.723465530633, 14476.782848257284, 14526.854731452762, 14539.20034398097, 14560.708785824225, 7420.5176663516695, 7433.219511951275, 7588.468807183554, 7695.115061767857, 7725.652345644459, 7170.426365890717, 7216.0, 7268.709251629982, 7282.907563865357, 7401.185869554345, 4197.895052623709, 4230.61924426803, 4258.808353624095, 4297.39836422901, 4330.566943305645, 1724.5085150732232, 1808.9457316280532, 1812.338496448813, 1812.3928483958023, 1817.5001874484622, 922.041077279635, 952.9809403811885, 954.0697819625809, 999.9850002249972, 1025.395016939994, 11339.94330028361, 11458.255213411101, 11653.00949419309, 11755.764884702257, 11914.404279785977, 488.9511048895082, 494.4363425694711, 494.47832536674156, 502.7260143221953, 506.23052959501354, 6079.665618391031, 6265.185525881606, 6367.904481432783, 6633.170853643294, 6694.129763130762, 440362.0, 445195.0, 447520.0, 451813.0, 471163.0, 76591.2340876584, 80045.0, 80567.597162015, 80595.59702201451, 81871.5906420464, 496.78638185579825, 497.7411745892188, 502.87176769923434, 502.95473407393513, 504.40984048663154, 10953.068989136013, 10997.12023038139, 11068.114550836075, 11104.611338603434, 11152.330860148417, 35182.82408587941, 36087.27825443424, 36401.45397818982, 36534.269314613026, 36636.633633663325, 50334.49665503298, 50368.496315036384, 50659.0, 50720.74639626778, 51835.48164518306, 8513.531755753493, 8523.190296921783, 8526.275266602408, 8543.572821358783, 8778.648854046021, 9655.179309758749, 11947.641570752892, 12663.113582049167, 12917.418716157983, 12926.159799612995, 11129.16531260175, 11141.777164456827, 11164.497597607964, 11351.0, 11620.012298954345, 10872.782544349227, 11269.887301127212, 11313.264637798517, 11380.317180969168, 11539.19225654196, 11424.714382140513, 11524.711882203012, 11633.825492617787, 11794.46924888365, 11826.172167948162, 8673.392862499564, 8701.347398944978, 8788.472691638523, 8885.333599979898, 8928.598213080297, 10792.136629069813, 11028.669139925814, 11045.447727613748, 11177.16171287173, 11419.486123124645], "unit": "score", "name": "jquery.html", "value": 8059.305852320719}, {"lowerIsBetter": false, "replicates": [1390.1520072755623, 1581.2093953023489, 1595.7765912772213, 1824.498262977681, 1950.0542237015045, 7718.3825293976415, 8446.324294056476, 8612.784680382994, 8675.132486751321, 8689.04420513743, 8433.831323373528, 8622.267107295887, 8630.352723545728, 8634.093420190868, 8634.352423568225, 2073.0774805211686, 2342.648602709599, 2372.9644055339186, 2400.099962514057, 2400.9639855402183, 2415.9637605435933, 2428.8421252618614, 2432.7323994360604, 2434.0385547708643, 2435.5007223519224, 2391.988040059797, 2458.60662294033, 2462.1628646260356, 2462.56905041617, 2463.285647162321, 2426.1265944260053, 2435.07467162478, 2468.3829042739317, 2474.591692370757, 2474.7401522840114, 2413.263954493879, 2449.2407353720405, 2450.130203777669, 2459.286806826018, 2462.5567397868376, 8431.578421078983, 8539.957300213522, 8543.871841922377, 8546.871796923051, 8557.871631925525, 5210.687358758487, 5374.2476053352175, 5396.028714831329, 5396.082665946798, 5402.189671549259, 3162.398709877123, 3168.762342824274, 3188.1551388881967, 3198.2484116232667, 3214.7267482264037, 1006.4213077480405, 1031.551275195285, 1039.6465201831338, 1043.4209013997229, 1048.5438834107188, 12436.129470937038, 12506.18709783861, 12524.81212781809, 12529.43617537213, 12565.93717031409, 4591.770411479412, 4662.254039353687, 4668.206404911173, 4727.628987593628, 4752.239641657318, 10586.629467968583, 10608.787824243625, 10614.840777388345, 10642.308249963728, 10651.627193048205, 4689.413823272091, 5295.4969277918535, 5334.013207556614, 5336.306280183551, 5348.652337598043, 4633.86098417048, 4760.785764640599, 4780.330753694486, 4800.711957282574, 4812.831550895702, 4036.1322315702264, 4092.4066010428323, 4099.323611604052, 4117.032497363117, 4122.484689413824, 1309.6005718256024, 1341.463414634154, 1345.9992257526476, 1348.1237195822794, 1348.4336578636996, 1077.5312738958578, 1077.956881724738, 1090.432974853088, 1097.5829184909683, 1098.8296813993843, 8356.874646880302, 8369.539675317916, 8413.242808147295, 8417.70538031166, 8440.873386899202, 526.2868812758734, 534.4868925831167, 546.9425710300441, 549.2063967566908, 557.8103444828778, 6376.7130479128555, 6429.9678501607195, 6453.032045193165, 6505.316941721146, 6509.869802603921, 10530.36817790935, 10841.13270938323, 10850.62022829213, 11009.724756881142, 11013.0, 10528.842067368996, 10705.785884282272, 10765.24643274979, 10769.56921723138, 10993.340399576051, 8423.073461919184, 8446.282066024456, 8496.915030849736, 8505.65977360911, 8508.532030738368, 8009.479383840032, 8011.839763204586, 8043.19568043191, 8154.918450815653, 8183.0, 9123.49820759838, 9210.585523651318, 9301.441913484941, 9356.157945784911, 9488.33581649278, 9476.431414115175, 9634.90365096368, 9760.41437513723, 9779.706608801747, 9799.755006124904, 6379.106925030406, 6892.586444813327, 7065.293470652894, 7147.106611673541, 7192.964035179791, 8253.009638843378, 8262.545559994258, 8280.668773249003, 8321.459105158145, 8329.125441828763, 7092.787216383516, 7305.41556675454, 7349.375303099297, 7386.48294619393, 7432.070991126109, 7409.962950185214, 7453.925460745323, 7475.1029876413, 7491.4006879448425, 7601.543907365576, 7790.415718821225, 7819.100803407681, 7873.09459412175, 7882.290593846581, 7896.170902055431, 6989.161300643956, 7059.117610298713, 7073.2219455858785, 7109.146902371748, 7129.7861064168155, 7340.082489688789, 7342.412606991535, 7400.888986665312, 7450.217727138789, 7450.8882366763455], "unit": "score", "name": "mootools.html", "value": 4816.852424812741}, {"lowerIsBetter": false, "replicates": [361.6925613228755, 363.429415817167, 367.88043885737125, 369.7892201445174, 375.5943580932593, 6128.417800308969, 6133.601315914462, 6152.784652537162, 6194.566380353377, 6196.442320191182, 6049.546284028705, 6050.848728781772, 6051.818445446633, 6068.787592434266, 6072.0, 4543.432070991126, 4590.081983603292, 4703.200455922484, 4726.4328280606205, 4760.42874855017, 4729.101470720552, 4730.0066985933, 4754.286856971447, 4763.261694437368, 4764.332993380929, 4705.058988202356, 4712.0811441768865, 4713.9057218855605, 4721.433427988646, 4727.692699974491, 4511.481179664332, 4557.951671115628, 4712.128256272601, 4715.1512727709, 4732.313814496913, 4185.414042034117, 4198.181354635817, 4198.6011328923705, 4200.432941552882, 4214.157168566299, 5769.826905192851, 5778.711064446761, 5781.4507621775865, 5787.276590426197, 5806.506446952014, 5513.696746678931, 5514.531264842493, 5520.7302320466515, 5522.806701765459, 5525.751341189656, 6400.39196276353, 6402.519811014193, 6407.647579383132, 6418.229812422539, 6419.0, 4390.27560452525, 4510.436195475566, 4522.909541809178, 4529.094181163748, 4662.533746625344, 6629.303923088055, 6677.732890684367, 6702.564333318367, 6710.93289067108, 6713.530052896299, 4631.652626053059, 4633.698809577367, 4642.210824159901, 4643.883902902455, 4644.698094623838, 4698.976505117521, 4699.859004229878, 4701.412323459567, 4701.848047228383, 4704.976475117603, 5391.2747920665015, 5394.541463975606, 5396.784128634889, 5398.784048638089, 5402.810901618424, 6315.8105256841445, 6399.520035997319, 6449.484041276686, 6460.160179176677, 6462.386073323027, 1634.3299247308785, 1653.79327584052, 1657.3287818433553, 1662.5843539115222, 1663.6173680053655, 1034.6585626743308, 1087.396494945313, 1090.2041509697965, 1107.2470719910377, 1113.4043286841502, 6209.316975132731, 6231.4391704746795, 6235.314115447297, 6240.5319601030105, 6244.313125556185, 6617.437517810944, 6618.0, 6623.7350505980185, 6635.170603674541, 6637.734490620321, 6216.222972128484, 6220.035894436279, 6223.1287619733275, 6224.315325314212, 6249.78125765596, 3544.8936531904083, 3572.089117275078, 3573.6783689468075, 3580.480830279647, 3585.46218067292, 6597.538172327987, 6802.931970680329, 6817.829554261183, 6825.419839313615, 6828.214755303204, 6719.630420326831, 6737.764178253738, 6742.595444273359, 6751.324867513307, 6751.594904305757, 6795.762148324785, 6814.250432452525, 6816.250212476623, 6818.659067046727, 6825.829354266183, 6593.505487088391, 6599.307072757483, 6601.108850305147, 6604.801855944329, 6605.174353205849, 6332.525060620564, 6446.419822216023, 6469.935300646934, 6471.708773105127, 6499.7400103995315, 6771.966140169267, 6798.728050878108, 6801.285864984304, 6809.625470599165, 6814.93185068143, 4629.907401852011, 4636.582707556337, 4638.582527572535, 4639.86080417588, 4641.605463535638, 6603.735850565923, 6611.809874222686, 6618.7352505899225, 6625.4699624029, 6625.469962403093, 6260.092286618506, 6418.743250269937, 6428.967855160694, 6434.260060092962, 6436.420722135031, 6328.335524769833, 6358.237011558643, 6362.6818659067785, 6363.459105976044, 6408.391202835724, 6267.843303917439, 6336.619802811846, 6378.52161087911, 6382.521310901794, 6391.744330226739, 6437.935620643921, 6440.774572889926, 6449.064885591469, 6451.451626611791, 6457.3865482779065, 6152.169457123231, 6235.844103897439, 6277.71750271248, 6299.779507717208, 6317.778877739257], "unit": "score", "name": "prototype.html", "value": 4883.63460590514}, {"lowerIsBetter": false, "replicates": [752.2026651749146, 820.6717313074771, 838.513662075996, 899.1098812175948, 945.5697657565809, 13932.860671393295, 14459.13245205287, 14492.565223043299, 14587.124772513656, 14666.70666586669, 13803.930980345109, 13943.0, 13967.65080872976, 13970.0, 13984.580462586113, 774.0517865614634, 900.3472482450237, 911.8313112074271, 913.9268858491338, 917.2295271971543, 917.3991035871514, 931.3434029009532, 935.0836180543038, 935.0836180543072, 936.2089034765612, 965.2133511188395, 980.2941881845096, 980.36276420327, 982.3123813330661, 982.3565564555228, 809.720646376999, 953.8044700836347, 962.7544976031068, 973.0, 973.4500007495812, 719.0185396933201, 719.2663483247059, 719.2879049740772, 719.3669570777735, 719.8128486593471, 14462.783058254134, 14466.855331446655, 14496.85503144976, 14520.927395363062, 14530.12819230839, 14525.636859078502, 14595.78106328406, 14901.850981490155, 14926.70146597062, 14947.925260373737, 11237.3257604544, 11326.0, 11348.14888883337, 11351.943240283746, 11920.22518536301, 3942.743721658083, 3959.6238357356006, 3995.5005624296964, 4006.4991876015497, 4032.0323122450695, 51597.74201129008, 51705.48294517044, 51729.48270517284, 52142.217866732026, 52175.217371739454, 11084.833727494093, 11378.715532111597, 11469.082473402108, 11534.134939879543, 11745.530178792924, 18734.250629974922, 18747.437576872715, 18755.156017978952, 18756.71864922027, 18840.246390144242, 7610.200928902496, 7813.218678132255, 7882.132965373804, 8080.151584083704, 8250.876236856451, 4460.665450091256, 4508.391367165456, 4514.458265008155, 4538.364628951949, 4551.6813823032735, 3375.780574262665, 3382.2389962258294, 3393.440082386428, 3397.0658069031215, 3401.1837159081642, 562.535907876004, 621.3972446726668, 634.520936692794, 656.7602824968852, 674.9932500675029, 529.5869222006841, 612.0665984373866, 642.9710663020081, 647.5499527828114, 679.4768028617937, 8868.955655221682, 8952.328575356743, 8965.013848476663, 8979.416337938013, 9087.727368178965, 600.5315853634172, 643.2024289880515, 652.9934700653027, 653.9247986481521, 673.8685956238486, 4189.874303770892, 4204.138151678899, 4229.873103806891, 4257.042165512735, 4311.33174357975, 59517.0, 59576.0, 59579.0, 60088.69955650194, 60136.69931650314, 53107.73446132822, 53282.73358633259, 53715.19427208595, 53739.0, 54734.0, 47955.760221198674, 48126.759366203645, 48638.756806215744, 49111.0, 49238.0, 8325.16748325187, 8337.166283371856, 8404.411691181558, 8553.57232138403, 8561.871571926302, 36532.0, 36992.81503592573, 37719.0, 38298.0, 38345.61654383421, 42720.572794272906, 46232.53767462282, 46670.76664616791, 46695.76652116854, 46850.29724554066, 10505.242136794808, 10700.30448020876, 10731.517081731185, 10767.407792571485, 10878.23852330361, 11570.537178512765, 11610.6516804496, 11708.941455292668, 11782.234154779911, 12052.457639406073, 10469.371837689763, 10607.045365917105, 10707.946460267649, 10824.783504330027, 10942.945285273523, 11331.32012079278, 11600.013998809858, 11982.041436685218, 12195.817062744243, 12539.435725392561, 11801.232919860182, 11801.763964720485, 11812.40937953116, 11833.763324733285, 11853.940730296294, 10465.162786977176, 10504.10715089226, 10561.841572376266, 10584.4707764613, 10766.354018758899, 9802.313838031268, 9863.556139973862, 9922.900770992486, 10066.496675166067, 10160.847587286344], "unit": "score", "name": "yui.html", "value": 6696.7938779766}], "name": "dromaeo_css", "value": 7146.0773280738185}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 109.0, 103.0, 109.0, 110.0, 110.0, 97.0, 109.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 152.0, 163.0, 136.0, 151.0, 160.0, 134.0, 177.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 163.0, 162.0, 165.0, 163.0, 165.0, 170.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 75.0, 168.0, 77.0, 73.0, 77.0, 76.0, 167.0, 75.0], "unit": "score", "name": "audio-fft", "value": 94.1}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 146.0, 93.0, 93.0, 94.0, 153.0, 93.0, 93.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 53.0, 55.0, 54.0, 54.0, 55.0, 65.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.2}, {"lowerIsBetter": true, "replicates": [86.0, 80.0, 80.0, 80.0, 82.0, 80.0, 79.0, 80.0, 81.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.8}, {"lowerIsBetter": true, "replicates": [118.0, 114.0, 113.0, 112.0, 112.0, 115.0, 121.0, 112.0, 138.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.6}, {"lowerIsBetter": true, "replicates": [143.0, 134.0, 134.0, 140.0, 141.0, 138.0, 154.0, 141.0, 146.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 65.0, 67.0, 67.0, 66.0, 64.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1506.3000000000002}]} 04:17:21 INFO - Return code: 0 04:17:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:17:21 INFO - # TBPL SUCCESS # 04:17:21 INFO - Running post-action listener: _resource_record_post_action 04:17:21 INFO - Running post-run listener: _resource_record_post_run 04:17:22 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 499367936; Read time: 0; Write time: 533676 04:17:22 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 252002304; Read time: 0; Write time: 370812 04:17:22 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 246767616; Read time: 0; Write time: 162864 04:17:22 INFO - Running post-run listener: _upload_blobber_files 04:17:22 INFO - Blob upload gear active. 04:17:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:17:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:17:22 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'] 04:17:22 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 04:17:23 INFO - (blobuploader) - INFO - Open directory for files ... 04:17:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:17:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:17:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:23 INFO - (blobuploader) - INFO - Done attempting. 04:17:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:17:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:17:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:24 INFO - (blobuploader) - INFO - Done attempting. 04:17:24 INFO - (blobuploader) - INFO - Iteration through files over. 04:17:24 INFO - Return code: 0 04:17:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:17:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:17:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/867236dc2035509bec7117ddea67aa9acf6081121883295c9f0cb5b8f4683012b4e2750690c8ebcba46b764dc9233d94ef35a21766dad0e712644b87621e9704", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/763660a5a58e8ce722fe9971bc4094f55b7227b5010fc1baddcce34f138786b27227d04a179ee506fa7b1a43ae1987689541aa8f037875f403aa4b1af9ea7a74"} 04:17:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:17:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:17:24 INFO - Contents: 04:17:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/867236dc2035509bec7117ddea67aa9acf6081121883295c9f0cb5b8f4683012b4e2750690c8ebcba46b764dc9233d94ef35a21766dad0e712644b87621e9704", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/763660a5a58e8ce722fe9971bc4094f55b7227b5010fc1baddcce34f138786b27227d04a179ee506fa7b1a43ae1987689541aa8f037875f403aa4b1af9ea7a74"} 04:17:24 INFO - Running post-run listener: copy_logs_to_upload_dir 04:17:24 INFO - Copying logs to upload dir... 04:17:24 INFO - mkdir: /builds/slave/test/build/upload/logs 04:17:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.628957 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-04-27 04:17:22.674155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:17:22.683053) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584 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/867236dc2035509bec7117ddea67aa9acf6081121883295c9f0cb5b8f4683012b4e2750690c8ebcba46b764dc9233d94ef35a21766dad0e712644b87621e9704", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/763660a5a58e8ce722fe9971bc4094f55b7227b5010fc1baddcce34f138786b27227d04a179ee506fa7b1a43ae1987689541aa8f037875f403aa4b1af9ea7a74"} build_url:https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/flbnhoNVSWK3J8Ku8n48-A/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/867236dc2035509bec7117ddea67aa9acf6081121883295c9f0cb5b8f4683012b4e2750690c8ebcba46b764dc9233d94ef35a21766dad0e712644b87621e9704", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/763660a5a58e8ce722fe9971bc4094f55b7227b5010fc1baddcce34f138786b27227d04a179ee506fa7b1a43ae1987689541aa8f037875f403aa4b1af9ea7a74"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:17:22.713533) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:17:22.713884) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461754616.718044-2116605584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004740 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:17:22.767598) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:17:22.768553) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:17:22.768864) ========= ========= Total master_lag: 0.15 =========