builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1461618988.54 results: success (0) buildid: 20160425095909 builduid: bf4af95f322a4411b3423b15fcf5776e revision: dcaf0a6fa115ad73bf7505a8e76464250b971a04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:28.538086) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:28.538575) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:28.539062) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.109353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.109669) ========= 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=41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 14:16:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-25 14:16:29 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.198310 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.367154) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.367476) ========= 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=41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016477 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.447865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:29.451018) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dcaf0a6fa115ad73bf7505a8e76464250b971a04 --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-beta --rev dcaf0a6fa115ad73bf7505a8e76464250b971a04 --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=41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 14:16:29,501 truncating revision to first 12 chars 2016-04-25 14:16:29,501 Setting DEBUG logging. 2016-04-25 14:16:29,501 attempt 1/10 2016-04-25 14:16:29,501 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dcaf0a6fa115?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 14:16:29,802 unpacking tar archive at: mozilla-beta-dcaf0a6fa115/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611454 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.091261) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.091606) ========= script_repo_revision: dcaf0a6fa115ad73bf7505a8e76464250b971a04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.092052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.092358) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:16:30.103198) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-04-25 14:16:30.103524) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:16:30 INFO - MultiFileLogger online at 20160425 14:16:30 in /builds/slave/test 14:16:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:16:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:16:30 INFO - {'append_to_log': False, 14:16:30 INFO - 'base_work_dir': '/builds/slave/test', 14:16:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:16:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:16:30 INFO - 'branch': 'Mozilla-Beta', 14:16:30 INFO - 'buildbot_json_path': 'buildprops.json', 14:16:30 INFO - 'config_files': ('talos/linux_config.py',), 14:16:30 INFO - 'default_actions': ('clobber', 14:16:30 INFO - 'read-buildbot-config', 14:16:30 INFO - 'download-and-extract', 14:16:30 INFO - 'populate-webroot', 14:16:30 INFO - 'create-virtualenv', 14:16:30 INFO - 'install', 14:16:30 INFO - 'run-tests'), 14:16:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:16:30 INFO - 'download_minidump_stackwalk': True, 14:16:30 INFO - 'download_symbols': 'ondemand', 14:16:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:16:30 INFO - 'tooltool.py': '/tools/tooltool.py', 14:16:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:16:30 INFO - '/tools/misc-python/virtualenv.py')}, 14:16:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:16:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:16:30 INFO - 'installer_path': 'installer.exe', 14:16:30 INFO - 'log_level': 'info', 14:16:30 INFO - 'log_name': 'talos', 14:16:30 INFO - 'log_to_console': True, 14:16:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:16:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:16:30 INFO - 'opt_config_files': (), 14:16:30 INFO - 'pip_index': False, 14:16:30 INFO - 'sps_profile': False, 14:16:30 INFO - 'sps_profile_interval': 0, 14:16:30 INFO - 'suite': 'dromaeojs', 14:16:30 INFO - 'system_bits': '32', 14:16:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:16:30 INFO - 'title': 'talos-linux64-ix-026', 14:16:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:16:30 INFO - 'use_talos_json': True, 14:16:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:16:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:16:30 INFO - 'work_dir': 'build'} 14:16:30 INFO - ##### 14:16:30 INFO - ##### Running clobber step. 14:16:30 INFO - ##### 14:16:30 INFO - Running pre-action listener: _resource_record_pre_action 14:16:30 INFO - Running main action method: clobber 14:16:30 INFO - rmtree: /builds/slave/test/build 14:16:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:16:30 INFO - Running post-action listener: _resource_record_post_action 14:16:30 INFO - ##### 14:16:30 INFO - ##### Running read-buildbot-config step. 14:16:30 INFO - ##### 14:16:30 INFO - Running pre-action listener: _resource_record_pre_action 14:16:30 INFO - Running main action method: read_buildbot_config 14:16:30 INFO - Using buildbot properties: 14:16:30 INFO - { 14:16:30 INFO - "project": "", 14:16:30 INFO - "product": "firefox", 14:16:30 INFO - "script_repo_revision": "production", 14:16:30 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:16:30 INFO - "repository": "", 14:16:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:16:30 INFO - "buildid": "20160425095909", 14:16:30 INFO - "pgo_build": "True", 14:16:30 INFO - "basedir": "/builds/slave/test", 14:16:30 INFO - "buildnumber": 41, 14:16:30 INFO - "slavename": "talos-linux64-ix-026", 14:16:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:16:30 INFO - "platform": "ubuntu64_hw", 14:16:30 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:16:30 INFO - "branch": "mozilla-beta", 14:16:30 INFO - "repo_path": "releases/mozilla-beta", 14:16:30 INFO - "revision": "dcaf0a6fa115ad73bf7505a8e76464250b971a04", 14:16:30 INFO - "stage_platform": "linux64-pgo", 14:16:30 INFO - "builduid": "bf4af95f322a4411b3423b15fcf5776e", 14:16:30 INFO - "slavebuilddir": "test" 14:16:30 INFO - } 14:16:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 14:16:30 INFO - Running post-action listener: _resource_record_post_action 14:16:30 INFO - ##### 14:16:30 INFO - ##### Running download-and-extract step. 14:16:30 INFO - ##### 14:16:30 INFO - Running pre-action listener: _resource_record_pre_action 14:16:30 INFO - Running main action method: download_and_extract 14:16:30 INFO - mkdir: /builds/slave/test/build/tests 14:16:30 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')]} 14:16:30 INFO - https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:16:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:16:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:16:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:16:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:16:31 INFO - Downloaded 1412 bytes. 14:16:31 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:16:31 INFO - Using the following test package requirements: 14:16:31 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:16:31 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:31 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:16:31 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:31 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 14:16:31 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:31 INFO - u'jsshell-linux-x86_64.zip'], 14:16:31 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:31 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:16:31 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:16:31 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:31 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 14:16:31 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:31 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 14:16:31 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:31 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:16:31 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:16:31 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:16:31 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:16:31 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:16:31 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')]} 14:16:31 INFO - https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:16:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:16:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:16:32 INFO - Downloaded 23362833 bytes. 14:16:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:16:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:16:34 INFO - Return code: 0 14:16:34 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:16: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')]} 14:16:34 INFO - https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:16:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:16:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:16:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:16:36 INFO - Downloaded 23362833 bytes. 14:16:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:16:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:16:38 INFO - Return code: 0 14:16:38 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')]} 14:16:38 INFO - https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:16:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 14:16:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 14:16:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 14:16:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:16:38 INFO - Downloaded 10845194 bytes. 14:16:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:16:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:16:39 INFO - Return code: 0 14:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:39 INFO - https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:16:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:16:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:16:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:16:40 INFO - Downloaded 53782838 bytes. 14:16:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:16:40 INFO - mkdir: /builds/slave/test/properties 14:16:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:16:40 INFO - Writing to file /builds/slave/test/properties/build_url 14:16:40 INFO - Contents: 14:16:40 INFO - build_url:https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:16:41 INFO - Running post-action listener: _resource_record_post_action 14:16:41 INFO - Running post-action listener: set_extra_try_arguments 14:16:41 INFO - ##### 14:16:41 INFO - ##### Running populate-webroot step. 14:16:41 INFO - ##### 14:16:41 INFO - Running pre-action listener: _resource_record_pre_action 14:16:41 INFO - Running main action method: populate_webroot 14:16:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:16:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:16:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:16:41 INFO - '--tppagecycles', 14:16:41 INFO - '7'], 14:16:41 INFO - 'tests': ['tsvgm']}}, 14:16:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:16:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:16:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:16:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:16:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:16:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:16:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:41 INFO - 'talos_options': ['--e10s'], 14:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:41 INFO - 'tests': ['damp', 'tps']}, 14:16:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:41 INFO - 'talos_options': ['--e10s'], 14:16:41 INFO - 'tests': ['damp', 'tps']}, 14:16:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:16:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:16:41 INFO - 'other': {'tests': ['a11yr', 14:16:41 INFO - 'ts_paint', 14:16:41 INFO - 'tpaint', 14:16:41 INFO - 'sessionrestore', 14:16:41 INFO - 'sessionrestore_no_auto_restore', 14:16:41 INFO - 'tabpaint']}, 14:16:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:16:41 INFO - 'tests': ['a11yr', 14:16:41 INFO - 'ts_paint', 14:16:41 INFO - 'tpaint', 14:16:41 INFO - 'sessionrestore', 14:16:41 INFO - 'sessionrestore_no_auto_restore', 14:16:41 INFO - 'tabpaint']}, 14:16:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:16:41 INFO - 'tests': ['a11yr', 14:16:41 INFO - 'ts_paint', 14:16:41 INFO - 'tpaint', 14:16:41 INFO - 'sessionrestore', 14:16:41 INFO - 'sessionrestore_no_auto_restore', 14:16:41 INFO - 'tabpaint']}, 14:16:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:16:41 INFO - 'tests': ['a11yr', 14:16:41 INFO - 'ts_paint', 14:16:41 INFO - 'tpaint', 14:16:41 INFO - 'sessionrestore', 14:16:41 INFO - 'sessionrestore_no_auto_restore', 14:16:41 INFO - 'tabpaint']}, 14:16:41 INFO - 'other_l64': {'tests': ['a11yr', 14:16:41 INFO - 'ts_paint', 14:16:41 INFO - 'tpaint', 14:16:41 INFO - 'sessionrestore', 14:16:41 INFO - 'sessionrestore_no_auto_restore', 14:16:41 INFO - 'tabpaint']}, 14:16:41 INFO - 'other_nol64': {'tests': ['a11yr', 14:16:41 INFO - 'ts_paint', 14:16:41 INFO - 'tpaint', 14:16:41 INFO - 'sessionrestore', 14:16:41 INFO - 'sessionrestore_no_auto_restore', 14:16:41 INFO - 'tabpaint']}, 14:16:41 INFO - 'svgr': {'tests': ['tsvgx', 14:16:41 INFO - 'tsvgr_opacity', 14:16:41 INFO - 'tart', 14:16:41 INFO - 'tscrollx', 14:16:41 INFO - 'cart']}, 14:16:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:16:41 INFO - 'tests': ['tsvgx', 14:16:41 INFO - 'tsvgr_opacity', 14:16:41 INFO - 'tart', 14:16:41 INFO - 'tscrollx', 14:16:41 INFO - 'cart']}, 14:16:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:41 INFO - 'tests': ['tp5o']}, 14:16:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:41 INFO - 'talos_options': ['--e10s'], 14:16:41 INFO - 'tests': ['tp5o']}, 14:16:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:41 INFO - 'talos_options': ['--xperf_path', 14:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:41 INFO - 'tests': ['tp5n']}, 14:16:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:41 INFO - 'talos_options': ['--e10s', 14:16:41 INFO - '--xperf_path', 14:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:41 INFO - 'tests': ['tp5n']}}, 14:16:41 INFO - 'talos.zip': {'path': '', 14:16:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:16:41 INFO - Running post-action listener: _resource_record_post_action 14:16:41 INFO - ##### 14:16:41 INFO - ##### Running create-virtualenv step. 14:16:41 INFO - ##### 14:16:41 INFO - Running pre-action listener: _resource_record_pre_action 14:16:41 INFO - Running main action method: create_virtualenv 14:16:41 INFO - Creating virtualenv /builds/slave/test/build/venv 14:16:41 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 14:16:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:16:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:16:41 INFO - Using real prefix '/usr' 14:16:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:16:41 INFO - Installing distribute.............................................................................................................................................................................................done. 14:16:43 INFO - Installing pip.................done. 14:16:43 INFO - Return code: 0 14:16:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:43 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 0x7f6a750e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7160>, '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 0x10c8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84f0>, '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': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', '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 14:16:43 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 14:16:43 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 14:16:43 INFO - Using env: {'DISPLAY': ':0', 14:16:43 INFO - 'HOME': '/home/cltbld', 14:16:43 INFO - 'LANG': 'en_US.UTF-8', 14:16:43 INFO - 'LANGUAGE': 'en_US:en', 14:16:43 INFO - 'LOGNAME': 'cltbld', 14:16:43 INFO - 'MAIL': '/var/mail/cltbld', 14:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:43 INFO - 'MOZ_NO_REMOTE': '1', 14:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:43 INFO - 'NO_EM_RESTART': '1', 14:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:43 INFO - 'PWD': '/builds/slave/test', 14:16:43 INFO - 'SHELL': '/bin/bash', 14:16:43 INFO - 'SHLVL': '1', 14:16:43 INFO - 'TERM': 'linux', 14:16:43 INFO - 'TMOUT': '86400', 14:16:43 INFO - 'USER': 'cltbld', 14:16:43 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', 14:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:43 INFO - '_': '/tools/buildbot/bin/python'} 14:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:44 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 14:16:44 INFO - Cleaning up... 14:16:44 INFO - Return code: 0 14:16:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:16: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')]} 14:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16: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')]} 14:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16: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', '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 0x7f6a750e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7160>, '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 0x10c8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84f0>, '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': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', '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 14:16: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', 'psutil>=0.7.1'] in /builds/slave/test/build 14:16: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 psutil>=0.7.1 14:16:44 INFO - Using env: {'DISPLAY': ':0', 14:16:44 INFO - 'HOME': '/home/cltbld', 14:16:44 INFO - 'LANG': 'en_US.UTF-8', 14:16:44 INFO - 'LANGUAGE': 'en_US:en', 14:16:44 INFO - 'LOGNAME': 'cltbld', 14:16:44 INFO - 'MAIL': '/var/mail/cltbld', 14:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:44 INFO - 'MOZ_NO_REMOTE': '1', 14:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:44 INFO - 'NO_EM_RESTART': '1', 14:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:44 INFO - 'PWD': '/builds/slave/test', 14:16:44 INFO - 'SHELL': '/bin/bash', 14:16:44 INFO - 'SHLVL': '1', 14:16:44 INFO - 'TERM': 'linux', 14:16:44 INFO - 'TMOUT': '86400', 14:16:44 INFO - 'USER': 'cltbld', 14:16:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', 14:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:44 INFO - '_': '/tools/buildbot/bin/python'} 14:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:44 INFO - Downloading/unpacking psutil>=0.7.1 14:16:44 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 14:16:44 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 14:16:44 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 14:16:44 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 14:16:44 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 14:16:44 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 14:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:16:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:16:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:16:46 INFO - Installing collected packages: psutil 14:16:46 INFO - Running setup.py install for psutil 14:16:46 INFO - building 'psutil._psutil_linux' extension 14:16:46 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 14:16:46 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 14:16:46 INFO - building 'psutil._psutil_posix' extension 14:16:46 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 14:16:46 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 14:16:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:16:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:16:46 INFO - Successfully installed psutil 14:16:46 INFO - Cleaning up... 14:16:46 INFO - Return code: 0 14:16:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:16:46 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')]} 14:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:46 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')]} 14:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:46 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 0x7f6a750e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7160>, '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 0x10c8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84f0>, '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': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', '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 14:16:46 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 14:16:46 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 14:16:46 INFO - Using env: {'DISPLAY': ':0', 14:16:46 INFO - 'HOME': '/home/cltbld', 14:16:46 INFO - 'LANG': 'en_US.UTF-8', 14:16:46 INFO - 'LANGUAGE': 'en_US:en', 14:16:46 INFO - 'LOGNAME': 'cltbld', 14:16:46 INFO - 'MAIL': '/var/mail/cltbld', 14:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:46 INFO - 'MOZ_NO_REMOTE': '1', 14:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:46 INFO - 'NO_EM_RESTART': '1', 14:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:46 INFO - 'PWD': '/builds/slave/test', 14:16:46 INFO - 'SHELL': '/bin/bash', 14:16:46 INFO - 'SHLVL': '1', 14:16:46 INFO - 'TERM': 'linux', 14:16:46 INFO - 'TMOUT': '86400', 14:16:46 INFO - 'USER': 'cltbld', 14:16:46 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', 14:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:46 INFO - '_': '/tools/buildbot/bin/python'} 14:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:16: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 14:16: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 14:16: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 14:16: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 14:16: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 14:16: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 14:16:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:16:49 INFO - Installing collected packages: mozsystemmonitor 14:16:49 INFO - Running setup.py install for mozsystemmonitor 14:16:49 INFO - Successfully installed mozsystemmonitor 14:16:49 INFO - Cleaning up... 14:16:49 INFO - Return code: 0 14:16:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6a750e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7160>, '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 0x10c8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84f0>, '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': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', '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 14:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:16:49 INFO - Using env: {'DISPLAY': ':0', 14:16:49 INFO - 'HOME': '/home/cltbld', 14:16:49 INFO - 'LANG': 'en_US.UTF-8', 14:16:49 INFO - 'LANGUAGE': 'en_US:en', 14:16:49 INFO - 'LOGNAME': 'cltbld', 14:16:49 INFO - 'MAIL': '/var/mail/cltbld', 14:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:49 INFO - 'MOZ_NO_REMOTE': '1', 14:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:49 INFO - 'NO_EM_RESTART': '1', 14:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:49 INFO - 'PWD': '/builds/slave/test', 14:16:49 INFO - 'SHELL': '/bin/bash', 14:16:49 INFO - 'SHLVL': '1', 14:16:49 INFO - 'TERM': 'linux', 14:16:49 INFO - 'TMOUT': '86400', 14:16:49 INFO - 'USER': 'cltbld', 14:16:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', 14:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:49 INFO - '_': '/tools/buildbot/bin/python'} 14:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:49 INFO - Downloading/unpacking blobuploader==1.2.4 14:16: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 14:16: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 14:16: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 14:16: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 14:16: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 14:16: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 14:16:51 INFO - Downloading blobuploader-1.2.4.tar.gz 14:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:16:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:16:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:51 INFO - Downloading docopt-0.6.1.tar.gz 14:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:16:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:16:52 INFO - Running setup.py install for blobuploader 14:16:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:16:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:16:52 INFO - Running setup.py install for requests 14:16:52 INFO - Running setup.py install for docopt 14:16:52 INFO - Successfully installed blobuploader requests docopt 14:16:52 INFO - Cleaning up... 14:16:52 INFO - Return code: 0 14:16:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:52 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 0x7f6a750e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7160>, '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 0x10c8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84f0>, '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': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', '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 14:16:52 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 14:16:52 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 14:16:52 INFO - Using env: {'DISPLAY': ':0', 14:16:52 INFO - 'HOME': '/home/cltbld', 14:16:52 INFO - 'LANG': 'en_US.UTF-8', 14:16:52 INFO - 'LANGUAGE': 'en_US:en', 14:16:52 INFO - 'LOGNAME': 'cltbld', 14:16:52 INFO - 'MAIL': '/var/mail/cltbld', 14:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:52 INFO - 'MOZ_NO_REMOTE': '1', 14:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:52 INFO - 'NO_EM_RESTART': '1', 14:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:52 INFO - 'PWD': '/builds/slave/test', 14:16:52 INFO - 'SHELL': '/bin/bash', 14:16:52 INFO - 'SHLVL': '1', 14:16:52 INFO - 'TERM': 'linux', 14:16:52 INFO - 'TMOUT': '86400', 14:16:52 INFO - 'USER': 'cltbld', 14:16:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', 14:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:52 INFO - '_': '/tools/buildbot/bin/python'} 14:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:16:52 INFO - Running setup.py (path:/tmp/pip-zdVzU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:16:52 INFO - Running setup.py (path:/tmp/pip-QpeW5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:16:52 INFO - Running setup.py (path:/tmp/pip-jh2gwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:16:53 INFO - Running setup.py (path:/tmp/pip-uFo2kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:16:53 INFO - Running setup.py (path:/tmp/pip-7MDiLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:16:53 INFO - Running setup.py (path:/tmp/pip-Bg5JfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:16:53 INFO - Running setup.py (path:/tmp/pip-EaSE5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:16:53 INFO - Running setup.py (path:/tmp/pip-Zfgtoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:16:53 INFO - Running setup.py (path:/tmp/pip-08R77M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:16:53 INFO - Running setup.py (path:/tmp/pip-tSyM_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:16:53 INFO - Running setup.py (path:/tmp/pip-BWxJdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:16:53 INFO - Running setup.py (path:/tmp/pip-gltFm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:16:53 INFO - Running setup.py (path:/tmp/pip-beMwel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:16:53 INFO - Running setup.py (path:/tmp/pip-l4hEeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:53 INFO - Running setup.py (path:/tmp/pip-0zG856-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:16:53 INFO - Running setup.py (path:/tmp/pip-xvJBuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:16:53 INFO - Running setup.py (path:/tmp/pip-pnHrv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:16:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:16:54 INFO - Running setup.py install for manifestparser 14:16:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:16:54 INFO - Running setup.py install for mozcrash 14:16:54 INFO - Running setup.py install for mozdebug 14:16:54 INFO - Running setup.py install for mozdevice 14:16:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:16:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:16:54 INFO - Running setup.py install for mozfile 14:16:54 INFO - Running setup.py install for mozhttpd 14:16:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:16:54 INFO - Running setup.py install for mozinfo 14:16:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:16:54 INFO - Running setup.py install for mozInstall 14:16:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:16:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:16:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:16:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:16:54 INFO - Running setup.py install for mozleak 14:16:54 INFO - Running setup.py install for mozlog 14:16:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:16:55 INFO - Running setup.py install for moznetwork 14:16:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:16:55 INFO - Running setup.py install for mozprocess 14:16:55 INFO - Running setup.py install for mozprofile 14:16:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:16:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:16:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:16:55 INFO - Running setup.py install for mozrunner 14:16:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:16:55 INFO - Running setup.py install for mozscreenshot 14:16:55 INFO - Running setup.py install for moztest 14:16:55 INFO - Running setup.py install for mozversion 14:16:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:16:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:16:55 INFO - Cleaning up... 14:16:55 INFO - Return code: 0 14:16:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:55 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 0x7f6a750e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7160>, '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 0x10c8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84f0>, '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': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', '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 14:16:55 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 14:16:55 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 14:16:55 INFO - Using env: {'DISPLAY': ':0', 14:16:55 INFO - 'HOME': '/home/cltbld', 14:16:55 INFO - 'LANG': 'en_US.UTF-8', 14:16:55 INFO - 'LANGUAGE': 'en_US:en', 14:16:55 INFO - 'LOGNAME': 'cltbld', 14:16:55 INFO - 'MAIL': '/var/mail/cltbld', 14:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:55 INFO - 'MOZ_NO_REMOTE': '1', 14:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:55 INFO - 'NO_EM_RESTART': '1', 14:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:55 INFO - 'PWD': '/builds/slave/test', 14:16:55 INFO - 'SHELL': '/bin/bash', 14:16:55 INFO - 'SHLVL': '1', 14:16:55 INFO - 'TERM': 'linux', 14:16:55 INFO - 'TMOUT': '86400', 14:16:55 INFO - 'USER': 'cltbld', 14:16:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', 14:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:55 INFO - '_': '/tools/buildbot/bin/python'} 14:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:16:56 INFO - Running setup.py (path:/tmp/pip-3ZSSJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:16:56 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)) 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:16:56 INFO - Running setup.py (path:/tmp/pip-p3cMRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:16:56 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)) 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:16:56 INFO - Running setup.py (path:/tmp/pip-PMHz39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:16:56 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)) 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:16:56 INFO - Running setup.py (path:/tmp/pip-C5yMNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:16:56 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)) 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:16:56 INFO - Running setup.py (path:/tmp/pip-PD9l2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:16:56 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)) 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:16:56 INFO - Running setup.py (path:/tmp/pip-M8feUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:16:56 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)) 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:16:56 INFO - Running setup.py (path:/tmp/pip-Tn1spN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:16:56 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)) 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:16:56 INFO - Running setup.py (path:/tmp/pip-5RHI4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:16:56 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)) 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:16:56 INFO - Running setup.py (path:/tmp/pip-6w9j6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:16:56 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)) 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:16:56 INFO - Running setup.py (path:/tmp/pip-nhBsc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:16:56 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)) 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:16:56 INFO - Running setup.py (path:/tmp/pip-QK0H3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:16:56 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)) 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:16:56 INFO - Running setup.py (path:/tmp/pip-aTF1OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:16:56 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)) 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:16:56 INFO - Running setup.py (path:/tmp/pip-dJhEra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:16:56 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)) 14:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:16:56 INFO - Running setup.py (path:/tmp/pip-I9sziR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:16:57 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)) 14:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:57 INFO - Running setup.py (path:/tmp/pip-dNxkQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:57 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)) 14:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:16:57 INFO - Running setup.py (path:/tmp/pip-lgW1VS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:16:57 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)) 14:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:16:57 INFO - Running setup.py (path:/tmp/pip-Rpcr1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:16:57 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)) 14:16:57 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)) 14:16:57 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)) 14:16:57 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)) 14:16:57 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)) 14:16:57 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)) 14:16:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:59 INFO - Downloading blessings-1.6.tar.gz 14:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:16:59 INFO - Installing collected packages: blessings 14:16:59 INFO - Running setup.py install for blessings 14:16:59 INFO - Successfully installed blessings 14:16:59 INFO - Cleaning up... 14:16:59 INFO - Return code: 0 14:16:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:16:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:16:59 INFO - Reading from file tmpfile_stdout 14:16:59 INFO - Current package versions: 14:16:59 INFO - argparse == 1.2.1 14:16:59 INFO - blessings == 1.6 14:16:59 INFO - blobuploader == 1.2.4 14:16:59 INFO - docopt == 0.6.1 14:16:59 INFO - manifestparser == 1.1 14:16:59 INFO - mozInstall == 1.12 14:16:59 INFO - mozcrash == 0.17 14:16:59 INFO - mozdebug == 0.1 14:16:59 INFO - mozdevice == 0.48 14:16:59 INFO - mozfile == 1.2 14:16:59 INFO - mozhttpd == 0.7 14:16:59 INFO - mozinfo == 0.9 14:16:59 INFO - mozleak == 0.1 14:16:59 INFO - mozlog == 3.1 14:16:59 INFO - moznetwork == 0.27 14:16:59 INFO - mozprocess == 0.22 14:16:59 INFO - mozprofile == 0.28 14:16:59 INFO - mozrunner == 6.11 14:16:59 INFO - mozscreenshot == 0.1 14:16:59 INFO - mozsystemmonitor == 0.0 14:16:59 INFO - moztest == 0.7 14:16:59 INFO - mozversion == 1.4 14:16:59 INFO - psutil == 3.1.1 14:16:59 INFO - requests == 1.2.3 14:16:59 INFO - wsgiref == 0.1.2 14:16:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:59 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 0x7f6a750e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7160>, '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 0x10c8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84f0>, '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': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', '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 14:16:59 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 14:16:59 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 14:16:59 INFO - Using env: {'DISPLAY': ':0', 14:16:59 INFO - 'HOME': '/home/cltbld', 14:16:59 INFO - 'LANG': 'en_US.UTF-8', 14:16:59 INFO - 'LANGUAGE': 'en_US:en', 14:16:59 INFO - 'LOGNAME': 'cltbld', 14:16:59 INFO - 'MAIL': '/var/mail/cltbld', 14:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:59 INFO - 'MOZ_NO_REMOTE': '1', 14:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:59 INFO - 'NO_EM_RESTART': '1', 14:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:59 INFO - 'PWD': '/builds/slave/test', 14:16:59 INFO - 'SHELL': '/bin/bash', 14:16:59 INFO - 'SHLVL': '1', 14:16:59 INFO - 'TERM': 'linux', 14:16:59 INFO - 'TMOUT': '86400', 14:16:59 INFO - 'USER': 'cltbld', 14:16:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', 14:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:59 INFO - '_': '/tools/buildbot/bin/python'} 14:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:59 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)) 14:16:59 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)) 14:16:59 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)) 14:16:59 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)) 14:16:59 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)) 14:16:59 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)) 14:16:59 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)) 14:16:59 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)) 14:16:59 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)) 14:16:59 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)) 14:16:59 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)) 14:16:59 INFO - Cleaning up... 14:16:59 INFO - Return code: 0 14:16:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:59 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 0x7f6a750e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7160>, '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 0x10c8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84f0>, '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': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', '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 14:16:59 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 14:16:59 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 14:16:59 INFO - Using env: {'DISPLAY': ':0', 14:16:59 INFO - 'HOME': '/home/cltbld', 14:16:59 INFO - 'LANG': 'en_US.UTF-8', 14:16:59 INFO - 'LANGUAGE': 'en_US:en', 14:16:59 INFO - 'LOGNAME': 'cltbld', 14:16:59 INFO - 'MAIL': '/var/mail/cltbld', 14:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:59 INFO - 'MOZ_NO_REMOTE': '1', 14:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:59 INFO - 'NO_EM_RESTART': '1', 14:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:59 INFO - 'PWD': '/builds/slave/test', 14:16:59 INFO - 'SHELL': '/bin/bash', 14:16:59 INFO - 'SHLVL': '1', 14:16:59 INFO - 'TERM': 'linux', 14:16:59 INFO - 'TMOUT': '86400', 14:16:59 INFO - 'USER': 'cltbld', 14:16:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', 14:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:59 INFO - '_': '/tools/buildbot/bin/python'} 14:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:59 INFO - Downloading/unpacking jsonschema 14:16: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 14:16: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 14:16: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 14:16: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 14:16: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 14:16: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 14:17:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:17:01 INFO - Downloading/unpacking functools32 (from jsonschema) 14:17:01 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 14:17:01 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 14:17:01 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 14:17:01 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 14:17:01 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 14:17:01 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 14:17:02 INFO - Downloading functools32-3.2.3-2.tar.gz 14:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:17:02 INFO - warning: no files found matching '*.txt' 14:17:02 INFO - no previously-included directories found matching 'build' 14:17:02 INFO - no previously-included directories found matching 'dist' 14:17:02 INFO - no previously-included directories found matching '.git*' 14:17:02 INFO - Installing collected packages: jsonschema, functools32 14:17:02 INFO - Running setup.py install for functools32 14:17:02 INFO - warning: no files found matching '*.txt' 14:17:02 INFO - no previously-included directories found matching 'build' 14:17:02 INFO - no previously-included directories found matching 'dist' 14:17:02 INFO - no previously-included directories found matching '.git*' 14:17:02 INFO - Successfully installed jsonschema functools32 14:17:02 INFO - Cleaning up... 14:17:02 INFO - Return code: 0 14:17:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:02 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 0x7f6a750e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7160>, '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 0x10c8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84f0>, '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': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', '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 14:17:02 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 14:17:02 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 14:17:02 INFO - Using env: {'DISPLAY': ':0', 14:17:02 INFO - 'HOME': '/home/cltbld', 14:17:02 INFO - 'LANG': 'en_US.UTF-8', 14:17:02 INFO - 'LANGUAGE': 'en_US:en', 14:17:02 INFO - 'LOGNAME': 'cltbld', 14:17:02 INFO - 'MAIL': '/var/mail/cltbld', 14:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:02 INFO - 'MOZ_NO_REMOTE': '1', 14:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:02 INFO - 'NO_EM_RESTART': '1', 14:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:02 INFO - 'PWD': '/builds/slave/test', 14:17:02 INFO - 'SHELL': '/bin/bash', 14:17:02 INFO - 'SHLVL': '1', 14:17:02 INFO - 'TERM': 'linux', 14:17:02 INFO - 'TMOUT': '86400', 14:17:02 INFO - 'USER': 'cltbld', 14:17:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', 14:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:02 INFO - '_': '/tools/buildbot/bin/python'} 14:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:02 INFO - Downloading/unpacking flake8 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:17:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:17:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:17:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:05 INFO - no previously-included directories found matching 'docs/_build' 14:17:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:17:05 INFO - Running setup.py install for pep8 14:17:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:05 INFO - no previously-included directories found matching 'docs/_build' 14:17:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:17:05 INFO - Cleaning up... 14:17:05 INFO - Return code: 0 14:17:05 INFO - Running post-action listener: _resource_record_post_action 14:17:05 INFO - Running post-action listener: _start_resource_monitoring 14:17:05 INFO - Starting resource monitoring. 14:17:05 INFO - ##### 14:17:05 INFO - ##### Running install step. 14:17:05 INFO - ##### 14:17:05 INFO - Running pre-action listener: _resource_record_pre_action 14:17:05 INFO - Running main action method: install 14:17:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:17:05 INFO - Reading from file tmpfile_stdout 14:17:05 INFO - Detecting whether we're running mozinstall >=1.0... 14:17:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:17:05 INFO - Reading from file tmpfile_stdout 14:17:05 INFO - Output received: 14:17:05 INFO - Usage: mozinstall [options] installer 14:17:05 INFO - Options: 14:17:05 INFO - -h, --help show this help message and exit 14:17:05 INFO - -d DEST, --destination=DEST 14:17:05 INFO - Directory to install application into. [default: 14:17:05 INFO - "/builds/slave/test"] 14:17:05 INFO - --app=APP Application being installed. [default: firefox] 14:17:05 INFO - mkdir: /builds/slave/test/build/application 14:17:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:17:18 INFO - Reading from file tmpfile_stdout 14:17:18 INFO - Output received: 14:17:18 INFO - /builds/slave/test/build/application/firefox/firefox 14:17:18 INFO - Running post-action listener: _resource_record_post_action 14:17:18 INFO - ##### 14:17:18 INFO - ##### Running run-tests step. 14:17:18 INFO - ##### 14:17:18 INFO - Running pre-action listener: _resource_record_pre_action 14:17:18 INFO - Running main action method: run_tests 14:17:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:17:18 INFO - Python 2.7.3 14:17:18 INFO - Return code: 0 14:17:18 INFO - grabbing minidump binary from tooltool 14:17:18 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')]} 14:17:18 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 0x10c7160>, '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 0x10c8060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:17:18 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 14:17:18 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 14:17:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:17:18 INFO - Return code: 0 14:17:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:17:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:17:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:17:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:17:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:17:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:17:19 INFO - Return code: 0 14:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 14:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 14:17:19 INFO - Using env: {'DISPLAY': ':0', 14:17:19 INFO - 'HOME': '/home/cltbld', 14:17:19 INFO - 'LANG': 'en_US.UTF-8', 14:17:19 INFO - 'LANGUAGE': 'en_US:en', 14:17:19 INFO - 'LOGNAME': 'cltbld', 14:17:19 INFO - 'MAIL': '/var/mail/cltbld', 14:17:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:17:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:19 INFO - 'MOZ_NO_REMOTE': '1', 14:17:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:19 INFO - 'NO_EM_RESTART': '1', 14:17:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:19 INFO - 'PWD': '/builds/slave/test', 14:17:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:17:19 INFO - 'SHELL': '/bin/bash', 14:17:19 INFO - 'SHLVL': '1', 14:17:19 INFO - 'TERM': 'linux', 14:17:19 INFO - 'TMOUT': '86400', 14:17:19 INFO - 'USER': 'cltbld', 14:17:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664', 14:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:19 INFO - '_': '/tools/buildbot/bin/python'} 14:17:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 14:17:19 INFO - mozversion application_buildid: 20160425095909 14:17:19 INFO - mozversion application_changeset: dcaf0a6fa115ad73bf7505a8e76464250b971a04 14:17:19 INFO - mozversion application_display_name: Firefox 14:17:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:17:19 INFO - mozversion application_name: Firefox 14:17:19 INFO - mozversion application_remotingname: firefox 14:17:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:17:19 INFO - mozversion application_vendor: Mozilla 14:17:19 INFO - mozversion application_version: 47.0 14:17:19 INFO - mozversion platform_buildid: 20160425095909 14:17:19 INFO - mozversion platform_changeset: dcaf0a6fa115ad73bf7505a8e76464250b971a04 14:17:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:17:19 INFO - mozversion platform_version: 47.0 14:17:19 INFO - using testdate: 1461619039 14:17:19 INFO - actual date: 1461619039 14:17:19 INFO - starting webserver on 'localhost:45552' 14:17:19 INFO - SUITE-START | Running 2 tests 14:17:19 INFO - TEST-START | dromaeo_css 14:17:19 INFO - operating with platform_type : linux_ 14:17:19 INFO - Initialising browser for dromaeo_css test... 14:17:19 INFO - TEST-INFO | started process 10287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmzz_Ri/profile http://localhost:45552/getInfo.html) 14:17:23 INFO - PROCESS | 10287 | __metrics Screen width/height:1600/1200 14:17:23 INFO - PROCESS | 10287 | colorDepth:24 14:17:23 INFO - PROCESS | 10287 | Browser inner width/height: 1024/697 14:17:23 INFO - PROCESS | 10287 | __metrics 14:17:24 INFO - PROCESS | 10287 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:17:25 INFO - TEST-INFO | 10287: exit 0 14:17:25 INFO - Browser initialized. 14:17:25 INFO - Running cycle 1/1 for dromaeo_css test... 14:17:25 INFO - TEST-INFO | started process 10379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmzz_Ri/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:17:37 INFO - PROCESS | 10379 | RSS: Main: 138956800 14:17:37 INFO - PROCESS | 10379 | 14:18:28 INFO - PROCESS | 10379 | 1461619108428 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] 14:20:35 INFO - PROCESS | 10379 | Cycle 1(1): loaded http://localhost:45552/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45552/tests/dromaeo/cssquery-ext.html) 14:20:36 INFO - PROCESS | 10379 | RSS: Main: 214134784 14:20:36 INFO - PROCESS | 10379 | 14:23:38 INFO - PROCESS | 10379 | Cycle 1(1): loaded http://localhost:45552/tests/dromaeo/cssquery-ext.html (next: http://localhost:45552/tests/dromaeo/cssquery-jquery.html) 14:23:39 INFO - PROCESS | 10379 | RSS: Main: 221884416 14:23:39 INFO - PROCESS | 10379 | 14:26:40 INFO - PROCESS | 10379 | Cycle 1(1): loaded http://localhost:45552/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45552/tests/dromaeo/cssquery-mootools.html) 14:26:41 INFO - PROCESS | 10379 | RSS: Main: 217174016 14:26:41 INFO - PROCESS | 10379 | 14:29:43 INFO - PROCESS | 10379 | Cycle 1(1): loaded http://localhost:45552/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45552/tests/dromaeo/cssquery-prototype.html) 14:29:43 INFO - PROCESS | 10379 | RSS: Main: 205148160 14:29:43 INFO - PROCESS | 10379 | 14:32:46 INFO - PROCESS | 10379 | Cycle 1(1): loaded http://localhost:45552/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45552/tests/dromaeo/cssquery-yui.html) 14:32:46 INFO - PROCESS | 10379 | RSS: Main: 208031744 14:32:46 INFO - PROCESS | 10379 | 14:35:49 INFO - PROCESS | 10379 | Cycle 1(1): loaded http://localhost:45552/tests/dromaeo/cssquery-yui.html (next: http://localhost:45552/tests/dromaeo/cssquery-dojo.html) 14:35:49 INFO - PROCESS | 10379 | RSS: Main: 253906944 14:35:49 INFO - PROCESS | 10379 | 14:35:49 INFO - PROCESS | 10379 | __start_tp_report 14:35:49 INFO - PROCESS | 10379 | _x_x_mozilla_page_load 14:35:49 INFO - PROCESS | 10379 | _x_x_mozilla_page_load_details 14:35:49 INFO - PROCESS | 10379 | |i|pagename|runs| 14:35:49 INFO - PROCESS | 10379 | |0;dojo.html;3232.0627018164732;3271.55833962415;3277.1807048237943;3292.4732042873147;3324.700776930076;5203.739813009349;5210.218467229913;5222.399424066233;5225.268462415265;5260.395054568726;5200.297959775429;5225.581953443725;5231.712255825928;5239.240310155025;5267.710275934822;4721.740304283263;4764.118638051954;4787.377640906678;4823.372961514998;4868.0750657375165;4800.4719480857075;4803.903921921559;4835.564799168074;4840.9757951210195;4842.370491836056;4855.5872750816225;4892.633052521057;4894.461609223001;4906.165951788187;4959.776810043557;4779.617630589544;4880.560749532541;4887.780049897728;4888.340074089988;4897.975510122462;4693.9530604693855;4725.716457012591;4790.856274311776;4819.397575303087;4836.153673107192;5057.49425057495;5092.465291144414;5092.898142037138;5094.337736094321;5123.2315152727015;5666.206731057655;5672.06410942194;5678.261825962599;5678.659280443187;5701.0308247597595;5557.6109672322955;5560.443955604448;5660.3490598581275;5676.602637815355;5681.971590142023;5282.471752824726;5288.788448462057;5298.258243845865;5301.204819277101;5327;5765.798197063083;5769.94230057694;5770.769169233184;5782.045962416154;5786.884262314814;5437.211604317352;5478.671279723229;5525.944740552623;5529.695866727288;5561.443855614487;5645.520130788929;5649.802256920988;5650.943490565041;5651.350094739076;5657.32112146545;5570.888582228414;5581.804636837691;5588.329400471888;5589.245451864028;5594.1608758686525;5506.366767821672;5580;5601.775928962796;5603.271574695345;5644.9435505644415;4362.76004819738;4381.233284175257;4383.101464199832;4384.846530371422;4412.911741765147;3937.074787424953;3954.5254569451276;3973.344398174269;3986.980065099656;3991.560928297885;5287.391949925808;5308.389535203424;5416.10634245353;5460.590455715837;5495.120780675073;5669;5680.289963754531;5699.031164702011;5701.657900525982;5717.113847353667;5259.21111833228;5421.4578542146255;5423.484768946943;5438.972805136028;5441.673499590037;4826.8793280168275;4874.415070191529;4883.609311255091;4889.706617602884;4906.067847109038;5805.274340707411;5886.3230728465915;5889.852753681106;5890.646561206341;5898.115282707542;5582.190582365615;5680.801171958961;5705.4009329019855;5715.371309156073;5737.827865164052;5789.189513468202;5812.273465816773;5838.153467747068;5841.094630332305;5842.065269557021;5556.333240011225;5566.638168519034;5567.47109024642;5577.860553486195;5581.190727344431;5559.805406810742;5653.886922261614;5654.236678048575;5683.460071293386;5762.567807414544;5487.5609951203005;5492.450754924475;5496.890062198813;5497.725113744217;5517.200005999188;5470.398256191896;5472.425395333592;5473.261109750133;5481.588880833874;5505.091659876076;5337.146056630921;5371.597130215171;5401.351837779492;5407.594430417813;5418.972905135449;5419.4309597493275;5527.613067085265;5534.7786088556;5604.8879022418505;5653.406392328746;5393.919091213714;5399.082156033563;5457.781688732406;5463;5483.5064844162625 14:35:49 INFO - PROCESS | 10379 | |1;ext.html;523.9607029472788;528.5137673340527;536.4313827343017;546.7375659683352;558.625720767086;31996.52005219921;32865.835670821674;40510.18979620406;40842.183156336854;40866.591334086654;44880.326795098015;45375.77312113435;45454.31818522717;45455.318170227474;45507.54492455075;8925.73222803317;9121.17909388155;9131.908680913206;9132.543372831366;9141.360104792668;8835.911640883573;8935.329850261223;8954.149355811187;8961.148690874357;8962.775930601721;9217.032211617785;9292.628294868196;9319.720408387759;9323.30075244356;9325.114114159143;9155.725328240163;9245.399049061856;9251.121143491358;9252.352335336529;9255.398399104037;9101.36290459668;9261.907380926172;9267.119623635745;9272.860907086399;9281.39670921388;40377;40869;40873.18253634911;40908.795456022526;40921.1815763686;3575.78545287281;3644.2529281497227;3671.4859919611276;3704.370257056307;3742.120601658608;30882.382352353052;32229;32268.193295167574;32268.354632907445;32287.35425291481;4068.613481719232;4100.118474527961;4118.814653340577;4134.586541345841;4203.936940945889;222343;225943;226404.99999999834;226757.99999999834;227293;71983;72129;72766.27233727701;72840;72876.63561682263;76843;77842.6107869457;78127;78412;78845.60577197078;17915.820841791676;18192;18200.63598728018;18216.81783182151;18219.45341639753;14533.491327803476;14704.926475367554;14815;14821.703565928621;14825.481108161162;23975.76024239735;24405;24550.50898982046;24634.13780517709;24638.384040398774;8498.74503764888;8998.910010899937;9308.440178950706;9309.812194134372;9316.673916412892;1016.1159790981893;1043.7286305560608;1062.2245760594808;1097.7365432296192;1127.7913585986619;30046.84976575103;30450.54324185139;30833.537496937563;31023.68976310253;31040.91356802501;1105.7456784939347;1139.5270962550615;1159.515165942581;1186.6677330347343;1207.836942012817;16380.26288817006;16394.918025409796;16403.42588009414;16403.83596164047;16707.33170673184;337713;338258;341188;341331;341373;56424.43575564274;57050.714746426835;57148.14277785837;57155.14267285994;57161.42838571561;1368.9520866769615;1427.7358688642635;1488.6576087499718;1490.3219035338896;1503.1432083712398;27342.316442089108;27693.723062769113;29428.411431770815;30301.242468938453;30328;46020.30969535527;46269;46746;46816;46829.76585117052;189150.05424972787;189691;189776;189799;189818;30500.237494062825;35285.47071793874;35416.46875296821;35421.291574168885;35973;41566.376504353066;42852.78573607112;43274.35088473612;43343.13313733771;43567;38025.80987095047;38453.61546384612;38517.422238667;38527;39418.605813941496;36416.45375319319;37852.62147378491;38211.04472388213;38343.616563834;38458.80770596129;37608.811955940044;38384.23231535409;38433.807830960664;39063;39361.60638393694;33443.498347525296;34318.656813431546;34706.305873882884;34788.130296742784;34813.82593087018;26247;26644.866775665996;26716;26755.732442676104;26899.86550067237 14:35:49 INFO - PROCESS | 10379 | |2;jquery.html;374.7582809088137;378.12652772096453;380.9123901502656;384.81144239322725;391.59078762692985;17743.37898173564;18803.435896923096;19361.806381936178;19525;19535.902320488396;13949.651258718537;16590.336386544524;17162.485125446256;17188.914055429737;17332.566685832862;5204.531592156705;5316.043112239795;5357.464253574631;5360.839174824761;5366.490183432567;4055.858044968427;6694.230163531183;7143.107111611049;7147;7175.425965922714;6785.2196997345445;7068.081149450564;7136.072310599615;7149.3923016543395;7168.892466612979;6960.79117626467;6973.407260382823;6997.720091196372;7005.614691191982;7013.158420989488;6625.602463852184;6703.162104736908;6715.496337774686;6739.292374300726;6739.730410783563;23825.76174238253;24561.877190613934;24973.875130624412;25013.12454064099;25030.249092527254;2361.6575596538405;2378.6550950112137;2399.5560821248123;2422.624493203556;3252.902412927616;14400.423983040666;14452.205128717917;14554.272286385638;14671.413143474248;15214.239288035555;2063.783302753204;2109.4831766217376;2166.068590506082;2183.5087105401317;2187.9671804922937;72860.6356968217;73117.99999999946;74944;75165.62417187933;75367;15694.921525392529;15942.442014529668;16180;16182.352705891632;16216.351345946267;27564.448711025667;27665.861670691516;27915.58126628102;27994.16017519478;27998.160055198376;9629;9995.200383969264;10069.244806639532;10078.042585954323;10156.796864062826;8613.095624959415;8724.825503489894;8731.476111433334;8816.823663526693;8878.334124940655;7079.1505019398;7973.162817904153;7991.3606911448105;8005.439619226599;8082.555459449787;2663.746944040313;3141.7800753947463;3155.290059736541;3178.268998130443;3231.41834469793;989.9703008909744;1005.2561104782409;1067.6547550086946;1071.8660167479065;1112.7663190729875;16806.747898781527;16944.15279236033;17115.74326385105;17285.135743212788;17331.740023899652;985.7634167799677;1006.9295149339622;1037.227265687053;1043.3270540501335;1058.2539309786582;9550.092741189575;9593.232541396672;9865;10309.94845025785;10357.689269321932;437988;438043;445588;469347;473459;81866.59066704629;82845.58577207076;83400;84972.57513712515;85622.57188714141;1036.3781730961364;1073.2755390111643;1076.7792602516465;1083.7344850511674;1094.68801391603;16415.42546010884;16480.011199328077;16522.917385412995;16615.50153495397;16984;35046;35121;36333.63666363303;36836.07909802276;37076.44385334276;47563.52436475591;49763.50236497589;50718;51055.48944510656;51600.22599660933;8513.276371508244;8515.233628973423;8536.957315213633;8850.026497085444;8870.822583548164;12580.937095314464;12793.168444051107;12840.101192916407;13170;13183.274919879499;10585.788284234119;11231.831522527333;11559.942200288944;11766.470508826953;11859.16985810985;11399.259048161843;11507.079433645456;11513.30920144794;11784.410779461165;11833.112516561465;11416.315021098428;11485.712857178303;11618.6514404568;11716.355600442057;11957.701057473632;8429.704960326359;8677.652893884175;8742.34432417584;8909.287257019552;9107.544622768703;11099.954541140281;11380.54477820878;11481.311121332747;11513.88486115128;11798.823017654913 14:35:49 INFO - PROCESS | 10379 | |3;mootools.html;1390.2492653966858;1499.0481044536718;1501.196859680071;1689.2229574395778;1844;7055.964720176398;7568.243175682429;7732.420068494871;7763.883541746871;7771.92228077719;7686.807829804257;7829.138794732575;7841.568713720743;7842.254985776356;7848.411369147322;2335.9649605255936;2341.5785158671433;2365.5387199496017;2367.4081479630095;2368.076450184421;2307.1232931486097;2331.393837602227;2343.8593684378907;2346.718393792739;2357.233898982837;2328.4178955261186;2331.6968794056834;2346.4485845826216;2388.7850093491584;2396.892139853711;2326.906923723049;2348.1429278313462;2362.681038059866;2363.420961864346;2377.1442280778906;2321.1179751694417;2362.078789272185;2364.432536191319;2366.3610825077303;2369.9763002369928;7976.521408715437;7995.320397766197;8001.599920004035;8006.239407256301;8020.438569300151;4973.403191616993;5083.822066227664;5088.389393272831;5093.490650934877;5099.4900509949075;3153.274746808247;3169.2235402326346;3206.9198270043435;3224.7903886247555;3232.078857525594;1099.7855418193456;1885.7831349394858;1952.3069310394746;1988.434918954547;1998.7701414337391;10652.573897044109;10748.892511074868;10823.080038196762;10824.621138260123;10826.18803589734;4159.355299928456;4282.35764635301;4305.677074219383;4367.58507941745;4384.364267181305;8707.346948978851;8783.560821958876;8802.295816334678;8824.117588241124;8824.911750882537;4910.116179087799;4931.260310953314;4943.876403089952;4944.035912997003;4944.134776414113;4036.3945408189006;4445.555444455593;4545.272756358967;4562.954370456253;4579.519150489217;3419.6067452242814;3464.255185135208;3486.1981744198974;3516.6307537708685;3528.3825330567047;1060.183658582887;1067.508945884886;1075.9677209683723;1076.5478499030426;1086.6631344283298;1232.2236990695803;1234.2224398628807;1293.9611811645666;1343.2276441046438;1363.5704753002772;7556.206598307209;7659.502132361378;7753.457257991887;7763.961180194063;7767.53394796314;510.36204744069914;510.36969342861534;513.4480433533965;518.5695872425878;519.4934938434996;5982.73077711504;6000;6014.338422773491;6028.2766068072115;6062.120992456069;9166.49584272858;9210;9362.765930851647;9383.718488445358;9403.670871519464;9159.542022898828;9311.580978855967;9318.440893546409;9323.347365684473;9327.113924177193;7314.158871729819;7480.812979675552;7566;7580.431467639949;7597.886031709529;7442.888356674763;7596.924030759843;7597.962010189914;7634.923650763421;7802.29779319864;8635.179657932485;8661.740147795575;8710.12898710124;8827.16141966512;8828;8569.614367353359;8781.077986811293;8917.643294268417;8964.955175224082;8998.100189980949;6753.493487988519;7208.423326133792;7413.443991700537;7633.465657403928;7739.264769846855;7532.17146113938;7537.9623101884135;7552.66013029426;7574.469787114849;7588.165301816685;6731.461483081243;6898.413634841095;6995.545289556163;7018.33325834045;7067.858642827012;6778.8983165251575;6786.558873673195;6854.794356169323;6893.896591551231;6914.377706006484;6933.445324374139;6935.861282774417;6944;7100.502964792621;7133.643317834191;6631.237407697983;6634.104395906684;6656.800295991128;6665.466762658879;6688.966555167193;6515.446187074152;6649.534532582673;6692.130023096966;6704.4301234395625;6710.932890671031 14:35:49 INFO - PROCESS | 10379 | |4;prototype.html;352.130238311371;352.92941411717663;364.5279363224625;366.77626647744887;368.50252159584556;5890.558208134391;5912.88174236515;5939.376365481627;5987.40125987401;5993.041113421853;5695.0887857942735;5842.853928651786;5846.649201047941;5852.502537284326;5856.004479238529;4623.606993405556;4667.299905014258;4672.415948006499;4706.694064885789;4714.057188562301;4700.529947005306;4718.150732868083;4723.291506274052;4729.9763501182615;4745;4483.887902802439;4584.610308123813;4696.131215725101;4708.176069187895;4711.505291944348;4681.83613573525;4682.672212945061;4688.742119183444;4692.460367057798;4706.858794236178;4180.038591124058;4183.895402614929;4188.308929026707;4189.706720529564;4196.538380778112;5643.238162848004;5645.915311270334;5653.717314134276;5653.8586535336535;5659.151127330892;5434.565234781208;5434.728263586805;5441.83674489766;5444.047291723932;5446.809361672323;6132.386761323832;6240.875182496325;6273.686315684243;6274.592151510137;6277.686115694242;4610.723356598614;4611.30830375443;4615.676902616819;4616.884577885546;4620.537946205386;6495.967520162416;6522.249941256721;6539.771108011197;6544.934550654528;6556.8032959010825;4730.219513780187;4733.739644319596;4736.573708366263;4737.763111844394;4739.3601863748645;4813;4815.253635686474;4818.277258411196;4818.445878723922;4821.807127714852;5380;5409.864753381197;5410.458954104637;5415.48552887475;5418.945810541844;6147.323794382614;6222.471089957314;6265.4361107500545;6292.653904035322;6302.464290535356;1666.5000499849996;1687.64559442516;1699.7195462748507;1700.3623641134575;1700.863930885526;1075.0378411321824;1147.4033502578613;1174.7356844709873;1177.2818580665787;1178.9587364442202;6055.788047418319;6098.908516372258;6119.602225855305;6124.11200375943;6124.418180272867;6441.32366101562;6451.29035806061;6456.3543645636;6459.580127291711;6460.515461340418;6090.33006369299;6119.724612392453;6126.693665316717;6136.662483563447;6138.202033735586;3457;3489.45913383426;3489.616142224353;3490.877819276364;3492;6603.933960660332;6692.799216023527;6814.48891333152;6822.464945387248;6828.112345395067;6626.370494802986;6714.932850671528;6735.393814556714;6814.863702725917;6820;6828.214755303204;6869.862602747917;6881.518293719491;6887.139107611549;6900.723971041102;6585.967070164618;6588.275289718032;6590.5716128451495;6594.571352862049;6599.637019963948;6224.253089629093;6385.329540398191;6475.352464753487;6498.122753428227;6502.4472919800455;6770.93229067703;6793.830154245986;6797.0144329073;6812.795616131524;6822.351876571718;4653.046125544188;4687.695299805502;4691.873950251983;4695.460022097503;4700.083483720641;6503.057056726842;6504.837379065561;6505.902411463737;6510.837229069311;6511.120998665309;6203.751849925952;6299.842503937255;6310.422394401399;6317.431431171033;6415.422611964946;6362.491000719839;6386.840328991812;6389.68051597409;6394.360563943568;6411.4229719325485;6256.374362563889;6262.718177681924;6266.68666566679;6274.560780745304;6275.843103922439;6424.839379015562;6433.388828061326;6433.453156481564;6434.613923164625;6439.613623182624;6027.005544085352;6074.544409169418;6210.627362358273;6233.376662333912;6279.905801413074 14:35:49 INFO - PROCESS | 10379 | |5;yui.html;807.4791759315245;809.4172196018865;813.4712436916004;841.6338892581728;930.4417349590246;13526.256055916921;13676.52132175374;13692.315384230798;13695.24676142813;13720.559341269172;13536.729265414686;13560.45758169672;13599.38802753876;13621.727565448686;13633.182009079463;751.9887201691965;896.7802888292345;911.8905731312252;913.9040400757924;916.9266458683322;920.3097676742443;922.8431166701677;927.1933417926414;928.0394791390878;928.8095940332249;964.3876138651937;969.5394687523441;970.553545369131;971.3637567393368;973.3235401396032;788.4008153803122;953.1612181280498;957.6456711016899;961.7499450142943;963.5904740485265;712.9821754456128;713.4827250243584;713.6253466929851;714.6926821466767;716.6810769207705;14197.716045679028;14230.644233894132;14263.572092837232;14278.64303392413;14311.284435778274;14016.789748153786;14527.56417307472;14538.491152809602;14612.707745845024;14625.78061329081;11054.502547385306;11080.05819505343;11190.552377904874;11491.94254028733;11529.596464123799;3908.687305015592;3922.960770392288;3929.8035098244973;3990.5610382857863;4013.7591744495426;51006.234906476435;51320;51352.74323628358;51593.2261016085;51882.74058629683;10852.837207441895;10930.344179349264;10986.945065274622;11092.722681933015;11338.546458141747;19783.505412364808;19983.20067197325;20115.497112572302;20187.192512299636;20474.59050819005;8274;8315.792105197297;8440.40917135807;8562.357823163287;8586.441881277697;4763.857084287477;4830.758462076882;4857.878553036132;4900.436449808318;4912.606991440676;3448.1724386147644;3530.5763308403157;3540.2388486475015;3556.253186830743;3565.3938830398893;592.1591340296789;639.1499305923111;654.3031671270082;664.7739768478643;667.4593579200863;520.1599416941611;580.8199458167982;624.7969409941696;634.9841253968688;645.3707635055783;8251.587420629065;8446;8722.607482663296;8746.56267186638;8806.60370283326;636.7357546618194;667.182701191037;711.4095300900241;717.5300178383168;727.0838743183626;3990.3615421532418;4072.5745988903645;4139.5653456387245;4175.54069052404;4270.679699022586;60373.396266036776;62549;62640;62914.37085629085;63215;47271.29093063607;47712.761436192595;48079.278810817865;48133.27800083002;48365;45707;48244.517554824;48601.27098093531;48975.51024489781;49525.75237123863;9420.858687119562;9468.905310947079;9479.28905332089;9540.95229523848;9594.088561586637;35620.109497262776;36059.81970090133;36232;37542;37557;43515.78242108769;45559.77220113878;47200.29199562078;47895.5210447905;49662;11168.776624467628;11226.943865280622;11878.109141814572;11910.821337680116;12046.941323345818;11819.290842549131;12585.181963172365;12736.808947865604;12744;12807.93596032014;10687.572497100029;11435.714107147387;12355.480229348748;12785;12811.239185914917;11665.416729163677;12111.939440302742;12248.326342051272;12784.87215127874;12957.611271661865;12297;12669.556565520163;12745.17156384832;12918.35408229566;13334.3332833356;10233;10325.638602649171;10420.42687652156;10435.37387756737;10437;10205.540750666089;10678.572857085941;10853.565857365616;10865.293755905841;10894.945525272324 14:35:49 INFO - PROCESS | 10379 | __end_tp_report 14:35:49 INFO - PROCESS | 10379 | __start_cc_report 14:35:49 INFO - PROCESS | 10379 | _x_x_mozilla_cycle_collect,667 14:35:49 INFO - PROCESS | 10379 | __end_cc_report 14:35:49 INFO - PROCESS | 10379 | __startTimestamp1461620149636__endTimestamp 14:35:49 INFO - PROCESS | 10379 | 14:35:49 INFO - PROCESS | 10379 | ------- Summary: start ------- 14:35:49 INFO - PROCESS | 10379 | Number of tests: 6 14:35:49 INFO - PROCESS | 10379 | 14:35:49 INFO - PROCESS | 10379 | [#0] dojo.html Cycles:165 Average:5254.01 Median:5457.78 stddev:555.13 (10.2%) stddev-sans-first:533.69 14:35:49 INFO - PROCESS | 10379 | Values: 3232.1 3271.6 3277.2 3292.5 3324.7 5203.7 5210.2 5222.4 5225.3 5260.4 5200.3 5225.6 5231.7 5239.2 5267.7 4721.7 4764.1 4787.4 4823.4 4868.1 4800.5 4803.9 4835.6 4841.0 4842.4 4855.6 4892.6 4894.5 4906.2 4959.8 4779.6 4880.6 4887.8 4888.3 4898.0 4694.0 4725.7 4790.9 4819.4 4836.2 5057.5 5092.5 5092.9 5094.3 5123.2 5666.2 5672.1 5678.3 5678.7 5701.0 5557.6 5560.4 5660.3 5676.6 5682.0 5282.5 5288.8 5298.3 5301.2 5327.0 5765.8 5769.9 5770.8 5782.0 5786.9 5437.2 5478.7 5525.9 5529.7 5561.4 5645.5 5649.8 5650.9 5651.4 5657.3 5570.9 5581.8 5588.3 5589.2 5594.2 5506.4 5580.0 5601.8 5603.3 5644.9 4362.8 4381.2 4383.1 4384.8 4412.9 3937.1 3954.5 3973.3 3987.0 3991.6 5287.4 5308.4 5416.1 5460.6 5495.1 5669.0 5680.3 5699.0 5701.7 5717.1 5259.2 5421.5 5423.5 5439.0 5441.7 4826.9 4874.4 4883.6 4889.7 4906.1 5805.3 5886.3 5889.9 5890.6 5898.1 5582.2 5680.8 5705.4 5715.4 5737.8 5789.2 5812.3 5838.2 5841.1 5842.1 5556.3 5566.6 5567.5 5577.9 5581.2 5559.8 5653.9 5654.2 5683.5 5762.6 5487.6 5492.5 5496.9 5497.7 5517.2 5470.4 5472.4 5473.3 5481.6 5505.1 5337.1 5371.6 5401.4 5407.6 5419.0 5419.4 5527.6 5534.8 5604.9 5653.4 5393.9 5399.1 5457.8 5463.0 5483.5 14:35:49 INFO - PROCESS | 10379 | 14:35:49 INFO - PROCESS | 10379 | [#1] ext.html Cycles:180 Average:44968.02 Median:38118.43 stddev:68036.98 (178.5%) stddev-sans-first:68146.00 14:35:49 INFO - PROCESS | 10379 | Values: 524.0 528.5 536.4 546.7 558.6 31996.5 32865.8 40510.2 40842.2 40866.6 44880.3 45375.8 45454.3 45455.3 45507.5 8925.7 9121.2 9131.9 9132.5 9141.4 8835.9 8935.3 8954.1 8961.1 8962.8 9217.0 9292.6 9319.7 9323.3 9325.1 9155.7 9245.4 9251.1 9252.4 9255.4 9101.4 9261.9 9267.1 9272.9 9281.4 40377.0 40869.0 40873.2 40908.8 40921.2 3575.8 3644.3 3671.5 3704.4 3742.1 30882.4 32229.0 32268.2 32268.4 32287.4 4068.6 4100.1 4118.8 4134.6 4203.9 222343.0 225943.0 226405.0 226758.0 227293.0 71983.0 72129.0 72766.3 72840.0 72876.6 76843.0 77842.6 78127.0 78412.0 78845.6 17915.8 18192.0 18200.6 18216.8 18219.5 14533.5 14704.9 14815.0 14821.7 14825.5 23975.8 24405.0 24550.5 24634.1 24638.4 8498.7 8998.9 9308.4 9309.8 9316.7 1016.1 1043.7 1062.2 1097.7 1127.8 30046.8 30450.5 30833.5 31023.7 31040.9 1105.7 1139.5 1159.5 1186.7 1207.8 16380.3 16394.9 16403.4 16403.8 16707.3 337713.0 338258.0 341188.0 341331.0 341373.0 56424.4 57050.7 57148.1 57155.1 57161.4 1369.0 1427.7 1488.7 1490.3 1503.1 27342.3 27693.7 29428.4 30301.2 30328.0 46020.3 46269.0 46746.0 46816.0 46829.8 189150.1 189691.0 189776.0 189799.0 189818.0 30500.2 35285.5 35416.5 35421.3 35973.0 41566.4 42852.8 43274.4 43343.1 43567.0 38025.8 38453.6 38517.4 38527.0 39418.6 36416.5 37852.6 38211.0 38343.6 38458.8 37608.8 38384.2 38433.8 39063.0 39361.6 33443.5 34318.7 34706.3 34788.1 34813.8 26247.0 26644.9 26716.0 26755.7 26899.9 14:35:49 INFO - PROCESS | 10379 | 14:35:49 INFO - PROCESS | 10379 | [#2] jquery.html Cycles:180 Average:27951.84 Median:27954.87 stddev:74378.84 (266.1%) stddev-sans-first:74558.67 14:35:49 INFO - PROCESS | 10379 | Values: 374.8 378.1 380.9 384.8 391.6 17743.4 18803.4 19361.8 19525.0 19535.9 13949.7 16590.3 17162.5 17188.9 17332.6 5204.5 5316.0 5357.5 5360.8 5366.5 4055.9 6694.2 7143.1 7147.0 7175.4 6785.2 7068.1 7136.1 7149.4 7168.9 6960.8 6973.4 6997.7 7005.6 7013.2 6625.6 6703.2 6715.5 6739.3 6739.7 23825.8 24561.9 24973.9 25013.1 25030.2 2361.7 2378.7 2399.6 2422.6 3252.9 14400.4 14452.2 14554.3 14671.4 15214.2 2063.8 2109.5 2166.1 2183.5 2188.0 72860.6 73118.0 74944.0 75165.6 75367.0 15694.9 15942.4 16180.0 16182.4 16216.4 27564.4 27665.9 27915.6 27994.2 27998.2 9629.0 9995.2 10069.2 10078.0 10156.8 8613.1 8724.8 8731.5 8816.8 8878.3 7079.2 7973.2 7991.4 8005.4 8082.6 2663.7 3141.8 3155.3 3178.3 3231.4 990.0 1005.3 1067.7 1071.9 1112.8 16806.7 16944.2 17115.7 17285.1 17331.7 985.8 1006.9 1037.2 1043.3 1058.3 9550.1 9593.2 9865.0 10309.9 10357.7 437988.0 438043.0 445588.0 469347.0 473459.0 81866.6 82845.6 83400.0 84972.6 85622.6 1036.4 1073.3 1076.8 1083.7 1094.7 16415.4 16480.0 16522.9 16615.5 16984.0 35046.0 35121.0 36333.6 36836.1 37076.4 47563.5 49763.5 50718.0 51055.5 51600.2 8513.3 8515.2 8537.0 8850.0 8870.8 12580.9 12793.2 12840.1 13170.0 13183.3 10585.8 11231.8 11559.9 11766.5 11859.2 11399.3 11507.1 11513.3 11784.4 11833.1 11416.3 11485.7 11618.7 11716.4 11957.7 8429.7 8677.7 8742.3 8909.3 9107.5 11100.0 11380.5 11481.3 11513.9 11798.8 14:35:49 INFO - PROCESS | 10379 | 14:35:49 INFO - PROCESS | 10379 | [#3] mootools.html Cycles:180 Average:5566.93 Median:6573.34 stddev:2839.94 (43.2%) stddev-sans-first:2830.55 14:35:49 INFO - PROCESS | 10379 | Values: 1390.2 1499.0 1501.2 1689.2 1844.0 7056.0 7568.2 7732.4 7763.9 7771.9 7686.8 7829.1 7841.6 7842.3 7848.4 2336.0 2341.6 2365.5 2367.4 2368.1 2307.1 2331.4 2343.9 2346.7 2357.2 2328.4 2331.7 2346.4 2388.8 2396.9 2326.9 2348.1 2362.7 2363.4 2377.1 2321.1 2362.1 2364.4 2366.4 2370.0 7976.5 7995.3 8001.6 8006.2 8020.4 4973.4 5083.8 5088.4 5093.5 5099.5 3153.3 3169.2 3206.9 3224.8 3232.1 1099.8 1885.8 1952.3 1988.4 1998.8 10652.6 10748.9 10823.1 10824.6 10826.2 4159.4 4282.4 4305.7 4367.6 4384.4 8707.3 8783.6 8802.3 8824.1 8824.9 4910.1 4931.3 4943.9 4944.0 4944.1 4036.4 4445.6 4545.3 4563.0 4579.5 3419.6 3464.3 3486.2 3516.6 3528.4 1060.2 1067.5 1076.0 1076.5 1086.7 1232.2 1234.2 1294.0 1343.2 1363.6 7556.2 7659.5 7753.5 7764.0 7767.5 510.4 510.4 513.4 518.6 519.5 5982.7 6000.0 6014.3 6028.3 6062.1 9166.5 9210.0 9362.8 9383.7 9403.7 9159.5 9311.6 9318.4 9323.3 9327.1 7314.2 7480.8 7566.0 7580.4 7597.9 7442.9 7596.9 7598.0 7634.9 7802.3 8635.2 8661.7 8710.1 8827.2 8828.0 8569.6 8781.1 8917.6 8965.0 8998.1 6753.5 7208.4 7413.4 7633.5 7739.3 7532.2 7538.0 7552.7 7574.5 7588.2 6731.5 6898.4 6995.5 7018.3 7067.9 6778.9 6786.6 6854.8 6893.9 6914.4 6933.4 6935.9 6944.0 7100.5 7133.6 6631.2 6634.1 6656.8 6665.5 6689.0 6515.4 6649.5 6692.1 6704.4 6710.9 14:35:49 INFO - PROCESS | 10379 | 14:35:49 INFO - PROCESS | 10379 | [#4] prototype.html Cycles:180 Average:5351.75 Median:6041.40 stddev:1561.76 (25.9%) stddev-sans-first:1520.39 14:35:49 INFO - PROCESS | 10379 | Values: 352.1 352.9 364.5 366.8 368.5 5890.6 5912.9 5939.4 5987.4 5993.0 5695.1 5842.9 5846.6 5852.5 5856.0 4623.6 4667.3 4672.4 4706.7 4714.1 4700.5 4718.2 4723.3 4730.0 4745.0 4483.9 4584.6 4696.1 4708.2 4711.5 4681.8 4682.7 4688.7 4692.5 4706.9 4180.0 4183.9 4188.3 4189.7 4196.5 5643.2 5645.9 5653.7 5653.9 5659.2 5434.6 5434.7 5441.8 5444.0 5446.8 6132.4 6240.9 6273.7 6274.6 6277.7 4610.7 4611.3 4615.7 4616.9 4620.5 6496.0 6522.2 6539.8 6544.9 6556.8 4730.2 4733.7 4736.6 4737.8 4739.4 4813.0 4815.3 4818.3 4818.4 4821.8 5380.0 5409.9 5410.5 5415.5 5418.9 6147.3 6222.5 6265.4 6292.7 6302.5 1666.5 1687.6 1699.7 1700.4 1700.9 1075.0 1147.4 1174.7 1177.3 1179.0 6055.8 6098.9 6119.6 6124.1 6124.4 6441.3 6451.3 6456.4 6459.6 6460.5 6090.3 6119.7 6126.7 6136.7 6138.2 3457.0 3489.5 3489.6 3490.9 3492.0 6603.9 6692.8 6814.5 6822.5 6828.1 6626.4 6714.9 6735.4 6814.9 6820.0 6828.2 6869.9 6881.5 6887.1 6900.7 6586.0 6588.3 6590.6 6594.6 6599.6 6224.3 6385.3 6475.4 6498.1 6502.4 6770.9 6793.8 6797.0 6812.8 6822.4 4653.0 4687.7 4691.9 4695.5 4700.1 6503.1 6504.8 6505.9 6510.8 6511.1 6203.8 6299.8 6310.4 6317.4 6415.4 6362.5 6386.8 6389.7 6394.4 6411.4 6256.4 6262.7 6266.7 6274.6 6275.8 6424.8 6433.4 6433.5 6434.6 6439.6 6027.0 6074.5 6210.6 6233.4 6279.9 14:35:49 INFO - PROCESS | 10379 | 14:35:49 INFO - PROCESS | 10379 | [#5] yui.html Cycles:180 Average:14562.63 Median:44537.78 stddev:16524.49 (37.1%) stddev-sans-first:16538.56 14:35:49 INFO - PROCESS | 10379 | Values: 807.5 809.4 813.5 841.6 930.4 13526.3 13676.5 13692.3 13695.2 13720.6 13536.7 13560.5 13599.4 13621.7 13633.2 752.0 896.8 911.9 913.9 916.9 920.3 922.8 927.2 928.0 928.8 964.4 969.5 970.6 971.4 973.3 788.4 953.2 957.6 961.7 963.6 713.0 713.5 713.6 714.7 716.7 14197.7 14230.6 14263.6 14278.6 14311.3 14016.8 14527.6 14538.5 14612.7 14625.8 11054.5 11080.1 11190.6 11491.9 11529.6 3908.7 3923.0 3929.8 3990.6 4013.8 51006.2 51320.0 51352.7 51593.2 51882.7 10852.8 10930.3 10986.9 11092.7 11338.5 19783.5 19983.2 20115.5 20187.2 20474.6 8274.0 8315.8 8440.4 8562.4 8586.4 4763.9 4830.8 4857.9 4900.4 4912.6 3448.2 3530.6 3540.2 3556.3 3565.4 592.2 639.1 654.3 664.8 667.5 520.2 580.8 624.8 635.0 645.4 8251.6 8446.0 8722.6 8746.6 8806.6 636.7 667.2 711.4 717.5 727.1 3990.4 4072.6 4139.6 4175.5 4270.7 60373.4 62549.0 62640.0 62914.4 63215.0 47271.3 47712.8 48079.3 48133.3 48365.0 45707.0 48244.5 48601.3 48975.5 49525.8 9420.9 9468.9 9479.3 9541.0 9594.1 35620.1 36059.8 36232.0 37542.0 37557.0 43515.8 45559.8 47200.3 47895.5 49662.0 11168.8 11226.9 11878.1 11910.8 12046.9 11819.3 12585.2 12736.8 12744.0 12807.9 10687.6 11435.7 12355.5 12785.0 12811.2 11665.4 12111.9 12248.3 12784.9 12957.6 12297.0 12669.6 12745.2 12918.4 13334.3 10233.0 10325.6 10420.4 10435.4 10437.0 10205.5 10678.6 10853.6 10865.3 10894.9 14:35:49 INFO - PROCESS | 10379 | -------- Summary: end -------- 14:35:49 INFO - PROCESS | 10379 | 14:35:50 INFO - TEST-INFO | 10379: exit 0 14:35:50 INFO - TEST-OK | dromaeo_css | took 1110630ms 14:35:50 INFO - TEST-START | kraken 14:35:50 INFO - operating with platform_type : linux_ 14:35:50 INFO - Initialising browser for kraken test... 14:35:50 INFO - TEST-INFO | started process 10573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHi0Upz/profile http://localhost:45552/getInfo.html) 14:35:54 INFO - PROCESS | 10573 | __metrics Screen width/height:1600/1200 14:35:54 INFO - PROCESS | 10573 | colorDepth:24 14:35:54 INFO - PROCESS | 10573 | Browser inner width/height: 1024/697 14:35:54 INFO - PROCESS | 10573 | __metrics 14:35:55 INFO - PROCESS | 10573 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:35:55 INFO - TEST-INFO | 10573: exit 0 14:35:55 INFO - Browser initialized. 14:35:55 INFO - Running cycle 1/1 for kraken test... 14:35:55 INFO - TEST-INFO | started process 10662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHi0Upz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:36:07 INFO - PROCESS | 10662 | RSS: Main: 139657216 14:36:07 INFO - PROCESS | 10662 | 14:36:10 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45552/tests/kraken/driver.html?testName=audio-beat-detection) 14:36:10 INFO - PROCESS | 10662 | RSS: Main: 174399488 14:36:10 INFO - PROCESS | 10662 | 14:36:13 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45552/tests/kraken/driver.html?testName=audio-dft) 14:36:13 INFO - PROCESS | 10662 | RSS: Main: 172072960 14:36:13 INFO - PROCESS | 10662 | 14:36:16 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45552/tests/kraken/driver.html?testName=audio-fft) 14:36:17 INFO - PROCESS | 10662 | RSS: Main: 169410560 14:36:17 INFO - PROCESS | 10662 | 14:36:19 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45552/tests/kraken/driver.html?testName=audio-oscillator) 14:36:19 INFO - PROCESS | 10662 | RSS: Main: 169619456 14:36:19 INFO - PROCESS | 10662 | 14:36:22 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45552/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:36:22 INFO - PROCESS | 10662 | RSS: Main: 167329792 14:36:22 INFO - PROCESS | 10662 | 14:36:25 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45552/tests/kraken/driver.html?testName=imaging-darkroom) 14:36:26 INFO - PROCESS | 10662 | RSS: Main: 168357888 14:36:26 INFO - PROCESS | 10662 | 14:36:29 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45552/tests/kraken/driver.html?testName=imaging-desaturate) 14:36:30 INFO - PROCESS | 10662 | RSS: Main: 167657472 14:36:30 INFO - PROCESS | 10662 | 14:36:32 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45552/tests/kraken/driver.html?testName=json-parse-financial) 14:36:33 INFO - PROCESS | 10662 | RSS: Main: 167538688 14:36:33 INFO - PROCESS | 10662 | 14:36:35 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45552/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:36:35 INFO - PROCESS | 10662 | RSS: Main: 174977024 14:36:35 INFO - PROCESS | 10662 | 14:36:37 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:36:38 INFO - PROCESS | 10662 | RSS: Main: 172728320 14:36:38 INFO - PROCESS | 10662 | 14:36:40 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:36:40 INFO - PROCESS | 10662 | RSS: Main: 178896896 14:36:40 INFO - PROCESS | 10662 | 14:36:43 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:36:43 INFO - PROCESS | 10662 | RSS: Main: 183468032 14:36:43 INFO - PROCESS | 10662 | 14:36:46 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:36:46 INFO - PROCESS | 10662 | RSS: Main: 181854208 14:36:46 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:45552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45552/tests/kraken/driver.html?testName=ai-astar) 14:36:48 INFO - PROCESS | 10662 | RSS: Main: 244142080 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | __start_tp_report 14:36:48 INFO - PROCESS | 10662 | _x_x_mozilla_page_load 14:36:48 INFO - PROCESS | 10662 | _x_x_mozilla_page_load_details 14:36:48 INFO - PROCESS | 10662 | |i|pagename|runs| 14:36:48 INFO - PROCESS | 10662 | |0;ai-astar;109;112;106;109;108;110;101;110;110;108 14:36:48 INFO - PROCESS | 10662 | |1;audio-beat-detection;155;131;164;164;127;160;150;128;168;126 14:36:48 INFO - PROCESS | 10662 | |2;audio-dft;161;162;163;160;161;161;160;163;160;161 14:36:48 INFO - PROCESS | 10662 | |3;audio-fft;76;76;73;170;77;75;76;76;175;85 14:36:48 INFO - PROCESS | 10662 | |4;audio-oscillator;94;93;145;93;93;93;141;93;93;139 14:36:48 INFO - PROCESS | 10662 | |5;imaging-gaussian-blur;117;116;116;116;117;117;116;117;116;116 14:36:48 INFO - PROCESS | 10662 | |6;imaging-darkroom;146;146;146;145;146;145;146;146;146;145 14:36:48 INFO - PROCESS | 10662 | |7;imaging-desaturate;95;96;96;95;95;95;95;96;96;95 14:36:48 INFO - PROCESS | 10662 | |8;json-parse-financial;55;55;56;54;54;55;59;55;53;53 14:36:48 INFO - PROCESS | 10662 | |9;json-stringify-tinderbox;83;82;84;84;84;93;82;83;84;84 14:36:48 INFO - PROCESS | 10662 | |10;stanford-crypto-aes;76;78;86;80;78;79;80;85;88;79 14:36:48 INFO - PROCESS | 10662 | |11;stanford-crypto-ccm;119;127;112;121;112;111;121;113;114;112 14:36:48 INFO - PROCESS | 10662 | |12;stanford-crypto-pbkdf2;147;139;150;147;147;135;143;143;147;143 14:36:48 INFO - PROCESS | 10662 | |13;stanford-crypto-sha256-iterative;67;67;69;69;69;67;68;66;66;66 14:36:48 INFO - PROCESS | 10662 | __end_tp_report 14:36:48 INFO - PROCESS | 10662 | __start_cc_report 14:36:48 INFO - PROCESS | 10662 | _x_x_mozilla_cycle_collect,1061 14:36:48 INFO - PROCESS | 10662 | __end_cc_report 14:36:48 INFO - PROCESS | 10662 | __startTimestamp1461620208790__endTimestamp 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | ------- Summary: start ------- 14:36:48 INFO - PROCESS | 10662 | Number of tests: 14 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.50 stddev:3.02 (2.8%) stddev-sans-first:3.19 14:36:48 INFO - PROCESS | 10662 | Values: 109.0 112.0 106.0 109.0 108.0 110.0 101.0 110.0 110.0 108.0 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:157.50 stddev:17.38 (11.0%) stddev-sans-first:18.21 14:36:48 INFO - PROCESS | 10662 | Values: 155.0 131.0 164.0 164.0 127.0 160.0 150.0 128.0 168.0 126.0 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 14:36:48 INFO - PROCESS | 10662 | Values: 161.0 162.0 163.0 160.0 161.0 161.0 160.0 163.0 160.0 161.0 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#3] audio-fft Cycles:10 Average:95.90 Median:76.00 stddev:40.51 (53.3%) stddev-sans-first:42.32 14:36:48 INFO - PROCESS | 10662 | Values: 76.0 76.0 73.0 170.0 77.0 75.0 76.0 76.0 175.0 85.0 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.00 stddev:23.49 (25.3%) stddev-sans-first:24.38 14:36:48 INFO - PROCESS | 10662 | Values: 94.0 93.0 145.0 93.0 93.0 93.0 141.0 93.0 93.0 139.0 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:36:48 INFO - PROCESS | 10662 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 14:36:48 INFO - PROCESS | 10662 | Values: 146.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:36:48 INFO - PROCESS | 10662 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.73 (3.1%) stddev-sans-first:1.83 14:36:48 INFO - PROCESS | 10662 | Values: 55.0 55.0 56.0 54.0 54.0 55.0 59.0 55.0 53.0 53.0 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#9] json-stringify-tinderbox Cycles:10 Average:84.30 Median:84.00 stddev:3.16 (3.8%) stddev-sans-first:3.32 14:36:48 INFO - PROCESS | 10662 | Values: 83.0 82.0 84.0 84.0 84.0 93.0 82.0 83.0 84.0 84.0 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:3.98 (5.0%) stddev-sans-first:3.81 14:36:48 INFO - PROCESS | 10662 | Values: 76.0 78.0 86.0 80.0 78.0 79.0 80.0 85.0 88.0 79.0 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:116.50 stddev:5.43 (4.7%) stddev-sans-first:5.67 14:36:48 INFO - PROCESS | 10662 | Values: 119.0 127.0 112.0 121.0 112.0 111.0 121.0 113.0 114.0 112.0 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:147.00 stddev:4.48 (3.0%) stddev-sans-first:4.63 14:36:48 INFO - PROCESS | 10662 | Values: 147.0 139.0 150.0 147.0 147.0 135.0 143.0 143.0 147.0 143.0 14:36:48 INFO - PROCESS | 10662 | 14:36:48 INFO - PROCESS | 10662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.26 (1.9%) stddev-sans-first:1.33 14:36:48 INFO - PROCESS | 10662 | Values: 67.0 67.0 69.0 69.0 69.0 67.0 68.0 66.0 66.0 66.0 14:36:48 INFO - PROCESS | 10662 | -------- Summary: end -------- 14:36:48 INFO - PROCESS | 10662 | 14:36:49 INFO - TEST-INFO | 10662: exit 0 14:36:49 INFO - TEST-OK | kraken | took 59345ms 14:36:49 INFO - SUITE-END | took 1169s 14:36:49 INFO - Completed test suite (00:19:30) 14:36:49 INFO - javascript benchmark 14:36:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3232.0627018164732, 3271.55833962415, 3277.1807048237943, 3292.4732042873147, 3324.700776930076, 5203.739813009349, 5210.218467229913, 5222.399424066233, 5225.268462415265, 5260.395054568726, 5200.297959775429, 5225.581953443725, 5231.712255825928, 5239.240310155025, 5267.710275934822, 4721.740304283263, 4764.118638051954, 4787.377640906678, 4823.372961514998, 4868.0750657375165, 4800.4719480857075, 4803.903921921559, 4835.564799168074, 4840.9757951210195, 4842.370491836056, 4855.5872750816225, 4892.633052521057, 4894.461609223001, 4906.165951788187, 4959.776810043557, 4779.617630589544, 4880.560749532541, 4887.780049897728, 4888.340074089988, 4897.975510122462, 4693.9530604693855, 4725.716457012591, 4790.856274311776, 4819.397575303087, 4836.153673107192, 5057.49425057495, 5092.465291144414, 5092.898142037138, 5094.337736094321, 5123.2315152727015, 5666.206731057655, 5672.06410942194, 5678.261825962599, 5678.659280443187, 5701.0308247597595, 5557.6109672322955, 5560.443955604448, 5660.3490598581275, 5676.602637815355, 5681.971590142023, 5282.471752824726, 5288.788448462057, 5298.258243845865, 5301.204819277101, 5327.0, 5765.798197063083, 5769.94230057694, 5770.769169233184, 5782.045962416154, 5786.884262314814, 5437.211604317352, 5478.671279723229, 5525.944740552623, 5529.695866727288, 5561.443855614487, 5645.520130788929, 5649.802256920988, 5650.943490565041, 5651.350094739076, 5657.32112146545, 5570.888582228414, 5581.804636837691, 5588.329400471888, 5589.245451864028, 5594.1608758686525, 5506.366767821672, 5580.0, 5601.775928962796, 5603.271574695345, 5644.9435505644415, 4362.76004819738, 4381.233284175257, 4383.101464199832, 4384.846530371422, 4412.911741765147, 3937.074787424953, 3954.5254569451276, 3973.344398174269, 3986.980065099656, 3991.560928297885, 5287.391949925808, 5308.389535203424, 5416.10634245353, 5460.590455715837, 5495.120780675073, 5669.0, 5680.289963754531, 5699.031164702011, 5701.657900525982, 5717.113847353667, 5259.21111833228, 5421.4578542146255, 5423.484768946943, 5438.972805136028, 5441.673499590037, 4826.8793280168275, 4874.415070191529, 4883.609311255091, 4889.706617602884, 4906.067847109038, 5805.274340707411, 5886.3230728465915, 5889.852753681106, 5890.646561206341, 5898.115282707542, 5582.190582365615, 5680.801171958961, 5705.4009329019855, 5715.371309156073, 5737.827865164052, 5789.189513468202, 5812.273465816773, 5838.153467747068, 5841.094630332305, 5842.065269557021, 5556.333240011225, 5566.638168519034, 5567.47109024642, 5577.860553486195, 5581.190727344431, 5559.805406810742, 5653.886922261614, 5654.236678048575, 5683.460071293386, 5762.567807414544, 5487.5609951203005, 5492.450754924475, 5496.890062198813, 5497.725113744217, 5517.200005999188, 5470.398256191896, 5472.425395333592, 5473.261109750133, 5481.588880833874, 5505.091659876076, 5337.146056630921, 5371.597130215171, 5401.351837779492, 5407.594430417813, 5418.972905135449, 5419.4309597493275, 5527.613067085265, 5534.7786088556, 5604.8879022418505, 5653.406392328746, 5393.919091213714, 5399.082156033563, 5457.781688732406, 5463.0, 5483.5064844162625], "unit": "score", "name": "dojo.html", "value": 5220.164029952979}, {"lowerIsBetter": false, "replicates": [523.9607029472788, 528.5137673340527, 536.4313827343017, 546.7375659683352, 558.625720767086, 31996.52005219921, 32865.835670821674, 40510.18979620406, 40842.183156336854, 40866.591334086654, 44880.326795098015, 45375.77312113435, 45454.31818522717, 45455.318170227474, 45507.54492455075, 8925.73222803317, 9121.17909388155, 9131.908680913206, 9132.543372831366, 9141.360104792668, 8835.911640883573, 8935.329850261223, 8954.149355811187, 8961.148690874357, 8962.775930601721, 9217.032211617785, 9292.628294868196, 9319.720408387759, 9323.30075244356, 9325.114114159143, 9155.725328240163, 9245.399049061856, 9251.121143491358, 9252.352335336529, 9255.398399104037, 9101.36290459668, 9261.907380926172, 9267.119623635745, 9272.860907086399, 9281.39670921388, 40377.0, 40869.0, 40873.18253634911, 40908.795456022526, 40921.1815763686, 3575.78545287281, 3644.2529281497227, 3671.4859919611276, 3704.370257056307, 3742.120601658608, 30882.382352353052, 32229.0, 32268.193295167574, 32268.354632907445, 32287.35425291481, 4068.613481719232, 4100.118474527961, 4118.814653340577, 4134.586541345841, 4203.936940945889, 222343.0, 225943.0, 226404.99999999834, 226757.99999999834, 227293.0, 71983.0, 72129.0, 72766.27233727701, 72840.0, 72876.63561682263, 76843.0, 77842.6107869457, 78127.0, 78412.0, 78845.60577197078, 17915.820841791676, 18192.0, 18200.63598728018, 18216.81783182151, 18219.45341639753, 14533.491327803476, 14704.926475367554, 14815.0, 14821.703565928621, 14825.481108161162, 23975.76024239735, 24405.0, 24550.50898982046, 24634.13780517709, 24638.384040398774, 8498.74503764888, 8998.910010899937, 9308.440178950706, 9309.812194134372, 9316.673916412892, 1016.1159790981893, 1043.7286305560608, 1062.2245760594808, 1097.7365432296192, 1127.7913585986619, 30046.84976575103, 30450.54324185139, 30833.537496937563, 31023.68976310253, 31040.91356802501, 1105.7456784939347, 1139.5270962550615, 1159.515165942581, 1186.6677330347343, 1207.836942012817, 16380.26288817006, 16394.918025409796, 16403.42588009414, 16403.83596164047, 16707.33170673184, 337713.0, 338258.0, 341188.0, 341331.0, 341373.0, 56424.43575564274, 57050.714746426835, 57148.14277785837, 57155.14267285994, 57161.42838571561, 1368.9520866769615, 1427.7358688642635, 1488.6576087499718, 1490.3219035338896, 1503.1432083712398, 27342.316442089108, 27693.723062769113, 29428.411431770815, 30301.242468938453, 30328.0, 46020.30969535527, 46269.0, 46746.0, 46816.0, 46829.76585117052, 189150.05424972787, 189691.0, 189776.0, 189799.0, 189818.0, 30500.237494062825, 35285.47071793874, 35416.46875296821, 35421.291574168885, 35973.0, 41566.376504353066, 42852.78573607112, 43274.35088473612, 43343.13313733771, 43567.0, 38025.80987095047, 38453.61546384612, 38517.422238667, 38527.0, 39418.605813941496, 36416.45375319319, 37852.62147378491, 38211.04472388213, 38343.616563834, 38458.80770596129, 37608.811955940044, 38384.23231535409, 38433.807830960664, 39063.0, 39361.60638393694, 33443.498347525296, 34318.656813431546, 34706.305873882884, 34788.130296742784, 34813.82593087018, 26247.0, 26644.866775665996, 26716.0, 26755.732442676104, 26899.86550067237], "unit": "score", "name": "ext.html", "value": 19556.462780082387}, {"lowerIsBetter": false, "replicates": [374.7582809088137, 378.12652772096453, 380.9123901502656, 384.81144239322725, 391.59078762692985, 17743.37898173564, 18803.435896923096, 19361.806381936178, 19525.0, 19535.902320488396, 13949.651258718537, 16590.336386544524, 17162.485125446256, 17188.914055429737, 17332.566685832862, 5204.531592156705, 5316.043112239795, 5357.464253574631, 5360.839174824761, 5366.490183432567, 4055.858044968427, 6694.230163531183, 7143.107111611049, 7147.0, 7175.425965922714, 6785.2196997345445, 7068.081149450564, 7136.072310599615, 7149.3923016543395, 7168.892466612979, 6960.79117626467, 6973.407260382823, 6997.720091196372, 7005.614691191982, 7013.158420989488, 6625.602463852184, 6703.162104736908, 6715.496337774686, 6739.292374300726, 6739.730410783563, 23825.76174238253, 24561.877190613934, 24973.875130624412, 25013.12454064099, 25030.249092527254, 2361.6575596538405, 2378.6550950112137, 2399.5560821248123, 2422.624493203556, 3252.902412927616, 14400.423983040666, 14452.205128717917, 14554.272286385638, 14671.413143474248, 15214.239288035555, 2063.783302753204, 2109.4831766217376, 2166.068590506082, 2183.5087105401317, 2187.9671804922937, 72860.6356968217, 73117.99999999946, 74944.0, 75165.62417187933, 75367.0, 15694.921525392529, 15942.442014529668, 16180.0, 16182.352705891632, 16216.351345946267, 27564.448711025667, 27665.861670691516, 27915.58126628102, 27994.16017519478, 27998.160055198376, 9629.0, 9995.200383969264, 10069.244806639532, 10078.042585954323, 10156.796864062826, 8613.095624959415, 8724.825503489894, 8731.476111433334, 8816.823663526693, 8878.334124940655, 7079.1505019398, 7973.162817904153, 7991.3606911448105, 8005.439619226599, 8082.555459449787, 2663.746944040313, 3141.7800753947463, 3155.290059736541, 3178.268998130443, 3231.41834469793, 989.9703008909744, 1005.2561104782409, 1067.6547550086946, 1071.8660167479065, 1112.7663190729875, 16806.747898781527, 16944.15279236033, 17115.74326385105, 17285.135743212788, 17331.740023899652, 985.7634167799677, 1006.9295149339622, 1037.227265687053, 1043.3270540501335, 1058.2539309786582, 9550.092741189575, 9593.232541396672, 9865.0, 10309.94845025785, 10357.689269321932, 437988.0, 438043.0, 445588.0, 469347.0, 473459.0, 81866.59066704629, 82845.58577207076, 83400.0, 84972.57513712515, 85622.57188714141, 1036.3781730961364, 1073.2755390111643, 1076.7792602516465, 1083.7344850511674, 1094.68801391603, 16415.42546010884, 16480.011199328077, 16522.917385412995, 16615.50153495397, 16984.0, 35046.0, 35121.0, 36333.63666363303, 36836.07909802276, 37076.44385334276, 47563.52436475591, 49763.50236497589, 50718.0, 51055.48944510656, 51600.22599660933, 8513.276371508244, 8515.233628973423, 8536.957315213633, 8850.026497085444, 8870.822583548164, 12580.937095314464, 12793.168444051107, 12840.101192916407, 13170.0, 13183.274919879499, 10585.788284234119, 11231.831522527333, 11559.942200288944, 11766.470508826953, 11859.16985810985, 11399.259048161843, 11507.079433645456, 11513.30920144794, 11784.410779461165, 11833.112516561465, 11416.315021098428, 11485.712857178303, 11618.6514404568, 11716.355600442057, 11957.701057473632, 8429.704960326359, 8677.652893884175, 8742.34432417584, 8909.287257019552, 9107.544622768703, 11099.954541140281, 11380.54477820878, 11481.311121332747, 11513.88486115128, 11798.823017654913], "unit": "score", "name": "jquery.html", "value": 9912.909786050883}, {"lowerIsBetter": false, "replicates": [1390.2492653966858, 1499.0481044536718, 1501.196859680071, 1689.2229574395778, 1844.0, 7055.964720176398, 7568.243175682429, 7732.420068494871, 7763.883541746871, 7771.92228077719, 7686.807829804257, 7829.138794732575, 7841.568713720743, 7842.254985776356, 7848.411369147322, 2335.9649605255936, 2341.5785158671433, 2365.5387199496017, 2367.4081479630095, 2368.076450184421, 2307.1232931486097, 2331.393837602227, 2343.8593684378907, 2346.718393792739, 2357.233898982837, 2328.4178955261186, 2331.6968794056834, 2346.4485845826216, 2388.7850093491584, 2396.892139853711, 2326.906923723049, 2348.1429278313462, 2362.681038059866, 2363.420961864346, 2377.1442280778906, 2321.1179751694417, 2362.078789272185, 2364.432536191319, 2366.3610825077303, 2369.9763002369928, 7976.521408715437, 7995.320397766197, 8001.599920004035, 8006.239407256301, 8020.438569300151, 4973.403191616993, 5083.822066227664, 5088.389393272831, 5093.490650934877, 5099.4900509949075, 3153.274746808247, 3169.2235402326346, 3206.9198270043435, 3224.7903886247555, 3232.078857525594, 1099.7855418193456, 1885.7831349394858, 1952.3069310394746, 1988.434918954547, 1998.7701414337391, 10652.573897044109, 10748.892511074868, 10823.080038196762, 10824.621138260123, 10826.18803589734, 4159.355299928456, 4282.35764635301, 4305.677074219383, 4367.58507941745, 4384.364267181305, 8707.346948978851, 8783.560821958876, 8802.295816334678, 8824.117588241124, 8824.911750882537, 4910.116179087799, 4931.260310953314, 4943.876403089952, 4944.035912997003, 4944.134776414113, 4036.3945408189006, 4445.555444455593, 4545.272756358967, 4562.954370456253, 4579.519150489217, 3419.6067452242814, 3464.255185135208, 3486.1981744198974, 3516.6307537708685, 3528.3825330567047, 1060.183658582887, 1067.508945884886, 1075.9677209683723, 1076.5478499030426, 1086.6631344283298, 1232.2236990695803, 1234.2224398628807, 1293.9611811645666, 1343.2276441046438, 1363.5704753002772, 7556.206598307209, 7659.502132361378, 7753.457257991887, 7763.961180194063, 7767.53394796314, 510.36204744069914, 510.36969342861534, 513.4480433533965, 518.5695872425878, 519.4934938434996, 5982.73077711504, 6000.0, 6014.338422773491, 6028.2766068072115, 6062.120992456069, 9166.49584272858, 9210.0, 9362.765930851647, 9383.718488445358, 9403.670871519464, 9159.542022898828, 9311.580978855967, 9318.440893546409, 9323.347365684473, 9327.113924177193, 7314.158871729819, 7480.812979675552, 7566.0, 7580.431467639949, 7597.886031709529, 7442.888356674763, 7596.924030759843, 7597.962010189914, 7634.923650763421, 7802.29779319864, 8635.179657932485, 8661.740147795575, 8710.12898710124, 8827.16141966512, 8828.0, 8569.614367353359, 8781.077986811293, 8917.643294268417, 8964.955175224082, 8998.100189980949, 6753.493487988519, 7208.423326133792, 7413.443991700537, 7633.465657403928, 7739.264769846855, 7532.17146113938, 7537.9623101884135, 7552.66013029426, 7574.469787114849, 7588.165301816685, 6731.461483081243, 6898.413634841095, 6995.545289556163, 7018.33325834045, 7067.858642827012, 6778.8983165251575, 6786.558873673195, 6854.794356169323, 6893.896591551231, 6914.377706006484, 6933.445324374139, 6935.861282774417, 6944.0, 7100.502964792621, 7133.643317834191, 6631.237407697983, 6634.104395906684, 6656.800295991128, 6665.466762658879, 6688.966555167193, 6515.446187074152, 6649.534532582673, 6692.130023096966, 6704.4301234395625, 6710.932890671031], "unit": "score", "name": "mootools.html", "value": 4554.1116299791365}, {"lowerIsBetter": false, "replicates": [352.130238311371, 352.92941411717663, 364.5279363224625, 366.77626647744887, 368.50252159584556, 5890.558208134391, 5912.88174236515, 5939.376365481627, 5987.40125987401, 5993.041113421853, 5695.0887857942735, 5842.853928651786, 5846.649201047941, 5852.502537284326, 5856.004479238529, 4623.606993405556, 4667.299905014258, 4672.415948006499, 4706.694064885789, 4714.057188562301, 4700.529947005306, 4718.150732868083, 4723.291506274052, 4729.9763501182615, 4745.0, 4483.887902802439, 4584.610308123813, 4696.131215725101, 4708.176069187895, 4711.505291944348, 4681.83613573525, 4682.672212945061, 4688.742119183444, 4692.460367057798, 4706.858794236178, 4180.038591124058, 4183.895402614929, 4188.308929026707, 4189.706720529564, 4196.538380778112, 5643.238162848004, 5645.915311270334, 5653.717314134276, 5653.8586535336535, 5659.151127330892, 5434.565234781208, 5434.728263586805, 5441.83674489766, 5444.047291723932, 5446.809361672323, 6132.386761323832, 6240.875182496325, 6273.686315684243, 6274.592151510137, 6277.686115694242, 4610.723356598614, 4611.30830375443, 4615.676902616819, 4616.884577885546, 4620.537946205386, 6495.967520162416, 6522.249941256721, 6539.771108011197, 6544.934550654528, 6556.8032959010825, 4730.219513780187, 4733.739644319596, 4736.573708366263, 4737.763111844394, 4739.3601863748645, 4813.0, 4815.253635686474, 4818.277258411196, 4818.445878723922, 4821.807127714852, 5380.0, 5409.864753381197, 5410.458954104637, 5415.48552887475, 5418.945810541844, 6147.323794382614, 6222.471089957314, 6265.4361107500545, 6292.653904035322, 6302.464290535356, 1666.5000499849996, 1687.64559442516, 1699.7195462748507, 1700.3623641134575, 1700.863930885526, 1075.0378411321824, 1147.4033502578613, 1174.7356844709873, 1177.2818580665787, 1178.9587364442202, 6055.788047418319, 6098.908516372258, 6119.602225855305, 6124.11200375943, 6124.418180272867, 6441.32366101562, 6451.29035806061, 6456.3543645636, 6459.580127291711, 6460.515461340418, 6090.33006369299, 6119.724612392453, 6126.693665316717, 6136.662483563447, 6138.202033735586, 3457.0, 3489.45913383426, 3489.616142224353, 3490.877819276364, 3492.0, 6603.933960660332, 6692.799216023527, 6814.48891333152, 6822.464945387248, 6828.112345395067, 6626.370494802986, 6714.932850671528, 6735.393814556714, 6814.863702725917, 6820.0, 6828.214755303204, 6869.862602747917, 6881.518293719491, 6887.139107611549, 6900.723971041102, 6585.967070164618, 6588.275289718032, 6590.5716128451495, 6594.571352862049, 6599.637019963948, 6224.253089629093, 6385.329540398191, 6475.352464753487, 6498.122753428227, 6502.4472919800455, 6770.93229067703, 6793.830154245986, 6797.0144329073, 6812.795616131524, 6822.351876571718, 4653.046125544188, 4687.695299805502, 4691.873950251983, 4695.460022097503, 4700.083483720641, 6503.057056726842, 6504.837379065561, 6505.902411463737, 6510.837229069311, 6511.120998665309, 6203.751849925952, 6299.842503937255, 6310.422394401399, 6317.431431171033, 6415.422611964946, 6362.491000719839, 6386.840328991812, 6389.68051597409, 6394.360563943568, 6411.4229719325485, 6256.374362563889, 6262.718177681924, 6266.68666566679, 6274.560780745304, 6275.843103922439, 6424.839379015562, 6433.388828061326, 6433.453156481564, 6434.613923164625, 6439.613623182624, 6027.005544085352, 6074.544409169418, 6210.627362358273, 6233.376662333912, 6279.905801413074], "unit": "score", "name": "prototype.html", "value": 4855.039757597228}, {"lowerIsBetter": false, "replicates": [807.4791759315245, 809.4172196018865, 813.4712436916004, 841.6338892581728, 930.4417349590246, 13526.256055916921, 13676.52132175374, 13692.315384230798, 13695.24676142813, 13720.559341269172, 13536.729265414686, 13560.45758169672, 13599.38802753876, 13621.727565448686, 13633.182009079463, 751.9887201691965, 896.7802888292345, 911.8905731312252, 913.9040400757924, 916.9266458683322, 920.3097676742443, 922.8431166701677, 927.1933417926414, 928.0394791390878, 928.8095940332249, 964.3876138651937, 969.5394687523441, 970.553545369131, 971.3637567393368, 973.3235401396032, 788.4008153803122, 953.1612181280498, 957.6456711016899, 961.7499450142943, 963.5904740485265, 712.9821754456128, 713.4827250243584, 713.6253466929851, 714.6926821466767, 716.6810769207705, 14197.716045679028, 14230.644233894132, 14263.572092837232, 14278.64303392413, 14311.284435778274, 14016.789748153786, 14527.56417307472, 14538.491152809602, 14612.707745845024, 14625.78061329081, 11054.502547385306, 11080.05819505343, 11190.552377904874, 11491.94254028733, 11529.596464123799, 3908.687305015592, 3922.960770392288, 3929.8035098244973, 3990.5610382857863, 4013.7591744495426, 51006.234906476435, 51320.0, 51352.74323628358, 51593.2261016085, 51882.74058629683, 10852.837207441895, 10930.344179349264, 10986.945065274622, 11092.722681933015, 11338.546458141747, 19783.505412364808, 19983.20067197325, 20115.497112572302, 20187.192512299636, 20474.59050819005, 8274.0, 8315.792105197297, 8440.40917135807, 8562.357823163287, 8586.441881277697, 4763.857084287477, 4830.758462076882, 4857.878553036132, 4900.436449808318, 4912.606991440676, 3448.1724386147644, 3530.5763308403157, 3540.2388486475015, 3556.253186830743, 3565.3938830398893, 592.1591340296789, 639.1499305923111, 654.3031671270082, 664.7739768478643, 667.4593579200863, 520.1599416941611, 580.8199458167982, 624.7969409941696, 634.9841253968688, 645.3707635055783, 8251.587420629065, 8446.0, 8722.607482663296, 8746.56267186638, 8806.60370283326, 636.7357546618194, 667.182701191037, 711.4095300900241, 717.5300178383168, 727.0838743183626, 3990.3615421532418, 4072.5745988903645, 4139.5653456387245, 4175.54069052404, 4270.679699022586, 60373.396266036776, 62549.0, 62640.0, 62914.37085629085, 63215.0, 47271.29093063607, 47712.761436192595, 48079.278810817865, 48133.27800083002, 48365.0, 45707.0, 48244.517554824, 48601.27098093531, 48975.51024489781, 49525.75237123863, 9420.858687119562, 9468.905310947079, 9479.28905332089, 9540.95229523848, 9594.088561586637, 35620.109497262776, 36059.81970090133, 36232.0, 37542.0, 37557.0, 43515.78242108769, 45559.77220113878, 47200.29199562078, 47895.5210447905, 49662.0, 11168.776624467628, 11226.943865280622, 11878.109141814572, 11910.821337680116, 12046.941323345818, 11819.290842549131, 12585.181963172365, 12736.808947865604, 12744.0, 12807.93596032014, 10687.572497100029, 11435.714107147387, 12355.480229348748, 12785.0, 12811.239185914917, 11665.416729163677, 12111.939440302742, 12248.326342051272, 12784.87215127874, 12957.611271661865, 12297.0, 12669.556565520163, 12745.17156384832, 12918.35408229566, 13334.3332833356, 10233.0, 10325.638602649171, 10420.42687652156, 10435.37387756737, 10437.0, 10205.540750666089, 10678.572857085941, 10853.565857365616, 10865.293755905841, 10894.945525272324], "unit": "score", "name": "yui.html", "value": 6782.367493765096}], "name": "dromaeo_css", "value": 7303.523704161367}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 106.0, 109.0, 108.0, 110.0, 101.0, 110.0, 110.0, 108.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [155.0, 131.0, 164.0, 164.0, 127.0, 160.0, 150.0, 128.0, 168.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 163.0, 160.0, 161.0, 161.0, 160.0, 163.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 73.0, 170.0, 77.0, 75.0, 76.0, 76.0, 175.0, 85.0], "unit": "score", "name": "audio-fft", "value": 95.9}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 145.0, 93.0, 93.0, 93.0, 141.0, 93.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 56.0, 54.0, 54.0, 55.0, 59.0, 55.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 84.0, 84.0, 84.0, 93.0, 82.0, 83.0, 84.0, 84.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 84.3}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 86.0, 80.0, 78.0, 79.0, 80.0, 85.0, 88.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.9}, {"lowerIsBetter": true, "replicates": [119.0, 127.0, 112.0, 121.0, 112.0, 111.0, 121.0, 113.0, 114.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [147.0, 139.0, 150.0, 147.0, 147.0, 135.0, 143.0, 143.0, 147.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 69.0, 69.0, 69.0, 67.0, 68.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1525.7}]} 14:36:50 INFO - Return code: 0 14:36:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:36:50 INFO - # TBPL SUCCESS # 14:36:50 INFO - Running post-action listener: _resource_record_post_action 14:36:50 INFO - Running post-run listener: _resource_record_post_run 14:36:51 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 16384; Write bytes: 468905984; Read time: 44; Write time: 534168 14:36:51 INFO - install - Wall time: 13s; CPU: 16.0%; Read bytes: 0; Write bytes: 249630720; Read time: 0; Write time: 380132 14:36:51 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 219275264; Read time: 44; Write time: 154036 14:36:51 INFO - Running post-run listener: _upload_blobber_files 14:36:51 INFO - Blob upload gear active. 14:36:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:36:51 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 14:36:51 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:36:51 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:36:51 INFO - (blobuploader) - INFO - Open directory for files ... 14:36:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:36:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:36:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:52 INFO - (blobuploader) - INFO - Done attempting. 14:36:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:36:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:36:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:53 INFO - (blobuploader) - INFO - Done attempting. 14:36:53 INFO - (blobuploader) - INFO - Iteration through files over. 14:36:53 INFO - Return code: 0 14:36:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:36:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:36:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7715141339c065ca855900b0f814717c1a718cf9f7c5215a35f60cbfe6c89a428e8a3dc3529a70f76a6b71884e5cab09b47195530175c039b1f3baf2d7afb028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/af468e56325f68d8ca6f4c3431f2ff1898c5333d197c608b65a80cf6521754e320dd0b79a9dfa89fc921af89ef6c791f0e736b1a025e0665df6504573549a199"} 14:36:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:36:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:36:53 INFO - Contents: 14:36:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7715141339c065ca855900b0f814717c1a718cf9f7c5215a35f60cbfe6c89a428e8a3dc3529a70f76a6b71884e5cab09b47195530175c039b1f3baf2d7afb028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/af468e56325f68d8ca6f4c3431f2ff1898c5333d197c608b65a80cf6521754e320dd0b79a9dfa89fc921af89ef6c791f0e736b1a025e0665df6504573549a199"} 14:36:53 INFO - Running post-run listener: copy_logs_to_upload_dir 14:36:53 INFO - Copying logs to upload dir... 14:36:53 INFO - mkdir: /builds/slave/test/build/upload/logs 14:36:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.980888 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-04-25 14:36:53.103836) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:36:53.107467) ========= 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=41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664 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-Beta/sha512/7715141339c065ca855900b0f814717c1a718cf9f7c5215a35f60cbfe6c89a428e8a3dc3529a70f76a6b71884e5cab09b47195530175c039b1f3baf2d7afb028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/af468e56325f68d8ca6f4c3431f2ff1898c5333d197c608b65a80cf6521754e320dd0b79a9dfa89fc921af89ef6c791f0e736b1a025e0665df6504573549a199"} build_url:https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/WhjevC-gR6GdDGJZmOxEUA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7715141339c065ca855900b0f814717c1a718cf9f7c5215a35f60cbfe6c89a428e8a3dc3529a70f76a6b71884e5cab09b47195530175c039b1f3baf2d7afb028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/af468e56325f68d8ca6f4c3431f2ff1898c5333d197c608b65a80cf6521754e320dd0b79a9dfa89fc921af89ef6c791f0e736b1a025e0665df6504573549a199"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:36:53.133248) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:36:53.133635) ========= 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=41bf3e9aed84707956354da8000001c5-1461618626.45881-259424664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004389 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:36:53.218136) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:36:53.218604) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:36:53.219050) ========= ========= Total master_lag: 0.27 =========