builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1467245118.0 results: success (0) buildid: 20160629143024 builduid: 64831469a0cd4a869f5c0d9234a5f599 revision: 5ecfdfb4a997766e51465fadc7453097a830b372 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:17.996577) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:17.997181) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:17.997490) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:18.012588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:18.012960) ========= 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=eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 17:05:18-- 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-06-29 17:05:18 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113174 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:18.153976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:18.154294) ========= 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=eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022488 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:18.204378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:18.204781) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ecfdfb4a997766e51465fadc7453097a830b372 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5ecfdfb4a997766e51465fadc7453097a830b372 --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=eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 17:05:18,787 truncating revision to first 12 chars 2016-06-29 17:05:18,787 Setting DEBUG logging. 2016-06-29 17:05:18,787 attempt 1/10 2016-06-29 17:05:18,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ecfdfb4a997?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 17:05:19,110 unpacking tar archive at: fx-team-5ecfdfb4a997/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644288 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:18.863278) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:18.863630) ========= script_repo_revision: 5ecfdfb4a997766e51465fadc7453097a830b372 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:18.864056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:18.864368) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 17:05:18.873778) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 53 secs) (at 2016-06-29 17:05:18.874135) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:05:19 INFO - MultiFileLogger online at 20160629 17:05:19 in /builds/slave/test 17:05:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:05:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:05:19 INFO - {'append_to_log': False, 17:05:19 INFO - 'base_work_dir': '/builds/slave/test', 17:05:19 INFO - 'blob_upload_branch': 'Fx-Team', 17:05:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:05:19 INFO - 'branch': 'Fx-Team', 17:05:19 INFO - 'buildbot_json_path': 'buildprops.json', 17:05:19 INFO - 'config_files': ('talos/linux_config.py',), 17:05:19 INFO - 'default_actions': ('clobber', 17:05:19 INFO - 'read-buildbot-config', 17:05:19 INFO - 'download-and-extract', 17:05:19 INFO - 'populate-webroot', 17:05:19 INFO - 'create-virtualenv', 17:05:19 INFO - 'install', 17:05:19 INFO - 'run-tests'), 17:05:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:05:19 INFO - 'download_minidump_stackwalk': True, 17:05:19 INFO - 'download_symbols': 'ondemand', 17:05:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:05:19 INFO - 'tooltool.py': '/tools/tooltool.py', 17:05:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:05:19 INFO - '/tools/misc-python/virtualenv.py')}, 17:05:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:05:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:05:19 INFO - 'installer_path': 'installer.exe', 17:05:19 INFO - 'log_level': 'info', 17:05:19 INFO - 'log_name': 'talos', 17:05:19 INFO - 'log_to_console': True, 17:05:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:05:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:05:19 INFO - 'opt_config_files': (), 17:05:19 INFO - 'pip_index': False, 17:05:19 INFO - 'sps_profile': False, 17:05:19 INFO - 'sps_profile_interval': 0, 17:05:19 INFO - 'suite': 'dromaeojs-e10s', 17:05:19 INFO - 'system_bits': '32', 17:05:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:05:19 INFO - 'title': 'talos-linux64-ix-010', 17:05:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:05:19 INFO - 'use_talos_json': True, 17:05:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:05:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:05:19 INFO - 'work_dir': 'build'} 17:05:19 INFO - ##### 17:05:19 INFO - ##### Running clobber step. 17:05:19 INFO - ##### 17:05:19 INFO - Running pre-action listener: _resource_record_pre_action 17:05:19 INFO - Running main action method: clobber 17:05:19 INFO - rmtree: /builds/slave/test/build 17:05:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:05:20 INFO - Running post-action listener: _resource_record_post_action 17:05:20 INFO - ##### 17:05:20 INFO - ##### Finished clobber step (success) 17:05:20 INFO - ##### 17:05:20 INFO - ##### 17:05:20 INFO - ##### Running read-buildbot-config step. 17:05:20 INFO - ##### 17:05:20 INFO - Running pre-action listener: _resource_record_pre_action 17:05:20 INFO - Running main action method: read_buildbot_config 17:05:20 INFO - Using buildbot properties: 17:05:20 INFO - { 17:05:20 INFO - "project": "", 17:05:20 INFO - "product": "firefox", 17:05:20 INFO - "script_repo_revision": "production", 17:05:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:05:20 INFO - "repository": "", 17:05:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:05:20 INFO - "buildid": "20160629143024", 17:05:20 INFO - "pgo_build": "True", 17:05:20 INFO - "basedir": "/builds/slave/test", 17:05:20 INFO - "buildnumber": 587, 17:05:20 INFO - "slavename": "talos-linux64-ix-010", 17:05:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:05:20 INFO - "platform": "ubuntu64_hw", 17:05:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:05:20 INFO - "branch": "fx-team", 17:05:20 INFO - "repo_path": "integration/fx-team", 17:05:20 INFO - "revision": "5ecfdfb4a997766e51465fadc7453097a830b372", 17:05:20 INFO - "stage_platform": "linux64-pgo", 17:05:20 INFO - "builduid": "64831469a0cd4a869f5c0d9234a5f599", 17:05:20 INFO - "slavebuilddir": "test" 17:05:20 INFO - } 17:05:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:05:20 INFO - Running post-action listener: _resource_record_post_action 17:05:20 INFO - ##### 17:05:20 INFO - ##### Finished read-buildbot-config step (success) 17:05:20 INFO - ##### 17:05:20 INFO - ##### 17:05:20 INFO - ##### Running download-and-extract step. 17:05:20 INFO - ##### 17:05:20 INFO - Running pre-action listener: _resource_record_pre_action 17:05:20 INFO - Running main action method: download_and_extract 17:05:20 INFO - mkdir: /builds/slave/test/build/tests 17:05:20 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')]} 17:05:20 INFO - https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 17:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 17:05:21 INFO - Downloaded 1361 bytes. 17:05:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:05:21 INFO - Using the following test package requirements: 17:05:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:05:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:05:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:05:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:21 INFO - u'jsshell-linux-x86_64.zip'], 17:05:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:05:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:05:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:05:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:05:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:05:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:05:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:05:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:05:21 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')]} 17:05:21 INFO - https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:05:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:05:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:05:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 17:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 17:05:22 INFO - Downloaded 24268174 bytes. 17:05:22 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'] 17:05:22 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 17:05:24 INFO - Return code: 0 17:05:24 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 17:05:24 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')]} 17:05:24 INFO - https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:05:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:05:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:05:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 17:05:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 17:08:16 INFO - Downloaded 24268174 bytes. 17:08:16 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'] 17:08:16 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 17:08:18 INFO - Return code: 0 17:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:18 INFO - https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 17:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 17:08:30 INFO - Downloaded 14405245 bytes. 17:08:30 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'] 17:08:30 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 17:08:30 INFO - Return code: 0 17:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:30 INFO - https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 17:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 17:08:51 INFO - Downloaded 60337418 bytes. 17:08:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:08:51 INFO - mkdir: /builds/slave/test/properties 17:08:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:08:51 INFO - Writing to file /builds/slave/test/properties/build_url 17:08:51 INFO - Contents: 17:08:51 INFO - build_url:https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:08:53 INFO - Running post-action listener: _resource_record_post_action 17:08:53 INFO - Running post-action listener: set_extra_try_arguments 17:08:53 INFO - ##### 17:08:53 INFO - ##### Finished download-and-extract step (success) 17:08:53 INFO - ##### 17:08:53 INFO - ##### 17:08:53 INFO - ##### Running populate-webroot step. 17:08:53 INFO - ##### 17:08:53 INFO - Running pre-action listener: _resource_record_pre_action 17:08:53 INFO - Running main action method: populate_webroot 17:08:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:08:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:08:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:08:53 INFO - '--tppagecycles', 17:08:53 INFO - '7'], 17:08:53 INFO - 'tests': ['tsvgm']}}, 17:08:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:08:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:08:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:08:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:08:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:08:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:08:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:53 INFO - 'talos_options': ['--disable-e10s'], 17:08:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:53 INFO - 'talos_options': ['--disable-e10s'], 17:08:53 INFO - 'tests': ['damp', 'tps']}, 17:08:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:53 INFO - 'tests': ['damp', 'tps']}, 17:08:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:08:53 INFO - 'tests': ['dromaeo_dom']}, 17:08:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:08:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:08:53 INFO - 'tests': ['basic_compositor_video']}, 17:08:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:08:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:08:53 INFO - 'tests': ['a11yr', 17:08:53 INFO - 'ts_paint', 17:08:53 INFO - 'tpaint', 17:08:53 INFO - 'sessionrestore', 17:08:53 INFO - 'sessionrestore_no_auto_restore', 17:08:53 INFO - 'tabpaint']}, 17:08:53 INFO - 'other-e10s': {'tests': ['a11yr', 17:08:53 INFO - 'ts_paint', 17:08:53 INFO - 'tpaint', 17:08:53 INFO - 'sessionrestore', 17:08:53 INFO - 'sessionrestore_no_auto_restore', 17:08:53 INFO - 'tabpaint']}, 17:08:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:08:53 INFO - 'ts_paint', 17:08:53 INFO - 'tpaint', 17:08:53 INFO - 'sessionrestore', 17:08:53 INFO - 'sessionrestore_no_auto_restore', 17:08:53 INFO - 'tabpaint']}, 17:08:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:08:53 INFO - 'ts_paint', 17:08:53 INFO - 'tpaint', 17:08:53 INFO - 'sessionrestore', 17:08:53 INFO - 'sessionrestore_no_auto_restore', 17:08:53 INFO - 'tabpaint']}, 17:08:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:08:53 INFO - 'tests': ['a11yr', 17:08:53 INFO - 'ts_paint', 17:08:53 INFO - 'tpaint', 17:08:53 INFO - 'sessionrestore', 17:08:53 INFO - 'sessionrestore_no_auto_restore', 17:08:53 INFO - 'tabpaint']}, 17:08:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:08:53 INFO - 'tests': ['a11yr', 17:08:53 INFO - 'ts_paint', 17:08:53 INFO - 'tpaint', 17:08:53 INFO - 'sessionrestore', 17:08:53 INFO - 'sessionrestore_no_auto_restore', 17:08:53 INFO - 'tabpaint']}, 17:08:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:08:53 INFO - 'tests': ['tsvgx', 17:08:53 INFO - 'tsvgr_opacity', 17:08:53 INFO - 'tart', 17:08:53 INFO - 'tscrollx', 17:08:53 INFO - 'cart']}, 17:08:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:08:53 INFO - 'tsvgr_opacity', 17:08:53 INFO - 'tart', 17:08:53 INFO - 'tscrollx', 17:08:53 INFO - 'cart']}, 17:08:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:53 INFO - 'talos_options': ['--disable-e10s'], 17:08:53 INFO - 'tests': ['tp5o']}, 17:08:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:53 INFO - 'tests': ['tp5o']}, 17:08:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:53 INFO - 'talos_options': ['--disable-e10s', 17:08:53 INFO - '--xperf_path', 17:08:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:53 INFO - 'tests': ['tp5n']}, 17:08:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:53 INFO - 'talos_options': ['--xperf_path', 17:08:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:53 INFO - 'tests': ['tp5n']}}, 17:08:53 INFO - 'talos.zip': {'path': '', 17:08:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:08:53 INFO - Running post-action listener: _resource_record_post_action 17:08:53 INFO - ##### 17:08:53 INFO - ##### Finished populate-webroot step (success) 17:08:53 INFO - ##### 17:08:53 INFO - ##### 17:08:53 INFO - ##### Running create-virtualenv step. 17:08:53 INFO - ##### 17:08:53 INFO - Running pre-action listener: _resource_record_pre_action 17:08:53 INFO - Running main action method: create_virtualenv 17:08:53 INFO - Creating virtualenv /builds/slave/test/build/venv 17:08:53 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 17:08:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:08:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:08:53 INFO - Using real prefix '/usr' 17:08:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:08:53 INFO - Installing distribute.............................................................................................................................................................................................done. 17:08:55 INFO - Installing pip.................done. 17:08:55 INFO - Return code: 0 17:08:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:55 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 0x144c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b3b0>, '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 0x170c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170c740>, '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': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', '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 17:08:55 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 17:08:55 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 17:08:55 INFO - Using env: {'DISPLAY': ':0', 17:08:55 INFO - 'HOME': '/home/cltbld', 17:08:55 INFO - 'LANG': 'en_US.UTF-8', 17:08:55 INFO - 'LANGUAGE': 'en_US:en', 17:08:55 INFO - 'LOGNAME': 'cltbld', 17:08:55 INFO - 'MAIL': '/var/mail/cltbld', 17:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:55 INFO - 'MOZ_NO_REMOTE': '1', 17:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:55 INFO - 'NO_EM_RESTART': '1', 17:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:55 INFO - 'PWD': '/builds/slave/test', 17:08:55 INFO - 'SHELL': '/bin/bash', 17:08:55 INFO - 'SHLVL': '1', 17:08:55 INFO - 'TERM': 'linux', 17:08:55 INFO - 'TMOUT': '86400', 17:08:55 INFO - 'USER': 'cltbld', 17:08:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', 17:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:55 INFO - '_': '/tools/buildbot/bin/python'} 17:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:55 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 17:08:55 INFO - Cleaning up... 17:08:55 INFO - Return code: 0 17:08:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:55 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 0x144c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b3b0>, '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 0x170c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170c740>, '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': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', '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 17:08:55 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 17:08:55 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 17:08:55 INFO - Using env: {'DISPLAY': ':0', 17:08:55 INFO - 'HOME': '/home/cltbld', 17:08:55 INFO - 'LANG': 'en_US.UTF-8', 17:08:55 INFO - 'LANGUAGE': 'en_US:en', 17:08:55 INFO - 'LOGNAME': 'cltbld', 17:08:55 INFO - 'MAIL': '/var/mail/cltbld', 17:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:55 INFO - 'MOZ_NO_REMOTE': '1', 17:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:55 INFO - 'NO_EM_RESTART': '1', 17:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:55 INFO - 'PWD': '/builds/slave/test', 17:08:55 INFO - 'SHELL': '/bin/bash', 17:08:55 INFO - 'SHLVL': '1', 17:08:55 INFO - 'TERM': 'linux', 17:08:55 INFO - 'TMOUT': '86400', 17:08:55 INFO - 'USER': 'cltbld', 17:08:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', 17:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:55 INFO - '_': '/tools/buildbot/bin/python'} 17:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:56 INFO - Downloading/unpacking psutil>=3.1.1 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:08:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:58 INFO - Installing collected packages: psutil 17:08:58 INFO - Running setup.py install for psutil 17:08:58 INFO - building 'psutil._psutil_linux' extension 17:08:58 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 17:08:58 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 17:08:58 INFO - building 'psutil._psutil_posix' extension 17:08:58 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 17:08:58 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 17:08:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:58 INFO - Successfully installed psutil 17:08:58 INFO - Cleaning up... 17:08:58 INFO - Return code: 0 17:08:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b3b0>, '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 0x170c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170c740>, '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': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', '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 17:08: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:08: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 mozsystemmonitor==0.3 17:08:58 INFO - Using env: {'DISPLAY': ':0', 17:08:58 INFO - 'HOME': '/home/cltbld', 17:08:58 INFO - 'LANG': 'en_US.UTF-8', 17:08:58 INFO - 'LANGUAGE': 'en_US:en', 17:08:58 INFO - 'LOGNAME': 'cltbld', 17:08:58 INFO - 'MAIL': '/var/mail/cltbld', 17:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:58 INFO - 'MOZ_NO_REMOTE': '1', 17:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:58 INFO - 'NO_EM_RESTART': '1', 17:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:58 INFO - 'PWD': '/builds/slave/test', 17:08:58 INFO - 'SHELL': '/bin/bash', 17:08:58 INFO - 'SHLVL': '1', 17:08:58 INFO - 'TERM': 'linux', 17:08:58 INFO - 'TMOUT': '86400', 17:08:58 INFO - 'USER': 'cltbld', 17:08:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', 17:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:58 INFO - '_': '/tools/buildbot/bin/python'} 17:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:09:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:09:00 INFO - Installing collected packages: mozsystemmonitor 17:09:00 INFO - Running setup.py install for mozsystemmonitor 17:09:00 INFO - Successfully installed mozsystemmonitor 17:09:00 INFO - Cleaning up... 17:09:01 INFO - Return code: 0 17:09:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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', '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 0x144c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b3b0>, '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 0x170c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170c740>, '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': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', '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 17:09: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:09: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 jsonschema==2.5.1 17:09:01 INFO - Using env: {'DISPLAY': ':0', 17:09:01 INFO - 'HOME': '/home/cltbld', 17:09:01 INFO - 'LANG': 'en_US.UTF-8', 17:09:01 INFO - 'LANGUAGE': 'en_US:en', 17:09:01 INFO - 'LOGNAME': 'cltbld', 17:09:01 INFO - 'MAIL': '/var/mail/cltbld', 17:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:01 INFO - 'MOZ_NO_REMOTE': '1', 17:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:01 INFO - 'NO_EM_RESTART': '1', 17:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:01 INFO - 'PWD': '/builds/slave/test', 17:09:01 INFO - 'SHELL': '/bin/bash', 17:09:01 INFO - 'SHLVL': '1', 17:09:01 INFO - 'TERM': 'linux', 17:09:01 INFO - 'TMOUT': '86400', 17:09:01 INFO - 'USER': 'cltbld', 17:09:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', 17:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:01 INFO - '_': '/tools/buildbot/bin/python'} 17:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:01 INFO - Downloading/unpacking jsonschema==2.5.1 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:03 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:09:03 INFO - warning: no files found matching '*.txt' 17:09:03 INFO - no previously-included directories found matching 'build' 17:09:03 INFO - no previously-included directories found matching 'dist' 17:09:03 INFO - no previously-included directories found matching '.git*' 17:09:03 INFO - Installing collected packages: jsonschema, functools32 17:09:03 INFO - Running setup.py install for functools32 17:09:03 INFO - warning: no files found matching '*.txt' 17:09:03 INFO - no previously-included directories found matching 'build' 17:09:03 INFO - no previously-included directories found matching 'dist' 17:09:03 INFO - no previously-included directories found matching '.git*' 17:09:03 INFO - Successfully installed jsonschema functools32 17:09:03 INFO - Cleaning up... 17:09:03 INFO - Return code: 0 17:09:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:09:03 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')]} 17:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:03 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')]} 17:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:03 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 0x144c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b3b0>, '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 0x170c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170c740>, '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': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', '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 17:09:03 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 17:09:03 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 17:09:03 INFO - Using env: {'DISPLAY': ':0', 17:09:03 INFO - 'HOME': '/home/cltbld', 17:09:03 INFO - 'LANG': 'en_US.UTF-8', 17:09:03 INFO - 'LANGUAGE': 'en_US:en', 17:09:03 INFO - 'LOGNAME': 'cltbld', 17:09:03 INFO - 'MAIL': '/var/mail/cltbld', 17:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:03 INFO - 'MOZ_NO_REMOTE': '1', 17:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:03 INFO - 'NO_EM_RESTART': '1', 17:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:03 INFO - 'PWD': '/builds/slave/test', 17:09:03 INFO - 'SHELL': '/bin/bash', 17:09:03 INFO - 'SHLVL': '1', 17:09:03 INFO - 'TERM': 'linux', 17:09:03 INFO - 'TMOUT': '86400', 17:09:03 INFO - 'USER': 'cltbld', 17:09:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', 17:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:03 INFO - '_': '/tools/buildbot/bin/python'} 17:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:03 INFO - Downloading/unpacking blobuploader==1.2.4 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:05 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:09:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:06 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 17:09:06 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 17:09:06 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 17:09:06 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 17:09:06 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 17:09:06 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 17:09:06 INFO - Downloading docopt-0.6.1.tar.gz 17:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:06 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:06 INFO - Running setup.py install for blobuploader 17:09:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:09:06 INFO - Running setup.py install for requests 17:09:07 INFO - Running setup.py install for docopt 17:09:07 INFO - Successfully installed blobuploader requests docopt 17:09:07 INFO - Cleaning up... 17:09:07 INFO - Return code: 0 17:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:07 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 0x144c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b3b0>, '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 0x170c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170c740>, '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': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', '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 17:09:07 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 17:09:07 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 17:09:07 INFO - Using env: {'DISPLAY': ':0', 17:09:07 INFO - 'HOME': '/home/cltbld', 17:09:07 INFO - 'LANG': 'en_US.UTF-8', 17:09:07 INFO - 'LANGUAGE': 'en_US:en', 17:09:07 INFO - 'LOGNAME': 'cltbld', 17:09:07 INFO - 'MAIL': '/var/mail/cltbld', 17:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:07 INFO - 'MOZ_NO_REMOTE': '1', 17:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:07 INFO - 'NO_EM_RESTART': '1', 17:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:07 INFO - 'PWD': '/builds/slave/test', 17:09:07 INFO - 'SHELL': '/bin/bash', 17:09:07 INFO - 'SHLVL': '1', 17:09:07 INFO - 'TERM': 'linux', 17:09:07 INFO - 'TMOUT': '86400', 17:09:07 INFO - 'USER': 'cltbld', 17:09:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', 17:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:07 INFO - '_': '/tools/buildbot/bin/python'} 17:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:07 INFO - Running setup.py (path:/tmp/pip-ieIPvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:07 INFO - Running setup.py (path:/tmp/pip-e8Le7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:07 INFO - Running setup.py (path:/tmp/pip-1Ml13j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:07 INFO - Running setup.py (path:/tmp/pip-gRwgEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:07 INFO - Running setup.py (path:/tmp/pip-7lerZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:07 INFO - Running setup.py (path:/tmp/pip-kcUznb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:07 INFO - Running setup.py (path:/tmp/pip-wmiRwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:07 INFO - Running setup.py (path:/tmp/pip-R1_D7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:08 INFO - Running setup.py (path:/tmp/pip-xqpFZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:08 INFO - Running setup.py (path:/tmp/pip-wPrxwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:08 INFO - Running setup.py (path:/tmp/pip-Vbkhav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:08 INFO - Running setup.py (path:/tmp/pip-N_b7ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:08 INFO - Running setup.py (path:/tmp/pip-ycyKHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:08 INFO - Running setup.py (path:/tmp/pip-14bwpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:08 INFO - Running setup.py (path:/tmp/pip-HsaA9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:08 INFO - Running setup.py (path:/tmp/pip-rbLHKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:08 INFO - Running setup.py (path:/tmp/pip-IU9_xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:08 INFO - Running setup.py install for manifestparser 17:09:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:09:08 INFO - Running setup.py install for mozcrash 17:09:08 INFO - Running setup.py install for mozdebug 17:09:08 INFO - Running setup.py install for mozdevice 17:09:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Running setup.py install for mozfile 17:09:09 INFO - Running setup.py install for mozhttpd 17:09:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Running setup.py install for mozinfo 17:09:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Running setup.py install for mozInstall 17:09:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Running setup.py install for mozleak 17:09:09 INFO - Running setup.py install for mozlog 17:09:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Running setup.py install for moznetwork 17:09:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Running setup.py install for mozprocess 17:09:09 INFO - Running setup.py install for mozprofile 17:09:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:09:10 INFO - Running setup.py install for mozrunner 17:09:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:09:10 INFO - Running setup.py install for mozscreenshot 17:09:10 INFO - Running setup.py install for moztest 17:09:10 INFO - Running setup.py install for mozversion 17:09:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:09:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:10 INFO - Cleaning up... 17:09:10 INFO - Return code: 0 17:09:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:10 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 0x144c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b3b0>, '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 0x170c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170c740>, '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': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', '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 17:09:10 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 17:09:10 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 17:09:10 INFO - Using env: {'DISPLAY': ':0', 17:09:10 INFO - 'HOME': '/home/cltbld', 17:09:10 INFO - 'LANG': 'en_US.UTF-8', 17:09:10 INFO - 'LANGUAGE': 'en_US:en', 17:09:10 INFO - 'LOGNAME': 'cltbld', 17:09:10 INFO - 'MAIL': '/var/mail/cltbld', 17:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:10 INFO - 'MOZ_NO_REMOTE': '1', 17:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:10 INFO - 'NO_EM_RESTART': '1', 17:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:10 INFO - 'PWD': '/builds/slave/test', 17:09:10 INFO - 'SHELL': '/bin/bash', 17:09:10 INFO - 'SHLVL': '1', 17:09:10 INFO - 'TERM': 'linux', 17:09:10 INFO - 'TMOUT': '86400', 17:09:10 INFO - 'USER': 'cltbld', 17:09:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', 17:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:10 INFO - '_': '/tools/buildbot/bin/python'} 17:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:10 INFO - Running setup.py (path:/tmp/pip-hSJh5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:10 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)) 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:10 INFO - Running setup.py (path:/tmp/pip-7ajcwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:10 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)) 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:10 INFO - Running setup.py (path:/tmp/pip-7ITO8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:10 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)) 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:10 INFO - Running setup.py (path:/tmp/pip-ZJCJon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:10 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)) 17:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:10 INFO - Running setup.py (path:/tmp/pip-gLhEkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:11 INFO - Running setup.py (path:/tmp/pip-fylOXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:11 INFO - Running setup.py (path:/tmp/pip-p1zbpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:11 INFO - Running setup.py (path:/tmp/pip-h0XbT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:11 INFO - Running setup.py (path:/tmp/pip-eV8P4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:11 INFO - Running setup.py (path:/tmp/pip-OW2g3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:11 INFO - Running setup.py (path:/tmp/pip-FPQFjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:11 INFO - Running setup.py (path:/tmp/pip-dAXlUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:11 INFO - Running setup.py (path:/tmp/pip-reY_bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:11 INFO - Running setup.py (path:/tmp/pip-aU2vvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:11 INFO - Running setup.py (path:/tmp/pip-m6FQNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:11 INFO - Running setup.py (path:/tmp/pip-wFfqcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:11 INFO - Running setup.py (path:/tmp/pip-MmEnty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:11 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)) 17:09:11 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)) 17:09:11 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)) 17:09:11 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)) 17:09:11 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)) 17:09:11 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)) 17:09:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:13 INFO - Downloading blessings-1.6.tar.gz 17:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:09:13 INFO - Installing collected packages: blessings 17:09:13 INFO - Running setup.py install for blessings 17:09:13 INFO - Successfully installed blessings 17:09:13 INFO - Cleaning up... 17:09:14 INFO - Return code: 0 17:09:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:14 INFO - Reading from file tmpfile_stdout 17:09:14 INFO - Current package versions: 17:09:14 INFO - argparse == 1.2.1 17:09:14 INFO - blessings == 1.6 17:09:14 INFO - blobuploader == 1.2.4 17:09:14 INFO - docopt == 0.6.1 17:09:14 INFO - functools32 == 3.2.3-2 17:09:14 INFO - jsonschema == 2.5.1 17:09:14 INFO - manifestparser == 1.1 17:09:14 INFO - mozInstall == 1.12 17:09:14 INFO - mozcrash == 0.17 17:09:14 INFO - mozdebug == 0.1 17:09:14 INFO - mozdevice == 0.48 17:09:14 INFO - mozfile == 1.2 17:09:14 INFO - mozhttpd == 0.7 17:09:14 INFO - mozinfo == 0.9 17:09:14 INFO - mozleak == 0.1 17:09:14 INFO - mozlog == 3.2 17:09:14 INFO - moznetwork == 0.27 17:09:14 INFO - mozprocess == 0.22 17:09:14 INFO - mozprofile == 0.28 17:09:14 INFO - mozrunner == 6.11 17:09:14 INFO - mozscreenshot == 0.1 17:09:14 INFO - mozsystemmonitor == 0.3 17:09:14 INFO - moztest == 0.7 17:09:14 INFO - mozversion == 1.4 17:09:14 INFO - psutil == 3.1.1 17:09:14 INFO - requests == 1.2.3 17:09:14 INFO - wsgiref == 0.1.2 17:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:14 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')]} 17:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:14 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')]} 17:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:14 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 0x144c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b3b0>, '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 0x170c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170c740>, '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': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', '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 17:09:14 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 17:09:14 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 17:09:14 INFO - Using env: {'DISPLAY': ':0', 17:09:14 INFO - 'HOME': '/home/cltbld', 17:09:14 INFO - 'LANG': 'en_US.UTF-8', 17:09:14 INFO - 'LANGUAGE': 'en_US:en', 17:09:14 INFO - 'LOGNAME': 'cltbld', 17:09:14 INFO - 'MAIL': '/var/mail/cltbld', 17:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:14 INFO - 'MOZ_NO_REMOTE': '1', 17:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:14 INFO - 'NO_EM_RESTART': '1', 17:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:14 INFO - 'PWD': '/builds/slave/test', 17:09:14 INFO - 'SHELL': '/bin/bash', 17:09:14 INFO - 'SHLVL': '1', 17:09:14 INFO - 'TERM': 'linux', 17:09:14 INFO - 'TMOUT': '86400', 17:09:14 INFO - 'USER': 'cltbld', 17:09:14 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', 17:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:14 INFO - '_': '/tools/buildbot/bin/python'} 17:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 INFO - Cleaning up... 17:09:14 INFO - Return code: 0 17:09:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:09:14 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')]} 17:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:14 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')]} 17:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:14 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 0x144c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170b3b0>, '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 0x170c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170c740>, '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': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', '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 17:09:14 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 17:09:14 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 17:09:14 INFO - Using env: {'DISPLAY': ':0', 17:09:14 INFO - 'HOME': '/home/cltbld', 17:09:14 INFO - 'LANG': 'en_US.UTF-8', 17:09:14 INFO - 'LANGUAGE': 'en_US:en', 17:09:14 INFO - 'LOGNAME': 'cltbld', 17:09:14 INFO - 'MAIL': '/var/mail/cltbld', 17:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:14 INFO - 'MOZ_NO_REMOTE': '1', 17:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:14 INFO - 'NO_EM_RESTART': '1', 17:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:14 INFO - 'PWD': '/builds/slave/test', 17:09:14 INFO - 'SHELL': '/bin/bash', 17:09:14 INFO - 'SHLVL': '1', 17:09:14 INFO - 'TERM': 'linux', 17:09:14 INFO - 'TMOUT': '86400', 17:09:14 INFO - 'USER': 'cltbld', 17:09:14 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', 17:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:14 INFO - '_': '/tools/buildbot/bin/python'} 17:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:09:14 INFO - Cleaning up... 17:09:14 INFO - Return code: 0 17:09:14 INFO - Running post-action listener: _resource_record_post_action 17:09:14 INFO - Running post-action listener: _start_resource_monitoring 17:09:14 INFO - Starting resource monitoring. 17:09:14 INFO - ##### 17:09:14 INFO - ##### Finished create-virtualenv step (success) 17:09:14 INFO - ##### 17:09:14 INFO - ##### 17:09:14 INFO - ##### Running install step. 17:09:14 INFO - ##### 17:09:14 INFO - Running pre-action listener: _resource_record_pre_action 17:09:14 INFO - Running main action method: install 17:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:14 INFO - Reading from file tmpfile_stdout 17:09:14 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:09:15 INFO - Reading from file tmpfile_stdout 17:09:15 INFO - Output received: 17:09:15 INFO - Usage: mozinstall [options] installer 17:09:15 INFO - Options: 17:09:15 INFO - -h, --help show this help message and exit 17:09:15 INFO - -d DEST, --destination=DEST 17:09:15 INFO - Directory to install application into. [default: 17:09:15 INFO - "/builds/slave/test"] 17:09:15 INFO - --app=APP Application being installed. [default: firefox] 17:09:15 INFO - mkdir: /builds/slave/test/build/application 17:09:15 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'] 17:09:15 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 17:09:32 INFO - Reading from file tmpfile_stdout 17:09:32 INFO - Output received: 17:09:32 INFO - /builds/slave/test/build/application/firefox/firefox 17:09:32 INFO - Running post-action listener: _resource_record_post_action 17:09:32 INFO - ##### 17:09:32 INFO - ##### Finished install step (success) 17:09:32 INFO - ##### 17:09:32 INFO - ##### 17:09:32 INFO - ##### Running run-tests step. 17:09:32 INFO - ##### 17:09:32 INFO - Running pre-action listener: _resource_record_pre_action 17:09:32 INFO - Running main action method: run_tests 17:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:09:32 INFO - Python 2.7.3 17:09:32 INFO - Return code: 0 17:09:32 INFO - grabbing minidump binary from tooltool 17:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:32 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 0x170b3b0>, '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 0x170c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:09:32 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 17:09:32 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 17:09:32 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 17:09:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:32 INFO - Return code: 0 17:09:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:09:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:09:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:09:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:09:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 17:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 17:09:32 INFO - Using env: {'DISPLAY': ':0', 17:09:32 INFO - 'HOME': '/home/cltbld', 17:09:32 INFO - 'LANG': 'en_US.UTF-8', 17:09:32 INFO - 'LANGUAGE': 'en_US:en', 17:09:32 INFO - 'LOGNAME': 'cltbld', 17:09:32 INFO - 'MAIL': '/var/mail/cltbld', 17:09:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:09:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:32 INFO - 'MOZ_NO_REMOTE': '1', 17:09:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:32 INFO - 'NO_EM_RESTART': '1', 17:09:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:32 INFO - 'PWD': '/builds/slave/test', 17:09:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:09:32 INFO - 'SHELL': '/bin/bash', 17:09:32 INFO - 'SHLVL': '1', 17:09:32 INFO - 'TERM': 'linux', 17:09:32 INFO - 'TMOUT': '86400', 17:09:32 INFO - 'USER': 'cltbld', 17:09:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142', 17:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:32 INFO - '_': '/tools/buildbot/bin/python'} 17:09:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 17:09:32 INFO - mozversion application_buildid: 20160629143024 17:09:32 INFO - mozversion application_changeset: 5ecfdfb4a997766e51465fadc7453097a830b372 17:09:32 INFO - mozversion application_display_name: Nightly 17:09:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:32 INFO - mozversion application_name: Firefox 17:09:32 INFO - mozversion application_remotingname: firefox 17:09:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:09:32 INFO - mozversion application_vendor: Mozilla 17:09:32 INFO - mozversion application_version: 50.0a1 17:09:32 INFO - mozversion platform_buildid: 20160629143024 17:09:32 INFO - mozversion platform_changeset: 5ecfdfb4a997766e51465fadc7453097a830b372 17:09:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:09:32 INFO - mozversion platform_version: 50.0a1 17:09:32 INFO - using testdate: 1467245372 17:09:32 INFO - actual date: 1467245372 17:09:32 INFO - starting webserver on 'localhost:50742' 17:09:32 INFO - SUITE-START | Running 2 tests 17:09:32 INFO - TEST-START | dromaeo_css 17:09:32 INFO - operating with platform_type : linux_ 17:09:32 INFO - Initialising browser for dromaeo_css test... 17:09:32 INFO - TEST-INFO | started process 25963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMejEGR/profile http://localhost:50742/getInfo.html) 17:09:37 INFO - PROCESS | 25963 | __metrics Screen width/height:1600/1200 17:09:37 INFO - PROCESS | 25963 | colorDepth:24 17:09:37 INFO - PROCESS | 25963 | Browser inner width/height: 1024/697 17:09:37 INFO - PROCESS | 25963 | __metrics 17:09:38 ERROR - PROCESS | 25963 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:09:39 INFO - TEST-INFO | 25963: exit 0 17:09:39 INFO - Browser initialized. 17:09:39 INFO - Running cycle 1/1 for dromaeo_css test... 17:09:39 INFO - TEST-INFO | started process 26083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMejEGR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:51 INFO - PROCESS | 26083 | RSS: Main: 168329216 17:09:51 INFO - PROCESS | 26083 | 17:10:40 INFO - PROCESS | 26083 | 1467245440662 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] 17:12:48 INFO - PROCESS | 26083 | Cycle 1(1): loaded http://localhost:50742/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50742/tests/dromaeo/cssquery-ext.html) 17:12:49 INFO - PROCESS | 26083 | RSS: Main: 172580864 17:12:49 INFO - PROCESS | 26083 | 17:15:51 INFO - PROCESS | 26083 | Cycle 1(1): loaded http://localhost:50742/tests/dromaeo/cssquery-ext.html (next: http://localhost:50742/tests/dromaeo/cssquery-jquery.html) 17:15:52 INFO - PROCESS | 26083 | RSS: Main: 168763392 17:15:52 INFO - PROCESS | 26083 | 17:18:54 INFO - PROCESS | 26083 | Cycle 1(1): loaded http://localhost:50742/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50742/tests/dromaeo/cssquery-mootools.html) 17:18:54 INFO - PROCESS | 26083 | RSS: Main: 172437504 17:18:54 INFO - PROCESS | 26083 | 17:21:56 INFO - PROCESS | 26083 | Cycle 1(1): loaded http://localhost:50742/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50742/tests/dromaeo/cssquery-prototype.html) 17:21:57 INFO - PROCESS | 26083 | RSS: Main: 168009728 17:21:57 INFO - PROCESS | 26083 | 17:24:59 INFO - PROCESS | 26083 | Cycle 1(1): loaded http://localhost:50742/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50742/tests/dromaeo/cssquery-yui.html) 17:25:00 INFO - PROCESS | 26083 | RSS: Main: 169832448 17:25:00 INFO - PROCESS | 26083 | 17:28:02 INFO - PROCESS | 26083 | Cycle 1(1): loaded http://localhost:50742/tests/dromaeo/cssquery-yui.html (next: http://localhost:50742/tests/dromaeo/cssquery-dojo.html) 17:28:03 INFO - PROCESS | 26083 | RSS: Main: 171081728 17:28:03 INFO - PROCESS | 26083 | 17:28:03 INFO - PROCESS | 26083 | __start_tp_report 17:28:03 INFO - PROCESS | 26083 | _x_x_mozilla_page_load 17:28:03 INFO - PROCESS | 26083 | _x_x_mozilla_page_load_details 17:28:03 INFO - PROCESS | 26083 | |i|pagename|runs| 17:28:03 INFO - PROCESS | 26083 | |0;dojo.html;3140.5289206619004;3141.6230052393717;3179.046286114165;3184.267618447757;3186.745060395169;5311.62818602698;5324.520793128618;5379.784808607656;5440.945590544094;5441.59188060895;5271.077561426745;5362.490563396481;5401.378841433237;5409.756560954756;5430.15832545955;4858.878528036792;4893.902121957559;5022.522860328263;5067.695938243699;5108.8211912583065;720.3187393638858;4965.627577931651;5031.345925029759;5041.72270525121;5087.5421212090905;4942.481039490874;4943.555080042777;4969.105560999019;4999.999999999996;5048.596112311006;4853.927191092136;4978.77595508203;4985.501449855022;4998.925016124761;5043.42000669924;4853.805847766085;4866.3673722416215;4880;4883.072216278932;4894.755262236874;5363.141897296453;5462.481064298885;5467.480589344006;5474.616776825624;5484.588655850827;5762.222100016486;5814.244148260741;5857.76568937242;5885.205497257858;5914.881702365971;5859.4433528815125;5912.615679980788;5915.704214789286;5917.378675239081;5964.314103878066;5497.725113744297;5524.088525393306;5525.723713814334;5527.419620939824;5530.419305972895;5866.589338746332;5924.7926322578505;5936.376680448577;5938.673372964528;6019.127226552213;5720.8283751487525;5739.110437882052;5743.8564035899435;5747.1379293106365;5748.626339287933;5813.273340832396;5818.738156782955;5827.242458480455;5830.154627578977;5832.066869300891;5687.203791469197;5804.65172089676;5834.416558344216;5871.588988770745;5910.468057874812;5582.497575218169;5829.446202610745;5844.766209351664;5869.442402971711;5870.412958704095;4497.370368148462;4521.050579378368;4523.683342166082;4525.502194758574;4560.543945605413;3877.7867217302755;3917.9020524487114;3950.6049395060263;3982.561918188997;4000.9199816003515;5567.969925563783;5568.749406276727;5569.220309156722;5606.131049687305;5608.298962629671;5821.650700957956;5885.941140588625;5898.8230353089475;5901.114832775118;5922.378150294157;5415.756290966916;5434.456554344534;5452.40023597404;5467.4532546745;5468.152436372368;4966;4968.378952630921;5002.274670172805;5002.449730529639;5023.79904803811;5885.411458854081;5958.612690175125;5964.135200395918;5972.850678733066;5979.611325263844;5812.041013232853;5816;5822.7670893163795;5873.559483038704;5892.911606325994;6029.939700603113;6030.30651475086;6033.456988871023;6046.818595442144;6100.603460775035;5649.37856835756;5711.714414279352;5777.566682498746;5781.248437703071;5818.098194779646;5822.592418530662;5878.735456904364;5884.08796636522;5892.175095486549;5971.701414929149;5664.631798933221;5706.486416222394;5709.20071190042;5714.342850572071;5714.914276285942;5461.453854614507;5634.464725851038;5657.60396772222;5659.6321239119325;5704.743286552032;5360.946390536044;5469.72651367438;5497.422770609189;5542.584306176972;5707.229524014205;5634.74643641029;5687.488126068673;5714.399988001366;5733.627314224562;5735.311762588516;5443.510084092451;5559.555235581063;5590.608657393944;5594.720263986703;5597.356304024926 17:28:03 INFO - PROCESS | 26083 | |1;ext.html;581.7963712700555;618.5391883047131;627.30369290088;632.2097378277152;634.3814780588923;41901.58098419015;43267.350989735176;43341.78329108354;43441.78279108604;46446.30330545045;44052.77973610136;44264.11471770563;44602.55397446024;44639.330410043876;44754.10491790162;8822.867656985134;8974;8979.14698103679;8984.371094023389;8989.685361012365;8614.224719775219;8639.39524233304;8708.259797917184;8724.607392667314;8737.475751454902;8759.562021898912;8768.649254029831;8794;8807.735767926972;8809.163129502718;8672.60973256205;8683.652653893836;8686.435381700168;8691.652333906668;8699.565021748887;8789.472631642058;8854.822903541894;8865.468071915706;8867.379283450162;8891.644334226623;42599.36100958488;42964.785176074234;42974.78512607448;43087.35368969468;43100;3698.519192504984;3727.049602351383;4172.958270417287;4209.431726716884;4315.39584458173;29679.25801854949;29873.850630746707;31667.683323166704;32415;33200.16999575006;4144.254034273829;4154.124923252023;4154.626083652486;4167.374893765929;4194.622483976426;359155;360163;360851;360976;361584;35195.64804351975;36234;56433.43566564282;56462.15306770402;56691;37404.43893341602;37467.437988430196;37476.62523374786;37518.624813751514;37589.24821503554;15542.300596473186;15635;15668.373265069498;15807.446739364066;15882.682346353009;13249.73500529984;13351.599452016455;13395.531156409479;13454.394552245172;13479;8618.482891026559;8631.697890573925;8693.565321733888;8795.120487951153;8828.955855220684;3404.6425125361975;3414.5048967899515;3470.687638112582;3503.9474407883904;3516.6307537708685;1037.190991027;1040.4508953065022;1092.355510248957;1101.2786624760795;1126.2904370246856;31827.363452730817;31857.203569910474;31901.20246993844;32199.51700724491;32256.516152257736;1088.755030118233;1115.525901491879;1138.8177891537314;1145.6849366424133;1189.851268591426;16419.5895102621;16689.49931502057;16720.74918876218;16748.41380551675;16903.323867045427;543091;547110;549038;550229;553059;56756.71621641948;57887;58202.41797582055;58324.416755832746;58364.4163558359;1376.7246550689902;1377.3595278195687;1380.6893448974101;1394.965125871841;1401.3973991183684;30193.69806301997;31831.522527161647;31952.520712189802;32117.839410802797;32132.518012230303;44739;45127;45276.32085518654;45323.546764533254;45471.31793023041;413666;415496;416374;417308;417484;28674.139775806758;28808.732087738194;28966;29287.267818304714;29312.853435732686;47938;48425;48851;49064.509354906;49276.2608560879;41246.38130428106;41684;41866;42402.36396453994;42745.78627106844;41119.588804111576;41131.7943410281;41551.7922410386;41604.58395416007;42300.78849605732;34087.4886876702;39701.404478933415;39804;39811.20377592374;40678;35425.645743542234;37510;37609.623903760614;38077.238455231294;38088.809555952044;28234.2941426466;28726.425471490034;28806;28940.27649308784;29027.56458653164 17:28:03 INFO - PROCESS | 26083 | |2;jquery.html;404.24406360106593;405.23208519854876;414.5481425246481;417.8036322928224;424.8810333106731;18326.633467330645;19973.201071957123;20053.799462005376;20676.379708608765;21564.813935233557;12042.277463352184;12054.276743395381;12065.33640649764;12110.27338359699;12328.753424931518;5271.920921186175;5351.304330437038;5374.973125134388;5400.270963419927;5406.8918621627545;5459.208414779854;5905.43898329658;5912.615679980788;5919.43765342294;5939.495142912836;5631.183478395651;5821.3887541808135;5843.415658434144;5857.6778277194735;5859.384764599719;5872.119182122673;5905.6751878646655;5917.260342457193;5919.792807251725;5925.081612350093;5037.546620804109;5256.159014557652;5284.39229488606;5291.947080529222;5341.0653135701095;13346.33268336589;13348.73302533944;17245.051522166403;24231.515369692508;24474.51050978988;2249.966250506244;2528.759767822054;2557.6291437741424;2754.986225068882;2755.8976409436186;9389.342746007782;9456.290778191664;9533.427994320293;9625.326227164102;10309.690709278733;1933.9129739161772;1979.8218160365636;1983.7321961535151;1994.9601007979904;1995.6806910894188;83500.16499834985;84182;84677.57661211655;85942;86944.56527717384;10990.010899018967;11218.943905280585;11235.66293011211;11240.100791936626;11301.830472542919;15720.528384148494;15751.763723544156;15823.367065317489;15841.128737919295;15842.207889605705;8507.744767656981;8558.486490810572;8637.611307491177;8700.214832341702;8879.467231966102;8642.351823613255;8694.478331300143;8783.121687831293;8880.467171969702;8919.554022298858;4549.203889319356;4699.355225670988;4773.498782627774;4922.360093187935;4965.896314803248;1971.8915459649857;2002.8698134621202;2005.9899700501696;2011.6278488479677;2019.1822311963679;928.4846909964899;962.3263715399248;968.1770495079127;997.8553109799184;1048.4233671480808;20116.39650810478;20476.488087797625;20479.79520204779;20494.282700105425;20524.486887827923;1026.7330494071446;1032.7831155457438;1041.5156952017348;1054.947252637365;1085.2023762534532;11031.172662050378;11457.369844658624;11494.597689080842;11507.367094809866;11560.94219528897;512927;533438;539199;541456;541582;66152;67571.32428675749;99441.50279248557;99650;100056.49971750095;907.6006557114848;922.0042354257386;922.1193759959223;933.8785957825439;939.6006697153682;17368.21843017042;17738;18066.548336291697;18711.06444677788;18853.15160817794;37961.4305785419;46111.76944115258;46147;47153.292700608836;47331.763341183076;58494.707526462094;63090.369096310285;63740;63831.361686382545;64923.35076649173;8616.526091065052;8867.334949878656;8870.86693699582;8896.644134234559;9003.324750643858;10086.798264034825;14105.29473526299;14133.293335332986;14547.272636367927;14923.701525969203;12435.564755233523;12625.81061284063;12681.112322137362;12687.619371418872;12898;12033.338166400932;12442.129050966345;12484.063695222712;12491.75016499683;12647.936760316139;12656.17734847232;12685.429155687832;12830.358482076046;12854.485820567073;12953.676158096123;8991.325650576102;8993.730188094367;9055.909440905507;9150.542472876463;9218.354715169873;12157.635270941886;12773.361331933553;12790.360481975678;12828.486860525474;12881.871181288067 17:28:03 INFO - PROCESS | 26083 | |3;mootools.html;1502.519193857965;1533.631928337199;1667.5247554446985;1789.2127463915867;1791.3372052340628;7777.572233527154;8282.585870706464;8508.61711222995;8849.690260840873;8885.511296878669;8672.43629164104;8804.119588041192;8818.07410221927;8830.116988301166;8926.062763409846;2353.8352315337934;2399;2410.5781488239486;2410.7227668818045;2414.9758502414925;2307.734610519795;2351.153584709512;2368.2066507719933;2388.677528533643;2388.904443822245;2367.242482405631;2375.299286710416;2396.7842894139526;2410.313060777679;2413.553492603874;2308.3882771065682;2320.164740693349;2326.464913069995;2348.5655153796515;2369.1115831563166;2308;2324.4537533679572;2328.348062542491;2328.3701409013756;2335.801456876168;8837.337199710048;8888.555572221429;8891.443997300446;8966.372353935227;9015.278777697835;5180.663256888291;5300.867478313035;5303.8408847734245;5313.920291195635;5325.068113080234;3465.28961562879;3477.2176260341475;3553.07620018797;3557.1640664443835;3601.4957905893198;1152.9250598711058;1169.6198735411026;1180.7579446213506;1204.813253945631;1207.1911819081236;12454.25274483534;12513.93743031288;12518.06114541413;12543.498260069586;12549.1215614907;4547.636189104864;4707.8587642370785;4766.523347665206;4772.809087636456;4780.067886762048;10437.269391142547;10493.370397776158;10531.104856087319;10537.367757934548;10572.735681608021;5399.136138217867;5411.377691565521;5424.538914192259;5427.402985671573;5444.128939369682;4412.294032954776;4811.230203167476;4887.266909963463;4957.529034741694;4966.329545511382;4003.459532963071;4039.091204478969;4168.7707176105;4181.310083836193;4181.832726690959;1278.111712359901;1298.6298904812083;1300.902432317561;1314.993425032888;1344.731053789246;858.6307887608264;954.4798085043668;959.0505399654292;962.3071388600197;968.0271327316143;5701.857453563694;5748.511376532958;5770.5095066919785;5920.644761314335;5980.940190598125;431.12911917926243;438.19153661494494;441.5672640812022;445.29643163801114;453.3766071651479;3894.415837624379;3942.5466071401584;3944.6647035001774;3946.861859834892;4007.479027726377;10818.080463160562;11012.50443730034;11032.172587055842;11058.22592418523;11135.220534562503;11020.338779673246;11028.117750580095;11040.779184416268;11042.668719938254;11060;7940;8326.45878017927;8328.08391076981;8386;8514.70198543048;5958.374370691188;6025.87948241024;6095.329513753572;6099.146119543356;6161;10189.133923616575;10408.063274305046;10414.687559373231;10466.738331541772;10497.632582859564;9722.465264410524;10152.54313555877;10565.735856603338;10670.093042091508;10672.30630009047;7286.380657644159;7758;8002.5598592077995;8039.236272554098;8192.590370481334;8743.38796284254;8803.855498785117;8808.91191088081;8847.911520884709;8854.29165666758;7647.655855486628;7722.15056343813;7802.843943121219;7852.568108754073;8028;7498.737544185928;7605.885911711218;7615.504992175491;7714.151443341116;7740.574268415291;7115.893261600977;7137.892931605927;7171.354578087997;7176.138863336433;7226.241244669234;4938.407391113089;5019.899602008012;5074.974625126851;5115.130427827204;5197.038547868657;5008.298838162733;5026.3214466048075;5030.647854650286;5056.089903817348;5100.6429549931145 17:28:03 INFO - PROCESS | 26083 | |4;prototype.html;313.93419341336164;320.1484052420559;320.383262220226;322.01945077239805;323.50503729294184;5619.819837834055;5621.915671264929;5629.211910332547;5636.210930469727;5644.266245388099;5550.69471179085;5550.77796888124;5550.888982220353;5567.749451274693;5568.276124103871;4086.5300490443606;4202.138561594881;4290.356446533014;4308.159908817782;4309.125530394273;4305.901994991273;4319.265724826787;4321.817482171499;4326.329418940069;4334.461266250483;4223.51429585597;4271.124419494012;4280;4281.72168809028;4287.335463003239;4016.297147999103;4225.72532785371;4234.343676730112;4246.214450326699;4295.1839150561445;3668.8899333019785;3686.7787932723854;3690.852365905361;3695.611960744137;3696.537932758405;5400.270963419927;5412.648177868426;5416.74995002999;5429.212764149176;5451.255598208575;4677.7193368398;4890.73100979446;4897.3878265216845;4915.434725006634;4937.827176048857;5777.480026797609;5796.768129274824;5856.560757943129;5879.206307148523;5879.559033072494;4097.405876147972;4100.159467309224;4102.671786257092;4107.281225785476;4107.527634322061;5889.7644094236175;6065;6075.878482430371;6115.755369785159;6116.388361163892;4142.46148000764;4150.5641907599875;4150.858513908639;4153.670825335864;4178.289690752518;4169.228692691861;4186.413902053715;4196.454460920122;4203.654830454287;4223.366495025771;4727.881802954885;4852.878678033077;4867.853964381075;4876.122297986397;4887.193613053877;5837.503812175928;5839.3430988899945;5842.152887831241;5849.268841394825;5876.706164691834;1445.6964037552023;1451.6298343922444;1452.4045141491938;1453.4912780526731;1454.345544504977;908.3641450984337;912.3841407050214;913.0960349254324;955.52848613135;977.750673578233;5604.495595396353;5618.494335509824;5635.154726791015;5648.85877853057;5661.66030038199;5939.227900372924;5956.225690660273;5966.254218222723;6020.397960203944;6027.186329845415;5374;5645.322561292671;5760.971195143998;5774.682392468455;5785.1611516329895;3220.533022711694;3221.8066915984646;3235.288236587947;3250.431174544445;3254.3491301739746;6177.536684748662;6255.43701066897;6267.592606480564;6293.632906395057;6339.2567044062325;6151.630902145886;6160.7535698571555;6191.164192834;6198.938010619926;6215.471684906834;6059.757609695651;6225.3774622537385;6306.590071645328;6307.180066591405;6310.558260921784;6026.638401695912;6038.611119442465;6057.7879774207695;6063.393660634078;6074.574779765374;5983.282006159288;6006.669633170043;6015.157877897011;6022.397760223943;6031.517478601789;6000.279966404059;6214.658193799384;6222;6257.78097766576;6303.779367722108;4191.2874811281545;4229.555896630933;4253.617174454314;4264.978675106605;4273.401723758614;5837.328707198557;6011.098335249748;6047.213862197887;6060.727267272895;6098.359672234352;5823.7379317931645;5856.736446859987;5879.647221166743;5884.411208973467;5891.644921668126;5761.625494342854;5789.739461724317;5792.247007888947;5852.239208902815;5877.413098463306;5197.870053248699;5716.399778023248;5730.255066841284;5766.798162064308;5796.913046304393;5826.970865145647;5859.736311866061;5898.35118136996;5899.17411562373;5908.291005079418;5513.862153446196;5738.770449181986;5738.885222295614;5742.368339482737;5846.532277417881 17:28:03 INFO - PROCESS | 26083 | |5;yui.html;752.0711920777838;778.3150827272;812.8821320908472;814.5723495165038;852.5140669818204;14014.22921739304;14910.881683873713;15056.322465489053;15057;15085;11954.940225298884;12166.391680415989;12204.32876191809;12236.510539578407;12261.509539618426;653.1867824558432;778.7897267737721;781.9843603127935;790.8022994251437;792.8017995501125;811.5374236685092;815.4577206157898;819.3690858039306;820.8563501387263;824.6371596497522;868.3053557154283;873.7204094689702;875.4397185801092;876.0319846569545;876.2245412809677;863.4689665855485;866.4974314897345;866.9956650216772;867.3321542412307;869.3088994249555;626.4143026270406;629.8267976306553;632.4402903430451;633.6388258692547;634.4068296143075;14329.78505322421;14361.210133442657;14402.567922962327;14448;14527.055741376776;16086;16202.75695864563;16239.269232884548;16251.918740406223;16546.089965051917;11812.29126252419;11966.282023078644;11979.401029948554;12047.096467764864;12174.452149653198;3962.128331767007;3964.6035396460125;3986.641202291779;3991.880243592697;4056.5132184137797;81475.18524814735;84701.57649211776;86149.56925215396;87288.12711872927;88071;12218.572349967708;12281.508739650493;12317.753644927052;12377.504899804087;12664.6833829155;23838.642420363707;23865.403364916016;24042;24111;24146.154884579308;8921.509316987627;8943.865842012376;9113.3165012623;9238.722838314861;9297;4832.516748325139;5033.723145226974;5077.974610126999;5141.0232055909255;5218.373795144607;3560.1633616100194;3649.324874898099;3685.0787303174206;3696.353138200804;3702.7222958278235;585.8242527241811;600.7700149450143;606.0515293565555;615.3169981320731;631.5799993004692;723.8371366442508;748.1555886529732;749.3771798704535;750.7484992527455;759.6429678051308;9561.569729362196;9595.616175352907;9706.75733106678;9872.308938374244;10152.796944061078;653.9901901471482;693.970083058613;767.1484652036236;770.8650986077527;776.6194564663274;4556.954430455719;4563.155816174019;4581.198290299184;4603.240465323184;4609.539046095364;125295;125894.3705281486;126580.36709816392;127523;129434;86408;101655;105630.4718476418;106772.46613767037;107579.46210269055;78345.60827195828;78918.6054069726;79484;90792;91594;9005.909940900507;9385.483798391155;9461.763455913657;9706.466144361846;9956.850647240442;46645.30032049454;46713.76643116763;46829.531704682515;47802;47952.5204747962;62975.370246298786;70778;71719;72749;72909.27090729238;12803.807942880678;12854.485820567073;13003.219806811621;13155.144915580457;13407.396667150197;14299.57101286963;15351.462698805488;15585.76621350658;15856.207189640703;16028;13989.370478328296;14248.71502569922;14297.285135742963;14442.711145776815;14570.927145364629;13319.53381631677;13963.441462341392;14157.929210353883;14172.716545668824;14409.927950360181;14319.427222911383;14392.640183995483;14463.665079066819;14482.493112741004;15019.549413517612;11625.709357266136;11958.760824783281;12255.264684118982;12283.75432491363;12644.873551264369;12098.818517722417;12304.753904921672;12317.692057698629;12502.687432814253;12527.87472125267 17:28:03 INFO - PROCESS | 26083 | __end_tp_report 17:28:03 INFO - PROCESS | 26083 | __start_cc_report 17:28:03 INFO - PROCESS | 26083 | _x_x_mozilla_cycle_collect,360 17:28:03 INFO - PROCESS | 26083 | __end_cc_report 17:28:03 INFO - PROCESS | 26083 | __startTimestamp1467246483092__endTimestamp 17:28:03 INFO - PROCESS | 26083 | 17:28:03 INFO - PROCESS | 26083 | ------- Summary: start ------- 17:28:03 INFO - PROCESS | 26083 | Number of tests: 6 17:28:03 INFO - PROCESS | 26083 | 17:28:03 INFO - PROCESS | 26083 | [#0] dojo.html Cycles:165 Average:5385.65 Median:5597.36 stddev:712.12 (12.7%) stddev-sans-first:692.18 17:28:03 INFO - PROCESS | 26083 | Values: 3140.5 3141.6 3179.0 3184.3 3186.7 5311.6 5324.5 5379.8 5440.9 5441.6 5271.1 5362.5 5401.4 5409.8 5430.2 4858.9 4893.9 5022.5 5067.7 5108.8 720.3 4965.6 5031.3 5041.7 5087.5 4942.5 4943.6 4969.1 5000.0 5048.6 4853.9 4978.8 4985.5 4998.9 5043.4 4853.8 4866.4 4880.0 4883.1 4894.8 5363.1 5462.5 5467.5 5474.6 5484.6 5762.2 5814.2 5857.8 5885.2 5914.9 5859.4 5912.6 5915.7 5917.4 5964.3 5497.7 5524.1 5525.7 5527.4 5530.4 5866.6 5924.8 5936.4 5938.7 6019.1 5720.8 5739.1 5743.9 5747.1 5748.6 5813.3 5818.7 5827.2 5830.2 5832.1 5687.2 5804.7 5834.4 5871.6 5910.5 5582.5 5829.4 5844.8 5869.4 5870.4 4497.4 4521.1 4523.7 4525.5 4560.5 3877.8 3917.9 3950.6 3982.6 4000.9 5568.0 5568.7 5569.2 5606.1 5608.3 5821.7 5885.9 5898.8 5901.1 5922.4 5415.8 5434.5 5452.4 5467.5 5468.2 4966.0 4968.4 5002.3 5002.4 5023.8 5885.4 5958.6 5964.1 5972.9 5979.6 5812.0 5816.0 5822.8 5873.6 5892.9 6029.9 6030.3 6033.5 6046.8 6100.6 5649.4 5711.7 5777.6 5781.2 5818.1 5822.6 5878.7 5884.1 5892.2 5971.7 5664.6 5706.5 5709.2 5714.3 5714.9 5461.5 5634.5 5657.6 5659.6 5704.7 5360.9 5469.7 5497.4 5542.6 5707.2 5634.7 5687.5 5714.4 5733.6 5735.3 5443.5 5559.6 5590.6 5594.7 5597.4 17:28:03 INFO - PROCESS | 26083 | 17:28:03 INFO - PROCESS | 26083 | [#1] ext.html Cycles:180 Average:58902.99 Median:209825.31 stddev:119203.58 (56.8%) stddev-sans-first:119457.55 17:28:03 INFO - PROCESS | 26083 | Values: 581.8 618.5 627.3 632.2 634.4 41901.6 43267.4 43341.8 43441.8 46446.3 44052.8 44264.1 44602.6 44639.3 44754.1 8822.9 8974.0 8979.1 8984.4 8989.7 8614.2 8639.4 8708.3 8724.6 8737.5 8759.6 8768.6 8794.0 8807.7 8809.2 8672.6 8683.7 8686.4 8691.7 8699.6 8789.5 8854.8 8865.5 8867.4 8891.6 42599.4 42964.8 42974.8 43087.4 43100.0 3698.5 3727.0 4173.0 4209.4 4315.4 29679.3 29873.9 31667.7 32415.0 33200.2 4144.3 4154.1 4154.6 4167.4 4194.6 359155.0 360163.0 360851.0 360976.0 361584.0 35195.6 36234.0 56433.4 56462.2 56691.0 37404.4 37467.4 37476.6 37518.6 37589.2 15542.3 15635.0 15668.4 15807.4 15882.7 13249.7 13351.6 13395.5 13454.4 13479.0 8618.5 8631.7 8693.6 8795.1 8829.0 3404.6 3414.5 3470.7 3503.9 3516.6 1037.2 1040.5 1092.4 1101.3 1126.3 31827.4 31857.2 31901.2 32199.5 32256.5 1088.8 1115.5 1138.8 1145.7 1189.9 16419.6 16689.5 16720.7 16748.4 16903.3 543091.0 547110.0 549038.0 550229.0 553059.0 56756.7 57887.0 58202.4 58324.4 58364.4 1376.7 1377.4 1380.7 1395.0 1401.4 30193.7 31831.5 31952.5 32117.8 32132.5 44739.0 45127.0 45276.3 45323.5 45471.3 413666.0 415496.0 416374.0 417308.0 417484.0 28674.1 28808.7 28966.0 29287.3 29312.9 47938.0 48425.0 48851.0 49064.5 49276.3 41246.4 41684.0 41866.0 42402.4 42745.8 41119.6 41131.8 41551.8 41604.6 42300.8 34087.5 39701.4 39804.0 39811.2 40678.0 35425.6 37510.0 37609.6 38077.2 38088.8 28234.3 28726.4 28806.0 28940.3 29027.6 17:28:03 INFO - PROCESS | 26083 | 17:28:03 INFO - PROCESS | 26083 | [#2] jquery.html Cycles:180 Average:30356.73 Median:409.89 stddev:87863.57 (21435.9%) stddev-sans-first:88081.26 17:28:03 INFO - PROCESS | 26083 | Values: 404.2 405.2 414.5 417.8 424.9 18326.6 19973.2 20053.8 20676.4 21564.8 12042.3 12054.3 12065.3 12110.3 12328.8 5271.9 5351.3 5375.0 5400.3 5406.9 5459.2 5905.4 5912.6 5919.4 5939.5 5631.2 5821.4 5843.4 5857.7 5859.4 5872.1 5905.7 5917.3 5919.8 5925.1 5037.5 5256.2 5284.4 5291.9 5341.1 13346.3 13348.7 17245.1 24231.5 24474.5 2250.0 2528.8 2557.6 2755.0 2755.9 9389.3 9456.3 9533.4 9625.3 10309.7 1933.9 1979.8 1983.7 1995.0 1995.7 83500.2 84182.0 84677.6 85942.0 86944.6 10990.0 11218.9 11235.7 11240.1 11301.8 15720.5 15751.8 15823.4 15841.1 15842.2 8507.7 8558.5 8637.6 8700.2 8879.5 8642.4 8694.5 8783.1 8880.5 8919.6 4549.2 4699.4 4773.5 4922.4 4965.9 1971.9 2002.9 2006.0 2011.6 2019.2 928.5 962.3 968.2 997.9 1048.4 20116.4 20476.5 20479.8 20494.3 20524.5 1026.7 1032.8 1041.5 1054.9 1085.2 11031.2 11457.4 11494.6 11507.4 11560.9 512927.0 533438.0 539199.0 541456.0 541582.0 66152.0 67571.3 99441.5 99650.0 100056.5 907.6 922.0 922.1 933.9 939.6 17368.2 17738.0 18066.5 18711.1 18853.2 37961.4 46111.8 46147.0 47153.3 47331.8 58494.7 63090.4 63740.0 63831.4 64923.4 8616.5 8867.3 8870.9 8896.6 9003.3 10086.8 14105.3 14133.3 14547.3 14923.7 12435.6 12625.8 12681.1 12687.6 12898.0 12033.3 12442.1 12484.1 12491.8 12647.9 12656.2 12685.4 12830.4 12854.5 12953.7 8991.3 8993.7 9055.9 9150.5 9218.4 12157.6 12773.4 12790.4 12828.5 12881.9 17:28:03 INFO - PROCESS | 26083 | 17:28:03 INFO - PROCESS | 26083 | [#3] mootools.html Cycles:180 Average:5854.66 Median:4627.75 stddev:3360.37 (72.6%) stddev-sans-first:3353.88 17:28:03 INFO - PROCESS | 26083 | Values: 1502.5 1533.6 1667.5 1789.2 1791.3 7777.6 8282.6 8508.6 8849.7 8885.5 8672.4 8804.1 8818.1 8830.1 8926.1 2353.8 2399.0 2410.6 2410.7 2415.0 2307.7 2351.2 2368.2 2388.7 2388.9 2367.2 2375.3 2396.8 2410.3 2413.6 2308.4 2320.2 2326.5 2348.6 2369.1 2308.0 2324.5 2328.3 2328.4 2335.8 8837.3 8888.6 8891.4 8966.4 9015.3 5180.7 5300.9 5303.8 5313.9 5325.1 3465.3 3477.2 3553.1 3557.2 3601.5 1152.9 1169.6 1180.8 1204.8 1207.2 12454.3 12513.9 12518.1 12543.5 12549.1 4547.6 4707.9 4766.5 4772.8 4780.1 10437.3 10493.4 10531.1 10537.4 10572.7 5399.1 5411.4 5424.5 5427.4 5444.1 4412.3 4811.2 4887.3 4957.5 4966.3 4003.5 4039.1 4168.8 4181.3 4181.8 1278.1 1298.6 1300.9 1315.0 1344.7 858.6 954.5 959.1 962.3 968.0 5701.9 5748.5 5770.5 5920.6 5980.9 431.1 438.2 441.6 445.3 453.4 3894.4 3942.5 3944.7 3946.9 4007.5 10818.1 11012.5 11032.2 11058.2 11135.2 11020.3 11028.1 11040.8 11042.7 11060.0 7940.0 8326.5 8328.1 8386.0 8514.7 5958.4 6025.9 6095.3 6099.1 6161.0 10189.1 10408.1 10414.7 10466.7 10497.6 9722.5 10152.5 10565.7 10670.1 10672.3 7286.4 7758.0 8002.6 8039.2 8192.6 8743.4 8803.9 8808.9 8847.9 8854.3 7647.7 7722.2 7802.8 7852.6 8028.0 7498.7 7605.9 7615.5 7714.2 7740.6 7115.9 7137.9 7171.4 7176.1 7226.2 4938.4 5019.9 5075.0 5115.1 5197.0 5008.3 5026.3 5030.6 5056.1 5100.6 17:28:03 INFO - PROCESS | 26083 | 17:28:03 INFO - PROCESS | 26083 | [#4] prototype.html Cycles:180 Average:4905.09 Median:5644.79 stddev:1477.73 (26.2%) stddev-sans-first:1441.13 17:28:03 INFO - PROCESS | 26083 | Values: 313.9 320.1 320.4 322.0 323.5 5619.8 5621.9 5629.2 5636.2 5644.3 5550.7 5550.8 5550.9 5567.7 5568.3 4086.5 4202.1 4290.4 4308.2 4309.1 4305.9 4319.3 4321.8 4326.3 4334.5 4223.5 4271.1 4280.0 4281.7 4287.3 4016.3 4225.7 4234.3 4246.2 4295.2 3668.9 3686.8 3690.9 3695.6 3696.5 5400.3 5412.6 5416.7 5429.2 5451.3 4677.7 4890.7 4897.4 4915.4 4937.8 5777.5 5796.8 5856.6 5879.2 5879.6 4097.4 4100.2 4102.7 4107.3 4107.5 5889.8 6065.0 6075.9 6115.8 6116.4 4142.5 4150.6 4150.9 4153.7 4178.3 4169.2 4186.4 4196.5 4203.7 4223.4 4727.9 4852.9 4867.9 4876.1 4887.2 5837.5 5839.3 5842.2 5849.3 5876.7 1445.7 1451.6 1452.4 1453.5 1454.3 908.4 912.4 913.1 955.5 977.8 5604.5 5618.5 5635.2 5648.9 5661.7 5939.2 5956.2 5966.3 6020.4 6027.2 5374.0 5645.3 5761.0 5774.7 5785.2 3220.5 3221.8 3235.3 3250.4 3254.3 6177.5 6255.4 6267.6 6293.6 6339.3 6151.6 6160.8 6191.2 6198.9 6215.5 6059.8 6225.4 6306.6 6307.2 6310.6 6026.6 6038.6 6057.8 6063.4 6074.6 5983.3 6006.7 6015.2 6022.4 6031.5 6000.3 6214.7 6222.0 6257.8 6303.8 4191.3 4229.6 4253.6 4265.0 4273.4 5837.3 6011.1 6047.2 6060.7 6098.4 5823.7 5856.7 5879.6 5884.4 5891.6 5761.6 5789.7 5792.2 5852.2 5877.4 5197.9 5716.4 5730.3 5766.8 5796.9 5827.0 5859.7 5898.4 5899.2 5908.3 5513.9 5738.8 5738.9 5742.4 5846.5 17:28:03 INFO - PROCESS | 26083 | 17:28:03 INFO - PROCESS | 26083 | [#5] yui.html Cycles:180 Average:21380.85 Median:4560.06 stddev:31262.60 (685.6%) stddev-sans-first:31311.92 17:28:03 INFO - PROCESS | 26083 | Values: 752.1 778.3 812.9 814.6 852.5 14014.2 14910.9 15056.3 15057.0 15085.0 11954.9 12166.4 12204.3 12236.5 12261.5 653.2 778.8 782.0 790.8 792.8 811.5 815.5 819.4 820.9 824.6 868.3 873.7 875.4 876.0 876.2 863.5 866.5 867.0 867.3 869.3 626.4 629.8 632.4 633.6 634.4 14329.8 14361.2 14402.6 14448.0 14527.1 16086.0 16202.8 16239.3 16251.9 16546.1 11812.3 11966.3 11979.4 12047.1 12174.5 3962.1 3964.6 3986.6 3991.9 4056.5 81475.2 84701.6 86149.6 87288.1 88071.0 12218.6 12281.5 12317.8 12377.5 12664.7 23838.6 23865.4 24042.0 24111.0 24146.2 8921.5 8943.9 9113.3 9238.7 9297.0 4832.5 5033.7 5078.0 5141.0 5218.4 3560.2 3649.3 3685.1 3696.4 3702.7 585.8 600.8 606.1 615.3 631.6 723.8 748.2 749.4 750.7 759.6 9561.6 9595.6 9706.8 9872.3 10152.8 654.0 694.0 767.1 770.9 776.6 4557.0 4563.2 4581.2 4603.2 4609.5 125295.0 125894.4 126580.4 127523.0 129434.0 86408.0 101655.0 105630.5 106772.5 107579.5 78345.6 78918.6 79484.0 90792.0 91594.0 9005.9 9385.5 9461.8 9706.5 9956.9 46645.3 46713.8 46829.5 47802.0 47952.5 62975.4 70778.0 71719.0 72749.0 72909.3 12803.8 12854.5 13003.2 13155.1 13407.4 14299.6 15351.5 15585.8 15856.2 16028.0 13989.4 14248.7 14297.3 14442.7 14570.9 13319.5 13963.4 14157.9 14172.7 14409.9 14319.4 14392.6 14463.7 14482.5 15019.5 11625.7 11958.8 12255.3 12283.8 12644.9 12098.8 12304.8 12317.7 12502.7 12527.9 17:28:03 INFO - PROCESS | 26083 | -------- Summary: end -------- 17:28:03 INFO - PROCESS | 26083 | 17:28:03 INFO - TEST-INFO | 26083: exit 0 17:28:03 INFO - TEST-OK | dromaeo_css | took 1111456ms 17:28:03 INFO - TEST-START | kraken 17:28:03 INFO - operating with platform_type : linux_ 17:28:03 INFO - Initialising browser for kraken test... 17:28:03 INFO - TEST-INFO | started process 26325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBMKKXE/profile http://localhost:50742/getInfo.html) 17:28:08 INFO - PROCESS | 26325 | __metrics Screen width/height:1600/1200 17:28:08 INFO - PROCESS | 26325 | colorDepth:24 17:28:08 INFO - PROCESS | 26325 | Browser inner width/height: 1024/697 17:28:08 INFO - PROCESS | 26325 | __metrics 17:28:09 ERROR - PROCESS | 26325 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:28:10 INFO - TEST-INFO | 26325: exit 0 17:28:10 INFO - Browser initialized. 17:28:10 INFO - Running cycle 1/1 for kraken test... 17:28:10 INFO - TEST-INFO | started process 26448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBMKKXE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:22 INFO - PROCESS | 26448 | RSS: Main: 168706048 17:28:22 INFO - PROCESS | 26448 | 17:28:24 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50742/tests/kraken/driver.html?testName=audio-beat-detection) 17:28:25 INFO - PROCESS | 26448 | RSS: Main: 174202880 17:28:25 INFO - PROCESS | 26448 | 17:28:28 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50742/tests/kraken/driver.html?testName=audio-dft) 17:28:28 INFO - PROCESS | 26448 | RSS: Main: 173547520 17:28:28 INFO - PROCESS | 26448 | 17:28:31 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50742/tests/kraken/driver.html?testName=audio-fft) 17:28:32 INFO - PROCESS | 26448 | RSS: Main: 168194048 17:28:32 INFO - PROCESS | 26448 | 17:28:34 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50742/tests/kraken/driver.html?testName=audio-oscillator) 17:28:35 INFO - PROCESS | 26448 | RSS: Main: 169029632 17:28:35 INFO - PROCESS | 26448 | 17:28:37 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50742/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:28:37 INFO - PROCESS | 26448 | RSS: Main: 169652224 17:28:37 INFO - PROCESS | 26448 | 17:28:41 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50742/tests/kraken/driver.html?testName=imaging-darkroom) 17:28:41 INFO - PROCESS | 26448 | RSS: Main: 170041344 17:28:41 INFO - PROCESS | 26448 | 17:28:45 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50742/tests/kraken/driver.html?testName=imaging-desaturate) 17:28:45 INFO - PROCESS | 26448 | RSS: Main: 167104512 17:28:45 INFO - PROCESS | 26448 | 17:28:48 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50742/tests/kraken/driver.html?testName=json-parse-financial) 17:28:49 INFO - PROCESS | 26448 | RSS: Main: 168796160 17:28:49 INFO - PROCESS | 26448 | 17:28:50 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50742/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:28:51 INFO - PROCESS | 26448 | RSS: Main: 168935424 17:28:51 INFO - PROCESS | 26448 | 17:28:53 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50742/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:28:53 INFO - PROCESS | 26448 | RSS: Main: 169672704 17:28:53 INFO - PROCESS | 26448 | 17:28:55 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50742/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:28:56 INFO - PROCESS | 26448 | RSS: Main: 169873408 17:28:56 INFO - PROCESS | 26448 | 17:28:59 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:28:59 INFO - PROCESS | 26448 | RSS: Main: 170606592 17:28:59 INFO - PROCESS | 26448 | 17:29:02 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:29:03 INFO - PROCESS | 26448 | RSS: Main: 169672704 17:29:03 INFO - PROCESS | 26448 | 17:29:04 INFO - PROCESS | 26448 | Cycle 1(1): loaded http://localhost:50742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50742/tests/kraken/driver.html?testName=ai-astar) 17:29:04 INFO - PROCESS | 26448 | RSS: Main: 170778624 17:29:04 INFO - PROCESS | 26448 | 17:29:04 INFO - PROCESS | 26448 | __start_tp_report 17:29:04 INFO - PROCESS | 26448 | _x_x_mozilla_page_load 17:29:04 INFO - PROCESS | 26448 | _x_x_mozilla_page_load_details 17:29:04 INFO - PROCESS | 26448 | |i|pagename|runs| 17:29:04 INFO - PROCESS | 26448 | |0;ai-astar;102;112;106;115;115;114;114;114;112;111 17:29:04 INFO - PROCESS | 26448 | |1;audio-beat-detection;149;120;157;169;119;148;144;124;182;116 17:29:04 INFO - PROCESS | 26448 | |2;audio-dft;163;163;164;162;163;166;176;165;162;163 17:29:04 INFO - PROCESS | 26448 | |3;audio-fft;76;75;77;169;78;76;76;75;179;76 17:29:04 INFO - PROCESS | 26448 | |4;audio-oscillator;88;85;151;84;84;85;143;84;85;148 17:29:04 INFO - PROCESS | 26448 | |5;imaging-gaussian-blur;117;118;117;117;118;117;118;118;118;122 17:29:04 INFO - PROCESS | 26448 | |6;imaging-darkroom;147;147;147;147;148;146;150;147;147;147 17:29:04 INFO - PROCESS | 26448 | |7;imaging-desaturate;96;98;96;95;100;96;97;96;95;96 17:29:04 INFO - PROCESS | 26448 | |8;json-parse-financial;54;57;54;56;54;54;65;55;59;54 17:29:04 INFO - PROCESS | 26448 | |9;json-stringify-tinderbox;61;61;61;60;62;61;62;62;61;61 17:29:04 INFO - PROCESS | 26448 | |10;stanford-crypto-aes;75;82;75;74;76;75;75;74;79;76 17:29:04 INFO - PROCESS | 26448 | |11;stanford-crypto-ccm;120;118;118;120;123;120;124;133;157;136 17:29:04 INFO - PROCESS | 26448 | |12;stanford-crypto-pbkdf2;158;156;159;155;158;157;157;155;160;156 17:29:04 INFO - PROCESS | 26448 | |13;stanford-crypto-sha256-iterative;67;63;62;67;63;63;64;63;67;61 17:29:04 INFO - PROCESS | 26448 | __end_tp_report 17:29:04 INFO - PROCESS | 26448 | __start_cc_report 17:29:05 INFO - PROCESS | 26448 | _x_x_mozilla_cycle_collect,922 17:29:05 INFO - PROCESS | 26448 | __end_cc_report 17:29:05 INFO - PROCESS | 26448 | __startTimestamp1467246544992__endTimestamp 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | ------- Summary: start ------- 17:29:05 INFO - PROCESS | 26448 | Number of tests: 14 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#0] ai-astar Cycles:10 Average:111.50 Median:114.00 stddev:4.28 (3.8%) stddev-sans-first:2.83 17:29:05 INFO - PROCESS | 26448 | Values: 102.0 112.0 106.0 115.0 115.0 114.0 114.0 114.0 112.0 111.0 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:148.50 stddev:22.73 (15.3%) stddev-sans-first:24.00 17:29:05 INFO - PROCESS | 26448 | Values: 149.0 120.0 157.0 169.0 119.0 148.0 144.0 124.0 182.0 116.0 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.50 stddev:4.16 (2.5%) stddev-sans-first:4.37 17:29:05 INFO - PROCESS | 26448 | Values: 163.0 163.0 164.0 162.0 163.0 166.0 176.0 165.0 162.0 163.0 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:41.34 (54.4%) stddev-sans-first:43.23 17:29:05 INFO - PROCESS | 26448 | Values: 76.0 75.0 77.0 169.0 78.0 76.0 76.0 75.0 179.0 76.0 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:84.50 stddev:30.19 (35.7%) stddev-sans-first:31.48 17:29:05 INFO - PROCESS | 26448 | Values: 88.0 85.0 151.0 84.0 84.0 85.0 143.0 84.0 85.0 148.0 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.49 (1.3%) stddev-sans-first:1.54 17:29:05 INFO - PROCESS | 26448 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 122.0 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 17:29:05 INFO - PROCESS | 26448 | Values: 147.0 147.0 147.0 147.0 148.0 146.0 150.0 147.0 147.0 147.0 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.51 (1.6%) stddev-sans-first:1.59 17:29:05 INFO - PROCESS | 26448 | Values: 96.0 98.0 96.0 95.0 100.0 96.0 97.0 96.0 95.0 96.0 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.50 stddev:3.52 (6.3%) stddev-sans-first:3.64 17:29:05 INFO - PROCESS | 26448 | Values: 54.0 57.0 54.0 56.0 54.0 54.0 65.0 55.0 59.0 54.0 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 17:29:05 INFO - PROCESS | 26448 | Values: 61.0 61.0 61.0 60.0 62.0 61.0 62.0 62.0 61.0 61.0 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:75.50 stddev:2.51 (3.3%) stddev-sans-first:2.64 17:29:05 INFO - PROCESS | 26448 | Values: 75.0 82.0 75.0 74.0 76.0 75.0 75.0 74.0 79.0 76.0 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:123.50 stddev:12.25 (9.9%) stddev-sans-first:12.74 17:29:05 INFO - PROCESS | 26448 | Values: 120.0 118.0 118.0 120.0 123.0 120.0 124.0 133.0 157.0 136.0 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:157.50 stddev:1.66 (1.1%) stddev-sans-first:1.73 17:29:05 INFO - PROCESS | 26448 | Values: 158.0 156.0 159.0 155.0 158.0 157.0 157.0 155.0 160.0 156.0 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - PROCESS | 26448 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:63.50 stddev:2.21 (3.5%) stddev-sans-first:2.06 17:29:05 INFO - PROCESS | 26448 | Values: 67.0 63.0 62.0 67.0 63.0 63.0 64.0 63.0 67.0 61.0 17:29:05 INFO - PROCESS | 26448 | -------- Summary: end -------- 17:29:05 INFO - PROCESS | 26448 | 17:29:05 INFO - TEST-INFO | 26448: exit 0 17:29:06 INFO - TEST-OK | kraken | took 62148ms 17:29:06 INFO - SUITE-END | took 1173s 17:29:06 INFO - Completed test suite (00:19:33) 17:29:06 INFO - javascript benchmark 17:29:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7279.099624633118, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.5289206619004, 3141.6230052393717, 3179.046286114165, 3184.267618447757, 3186.745060395169, 5311.62818602698, 5324.520793128618, 5379.784808607656, 5440.945590544094, 5441.59188060895, 5271.077561426745, 5362.490563396481, 5401.378841433237, 5409.756560954756, 5430.15832545955, 4858.878528036792, 4893.902121957559, 5022.522860328263, 5067.695938243699, 5108.8211912583065, 720.3187393638858, 4965.627577931651, 5031.345925029759, 5041.72270525121, 5087.5421212090905, 4942.481039490874, 4943.555080042777, 4969.105560999019, 4999.999999999996, 5048.596112311006, 4853.927191092136, 4978.77595508203, 4985.501449855022, 4998.925016124761, 5043.42000669924, 4853.805847766085, 4866.3673722416215, 4880.0, 4883.072216278932, 4894.755262236874, 5363.141897296453, 5462.481064298885, 5467.480589344006, 5474.616776825624, 5484.588655850827, 5762.222100016486, 5814.244148260741, 5857.76568937242, 5885.205497257858, 5914.881702365971, 5859.4433528815125, 5912.615679980788, 5915.704214789286, 5917.378675239081, 5964.314103878066, 5497.725113744297, 5524.088525393306, 5525.723713814334, 5527.419620939824, 5530.419305972895, 5866.589338746332, 5924.7926322578505, 5936.376680448577, 5938.673372964528, 6019.127226552213, 5720.8283751487525, 5739.110437882052, 5743.8564035899435, 5747.1379293106365, 5748.626339287933, 5813.273340832396, 5818.738156782955, 5827.242458480455, 5830.154627578977, 5832.066869300891, 5687.203791469197, 5804.65172089676, 5834.416558344216, 5871.588988770745, 5910.468057874812, 5582.497575218169, 5829.446202610745, 5844.766209351664, 5869.442402971711, 5870.412958704095, 4497.370368148462, 4521.050579378368, 4523.683342166082, 4525.502194758574, 4560.543945605413, 3877.7867217302755, 3917.9020524487114, 3950.6049395060263, 3982.561918188997, 4000.9199816003515, 5567.969925563783, 5568.749406276727, 5569.220309156722, 5606.131049687305, 5608.298962629671, 5821.650700957956, 5885.941140588625, 5898.8230353089475, 5901.114832775118, 5922.378150294157, 5415.756290966916, 5434.456554344534, 5452.40023597404, 5467.4532546745, 5468.152436372368, 4966.0, 4968.378952630921, 5002.274670172805, 5002.449730529639, 5023.79904803811, 5885.411458854081, 5958.612690175125, 5964.135200395918, 5972.850678733066, 5979.611325263844, 5812.041013232853, 5816.0, 5822.7670893163795, 5873.559483038704, 5892.911606325994, 6029.939700603113, 6030.30651475086, 6033.456988871023, 6046.818595442144, 6100.603460775035, 5649.37856835756, 5711.714414279352, 5777.566682498746, 5781.248437703071, 5818.098194779646, 5822.592418530662, 5878.735456904364, 5884.08796636522, 5892.175095486549, 5971.701414929149, 5664.631798933221, 5706.486416222394, 5709.20071190042, 5714.342850572071, 5714.914276285942, 5461.453854614507, 5634.464725851038, 5657.60396772222, 5659.6321239119325, 5704.743286552032, 5360.946390536044, 5469.72651367438, 5497.422770609189, 5542.584306176972, 5707.229524014205, 5634.74643641029, 5687.488126068673, 5714.399988001366, 5733.627314224562, 5735.311762588516, 5443.510084092451, 5559.555235581063, 5590.608657393944, 5594.720263986703, 5597.356304024926], "value": 5340.173482555855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.7963712700555, 618.5391883047131, 627.30369290088, 632.2097378277152, 634.3814780588923, 41901.58098419015, 43267.350989735176, 43341.78329108354, 43441.78279108604, 46446.30330545045, 44052.77973610136, 44264.11471770563, 44602.55397446024, 44639.330410043876, 44754.10491790162, 8822.867656985134, 8974.0, 8979.14698103679, 8984.371094023389, 8989.685361012365, 8614.224719775219, 8639.39524233304, 8708.259797917184, 8724.607392667314, 8737.475751454902, 8759.562021898912, 8768.649254029831, 8794.0, 8807.735767926972, 8809.163129502718, 8672.60973256205, 8683.652653893836, 8686.435381700168, 8691.652333906668, 8699.565021748887, 8789.472631642058, 8854.822903541894, 8865.468071915706, 8867.379283450162, 8891.644334226623, 42599.36100958488, 42964.785176074234, 42974.78512607448, 43087.35368969468, 43100.0, 3698.519192504984, 3727.049602351383, 4172.958270417287, 4209.431726716884, 4315.39584458173, 29679.25801854949, 29873.850630746707, 31667.683323166704, 32415.0, 33200.16999575006, 4144.254034273829, 4154.124923252023, 4154.626083652486, 4167.374893765929, 4194.622483976426, 359155.0, 360163.0, 360851.0, 360976.0, 361584.0, 35195.64804351975, 36234.0, 56433.43566564282, 56462.15306770402, 56691.0, 37404.43893341602, 37467.437988430196, 37476.62523374786, 37518.624813751514, 37589.24821503554, 15542.300596473186, 15635.0, 15668.373265069498, 15807.446739364066, 15882.682346353009, 13249.73500529984, 13351.599452016455, 13395.531156409479, 13454.394552245172, 13479.0, 8618.482891026559, 8631.697890573925, 8693.565321733888, 8795.120487951153, 8828.955855220684, 3404.6425125361975, 3414.5048967899515, 3470.687638112582, 3503.9474407883904, 3516.6307537708685, 1037.190991027, 1040.4508953065022, 1092.355510248957, 1101.2786624760795, 1126.2904370246856, 31827.363452730817, 31857.203569910474, 31901.20246993844, 32199.51700724491, 32256.516152257736, 1088.755030118233, 1115.525901491879, 1138.8177891537314, 1145.6849366424133, 1189.851268591426, 16419.5895102621, 16689.49931502057, 16720.74918876218, 16748.41380551675, 16903.323867045427, 543091.0, 547110.0, 549038.0, 550229.0, 553059.0, 56756.71621641948, 57887.0, 58202.41797582055, 58324.416755832746, 58364.4163558359, 1376.7246550689902, 1377.3595278195687, 1380.6893448974101, 1394.965125871841, 1401.3973991183684, 30193.69806301997, 31831.522527161647, 31952.520712189802, 32117.839410802797, 32132.518012230303, 44739.0, 45127.0, 45276.32085518654, 45323.546764533254, 45471.31793023041, 413666.0, 415496.0, 416374.0, 417308.0, 417484.0, 28674.139775806758, 28808.732087738194, 28966.0, 29287.267818304714, 29312.853435732686, 47938.0, 48425.0, 48851.0, 49064.509354906, 49276.2608560879, 41246.38130428106, 41684.0, 41866.0, 42402.36396453994, 42745.78627106844, 41119.588804111576, 41131.7943410281, 41551.7922410386, 41604.58395416007, 42300.78849605732, 34087.4886876702, 39701.404478933415, 39804.0, 39811.20377592374, 40678.0, 35425.645743542234, 37510.0, 37609.623903760614, 38077.238455231294, 38088.809555952044, 28234.2941426466, 28726.425471490034, 28806.0, 28940.27649308784, 29027.56458653164], "value": 18979.43684512944, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.24406360106593, 405.23208519854876, 414.5481425246481, 417.8036322928224, 424.8810333106731, 18326.633467330645, 19973.201071957123, 20053.799462005376, 20676.379708608765, 21564.813935233557, 12042.277463352184, 12054.276743395381, 12065.33640649764, 12110.27338359699, 12328.753424931518, 5271.920921186175, 5351.304330437038, 5374.973125134388, 5400.270963419927, 5406.8918621627545, 5459.208414779854, 5905.43898329658, 5912.615679980788, 5919.43765342294, 5939.495142912836, 5631.183478395651, 5821.3887541808135, 5843.415658434144, 5857.6778277194735, 5859.384764599719, 5872.119182122673, 5905.6751878646655, 5917.260342457193, 5919.792807251725, 5925.081612350093, 5037.546620804109, 5256.159014557652, 5284.39229488606, 5291.947080529222, 5341.0653135701095, 13346.33268336589, 13348.73302533944, 17245.051522166403, 24231.515369692508, 24474.51050978988, 2249.966250506244, 2528.759767822054, 2557.6291437741424, 2754.986225068882, 2755.8976409436186, 9389.342746007782, 9456.290778191664, 9533.427994320293, 9625.326227164102, 10309.690709278733, 1933.9129739161772, 1979.8218160365636, 1983.7321961535151, 1994.9601007979904, 1995.6806910894188, 83500.16499834985, 84182.0, 84677.57661211655, 85942.0, 86944.56527717384, 10990.010899018967, 11218.943905280585, 11235.66293011211, 11240.100791936626, 11301.830472542919, 15720.528384148494, 15751.763723544156, 15823.367065317489, 15841.128737919295, 15842.207889605705, 8507.744767656981, 8558.486490810572, 8637.611307491177, 8700.214832341702, 8879.467231966102, 8642.351823613255, 8694.478331300143, 8783.121687831293, 8880.467171969702, 8919.554022298858, 4549.203889319356, 4699.355225670988, 4773.498782627774, 4922.360093187935, 4965.896314803248, 1971.8915459649857, 2002.8698134621202, 2005.9899700501696, 2011.6278488479677, 2019.1822311963679, 928.4846909964899, 962.3263715399248, 968.1770495079127, 997.8553109799184, 1048.4233671480808, 20116.39650810478, 20476.488087797625, 20479.79520204779, 20494.282700105425, 20524.486887827923, 1026.7330494071446, 1032.7831155457438, 1041.5156952017348, 1054.947252637365, 1085.2023762534532, 11031.172662050378, 11457.369844658624, 11494.597689080842, 11507.367094809866, 11560.94219528897, 512927.0, 533438.0, 539199.0, 541456.0, 541582.0, 66152.0, 67571.32428675749, 99441.50279248557, 99650.0, 100056.49971750095, 907.6006557114848, 922.0042354257386, 922.1193759959223, 933.8785957825439, 939.6006697153682, 17368.21843017042, 17738.0, 18066.548336291697, 18711.06444677788, 18853.15160817794, 37961.4305785419, 46111.76944115258, 46147.0, 47153.292700608836, 47331.763341183076, 58494.707526462094, 63090.369096310285, 63740.0, 63831.361686382545, 64923.35076649173, 8616.526091065052, 8867.334949878656, 8870.86693699582, 8896.644134234559, 9003.324750643858, 10086.798264034825, 14105.29473526299, 14133.293335332986, 14547.272636367927, 14923.701525969203, 12435.564755233523, 12625.81061284063, 12681.112322137362, 12687.619371418872, 12898.0, 12033.338166400932, 12442.129050966345, 12484.063695222712, 12491.75016499683, 12647.936760316139, 12656.17734847232, 12685.429155687832, 12830.358482076046, 12854.485820567073, 12953.676158096123, 8991.325650576102, 8993.730188094367, 9055.909440905507, 9150.542472876463, 9218.354715169873, 12157.635270941886, 12773.361331933553, 12790.360481975678, 12828.486860525474, 12881.871181288067], "value": 9331.378506757339, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.519193857965, 1533.631928337199, 1667.5247554446985, 1789.2127463915867, 1791.3372052340628, 7777.572233527154, 8282.585870706464, 8508.61711222995, 8849.690260840873, 8885.511296878669, 8672.43629164104, 8804.119588041192, 8818.07410221927, 8830.116988301166, 8926.062763409846, 2353.8352315337934, 2399.0, 2410.5781488239486, 2410.7227668818045, 2414.9758502414925, 2307.734610519795, 2351.153584709512, 2368.2066507719933, 2388.677528533643, 2388.904443822245, 2367.242482405631, 2375.299286710416, 2396.7842894139526, 2410.313060777679, 2413.553492603874, 2308.3882771065682, 2320.164740693349, 2326.464913069995, 2348.5655153796515, 2369.1115831563166, 2308.0, 2324.4537533679572, 2328.348062542491, 2328.3701409013756, 2335.801456876168, 8837.337199710048, 8888.555572221429, 8891.443997300446, 8966.372353935227, 9015.278777697835, 5180.663256888291, 5300.867478313035, 5303.8408847734245, 5313.920291195635, 5325.068113080234, 3465.28961562879, 3477.2176260341475, 3553.07620018797, 3557.1640664443835, 3601.4957905893198, 1152.9250598711058, 1169.6198735411026, 1180.7579446213506, 1204.813253945631, 1207.1911819081236, 12454.25274483534, 12513.93743031288, 12518.06114541413, 12543.498260069586, 12549.1215614907, 4547.636189104864, 4707.8587642370785, 4766.523347665206, 4772.809087636456, 4780.067886762048, 10437.269391142547, 10493.370397776158, 10531.104856087319, 10537.367757934548, 10572.735681608021, 5399.136138217867, 5411.377691565521, 5424.538914192259, 5427.402985671573, 5444.128939369682, 4412.294032954776, 4811.230203167476, 4887.266909963463, 4957.529034741694, 4966.329545511382, 4003.459532963071, 4039.091204478969, 4168.7707176105, 4181.310083836193, 4181.832726690959, 1278.111712359901, 1298.6298904812083, 1300.902432317561, 1314.993425032888, 1344.731053789246, 858.6307887608264, 954.4798085043668, 959.0505399654292, 962.3071388600197, 968.0271327316143, 5701.857453563694, 5748.511376532958, 5770.5095066919785, 5920.644761314335, 5980.940190598125, 431.12911917926243, 438.19153661494494, 441.5672640812022, 445.29643163801114, 453.3766071651479, 3894.415837624379, 3942.5466071401584, 3944.6647035001774, 3946.861859834892, 4007.479027726377, 10818.080463160562, 11012.50443730034, 11032.172587055842, 11058.22592418523, 11135.220534562503, 11020.338779673246, 11028.117750580095, 11040.779184416268, 11042.668719938254, 11060.0, 7940.0, 8326.45878017927, 8328.08391076981, 8386.0, 8514.70198543048, 5958.374370691188, 6025.87948241024, 6095.329513753572, 6099.146119543356, 6161.0, 10189.133923616575, 10408.063274305046, 10414.687559373231, 10466.738331541772, 10497.632582859564, 9722.465264410524, 10152.54313555877, 10565.735856603338, 10670.093042091508, 10672.30630009047, 7286.380657644159, 7758.0, 8002.5598592077995, 8039.236272554098, 8192.590370481334, 8743.38796284254, 8803.855498785117, 8808.91191088081, 8847.911520884709, 8854.29165666758, 7647.655855486628, 7722.15056343813, 7802.843943121219, 7852.568108754073, 8028.0, 7498.737544185928, 7605.885911711218, 7615.504992175491, 7714.151443341116, 7740.574268415291, 7115.893261600977, 7137.892931605927, 7171.354578087997, 7176.138863336433, 7226.241244669234, 4938.407391113089, 5019.899602008012, 5074.974625126851, 5115.130427827204, 5197.038547868657, 5008.298838162733, 5026.3214466048075, 5030.647854650286, 5056.089903817348, 5100.6429549931145], "value": 4603.542617773031, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.93419341336164, 320.1484052420559, 320.383262220226, 322.01945077239805, 323.50503729294184, 5619.819837834055, 5621.915671264929, 5629.211910332547, 5636.210930469727, 5644.266245388099, 5550.69471179085, 5550.77796888124, 5550.888982220353, 5567.749451274693, 5568.276124103871, 4086.5300490443606, 4202.138561594881, 4290.356446533014, 4308.159908817782, 4309.125530394273, 4305.901994991273, 4319.265724826787, 4321.817482171499, 4326.329418940069, 4334.461266250483, 4223.51429585597, 4271.124419494012, 4280.0, 4281.72168809028, 4287.335463003239, 4016.297147999103, 4225.72532785371, 4234.343676730112, 4246.214450326699, 4295.1839150561445, 3668.8899333019785, 3686.7787932723854, 3690.852365905361, 3695.611960744137, 3696.537932758405, 5400.270963419927, 5412.648177868426, 5416.74995002999, 5429.212764149176, 5451.255598208575, 4677.7193368398, 4890.73100979446, 4897.3878265216845, 4915.434725006634, 4937.827176048857, 5777.480026797609, 5796.768129274824, 5856.560757943129, 5879.206307148523, 5879.559033072494, 4097.405876147972, 4100.159467309224, 4102.671786257092, 4107.281225785476, 4107.527634322061, 5889.7644094236175, 6065.0, 6075.878482430371, 6115.755369785159, 6116.388361163892, 4142.46148000764, 4150.5641907599875, 4150.858513908639, 4153.670825335864, 4178.289690752518, 4169.228692691861, 4186.413902053715, 4196.454460920122, 4203.654830454287, 4223.366495025771, 4727.881802954885, 4852.878678033077, 4867.853964381075, 4876.122297986397, 4887.193613053877, 5837.503812175928, 5839.3430988899945, 5842.152887831241, 5849.268841394825, 5876.706164691834, 1445.6964037552023, 1451.6298343922444, 1452.4045141491938, 1453.4912780526731, 1454.345544504977, 908.3641450984337, 912.3841407050214, 913.0960349254324, 955.52848613135, 977.750673578233, 5604.495595396353, 5618.494335509824, 5635.154726791015, 5648.85877853057, 5661.66030038199, 5939.227900372924, 5956.225690660273, 5966.254218222723, 6020.397960203944, 6027.186329845415, 5374.0, 5645.322561292671, 5760.971195143998, 5774.682392468455, 5785.1611516329895, 3220.533022711694, 3221.8066915984646, 3235.288236587947, 3250.431174544445, 3254.3491301739746, 6177.536684748662, 6255.43701066897, 6267.592606480564, 6293.632906395057, 6339.2567044062325, 6151.630902145886, 6160.7535698571555, 6191.164192834, 6198.938010619926, 6215.471684906834, 6059.757609695651, 6225.3774622537385, 6306.590071645328, 6307.180066591405, 6310.558260921784, 6026.638401695912, 6038.611119442465, 6057.7879774207695, 6063.393660634078, 6074.574779765374, 5983.282006159288, 6006.669633170043, 6015.157877897011, 6022.397760223943, 6031.517478601789, 6000.279966404059, 6214.658193799384, 6222.0, 6257.78097766576, 6303.779367722108, 4191.2874811281545, 4229.555896630933, 4253.617174454314, 4264.978675106605, 4273.401723758614, 5837.328707198557, 6011.098335249748, 6047.213862197887, 6060.727267272895, 6098.359672234352, 5823.7379317931645, 5856.736446859987, 5879.647221166743, 5884.411208973467, 5891.644921668126, 5761.625494342854, 5789.739461724317, 5792.247007888947, 5852.239208902815, 5877.413098463306, 5197.870053248699, 5716.399778023248, 5730.255066841284, 5766.798162064308, 5796.913046304393, 5826.970865145647, 5859.736311866061, 5898.35118136996, 5899.17411562373, 5908.291005079418, 5513.862153446196, 5738.770449181986, 5738.885222295614, 5742.368339482737, 5846.532277417881], "value": 4421.010481991475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.0711920777838, 778.3150827272, 812.8821320908472, 814.5723495165038, 852.5140669818204, 14014.22921739304, 14910.881683873713, 15056.322465489053, 15057.0, 15085.0, 11954.940225298884, 12166.391680415989, 12204.32876191809, 12236.510539578407, 12261.509539618426, 653.1867824558432, 778.7897267737721, 781.9843603127935, 790.8022994251437, 792.8017995501125, 811.5374236685092, 815.4577206157898, 819.3690858039306, 820.8563501387263, 824.6371596497522, 868.3053557154283, 873.7204094689702, 875.4397185801092, 876.0319846569545, 876.2245412809677, 863.4689665855485, 866.4974314897345, 866.9956650216772, 867.3321542412307, 869.3088994249555, 626.4143026270406, 629.8267976306553, 632.4402903430451, 633.6388258692547, 634.4068296143075, 14329.78505322421, 14361.210133442657, 14402.567922962327, 14448.0, 14527.055741376776, 16086.0, 16202.75695864563, 16239.269232884548, 16251.918740406223, 16546.089965051917, 11812.29126252419, 11966.282023078644, 11979.401029948554, 12047.096467764864, 12174.452149653198, 3962.128331767007, 3964.6035396460125, 3986.641202291779, 3991.880243592697, 4056.5132184137797, 81475.18524814735, 84701.57649211776, 86149.56925215396, 87288.12711872927, 88071.0, 12218.572349967708, 12281.508739650493, 12317.753644927052, 12377.504899804087, 12664.6833829155, 23838.642420363707, 23865.403364916016, 24042.0, 24111.0, 24146.154884579308, 8921.509316987627, 8943.865842012376, 9113.3165012623, 9238.722838314861, 9297.0, 4832.516748325139, 5033.723145226974, 5077.974610126999, 5141.0232055909255, 5218.373795144607, 3560.1633616100194, 3649.324874898099, 3685.0787303174206, 3696.353138200804, 3702.7222958278235, 585.8242527241811, 600.7700149450143, 606.0515293565555, 615.3169981320731, 631.5799993004692, 723.8371366442508, 748.1555886529732, 749.3771798704535, 750.7484992527455, 759.6429678051308, 9561.569729362196, 9595.616175352907, 9706.75733106678, 9872.308938374244, 10152.796944061078, 653.9901901471482, 693.970083058613, 767.1484652036236, 770.8650986077527, 776.6194564663274, 4556.954430455719, 4563.155816174019, 4581.198290299184, 4603.240465323184, 4609.539046095364, 125295.0, 125894.3705281486, 126580.36709816392, 127523.0, 129434.0, 86408.0, 101655.0, 105630.4718476418, 106772.46613767037, 107579.46210269055, 78345.60827195828, 78918.6054069726, 79484.0, 90792.0, 91594.0, 9005.909940900507, 9385.483798391155, 9461.763455913657, 9706.466144361846, 9956.850647240442, 46645.30032049454, 46713.76643116763, 46829.531704682515, 47802.0, 47952.5204747962, 62975.370246298786, 70778.0, 71719.0, 72749.0, 72909.27090729238, 12803.807942880678, 12854.485820567073, 13003.219806811621, 13155.144915580457, 13407.396667150197, 14299.57101286963, 15351.462698805488, 15585.76621350658, 15856.207189640703, 16028.0, 13989.370478328296, 14248.71502569922, 14297.285135742963, 14442.711145776815, 14570.927145364629, 13319.53381631677, 13963.441462341392, 14157.929210353883, 14172.716545668824, 14409.927950360181, 14319.427222911383, 14392.640183995483, 14463.665079066819, 14482.493112741004, 15019.549413517612, 11625.709357266136, 11958.760824783281, 12255.264684118982, 12283.75432491363, 12644.873551264369, 12098.818517722417, 12304.753904921672, 12317.692057698629, 12502.687432814253, 12527.87472125267], "value": 7727.272685668702, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 106.0, 115.0, 115.0, 114.0, 114.0, 114.0, 112.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 120.0, 157.0, 169.0, 119.0, 148.0, 144.0, 124.0, 182.0, 116.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 162.0, 163.0, 166.0, 176.0, 165.0, 162.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 169.0, 78.0, 76.0, 76.0, 75.0, 179.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 151.0, 84.0, 84.0, 85.0, 143.0, 84.0, 85.0, 148.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 122.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 150.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 95.0, 100.0, 96.0, 97.0, 96.0, 95.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 54.0, 56.0, 54.0, 54.0, 65.0, 55.0, 59.0, 54.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 75.0, 74.0, 76.0, 75.0, 75.0, 74.0, 79.0, 76.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 118.0, 120.0, 123.0, 120.0, 124.0, 133.0, 157.0, 136.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 159.0, 155.0, 158.0, 157.0, 157.0, 155.0, 160.0, 156.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 62.0, 67.0, 63.0, 63.0, 64.0, 63.0, 67.0, 61.0], "value": 64.0, "unit": "score"}]}]} 17:29:06 INFO - Return code: 0 17:29:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:29:06 ERROR - # TBPL SUCCESS # 17:29:06 INFO - Running post-action listener: _resource_record_post_action 17:29:06 INFO - ##### 17:29:06 INFO - ##### Finished run-tests step (success) 17:29:06 INFO - ##### 17:29:06 INFO - Running post-run listener: _resource_record_post_run 17:29:06 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 304132096; Read time: 16; Write time: 199352 17:29:06 INFO - TinderboxPrint: CPU usage
13.3% 17:29:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:29:06 INFO - TinderboxPrint: I/O write bytes / time
304,132,096 / 199,352 17:29:06 INFO - TinderboxPrint: CPU idle
8,238.1 (86.7%) 17:29:06 INFO - TinderboxPrint: CPU user
1,210.1 (12.7%) 17:29:06 INFO - TinderboxPrint: Swap in / out
0 / 0 17:29:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 14086144; Read time: 0; Write time: 1688 17:29:06 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 290045952; Read time: 0; Write time: 197664 17:29:06 INFO - Running post-run listener: _upload_blobber_files 17:29:06 INFO - Blob upload gear active. 17:29:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:29:06 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 17:29:06 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:29:06 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:29:07 INFO - (blobuploader) - INFO - Open directory for files ... 17:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:29:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:10 INFO - (blobuploader) - INFO - Done attempting. 17:29:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:29:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:29:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:11 INFO - (blobuploader) - INFO - Done attempting. 17:29:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:29:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:29:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:12 INFO - (blobuploader) - INFO - Done attempting. 17:29:12 INFO - (blobuploader) - INFO - Iteration through files over. 17:29:12 INFO - Return code: 0 17:29:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:29:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:29:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c83c0d906ffb52af43eb11f6d4b95d80dc44de0a8de6ef6e20f7047749cd7d11b655d20d72efc92772ba07f802316561e96b0f6bdb0a4dcb10b97dbbefaa3201", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d70c30b241bb58a5c7e86c6d64ccca85b6b58417db261902d40c6ec165a2142fc5535a7412ea48ee013230c87566d44adf59e7f25f8cded18243d77ad4289b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1a626e6968af890fcb92b7a799954b58765dcd5c634ec0c92859b988aa58ff95f74003e1b66c15b938ea55295457cf2a6921c0e03c0f4c456ad54e7f660acf7"} 17:29:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:29:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:29:12 INFO - Contents: 17:29:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c83c0d906ffb52af43eb11f6d4b95d80dc44de0a8de6ef6e20f7047749cd7d11b655d20d72efc92772ba07f802316561e96b0f6bdb0a4dcb10b97dbbefaa3201", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d70c30b241bb58a5c7e86c6d64ccca85b6b58417db261902d40c6ec165a2142fc5535a7412ea48ee013230c87566d44adf59e7f25f8cded18243d77ad4289b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1a626e6968af890fcb92b7a799954b58765dcd5c634ec0c92859b988aa58ff95f74003e1b66c15b938ea55295457cf2a6921c0e03c0f4c456ad54e7f660acf7"} 17:29:12 INFO - Running post-run listener: copy_logs_to_upload_dir 17:29:12 INFO - Copying logs to upload dir... 17:29:12 INFO - mkdir: /builds/slave/test/build/upload/logs 17:29:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1433.001716 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 53 secs) (at 2016-06-29 17:29:11.886618) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 17:29:11.890851) ========= 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=eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142 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/Fx-Team/sha512/c83c0d906ffb52af43eb11f6d4b95d80dc44de0a8de6ef6e20f7047749cd7d11b655d20d72efc92772ba07f802316561e96b0f6bdb0a4dcb10b97dbbefaa3201", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d70c30b241bb58a5c7e86c6d64ccca85b6b58417db261902d40c6ec165a2142fc5535a7412ea48ee013230c87566d44adf59e7f25f8cded18243d77ad4289b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1a626e6968af890fcb92b7a799954b58765dcd5c634ec0c92859b988aa58ff95f74003e1b66c15b938ea55295457cf2a6921c0e03c0f4c456ad54e7f660acf7"} build_url:https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/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/Fx-Team/sha512/c83c0d906ffb52af43eb11f6d4b95d80dc44de0a8de6ef6e20f7047749cd7d11b655d20d72efc92772ba07f802316561e96b0f6bdb0a4dcb10b97dbbefaa3201", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d70c30b241bb58a5c7e86c6d64ccca85b6b58417db261902d40c6ec165a2142fc5535a7412ea48ee013230c87566d44adf59e7f25f8cded18243d77ad4289b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1a626e6968af890fcb92b7a799954b58765dcd5c634ec0c92859b988aa58ff95f74003e1b66c15b938ea55295457cf2a6921c0e03c0f4c456ad54e7f660acf7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 17:29:11.920574) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:29:11.920914) ========= 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=eca2ab57546de7b41f256b19000001ef-1467243653.371862-1863571142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:29:12.001369) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 17:29:12.001699) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 17:29:12.002003) ========= ========= Total master_lag: 0.17 =========