builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1461006913.28 results: success (0) buildid: 20160418094943 builduid: 82cf067085264d8d8a7159b7c61cf302 revision: 1a229bf7891d7b453eb6e5269c11ace513e400a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:13.275435) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:13.275883) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:13.276188) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:13.292736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:13.293069) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 12:15:13-- 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% 49.2M=0s 2016-04-18 12:15:13 (49.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073798 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:13.380441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:13.380788) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015296 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:13.431020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 12:15:13.431406) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1a229bf7891d7b453eb6e5269c11ace513e400a4 --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 1a229bf7891d7b453eb6e5269c11ace513e400a4 --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=97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 12:15:13,662 truncating revision to first 12 chars 2016-04-18 12:15:13,662 Setting DEBUG logging. 2016-04-18 12:15:13,662 attempt 1/10 2016-04-18 12:15:13,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1a229bf7891d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 12:15:14,758 unpacking tar archive at: mozilla-aurora-1a229bf7891d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.383324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 12:15:14.827921) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:14.828262) ========= script_repo_revision: 1a229bf7891d7b453eb6e5269c11ace513e400a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:14.828681) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:14.828971) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 12:15:14.846292) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-18 12:15:14.846587) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:15:15 INFO - MultiFileLogger online at 20160418 12:15:15 in /builds/slave/test 12:15:15 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 12:15:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:15:15 INFO - {'append_to_log': False, 12:15:15 INFO - 'base_work_dir': '/builds/slave/test', 12:15:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:15:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:15:15 INFO - 'branch': 'Mozilla-Aurora', 12:15:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:15:15 INFO - 'config_files': ('talos/linux_config.py',), 12:15:15 INFO - 'default_actions': ('clobber', 12:15:15 INFO - 'read-buildbot-config', 12:15:15 INFO - 'download-and-extract', 12:15:15 INFO - 'populate-webroot', 12:15:15 INFO - 'create-virtualenv', 12:15:15 INFO - 'install', 12:15:15 INFO - 'run-tests'), 12:15:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:15:15 INFO - 'download_minidump_stackwalk': True, 12:15:15 INFO - 'download_symbols': 'ondemand', 12:15:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:15:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:15:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:15:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:15:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:15:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:15:15 INFO - 'installer_path': 'installer.exe', 12:15:15 INFO - 'log_level': 'info', 12:15:15 INFO - 'log_name': 'talos', 12:15:15 INFO - 'log_to_console': True, 12:15:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:15:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:15:15 INFO - 'opt_config_files': (), 12:15:15 INFO - 'pip_index': False, 12:15:15 INFO - 'sps_profile': False, 12:15:15 INFO - 'sps_profile_interval': 0, 12:15:15 INFO - 'suite': 'dromaeojs', 12:15:15 INFO - 'system_bits': '32', 12:15:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:15:15 INFO - 'title': 'talos-linux64-ix-068', 12:15:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:15:15 INFO - 'use_talos_json': True, 12:15:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:15:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:15:15 INFO - 'work_dir': 'build'} 12:15:15 INFO - ##### 12:15:15 INFO - ##### Running clobber step. 12:15:15 INFO - ##### 12:15:15 INFO - Running pre-action listener: _resource_record_pre_action 12:15:15 INFO - Running main action method: clobber 12:15:15 INFO - rmtree: /builds/slave/test/build 12:15:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:15:15 INFO - Running post-action listener: _resource_record_post_action 12:15:15 INFO - ##### 12:15:15 INFO - ##### Running read-buildbot-config step. 12:15:15 INFO - ##### 12:15:15 INFO - Running pre-action listener: _resource_record_pre_action 12:15:15 INFO - Running main action method: read_buildbot_config 12:15:15 INFO - Using buildbot properties: 12:15:15 INFO - { 12:15:15 INFO - "project": "", 12:15:15 INFO - "product": "firefox", 12:15:15 INFO - "script_repo_revision": "production", 12:15:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:15:15 INFO - "repository": "", 12:15:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:15:15 INFO - "buildid": "20160418094943", 12:15:15 INFO - "pgo_build": "True", 12:15:15 INFO - "basedir": "/builds/slave/test", 12:15:15 INFO - "buildnumber": 444, 12:15:15 INFO - "slavename": "talos-linux64-ix-068", 12:15:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:15:15 INFO - "platform": "ubuntu64_hw", 12:15:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:15:15 INFO - "branch": "mozilla-aurora", 12:15:15 INFO - "repo_path": "releases/mozilla-aurora", 12:15:15 INFO - "revision": "1a229bf7891d7b453eb6e5269c11ace513e400a4", 12:15:15 INFO - "stage_platform": "linux64-pgo", 12:15:15 INFO - "builduid": "82cf067085264d8d8a7159b7c61cf302", 12:15:15 INFO - "slavebuilddir": "test" 12:15:15 INFO - } 12:15:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 12:15:15 INFO - Running post-action listener: _resource_record_post_action 12:15:15 INFO - ##### 12:15:15 INFO - ##### Running download-and-extract step. 12:15:15 INFO - ##### 12:15:15 INFO - Running pre-action listener: _resource_record_pre_action 12:15:15 INFO - Running main action method: download_and_extract 12:15:15 INFO - mkdir: /builds/slave/test/build/tests 12:15:15 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')]} 12:15:15 INFO - https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:15:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:15:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:15:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/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 12:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/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 12:15:27 INFO - Downloaded 1448 bytes. 12:15:27 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:15:27 INFO - Using the following test package requirements: 12:15:27 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 12:15:27 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:15:27 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:15:27 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:27 INFO - u'jsshell-linux-x86_64.zip'], 12:15:27 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:15:27 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 12:15:27 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:15:27 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:15:27 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:15:27 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 12:15:27 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:15:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:15:27 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:27 INFO - https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:15:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:15:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:15:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/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 12:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/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 12:15:31 INFO - Downloaded 23351834 bytes. 12:15:31 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'] 12:15:31 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 12:15:32 INFO - Return code: 0 12:15:32 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 12:15:32 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')]} 12:15:32 INFO - https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:15:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:15:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:15:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/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 12:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/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 12:15:33 INFO - Downloaded 23351834 bytes. 12:15:33 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'] 12:15:33 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 12:15:34 INFO - Return code: 0 12:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:34 INFO - https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:15:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 12:15:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 12:15:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/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 12:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/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 12:15:36 INFO - Downloaded 10845168 bytes. 12:15:36 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'] 12:15:36 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 12:15:37 INFO - Return code: 0 12:15:37 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')]} 12:15:37 INFO - https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:15:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:15:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:15:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/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 12:15:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQcEIOF2SFCDPCIV5ft67A/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 12:15:38 INFO - Downloaded 60592669 bytes. 12:15:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:15:38 INFO - mkdir: /builds/slave/test/properties 12:15:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:15:38 INFO - Writing to file /builds/slave/test/properties/build_url 12:15:38 INFO - Contents: 12:15:38 INFO - build_url:https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:15:39 INFO - Running post-action listener: _resource_record_post_action 12:15:39 INFO - Running post-action listener: set_extra_try_arguments 12:15:39 INFO - ##### 12:15:39 INFO - ##### Running populate-webroot step. 12:15:39 INFO - ##### 12:15:39 INFO - Running pre-action listener: _resource_record_pre_action 12:15:39 INFO - Running main action method: populate_webroot 12:15:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:15:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:15:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:15:39 INFO - '--tppagecycles', 12:15:39 INFO - '7'], 12:15:39 INFO - 'tests': ['tsvgm']}}, 12:15:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:15:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:15:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:15:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:15:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:15:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:15:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'talos_options': ['--e10s'], 12:15:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'tests': ['damp', 'tps']}, 12:15:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'talos_options': ['--e10s'], 12:15:39 INFO - 'tests': ['damp', 'tps']}, 12:15:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:15:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:15:39 INFO - 'other': {'tests': ['a11yr', 12:15:39 INFO - 'ts_paint', 12:15:39 INFO - 'tpaint', 12:15:39 INFO - 'sessionrestore', 12:15:39 INFO - 'sessionrestore_no_auto_restore', 12:15:39 INFO - 'tabpaint']}, 12:15:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:15:39 INFO - 'tests': ['a11yr', 12:15:39 INFO - 'ts_paint', 12:15:39 INFO - 'tpaint', 12:15:39 INFO - 'sessionrestore', 12:15:39 INFO - 'sessionrestore_no_auto_restore', 12:15:39 INFO - 'tabpaint']}, 12:15:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:15:39 INFO - 'tests': ['a11yr', 12:15:39 INFO - 'ts_paint', 12:15:39 INFO - 'tpaint', 12:15:39 INFO - 'sessionrestore', 12:15:39 INFO - 'sessionrestore_no_auto_restore', 12:15:39 INFO - 'tabpaint']}, 12:15:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:15:39 INFO - 'tests': ['a11yr', 12:15:39 INFO - 'ts_paint', 12:15:39 INFO - 'tpaint', 12:15:39 INFO - 'sessionrestore', 12:15:39 INFO - 'sessionrestore_no_auto_restore', 12:15:39 INFO - 'tabpaint']}, 12:15:39 INFO - 'other_l64': {'tests': ['a11yr', 12:15:39 INFO - 'ts_paint', 12:15:39 INFO - 'tpaint', 12:15:39 INFO - 'sessionrestore', 12:15:39 INFO - 'sessionrestore_no_auto_restore', 12:15:39 INFO - 'tabpaint']}, 12:15:39 INFO - 'other_nol64': {'tests': ['a11yr', 12:15:39 INFO - 'ts_paint', 12:15:39 INFO - 'tpaint', 12:15:39 INFO - 'sessionrestore', 12:15:39 INFO - 'sessionrestore_no_auto_restore', 12:15:39 INFO - 'tabpaint']}, 12:15:39 INFO - 'svgr': {'tests': ['tsvgx', 12:15:39 INFO - 'tsvgr_opacity', 12:15:39 INFO - 'tart', 12:15:39 INFO - 'tscrollx', 12:15:39 INFO - 'cart']}, 12:15:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:15:39 INFO - 'tests': ['tsvgx', 12:15:39 INFO - 'tsvgr_opacity', 12:15:39 INFO - 'tart', 12:15:39 INFO - 'tscrollx', 12:15:39 INFO - 'cart']}, 12:15:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'tests': ['tp5o']}, 12:15:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'talos_options': ['--e10s'], 12:15:39 INFO - 'tests': ['tp5o']}, 12:15:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'talos_options': ['--xperf_path', 12:15:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:39 INFO - 'tests': ['tp5n']}, 12:15:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'talos_options': ['--e10s', 12:15:39 INFO - '--xperf_path', 12:15:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:39 INFO - 'tests': ['tp5n']}}, 12:15:39 INFO - 'talos.zip': {'path': '', 12:15:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:15:39 INFO - Running post-action listener: _resource_record_post_action 12:15:39 INFO - ##### 12:15:39 INFO - ##### Running create-virtualenv step. 12:15:39 INFO - ##### 12:15:39 INFO - Running pre-action listener: _resource_record_pre_action 12:15:39 INFO - Running main action method: create_virtualenv 12:15:39 INFO - Creating virtualenv /builds/slave/test/build/venv 12:15:39 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 12:15:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:15:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:15:39 INFO - Using real prefix '/usr' 12:15:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:15:39 INFO - Installing distribute.............................................................................................................................................................................................done. 12:15:41 INFO - Installing pip.................done. 12:15:41 INFO - Return code: 0 12:15:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:41 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 0x7f1987845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f160>, '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 0x2160060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21604f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', '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 12:15:41 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 12:15:41 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 12:15:41 INFO - Using env: {'DISPLAY': ':0', 12:15:41 INFO - 'HOME': '/home/cltbld', 12:15:41 INFO - 'LANG': 'en_US.UTF-8', 12:15:41 INFO - 'LANGUAGE': 'en_US:en', 12:15:41 INFO - 'LOGNAME': 'cltbld', 12:15:41 INFO - 'MAIL': '/var/mail/cltbld', 12:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:41 INFO - 'MOZ_NO_REMOTE': '1', 12:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:41 INFO - 'NO_EM_RESTART': '1', 12:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:41 INFO - 'PWD': '/builds/slave/test', 12:15:41 INFO - 'SHELL': '/bin/bash', 12:15:41 INFO - 'SHLVL': '1', 12:15:41 INFO - 'TERM': 'linux', 12:15:41 INFO - 'TMOUT': '86400', 12:15:41 INFO - 'USER': 'cltbld', 12:15:41 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', 12:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:41 INFO - '_': '/tools/buildbot/bin/python'} 12:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:42 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 12:15:42 INFO - Cleaning up... 12:15:42 INFO - Return code: 0 12:15:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:42 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 0x7f1987845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f160>, '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 0x2160060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21604f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', '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 12:15:42 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 12:15:42 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 12:15:42 INFO - Using env: {'DISPLAY': ':0', 12:15:42 INFO - 'HOME': '/home/cltbld', 12:15:42 INFO - 'LANG': 'en_US.UTF-8', 12:15:42 INFO - 'LANGUAGE': 'en_US:en', 12:15:42 INFO - 'LOGNAME': 'cltbld', 12:15:42 INFO - 'MAIL': '/var/mail/cltbld', 12:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:42 INFO - 'MOZ_NO_REMOTE': '1', 12:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:42 INFO - 'NO_EM_RESTART': '1', 12:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:42 INFO - 'PWD': '/builds/slave/test', 12:15:42 INFO - 'SHELL': '/bin/bash', 12:15:42 INFO - 'SHLVL': '1', 12:15:42 INFO - 'TERM': 'linux', 12:15:42 INFO - 'TMOUT': '86400', 12:15:42 INFO - 'USER': 'cltbld', 12:15:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', 12:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:42 INFO - '_': '/tools/buildbot/bin/python'} 12:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:42 INFO - Downloading/unpacking psutil>=0.7.1 12:15:42 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 12:15:42 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 12:15:42 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 12:15:42 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 12:15:42 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 12:15:42 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 12:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:15:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:44 INFO - Installing collected packages: psutil 12:15:44 INFO - Running setup.py install for psutil 12:15:44 INFO - building 'psutil._psutil_linux' extension 12:15:44 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 12:15:44 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 12:15:44 INFO - building 'psutil._psutil_posix' extension 12:15:44 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 12:15:44 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 12:15:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:44 INFO - Successfully installed psutil 12:15:44 INFO - Cleaning up... 12:15:44 INFO - Return code: 0 12:15:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:44 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 0x7f1987845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f160>, '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 0x2160060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21604f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', '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 12:15:44 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 12:15:44 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 12:15:44 INFO - Using env: {'DISPLAY': ':0', 12:15:44 INFO - 'HOME': '/home/cltbld', 12:15:44 INFO - 'LANG': 'en_US.UTF-8', 12:15:44 INFO - 'LANGUAGE': 'en_US:en', 12:15:44 INFO - 'LOGNAME': 'cltbld', 12:15:44 INFO - 'MAIL': '/var/mail/cltbld', 12:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:44 INFO - 'MOZ_NO_REMOTE': '1', 12:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:44 INFO - 'NO_EM_RESTART': '1', 12:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:44 INFO - 'PWD': '/builds/slave/test', 12:15:44 INFO - 'SHELL': '/bin/bash', 12:15:44 INFO - 'SHLVL': '1', 12:15:44 INFO - 'TERM': 'linux', 12:15:44 INFO - 'TMOUT': '86400', 12:15:44 INFO - 'USER': 'cltbld', 12:15:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', 12:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:44 INFO - '_': '/tools/buildbot/bin/python'} 12:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:15:45 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 12:15:45 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 12:15:45 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 12:15:45 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 12:15:45 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 12:15:45 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 12:15:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:15:47 INFO - Installing collected packages: mozsystemmonitor 12:15:47 INFO - Running setup.py install for mozsystemmonitor 12:15:47 INFO - Successfully installed mozsystemmonitor 12:15:47 INFO - Cleaning up... 12:15:47 INFO - Return code: 0 12:15:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:15:47 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')]} 12:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:47 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')]} 12:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:47 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 0x7f1987845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f160>, '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 0x2160060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21604f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', '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 12:15:47 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 12:15:47 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 12:15:47 INFO - Using env: {'DISPLAY': ':0', 12:15:47 INFO - 'HOME': '/home/cltbld', 12:15:47 INFO - 'LANG': 'en_US.UTF-8', 12:15:47 INFO - 'LANGUAGE': 'en_US:en', 12:15:47 INFO - 'LOGNAME': 'cltbld', 12:15:47 INFO - 'MAIL': '/var/mail/cltbld', 12:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:47 INFO - 'MOZ_NO_REMOTE': '1', 12:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:47 INFO - 'NO_EM_RESTART': '1', 12:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:47 INFO - 'PWD': '/builds/slave/test', 12:15:47 INFO - 'SHELL': '/bin/bash', 12:15:47 INFO - 'SHLVL': '1', 12:15:47 INFO - 'TERM': 'linux', 12:15:47 INFO - 'TMOUT': '86400', 12:15:47 INFO - 'USER': 'cltbld', 12:15:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', 12:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:47 INFO - '_': '/tools/buildbot/bin/python'} 12:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:47 INFO - Downloading/unpacking blobuploader==1.2.4 12:15:47 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 12:15:47 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 12:15:47 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 12:15:47 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 12:15:47 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 12:15:47 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 12:15:49 INFO - Downloading blobuploader-1.2.4.tar.gz 12:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:15:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:15:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:49 INFO - Downloading docopt-0.6.1.tar.gz 12:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:15:50 INFO - Installing collected packages: blobuploader, requests, docopt 12:15:50 INFO - Running setup.py install for blobuploader 12:15:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:15:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:15:50 INFO - Running setup.py install for requests 12:15:50 INFO - Running setup.py install for docopt 12:15:50 INFO - Successfully installed blobuploader requests docopt 12:15:50 INFO - Cleaning up... 12:15:50 INFO - Return code: 0 12:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:50 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 0x7f1987845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f160>, '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 0x2160060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21604f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', '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 12:15:50 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 12:15:50 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 12:15:50 INFO - Using env: {'DISPLAY': ':0', 12:15:50 INFO - 'HOME': '/home/cltbld', 12:15:50 INFO - 'LANG': 'en_US.UTF-8', 12:15:50 INFO - 'LANGUAGE': 'en_US:en', 12:15:50 INFO - 'LOGNAME': 'cltbld', 12:15:50 INFO - 'MAIL': '/var/mail/cltbld', 12:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:50 INFO - 'MOZ_NO_REMOTE': '1', 12:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:50 INFO - 'NO_EM_RESTART': '1', 12:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:50 INFO - 'PWD': '/builds/slave/test', 12:15:50 INFO - 'SHELL': '/bin/bash', 12:15:50 INFO - 'SHLVL': '1', 12:15:50 INFO - 'TERM': 'linux', 12:15:50 INFO - 'TMOUT': '86400', 12:15:50 INFO - 'USER': 'cltbld', 12:15:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', 12:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:50 INFO - '_': '/tools/buildbot/bin/python'} 12:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:50 INFO - Running setup.py (path:/tmp/pip-8v_E2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:50 INFO - Running setup.py (path:/tmp/pip-63z9T4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:51 INFO - Running setup.py (path:/tmp/pip-6tXPS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:51 INFO - Running setup.py (path:/tmp/pip-AuYdcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:51 INFO - Running setup.py (path:/tmp/pip-zW850C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:51 INFO - Running setup.py (path:/tmp/pip-fVwsy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:51 INFO - Running setup.py (path:/tmp/pip-n1zduV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:51 INFO - Running setup.py (path:/tmp/pip-ZBlGrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:51 INFO - Running setup.py (path:/tmp/pip-smFtvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:51 INFO - Running setup.py (path:/tmp/pip-JRgcWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:51 INFO - Running setup.py (path:/tmp/pip-cE5k7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:51 INFO - Running setup.py (path:/tmp/pip-0YJXM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:51 INFO - Running setup.py (path:/tmp/pip-17vP7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:51 INFO - Running setup.py (path:/tmp/pip-ETHA_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:51 INFO - Running setup.py (path:/tmp/pip-vkEPAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:51 INFO - Running setup.py (path:/tmp/pip-vY4Fu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:52 INFO - Running setup.py (path:/tmp/pip-6vUrJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:15:52 INFO - Running setup.py install for manifestparser 12:15:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:15:52 INFO - Running setup.py install for mozcrash 12:15:52 INFO - Running setup.py install for mozdebug 12:15:52 INFO - Running setup.py install for mozdevice 12:15:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:15:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:15:52 INFO - Running setup.py install for mozfile 12:15:52 INFO - Running setup.py install for mozhttpd 12:15:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:15:52 INFO - Running setup.py install for mozinfo 12:15:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:15:52 INFO - Running setup.py install for mozInstall 12:15:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:15:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:15:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:15:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:15:52 INFO - Running setup.py install for mozleak 12:15:52 INFO - Running setup.py install for mozlog 12:15:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:15:53 INFO - Running setup.py install for moznetwork 12:15:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:15:53 INFO - Running setup.py install for mozprocess 12:15:53 INFO - Running setup.py install for mozprofile 12:15:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:15:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:15:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:15:53 INFO - Running setup.py install for mozrunner 12:15:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:15:53 INFO - Running setup.py install for mozscreenshot 12:15:53 INFO - Running setup.py install for moztest 12:15:53 INFO - Running setup.py install for mozversion 12:15:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:15:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:15:53 INFO - Cleaning up... 12:15:53 INFO - Return code: 0 12:15:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:53 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 0x7f1987845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f160>, '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 0x2160060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21604f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', '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 12:15:53 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 12:15:53 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 12:15:53 INFO - Using env: {'DISPLAY': ':0', 12:15:53 INFO - 'HOME': '/home/cltbld', 12:15:53 INFO - 'LANG': 'en_US.UTF-8', 12:15:53 INFO - 'LANGUAGE': 'en_US:en', 12:15:53 INFO - 'LOGNAME': 'cltbld', 12:15:53 INFO - 'MAIL': '/var/mail/cltbld', 12:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:53 INFO - 'MOZ_NO_REMOTE': '1', 12:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:53 INFO - 'NO_EM_RESTART': '1', 12:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:53 INFO - 'PWD': '/builds/slave/test', 12:15:53 INFO - 'SHELL': '/bin/bash', 12:15:53 INFO - 'SHLVL': '1', 12:15:53 INFO - 'TERM': 'linux', 12:15:53 INFO - 'TMOUT': '86400', 12:15:53 INFO - 'USER': 'cltbld', 12:15:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', 12:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:53 INFO - '_': '/tools/buildbot/bin/python'} 12:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:54 INFO - Running setup.py (path:/tmp/pip-5JiijJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:54 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)) 12:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:54 INFO - Running setup.py (path:/tmp/pip-ocIGN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:54 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)) 12:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:54 INFO - Running setup.py (path:/tmp/pip-Mkx2bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:54 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)) 12:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:54 INFO - Running setup.py (path:/tmp/pip-mZBoud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:54 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)) 12:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:54 INFO - Running setup.py (path:/tmp/pip-rEAsz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:54 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)) 12:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:54 INFO - Running setup.py (path:/tmp/pip-a7BhFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:54 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)) 12:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:54 INFO - Running setup.py (path:/tmp/pip-OcbZQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:54 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)) 12:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:54 INFO - Running setup.py (path:/tmp/pip-LsnTLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:54 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)) 12:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:54 INFO - Running setup.py (path:/tmp/pip-xXIXd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:54 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)) 12:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:54 INFO - Running setup.py (path:/tmp/pip-EPBqEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:54 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)) 12:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:54 INFO - Running setup.py (path:/tmp/pip-UuznQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:54 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)) 12:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:54 INFO - Running setup.py (path:/tmp/pip-MEUQTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:54 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)) 12:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:54 INFO - Running setup.py (path:/tmp/pip-w3NT1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:55 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)) 12:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:55 INFO - Running setup.py (path:/tmp/pip-TGyGPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:55 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)) 12:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:55 INFO - Running setup.py (path:/tmp/pip-O5qD6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:55 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)) 12:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:55 INFO - Running setup.py (path:/tmp/pip-YIVITu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:55 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)) 12:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:55 INFO - Running setup.py (path:/tmp/pip-5iAaOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:55 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)) 12:15:55 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)) 12:15:55 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)) 12:15:55 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)) 12:15:55 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)) 12:15:55 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)) 12:15:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:15:55 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 12:15:55 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 12:15:55 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 12:15:55 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 12:15:55 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 12:15:55 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 12:15:57 INFO - Downloading blessings-1.6.tar.gz 12:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:15:57 INFO - Installing collected packages: blessings 12:15:57 INFO - Running setup.py install for blessings 12:15:57 INFO - Successfully installed blessings 12:15:57 INFO - Cleaning up... 12:15:57 INFO - Return code: 0 12:15:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:57 INFO - Reading from file tmpfile_stdout 12:15:57 INFO - Current package versions: 12:15:57 INFO - argparse == 1.2.1 12:15:57 INFO - blessings == 1.6 12:15:57 INFO - blobuploader == 1.2.4 12:15:57 INFO - docopt == 0.6.1 12:15:57 INFO - manifestparser == 1.1 12:15:57 INFO - mozInstall == 1.12 12:15:57 INFO - mozcrash == 0.17 12:15:57 INFO - mozdebug == 0.1 12:15:57 INFO - mozdevice == 0.48 12:15:57 INFO - mozfile == 1.2 12:15:57 INFO - mozhttpd == 0.7 12:15:57 INFO - mozinfo == 0.9 12:15:57 INFO - mozleak == 0.1 12:15:57 INFO - mozlog == 3.1 12:15:57 INFO - moznetwork == 0.27 12:15:57 INFO - mozprocess == 0.22 12:15:57 INFO - mozprofile == 0.28 12:15:57 INFO - mozrunner == 6.11 12:15:57 INFO - mozscreenshot == 0.1 12:15:57 INFO - mozsystemmonitor == 0.0 12:15:57 INFO - moztest == 0.7 12:15:57 INFO - mozversion == 1.4 12:15:57 INFO - psutil == 3.1.1 12:15:57 INFO - requests == 1.2.3 12:15:57 INFO - wsgiref == 0.1.2 12:15:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:57 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')]} 12:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:57 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')]} 12:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:57 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 0x7f1987845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f160>, '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 0x2160060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21604f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', '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 12:15:57 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 12:15:57 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 12:15:57 INFO - Using env: {'DISPLAY': ':0', 12:15:57 INFO - 'HOME': '/home/cltbld', 12:15:57 INFO - 'LANG': 'en_US.UTF-8', 12:15:57 INFO - 'LANGUAGE': 'en_US:en', 12:15:57 INFO - 'LOGNAME': 'cltbld', 12:15:57 INFO - 'MAIL': '/var/mail/cltbld', 12:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:57 INFO - 'MOZ_NO_REMOTE': '1', 12:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:57 INFO - 'NO_EM_RESTART': '1', 12:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:57 INFO - 'PWD': '/builds/slave/test', 12:15:57 INFO - 'SHELL': '/bin/bash', 12:15:57 INFO - 'SHLVL': '1', 12:15:57 INFO - 'TERM': 'linux', 12:15:57 INFO - 'TMOUT': '86400', 12:15:57 INFO - 'USER': 'cltbld', 12:15:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', 12:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:57 INFO - '_': '/tools/buildbot/bin/python'} 12:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:57 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)) 12:15:57 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)) 12:15:57 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)) 12:15:57 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)) 12:15:57 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)) 12:15:57 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)) 12:15:57 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)) 12:15:57 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)) 12:15:57 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)) 12:15:57 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)) 12:15:57 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)) 12:15:57 INFO - Cleaning up... 12:15:57 INFO - Return code: 0 12:15:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:15:57 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')]} 12:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:57 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')]} 12:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:57 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 0x7f1987845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f160>, '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 0x2160060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21604f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', '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 12:15:57 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 12:15:57 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 12:15:57 INFO - Using env: {'DISPLAY': ':0', 12:15:57 INFO - 'HOME': '/home/cltbld', 12:15:57 INFO - 'LANG': 'en_US.UTF-8', 12:15:57 INFO - 'LANGUAGE': 'en_US:en', 12:15:57 INFO - 'LOGNAME': 'cltbld', 12:15:57 INFO - 'MAIL': '/var/mail/cltbld', 12:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:57 INFO - 'MOZ_NO_REMOTE': '1', 12:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:57 INFO - 'NO_EM_RESTART': '1', 12:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:57 INFO - 'PWD': '/builds/slave/test', 12:15:57 INFO - 'SHELL': '/bin/bash', 12:15:57 INFO - 'SHLVL': '1', 12:15:57 INFO - 'TERM': 'linux', 12:15:57 INFO - 'TMOUT': '86400', 12:15:57 INFO - 'USER': 'cltbld', 12:15:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', 12:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:57 INFO - '_': '/tools/buildbot/bin/python'} 12:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:58 INFO - Downloading/unpacking jsonschema 12:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:59 INFO - Downloading/unpacking functools32 (from jsonschema) 12:15:59 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 12:15:59 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 12:15:59 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 12:15:59 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 12:15:59 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 12:15:59 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 12:16:00 INFO - Downloading functools32-3.2.3-2.tar.gz 12:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:16:00 INFO - warning: no files found matching '*.txt' 12:16:00 INFO - no previously-included directories found matching 'build' 12:16:00 INFO - no previously-included directories found matching 'dist' 12:16:00 INFO - no previously-included directories found matching '.git*' 12:16:00 INFO - Installing collected packages: jsonschema, functools32 12:16:00 INFO - Running setup.py install for functools32 12:16:00 INFO - warning: no files found matching '*.txt' 12:16:00 INFO - no previously-included directories found matching 'build' 12:16:00 INFO - no previously-included directories found matching 'dist' 12:16:00 INFO - no previously-included directories found matching '.git*' 12:16:00 INFO - Successfully installed jsonschema functools32 12:16:00 INFO - Cleaning up... 12:16:00 INFO - Return code: 0 12:16:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:16:00 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')]} 12:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:00 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')]} 12:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:00 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 0x7f1987845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215f160>, '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 0x2160060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21604f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', '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 12:16:00 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 12:16:00 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 12:16:00 INFO - Using env: {'DISPLAY': ':0', 12:16:00 INFO - 'HOME': '/home/cltbld', 12:16:00 INFO - 'LANG': 'en_US.UTF-8', 12:16:00 INFO - 'LANGUAGE': 'en_US:en', 12:16:00 INFO - 'LOGNAME': 'cltbld', 12:16:00 INFO - 'MAIL': '/var/mail/cltbld', 12:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:00 INFO - 'MOZ_NO_REMOTE': '1', 12:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:00 INFO - 'NO_EM_RESTART': '1', 12:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:00 INFO - 'PWD': '/builds/slave/test', 12:16:00 INFO - 'SHELL': '/bin/bash', 12:16:00 INFO - 'SHLVL': '1', 12:16:00 INFO - 'TERM': 'linux', 12:16:00 INFO - 'TMOUT': '86400', 12:16:00 INFO - 'USER': 'cltbld', 12:16:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', 12:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:00 INFO - '_': '/tools/buildbot/bin/python'} 12:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:00 INFO - Downloading/unpacking flake8 12:16:00 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 12:16:00 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 12:16:00 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 12:16:00 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 12:16:00 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 12:16:00 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 12:16:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:16:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:16:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:16:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:16:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:16:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:16:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:16:03 INFO - no previously-included directories found matching 'docs/_build' 12:16:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:16:03 INFO - Running setup.py install for pep8 12:16:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:16:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:16:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:16:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:16:03 INFO - no previously-included directories found matching 'docs/_build' 12:16:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:16:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:16:03 INFO - Cleaning up... 12:16:03 INFO - Return code: 0 12:16:03 INFO - Running post-action listener: _resource_record_post_action 12:16:03 INFO - Running post-action listener: _start_resource_monitoring 12:16:03 INFO - Starting resource monitoring. 12:16:03 INFO - ##### 12:16:03 INFO - ##### Running install step. 12:16:03 INFO - ##### 12:16:03 INFO - Running pre-action listener: _resource_record_pre_action 12:16:03 INFO - Running main action method: install 12:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:03 INFO - Reading from file tmpfile_stdout 12:16:03 INFO - Detecting whether we're running mozinstall >=1.0... 12:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:16:03 INFO - Reading from file tmpfile_stdout 12:16:03 INFO - Output received: 12:16:03 INFO - Usage: mozinstall [options] installer 12:16:03 INFO - Options: 12:16:03 INFO - -h, --help show this help message and exit 12:16:03 INFO - -d DEST, --destination=DEST 12:16:03 INFO - Directory to install application into. [default: 12:16:03 INFO - "/builds/slave/test"] 12:16:03 INFO - --app=APP Application being installed. [default: firefox] 12:16:03 INFO - mkdir: /builds/slave/test/build/application 12:16:03 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'] 12:16:03 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 12:16:19 INFO - Reading from file tmpfile_stdout 12:16:19 INFO - Output received: 12:16:19 INFO - /builds/slave/test/build/application/firefox/firefox 12:16:19 INFO - Running post-action listener: _resource_record_post_action 12:16:19 INFO - ##### 12:16:19 INFO - ##### Running run-tests step. 12:16:19 INFO - ##### 12:16:19 INFO - Running pre-action listener: _resource_record_pre_action 12:16:19 INFO - Running main action method: run_tests 12:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:19 INFO - Python 2.7.3 12:16:19 INFO - Return code: 0 12:16:19 INFO - grabbing minidump binary from tooltool 12:16: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')]} 12:16:19 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 0x215f160>, '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 0x2160060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21604f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:19 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 12:16:19 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 12:16:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:19 INFO - Return code: 0 12:16:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:16:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:16:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:16:20 INFO - Return code: 0 12:16:20 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/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 12:16:20 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/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 12:16:20 INFO - Using env: {'DISPLAY': ':0', 12:16:20 INFO - 'HOME': '/home/cltbld', 12:16:20 INFO - 'LANG': 'en_US.UTF-8', 12:16:20 INFO - 'LANGUAGE': 'en_US:en', 12:16:20 INFO - 'LOGNAME': 'cltbld', 12:16:20 INFO - 'MAIL': '/var/mail/cltbld', 12:16:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:20 INFO - 'MOZ_NO_REMOTE': '1', 12:16:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:20 INFO - 'NO_EM_RESTART': '1', 12:16:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:20 INFO - 'PWD': '/builds/slave/test', 12:16:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:20 INFO - 'SHELL': '/bin/bash', 12:16:20 INFO - 'SHLVL': '1', 12:16:20 INFO - 'TERM': 'linux', 12:16:20 INFO - 'TMOUT': '86400', 12:16:20 INFO - 'USER': 'cltbld', 12:16:20 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009', 12:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:20 INFO - '_': '/tools/buildbot/bin/python'} 12:16:20 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/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 12:16:20 INFO - mozversion application_buildid: 20160418094943 12:16:20 INFO - mozversion application_changeset: 1a229bf7891d7b453eb6e5269c11ace513e400a4 12:16:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:16:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:20 INFO - mozversion application_name: Firefox 12:16:20 INFO - mozversion application_remotingname: firefox-dev 12:16:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:16:20 INFO - mozversion application_vendor: Mozilla 12:16:20 INFO - mozversion application_version: 47.0a2 12:16:20 INFO - mozversion platform_buildid: 20160418094943 12:16:20 INFO - mozversion platform_changeset: 1a229bf7891d7b453eb6e5269c11ace513e400a4 12:16:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:16:20 INFO - mozversion platform_version: 47.0a2 12:16:20 INFO - using testdate: 1461006980 12:16:20 INFO - actual date: 1461006980 12:16:20 INFO - starting webserver on 'localhost:50293' 12:16:20 INFO - SUITE-START | Running 2 tests 12:16:20 INFO - TEST-START | dromaeo_css 12:16:20 INFO - operating with platform_type : linux_ 12:16:20 INFO - Initialising browser for dromaeo_css test... 12:16:20 INFO - TEST-INFO | started process 18118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_0BZLn/profile http://localhost:50293/getInfo.html) 12:16:24 INFO - PROCESS | 18118 | __metrics Screen width/height:1600/1200 12:16:24 INFO - PROCESS | 18118 | colorDepth:24 12:16:24 INFO - PROCESS | 18118 | Browser inner width/height: 1024/697 12:16:24 INFO - PROCESS | 18118 | __metrics 12:16:26 INFO - PROCESS | 18118 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:16:27 INFO - TEST-INFO | 18118: exit 0 12:16:27 INFO - Browser initialized. 12:16:27 INFO - Running cycle 1/1 for dromaeo_css test... 12:16:27 INFO - TEST-INFO | started process 18207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_0BZLn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:16:39 INFO - PROCESS | 18207 | RSS: Main: 141713408 12:16:39 INFO - PROCESS | 18207 | 12:17:29 INFO - PROCESS | 18207 | 1461007049936 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] 12:19:37 INFO - PROCESS | 18207 | Cycle 1(1): loaded http://localhost:50293/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50293/tests/dromaeo/cssquery-ext.html) 12:19:38 INFO - PROCESS | 18207 | RSS: Main: 241950720 12:19:38 INFO - PROCESS | 18207 | 12:22:41 INFO - PROCESS | 18207 | Cycle 1(1): loaded http://localhost:50293/tests/dromaeo/cssquery-ext.html (next: http://localhost:50293/tests/dromaeo/cssquery-jquery.html) 12:22:41 INFO - PROCESS | 18207 | RSS: Main: 217464832 12:22:41 INFO - PROCESS | 18207 | 12:25:43 INFO - PROCESS | 18207 | Cycle 1(1): loaded http://localhost:50293/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50293/tests/dromaeo/cssquery-mootools.html) 12:25:43 INFO - PROCESS | 18207 | RSS: Main: 210833408 12:25:43 INFO - PROCESS | 18207 | 12:28:45 INFO - PROCESS | 18207 | Cycle 1(1): loaded http://localhost:50293/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50293/tests/dromaeo/cssquery-prototype.html) 12:28:46 INFO - PROCESS | 18207 | RSS: Main: 206028800 12:28:46 INFO - PROCESS | 18207 | 12:31:48 INFO - PROCESS | 18207 | Cycle 1(1): loaded http://localhost:50293/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50293/tests/dromaeo/cssquery-yui.html) 12:31:49 INFO - PROCESS | 18207 | RSS: Main: 206462976 12:31:49 INFO - PROCESS | 18207 | 12:34:51 INFO - PROCESS | 18207 | Cycle 1(1): loaded http://localhost:50293/tests/dromaeo/cssquery-yui.html (next: http://localhost:50293/tests/dromaeo/cssquery-dojo.html) 12:34:51 INFO - PROCESS | 18207 | RSS: Main: 238444544 12:34:51 INFO - PROCESS | 18207 | 12:34:51 INFO - PROCESS | 18207 | __start_tp_report 12:34:51 INFO - PROCESS | 18207 | _x_x_mozilla_page_load 12:34:51 INFO - PROCESS | 18207 | _x_x_mozilla_page_load_details 12:34:51 INFO - PROCESS | 18207 | |i|pagename|runs| 12:34:51 INFO - PROCESS | 18207 | |0;dojo.html;3275.5741753572033;3364.226227967569;3377.9999999999986;3384.5261663367132;3405.5232267482547;5424.755885985131;5441.401445840955;5447.918281225785;5466.316710411199;5473.2063850741615;5407.5133238008575;5447.346318441782;5451.073317536018;5457.863553411166;5468.863278418042;4762.928556071644;4939.06157830012;4988.301637770715;4996.100701873661;5053.418856831457;4905;4927.408710954691;4958.157113290731;5036.345275114249;5068.5438310552045;5025.597952163836;5084.415292241402;5084.694918304895;5086.186210206368;5087.084324821531;4987.401511818569;5035.924461133086;5052.6210534209895;5053.69677819332;5056.418511871145;4774.522547745198;4842.70943743373;4945.950540494585;4953.157963146274;4960.379952505937;5263.34208223972;5282.286891269706;5295.867603309909;5299.973500132513;5311.867203319909;5849.824505264849;5850.473457388855;5851.093080572518;5855.76576936922;5864;5717.313922329306;5763.654180749127;5866.061430171152;5866.76532938682;5878.088896221093;5463.016657001738;5471.206675032098;5476.041692703761;5476.726163691839;5488.807891723771;5789.102689083199;5931.673757943355;5978.163057172;5981.880362392815;5983.581149319593;5737.282839645044;5741.081426971748;5754.0505816540635;5784.421557844182;5791.449812267828;5870.765169393177;5875.9118613220835;5887.234659494238;5892.057270836645;5893.587448878623;5674.97162514193;5785.363610002896;5816.505597024216;5833.154192642043;5834.766609335664;5827.708614569255;5839.532837373;5850.795222167204;5851.64890106595;5886.440788125121;4431.98064445173;4433;4440.311751678495;4441;4447.310666846579;3917.5494818096286;3958.9208215836097;4008.819603117867;4026.7382620129597;4050;5475.09660905946;5498.615096943256;5501.752421141058;5504.2294078829;5542.196381524656;5866.530677545786;5879.235699359056;5880.059190529495;5882.764689412375;5889.617174883619;5300.734963251822;5356.4107948125675;5457.536109430743;5485.972570137204;5491.862703432446;5044.394672639307;5046.949530504721;5057.8229761958155;5075.822346217865;5098.5411312982005;5923.822285331361;5971.164037034819;5976.133460648181;5977.163197152402;5988.371221021817;5694.800681976111;5811.070228763378;5848.181254624356;5852.7658893643775;5910.083936989773;5948.10778383246;5988.431099045583;5989.431004054608;5992.550558708202;6002.039673652194;5728.856778580569;5730.971345143247;5731.226284451713;5752.856178595569;5766.221560089334;5689.829305120853;5779.68211748341;5850.063989761617;5863;5868.149118377897;5694.601377903507;5705.201271822031;5706.942930570641;5709.143628455598;5714.885702286014;5617.185508101385;5649.265595472562;5699.145128230799;5702.942970570241;5708.172315014383;5481.232627432242;5543.695096769717;5624.887502250014;5640.88718225625;5656.406077361818;5656.43435656431;5681.829545113653;5685.232493613309;5685.431456854281;5695.117256825199;5430.212619170277;5586.692731899622;5586.916196257141;5588.552915766811;5591.720413979366 12:34:51 INFO - PROCESS | 18207 | |1;ext.html;521.1011006014622;555.1423051385609;562.57525568196;588.2529187931327;615.1940957345876;30655.23361915953;31415.528767068514;38655.61344386555;39365.60634393655;39401.40897886534;43019.78490107553;43432.348514772304;43600.3459948101;43665.78167109168;43724.34413483792;8821.779455513632;9018.729438116867;9022.864657030117;9026.368154229207;9031.09689031095;8933.55332233389;9087.681931132413;9094.408863423889;9113.179813816756;9113.95443022784;9080.182783549479;9147.95426022869;9153.95423022884;9162.86255706165;9167.449953002808;9033.322500812432;9080.77298067547;9089.77275568116;9102.40834345772;9108.544572771369;8967.282617390592;9086.86369704455;9088.454692718458;9093.318001149873;9097.772555686095;42243.155136897396;42634;42758.144837103086;42821.57178428238;42899.78550107229;3583.7670551414076;3844.673202777767;3892.9221415571815;4014.759114453142;4203.243416185085;32188.195295117574;32330.838345808355;32605.347893042243;32740.836295818608;33491.832540837386;4372.628326592244;4387.166438376698;4390.604845563883;4393.604575588212;4497;278341;282480;282552;283522;284493;45729.771351143034;46924;64811.351886481476;65895;65930;44665;44683;44710;44910;44967.77516112399;13593.456261749618;13715.314234288446;13742.106763060368;13745.725085498434;13757.656058598415;10558.947205263925;10570.312929659547;10585.417802020962;10591.046805787517;10624.681259562225;14998.47505337308;15558.9222053889;15581.220938953235;15622.375104995901;15667.138307392976;5618.943810561842;5645.068563687028;5725.885482290331;5752.654840709571;5793.420657934173;1003.7791685829106;1025.348903446302;1053.2837670384058;1158.09089864456;1172.536847945074;29459.705402946125;29584.852075739484;30125;30197.547036794465;30750.384992300027;1067.2102644043352;1094.162965331522;1114.5987444519967;1127.588430222979;1264.3299051502718;15757.212139392985;15854.128022958848;16183.67632647364;16184.271707773178;16467.34130634761;331173;333906;333918;334174;335309;56142.719286403306;56463.71768141133;56607.71696141493;56647.716761416756;56675.14987275194;1258.8363512743285;1343.2746316988912;1343.9260840653858;1387.3271463340272;1428.8785453236383;27542;27597.58603620907;27876.86061569679;28362.716372836832;28450;42768.78615606902;42783.57216427796;42995.35506967335;43061.3540796882;43118.35322470228;191636;192644;192919;192971;193272;31479.370412592078;32760;33877.66122338844;34606.30787384188;34704.30591388108;39919;40761.79619101885;41335.793321033205;41457.37813932854;41468;34908.82545587256;34947.12632184216;35109.82445087758;35346.46980295349;35374.64625353713;33704.1573960653;33965.83017084899;34479.827600861834;34530.30939381148;34715.13212169716;42462.36306455467;42664.573354267304;42941.355879661205;43222.78388608037;43877.56122438735;32867.83566082154;33245.83377083099;33465.665343346256;33521.32957340888;34503.654963451045;28071.157865264075;28852.70125902313;30159.246018849703;30631.387372252877;30723.846380767955 12:34:51 INFO - PROCESS | 18207 | |2;jquery.html;372.4934089638092;386.0618696567342;386.1774420484368;393.5985294999101;395.49969288849593;17188.226529806157;17679.29282828687;18515.35196268131;18516.722249166272;18520;16775.748363774554;17105;17927.193276302598;17954.461366159037;17966.10169491527;5572.164175373696;5723.284589426322;5731.254936858202;5757.395473475288;5762.3373312069225;5502.724863756796;5619.634723742944;5679.545636349082;5723.742431590567;5724.942750572503;5592;5612.130119831432;5621.606487545853;5640.041192997201;5647.887042259153;5376.677399356051;5600.299962504687;5600.943990560083;5608.130739735307;5611.298587676541;4976.054549635558;4999.900001999939;5024.346834911475;5026.070177017264;5035.320231768701;20817.271395501237;21411.67882481764;22148.2248121315;22183.223587174372;22215.777842221534;2397.880105994693;2447.657327974085;2646.0870999505332;2956;2996.1161457370126;13614.319284035759;13663.453461861514;13778.104423212459;14131.081479703786;14216.644583885382;1916.7412399326051;1951.6584597695346;1974.5261137326938;1978.1592823050146;2079.6360636888485;47439.5256047442;58855.411445884994;60167;65097;67005.66497167484;9205.447673139633;9453.43279403238;9743.658971935949;9977.700668979942;9995.450250236307;13487.797683034762;13576.389062492211;13616.795748063787;13659.453621855213;13815.585532434043;7218.963905180545;7233.8553228935125;7238.963805180941;7312.159101703266;7335.449841261927;6750.696218670171;6766.424853887376;6827.726890924308;6829.248782633907;6846.554973926679;5882.411758824169;6089.117078023751;6099.207103076572;6137.294211165684;6171.382861713792;1858.0988220712943;1860.8139186081555;1886.6509695706338;1886.8867867927968;1902.3246747404748;962.8988956159642;1029.4698230411343;1039.4906495817147;1048.1771809129796;1076.6662334676275;17728.734068988975;17808.198631061634;17815.376461823773;17923.73114403285;18139.81860181381;946.3659348236698;971.2763990826738;1006.0291818395284;1023.81059503992;1038.444432228754;10423.374597524173;10434.113100386401;10531.578736850593;10572.207084468695;10603.151747860153;438378;451289;454211;457910;460612;45069.54930450654;58784.41215587875;66505.33494665088;70529.29470705228;71915.2808471919;1021.9693409197736;1028.9794204115876;1031.3347890610514;1033.132168978062;1036.0675392147127;12891.48434062627;16005.359785608445;16109.113998729714;16205.513834584981;16487.093209873572;32341.51487727639;34414.82792586021;34492.13769655678;34878.302433951685;35268.823655881555;41248.587514124476;43421.565784343016;44003;44112.117757644024;44777.328340075575;8521.233089022018;8538.10349913275;8726.781830454289;8746.125387461203;8828.867566986371;12631;13615.52345667897;13624;13656.453741850612;13711.314434278445;11892.583759568373;12010.819837702616;12088.576899808464;12101.334426606621;12141.575044873387;10573.207009474167;10933.234673572773;10943.726406839574;11245.38150401703;11365.431728413381;11040.668779936615;11067.391293478613;11270.267432616854;11370.20408571392;11378.601748938747;7981.800454988672;7987.36101111898;8294.170582941899;8310.833783324179;11464.89176710445;11467.942660286979;11695.298282103102;12063.853933876268;12081.57714479989;12105.878941210474 12:34:51 INFO - PROCESS | 18207 | |3;mootools.html;1409.5207629406;1443.1629654800213;1448.6233579269388;1635.296822366382;1846.3537761783377;7854.882176767346;7975.8803617945705;8036.91963080369;8037.075736290329;8050.758477245678;7842.843143137134;7982.481138725979;7987.041555013392;8010.319122874548;8010.439269251155;2069.2343832781894;2106.641870881946;2357.0807385119815;2365.2194775724015;2391.175044609607;2407.7471865454136;2428.429319110008;2429.416939934412;2440.3533063738037;2447.632855071736;2320.2575175943703;2331.9883400583058;2342.4846533762543;2400.471896182837;2401.759824017593;2351.0830775997374;2365.7161140663056;2373.1693907132453;2374.857508549484;2405.1822380390577;2350.4476448034698;2378.250850981935;2384.594618914771;2403.315055209257;2403.5072810073893;8176.918230817735;8257.95871020647;8258;8307.584620768997;8328.541930193836;4939.382577177853;5052.9242061369105;5053;5053.343065401511;5053.67151135175;3187.6652951439996;3206.406814739281;3207.4386982278006;3245.902622921316;3247.155739507745;1086;1956.6478033953883;1982.375551701224;2026.4528577284198;2027.482991837087;11114.888851111466;11226.15803814709;11227.157963152715;11231.494582743715;11233.887661123366;4129.070959034253;4268.423762792046;4286.721363111388;4316.762578058174;4330.913381732347;8974.41666291689;9004.774880628036;9005.864912026325;9011.819763604692;9026.819463610822;4963.255511673278;4974.17926042199;4980;5000.599952003904;5001;3973.0861901762755;4049.068714195693;4478.14915166124;4500.864974050718;4638.953610463852;3589.9820500897326;3674.375356189454;3697.574778900461;3710.3692372296773;3720.9441858372147;1128.8081026225561;1150.8446359741495;1154.8498695169574;1155.0470861539095;1158.4960542164185;1179.9882001179878;1180.887815657511;1200.1239095460362;1462.3273294284747;1480.489231215229;7804.2195780422635;7812.375009999187;8085.514869107755;8091.83816323682;8094.797630059178;517.1647788821027;520.6277511579239;526.5971531778192;527.7783331000988;539.8839249561363;6214.751409943642;6234.438900498977;6291;6298.275698294663;6339.809805705836;9612.134907858326;9869.851952220723;9881.555330010167;9885.060919212663;10012.849807252896;9842.163416109568;9933.50332483373;9961.50192490387;10128.392296462089;10172.237082218864;7816.57008864518;7845.764627061083;7935.08746494149;7974.441789074709;7986.600669966479;7470.850582988419;7514.699412023677;7536.698532058656;7539;7592.544447333178;8831.558422078999;8919.063498332582;8976.237019853386;9009.099090090938;9140.63437462494;8671.34964877624;8847.42491738035;9263.490508022123;9423.10480504351;9436.575354108943;6366.9044964326495;6509;6518.771842985473;7170.892436613351;7271.563706177646;7444.739434119996;7550.848983020419;7584.203658615766;7592.240775922363;7603.125640551408;6968.581885086911;7105.076340075964;7136.500444968802;7173.5337203081635;7207.603581802841;7056.50604457683;7067;7071.7878463646175;7160.534565253241;7174.713011479483;7252.38354739853;7333.633318333956;7453.888191677021;7457.2542745724995;7459.104907411145;6743.15710536183;6755.392014718503;6755.493337999571;6756.223034351113;6763.391294783493;6888.483363747639;6946.479014073863;7036.331548502884;7042.401395881408;7047.894281585883 12:34:51 INFO - PROCESS | 18207 | |4;prototype.html;351.5377278878275;353.6269235956065;361.83355656398055;363.03794943399987;366.3113346907813;5872.823815285543;5876.382979787114;5885.234919460469;5888.0873464613;5917.0828521579115;5841.912371314434;5846.941530584693;5863.2670916135485;5871.67887225374;5878.294604647437;4437.9334309985215;4551.8634440966825;4597.126545956275;4668.836590719326;4722.787474563653;4668.229742092568;4693.178693728601;4693.389859318284;4697.084068606623;4700.341952126705;4662.417197850269;4669.066186762644;4679.508651591585;4680.836170734025;4685.273782563708;4424.2921132618785;4550.908981820362;4629.8148074077;4641.512641172696;4659.114768194032;4109.260333140033;4121.175764847043;4121.443605113302;4128.91742165158;4140.60664236897;5757.596968212227;5757.769689212427;5758.395368486291;5762.5221154903375;5769.798057067983;5413.377461591928;5416.079266524661;5417.566594672417;5424.891502169935;5436.374816896068;6284.214473190851;6291.370862913672;6293.056041593752;6293.087502312185;6298.118263443122;4340.131973605292;4464.441944756905;4464.93302600458;4475.731456112644;4583.4041574595085;6470.773522926675;6505.0892874997535;6518.77184298552;6525.151730275082;6546.27990921003;4564.680472366969;4568.565986231302;4570;4573.679842410999;4574.108048930493;4635.536446355405;4639.234526303189;4642.2340313847835;4645.628349732014;4649.093426781813;5302.70835104073;5307.363116426053;5313.521783039545;5320.308359913187;5330.413654498002;6127.724252408652;6323.399277068671;6335.778247761306;6338.397852204033;6354.618722876642;1616.4584864070669;1631.282235816237;1639.9262033208533;1640.3848556791204;1643.7123503386858;1015.0661391519819;1039.295555289326;1050.422267752733;1083.869935607732;1108.146727020206;5913.881722365529;6004.219451471368;6012.488938440281;6023.096535519707;6032.4570788629235;6486.870262594722;6494.545381823322;6495.610263384212;6499.512536559777;6506.60960342381;5972.761089556456;6016.488598469179;6019.398060194033;6020.819375418744;6029.6683682397015;3475.669811367916;3493.2314890724;3493.5982362028694;3499.3001399720156;3515.6132825389186;6477.255115661665;6598.307177746364;6621.304762999912;6628.23775265841;6662.533622646368;6560.278369379364;6583.736650534021;6587.077809106729;6587.703553340111;6590.308017658077;6616.239132499824;6621;6627.337266273431;6636.933630663728;6638.535302528777;6437.935620643733;6447.065175549613;6447.6453795041725;6450.516211284266;6460.547761656827;6298.71655775482;6322.146510221061;6337.841553961188;6348.809535713936;6485.3514648534765;6740.966295168493;6747;6748.865022699617;6751.797446076625;6762.425193858577;4519.186546421544;4554.180247555471;4555.703879247838;4561.110583436331;4568;6530;6542.1168142300185;6543.214814222324;6543.967280163759;6552.410283074546;6338.936610633835;6341.55609107358;6346.143270658402;6346.333634968262;6353.936460635335;6196.194494715658;6362.395572420613;6364.459020983269;6375.77684781049;6385.201849768779;6225.719842607003;6235.37646235391;6242.906356404566;6252.280987686292;6255.530835187288;6399.456046236122;6399.712012959521;6408.519361047846;6411;6415.647139407378;5974.253218347707;6112.602680825732;6241.469475094486;6254.468370188585;6268.059791031382 12:34:51 INFO - PROCESS | 18207 | |5;yui.html;875.8729984152297;878.9384743067984;887.48969342628;887.9556022198889;904.3850181876323;14477.855221447782;14499.565013049625;14519.346629401676;14656.047356921792;14673.926630366846;12423.503059877594;12424.813627795591;12463.501459941592;12470.251784892913;15398.153101579408;846.4413487098501;879.7536689726886;886.4636894678723;886.7472770260478;888.9022207557164;856.8886044814196;879.2174964281794;880.7401816464159;882.3206131278912;883.3948745109589;874.9606267717936;875.7153924974377;877.7322916510494;877.7366789963017;898.5776684958059;870.1689886158704;873.0396563779855;873.1137895036543;885.406777459104;888.4047688049022;646.9385408386196;647.1457675867856;647.2685864972598;648.7632014314788;648.860494993574;15369.923150384288;15401.614959625987;15408.3836646534;15456.149911754848;15481.303341349667;13632.182069075789;13711.794323085061;13713;13723.245221512812;13826.101303415246;11615.186936914419;11660.766784664344;11815;12028;12129.878701212963;3859.6526312632;3892.338302488555;3924.2151569685893;3965.6232657897453;4006.4591280177096;45677.314840277424;45709.314360284625;45781;46313.30530042052;52222.738886305706;8669.26311263537;9152.725418237464;10589.15286777056;10863.945680271549;10955.287906286225;17700.29198832058;17808.821911780717;17832.821671783116;17847.73228401575;17860.285588576313;7764.340031097307;7839.608019598997;7890.684372625031;8079.676812927417;8146.633401496947;4339.7830108494445;4368.584984426474;4446.666500012448;4514.210013247734;4595.701279416827;3261.59230096238;3274.476083826624;3278.918027049343;3285;3288.638249792521;621.741977079516;628.1896353703762;631.1447987976318;631.5137344244906;633.5343522510951;694.5763084518439;701.5019336271203;730.5726150202084;758.4842307231136;768.0936494936029;8833.55832208387;8880.689175878813;8922.598483068277;9045.547722613843;9203.4938078405;731.0678884422298;734.8677238097087;749.5689978262412;782.5852298281919;785.7014334552833;4139.627433530996;4142.523609784913;4185.58144185579;4186.330187170038;4298.677599180074;58750.70624646849;58778.41221587815;59126.70436647789;59362.10956835651;59533;48116.518834811206;49471.75264123728;49870.25194622084;50181.24728129081;50515.49484505181;42734;46616.533834661896;46729.532704673875;46885.76557117193;48291.5170848287;7975.4018448615425;8114.634841432032;8716.477011379338;8851.557422128739;9296.302777291596;34722;35573.82213088918;36581.11113887944;36592;36790.8160459196;41034.589654103074;41627;42306;46038.769806150754;46054.078918422114;11498.712532186428;11825.113116516124;11882.22765520273;12054.819177712518;12447.93776031114;12326.383680816103;12678.985681145301;13042.673933151747;13238.073334866467;13321.400536975665;12164.452599633214;12214;12853.228806271654;12930.353482326034;13150.736985260433;12931.159474634494;13442.193468391537;13754.724905502035;13761.17432954026;14114.929425352808;11298.855269843694;12188.146829721834;12851.871481285067;13502.662433439242;13572.253526055767;9254.259659227111;9993.800123997335;10186.134178594606;10189.43958082283;11032.448377580928;9645.469499177332;9696.885345315954;9703.46630935277;9709.36889102206;9710.417374957526 12:34:51 INFO - PROCESS | 18207 | __end_tp_report 12:34:51 INFO - PROCESS | 18207 | __start_cc_report 12:34:51 INFO - PROCESS | 18207 | _x_x_mozilla_cycle_collect,793 12:34:51 INFO - PROCESS | 18207 | __end_cc_report 12:34:51 INFO - PROCESS | 18207 | __startTimestamp1461008091917__endTimestamp 12:34:51 INFO - PROCESS | 18207 | 12:34:51 INFO - PROCESS | 18207 | ------- Summary: start ------- 12:34:51 INFO - PROCESS | 18207 | Number of tests: 6 12:34:51 INFO - PROCESS | 18207 | 12:34:51 INFO - PROCESS | 18207 | [#0] dojo.html Cycles:165 Average:5414.64 Median:5617.19 stddev:584.18 (10.4%) stddev-sans-first:561.35 12:34:51 INFO - PROCESS | 18207 | Values: 3275.6 3364.2 3378.0 3384.5 3405.5 5424.8 5441.4 5447.9 5466.3 5473.2 5407.5 5447.3 5451.1 5457.9 5468.9 4762.9 4939.1 4988.3 4996.1 5053.4 4905.0 4927.4 4958.2 5036.3 5068.5 5025.6 5084.4 5084.7 5086.2 5087.1 4987.4 5035.9 5052.6 5053.7 5056.4 4774.5 4842.7 4946.0 4953.2 4960.4 5263.3 5282.3 5295.9 5300.0 5311.9 5849.8 5850.5 5851.1 5855.8 5864.0 5717.3 5763.7 5866.1 5866.8 5878.1 5463.0 5471.2 5476.0 5476.7 5488.8 5789.1 5931.7 5978.2 5981.9 5983.6 5737.3 5741.1 5754.1 5784.4 5791.4 5870.8 5875.9 5887.2 5892.1 5893.6 5675.0 5785.4 5816.5 5833.2 5834.8 5827.7 5839.5 5850.8 5851.6 5886.4 4432.0 4433.0 4440.3 4441.0 4447.3 3917.5 3958.9 4008.8 4026.7 4050.0 5475.1 5498.6 5501.8 5504.2 5542.2 5866.5 5879.2 5880.1 5882.8 5889.6 5300.7 5356.4 5457.5 5486.0 5491.9 5044.4 5046.9 5057.8 5075.8 5098.5 5923.8 5971.2 5976.1 5977.2 5988.4 5694.8 5811.1 5848.2 5852.8 5910.1 5948.1 5988.4 5989.4 5992.6 6002.0 5728.9 5731.0 5731.2 5752.9 5766.2 5689.8 5779.7 5850.1 5863.0 5868.1 5694.6 5705.2 5706.9 5709.1 5714.9 5617.2 5649.3 5699.1 5702.9 5708.2 5481.2 5543.7 5624.9 5640.9 5656.4 5656.4 5681.8 5685.2 5685.4 5695.1 5430.2 5586.7 5586.9 5588.6 5591.7 12:34:51 INFO - PROCESS | 18207 | 12:34:51 INFO - PROCESS | 18207 | [#1] ext.html Cycles:180 Average:44249.70 Median:35360.56 stddev:72134.57 (204.0%) stddev-sans-first:72262.21 12:34:51 INFO - PROCESS | 18207 | Values: 521.1 555.1 562.6 588.3 615.2 30655.2 31415.5 38655.6 39365.6 39401.4 43019.8 43432.3 43600.3 43665.8 43724.3 8821.8 9018.7 9022.9 9026.4 9031.1 8933.6 9087.7 9094.4 9113.2 9114.0 9080.2 9148.0 9154.0 9162.9 9167.4 9033.3 9080.8 9089.8 9102.4 9108.5 8967.3 9086.9 9088.5 9093.3 9097.8 42243.2 42634.0 42758.1 42821.6 42899.8 3583.8 3844.7 3892.9 4014.8 4203.2 32188.2 32330.8 32605.3 32740.8 33491.8 4372.6 4387.2 4390.6 4393.6 4497.0 278341.0 282480.0 282552.0 283522.0 284493.0 45729.8 46924.0 64811.4 65895.0 65930.0 44665.0 44683.0 44710.0 44910.0 44967.8 13593.5 13715.3 13742.1 13745.7 13757.7 10558.9 10570.3 10585.4 10591.0 10624.7 14998.5 15558.9 15581.2 15622.4 15667.1 5618.9 5645.1 5725.9 5752.7 5793.4 1003.8 1025.3 1053.3 1158.1 1172.5 29459.7 29584.9 30125.0 30197.5 30750.4 1067.2 1094.2 1114.6 1127.6 1264.3 15757.2 15854.1 16183.7 16184.3 16467.3 331173.0 333906.0 333918.0 334174.0 335309.0 56142.7 56463.7 56607.7 56647.7 56675.1 1258.8 1343.3 1343.9 1387.3 1428.9 27542.0 27597.6 27876.9 28362.7 28450.0 42768.8 42783.6 42995.4 43061.4 43118.4 191636.0 192644.0 192919.0 192971.0 193272.0 31479.4 32760.0 33877.7 34606.3 34704.3 39919.0 40761.8 41335.8 41457.4 41468.0 34908.8 34947.1 35109.8 35346.5 35374.6 33704.2 33965.8 34479.8 34530.3 34715.1 42462.4 42664.6 42941.4 43222.8 43877.6 32867.8 33245.8 33465.7 33521.3 34503.7 28071.2 28852.7 30159.2 30631.4 30723.8 12:34:51 INFO - PROCESS | 18207 | 12:34:51 INFO - PROCESS | 18207 | [#2] jquery.html Cycles:180 Average:25717.88 Median:2801.04 stddev:73824.54 (2635.6%) stddev-sans-first:74007.10 12:34:51 INFO - PROCESS | 18207 | Values: 372.5 386.1 386.2 393.6 395.5 17188.2 17679.3 18515.4 18516.7 18520.0 16775.7 17105.0 17927.2 17954.5 17966.1 5572.2 5723.3 5731.3 5757.4 5762.3 5502.7 5619.6 5679.5 5723.7 5724.9 5592.0 5612.1 5621.6 5640.0 5647.9 5376.7 5600.3 5600.9 5608.1 5611.3 4976.1 4999.9 5024.3 5026.1 5035.3 20817.3 21411.7 22148.2 22183.2 22215.8 2397.9 2447.7 2646.1 2956.0 2996.1 13614.3 13663.5 13778.1 14131.1 14216.6 1916.7 1951.7 1974.5 1978.2 2079.6 47439.5 58855.4 60167.0 65097.0 67005.7 9205.4 9453.4 9743.7 9977.7 9995.5 13487.8 13576.4 13616.8 13659.5 13815.6 7219.0 7233.9 7239.0 7312.2 7335.4 6750.7 6766.4 6827.7 6829.2 6846.6 5882.4 6089.1 6099.2 6137.3 6171.4 1858.1 1860.8 1886.7 1886.9 1902.3 962.9 1029.5 1039.5 1048.2 1076.7 17728.7 17808.2 17815.4 17923.7 18139.8 946.4 971.3 1006.0 1023.8 1038.4 10423.4 10434.1 10531.6 10572.2 10603.2 438378.0 451289.0 454211.0 457910.0 460612.0 45069.5 58784.4 66505.3 70529.3 71915.3 1022.0 1029.0 1031.3 1033.1 1036.1 12891.5 16005.4 16109.1 16205.5 16487.1 32341.5 34414.8 34492.1 34878.3 35268.8 41248.6 43421.6 44003.0 44112.1 44777.3 8521.2 8538.1 8726.8 8746.1 8828.9 12631.0 13615.5 13624.0 13656.5 13711.3 11892.6 12010.8 12088.6 12101.3 12141.6 10573.2 10933.2 10943.7 11245.4 11365.4 11040.7 11067.4 11270.3 11370.2 11378.6 7981.8 7987.4 8294.2 8310.8 11464.9 11467.9 11695.3 12063.9 12081.6 12105.9 12:34:51 INFO - PROCESS | 18207 | 12:34:51 INFO - PROCESS | 18207 | [#3] mootools.html Cycles:180 Average:5706.69 Median:6294.64 stddev:2966.63 (47.1%) stddev-sans-first:2957.37 12:34:51 INFO - PROCESS | 18207 | Values: 1409.5 1443.2 1448.6 1635.3 1846.4 7854.9 7975.9 8036.9 8037.1 8050.8 7842.8 7982.5 7987.0 8010.3 8010.4 2069.2 2106.6 2357.1 2365.2 2391.2 2407.7 2428.4 2429.4 2440.4 2447.6 2320.3 2332.0 2342.5 2400.5 2401.8 2351.1 2365.7 2373.2 2374.9 2405.2 2350.4 2378.3 2384.6 2403.3 2403.5 8176.9 8258.0 8258.0 8307.6 8328.5 4939.4 5052.9 5053.0 5053.3 5053.7 3187.7 3206.4 3207.4 3245.9 3247.2 1086.0 1956.6 1982.4 2026.5 2027.5 11114.9 11226.2 11227.2 11231.5 11233.9 4129.1 4268.4 4286.7 4316.8 4330.9 8974.4 9004.8 9005.9 9011.8 9026.8 4963.3 4974.2 4980.0 5000.6 5001.0 3973.1 4049.1 4478.1 4500.9 4639.0 3590.0 3674.4 3697.6 3710.4 3720.9 1128.8 1150.8 1154.8 1155.0 1158.5 1180.0 1180.9 1200.1 1462.3 1480.5 7804.2 7812.4 8085.5 8091.8 8094.8 517.2 520.6 526.6 527.8 539.9 6214.8 6234.4 6291.0 6298.3 6339.8 9612.1 9869.9 9881.6 9885.1 10012.8 9842.2 9933.5 9961.5 10128.4 10172.2 7816.6 7845.8 7935.1 7974.4 7986.6 7470.9 7514.7 7536.7 7539.0 7592.5 8831.6 8919.1 8976.2 9009.1 9140.6 8671.3 8847.4 9263.5 9423.1 9436.6 6366.9 6509.0 6518.8 7170.9 7271.6 7444.7 7550.8 7584.2 7592.2 7603.1 6968.6 7105.1 7136.5 7173.5 7207.6 7056.5 7067.0 7071.8 7160.5 7174.7 7252.4 7333.6 7453.9 7457.3 7459.1 6743.2 6755.4 6755.5 6756.2 6763.4 6888.5 6946.5 7036.3 7042.4 7047.9 12:34:51 INFO - PROCESS | 18207 | 12:34:51 INFO - PROCESS | 18207 | [#4] prototype.html Cycles:180 Average:5297.42 Median:5944.92 stddev:1563.39 (26.3%) stddev-sans-first:1523.07 12:34:51 INFO - PROCESS | 18207 | Values: 351.5 353.6 361.8 363.0 366.3 5872.8 5876.4 5885.2 5888.1 5917.1 5841.9 5846.9 5863.3 5871.7 5878.3 4437.9 4551.9 4597.1 4668.8 4722.8 4668.2 4693.2 4693.4 4697.1 4700.3 4662.4 4669.1 4679.5 4680.8 4685.3 4424.3 4550.9 4629.8 4641.5 4659.1 4109.3 4121.2 4121.4 4128.9 4140.6 5757.6 5757.8 5758.4 5762.5 5769.8 5413.4 5416.1 5417.6 5424.9 5436.4 6284.2 6291.4 6293.1 6293.1 6298.1 4340.1 4464.4 4464.9 4475.7 4583.4 6470.8 6505.1 6518.8 6525.2 6546.3 4564.7 4568.6 4570.0 4573.7 4574.1 4635.5 4639.2 4642.2 4645.6 4649.1 5302.7 5307.4 5313.5 5320.3 5330.4 6127.7 6323.4 6335.8 6338.4 6354.6 1616.5 1631.3 1639.9 1640.4 1643.7 1015.1 1039.3 1050.4 1083.9 1108.1 5913.9 6004.2 6012.5 6023.1 6032.5 6486.9 6494.5 6495.6 6499.5 6506.6 5972.8 6016.5 6019.4 6020.8 6029.7 3475.7 3493.2 3493.6 3499.3 3515.6 6477.3 6598.3 6621.3 6628.2 6662.5 6560.3 6583.7 6587.1 6587.7 6590.3 6616.2 6621.0 6627.3 6636.9 6638.5 6437.9 6447.1 6447.6 6450.5 6460.5 6298.7 6322.1 6337.8 6348.8 6485.4 6741.0 6747.0 6748.9 6751.8 6762.4 4519.2 4554.2 4555.7 4561.1 4568.0 6530.0 6542.1 6543.2 6544.0 6552.4 6338.9 6341.6 6346.1 6346.3 6353.9 6196.2 6362.4 6364.5 6375.8 6385.2 6225.7 6235.4 6242.9 6252.3 6255.5 6399.5 6399.7 6408.5 6411.0 6415.6 5974.3 6112.6 6241.5 6254.5 6268.1 12:34:51 INFO - PROCESS | 18207 | 12:34:51 INFO - PROCESS | 18207 | [#5] yui.html Cycles:180 Average:14172.52 Median:45745.16 stddev:15818.89 (34.6%) stddev-sans-first:15831.75 12:34:51 INFO - PROCESS | 18207 | Values: 875.9 878.9 887.5 888.0 904.4 14477.9 14499.6 14519.3 14656.0 14673.9 12423.5 12424.8 12463.5 12470.3 15398.2 846.4 879.8 886.5 886.7 888.9 856.9 879.2 880.7 882.3 883.4 875.0 875.7 877.7 877.7 898.6 870.2 873.0 873.1 885.4 888.4 646.9 647.1 647.3 648.8 648.9 15369.9 15401.6 15408.4 15456.1 15481.3 13632.2 13711.8 13713.0 13723.2 13826.1 11615.2 11660.8 11815.0 12028.0 12129.9 3859.7 3892.3 3924.2 3965.6 4006.5 45677.3 45709.3 45781.0 46313.3 52222.7 8669.3 9152.7 10589.2 10863.9 10955.3 17700.3 17808.8 17832.8 17847.7 17860.3 7764.3 7839.6 7890.7 8079.7 8146.6 4339.8 4368.6 4446.7 4514.2 4595.7 3261.6 3274.5 3278.9 3285.0 3288.6 621.7 628.2 631.1 631.5 633.5 694.6 701.5 730.6 758.5 768.1 8833.6 8880.7 8922.6 9045.5 9203.5 731.1 734.9 749.6 782.6 785.7 4139.6 4142.5 4185.6 4186.3 4298.7 58750.7 58778.4 59126.7 59362.1 59533.0 48116.5 49471.8 49870.3 50181.2 50515.5 42734.0 46616.5 46729.5 46885.8 48291.5 7975.4 8114.6 8716.5 8851.6 9296.3 34722.0 35573.8 36581.1 36592.0 36790.8 41034.6 41627.0 42306.0 46038.8 46054.1 11498.7 11825.1 11882.2 12054.8 12447.9 12326.4 12679.0 13042.7 13238.1 13321.4 12164.5 12214.0 12853.2 12930.4 13150.7 12931.2 13442.2 13754.7 13761.2 14114.9 11298.9 12188.1 12851.9 13502.7 13572.3 9254.3 9993.8 10186.1 10189.4 11032.4 9645.5 9696.9 9703.5 9709.4 9710.4 12:34:51 INFO - PROCESS | 18207 | -------- Summary: end -------- 12:34:51 INFO - PROCESS | 18207 | 12:34:52 INFO - TEST-INFO | 18207: exit 0 12:34:52 INFO - TEST-OK | dromaeo_css | took 1112320ms 12:34:52 INFO - TEST-START | kraken 12:34:52 INFO - operating with platform_type : linux_ 12:34:52 INFO - Initialising browser for kraken test... 12:34:52 INFO - TEST-INFO | started process 18407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZWIEuI/profile http://localhost:50293/getInfo.html) 12:34:56 INFO - PROCESS | 18407 | __metrics Screen width/height:1600/1200 12:34:56 INFO - PROCESS | 18407 | colorDepth:24 12:34:56 INFO - PROCESS | 18407 | Browser inner width/height: 1024/697 12:34:56 INFO - PROCESS | 18407 | __metrics 12:34:57 INFO - PROCESS | 18407 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:34:58 INFO - TEST-INFO | 18407: exit 0 12:34:58 INFO - Browser initialized. 12:34:58 INFO - Running cycle 1/1 for kraken test... 12:34:58 INFO - TEST-INFO | started process 18497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZWIEuI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:10 INFO - PROCESS | 18497 | RSS: Main: 142053376 12:35:10 INFO - PROCESS | 18497 | 12:35:13 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50293/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:13 INFO - PROCESS | 18497 | RSS: Main: 177545216 12:35:13 INFO - PROCESS | 18497 | 12:35:16 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50293/tests/kraken/driver.html?testName=audio-dft) 12:35:16 INFO - PROCESS | 18497 | RSS: Main: 176189440 12:35:16 INFO - PROCESS | 18497 | 12:35:19 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50293/tests/kraken/driver.html?testName=audio-fft) 12:35:20 INFO - PROCESS | 18497 | RSS: Main: 173068288 12:35:20 INFO - PROCESS | 18497 | 12:35:22 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50293/tests/kraken/driver.html?testName=audio-oscillator) 12:35:22 INFO - PROCESS | 18497 | RSS: Main: 173674496 12:35:22 INFO - PROCESS | 18497 | 12:35:25 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50293/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:25 INFO - PROCESS | 18497 | RSS: Main: 170803200 12:35:25 INFO - PROCESS | 18497 | 12:35:28 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50293/tests/kraken/driver.html?testName=imaging-darkroom) 12:35:29 INFO - PROCESS | 18497 | RSS: Main: 170778624 12:35:29 INFO - PROCESS | 18497 | 12:35:32 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50293/tests/kraken/driver.html?testName=imaging-desaturate) 12:35:33 INFO - PROCESS | 18497 | RSS: Main: 171716608 12:35:33 INFO - PROCESS | 18497 | 12:35:36 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50293/tests/kraken/driver.html?testName=json-parse-financial) 12:35:36 INFO - PROCESS | 18497 | RSS: Main: 170737664 12:35:36 INFO - PROCESS | 18497 | 12:35:38 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50293/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:35:38 INFO - PROCESS | 18497 | RSS: Main: 176390144 12:35:38 INFO - PROCESS | 18497 | 12:35:40 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50293/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:35:41 INFO - PROCESS | 18497 | RSS: Main: 174510080 12:35:41 INFO - PROCESS | 18497 | 12:35:43 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50293/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:35:43 INFO - PROCESS | 18497 | RSS: Main: 184537088 12:35:43 INFO - PROCESS | 18497 | 12:35:46 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:35:46 INFO - PROCESS | 18497 | RSS: Main: 189652992 12:35:46 INFO - PROCESS | 18497 | 12:35:49 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:35:49 INFO - PROCESS | 18497 | RSS: Main: 187981824 12:35:49 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | Cycle 1(1): loaded http://localhost:50293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50293/tests/kraken/driver.html?testName=ai-astar) 12:35:51 INFO - PROCESS | 18497 | RSS: Main: 250290176 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | __start_tp_report 12:35:51 INFO - PROCESS | 18497 | _x_x_mozilla_page_load 12:35:51 INFO - PROCESS | 18497 | _x_x_mozilla_page_load_details 12:35:51 INFO - PROCESS | 18497 | |i|pagename|runs| 12:35:51 INFO - PROCESS | 18497 | |0;ai-astar;109;109;105;110;111;110;99;109;109;108 12:35:51 INFO - PROCESS | 18497 | |1;audio-beat-detection;157;128;152;169;134;166;162;129;177;129 12:35:51 INFO - PROCESS | 18497 | |2;audio-dft;160;160;160;162;162;160;159;163;160;159 12:35:51 INFO - PROCESS | 18497 | |3;audio-fft;76;74;75;167;77;74;76;76;171;75 12:35:51 INFO - PROCESS | 18497 | |4;audio-oscillator;93;93;144;93;93;94;155;94;94;137 12:35:51 INFO - PROCESS | 18497 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;116;117;117 12:35:51 INFO - PROCESS | 18497 | |6;imaging-darkroom;147;145;146;147;146;146;145;145;146;147 12:35:51 INFO - PROCESS | 18497 | |7;imaging-desaturate;95;96;96;96;95;96;96;95;95;95 12:35:51 INFO - PROCESS | 18497 | |8;json-parse-financial;54;55;56;55;55;54;56;69;56;53 12:35:51 INFO - PROCESS | 18497 | |9;json-stringify-tinderbox;65;64;64;66;65;65;64;64;65;64 12:35:51 INFO - PROCESS | 18497 | |10;stanford-crypto-aes;79;80;78;80;79;78;77;77;79;79 12:35:51 INFO - PROCESS | 18497 | |11;stanford-crypto-ccm;112;117;113;114;111;119;114;112;115;118 12:35:51 INFO - PROCESS | 18497 | |12;stanford-crypto-pbkdf2;147;135;143;143;143;143;138;144;143;132 12:35:51 INFO - PROCESS | 18497 | |13;stanford-crypto-sha256-iterative;68;68;68;69;73;69;69;70;67;65 12:35:51 INFO - PROCESS | 18497 | __end_tp_report 12:35:51 INFO - PROCESS | 18497 | __start_cc_report 12:35:51 INFO - PROCESS | 18497 | _x_x_mozilla_cycle_collect,1077 12:35:51 INFO - PROCESS | 18497 | __end_cc_report 12:35:51 INFO - PROCESS | 18497 | __startTimestamp1461008151678__endTimestamp 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | ------- Summary: start ------- 12:35:51 INFO - PROCESS | 18497 | Number of tests: 14 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.50 stddev:3.51 (3.2%) stddev-sans-first:3.70 12:35:51 INFO - PROCESS | 18497 | Values: 109.0 109.0 105.0 110.0 111.0 110.0 99.0 109.0 109.0 108.0 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:159.50 stddev:18.75 (11.8%) stddev-sans-first:19.73 12:35:51 INFO - PROCESS | 18497 | Values: 157.0 128.0 152.0 169.0 134.0 166.0 162.0 129.0 177.0 129.0 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 12:35:51 INFO - PROCESS | 18497 | Values: 160.0 160.0 160.0 162.0 162.0 160.0 159.0 163.0 160.0 159.0 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:39.50 (52.3%) stddev-sans-first:41.35 12:35:51 INFO - PROCESS | 18497 | Values: 76.0 74.0 75.0 167.0 77.0 74.0 76.0 76.0 171.0 75.0 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:93.00 stddev:25.44 (27.4%) stddev-sans-first:26.31 12:35:51 INFO - PROCESS | 18497 | Values: 93.0 93.0 144.0 93.0 93.0 94.0 155.0 94.0 94.0 137.0 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 12:35:51 INFO - PROCESS | 18497 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 116.0 117.0 117.0 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 12:35:51 INFO - PROCESS | 18497 | Values: 147.0 145.0 146.0 147.0 146.0 146.0 145.0 145.0 146.0 147.0 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:35:51 INFO - PROCESS | 18497 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.50 stddev:4.57 (8.2%) stddev-sans-first:4.77 12:35:51 INFO - PROCESS | 18497 | Values: 54.0 55.0 56.0 55.0 55.0 54.0 56.0 69.0 56.0 53.0 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 12:35:51 INFO - PROCESS | 18497 | Values: 65.0 64.0 64.0 66.0 65.0 65.0 64.0 64.0 65.0 64.0 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:1.07 (1.4%) stddev-sans-first:1.13 12:35:51 INFO - PROCESS | 18497 | Values: 79.0 80.0 78.0 80.0 79.0 78.0 77.0 77.0 79.0 79.0 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#11] stanford-crypto-ccm Cycles:10 Average:114.50 Median:114.50 stddev:2.72 (2.4%) stddev-sans-first:2.73 12:35:51 INFO - PROCESS | 18497 | Values: 112.0 117.0 113.0 114.0 111.0 119.0 114.0 112.0 115.0 118.0 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.10 Median:143.00 stddev:4.61 (3.2%) stddev-sans-first:4.36 12:35:51 INFO - PROCESS | 18497 | Values: 147.0 135.0 143.0 143.0 143.0 143.0 138.0 144.0 143.0 132.0 12:35:51 INFO - PROCESS | 18497 | 12:35:51 INFO - PROCESS | 18497 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:2.07 (3.0%) stddev-sans-first:2.18 12:35:51 INFO - PROCESS | 18497 | Values: 68.0 68.0 68.0 69.0 73.0 69.0 69.0 70.0 67.0 65.0 12:35:51 INFO - PROCESS | 18497 | -------- Summary: end -------- 12:35:51 INFO - PROCESS | 18497 | 12:35:52 INFO - TEST-INFO | 18497: exit 0 12:35:52 INFO - TEST-OK | kraken | took 60071ms 12:35:52 INFO - SUITE-END | took 1172s 12:35:52 INFO - Completed test suite (00:19:32) 12:35:52 INFO - javascript benchmark 12:35:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3275.5741753572033, 3364.226227967569, 3377.9999999999986, 3384.5261663367132, 3405.5232267482547, 5424.755885985131, 5441.401445840955, 5447.918281225785, 5466.316710411199, 5473.2063850741615, 5407.5133238008575, 5447.346318441782, 5451.073317536018, 5457.863553411166, 5468.863278418042, 4762.928556071644, 4939.06157830012, 4988.301637770715, 4996.100701873661, 5053.418856831457, 4905.0, 4927.408710954691, 4958.157113290731, 5036.345275114249, 5068.5438310552045, 5025.597952163836, 5084.415292241402, 5084.694918304895, 5086.186210206368, 5087.084324821531, 4987.401511818569, 5035.924461133086, 5052.6210534209895, 5053.69677819332, 5056.418511871145, 4774.522547745198, 4842.70943743373, 4945.950540494585, 4953.157963146274, 4960.379952505937, 5263.34208223972, 5282.286891269706, 5295.867603309909, 5299.973500132513, 5311.867203319909, 5849.824505264849, 5850.473457388855, 5851.093080572518, 5855.76576936922, 5864.0, 5717.313922329306, 5763.654180749127, 5866.061430171152, 5866.76532938682, 5878.088896221093, 5463.016657001738, 5471.206675032098, 5476.041692703761, 5476.726163691839, 5488.807891723771, 5789.102689083199, 5931.673757943355, 5978.163057172, 5981.880362392815, 5983.581149319593, 5737.282839645044, 5741.081426971748, 5754.0505816540635, 5784.421557844182, 5791.449812267828, 5870.765169393177, 5875.9118613220835, 5887.234659494238, 5892.057270836645, 5893.587448878623, 5674.97162514193, 5785.363610002896, 5816.505597024216, 5833.154192642043, 5834.766609335664, 5827.708614569255, 5839.532837373, 5850.795222167204, 5851.64890106595, 5886.440788125121, 4431.98064445173, 4433.0, 4440.311751678495, 4441.0, 4447.310666846579, 3917.5494818096286, 3958.9208215836097, 4008.819603117867, 4026.7382620129597, 4050.0, 5475.09660905946, 5498.615096943256, 5501.752421141058, 5504.2294078829, 5542.196381524656, 5866.530677545786, 5879.235699359056, 5880.059190529495, 5882.764689412375, 5889.617174883619, 5300.734963251822, 5356.4107948125675, 5457.536109430743, 5485.972570137204, 5491.862703432446, 5044.394672639307, 5046.949530504721, 5057.8229761958155, 5075.822346217865, 5098.5411312982005, 5923.822285331361, 5971.164037034819, 5976.133460648181, 5977.163197152402, 5988.371221021817, 5694.800681976111, 5811.070228763378, 5848.181254624356, 5852.7658893643775, 5910.083936989773, 5948.10778383246, 5988.431099045583, 5989.431004054608, 5992.550558708202, 6002.039673652194, 5728.856778580569, 5730.971345143247, 5731.226284451713, 5752.856178595569, 5766.221560089334, 5689.829305120853, 5779.68211748341, 5850.063989761617, 5863.0, 5868.149118377897, 5694.601377903507, 5705.201271822031, 5706.942930570641, 5709.143628455598, 5714.885702286014, 5617.185508101385, 5649.265595472562, 5699.145128230799, 5702.942970570241, 5708.172315014383, 5481.232627432242, 5543.695096769717, 5624.887502250014, 5640.88718225625, 5656.406077361818, 5656.43435656431, 5681.829545113653, 5685.232493613309, 5685.431456854281, 5695.117256825199, 5430.212619170277, 5586.692731899622, 5586.916196257141, 5588.552915766811, 5591.720413979366], "unit": "score", "name": "dojo.html", "value": 5378.057544587352}, {"lowerIsBetter": false, "replicates": [521.1011006014622, 555.1423051385609, 562.57525568196, 588.2529187931327, 615.1940957345876, 30655.23361915953, 31415.528767068514, 38655.61344386555, 39365.60634393655, 39401.40897886534, 43019.78490107553, 43432.348514772304, 43600.3459948101, 43665.78167109168, 43724.34413483792, 8821.779455513632, 9018.729438116867, 9022.864657030117, 9026.368154229207, 9031.09689031095, 8933.55332233389, 9087.681931132413, 9094.408863423889, 9113.179813816756, 9113.95443022784, 9080.182783549479, 9147.95426022869, 9153.95423022884, 9162.86255706165, 9167.449953002808, 9033.322500812432, 9080.77298067547, 9089.77275568116, 9102.40834345772, 9108.544572771369, 8967.282617390592, 9086.86369704455, 9088.454692718458, 9093.318001149873, 9097.772555686095, 42243.155136897396, 42634.0, 42758.144837103086, 42821.57178428238, 42899.78550107229, 3583.7670551414076, 3844.673202777767, 3892.9221415571815, 4014.759114453142, 4203.243416185085, 32188.195295117574, 32330.838345808355, 32605.347893042243, 32740.836295818608, 33491.832540837386, 4372.628326592244, 4387.166438376698, 4390.604845563883, 4393.604575588212, 4497.0, 278341.0, 282480.0, 282552.0, 283522.0, 284493.0, 45729.771351143034, 46924.0, 64811.351886481476, 65895.0, 65930.0, 44665.0, 44683.0, 44710.0, 44910.0, 44967.77516112399, 13593.456261749618, 13715.314234288446, 13742.106763060368, 13745.725085498434, 13757.656058598415, 10558.947205263925, 10570.312929659547, 10585.417802020962, 10591.046805787517, 10624.681259562225, 14998.47505337308, 15558.9222053889, 15581.220938953235, 15622.375104995901, 15667.138307392976, 5618.943810561842, 5645.068563687028, 5725.885482290331, 5752.654840709571, 5793.420657934173, 1003.7791685829106, 1025.348903446302, 1053.2837670384058, 1158.09089864456, 1172.536847945074, 29459.705402946125, 29584.852075739484, 30125.0, 30197.547036794465, 30750.384992300027, 1067.2102644043352, 1094.162965331522, 1114.5987444519967, 1127.588430222979, 1264.3299051502718, 15757.212139392985, 15854.128022958848, 16183.67632647364, 16184.271707773178, 16467.34130634761, 331173.0, 333906.0, 333918.0, 334174.0, 335309.0, 56142.719286403306, 56463.71768141133, 56607.71696141493, 56647.716761416756, 56675.14987275194, 1258.8363512743285, 1343.2746316988912, 1343.9260840653858, 1387.3271463340272, 1428.8785453236383, 27542.0, 27597.58603620907, 27876.86061569679, 28362.716372836832, 28450.0, 42768.78615606902, 42783.57216427796, 42995.35506967335, 43061.3540796882, 43118.35322470228, 191636.0, 192644.0, 192919.0, 192971.0, 193272.0, 31479.370412592078, 32760.0, 33877.66122338844, 34606.30787384188, 34704.30591388108, 39919.0, 40761.79619101885, 41335.793321033205, 41457.37813932854, 41468.0, 34908.82545587256, 34947.12632184216, 35109.82445087758, 35346.46980295349, 35374.64625353713, 33704.1573960653, 33965.83017084899, 34479.827600861834, 34530.30939381148, 34715.13212169716, 42462.36306455467, 42664.573354267304, 42941.355879661205, 43222.78388608037, 43877.56122438735, 32867.83566082154, 33245.83377083099, 33465.665343346256, 33521.32957340888, 34503.654963451045, 28071.157865264075, 28852.70125902313, 30159.246018849703, 30631.387372252877, 30723.846380767955], "unit": "score", "name": "ext.html", "value": 18342.5432149836}, {"lowerIsBetter": false, "replicates": [372.4934089638092, 386.0618696567342, 386.1774420484368, 393.5985294999101, 395.49969288849593, 17188.226529806157, 17679.29282828687, 18515.35196268131, 18516.722249166272, 18520.0, 16775.748363774554, 17105.0, 17927.193276302598, 17954.461366159037, 17966.10169491527, 5572.164175373696, 5723.284589426322, 5731.254936858202, 5757.395473475288, 5762.3373312069225, 5502.724863756796, 5619.634723742944, 5679.545636349082, 5723.742431590567, 5724.942750572503, 5592.0, 5612.130119831432, 5621.606487545853, 5640.041192997201, 5647.887042259153, 5376.677399356051, 5600.299962504687, 5600.943990560083, 5608.130739735307, 5611.298587676541, 4976.054549635558, 4999.900001999939, 5024.346834911475, 5026.070177017264, 5035.320231768701, 20817.271395501237, 21411.67882481764, 22148.2248121315, 22183.223587174372, 22215.777842221534, 2397.880105994693, 2447.657327974085, 2646.0870999505332, 2956.0, 2996.1161457370126, 13614.319284035759, 13663.453461861514, 13778.104423212459, 14131.081479703786, 14216.644583885382, 1916.7412399326051, 1951.6584597695346, 1974.5261137326938, 1978.1592823050146, 2079.6360636888485, 47439.5256047442, 58855.411445884994, 60167.0, 65097.0, 67005.66497167484, 9205.447673139633, 9453.43279403238, 9743.658971935949, 9977.700668979942, 9995.450250236307, 13487.797683034762, 13576.389062492211, 13616.795748063787, 13659.453621855213, 13815.585532434043, 7218.963905180545, 7233.8553228935125, 7238.963805180941, 7312.159101703266, 7335.449841261927, 6750.696218670171, 6766.424853887376, 6827.726890924308, 6829.248782633907, 6846.554973926679, 5882.411758824169, 6089.117078023751, 6099.207103076572, 6137.294211165684, 6171.382861713792, 1858.0988220712943, 1860.8139186081555, 1886.6509695706338, 1886.8867867927968, 1902.3246747404748, 962.8988956159642, 1029.4698230411343, 1039.4906495817147, 1048.1771809129796, 1076.6662334676275, 17728.734068988975, 17808.198631061634, 17815.376461823773, 17923.73114403285, 18139.81860181381, 946.3659348236698, 971.2763990826738, 1006.0291818395284, 1023.81059503992, 1038.444432228754, 10423.374597524173, 10434.113100386401, 10531.578736850593, 10572.207084468695, 10603.151747860153, 438378.0, 451289.0, 454211.0, 457910.0, 460612.0, 45069.54930450654, 58784.41215587875, 66505.33494665088, 70529.29470705228, 71915.2808471919, 1021.9693409197736, 1028.9794204115876, 1031.3347890610514, 1033.132168978062, 1036.0675392147127, 12891.48434062627, 16005.359785608445, 16109.113998729714, 16205.513834584981, 16487.093209873572, 32341.51487727639, 34414.82792586021, 34492.13769655678, 34878.302433951685, 35268.823655881555, 41248.587514124476, 43421.565784343016, 44003.0, 44112.117757644024, 44777.328340075575, 8521.233089022018, 8538.10349913275, 8726.781830454289, 8746.125387461203, 8828.867566986371, 12631.0, 13615.52345667897, 13624.0, 13656.453741850612, 13711.314434278445, 11892.583759568373, 12010.819837702616, 12088.576899808464, 12101.334426606621, 12141.575044873387, 10573.207009474167, 10933.234673572773, 10943.726406839574, 11245.38150401703, 11365.431728413381, 11040.668779936615, 11067.391293478613, 11270.267432616854, 11370.20408571392, 11378.601748938747, 7981.800454988672, 7987.36101111898, 8294.170582941899, 8310.833783324179, 11464.89176710445, 11467.942660286979, 11695.298282103102, 12063.853933876268, 12081.57714479989, 12105.878941210474], "unit": "score", "name": "jquery.html", "value": 8813.304690506044}, {"lowerIsBetter": false, "replicates": [1409.5207629406, 1443.1629654800213, 1448.6233579269388, 1635.296822366382, 1846.3537761783377, 7854.882176767346, 7975.8803617945705, 8036.91963080369, 8037.075736290329, 8050.758477245678, 7842.843143137134, 7982.481138725979, 7987.041555013392, 8010.319122874548, 8010.439269251155, 2069.2343832781894, 2106.641870881946, 2357.0807385119815, 2365.2194775724015, 2391.175044609607, 2407.7471865454136, 2428.429319110008, 2429.416939934412, 2440.3533063738037, 2447.632855071736, 2320.2575175943703, 2331.9883400583058, 2342.4846533762543, 2400.471896182837, 2401.759824017593, 2351.0830775997374, 2365.7161140663056, 2373.1693907132453, 2374.857508549484, 2405.1822380390577, 2350.4476448034698, 2378.250850981935, 2384.594618914771, 2403.315055209257, 2403.5072810073893, 8176.918230817735, 8257.95871020647, 8258.0, 8307.584620768997, 8328.541930193836, 4939.382577177853, 5052.9242061369105, 5053.0, 5053.343065401511, 5053.67151135175, 3187.6652951439996, 3206.406814739281, 3207.4386982278006, 3245.902622921316, 3247.155739507745, 1086.0, 1956.6478033953883, 1982.375551701224, 2026.4528577284198, 2027.482991837087, 11114.888851111466, 11226.15803814709, 11227.157963152715, 11231.494582743715, 11233.887661123366, 4129.070959034253, 4268.423762792046, 4286.721363111388, 4316.762578058174, 4330.913381732347, 8974.41666291689, 9004.774880628036, 9005.864912026325, 9011.819763604692, 9026.819463610822, 4963.255511673278, 4974.17926042199, 4980.0, 5000.599952003904, 5001.0, 3973.0861901762755, 4049.068714195693, 4478.14915166124, 4500.864974050718, 4638.953610463852, 3589.9820500897326, 3674.375356189454, 3697.574778900461, 3710.3692372296773, 3720.9441858372147, 1128.8081026225561, 1150.8446359741495, 1154.8498695169574, 1155.0470861539095, 1158.4960542164185, 1179.9882001179878, 1180.887815657511, 1200.1239095460362, 1462.3273294284747, 1480.489231215229, 7804.2195780422635, 7812.375009999187, 8085.514869107755, 8091.83816323682, 8094.797630059178, 517.1647788821027, 520.6277511579239, 526.5971531778192, 527.7783331000988, 539.8839249561363, 6214.751409943642, 6234.438900498977, 6291.0, 6298.275698294663, 6339.809805705836, 9612.134907858326, 9869.851952220723, 9881.555330010167, 9885.060919212663, 10012.849807252896, 9842.163416109568, 9933.50332483373, 9961.50192490387, 10128.392296462089, 10172.237082218864, 7816.57008864518, 7845.764627061083, 7935.08746494149, 7974.441789074709, 7986.600669966479, 7470.850582988419, 7514.699412023677, 7536.698532058656, 7539.0, 7592.544447333178, 8831.558422078999, 8919.063498332582, 8976.237019853386, 9009.099090090938, 9140.63437462494, 8671.34964877624, 8847.42491738035, 9263.490508022123, 9423.10480504351, 9436.575354108943, 6366.9044964326495, 6509.0, 6518.771842985473, 7170.892436613351, 7271.563706177646, 7444.739434119996, 7550.848983020419, 7584.203658615766, 7592.240775922363, 7603.125640551408, 6968.581885086911, 7105.076340075964, 7136.500444968802, 7173.5337203081635, 7207.603581802841, 7056.50604457683, 7067.0, 7071.7878463646175, 7160.534565253241, 7174.713011479483, 7252.38354739853, 7333.633318333956, 7453.888191677021, 7457.2542745724995, 7459.104907411145, 6743.15710536183, 6755.392014718503, 6755.493337999571, 6756.223034351113, 6763.391294783493, 6888.483363747639, 6946.479014073863, 7036.331548502884, 7042.401395881408, 7047.894281585883], "unit": "score", "name": "mootools.html", "value": 4646.125664666108}, {"lowerIsBetter": false, "replicates": [351.5377278878275, 353.6269235956065, 361.83355656398055, 363.03794943399987, 366.3113346907813, 5872.823815285543, 5876.382979787114, 5885.234919460469, 5888.0873464613, 5917.0828521579115, 5841.912371314434, 5846.941530584693, 5863.2670916135485, 5871.67887225374, 5878.294604647437, 4437.9334309985215, 4551.8634440966825, 4597.126545956275, 4668.836590719326, 4722.787474563653, 4668.229742092568, 4693.178693728601, 4693.389859318284, 4697.084068606623, 4700.341952126705, 4662.417197850269, 4669.066186762644, 4679.508651591585, 4680.836170734025, 4685.273782563708, 4424.2921132618785, 4550.908981820362, 4629.8148074077, 4641.512641172696, 4659.114768194032, 4109.260333140033, 4121.175764847043, 4121.443605113302, 4128.91742165158, 4140.60664236897, 5757.596968212227, 5757.769689212427, 5758.395368486291, 5762.5221154903375, 5769.798057067983, 5413.377461591928, 5416.079266524661, 5417.566594672417, 5424.891502169935, 5436.374816896068, 6284.214473190851, 6291.370862913672, 6293.056041593752, 6293.087502312185, 6298.118263443122, 4340.131973605292, 4464.441944756905, 4464.93302600458, 4475.731456112644, 4583.4041574595085, 6470.773522926675, 6505.0892874997535, 6518.77184298552, 6525.151730275082, 6546.27990921003, 4564.680472366969, 4568.565986231302, 4570.0, 4573.679842410999, 4574.108048930493, 4635.536446355405, 4639.234526303189, 4642.2340313847835, 4645.628349732014, 4649.093426781813, 5302.70835104073, 5307.363116426053, 5313.521783039545, 5320.308359913187, 5330.413654498002, 6127.724252408652, 6323.399277068671, 6335.778247761306, 6338.397852204033, 6354.618722876642, 1616.4584864070669, 1631.282235816237, 1639.9262033208533, 1640.3848556791204, 1643.7123503386858, 1015.0661391519819, 1039.295555289326, 1050.422267752733, 1083.869935607732, 1108.146727020206, 5913.881722365529, 6004.219451471368, 6012.488938440281, 6023.096535519707, 6032.4570788629235, 6486.870262594722, 6494.545381823322, 6495.610263384212, 6499.512536559777, 6506.60960342381, 5972.761089556456, 6016.488598469179, 6019.398060194033, 6020.819375418744, 6029.6683682397015, 3475.669811367916, 3493.2314890724, 3493.5982362028694, 3499.3001399720156, 3515.6132825389186, 6477.255115661665, 6598.307177746364, 6621.304762999912, 6628.23775265841, 6662.533622646368, 6560.278369379364, 6583.736650534021, 6587.077809106729, 6587.703553340111, 6590.308017658077, 6616.239132499824, 6621.0, 6627.337266273431, 6636.933630663728, 6638.535302528777, 6437.935620643733, 6447.065175549613, 6447.6453795041725, 6450.516211284266, 6460.547761656827, 6298.71655775482, 6322.146510221061, 6337.841553961188, 6348.809535713936, 6485.3514648534765, 6740.966295168493, 6747.0, 6748.865022699617, 6751.797446076625, 6762.425193858577, 4519.186546421544, 4554.180247555471, 4555.703879247838, 4561.110583436331, 4568.0, 6530.0, 6542.1168142300185, 6543.214814222324, 6543.967280163759, 6552.410283074546, 6338.936610633835, 6341.55609107358, 6346.143270658402, 6346.333634968262, 6353.936460635335, 6196.194494715658, 6362.395572420613, 6364.459020983269, 6375.77684781049, 6385.201849768779, 6225.719842607003, 6235.37646235391, 6242.906356404566, 6252.280987686292, 6255.530835187288, 6399.456046236122, 6399.712012959521, 6408.519361047846, 6411.0, 6415.647139407378, 5974.253218347707, 6112.602680825732, 6241.469475094486, 6254.468370188585, 6268.059791031382], "unit": "score", "name": "prototype.html", "value": 4794.2395503532425}, {"lowerIsBetter": false, "replicates": [875.8729984152297, 878.9384743067984, 887.48969342628, 887.9556022198889, 904.3850181876323, 14477.855221447782, 14499.565013049625, 14519.346629401676, 14656.047356921792, 14673.926630366846, 12423.503059877594, 12424.813627795591, 12463.501459941592, 12470.251784892913, 15398.153101579408, 846.4413487098501, 879.7536689726886, 886.4636894678723, 886.7472770260478, 888.9022207557164, 856.8886044814196, 879.2174964281794, 880.7401816464159, 882.3206131278912, 883.3948745109589, 874.9606267717936, 875.7153924974377, 877.7322916510494, 877.7366789963017, 898.5776684958059, 870.1689886158704, 873.0396563779855, 873.1137895036543, 885.406777459104, 888.4047688049022, 646.9385408386196, 647.1457675867856, 647.2685864972598, 648.7632014314788, 648.860494993574, 15369.923150384288, 15401.614959625987, 15408.3836646534, 15456.149911754848, 15481.303341349667, 13632.182069075789, 13711.794323085061, 13713.0, 13723.245221512812, 13826.101303415246, 11615.186936914419, 11660.766784664344, 11815.0, 12028.0, 12129.878701212963, 3859.6526312632, 3892.338302488555, 3924.2151569685893, 3965.6232657897453, 4006.4591280177096, 45677.314840277424, 45709.314360284625, 45781.0, 46313.30530042052, 52222.738886305706, 8669.26311263537, 9152.725418237464, 10589.15286777056, 10863.945680271549, 10955.287906286225, 17700.29198832058, 17808.821911780717, 17832.821671783116, 17847.73228401575, 17860.285588576313, 7764.340031097307, 7839.608019598997, 7890.684372625031, 8079.676812927417, 8146.633401496947, 4339.7830108494445, 4368.584984426474, 4446.666500012448, 4514.210013247734, 4595.701279416827, 3261.59230096238, 3274.476083826624, 3278.918027049343, 3285.0, 3288.638249792521, 621.741977079516, 628.1896353703762, 631.1447987976318, 631.5137344244906, 633.5343522510951, 694.5763084518439, 701.5019336271203, 730.5726150202084, 758.4842307231136, 768.0936494936029, 8833.55832208387, 8880.689175878813, 8922.598483068277, 9045.547722613843, 9203.4938078405, 731.0678884422298, 734.8677238097087, 749.5689978262412, 782.5852298281919, 785.7014334552833, 4139.627433530996, 4142.523609784913, 4185.58144185579, 4186.330187170038, 4298.677599180074, 58750.70624646849, 58778.41221587815, 59126.70436647789, 59362.10956835651, 59533.0, 48116.518834811206, 49471.75264123728, 49870.25194622084, 50181.24728129081, 50515.49484505181, 42734.0, 46616.533834661896, 46729.532704673875, 46885.76557117193, 48291.5170848287, 7975.4018448615425, 8114.634841432032, 8716.477011379338, 8851.557422128739, 9296.302777291596, 34722.0, 35573.82213088918, 36581.11113887944, 36592.0, 36790.8160459196, 41034.589654103074, 41627.0, 42306.0, 46038.769806150754, 46054.078918422114, 11498.712532186428, 11825.113116516124, 11882.22765520273, 12054.819177712518, 12447.93776031114, 12326.383680816103, 12678.985681145301, 13042.673933151747, 13238.073334866467, 13321.400536975665, 12164.452599633214, 12214.0, 12853.228806271654, 12930.353482326034, 13150.736985260433, 12931.159474634494, 13442.193468391537, 13754.724905502035, 13761.17432954026, 14114.929425352808, 11298.855269843694, 12188.146829721834, 12851.871481285067, 13502.662433439242, 13572.253526055767, 9254.259659227111, 9993.800123997335, 10186.134178594606, 10189.43958082283, 11032.448377580928, 9645.469499177332, 9696.885345315954, 9703.46630935277, 9709.36889102206, 9710.417374957526], "unit": "score", "name": "yui.html", "value": 6682.543771856324}], "name": "dromaeo_css", "value": 7112.169640685796}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 105.0, 110.0, 111.0, 110.0, 99.0, 109.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [157.0, 128.0, 152.0, 169.0, 134.0, 166.0, 162.0, 129.0, 177.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 150.3}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 162.0, 162.0, 160.0, 159.0, 163.0, 160.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 75.0, 167.0, 77.0, 74.0, 76.0, 76.0, 171.0, 75.0], "unit": "score", "name": "audio-fft", "value": 94.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 144.0, 93.0, 93.0, 94.0, 155.0, 94.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 147.0, 146.0, 146.0, 145.0, 145.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 56.0, 55.0, 55.0, 54.0, 56.0, 69.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 66.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 78.0, 80.0, 79.0, 78.0, 77.0, 77.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.6}, {"lowerIsBetter": true, "replicates": [112.0, 117.0, 113.0, 114.0, 111.0, 119.0, 114.0, 112.0, 115.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.5}, {"lowerIsBetter": true, "replicates": [147.0, 135.0, 143.0, 143.0, 143.0, 143.0, 138.0, 144.0, 143.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 73.0, 69.0, 69.0, 70.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1504.0999999999997}]} 12:35:52 INFO - Return code: 0 12:35:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:35:52 INFO - # TBPL SUCCESS # 12:35:52 INFO - Running post-action listener: _resource_record_post_action 12:35:52 INFO - Running post-run listener: _resource_record_post_run 12:35:54 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 278528; Write bytes: 497012736; Read time: 52; Write time: 709276 12:35:54 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 244977664; Read time: 0; Write time: 442632 12:35:54 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 278528; Write bytes: 252035072; Read time: 52; Write time: 266644 12:35:54 INFO - Running post-run listener: _upload_blobber_files 12:35:54 INFO - Blob upload gear active. 12:35:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:35:54 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 12:35:54 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'] 12:35:54 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 12:35:54 INFO - (blobuploader) - INFO - Open directory for files ... 12:35:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:35:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:35:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:55 INFO - (blobuploader) - INFO - Done attempting. 12:35:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:35:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:35:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:56 INFO - (blobuploader) - INFO - Done attempting. 12:35:56 INFO - (blobuploader) - INFO - Iteration through files over. 12:35:56 INFO - Return code: 0 12:35:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:35:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:35:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8871d4f3b58cf9e3a873f44ac21b34ed379b3ddd94b937c88feb74241001aa1868ebdbb31f097f0bf233f1f2999494699d19e33503efd5fc07b0191f1ce72a56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c02043eb3b24d55705d4d50b8bc5229548a74d6b2cb1b0b6ed26ebdbbc447cc4b5b92fa8373f04b14545e2d89f72e72f2583cf9a107cf955c7b05a646ee93940"} 12:35:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:35:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:35:56 INFO - Contents: 12:35:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8871d4f3b58cf9e3a873f44ac21b34ed379b3ddd94b937c88feb74241001aa1868ebdbb31f097f0bf233f1f2999494699d19e33503efd5fc07b0191f1ce72a56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c02043eb3b24d55705d4d50b8bc5229548a74d6b2cb1b0b6ed26ebdbbc447cc4b5b92fa8373f04b14545e2d89f72e72f2583cf9a107cf955c7b05a646ee93940"} 12:35:56 INFO - Running post-run listener: copy_logs_to_upload_dir 12:35:56 INFO - Copying logs to upload dir... 12:35:56 INFO - mkdir: /builds/slave/test/build/upload/logs 12:35:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.399194 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-18 12:35:56.247044) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 12:35:56.250469) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009 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/8871d4f3b58cf9e3a873f44ac21b34ed379b3ddd94b937c88feb74241001aa1868ebdbb31f097f0bf233f1f2999494699d19e33503efd5fc07b0191f1ce72a56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c02043eb3b24d55705d4d50b8bc5229548a74d6b2cb1b0b6ed26ebdbbc447cc4b5b92fa8373f04b14545e2d89f72e72f2583cf9a107cf955c7b05a646ee93940"} build_url:https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/bQcEIOF2SFCDPCIV5ft67A/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/8871d4f3b58cf9e3a873f44ac21b34ed379b3ddd94b937c88feb74241001aa1868ebdbb31f097f0bf233f1f2999494699d19e33503efd5fc07b0191f1ce72a56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c02043eb3b24d55705d4d50b8bc5229548a74d6b2cb1b0b6ed26ebdbbc447cc4b5b92fa8373f04b14545e2d89f72e72f2583cf9a107cf955c7b05a646ee93940"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 12:35:56.276240) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:35:56.276599) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1461006419.97276-163869009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004383 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 12:35:56.360491) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 12:35:56.360909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 12:35:56.361282) ========= ========= Total master_lag: 0.16 =========