builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1468607917.81 results: success (0) buildid: 20160715064309 builduid: c7b7f5c4fe1d41f4b73d9e5baffa9038 revision: 5a9c26f8bb9d599e80c92f6a7f30ad91bd54a854 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 11:38:37.809926) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 11:38:37.810446) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 11:38:37.810726) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 11:38:37.827900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:38:37.828289) ========= 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=920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 11:38:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-07-15 11:38:38 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133657 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:38:37.975830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:38:37.976148) ========= 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=920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020104 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:38:38.026076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 11:38:38.026437) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5a9c26f8bb9d599e80c92f6a7f30ad91bd54a854 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5a9c26f8bb9d599e80c92f6a7f30ad91bd54a854 --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=920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 11:38:38,386 truncating revision to first 12 chars 2016-07-15 11:38:38,386 Setting DEBUG logging. 2016-07-15 11:38:38,386 attempt 1/10 2016-07-15 11:38:38,386 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5a9c26f8bb9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 11:38:39,283 unpacking tar archive at: mozilla-inbound-5a9c26f8bb9d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.262200 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 11:38:39.302282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 11:38:39.302684) ========= script_repo_revision: 5a9c26f8bb9d599e80c92f6a7f30ad91bd54a854 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 11:38:39.303064) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 11:38:39.303359) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 11:38:39.313978) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-15 11:38:39.314276) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:38:39 INFO - MultiFileLogger online at 20160715 11:38:39 in /builds/slave/test 11:38:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:38:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:38:39 INFO - {'append_to_log': False, 11:38:39 INFO - 'base_work_dir': '/builds/slave/test', 11:38:39 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:38:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:38:39 INFO - 'branch': 'Mozilla-Inbound', 11:38:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:38:39 INFO - 'config_files': ('talos/linux_config.py',), 11:38:39 INFO - 'default_actions': ('clobber', 11:38:39 INFO - 'read-buildbot-config', 11:38:39 INFO - 'download-and-extract', 11:38:39 INFO - 'populate-webroot', 11:38:39 INFO - 'create-virtualenv', 11:38:39 INFO - 'install', 11:38:39 INFO - 'run-tests'), 11:38:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:38:39 INFO - 'download_minidump_stackwalk': True, 11:38:39 INFO - 'download_symbols': 'ondemand', 11:38:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:38:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:38:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:38:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:38:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:38:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:38:39 INFO - 'installer_path': 'installer.exe', 11:38:39 INFO - 'log_level': 'info', 11:38:39 INFO - 'log_name': 'talos', 11:38:39 INFO - 'log_to_console': True, 11:38:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:38:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:38:39 INFO - 'opt_config_files': (), 11:38:39 INFO - 'pip_index': False, 11:38:39 INFO - 'sps_profile': False, 11:38:39 INFO - 'sps_profile_interval': 0, 11:38:39 INFO - 'suite': 'dromaeojs-e10s', 11:38:39 INFO - 'system_bits': '32', 11:38:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:38:39 INFO - 'title': 'talos-linux64-ix-053', 11:38:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:38:39 INFO - 'use_talos_json': True, 11:38:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:38:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:38:39 INFO - 'work_dir': 'build'} 11:38:39 INFO - ##### 11:38:39 INFO - ##### Running clobber step. 11:38:39 INFO - ##### 11:38:39 INFO - Running pre-action listener: _resource_record_pre_action 11:38:39 INFO - Running main action method: clobber 11:38:39 INFO - rmtree: /builds/slave/test/build 11:38:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:38:40 INFO - Running post-action listener: _resource_record_post_action 11:38:40 INFO - ##### 11:38:40 INFO - ##### Finished clobber step (success) 11:38:40 INFO - ##### 11:38:40 INFO - ##### 11:38:40 INFO - ##### Running read-buildbot-config step. 11:38:40 INFO - ##### 11:38:40 INFO - Running pre-action listener: _resource_record_pre_action 11:38:40 INFO - Running main action method: read_buildbot_config 11:38:40 INFO - Using buildbot properties: 11:38:40 INFO - { 11:38:40 INFO - "project": "", 11:38:40 INFO - "product": "firefox", 11:38:40 INFO - "script_repo_revision": "production", 11:38:40 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 11:38:40 INFO - "repository": "", 11:38:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 11:38:40 INFO - "buildid": "20160715064309", 11:38:40 INFO - "pgo_build": "True", 11:38:40 INFO - "basedir": "/builds/slave/test", 11:38:40 INFO - "buildnumber": 1294, 11:38:40 INFO - "slavename": "talos-linux64-ix-053", 11:38:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:38:40 INFO - "platform": "ubuntu64_hw", 11:38:40 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 11:38:40 INFO - "branch": "mozilla-inbound", 11:38:40 INFO - "repo_path": "integration/mozilla-inbound", 11:38:40 INFO - "revision": "5a9c26f8bb9d599e80c92f6a7f30ad91bd54a854", 11:38:40 INFO - "stage_platform": "linux64-pgo", 11:38:40 INFO - "builduid": "c7b7f5c4fe1d41f4b73d9e5baffa9038", 11:38:40 INFO - "slavebuilddir": "test" 11:38:40 INFO - } 11:38:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:38:40 INFO - Running post-action listener: _resource_record_post_action 11:38:40 INFO - ##### 11:38:40 INFO - ##### Finished read-buildbot-config step (success) 11:38:40 INFO - ##### 11:38:40 INFO - ##### 11:38:40 INFO - ##### Running download-and-extract step. 11:38:40 INFO - ##### 11:38:40 INFO - Running pre-action listener: _resource_record_pre_action 11:38:40 INFO - Running main action method: download_and_extract 11:38:40 INFO - mkdir: /builds/slave/test/build/tests 11:38:40 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')]} 11:38:40 INFO - https://queue.taskcluster.net/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:38:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:38:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:38:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:38:41 INFO - Downloaded 1361 bytes. 11:38:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:38:41 INFO - Using the following test package requirements: 11:38:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:38:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:38:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:38:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:41 INFO - u'jsshell-linux-x86_64.zip'], 11:38:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:38:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:38:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:38:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:38:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:38:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:38:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:38:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:41 INFO - https://queue.taskcluster.net/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:38:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:38:42 INFO - Downloaded 24327512 bytes. 11:38:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:38:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:38:43 INFO - Return code: 0 11:38:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:38: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')]} 11:38:43 INFO - https://queue.taskcluster.net/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:38:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:38:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:38:44 INFO - Downloaded 24327512 bytes. 11:38:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:38:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:38:46 INFO - Return code: 0 11:38: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')]} 11:38:46 INFO - https://queue.taskcluster.net/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:38:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:38:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:38:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:38:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:38:47 INFO - Downloaded 14403317 bytes. 11:38:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:38:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:38:47 INFO - Return code: 0 11:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:47 INFO - https://queue.taskcluster.net/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:38:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:38:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:38:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:38:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:38:49 INFO - Downloaded 60817707 bytes. 11:38:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:38:49 INFO - mkdir: /builds/slave/test/properties 11:38:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:38:49 INFO - Writing to file /builds/slave/test/properties/build_url 11:38:49 INFO - Contents: 11:38:49 INFO - build_url:https://queue.taskcluster.net/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:38:50 INFO - Running post-action listener: _resource_record_post_action 11:38:50 INFO - Running post-action listener: set_extra_try_arguments 11:38:50 INFO - ##### 11:38:50 INFO - ##### Finished download-and-extract step (success) 11:38:50 INFO - ##### 11:38:50 INFO - ##### 11:38:50 INFO - ##### Running populate-webroot step. 11:38:50 INFO - ##### 11:38:50 INFO - Running pre-action listener: _resource_record_pre_action 11:38:50 INFO - Running main action method: populate_webroot 11:38:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:38:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:38:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:38:50 INFO - '--tppagecycles', 11:38:50 INFO - '7'], 11:38:50 INFO - 'tests': ['tsvgm']}}, 11:38:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:38:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:38:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:38:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:38:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:38:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:38:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'talos_options': ['--disable-e10s'], 11:38:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'talos_options': ['--disable-e10s'], 11:38:50 INFO - 'tests': ['damp', 'tps']}, 11:38:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'tests': ['damp', 'tps']}, 11:38:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:38:50 INFO - 'tests': ['dromaeo_dom']}, 11:38:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:38:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:38:50 INFO - 'tests': ['basic_compositor_video']}, 11:38:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:38:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:38:50 INFO - 'tests': ['a11yr', 11:38:50 INFO - 'ts_paint', 11:38:50 INFO - 'tpaint', 11:38:50 INFO - 'sessionrestore', 11:38:50 INFO - 'sessionrestore_no_auto_restore', 11:38:50 INFO - 'tabpaint']}, 11:38:50 INFO - 'other-e10s': {'tests': ['a11yr', 11:38:50 INFO - 'ts_paint', 11:38:50 INFO - 'tpaint', 11:38:50 INFO - 'sessionrestore', 11:38:50 INFO - 'sessionrestore_no_auto_restore', 11:38:50 INFO - 'tabpaint']}, 11:38:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:38:50 INFO - 'ts_paint', 11:38:50 INFO - 'tpaint', 11:38:50 INFO - 'sessionrestore', 11:38:50 INFO - 'sessionrestore_no_auto_restore', 11:38:50 INFO - 'tabpaint']}, 11:38:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:38:50 INFO - 'ts_paint', 11:38:50 INFO - 'tpaint', 11:38:50 INFO - 'sessionrestore', 11:38:50 INFO - 'sessionrestore_no_auto_restore', 11:38:50 INFO - 'tabpaint']}, 11:38:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:38:50 INFO - 'tests': ['a11yr', 11:38:50 INFO - 'ts_paint', 11:38:50 INFO - 'tpaint', 11:38:50 INFO - 'sessionrestore', 11:38:50 INFO - 'sessionrestore_no_auto_restore', 11:38:50 INFO - 'tabpaint']}, 11:38:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:38:50 INFO - 'tests': ['a11yr', 11:38:50 INFO - 'ts_paint', 11:38:50 INFO - 'tpaint', 11:38:50 INFO - 'sessionrestore', 11:38:50 INFO - 'sessionrestore_no_auto_restore', 11:38:50 INFO - 'tabpaint']}, 11:38:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:38:50 INFO - 'tests': ['tsvgx', 11:38:50 INFO - 'tsvgr_opacity', 11:38:50 INFO - 'tart', 11:38:50 INFO - 'tscrollx', 11:38:50 INFO - 'cart']}, 11:38:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:38:50 INFO - 'tsvgr_opacity', 11:38:50 INFO - 'tart', 11:38:50 INFO - 'tscrollx', 11:38:50 INFO - 'cart']}, 11:38:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'talos_options': ['--disable-e10s'], 11:38:50 INFO - 'tests': ['tp5o']}, 11:38:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'tests': ['tp5o']}, 11:38:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'talos_options': ['--disable-e10s', 11:38:50 INFO - '--xperf_path', 11:38:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:50 INFO - 'tests': ['tp5n']}, 11:38:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'talos_options': ['--xperf_path', 11:38:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:50 INFO - 'tests': ['tp5n']}}, 11:38:50 INFO - 'talos.zip': {'path': '', 11:38:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:38:50 INFO - Running post-action listener: _resource_record_post_action 11:38:50 INFO - ##### 11:38:50 INFO - ##### Finished populate-webroot step (success) 11:38:50 INFO - ##### 11:38:50 INFO - ##### 11:38:50 INFO - ##### Running create-virtualenv step. 11:38:50 INFO - ##### 11:38:50 INFO - Running pre-action listener: _resource_record_pre_action 11:38:50 INFO - Running main action method: create_virtualenv 11:38:50 INFO - Creating virtualenv /builds/slave/test/build/venv 11:38:50 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 11:38:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:38:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:38:50 INFO - Using real prefix '/usr' 11:38:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:38:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:38:53 INFO - Installing pip.................done. 11:38:53 INFO - Return code: 0 11:38:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:53 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 0xeb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176570>, '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 0x1177470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177900>, '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': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', '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 11:38:53 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 11:38:53 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 11:38:53 INFO - Using env: {'DISPLAY': ':0', 11:38:53 INFO - 'HOME': '/home/cltbld', 11:38:53 INFO - 'LANG': 'en_US.UTF-8', 11:38:53 INFO - 'LANGUAGE': 'en_US:en', 11:38:53 INFO - 'LOGNAME': 'cltbld', 11:38:53 INFO - 'MAIL': '/var/mail/cltbld', 11:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:53 INFO - 'MOZ_NO_REMOTE': '1', 11:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:53 INFO - 'NO_EM_RESTART': '1', 11:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:53 INFO - 'PWD': '/builds/slave/test', 11:38:53 INFO - 'SHELL': '/bin/bash', 11:38:53 INFO - 'SHLVL': '1', 11:38:53 INFO - 'TERM': 'linux', 11:38:53 INFO - 'TMOUT': '86400', 11:38:53 INFO - 'USER': 'cltbld', 11:38:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', 11:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:53 INFO - '_': '/tools/buildbot/bin/python'} 11:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:53 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 11:38:53 INFO - Cleaning up... 11:38:53 INFO - Return code: 0 11:38:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:53 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176570>, '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 0x1177470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177900>, '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': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', '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 11:38:53 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>=3.1.1'] in /builds/slave/test/build 11:38:53 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>=3.1.1 11:38:53 INFO - Using env: {'DISPLAY': ':0', 11:38:53 INFO - 'HOME': '/home/cltbld', 11:38:53 INFO - 'LANG': 'en_US.UTF-8', 11:38:53 INFO - 'LANGUAGE': 'en_US:en', 11:38:53 INFO - 'LOGNAME': 'cltbld', 11:38:53 INFO - 'MAIL': '/var/mail/cltbld', 11:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:53 INFO - 'MOZ_NO_REMOTE': '1', 11:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:53 INFO - 'NO_EM_RESTART': '1', 11:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:53 INFO - 'PWD': '/builds/slave/test', 11:38:53 INFO - 'SHELL': '/bin/bash', 11:38:53 INFO - 'SHLVL': '1', 11:38:53 INFO - 'TERM': 'linux', 11:38:53 INFO - 'TMOUT': '86400', 11:38:53 INFO - 'USER': 'cltbld', 11:38:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', 11:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:53 INFO - '_': '/tools/buildbot/bin/python'} 11:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:53 INFO - Downloading/unpacking psutil>=3.1.1 11:38:53 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 11:38:53 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 11:38:53 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 11:38:53 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 11:38:53 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 11:38:53 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 11:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:38:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:55 INFO - Installing collected packages: psutil 11:38:55 INFO - Running setup.py install for psutil 11:38:55 INFO - building 'psutil._psutil_linux' extension 11:38:55 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 11:38:55 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 11:38:55 INFO - building 'psutil._psutil_posix' extension 11:38:55 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 11:38:56 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 11:38:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:56 INFO - Successfully installed psutil 11:38:56 INFO - Cleaning up... 11:38:56 INFO - Return code: 0 11:38:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:38:56 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')]} 11:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:56 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')]} 11:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:56 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176570>, '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 0x1177470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177900>, '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': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', '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 11:38:56 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.3'] in /builds/slave/test/build 11:38:56 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.3 11:38:56 INFO - Using env: {'DISPLAY': ':0', 11:38:56 INFO - 'HOME': '/home/cltbld', 11:38:56 INFO - 'LANG': 'en_US.UTF-8', 11:38:56 INFO - 'LANGUAGE': 'en_US:en', 11:38:56 INFO - 'LOGNAME': 'cltbld', 11:38:56 INFO - 'MAIL': '/var/mail/cltbld', 11:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:56 INFO - 'MOZ_NO_REMOTE': '1', 11:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:56 INFO - 'NO_EM_RESTART': '1', 11:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:56 INFO - 'PWD': '/builds/slave/test', 11:38:56 INFO - 'SHELL': '/bin/bash', 11:38:56 INFO - 'SHLVL': '1', 11:38:56 INFO - 'TERM': 'linux', 11:38:56 INFO - 'TMOUT': '86400', 11:38:56 INFO - 'USER': 'cltbld', 11:38:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', 11:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:56 INFO - '_': '/tools/buildbot/bin/python'} 11:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:38:58 INFO - Installing collected packages: mozsystemmonitor 11:38:58 INFO - Running setup.py install for mozsystemmonitor 11:38:58 INFO - Successfully installed mozsystemmonitor 11:38:58 INFO - Cleaning up... 11:38:58 INFO - Return code: 0 11:38:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:58 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176570>, '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 0x1177470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177900>, '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': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', '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 11:38:58 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==2.5.1'] in /builds/slave/test/build 11:38:58 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==2.5.1 11:38:58 INFO - Using env: {'DISPLAY': ':0', 11:38:58 INFO - 'HOME': '/home/cltbld', 11:38:58 INFO - 'LANG': 'en_US.UTF-8', 11:38:58 INFO - 'LANGUAGE': 'en_US:en', 11:38:58 INFO - 'LOGNAME': 'cltbld', 11:38:58 INFO - 'MAIL': '/var/mail/cltbld', 11:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:58 INFO - 'MOZ_NO_REMOTE': '1', 11:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:58 INFO - 'NO_EM_RESTART': '1', 11:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:58 INFO - 'PWD': '/builds/slave/test', 11:38:58 INFO - 'SHELL': '/bin/bash', 11:38:58 INFO - 'SHLVL': '1', 11:38:58 INFO - 'TERM': 'linux', 11:38:58 INFO - 'TMOUT': '86400', 11:38:58 INFO - 'USER': 'cltbld', 11:38:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', 11:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:58 INFO - '_': '/tools/buildbot/bin/python'} 11:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:58 INFO - Downloading/unpacking jsonschema==2.5.1 11:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:39:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:39:00 INFO - warning: no files found matching '*.txt' 11:39:00 INFO - no previously-included directories found matching 'build' 11:39:00 INFO - no previously-included directories found matching 'dist' 11:39:00 INFO - no previously-included directories found matching '.git*' 11:39:01 INFO - Installing collected packages: jsonschema, functools32 11:39:01 INFO - Running setup.py install for functools32 11:39:01 INFO - warning: no files found matching '*.txt' 11:39:01 INFO - no previously-included directories found matching 'build' 11:39:01 INFO - no previously-included directories found matching 'dist' 11:39:01 INFO - no previously-included directories found matching '.git*' 11:39:01 INFO - Successfully installed jsonschema functools32 11:39:01 INFO - Cleaning up... 11:39:01 INFO - Return code: 0 11:39:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:01 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 0xeb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176570>, '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 0x1177470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177900>, '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': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', '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 11:39:01 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 11:39:01 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 11:39:01 INFO - Using env: {'DISPLAY': ':0', 11:39:01 INFO - 'HOME': '/home/cltbld', 11:39:01 INFO - 'LANG': 'en_US.UTF-8', 11:39:01 INFO - 'LANGUAGE': 'en_US:en', 11:39:01 INFO - 'LOGNAME': 'cltbld', 11:39:01 INFO - 'MAIL': '/var/mail/cltbld', 11:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:01 INFO - 'MOZ_NO_REMOTE': '1', 11:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:01 INFO - 'NO_EM_RESTART': '1', 11:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:01 INFO - 'PWD': '/builds/slave/test', 11:39:01 INFO - 'SHELL': '/bin/bash', 11:39:01 INFO - 'SHLVL': '1', 11:39:01 INFO - 'TERM': 'linux', 11:39:01 INFO - 'TMOUT': '86400', 11:39:01 INFO - 'USER': 'cltbld', 11:39:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', 11:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:01 INFO - '_': '/tools/buildbot/bin/python'} 11:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:01 INFO - Downloading/unpacking blobuploader==1.2.4 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:03 INFO - Downloading blobuploader-1.2.4.tar.gz 11:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:39:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:39:03 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 11:39:03 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 11:39:03 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 11:39:03 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 11:39:03 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 11:39:03 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 11:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:39:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:39:03 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 11:39:03 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 11:39:03 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 11:39:03 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 11:39:03 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 11:39:03 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 11:39:04 INFO - Downloading docopt-0.6.1.tar.gz 11:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:39:04 INFO - Installing collected packages: blobuploader, requests, docopt 11:39:04 INFO - Running setup.py install for blobuploader 11:39:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:39:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:39:04 INFO - Running setup.py install for requests 11:39:04 INFO - Running setup.py install for docopt 11:39:04 INFO - Successfully installed blobuploader requests docopt 11:39:04 INFO - Cleaning up... 11:39:04 INFO - Return code: 0 11:39:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:04 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 0xeb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176570>, '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 0x1177470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177900>, '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': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', '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 11:39:04 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 11:39:04 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 11:39:04 INFO - Using env: {'DISPLAY': ':0', 11:39:04 INFO - 'HOME': '/home/cltbld', 11:39:04 INFO - 'LANG': 'en_US.UTF-8', 11:39:04 INFO - 'LANGUAGE': 'en_US:en', 11:39:04 INFO - 'LOGNAME': 'cltbld', 11:39:04 INFO - 'MAIL': '/var/mail/cltbld', 11:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:04 INFO - 'MOZ_NO_REMOTE': '1', 11:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:04 INFO - 'NO_EM_RESTART': '1', 11:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:04 INFO - 'PWD': '/builds/slave/test', 11:39:04 INFO - 'SHELL': '/bin/bash', 11:39:04 INFO - 'SHLVL': '1', 11:39:04 INFO - 'TERM': 'linux', 11:39:04 INFO - 'TMOUT': '86400', 11:39:04 INFO - 'USER': 'cltbld', 11:39:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', 11:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:04 INFO - '_': '/tools/buildbot/bin/python'} 11:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:04 INFO - Running setup.py (path:/tmp/pip-0aDezP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:04 INFO - Running setup.py (path:/tmp/pip-9uEPCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:05 INFO - Running setup.py (path:/tmp/pip-O6OuOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:05 INFO - Running setup.py (path:/tmp/pip-L1E4hX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:05 INFO - Running setup.py (path:/tmp/pip-gZts24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:05 INFO - Running setup.py (path:/tmp/pip-0ELmtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:05 INFO - Running setup.py (path:/tmp/pip-PICvT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:05 INFO - Running setup.py (path:/tmp/pip-DtMwyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:05 INFO - Running setup.py (path:/tmp/pip-eBckU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:05 INFO - Running setup.py (path:/tmp/pip-jYB7Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:05 INFO - Running setup.py (path:/tmp/pip-kHSLj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:05 INFO - Running setup.py (path:/tmp/pip-uwuR0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:05 INFO - Running setup.py (path:/tmp/pip-BHrPXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:05 INFO - Running setup.py (path:/tmp/pip-ykbVI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:05 INFO - Running setup.py (path:/tmp/pip-PHgcNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:05 INFO - Running setup.py (path:/tmp/pip-uK6rdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:06 INFO - Running setup.py (path:/tmp/pip-McJ7r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:39:06 INFO - Running setup.py install for manifestparser 11:39:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Running setup.py install for mozcrash 11:39:06 INFO - Running setup.py install for mozdebug 11:39:06 INFO - Running setup.py install for mozdevice 11:39:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Running setup.py install for mozfile 11:39:06 INFO - Running setup.py install for mozhttpd 11:39:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Running setup.py install for mozinfo 11:39:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Running setup.py install for mozInstall 11:39:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:39:06 INFO - Running setup.py install for mozleak 11:39:07 INFO - Running setup.py install for mozlog 11:39:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:39:07 INFO - Running setup.py install for moznetwork 11:39:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:39:07 INFO - Running setup.py install for mozprocess 11:39:07 INFO - Running setup.py install for mozprofile 11:39:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:39:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:39:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:39:07 INFO - Running setup.py install for mozrunner 11:39:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:39:07 INFO - Running setup.py install for mozscreenshot 11:39:07 INFO - Running setup.py install for moztest 11:39:07 INFO - Running setup.py install for mozversion 11:39:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:39:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:39:07 INFO - Cleaning up... 11:39:07 INFO - Return code: 0 11:39:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:07 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 0xeb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176570>, '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 0x1177470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177900>, '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': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', '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 11:39:07 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 11:39:07 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 11:39:07 INFO - Using env: {'DISPLAY': ':0', 11:39:07 INFO - 'HOME': '/home/cltbld', 11:39:07 INFO - 'LANG': 'en_US.UTF-8', 11:39:07 INFO - 'LANGUAGE': 'en_US:en', 11:39:07 INFO - 'LOGNAME': 'cltbld', 11:39:07 INFO - 'MAIL': '/var/mail/cltbld', 11:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:07 INFO - 'MOZ_NO_REMOTE': '1', 11:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:07 INFO - 'NO_EM_RESTART': '1', 11:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:07 INFO - 'PWD': '/builds/slave/test', 11:39:07 INFO - 'SHELL': '/bin/bash', 11:39:07 INFO - 'SHLVL': '1', 11:39:07 INFO - 'TERM': 'linux', 11:39:07 INFO - 'TMOUT': '86400', 11:39:07 INFO - 'USER': 'cltbld', 11:39:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', 11:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:07 INFO - '_': '/tools/buildbot/bin/python'} 11:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:08 INFO - Running setup.py (path:/tmp/pip-gVQPOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:08 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)) 11:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:08 INFO - Running setup.py (path:/tmp/pip-mBaknY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:08 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)) 11:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:08 INFO - Running setup.py (path:/tmp/pip-zk59VK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:08 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)) 11:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:08 INFO - Running setup.py (path:/tmp/pip-CxGqB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:08 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)) 11:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:08 INFO - Running setup.py (path:/tmp/pip-vwcw9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:08 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)) 11:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:08 INFO - Running setup.py (path:/tmp/pip-jHc1jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:08 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)) 11:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:08 INFO - Running setup.py (path:/tmp/pip-5KFS5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:08 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)) 11:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:08 INFO - Running setup.py (path:/tmp/pip-SGLzER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:08 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)) 11:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:08 INFO - Running setup.py (path:/tmp/pip-ouXSeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:08 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)) 11:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:08 INFO - Running setup.py (path:/tmp/pip-beEWsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 11:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:08 INFO - Running setup.py (path:/tmp/pip-7gOZAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:08 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)) 11:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:08 INFO - Running setup.py (path:/tmp/pip-OwbECr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 11:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:09 INFO - Running setup.py (path:/tmp/pip-NttvcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:09 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)) 11:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:09 INFO - Running setup.py (path:/tmp/pip-cNgqIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 11:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:09 INFO - Running setup.py (path:/tmp/pip-OsCGZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:09 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)) 11:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:09 INFO - Running setup.py (path:/tmp/pip-tkVci_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:09 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)) 11:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:09 INFO - Running setup.py (path:/tmp/pip-6iCO0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:09 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)) 11:39:09 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)) 11:39:09 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)) 11:39:09 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)) 11:39:09 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)) 11:39:09 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)) 11:39:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:39:09 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 11:39:09 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 11:39:09 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 11:39:09 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 11:39:09 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 11:39:09 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 11:39:11 INFO - Downloading blessings-1.6.tar.gz 11:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:39:11 INFO - Installing collected packages: blessings 11:39:11 INFO - Running setup.py install for blessings 11:39:11 INFO - Successfully installed blessings 11:39:11 INFO - Cleaning up... 11:39:11 INFO - Return code: 0 11:39:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:39:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:11 INFO - Reading from file tmpfile_stdout 11:39:11 INFO - Current package versions: 11:39:11 INFO - argparse == 1.2.1 11:39:11 INFO - blessings == 1.6 11:39:11 INFO - blobuploader == 1.2.4 11:39:11 INFO - docopt == 0.6.1 11:39:11 INFO - functools32 == 3.2.3-2 11:39:11 INFO - jsonschema == 2.5.1 11:39:11 INFO - manifestparser == 1.1 11:39:11 INFO - mozInstall == 1.12 11:39:11 INFO - mozcrash == 0.17 11:39:11 INFO - mozdebug == 0.1 11:39:11 INFO - mozdevice == 0.48 11:39:11 INFO - mozfile == 1.2 11:39:11 INFO - mozhttpd == 0.7 11:39:11 INFO - mozinfo == 0.9 11:39:11 INFO - mozleak == 0.1 11:39:11 INFO - mozlog == 3.2 11:39:11 INFO - moznetwork == 0.27 11:39:11 INFO - mozprocess == 0.23 11:39:11 INFO - mozprofile == 0.28 11:39:11 INFO - mozrunner == 6.12 11:39:11 INFO - mozscreenshot == 0.1 11:39:11 INFO - mozsystemmonitor == 0.3 11:39:11 INFO - moztest == 0.7 11:39:11 INFO - mozversion == 1.4 11:39:11 INFO - psutil == 3.1.1 11:39:11 INFO - requests == 1.2.3 11:39:11 INFO - wsgiref == 0.1.2 11:39:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:11 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 0xeb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176570>, '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 0x1177470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177900>, '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': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', '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 11:39:11 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 11:39:11 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 11:39:11 INFO - Using env: {'DISPLAY': ':0', 11:39:11 INFO - 'HOME': '/home/cltbld', 11:39:11 INFO - 'LANG': 'en_US.UTF-8', 11:39:11 INFO - 'LANGUAGE': 'en_US:en', 11:39:11 INFO - 'LOGNAME': 'cltbld', 11:39:11 INFO - 'MAIL': '/var/mail/cltbld', 11:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:11 INFO - 'MOZ_NO_REMOTE': '1', 11:39:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:11 INFO - 'NO_EM_RESTART': '1', 11:39:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:11 INFO - 'PWD': '/builds/slave/test', 11:39:11 INFO - 'SHELL': '/bin/bash', 11:39:11 INFO - 'SHLVL': '1', 11:39:11 INFO - 'TERM': 'linux', 11:39:11 INFO - 'TMOUT': '86400', 11:39:11 INFO - 'USER': 'cltbld', 11:39:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', 11:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:11 INFO - '_': '/tools/buildbot/bin/python'} 11:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:11 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)) 11:39:11 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)) 11:39:11 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)) 11:39:11 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)) 11:39:11 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)) 11:39:11 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)) 11:39:11 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)) 11:39:11 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)) 11:39:11 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)) 11:39:11 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)) 11:39:11 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)) 11:39:11 INFO - Cleaning up... 11:39:11 INFO - Return code: 0 11:39:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176570>, '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 0x1177470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177900>, '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': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', '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 11:39:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:39:11 INFO - Using env: {'DISPLAY': ':0', 11:39:11 INFO - 'HOME': '/home/cltbld', 11:39:11 INFO - 'LANG': 'en_US.UTF-8', 11:39:11 INFO - 'LANGUAGE': 'en_US:en', 11:39:11 INFO - 'LOGNAME': 'cltbld', 11:39:11 INFO - 'MAIL': '/var/mail/cltbld', 11:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:11 INFO - 'MOZ_NO_REMOTE': '1', 11:39:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:11 INFO - 'NO_EM_RESTART': '1', 11:39:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:11 INFO - 'PWD': '/builds/slave/test', 11:39:11 INFO - 'SHELL': '/bin/bash', 11:39:11 INFO - 'SHLVL': '1', 11:39:11 INFO - 'TERM': 'linux', 11:39:11 INFO - 'TMOUT': '86400', 11:39:11 INFO - 'USER': 'cltbld', 11:39:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', 11:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:11 INFO - '_': '/tools/buildbot/bin/python'} 11:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:39:12 INFO - Cleaning up... 11:39:12 INFO - Return code: 0 11:39:12 INFO - Running post-action listener: _resource_record_post_action 11:39:12 INFO - Running post-action listener: _start_resource_monitoring 11:39:12 INFO - Starting resource monitoring. 11:39:12 INFO - ##### 11:39:12 INFO - ##### Finished create-virtualenv step (success) 11:39:12 INFO - ##### 11:39:12 INFO - ##### 11:39:12 INFO - ##### Running install step. 11:39:12 INFO - ##### 11:39:12 INFO - Running pre-action listener: _resource_record_pre_action 11:39:12 INFO - Running main action method: install 11:39:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:12 INFO - Reading from file tmpfile_stdout 11:39:12 INFO - Detecting whether we're running mozinstall >=1.0... 11:39:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:39:12 INFO - Reading from file tmpfile_stdout 11:39:12 INFO - Output received: 11:39:12 INFO - Usage: mozinstall [options] installer 11:39:12 INFO - Options: 11:39:12 INFO - -h, --help show this help message and exit 11:39:12 INFO - -d DEST, --destination=DEST 11:39:12 INFO - Directory to install application into. [default: 11:39:12 INFO - "/builds/slave/test"] 11:39:12 INFO - --app=APP Application being installed. [default: firefox] 11:39:12 INFO - mkdir: /builds/slave/test/build/application 11:39:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:39:29 INFO - Reading from file tmpfile_stdout 11:39:29 INFO - Output received: 11:39:29 INFO - /builds/slave/test/build/application/firefox/firefox 11:39:29 INFO - Running post-action listener: _resource_record_post_action 11:39:29 INFO - ##### 11:39:29 INFO - ##### Finished install step (success) 11:39:29 INFO - ##### 11:39:29 INFO - ##### 11:39:29 INFO - ##### Running run-tests step. 11:39:29 INFO - ##### 11:39:29 INFO - Running pre-action listener: _resource_record_pre_action 11:39:29 INFO - Running main action method: run_tests 11:39:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:39:29 INFO - Python 2.7.3 11:39:29 INFO - Return code: 0 11:39:29 INFO - grabbing minidump binary from tooltool 11:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:29 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176570>, '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 0x1177470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:39:29 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 11:39:29 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 11:39:29 INFO - Calling ['/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'] with output_timeout 600 11:39:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:39:29 INFO - Return code: 0 11:39:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:39:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:39:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:39:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:39:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:39:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:39:29 INFO - Using env: {'DISPLAY': ':0', 11:39:29 INFO - 'HOME': '/home/cltbld', 11:39:29 INFO - 'LANG': 'en_US.UTF-8', 11:39:29 INFO - 'LANGUAGE': 'en_US:en', 11:39:29 INFO - 'LOGNAME': 'cltbld', 11:39:29 INFO - 'MAIL': '/var/mail/cltbld', 11:39:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:39:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:29 INFO - 'MOZ_NO_REMOTE': '1', 11:39:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:29 INFO - 'NO_EM_RESTART': '1', 11:39:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:29 INFO - 'PWD': '/builds/slave/test', 11:39:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:39:29 INFO - 'SHELL': '/bin/bash', 11:39:29 INFO - 'SHLVL': '1', 11:39:29 INFO - 'TERM': 'linux', 11:39:29 INFO - 'TMOUT': '86400', 11:39:29 INFO - 'USER': 'cltbld', 11:39:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912', 11:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:29 INFO - '_': '/tools/buildbot/bin/python'} 11:39:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:39:30 INFO - mozversion application_buildid: 20160715064309 11:39:30 INFO - mozversion application_changeset: 5a9c26f8bb9d599e80c92f6a7f30ad91bd54a854 11:39:30 INFO - mozversion application_display_name: Nightly 11:39:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:39:30 INFO - mozversion application_name: Firefox 11:39:30 INFO - mozversion application_remotingname: firefox 11:39:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:39:30 INFO - mozversion application_vendor: Mozilla 11:39:30 INFO - mozversion application_version: 50.0a1 11:39:30 INFO - mozversion platform_buildid: 20160715064309 11:39:30 INFO - mozversion platform_changeset: 5a9c26f8bb9d599e80c92f6a7f30ad91bd54a854 11:39:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:39:30 INFO - mozversion platform_version: 50.0a1 11:39:30 INFO - using testdate: 1468607970 11:39:30 INFO - actual date: 1468607970 11:39:30 INFO - starting webserver on 'localhost:45115' 11:39:30 INFO - SUITE-START | Running 2 tests 11:39:30 INFO - TEST-START | dromaeo_css 11:39:30 INFO - operating with platform_type : linux_ 11:39:30 INFO - Initialising browser for dromaeo_css test... 11:39:30 INFO - TEST-INFO | started process 30549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHfj7qu/profile http://localhost:45115/getInfo.html) 11:39:35 INFO - PROCESS | 30549 | __metrics Screen width/height:1600/1200 11:39:35 INFO - PROCESS | 30549 | colorDepth:24 11:39:35 INFO - PROCESS | 30549 | Browser inner width/height: 1024/697 11:39:35 INFO - PROCESS | 30549 | __metrics 11:39:35 ERROR - PROCESS | 30549 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 11:39:36 INFO - TEST-INFO | 30549: exit 0 11:39:36 INFO - Browser initialized. 11:39:36 INFO - Running cycle 1/1 for dromaeo_css test... 11:39:36 INFO - TEST-INFO | started process 30667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHfj7qu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:39:48 INFO - PROCESS | 30667 | RSS: Main: 168075264 11:39:48 INFO - PROCESS | 30667 | 11:40:37 INFO - PROCESS | 30667 | 1468608037980 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] 11:42:45 INFO - PROCESS | 30667 | Cycle 1(1): loaded http://localhost:45115/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45115/tests/dromaeo/cssquery-ext.html) 11:42:46 INFO - PROCESS | 30667 | RSS: Main: 172060672 11:42:46 INFO - PROCESS | 30667 | 11:45:48 INFO - PROCESS | 30667 | Cycle 1(1): loaded http://localhost:45115/tests/dromaeo/cssquery-ext.html (next: http://localhost:45115/tests/dromaeo/cssquery-jquery.html) 11:45:49 INFO - PROCESS | 30667 | RSS: Main: 169320448 11:45:49 INFO - PROCESS | 30667 | 11:48:50 INFO - PROCESS | 30667 | Cycle 1(1): loaded http://localhost:45115/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45115/tests/dromaeo/cssquery-mootools.html) 11:48:51 INFO - PROCESS | 30667 | RSS: Main: 172457984 11:48:51 INFO - PROCESS | 30667 | 11:51:53 INFO - PROCESS | 30667 | Cycle 1(1): loaded http://localhost:45115/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45115/tests/dromaeo/cssquery-prototype.html) 11:51:53 INFO - PROCESS | 30667 | RSS: Main: 167460864 11:51:53 INFO - PROCESS | 30667 | 11:54:56 INFO - PROCESS | 30667 | Cycle 1(1): loaded http://localhost:45115/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45115/tests/dromaeo/cssquery-yui.html) 11:54:57 INFO - PROCESS | 30667 | RSS: Main: 169377792 11:54:57 INFO - PROCESS | 30667 | 11:57:59 INFO - PROCESS | 30667 | Cycle 1(1): loaded http://localhost:45115/tests/dromaeo/cssquery-yui.html (next: http://localhost:45115/tests/dromaeo/cssquery-dojo.html) 11:57:59 INFO - PROCESS | 30667 | RSS: Main: 170401792 11:57:59 INFO - PROCESS | 30667 | 11:57:59 INFO - PROCESS | 30667 | __start_tp_report 11:57:59 INFO - PROCESS | 30667 | _x_x_mozilla_page_load 11:57:59 INFO - PROCESS | 30667 | _x_x_mozilla_page_load_details 11:57:59 INFO - PROCESS | 30667 | |i|pagename|runs| 11:57:59 INFO - PROCESS | 30667 | |0;dojo.html;3082.38352329534;3097.767667424943;3098;3108.766842486811;3116.5481005254237;5341.839744807658;5368.973155134224;5383.407825139231;5405.702686352249;5482.177673349;5380.192971054344;5421.756020979055;5423.240746295522;5473.890522189554;5501.504864562188;4927.3101765752735;4960.603151747851;5053.343065401493;5109.718965456898;5155.896882062375;556.8614696214821;4908.558229759321;4915.5821755150855;4951.331570238008;5101;4862.246351815456;4906.264060390952;4914.385701787277;4921.753912304406;4934.333864928242;4917.188663870457;4932.087563800708;4936.5063493650705;4941.382327209099;4951.158303088484;4872.537108974677;4897.681650692729;4914.213725803854;4921;4942.0610084084265;5336.59975501835;5353.2237825515085;5397.7031263280505;5405.18922161675;5408.2698835657075;5663.886722265573;5711.828645140652;5862.853428664275;5890.263717035371;5897.439743224387;5773.740181691792;5820.88358232833;5832.62087964281;5843.53251739864;5905.911411328791;5388.865278368033;5398.163284690879;5403.78384864605;5422;5458.5087342139;5804.071348584206;5855.707214639251;5868.501177399883;5927.377625349276;5975.731092100779;5649.237352957298;5655.349634791969;5674.26234589509;5686.829395118153;5720.828375148669;5782.6819524925695;5783.843231353662;5784.797532086357;5786.971065144648;5797.043487824546;5700.4869561738815;5710.428957104256;5724.284464441945;5729.226554415184;5781.913271300934;5740.712964351766;5771.365149833515;5772.451617096369;5775.88448231033;5775.884482310415;4351.042770590465;4416.1609294233995;4432.84485043022;4438.511763705989;4459.9331010034875;3851.2490064437166;3934.488516492838;3951.1702542465828;3965.0285680008583;4009.398590211433;5402.567794576425;5529.944700553024;5547.750351234205;5576.386597474275;5590.776368945197;5832.825015249549;5906.291245050621;5913.408659134138;5917.940820591825;5932.851678707981;5364.6512976656395;5555.111182210908;5560.944390556043;5595.916061259084;5649.858753531194;4938.604911607063;4940.382452193476;4944.802207911644;4948.975255123773;4998.02538504988;6059.666718330446;6062.211912451441;6063.211782468251;6068.6358818471035;6071.605345652607;5731.398203188689;5839.270091238595;5864.589478736618;5884.58807883444;5891.94108058931;6063.757449701962;6074.7266373012435;6093.238345206849;6113.633182009094;6126.050462178369;5677.034904066401;5806.622569532967;5810.912836307374;5816.389279125631;5819;5864.912026319524;5893.616914900518;5911.793087241926;5949.791757288647;5950.761969521343;5749.97125014389;5801.216835727123;5804.303483581997;5808.82573522795;5839.124131380327;5682.176084467646;5683.9715801420725;5791.8552036199435;5809;5826;5594.496495315441;5646.181303711021;5682.460166284196;5685.204071430086;5718.599698021098;5670.149477578396;5711.857203569944;5719.685417302088;5751.856203594776;5757.798477053283;5453.045716999589;5615.354234263112;5617.045102332531;5625.46558076982;5632.295963004624 11:57:59 INFO - PROCESS | 30667 | |1;ext.html;560.6355868685354;598.0938877600433;598.963792638735;613.99693001535;648.1541588227361;39510.209795804105;43640.781796090974;43792.12415751683;43849.78075109624;43919.78040109803;42777.78611106948;43264.78367608158;43267;43275.10524052835;43290;8897.1102889711;9064.45613263203;9069.229115525188;9079.682211122612;9083.545822708871;8930.37487375884;8988.191062804346;9004.054574269705;9050.140236677506;9084.8637270441;9040.638374465014;9083.31875109366;9121.042290559495;9135.451872887616;9158.542072896362;9061.864072038925;9076.63693452261;9106.453612783222;9116.31627627924;9127.315451341176;8814.823703525957;8844.159804818531;8908;8916.643334266622;8949.865752013726;33196.834015830005;40928.1814363714;41151.38272925879;41454.58545414568;41469.37795933033;3410.4543273076188;3537.8054207018604;3588.784672919633;3624.58317293512;3646.908827279313;31657.309128724086;32311.51532727011;32369.190770230696;32378.514322285184;32705.836470817732;4307.935380969288;4357.542458041891;4385.51759306476;4391.253486907233;4465.866024019252;305073;308262;309385;309415;309672;34360.65639343624;34681.30637387238;35104;35115;35116.29767404689;35176.64823351785;36438.27123457569;36619.63380366215;36632.08419789527;36670;15556.533304000897;15742.212889355487;15764.842351576337;15781.921090394475;15823;13088.476460941456;13272.070955033249;13274.66813329655;13279.402426890812;13291.20252784836;8228.053773815967;8236.176382361717;8250.298724608476;8295.419320647617;8343.123971982975;3119.554634645621;3183.7453003759642;3200.9679903201136;3203.5034569641743;3232.725218356419;1080.287010573018;1116.9329840209614;1188.9108316876268;1195.0499353014375;1204.1871736577775;33555.664443355745;34000.48999265013;34097;34100.31799363999;34578.30843383118;1102.3496137279044;1102.873169585492;1139.8917102875214;1160.031373802884;1165.452237448398;16837.747433788503;17843.553911152325;17945;17961.820381796013;18076.548086297684;556884;558870;559805;560937;561956;40984.975375615846;40986.59013409887;41057;41121.58878411238;41241.79379103145;1325.754735373959;1334.5662659635657;1356.7354365898555;1374.4983081175299;1384.9861501385058;32526.674733253312;33578;33667.83166084154;34046.65953340435;34343.82828085843;53818;57576;59445.405545943984;59573.702131489066;62316.37683623106;504542;505313;507351;507869;508558;45067.09865802731;45769.31346029745;45946;46223;46416.76791616021;49653.25520117273;50320.24519632135;50601;50829.745851270505;50994;42787.78606107074;43697.344539832564;44027.33958990682;44200.33699494446;45280.09439811251;42906.78546607247;43374.132517348844;43558.56441435545;43712;43719.34420983624;39510.604893951844;42940;43153.56846431496;43326.350104749086;44173.55826441823;35995;38799.224015518965;39294.41058384184;40346.59653403428;41399.7930010348;29318.56022159712;29717.85141074281;29956.400871982874;30051.849740751157;30061 11:57:59 INFO - PROCESS | 30667 | |2;jquery.html;385.45650632607993;386.5593223724954;388.4076782906066;392.17642949805406;413.46249875162283;18805.71791423128;20357.694634580475;20374.490637734063;20691.172353105896;20889.791102089013;20100.59798804023;20122.899385503053;20184.59630807383;20660.276890308844;20888.373348799523;5498.257735205756;5528.695921724304;5799.768009279624;5866.296044474648;5870.26621672291;5745.683987380692;5779.248697669297;5962.314333851597;6354.3010268870385;6357.046443033536;6205.9379406206035;6340.23917129945;6368.395002474757;6379.234491860983;6553.475721942257;5896.823095307148;5975.223220981245;5975.940240597582;5990.311114221855;6036.909446358308;5768.221290125821;5803.245578074865;5824.446677565625;5831.825045248649;5838.678872662002;23228;23711.525769484513;24357.51284974308;24483.387915302083;24623.630645540332;2304.9078036878504;2312.0405031911737;2392.9162479313313;2652.4429869727383;3047.9085627431214;9948.154406875425;10152.39085654863;10209.2853500255;10275.48622568876;10526.842097368546;1950.161430584848;2001.9699704504444;2025.4430031741242;2034.5829105033433;2068.400163952452;86071.56964215201;87790.99999999936;89499;90837.54581227117;91619.08380916172;10857.51141198648;11061.391623460626;11127.5534180556;11232.10143188543;11262.931680743699;15299.694006119815;15464.845351546566;15604.843951560339;15625;15639.530814075595;8191.590420479071;8356.289715374262;8387.161283871565;8523.74428767138;8527.829443411098;8126.228008339198;8143;8165.183481651788;8280.627371768285;8360.58197090143;4697.4832768395445;4752.597983594847;4786.305985632064;4790.449098353664;4917.065757506062;1935.8451323894337;1951.5121219695077;1964.7052942058806;1980.2178139635053;1985.8510611703891;976.1751320134475;991.1971303244395;1000.564754331868;1069.9304545204536;1071.3732466507024;19454.90272548628;20188.798112018987;20720.58558828815;20958.056887440103;21464.892675536834;1003.9949800250952;1009.3388830316155;1065.7868426314767;1079.6760971708457;1084.4631907205983;11122.22144449897;11665.591704290478;11780.646580602424;11868.76262474763;11906.880931190577;538236.7793449304;540599;543199;546267;565972;80126;87476.56261718778;89653.55173224091;102752.48623756833;105444;1038.6105210546045;1065.1851333729703;1071.196602548089;1077.278223590212;1079.9676009719565;18796;18900.243990240237;19522.414327570197;19594;19691;43352.13295734004;43438.782806085765;43950.12099757923;44096.779516102215;44618.330725038504;58905;60303.39696602978;61092.38907610867;61392.69303653453;62067.37932620616;8671.739847804576;8686.91313086861;8757.562121894007;8912.242459391024;8983.910160898307;11409.657710268706;12788.488460461478;12881.484740610646;12904.8064279034;12947;10393.37639741618;11140.554377825121;11384.37385943781;11551.88448115508;11740.530378784753;10459.110975567162;11175.72060698489;11288.153388495732;11310.4910279036;11344.262622929484;11424.885751142714;11472.88527114718;11654.592089276835;11679.124065694938;11788.823167652663;8777.385583009129;8881.333899957659;8938.195562399414;8939.195472407515;9048.547572621474;8497.150284971452;10391.272610917164;11229.157813164209;11237.49431275611;11439.485223164811 11:57:59 INFO - PROCESS | 30667 | |3;mootools.html;1451.1873350923481;1484.1169504145034;1597.6085858964555;1733.046824246664;1749.7200447928326;7996.160403157672;8600.74197774067;8685.17490838371;9208.401453905492;9223.90776092239;8703.738887833359;8889;8969.147930946567;9005.099490050992;9006.09939006099;2311.641695537194;2334.6381310896754;2340.8127349811975;2351.482673811767;2351.8118550516;2291.8281128915314;2325.5813953488364;2334.101370972171;2349.847259928099;2352.952940941189;2287.565362581104;2290.2365178812306;2295.931122066341;2299.0688771047753;2303.8272129590264;2246.977625180539;2251.470904337479;2259.9378292202555;2269.6595510673365;2282.281081459335;2262.7850354216325;2263.3323169664986;2272.0570963050313;2275.453891066132;2285.1088075650346;8922.910770892273;8968.05835387288;8992.8651070234;9005.639774409015;9051.954740226323;5194.896102077975;5298.390685071189;5326.174442961347;5326.946730532683;5348.304720386363;3099.6590375058727;3254.4142054430195;3266.8856590019473;3274.2305558193807;3333.399988002159;988.2588058955783;1011.5700827148506;1022.5091955861228;1031.3966329697137;1033.3076838518211;12656.557020504239;12736.554220602235;12748.936255318757;12783.61649150527;12788.744225115539;4353.32523458858;4621.676482646182;4628.213203755302;4634.23535116702;4639.675222734376;10795.622153224756;10807.783844323227;10815.459227038617;10835.891641083646;10865.945670271598;5324.760385782649;5327.920081198785;5329.440408757102;5343.332083489564;5347.1979203119845;4454.4654641442585;4670.5329467053025;4791.688540244873;4926.556609905126;4952.232403977389;3820.102275965146;3920.725549211528;3930.7051971102283;3943.191645712622;3966.5835087315995;1234.5802427174804;1239.702471406856;1245.339969815999;1251.743392604514;1259.57174560648;994.6916455898695;997.9950100249453;1004.6232662751469;1030.3920686794827;1041.5156952017348;6200.906986395207;6359.841003974938;6378.553501254868;6393.360663933569;6537.248216455168;963.4969447661671;970.2529052629436;1004.9547770350351;1011.7925825205815;1012.1851909213007;4187.706860519735;4314.525402205755;4318.287482565404;4357;4360.869173924787;10994;11311.264767790068;11313.943430282796;11335.773284534263;11439.256448330832;10588.947055264674;11144.33134011962;11163.330200188015;11174.273672211442;11468.31190128595;7739.690412383554;7798.298153166129;7853.607319633996;7864.764057078297;7875.330596899328;6246;6540.934590654033;6549.410553050248;6552.737890484327;6565.770198043046;10365.896341036794;10483.68548943533;10592.205584581341;10604.787904241717;10660.093892019266;10492.632757853438;10592.629257975934;10647.627333043307;10668.719753629613;10671.092957098734;7175.138983322035;7426.628668566658;7467.701291948261;7918.841623167619;8021.197880211932;8651.52416617092;8705.912940870763;8727.083656216006;8779.648814047367;8802.515861627671;7148.070750802362;7386.593737344498;7437;7538.623068846646;7557.206493318123;7758.379329653727;7816.101148367783;7850.960745196237;7886.921130788848;7960.124386317616;7213.458990575833;7217.422606191387;7220.1696804866015;7272.272772722897;7275.708971641075;5331.413544510178;5447.618666693294;5527.39198688152;5563.805266815642;5617.382087970238;5525.171224316385;5552.472515111058;5610.831675049755;5639.436056394327;5742.684152371659 11:57:59 INFO - PROCESS | 30667 | |4;prototype.html;303.6022810118745;311.20487155318153;314.28813736885945;315.3204843562123;320.71296189910026;5642.717864106794;5655.915161272585;5674.595242854285;5688.516476099526;5705.800296989606;5560.86097847554;5588.245586845775;5588.580856435763;5589.329280486337;5591.238759790663;4073.674106071522;4170.9582904170875;4278.871633850989;4291.184674911757;4298.484181898169;4270.252705776492;4289.721168124062;4299.871003869874;4301.247281725701;4305.50486694031;4244.511881133662;4253.1281087377165;4262.744235345874;4263.445752052229;4279.465066866642;4002.579729128458;4247.787610619456;4256.2764330063965;4266.338717498777;4271.273883439822;3630.5280313559333;3644.398674218777;3647.1611529348397;3650.4159334506353;3671.1556342041213;5441.102218134003;5450.781968721247;5461.672299662033;5464.207689884945;5473.397926228112;4638.582527572501;4793.185158523024;4823.372961515016;4841.467438581753;4895.363602731622;5795.739191736382;5824.0390335594575;5830.650160990312;5831.300243970751;5853.5902486825935;4027.6979226557833;4057.3102572562734;4058.533268674111;4066.7763273019973;4086.244044851712;5870.412958704138;6002.459778619901;6069.332373438918;6105;6109.877802443971;4130.524989626171;4142.5857414258335;4157.251694694984;4164.895877603084;4168.895242760671;4187.183499217685;4192.580741925783;4193.580641935843;4204.474440694913;4270.295401258758;4754.5007774183905;4850.369451971221;4900.901981960341;4919.655624106278;4928.950710492849;5841.88316233673;5863.179154918314;5866.1494083357675;5871.383504732027;5888.735006924699;1424.3803945283835;1435.0313538361563;1435.2704990486438;1436.6192958865909;1437.985620143806;887.5340446265633;907.5961197267153;928.2202949522433;931.9720408387759;934.3786382055856;5569.498745112878;5585.346960193957;5594.972025139929;5601.971990140023;5605.0382366172325;5962.747822957141;5963.538932961452;5964.582479226499;5980.491658209014;5994.610350327215;5454.8909021819345;5560.833175004756;5580.609357345028;5592.384837667853;5612.579056570692;3167.7645718169933;3171.9691100392465;3180.8568614412407;3183.9204019899225;3191.654134211353;6001.849953751192;6157.199564056644;6161.969190154021;6169.65553089823;6176.629402235881;6074.51403887688;6075.513958883279;6089.238845144357;6107.6640784757265;6112.358202388774;6087.908681369783;6115.205023347025;6121.663308518075;6127.908081378694;6155.261368635793;5692.829215123553;5875;5893.174955506147;5960.374160713236;5981.790637327673;5883.735231914488;5884.617499862496;5912.852178695567;5919.881602368015;5929.555283353852;5897.144913987534;6069.544784141119;6098.817035488943;6132.325444201224;6149.538784591263;4121.4848143982;4126.216018956388;4138.896527586834;4155.854545090907;4156.605122513356;5938.732757025858;5943.732532035982;5959.821205363846;5984.341722410444;5984.491318237824;5581.609287349846;5824.534037276923;5864.9413505864395;5967.8209653710455;5978.880422391441;5898.734556945034;5929.495992840657;5931.347551769216;5933.228680271537;5946.910796337972;5275.762590683352;5802.6808525531505;5823.330317013429;5847.883042339215;5894.6757928314355;5940.821775346746;5952.196453478725;5960.4635582797755;5960.910586341295;5963.522918166623;5795.652260864362;5813.395694669163;5814.680192589448;5830.62100963436;5852.4440178183 11:57:59 INFO - PROCESS | 30667 | |5;yui.html;757.5341165183411;777.7433446962503;789.7709664197381;842.7471758472459;855.3584811391456;15443.227838608067;15997.440089596852;16473.50579482616;16718.41485548006;16752.078635675032;15226.771598426005;15263.389464421438;15402.152881591535;15405.306761195745;15432.922835385836;804.9396295277863;840.4663038970267;842.93256539477;843;843.1652663862793;837.2339309531772;839.7396806989822;841.5834162089743;841.6843683618642;842.153635596225;869.995650021749;874.3442418186361;876.1807709791334;876.2114097312437;879.226280872831;874.3224001398903;876.0713643537806;876.9824603507926;877.8068824858553;878.6002368922157;634.9841253968688;635.5836926812899;637.1016866218656;640.103854603554;641.2657507154329;16215.83784162167;16314.347426102942;16375.508734737978;16400.75398869018;16461.917690411592;16059.187468529224;16091.275892584745;16097.678046439123;16222.675546489005;16499.422520211854;12666.620001399973;12711.491540338468;12725.186631103683;12785.424655890414;13120.540781072617;3906.609339066099;3931.5085614298214;3957.7823219722904;3970.82131304092;4038.0914294283843;84960.15039849584;84961.57519212364;85590.57204713937;85624.57187714084;85909.71135432973;11662.300261984308;11815.586454474053;12176.086793490524;12250.877491225152;12466.376681166086;20217.696734548994;20271;20296.289629862884;20527.28154514585;22695.546089078125;8698.47809131454;8717.041125476193;8796.956015219883;8833;8840.778980525538;4628.467726211461;4645;4686.55477729622;4782.37829082224;4814.253790662383;3438.707709844641;3525.4006818840858;3527.5590551181103;3532.0816587687386;3538.239278555123;586.2173997713015;586.9589128761031;589.4341432225112;598.2970010237952;600.8527910661828;626.9247690277105;682.474494639125;693.8473535822111;778.116837389567;783.2911215350117;10044.547995340226;10065.295429320024;10198.541065652063;10244.692659220234;10551;756.5025920900196;768.9307962283422;784.9136594974663;786.7875673568104;789.2107892107892;4580.473245576802;4945.4312754033745;4978.626603004716;4999.850004499871;5101.69389836611;103284.48357758163;119985;122459;123971;124669;69556.6522167386;93617.53191234;93716;93999;94357;91795.54102229446;91956.54021729983;92447.5377623121;92666;93038.53480732553;9407.905920940977;9507.524623768923;9578.23374130054;9608.95195524018;9667.758306042124;55222.723886381915;55625;55816.44183558112;56327.71836140793;56732;71701.28298716946;74258.62870685612;78549.60725196337;80787;83290.58354708187;11202.551897923991;11497.770044598894;11680.357580332824;11856.288622682321;12118.575849845212;15730.213489325717;15779.842201577838;16134.596635084217;16212.756808648115;16215.513534593982;12986.480540778262;13463.865361346261;13658;14149.787753183504;14894;12578.433970471167;13127.803082953955;13252.536161234311;13393.330333483482;13459.327033648475;13220.272884991033;13469.797953030517;13878.930605346908;13979.720405591628;14065.437382504995;12311.815322770344;12312.322822244863;12675.17611355259;12864.871351286367;12958.546450874173;11764.647060588197;11901.82147267809;12076.154669173073;12121.69695757613;12359.38203089824 11:57:59 INFO - PROCESS | 30667 | __end_tp_report 11:57:59 INFO - PROCESS | 30667 | __start_cc_report 11:57:59 INFO - PROCESS | 30667 | _x_x_mozilla_cycle_collect,360 11:57:59 INFO - PROCESS | 30667 | __end_cc_report 11:57:59 INFO - PROCESS | 30667 | __startTimestamp1468609079752__endTimestamp 11:57:59 INFO - PROCESS | 30667 | 11:57:59 INFO - PROCESS | 30667 | ------- Summary: start ------- 11:57:59 INFO - PROCESS | 30667 | Number of tests: 6 11:57:59 INFO - PROCESS | 30667 | 11:57:59 INFO - PROCESS | 30667 | [#0] dojo.html Cycles:165 Average:5382.71 Median:5649.86 stddev:734.34 (13.0%) stddev-sans-first:714.07 11:57:59 INFO - PROCESS | 30667 | Values: 3082.4 3097.8 3098.0 3108.8 3116.5 5341.8 5369.0 5383.4 5405.7 5482.2 5380.2 5421.8 5423.2 5473.9 5501.5 4927.3 4960.6 5053.3 5109.7 5155.9 556.9 4908.6 4915.6 4951.3 5101.0 4862.2 4906.3 4914.4 4921.8 4934.3 4917.2 4932.1 4936.5 4941.4 4951.2 4872.5 4897.7 4914.2 4921.0 4942.1 5336.6 5353.2 5397.7 5405.2 5408.3 5663.9 5711.8 5862.9 5890.3 5897.4 5773.7 5820.9 5832.6 5843.5 5905.9 5388.9 5398.2 5403.8 5422.0 5458.5 5804.1 5855.7 5868.5 5927.4 5975.7 5649.2 5655.3 5674.3 5686.8 5720.8 5782.7 5783.8 5784.8 5787.0 5797.0 5700.5 5710.4 5724.3 5729.2 5781.9 5740.7 5771.4 5772.5 5775.9 5775.9 4351.0 4416.2 4432.8 4438.5 4459.9 3851.2 3934.5 3951.2 3965.0 4009.4 5402.6 5529.9 5547.8 5576.4 5590.8 5832.8 5906.3 5913.4 5917.9 5932.9 5364.7 5555.1 5560.9 5595.9 5649.9 4938.6 4940.4 4944.8 4949.0 4998.0 6059.7 6062.2 6063.2 6068.6 6071.6 5731.4 5839.3 5864.6 5884.6 5891.9 6063.8 6074.7 6093.2 6113.6 6126.1 5677.0 5806.6 5810.9 5816.4 5819.0 5864.9 5893.6 5911.8 5949.8 5950.8 5750.0 5801.2 5804.3 5808.8 5839.1 5682.2 5684.0 5791.9 5809.0 5826.0 5594.5 5646.2 5682.5 5685.2 5718.6 5670.1 5711.9 5719.7 5751.9 5757.8 5453.0 5615.4 5617.0 5625.5 5632.3 11:57:59 INFO - PROCESS | 30667 | 11:57:59 INFO - PROCESS | 30667 | [#1] ext.html Cycles:180 Average:60618.20 Median:41461.98 stddev:125416.23 (302.5%) stddev-sans-first:125687.00 11:57:59 INFO - PROCESS | 30667 | Values: 560.6 598.1 599.0 614.0 648.2 39510.2 43640.8 43792.1 43849.8 43919.8 42777.8 43264.8 43267.0 43275.1 43290.0 8897.1 9064.5 9069.2 9079.7 9083.5 8930.4 8988.2 9004.1 9050.1 9084.9 9040.6 9083.3 9121.0 9135.5 9158.5 9061.9 9076.6 9106.5 9116.3 9127.3 8814.8 8844.2 8908.0 8916.6 8949.9 33196.8 40928.2 41151.4 41454.6 41469.4 3410.5 3537.8 3588.8 3624.6 3646.9 31657.3 32311.5 32369.2 32378.5 32705.8 4307.9 4357.5 4385.5 4391.3 4465.9 305073.0 308262.0 309385.0 309415.0 309672.0 34360.7 34681.3 35104.0 35115.0 35116.3 35176.6 36438.3 36619.6 36632.1 36670.0 15556.5 15742.2 15764.8 15781.9 15823.0 13088.5 13272.1 13274.7 13279.4 13291.2 8228.1 8236.2 8250.3 8295.4 8343.1 3119.6 3183.7 3201.0 3203.5 3232.7 1080.3 1116.9 1188.9 1195.0 1204.2 33555.7 34000.5 34097.0 34100.3 34578.3 1102.3 1102.9 1139.9 1160.0 1165.5 16837.7 17843.6 17945.0 17961.8 18076.5 556884.0 558870.0 559805.0 560937.0 561956.0 40985.0 40986.6 41057.0 41121.6 41241.8 1325.8 1334.6 1356.7 1374.5 1385.0 32526.7 33578.0 33667.8 34046.7 34343.8 53818.0 57576.0 59445.4 59573.7 62316.4 504542.0 505313.0 507351.0 507869.0 508558.0 45067.1 45769.3 45946.0 46223.0 46416.8 49653.3 50320.2 50601.0 50829.7 50994.0 42787.8 43697.3 44027.3 44200.3 45280.1 42906.8 43374.1 43558.6 43712.0 43719.3 39510.6 42940.0 43153.6 43326.4 44173.6 35995.0 38799.2 39294.4 40346.6 41399.8 29318.6 29717.9 29956.4 30051.8 30061.0 11:57:59 INFO - PROCESS | 30667 | 11:57:59 INFO - PROCESS | 30667 | [#2] jquery.html Cycles:180 Average:31195.07 Median:23469.76 stddev:90068.92 (383.8%) stddev-sans-first:90291.88 11:57:59 INFO - PROCESS | 30667 | Values: 385.5 386.6 388.4 392.2 413.5 18805.7 20357.7 20374.5 20691.2 20889.8 20100.6 20122.9 20184.6 20660.3 20888.4 5498.3 5528.7 5799.8 5866.3 5870.3 5745.7 5779.2 5962.3 6354.3 6357.0 6205.9 6340.2 6368.4 6379.2 6553.5 5896.8 5975.2 5975.9 5990.3 6036.9 5768.2 5803.2 5824.4 5831.8 5838.7 23228.0 23711.5 24357.5 24483.4 24623.6 2304.9 2312.0 2392.9 2652.4 3047.9 9948.2 10152.4 10209.3 10275.5 10526.8 1950.2 2002.0 2025.4 2034.6 2068.4 86071.6 87791.0 89499.0 90837.5 91619.1 10857.5 11061.4 11127.6 11232.1 11262.9 15299.7 15464.8 15604.8 15625.0 15639.5 8191.6 8356.3 8387.2 8523.7 8527.8 8126.2 8143.0 8165.2 8280.6 8360.6 4697.5 4752.6 4786.3 4790.4 4917.1 1935.8 1951.5 1964.7 1980.2 1985.9 976.2 991.2 1000.6 1069.9 1071.4 19454.9 20188.8 20720.6 20958.1 21464.9 1004.0 1009.3 1065.8 1079.7 1084.5 11122.2 11665.6 11780.6 11868.8 11906.9 538236.8 540599.0 543199.0 546267.0 565972.0 80126.0 87476.6 89653.6 102752.5 105444.0 1038.6 1065.2 1071.2 1077.3 1080.0 18796.0 18900.2 19522.4 19594.0 19691.0 43352.1 43438.8 43950.1 44096.8 44618.3 58905.0 60303.4 61092.4 61392.7 62067.4 8671.7 8686.9 8757.6 8912.2 8983.9 11409.7 12788.5 12881.5 12904.8 12947.0 10393.4 11140.6 11384.4 11551.9 11740.5 10459.1 11175.7 11288.2 11310.5 11344.3 11424.9 11472.9 11654.6 11679.1 11788.8 8777.4 8881.3 8938.2 8939.2 9048.5 8497.2 10391.3 11229.2 11237.5 11439.5 11:57:59 INFO - PROCESS | 30667 | 11:57:59 INFO - PROCESS | 30667 | [#3] mootools.html Cycles:180 Average:5922.50 Median:4407.67 stddev:3406.90 (77.3%) stddev-sans-first:3399.89 11:57:59 INFO - PROCESS | 30667 | Values: 1451.2 1484.1 1597.6 1733.0 1749.7 7996.2 8600.7 8685.2 9208.4 9223.9 8703.7 8889.0 8969.1 9005.1 9006.1 2311.6 2334.6 2340.8 2351.5 2351.8 2291.8 2325.6 2334.1 2349.8 2353.0 2287.6 2290.2 2295.9 2299.1 2303.8 2247.0 2251.5 2259.9 2269.7 2282.3 2262.8 2263.3 2272.1 2275.5 2285.1 8922.9 8968.1 8992.9 9005.6 9052.0 5194.9 5298.4 5326.2 5326.9 5348.3 3099.7 3254.4 3266.9 3274.2 3333.4 988.3 1011.6 1022.5 1031.4 1033.3 12656.6 12736.6 12748.9 12783.6 12788.7 4353.3 4621.7 4628.2 4634.2 4639.7 10795.6 10807.8 10815.5 10835.9 10865.9 5324.8 5327.9 5329.4 5343.3 5347.2 4454.5 4670.5 4791.7 4926.6 4952.2 3820.1 3920.7 3930.7 3943.2 3966.6 1234.6 1239.7 1245.3 1251.7 1259.6 994.7 998.0 1004.6 1030.4 1041.5 6200.9 6359.8 6378.6 6393.4 6537.2 963.5 970.3 1005.0 1011.8 1012.2 4187.7 4314.5 4318.3 4357.0 4360.9 10994.0 11311.3 11313.9 11335.8 11439.3 10588.9 11144.3 11163.3 11174.3 11468.3 7739.7 7798.3 7853.6 7864.8 7875.3 6246.0 6540.9 6549.4 6552.7 6565.8 10365.9 10483.7 10592.2 10604.8 10660.1 10492.6 10592.6 10647.6 10668.7 10671.1 7175.1 7426.6 7467.7 7918.8 8021.2 8651.5 8705.9 8727.1 8779.6 8802.5 7148.1 7386.6 7437.0 7538.6 7557.2 7758.4 7816.1 7851.0 7886.9 7960.1 7213.5 7217.4 7220.2 7272.3 7275.7 5331.4 5447.6 5527.4 5563.8 5617.4 5525.2 5552.5 5610.8 5639.4 5742.7 11:57:59 INFO - PROCESS | 30667 | 11:57:59 INFO - PROCESS | 30667 | [#4] prototype.html Cycles:180 Average:4881.02 Median:5608.81 stddev:1472.56 (26.3%) stddev-sans-first:1436.05 11:57:59 INFO - PROCESS | 30667 | Values: 303.6 311.2 314.3 315.3 320.7 5642.7 5655.9 5674.6 5688.5 5705.8 5560.9 5588.2 5588.6 5589.3 5591.2 4073.7 4171.0 4278.9 4291.2 4298.5 4270.3 4289.7 4299.9 4301.2 4305.5 4244.5 4253.1 4262.7 4263.4 4279.5 4002.6 4247.8 4256.3 4266.3 4271.3 3630.5 3644.4 3647.2 3650.4 3671.2 5441.1 5450.8 5461.7 5464.2 5473.4 4638.6 4793.2 4823.4 4841.5 4895.4 5795.7 5824.0 5830.7 5831.3 5853.6 4027.7 4057.3 4058.5 4066.8 4086.2 5870.4 6002.5 6069.3 6105.0 6109.9 4130.5 4142.6 4157.3 4164.9 4168.9 4187.2 4192.6 4193.6 4204.5 4270.3 4754.5 4850.4 4900.9 4919.7 4929.0 5841.9 5863.2 5866.1 5871.4 5888.7 1424.4 1435.0 1435.3 1436.6 1438.0 887.5 907.6 928.2 932.0 934.4 5569.5 5585.3 5595.0 5602.0 5605.0 5962.7 5963.5 5964.6 5980.5 5994.6 5454.9 5560.8 5580.6 5592.4 5612.6 3167.8 3172.0 3180.9 3183.9 3191.7 6001.8 6157.2 6162.0 6169.7 6176.6 6074.5 6075.5 6089.2 6107.7 6112.4 6087.9 6115.2 6121.7 6127.9 6155.3 5692.8 5875.0 5893.2 5960.4 5981.8 5883.7 5884.6 5912.9 5919.9 5929.6 5897.1 6069.5 6098.8 6132.3 6149.5 4121.5 4126.2 4138.9 4155.9 4156.6 5938.7 5943.7 5959.8 5984.3 5984.5 5581.6 5824.5 5864.9 5967.8 5978.9 5898.7 5929.5 5931.3 5933.2 5946.9 5275.8 5802.7 5823.3 5847.9 5894.7 5940.8 5952.2 5960.5 5960.9 5963.5 5795.7 5813.4 5814.7 5830.6 5852.4 11:57:59 INFO - PROCESS | 30667 | 11:57:59 INFO - PROCESS | 30667 | [#5] yui.html Cycles:180 Average:21525.13 Median:4604.47 stddev:30787.58 (668.6%) stddev-sans-first:30834.46 11:57:59 INFO - PROCESS | 30667 | Values: 757.5 777.7 789.8 842.7 855.4 15443.2 15997.4 16473.5 16718.4 16752.1 15226.8 15263.4 15402.2 15405.3 15432.9 804.9 840.5 842.9 843.0 843.2 837.2 839.7 841.6 841.7 842.2 870.0 874.3 876.2 876.2 879.2 874.3 876.1 877.0 877.8 878.6 635.0 635.6 637.1 640.1 641.3 16215.8 16314.3 16375.5 16400.8 16461.9 16059.2 16091.3 16097.7 16222.7 16499.4 12666.6 12711.5 12725.2 12785.4 13120.5 3906.6 3931.5 3957.8 3970.8 4038.1 84960.2 84961.6 85590.6 85624.6 85909.7 11662.3 11815.6 12176.1 12250.9 12466.4 20217.7 20271.0 20296.3 20527.3 22695.5 8698.5 8717.0 8797.0 8833.0 8840.8 4628.5 4645.0 4686.6 4782.4 4814.3 3438.7 3525.4 3527.6 3532.1 3538.2 586.2 587.0 589.4 598.3 600.9 626.9 682.5 693.8 778.1 783.3 10044.5 10065.3 10198.5 10244.7 10551.0 756.5 768.9 784.9 786.8 789.2 4580.5 4945.4 4978.6 4999.9 5101.7 103284.5 119985.0 122459.0 123971.0 124669.0 69556.7 93617.5 93716.0 93999.0 94357.0 91795.5 91956.5 92447.5 92666.0 93038.5 9407.9 9507.5 9578.2 9609.0 9667.8 55222.7 55625.0 55816.4 56327.7 56732.0 71701.3 74258.6 78549.6 80787.0 83290.6 11202.6 11497.8 11680.4 11856.3 12118.6 15730.2 15779.8 16134.6 16212.8 16215.5 12986.5 13463.9 13658.0 14149.8 14894.0 12578.4 13127.8 13252.5 13393.3 13459.3 13220.3 13469.8 13878.9 13979.7 14065.4 12311.8 12312.3 12675.2 12864.9 12958.5 11764.6 11901.8 12076.2 12121.7 12359.4 11:57:59 INFO - PROCESS | 30667 | -------- Summary: end -------- 11:57:59 INFO - PROCESS | 30667 | 11:58:00 INFO - TEST-INFO | 30667: exit 0 11:58:00 INFO - TEST-OK | dromaeo_css | took 1110401ms 11:58:00 INFO - TEST-START | kraken 11:58:00 INFO - operating with platform_type : linux_ 11:58:00 INFO - Initialising browser for kraken test... 11:58:00 INFO - TEST-INFO | started process 30918 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm7G_7G/profile http://localhost:45115/getInfo.html) 11:58:05 INFO - PROCESS | 30918 | __metrics Screen width/height:1600/1200 11:58:05 INFO - PROCESS | 30918 | colorDepth:24 11:58:05 INFO - PROCESS | 30918 | Browser inner width/height: 1024/697 11:58:05 INFO - PROCESS | 30918 | __metrics 11:58:05 ERROR - PROCESS | 30918 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 11:58:06 INFO - TEST-INFO | 30918: exit 0 11:58:06 INFO - Browser initialized. 11:58:06 INFO - Running cycle 1/1 for kraken test... 11:58:06 INFO - TEST-INFO | started process 31040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm7G_7G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:18 INFO - PROCESS | 31040 | RSS: Main: 167895040 11:58:18 INFO - PROCESS | 31040 | 11:58:20 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45115/tests/kraken/driver.html?testName=audio-beat-detection) 11:58:21 INFO - PROCESS | 31040 | RSS: Main: 173326336 11:58:21 INFO - PROCESS | 31040 | 11:58:24 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45115/tests/kraken/driver.html?testName=audio-dft) 11:58:25 INFO - PROCESS | 31040 | RSS: Main: 172093440 11:58:25 INFO - PROCESS | 31040 | 11:58:27 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45115/tests/kraken/driver.html?testName=audio-fft) 11:58:28 INFO - PROCESS | 31040 | RSS: Main: 167014400 11:58:28 INFO - PROCESS | 31040 | 11:58:30 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45115/tests/kraken/driver.html?testName=audio-oscillator) 11:58:31 INFO - PROCESS | 31040 | RSS: Main: 168198144 11:58:31 INFO - PROCESS | 31040 | 11:58:33 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45115/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:58:34 INFO - PROCESS | 31040 | RSS: Main: 168161280 11:58:34 INFO - PROCESS | 31040 | 11:58:37 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45115/tests/kraken/driver.html?testName=imaging-darkroom) 11:58:37 INFO - PROCESS | 31040 | RSS: Main: 168566784 11:58:37 INFO - PROCESS | 31040 | 11:58:41 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45115/tests/kraken/driver.html?testName=imaging-desaturate) 11:58:41 INFO - PROCESS | 31040 | RSS: Main: 166617088 11:58:41 INFO - PROCESS | 31040 | 11:58:44 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45115/tests/kraken/driver.html?testName=json-parse-financial) 11:58:45 INFO - PROCESS | 31040 | RSS: Main: 167919616 11:58:45 INFO - PROCESS | 31040 | 11:58:46 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45115/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:58:47 INFO - PROCESS | 31040 | RSS: Main: 168288256 11:58:47 INFO - PROCESS | 31040 | 11:58:49 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45115/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:58:50 INFO - PROCESS | 31040 | RSS: Main: 168448000 11:58:50 INFO - PROCESS | 31040 | 11:58:52 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45115/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:58:52 INFO - PROCESS | 31040 | RSS: Main: 168673280 11:58:52 INFO - PROCESS | 31040 | 11:58:55 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:58:56 INFO - PROCESS | 31040 | RSS: Main: 169385984 11:58:56 INFO - PROCESS | 31040 | 11:58:58 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:58:59 INFO - PROCESS | 31040 | RSS: Main: 168783872 11:58:59 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | Cycle 1(1): loaded http://localhost:45115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45115/tests/kraken/driver.html?testName=ai-astar) 11:59:01 INFO - PROCESS | 31040 | RSS: Main: 169340928 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | __start_tp_report 11:59:01 INFO - PROCESS | 31040 | _x_x_mozilla_page_load 11:59:01 INFO - PROCESS | 31040 | _x_x_mozilla_page_load_details 11:59:01 INFO - PROCESS | 31040 | |i|pagename|runs| 11:59:01 INFO - PROCESS | 31040 | |0;ai-astar;102;114;107;112;114;114;114;114;112;112 11:59:01 INFO - PROCESS | 31040 | |1;audio-beat-detection;154;116;147;178;118;151;142;125;179;122 11:59:01 INFO - PROCESS | 31040 | |2;audio-dft;162;164;162;162;162;164;173;164;162;161 11:59:01 INFO - PROCESS | 31040 | |3;audio-fft;74;75;75;168;76;76;76;76;187;86 11:59:01 INFO - PROCESS | 31040 | |4;audio-oscillator;97;84;157;85;83;83;144;85;85;144 11:59:01 INFO - PROCESS | 31040 | |5;imaging-gaussian-blur;117;118;117;118;118;117;118;117;117;117 11:59:01 INFO - PROCESS | 31040 | |6;imaging-darkroom;146;147;146;147;148;148;148;147;147;146 11:59:01 INFO - PROCESS | 31040 | |7;imaging-desaturate;95;97;95;97;96;95;95;96;96;96 11:59:01 INFO - PROCESS | 31040 | |8;json-parse-financial;65;55;56;55;57;53;59;55;55;59 11:59:01 INFO - PROCESS | 31040 | |9;json-stringify-tinderbox;63;64;64;63;64;63;64;64;64;64 11:59:01 INFO - PROCESS | 31040 | |10;stanford-crypto-aes;77;86;77;76;77;76;75;84;80;76 11:59:01 INFO - PROCESS | 31040 | |11;stanford-crypto-ccm;131;131;131;125;125;121;130;131;171;121 11:59:01 INFO - PROCESS | 31040 | |12;stanford-crypto-pbkdf2;158;163;159;160;158;155;162;161;159;158 11:59:01 INFO - PROCESS | 31040 | |13;stanford-crypto-sha256-iterative;64;67;68;66;74;63;62;64;64;63 11:59:01 INFO - PROCESS | 31040 | __end_tp_report 11:59:01 INFO - PROCESS | 31040 | __start_cc_report 11:59:01 INFO - PROCESS | 31040 | _x_x_mozilla_cycle_collect,886 11:59:01 INFO - PROCESS | 31040 | __end_cc_report 11:59:01 INFO - PROCESS | 31040 | __startTimestamp1468609141284__endTimestamp 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | ------- Summary: start ------- 11:59:01 INFO - PROCESS | 31040 | Number of tests: 14 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#0] ai-astar Cycles:10 Average:111.50 Median:114.00 stddev:3.98 (3.5%) stddev-sans-first:2.30 11:59:01 INFO - PROCESS | 31040 | Values: 102.0 114.0 107.0 112.0 114.0 114.0 114.0 114.0 112.0 112.0 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:149.00 stddev:23.19 (15.6%) stddev-sans-first:24.27 11:59:01 INFO - PROCESS | 31040 | Values: 154.0 116.0 147.0 178.0 118.0 151.0 142.0 125.0 179.0 122.0 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.47 (2.1%) stddev-sans-first:3.63 11:59:01 INFO - PROCESS | 31040 | Values: 162.0 164.0 162.0 162.0 162.0 164.0 173.0 164.0 162.0 161.0 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#3] audio-fft Cycles:10 Average:96.90 Median:76.00 stddev:42.85 (56.4%) stddev-sans-first:44.64 11:59:01 INFO - PROCESS | 31040 | Values: 74.0 75.0 75.0 168.0 76.0 76.0 76.0 76.0 187.0 86.0 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:84.50 stddev:30.58 (36.2%) stddev-sans-first:32.31 11:59:01 INFO - PROCESS | 31040 | Values: 97.0 84.0 157.0 85.0 83.0 83.0 144.0 85.0 85.0 144.0 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:59:01 INFO - PROCESS | 31040 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 11:59:01 INFO - PROCESS | 31040 | Values: 146.0 147.0 146.0 147.0 148.0 148.0 148.0 147.0 147.0 146.0 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 11:59:01 INFO - PROCESS | 31040 | Values: 95.0 97.0 95.0 97.0 96.0 95.0 95.0 96.0 96.0 96.0 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.50 stddev:3.41 (6.0%) stddev-sans-first:2.00 11:59:01 INFO - PROCESS | 31040 | Values: 65.0 55.0 56.0 55.0 57.0 53.0 59.0 55.0 55.0 59.0 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 11:59:01 INFO - PROCESS | 31040 | Values: 63.0 64.0 64.0 63.0 64.0 63.0 64.0 64.0 64.0 64.0 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:77.00 stddev:3.75 (4.9%) stddev-sans-first:3.94 11:59:01 INFO - PROCESS | 31040 | Values: 77.0 86.0 77.0 76.0 77.0 76.0 75.0 84.0 80.0 76.0 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:131.00 stddev:14.41 (11.0%) stddev-sans-first:15.28 11:59:01 INFO - PROCESS | 31040 | Values: 131.0 131.0 131.0 125.0 125.0 121.0 130.0 131.0 171.0 121.0 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:159.50 stddev:2.31 (1.4%) stddev-sans-first:2.40 11:59:01 INFO - PROCESS | 31040 | Values: 158.0 163.0 159.0 160.0 158.0 155.0 162.0 161.0 159.0 158.0 11:59:01 INFO - PROCESS | 31040 | 11:59:01 INFO - PROCESS | 31040 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.00 stddev:3.54 (5.4%) stddev-sans-first:3.71 11:59:01 INFO - PROCESS | 31040 | Values: 64.0 67.0 68.0 66.0 74.0 63.0 62.0 64.0 64.0 63.0 11:59:01 INFO - PROCESS | 31040 | -------- Summary: end -------- 11:59:01 INFO - PROCESS | 31040 | 11:59:02 INFO - TEST-INFO | 31040: exit 0 11:59:02 INFO - TEST-OK | kraken | took 61811ms 11:59:02 INFO - SUITE-END | took 1172s 11:59:02 INFO - Completed test suite (00:19:32) 11:59:02 INFO - javascript benchmark 11:59:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7349.928538163092, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.38352329534, 3097.767667424943, 3098.0, 3108.766842486811, 3116.5481005254237, 5341.839744807658, 5368.973155134224, 5383.407825139231, 5405.702686352249, 5482.177673349, 5380.192971054344, 5421.756020979055, 5423.240746295522, 5473.890522189554, 5501.504864562188, 4927.3101765752735, 4960.603151747851, 5053.343065401493, 5109.718965456898, 5155.896882062375, 556.8614696214821, 4908.558229759321, 4915.5821755150855, 4951.331570238008, 5101.0, 4862.246351815456, 4906.264060390952, 4914.385701787277, 4921.753912304406, 4934.333864928242, 4917.188663870457, 4932.087563800708, 4936.5063493650705, 4941.382327209099, 4951.158303088484, 4872.537108974677, 4897.681650692729, 4914.213725803854, 4921.0, 4942.0610084084265, 5336.59975501835, 5353.2237825515085, 5397.7031263280505, 5405.18922161675, 5408.2698835657075, 5663.886722265573, 5711.828645140652, 5862.853428664275, 5890.263717035371, 5897.439743224387, 5773.740181691792, 5820.88358232833, 5832.62087964281, 5843.53251739864, 5905.911411328791, 5388.865278368033, 5398.163284690879, 5403.78384864605, 5422.0, 5458.5087342139, 5804.071348584206, 5855.707214639251, 5868.501177399883, 5927.377625349276, 5975.731092100779, 5649.237352957298, 5655.349634791969, 5674.26234589509, 5686.829395118153, 5720.828375148669, 5782.6819524925695, 5783.843231353662, 5784.797532086357, 5786.971065144648, 5797.043487824546, 5700.4869561738815, 5710.428957104256, 5724.284464441945, 5729.226554415184, 5781.913271300934, 5740.712964351766, 5771.365149833515, 5772.451617096369, 5775.88448231033, 5775.884482310415, 4351.042770590465, 4416.1609294233995, 4432.84485043022, 4438.511763705989, 4459.9331010034875, 3851.2490064437166, 3934.488516492838, 3951.1702542465828, 3965.0285680008583, 4009.398590211433, 5402.567794576425, 5529.944700553024, 5547.750351234205, 5576.386597474275, 5590.776368945197, 5832.825015249549, 5906.291245050621, 5913.408659134138, 5917.940820591825, 5932.851678707981, 5364.6512976656395, 5555.111182210908, 5560.944390556043, 5595.916061259084, 5649.858753531194, 4938.604911607063, 4940.382452193476, 4944.802207911644, 4948.975255123773, 4998.02538504988, 6059.666718330446, 6062.211912451441, 6063.211782468251, 6068.6358818471035, 6071.605345652607, 5731.398203188689, 5839.270091238595, 5864.589478736618, 5884.58807883444, 5891.94108058931, 6063.757449701962, 6074.7266373012435, 6093.238345206849, 6113.633182009094, 6126.050462178369, 5677.034904066401, 5806.622569532967, 5810.912836307374, 5816.389279125631, 5819.0, 5864.912026319524, 5893.616914900518, 5911.793087241926, 5949.791757288647, 5950.761969521343, 5749.97125014389, 5801.216835727123, 5804.303483581997, 5808.82573522795, 5839.124131380327, 5682.176084467646, 5683.9715801420725, 5791.8552036199435, 5809.0, 5826.0, 5594.496495315441, 5646.181303711021, 5682.460166284196, 5685.204071430086, 5718.599698021098, 5670.149477578396, 5711.857203569944, 5719.685417302088, 5751.856203594776, 5757.798477053283, 5453.045716999589, 5615.354234263112, 5617.045102332531, 5625.46558076982, 5632.295963004624], "value": 5333.818991154222, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.6355868685354, 598.0938877600433, 598.963792638735, 613.99693001535, 648.1541588227361, 39510.209795804105, 43640.781796090974, 43792.12415751683, 43849.78075109624, 43919.78040109803, 42777.78611106948, 43264.78367608158, 43267.0, 43275.10524052835, 43290.0, 8897.1102889711, 9064.45613263203, 9069.229115525188, 9079.682211122612, 9083.545822708871, 8930.37487375884, 8988.191062804346, 9004.054574269705, 9050.140236677506, 9084.8637270441, 9040.638374465014, 9083.31875109366, 9121.042290559495, 9135.451872887616, 9158.542072896362, 9061.864072038925, 9076.63693452261, 9106.453612783222, 9116.31627627924, 9127.315451341176, 8814.823703525957, 8844.159804818531, 8908.0, 8916.643334266622, 8949.865752013726, 33196.834015830005, 40928.1814363714, 41151.38272925879, 41454.58545414568, 41469.37795933033, 3410.4543273076188, 3537.8054207018604, 3588.784672919633, 3624.58317293512, 3646.908827279313, 31657.309128724086, 32311.51532727011, 32369.190770230696, 32378.514322285184, 32705.836470817732, 4307.935380969288, 4357.542458041891, 4385.51759306476, 4391.253486907233, 4465.866024019252, 305073.0, 308262.0, 309385.0, 309415.0, 309672.0, 34360.65639343624, 34681.30637387238, 35104.0, 35115.0, 35116.29767404689, 35176.64823351785, 36438.27123457569, 36619.63380366215, 36632.08419789527, 36670.0, 15556.533304000897, 15742.212889355487, 15764.842351576337, 15781.921090394475, 15823.0, 13088.476460941456, 13272.070955033249, 13274.66813329655, 13279.402426890812, 13291.20252784836, 8228.053773815967, 8236.176382361717, 8250.298724608476, 8295.419320647617, 8343.123971982975, 3119.554634645621, 3183.7453003759642, 3200.9679903201136, 3203.5034569641743, 3232.725218356419, 1080.287010573018, 1116.9329840209614, 1188.9108316876268, 1195.0499353014375, 1204.1871736577775, 33555.664443355745, 34000.48999265013, 34097.0, 34100.31799363999, 34578.30843383118, 1102.3496137279044, 1102.873169585492, 1139.8917102875214, 1160.031373802884, 1165.452237448398, 16837.747433788503, 17843.553911152325, 17945.0, 17961.820381796013, 18076.548086297684, 556884.0, 558870.0, 559805.0, 560937.0, 561956.0, 40984.975375615846, 40986.59013409887, 41057.0, 41121.58878411238, 41241.79379103145, 1325.754735373959, 1334.5662659635657, 1356.7354365898555, 1374.4983081175299, 1384.9861501385058, 32526.674733253312, 33578.0, 33667.83166084154, 34046.65953340435, 34343.82828085843, 53818.0, 57576.0, 59445.405545943984, 59573.702131489066, 62316.37683623106, 504542.0, 505313.0, 507351.0, 507869.0, 508558.0, 45067.09865802731, 45769.31346029745, 45946.0, 46223.0, 46416.76791616021, 49653.25520117273, 50320.24519632135, 50601.0, 50829.745851270505, 50994.0, 42787.78606107074, 43697.344539832564, 44027.33958990682, 44200.33699494446, 45280.09439811251, 42906.78546607247, 43374.132517348844, 43558.56441435545, 43712.0, 43719.34420983624, 39510.604893951844, 42940.0, 43153.56846431496, 43326.350104749086, 44173.55826441823, 35995.0, 38799.224015518965, 39294.41058384184, 40346.59653403428, 41399.7930010348, 29318.56022159712, 29717.85141074281, 29956.400871982874, 30051.849740751157, 30061.0], "value": 19196.424898282883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.45650632607993, 386.5593223724954, 388.4076782906066, 392.17642949805406, 413.46249875162283, 18805.71791423128, 20357.694634580475, 20374.490637734063, 20691.172353105896, 20889.791102089013, 20100.59798804023, 20122.899385503053, 20184.59630807383, 20660.276890308844, 20888.373348799523, 5498.257735205756, 5528.695921724304, 5799.768009279624, 5866.296044474648, 5870.26621672291, 5745.683987380692, 5779.248697669297, 5962.314333851597, 6354.3010268870385, 6357.046443033536, 6205.9379406206035, 6340.23917129945, 6368.395002474757, 6379.234491860983, 6553.475721942257, 5896.823095307148, 5975.223220981245, 5975.940240597582, 5990.311114221855, 6036.909446358308, 5768.221290125821, 5803.245578074865, 5824.446677565625, 5831.825045248649, 5838.678872662002, 23228.0, 23711.525769484513, 24357.51284974308, 24483.387915302083, 24623.630645540332, 2304.9078036878504, 2312.0405031911737, 2392.9162479313313, 2652.4429869727383, 3047.9085627431214, 9948.154406875425, 10152.39085654863, 10209.2853500255, 10275.48622568876, 10526.842097368546, 1950.161430584848, 2001.9699704504444, 2025.4430031741242, 2034.5829105033433, 2068.400163952452, 86071.56964215201, 87790.99999999936, 89499.0, 90837.54581227117, 91619.08380916172, 10857.51141198648, 11061.391623460626, 11127.5534180556, 11232.10143188543, 11262.931680743699, 15299.694006119815, 15464.845351546566, 15604.843951560339, 15625.0, 15639.530814075595, 8191.590420479071, 8356.289715374262, 8387.161283871565, 8523.74428767138, 8527.829443411098, 8126.228008339198, 8143.0, 8165.183481651788, 8280.627371768285, 8360.58197090143, 4697.4832768395445, 4752.597983594847, 4786.305985632064, 4790.449098353664, 4917.065757506062, 1935.8451323894337, 1951.5121219695077, 1964.7052942058806, 1980.2178139635053, 1985.8510611703891, 976.1751320134475, 991.1971303244395, 1000.564754331868, 1069.9304545204536, 1071.3732466507024, 19454.90272548628, 20188.798112018987, 20720.58558828815, 20958.056887440103, 21464.892675536834, 1003.9949800250952, 1009.3388830316155, 1065.7868426314767, 1079.6760971708457, 1084.4631907205983, 11122.22144449897, 11665.591704290478, 11780.646580602424, 11868.76262474763, 11906.880931190577, 538236.7793449304, 540599.0, 543199.0, 546267.0, 565972.0, 80126.0, 87476.56261718778, 89653.55173224091, 102752.48623756833, 105444.0, 1038.6105210546045, 1065.1851333729703, 1071.196602548089, 1077.278223590212, 1079.9676009719565, 18796.0, 18900.243990240237, 19522.414327570197, 19594.0, 19691.0, 43352.13295734004, 43438.782806085765, 43950.12099757923, 44096.779516102215, 44618.330725038504, 58905.0, 60303.39696602978, 61092.38907610867, 61392.69303653453, 62067.37932620616, 8671.739847804576, 8686.91313086861, 8757.562121894007, 8912.242459391024, 8983.910160898307, 11409.657710268706, 12788.488460461478, 12881.484740610646, 12904.8064279034, 12947.0, 10393.37639741618, 11140.554377825121, 11384.37385943781, 11551.88448115508, 11740.530378784753, 10459.110975567162, 11175.72060698489, 11288.153388495732, 11310.4910279036, 11344.262622929484, 11424.885751142714, 11472.88527114718, 11654.592089276835, 11679.124065694938, 11788.823167652663, 8777.385583009129, 8881.333899957659, 8938.195562399414, 8939.195472407515, 9048.547572621474, 8497.150284971452, 10391.272610917164, 11229.157813164209, 11237.49431275611, 11439.485223164811], "value": 9520.008883362005, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.1873350923481, 1484.1169504145034, 1597.6085858964555, 1733.046824246664, 1749.7200447928326, 7996.160403157672, 8600.74197774067, 8685.17490838371, 9208.401453905492, 9223.90776092239, 8703.738887833359, 8889.0, 8969.147930946567, 9005.099490050992, 9006.09939006099, 2311.641695537194, 2334.6381310896754, 2340.8127349811975, 2351.482673811767, 2351.8118550516, 2291.8281128915314, 2325.5813953488364, 2334.101370972171, 2349.847259928099, 2352.952940941189, 2287.565362581104, 2290.2365178812306, 2295.931122066341, 2299.0688771047753, 2303.8272129590264, 2246.977625180539, 2251.470904337479, 2259.9378292202555, 2269.6595510673365, 2282.281081459335, 2262.7850354216325, 2263.3323169664986, 2272.0570963050313, 2275.453891066132, 2285.1088075650346, 8922.910770892273, 8968.05835387288, 8992.8651070234, 9005.639774409015, 9051.954740226323, 5194.896102077975, 5298.390685071189, 5326.174442961347, 5326.946730532683, 5348.304720386363, 3099.6590375058727, 3254.4142054430195, 3266.8856590019473, 3274.2305558193807, 3333.399988002159, 988.2588058955783, 1011.5700827148506, 1022.5091955861228, 1031.3966329697137, 1033.3076838518211, 12656.557020504239, 12736.554220602235, 12748.936255318757, 12783.61649150527, 12788.744225115539, 4353.32523458858, 4621.676482646182, 4628.213203755302, 4634.23535116702, 4639.675222734376, 10795.622153224756, 10807.783844323227, 10815.459227038617, 10835.891641083646, 10865.945670271598, 5324.760385782649, 5327.920081198785, 5329.440408757102, 5343.332083489564, 5347.1979203119845, 4454.4654641442585, 4670.5329467053025, 4791.688540244873, 4926.556609905126, 4952.232403977389, 3820.102275965146, 3920.725549211528, 3930.7051971102283, 3943.191645712622, 3966.5835087315995, 1234.5802427174804, 1239.702471406856, 1245.339969815999, 1251.743392604514, 1259.57174560648, 994.6916455898695, 997.9950100249453, 1004.6232662751469, 1030.3920686794827, 1041.5156952017348, 6200.906986395207, 6359.841003974938, 6378.553501254868, 6393.360663933569, 6537.248216455168, 963.4969447661671, 970.2529052629436, 1004.9547770350351, 1011.7925825205815, 1012.1851909213007, 4187.706860519735, 4314.525402205755, 4318.287482565404, 4357.0, 4360.869173924787, 10994.0, 11311.264767790068, 11313.943430282796, 11335.773284534263, 11439.256448330832, 10588.947055264674, 11144.33134011962, 11163.330200188015, 11174.273672211442, 11468.31190128595, 7739.690412383554, 7798.298153166129, 7853.607319633996, 7864.764057078297, 7875.330596899328, 6246.0, 6540.934590654033, 6549.410553050248, 6552.737890484327, 6565.770198043046, 10365.896341036794, 10483.68548943533, 10592.205584581341, 10604.787904241717, 10660.093892019266, 10492.632757853438, 10592.629257975934, 10647.627333043307, 10668.719753629613, 10671.092957098734, 7175.138983322035, 7426.628668566658, 7467.701291948261, 7918.841623167619, 8021.197880211932, 8651.52416617092, 8705.912940870763, 8727.083656216006, 8779.648814047367, 8802.515861627671, 7148.070750802362, 7386.593737344498, 7437.0, 7538.623068846646, 7557.206493318123, 7758.379329653727, 7816.101148367783, 7850.960745196237, 7886.921130788848, 7960.124386317616, 7213.458990575833, 7217.422606191387, 7220.1696804866015, 7272.272772722897, 7275.708971641075, 5331.413544510178, 5447.618666693294, 5527.39198688152, 5563.805266815642, 5617.382087970238, 5525.171224316385, 5552.472515111058, 5610.831675049755, 5639.436056394327, 5742.684152371659], "value": 4709.243837876995, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.6022810118745, 311.20487155318153, 314.28813736885945, 315.3204843562123, 320.71296189910026, 5642.717864106794, 5655.915161272585, 5674.595242854285, 5688.516476099526, 5705.800296989606, 5560.86097847554, 5588.245586845775, 5588.580856435763, 5589.329280486337, 5591.238759790663, 4073.674106071522, 4170.9582904170875, 4278.871633850989, 4291.184674911757, 4298.484181898169, 4270.252705776492, 4289.721168124062, 4299.871003869874, 4301.247281725701, 4305.50486694031, 4244.511881133662, 4253.1281087377165, 4262.744235345874, 4263.445752052229, 4279.465066866642, 4002.579729128458, 4247.787610619456, 4256.2764330063965, 4266.338717498777, 4271.273883439822, 3630.5280313559333, 3644.398674218777, 3647.1611529348397, 3650.4159334506353, 3671.1556342041213, 5441.102218134003, 5450.781968721247, 5461.672299662033, 5464.207689884945, 5473.397926228112, 4638.582527572501, 4793.185158523024, 4823.372961515016, 4841.467438581753, 4895.363602731622, 5795.739191736382, 5824.0390335594575, 5830.650160990312, 5831.300243970751, 5853.5902486825935, 4027.6979226557833, 4057.3102572562734, 4058.533268674111, 4066.7763273019973, 4086.244044851712, 5870.412958704138, 6002.459778619901, 6069.332373438918, 6105.0, 6109.877802443971, 4130.524989626171, 4142.5857414258335, 4157.251694694984, 4164.895877603084, 4168.895242760671, 4187.183499217685, 4192.580741925783, 4193.580641935843, 4204.474440694913, 4270.295401258758, 4754.5007774183905, 4850.369451971221, 4900.901981960341, 4919.655624106278, 4928.950710492849, 5841.88316233673, 5863.179154918314, 5866.1494083357675, 5871.383504732027, 5888.735006924699, 1424.3803945283835, 1435.0313538361563, 1435.2704990486438, 1436.6192958865909, 1437.985620143806, 887.5340446265633, 907.5961197267153, 928.2202949522433, 931.9720408387759, 934.3786382055856, 5569.498745112878, 5585.346960193957, 5594.972025139929, 5601.971990140023, 5605.0382366172325, 5962.747822957141, 5963.538932961452, 5964.582479226499, 5980.491658209014, 5994.610350327215, 5454.8909021819345, 5560.833175004756, 5580.609357345028, 5592.384837667853, 5612.579056570692, 3167.7645718169933, 3171.9691100392465, 3180.8568614412407, 3183.9204019899225, 3191.654134211353, 6001.849953751192, 6157.199564056644, 6161.969190154021, 6169.65553089823, 6176.629402235881, 6074.51403887688, 6075.513958883279, 6089.238845144357, 6107.6640784757265, 6112.358202388774, 6087.908681369783, 6115.205023347025, 6121.663308518075, 6127.908081378694, 6155.261368635793, 5692.829215123553, 5875.0, 5893.174955506147, 5960.374160713236, 5981.790637327673, 5883.735231914488, 5884.617499862496, 5912.852178695567, 5919.881602368015, 5929.555283353852, 5897.144913987534, 6069.544784141119, 6098.817035488943, 6132.325444201224, 6149.538784591263, 4121.4848143982, 4126.216018956388, 4138.896527586834, 4155.854545090907, 4156.605122513356, 5938.732757025858, 5943.732532035982, 5959.821205363846, 5984.341722410444, 5984.491318237824, 5581.609287349846, 5824.534037276923, 5864.9413505864395, 5967.8209653710455, 5978.880422391441, 5898.734556945034, 5929.495992840657, 5931.347551769216, 5933.228680271537, 5946.910796337972, 5275.762590683352, 5802.6808525531505, 5823.330317013429, 5847.883042339215, 5894.6757928314355, 5940.821775346746, 5952.196453478725, 5960.4635582797755, 5960.910586341295, 5963.522918166623, 5795.652260864362, 5813.395694669163, 5814.680192589448, 5830.62100963436, 5852.4440178183], "value": 4395.025028427376, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.5341165183411, 777.7433446962503, 789.7709664197381, 842.7471758472459, 855.3584811391456, 15443.227838608067, 15997.440089596852, 16473.50579482616, 16718.41485548006, 16752.078635675032, 15226.771598426005, 15263.389464421438, 15402.152881591535, 15405.306761195745, 15432.922835385836, 804.9396295277863, 840.4663038970267, 842.93256539477, 843.0, 843.1652663862793, 837.2339309531772, 839.7396806989822, 841.5834162089743, 841.6843683618642, 842.153635596225, 869.995650021749, 874.3442418186361, 876.1807709791334, 876.2114097312437, 879.226280872831, 874.3224001398903, 876.0713643537806, 876.9824603507926, 877.8068824858553, 878.6002368922157, 634.9841253968688, 635.5836926812899, 637.1016866218656, 640.103854603554, 641.2657507154329, 16215.83784162167, 16314.347426102942, 16375.508734737978, 16400.75398869018, 16461.917690411592, 16059.187468529224, 16091.275892584745, 16097.678046439123, 16222.675546489005, 16499.422520211854, 12666.620001399973, 12711.491540338468, 12725.186631103683, 12785.424655890414, 13120.540781072617, 3906.609339066099, 3931.5085614298214, 3957.7823219722904, 3970.82131304092, 4038.0914294283843, 84960.15039849584, 84961.57519212364, 85590.57204713937, 85624.57187714084, 85909.71135432973, 11662.300261984308, 11815.586454474053, 12176.086793490524, 12250.877491225152, 12466.376681166086, 20217.696734548994, 20271.0, 20296.289629862884, 20527.28154514585, 22695.546089078125, 8698.47809131454, 8717.041125476193, 8796.956015219883, 8833.0, 8840.778980525538, 4628.467726211461, 4645.0, 4686.55477729622, 4782.37829082224, 4814.253790662383, 3438.707709844641, 3525.4006818840858, 3527.5590551181103, 3532.0816587687386, 3538.239278555123, 586.2173997713015, 586.9589128761031, 589.4341432225112, 598.2970010237952, 600.8527910661828, 626.9247690277105, 682.474494639125, 693.8473535822111, 778.116837389567, 783.2911215350117, 10044.547995340226, 10065.295429320024, 10198.541065652063, 10244.692659220234, 10551.0, 756.5025920900196, 768.9307962283422, 784.9136594974663, 786.7875673568104, 789.2107892107892, 4580.473245576802, 4945.4312754033745, 4978.626603004716, 4999.850004499871, 5101.69389836611, 103284.48357758163, 119985.0, 122459.0, 123971.0, 124669.0, 69556.6522167386, 93617.53191234, 93716.0, 93999.0, 94357.0, 91795.54102229446, 91956.54021729983, 92447.5377623121, 92666.0, 93038.53480732553, 9407.905920940977, 9507.524623768923, 9578.23374130054, 9608.95195524018, 9667.758306042124, 55222.723886381915, 55625.0, 55816.44183558112, 56327.71836140793, 56732.0, 71701.28298716946, 74258.62870685612, 78549.60725196337, 80787.0, 83290.58354708187, 11202.551897923991, 11497.770044598894, 11680.357580332824, 11856.288622682321, 12118.575849845212, 15730.213489325717, 15779.842201577838, 16134.596635084217, 16212.756808648115, 16215.513534593982, 12986.480540778262, 13463.865361346261, 13658.0, 14149.787753183504, 14894.0, 12578.433970471167, 13127.803082953955, 13252.536161234311, 13393.330333483482, 13459.327033648475, 13220.272884991033, 13469.797953030517, 13878.930605346908, 13979.720405591628, 14065.437382504995, 12311.815322770344, 12312.322822244863, 12675.17611355259, 12864.871351286367, 12958.546450874173, 11764.647060588197, 11901.82147267809, 12076.154669173073, 12121.69695757613, 12359.38203089824], "value": 7813.550860690026, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 107.0, 112.0, 114.0, 114.0, 114.0, 114.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 116.0, 147.0, 178.0, 118.0, 151.0, 142.0, 125.0, 179.0, 122.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 162.0, 162.0, 164.0, 173.0, 164.0, 162.0, 161.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 168.0, 76.0, 76.0, 76.0, 76.0, 187.0, 86.0], "value": 96.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 84.0, 157.0, 85.0, 83.0, 83.0, 144.0, 85.0, 85.0, 144.0], "value": 104.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 55.0, 56.0, 55.0, 57.0, 53.0, 59.0, 55.0, 55.0, 59.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 86.0, 77.0, 76.0, 77.0, 76.0, 75.0, 84.0, 80.0, 76.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 131.0, 125.0, 125.0, 121.0, 130.0, 131.0, 171.0, 121.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 163.0, 159.0, 160.0, 158.0, 155.0, 162.0, 161.0, 159.0, 158.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 68.0, 66.0, 74.0, 63.0, 62.0, 64.0, 64.0, 63.0], "value": 65.5, "unit": "score"}]}]} 11:59:02 INFO - Return code: 0 11:59:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:59:02 ERROR - # TBPL SUCCESS # 11:59:02 INFO - Running post-action listener: _resource_record_post_action 11:59:02 INFO - ##### 11:59:02 INFO - ##### Finished run-tests step (success) 11:59:02 INFO - ##### 11:59:02 INFO - Running post-run listener: _resource_record_post_run 11:59:02 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 558698496; Read time: 236; Write time: 555784 11:59:02 INFO - TinderboxPrint: CPU usage
13.3% 11:59:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 236 11:59:02 INFO - TinderboxPrint: I/O write bytes / time
558,698,496 / 555,784 11:59:02 INFO - TinderboxPrint: CPU idle
8,229.0 (86.7%) 11:59:02 INFO - TinderboxPrint: CPU user
1,208.3 (12.7%) 11:59:02 INFO - TinderboxPrint: Swap in / out
0 / 0 11:59:02 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 260857856; Read time: 0; Write time: 269736 11:59:02 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297840640; Read time: 228; Write time: 286048 11:59:03 INFO - Running post-run listener: _upload_blobber_files 11:59:03 INFO - Blob upload gear active. 11:59:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:59:03 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 11:59:03 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:59:03 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:59:03 INFO - (blobuploader) - INFO - Open directory for files ... 11:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:04 INFO - (blobuploader) - INFO - Done attempting. 11:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:59:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:05 INFO - (blobuploader) - INFO - Done attempting. 11:59:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:59:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:59:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:08 INFO - (blobuploader) - INFO - Done attempting. 11:59:08 INFO - (blobuploader) - INFO - Iteration through files over. 11:59:08 INFO - Return code: 0 11:59:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:59:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:59:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ba01eda08fc937514c56cedd5f32069e2e17985928b5d10ef4f256aef5186880e60fbb5d62f7a13bf1fa7ecd0dcc1cccb9bf7a4c7050008f0f828631a07d571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be4aa68678304e5a191e410fa5a860661c3f79da9117e8829964fa868e743d11257ea02edd131f0cc0d7fee041db10059a7fe0cc63a186cc2e71236cfe513a48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7f8778c6f0786ec0bdea87d1054b539cfbd378ff6388bd68ef914d3d3c704397c19d23fc845b1b985750c9b70c885a2ab89bcdd6eabfa4a389a368e58cdd9dd"} 11:59:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:59:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:59:08 INFO - Contents: 11:59:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ba01eda08fc937514c56cedd5f32069e2e17985928b5d10ef4f256aef5186880e60fbb5d62f7a13bf1fa7ecd0dcc1cccb9bf7a4c7050008f0f828631a07d571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be4aa68678304e5a191e410fa5a860661c3f79da9117e8829964fa868e743d11257ea02edd131f0cc0d7fee041db10059a7fe0cc63a186cc2e71236cfe513a48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7f8778c6f0786ec0bdea87d1054b539cfbd378ff6388bd68ef914d3d3c704397c19d23fc845b1b985750c9b70c885a2ab89bcdd6eabfa4a389a368e58cdd9dd"} 11:59:08 INFO - Running post-run listener: copy_logs_to_upload_dir 11:59:08 INFO - Copying logs to upload dir... 11:59:08 INFO - mkdir: /builds/slave/test/build/upload/logs 11:59:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.161020 ========= master_lag: 0.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-15 11:59:08.787053) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:59:08.790752) ========= 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=920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ba01eda08fc937514c56cedd5f32069e2e17985928b5d10ef4f256aef5186880e60fbb5d62f7a13bf1fa7ecd0dcc1cccb9bf7a4c7050008f0f828631a07d571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be4aa68678304e5a191e410fa5a860661c3f79da9117e8829964fa868e743d11257ea02edd131f0cc0d7fee041db10059a7fe0cc63a186cc2e71236cfe513a48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7f8778c6f0786ec0bdea87d1054b539cfbd378ff6388bd68ef914d3d3c704397c19d23fc845b1b985750c9b70c885a2ab89bcdd6eabfa4a389a368e58cdd9dd"} build_url:https://queue.taskcluster.net/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/B888eZ8qRBWKmMbDJFEmLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ba01eda08fc937514c56cedd5f32069e2e17985928b5d10ef4f256aef5186880e60fbb5d62f7a13bf1fa7ecd0dcc1cccb9bf7a4c7050008f0f828631a07d571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/be4aa68678304e5a191e410fa5a860661c3f79da9117e8829964fa868e743d11257ea02edd131f0cc0d7fee041db10059a7fe0cc63a186cc2e71236cfe513a48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7f8778c6f0786ec0bdea87d1054b539cfbd378ff6388bd68ef914d3d3c704397c19d23fc845b1b985750c9b70c885a2ab89bcdd6eabfa4a389a368e58cdd9dd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:59:08.825111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:59:08.825920) ========= 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=920470bf432669ad7e3a5387000001ca-1468607913.285027-273802912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:59:08.880202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:59:08.880885) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:59:08.881500) ========= ========= Total master_lag: 0.44 =========