builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1472926310.87 results: success (0) buildid: 20160903083042 builduid: 24a697df10714e9e9e7ea7f3801f40f5 revision: bcab45259b4fe5787d0d6fea16067e763f2a11ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:50.867410) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:50.867778) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:50.868059) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:50.890192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:50.890438) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-03 11:11:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-09-03 11:11:51 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097196 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:51.019507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:51.019799) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017591 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:51.089608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:51.090012) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bcab45259b4fe5787d0d6fea16067e763f2a11ea --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 bcab45259b4fe5787d0d6fea16067e763f2a11ea --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=5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-03 11:11:51,595 truncating revision to first 12 chars 2016-09-03 11:11:51,595 Setting DEBUG logging. 2016-09-03 11:11:51,595 attempt 1/10 2016-09-03 11:11:51,595 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bcab45259b4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-03 11:11:51,905 unpacking tar archive at: fx-team-bcab45259b4f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:51.750375) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:51.750710) ========= script_repo_revision: bcab45259b4fe5787d0d6fea16067e763f2a11ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:51.751157) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:51.751422) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 11:11:51.764263) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-03 11:11:51.764569) ========= /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=5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:11:52 INFO - MultiFileLogger online at 20160903 11:11:52 in /builds/slave/test 11:11:52 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 11:11:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:52 INFO - {'append_to_log': False, 11:11:52 INFO - 'base_work_dir': '/builds/slave/test', 11:11:52 INFO - 'blob_upload_branch': 'Fx-Team', 11:11:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:52 INFO - 'branch': 'Fx-Team', 11:11:52 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:52 INFO - 'config_files': ('talos/linux_config.py',), 11:11:52 INFO - 'default_actions': ('clobber', 11:11:52 INFO - 'read-buildbot-config', 11:11:52 INFO - 'download-and-extract', 11:11:52 INFO - 'populate-webroot', 11:11:52 INFO - 'create-virtualenv', 11:11:52 INFO - 'install', 11:11:52 INFO - 'run-tests'), 11:11:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:52 INFO - 'download_minidump_stackwalk': True, 11:11:52 INFO - 'download_symbols': 'ondemand', 11:11:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:52 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:52 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:52 INFO - 'installer_path': 'installer.exe', 11:11:52 INFO - 'log_level': 'info', 11:11:52 INFO - 'log_name': 'talos', 11:11:52 INFO - 'log_to_console': True, 11:11:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:11:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:11:52 INFO - 'opt_config_files': (), 11:11:52 INFO - 'pip_index': False, 11:11:52 INFO - 'sps_profile': False, 11:11:52 INFO - 'sps_profile_interval': 0, 11:11:52 INFO - 'suite': 'dromaeojs-e10s', 11:11:52 INFO - 'system_bits': '32', 11:11:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:52 INFO - 'title': 'talos-linux64-ix-011', 11:11:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:52 INFO - 'use_talos_json': True, 11:11:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:52 INFO - 'work_dir': 'build'} 11:11:52 INFO - [mozharness: 2016-09-03 18:11:52.360560Z] Running clobber step. 11:11:52 INFO - Running pre-action listener: _resource_record_pre_action 11:11:52 INFO - Running main action method: clobber 11:11:52 INFO - rmtree: /builds/slave/test/build 11:11:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:53 INFO - Running post-action listener: _resource_record_post_action 11:11:53 INFO - [mozharness: 2016-09-03 18:11:53.360299Z] Finished clobber step (success) 11:11:53 INFO - [mozharness: 2016-09-03 18:11:53.360400Z] Running read-buildbot-config step. 11:11:53 INFO - Running pre-action listener: _resource_record_pre_action 11:11:53 INFO - Running main action method: read_buildbot_config 11:11:53 INFO - Using buildbot properties: 11:11:53 INFO - { 11:11:53 INFO - "project": "", 11:11:53 INFO - "product": "firefox", 11:11:53 INFO - "script_repo_revision": "production", 11:11:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:11:53 INFO - "repository": "", 11:11:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:11:53 INFO - "buildid": "20160903083042", 11:11:53 INFO - "pgo_build": "True", 11:11:53 INFO - "basedir": "/builds/slave/test", 11:11:53 INFO - "buildnumber": 748, 11:11:53 INFO - "slavename": "talos-linux64-ix-011", 11:11:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:11:53 INFO - "platform": "ubuntu64_hw", 11:11:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:11:53 INFO - "branch": "fx-team", 11:11:53 INFO - "repo_path": "integration/fx-team", 11:11:53 INFO - "revision": "bcab45259b4fe5787d0d6fea16067e763f2a11ea", 11:11:53 INFO - "stage_platform": "linux64-pgo", 11:11:53 INFO - "builduid": "24a697df10714e9e9e7ea7f3801f40f5", 11:11:53 INFO - "slavebuilddir": "test" 11:11:53 INFO - } 11:11:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:11:53 INFO - Running post-action listener: _resource_record_post_action 11:11:53 INFO - [mozharness: 2016-09-03 18:11:53.362815Z] Finished read-buildbot-config step (success) 11:11:53 INFO - [mozharness: 2016-09-03 18:11:53.362906Z] Running download-and-extract step. 11:11:53 INFO - Running pre-action listener: _resource_record_pre_action 11:11:53 INFO - Running main action method: download_and_extract 11:11:53 INFO - mkdir: /builds/slave/test/build/tests 11:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:53 INFO - trying https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:11:53 INFO - Downloading https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:11:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:11:53 INFO - Downloaded 1361 bytes. 11:11:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:11:53 INFO - Using the following test package requirements: 11:11:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:11:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:11:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:11:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:53 INFO - u'jsshell-linux-x86_64.zip'], 11:11:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:11:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:11:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:11:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:11:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:11:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:11:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:53 INFO - trying https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:11:53 INFO - Downloading https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:11:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:11:54 INFO - Downloaded 21906553 bytes. 11:11:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:11:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:59 INFO - trying https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:11:59 INFO - Downloading https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:11:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:11:59 INFO - Downloaded 21906553 bytes. 11:11:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:04 INFO - trying https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:04 INFO - Downloading https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:12:05 INFO - Downloaded 14413998 bytes. 11:12:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:05 INFO - trying https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:12:05 INFO - Downloading https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:12:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:12:07 INFO - Downloaded 59698163 bytes. 11:12:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:12:07 INFO - mkdir: /builds/slave/test/properties 11:12:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:07 INFO - Contents: 11:12:07 INFO - build_url:https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:12:07 INFO - Running post-action listener: _resource_record_post_action 11:12:07 INFO - Running post-action listener: set_extra_try_arguments 11:12:07 INFO - [mozharness: 2016-09-03 18:12:07.772009Z] Finished download-and-extract step (success) 11:12:07 INFO - [mozharness: 2016-09-03 18:12:07.772238Z] Running populate-webroot step. 11:12:07 INFO - Running pre-action listener: _resource_record_pre_action 11:12:07 INFO - Running main action method: populate_webroot 11:12:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:07 INFO - '--tppagecycles', 11:12:07 INFO - '7'], 11:12:07 INFO - 'tests': ['tsvgm']}}, 11:12:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:12:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:12:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:12:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:12:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:12:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:07 INFO - 'talos_options': ['--disable-e10s'], 11:12:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:07 INFO - 'talos_options': ['--disable-e10s'], 11:12:07 INFO - 'tests': ['damp', 'tps']}, 11:12:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:07 INFO - 'tests': ['damp', 'tps']}, 11:12:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:12:07 INFO - 'tests': ['dromaeo_dom']}, 11:12:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:12:07 INFO - 'tests': ['basic_compositor_video']}, 11:12:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:12:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:12:07 INFO - 'tests': ['a11yr', 11:12:07 INFO - 'ts_paint', 11:12:07 INFO - 'tpaint', 11:12:07 INFO - 'sessionrestore', 11:12:07 INFO - 'sessionrestore_no_auto_restore', 11:12:07 INFO - 'tabpaint']}, 11:12:07 INFO - 'other-e10s': {'tests': ['a11yr', 11:12:07 INFO - 'ts_paint', 11:12:07 INFO - 'tpaint', 11:12:07 INFO - 'sessionrestore', 11:12:07 INFO - 'sessionrestore_no_auto_restore', 11:12:07 INFO - 'tabpaint']}, 11:12:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:12:07 INFO - 'ts_paint', 11:12:07 INFO - 'tpaint', 11:12:07 INFO - 'sessionrestore', 11:12:07 INFO - 'sessionrestore_no_auto_restore', 11:12:07 INFO - 'tabpaint']}, 11:12:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:12:07 INFO - 'ts_paint', 11:12:07 INFO - 'tpaint', 11:12:07 INFO - 'sessionrestore', 11:12:07 INFO - 'sessionrestore_no_auto_restore', 11:12:07 INFO - 'tabpaint']}, 11:12:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:12:07 INFO - 'tests': ['a11yr', 11:12:07 INFO - 'ts_paint', 11:12:07 INFO - 'tpaint', 11:12:07 INFO - 'sessionrestore', 11:12:07 INFO - 'sessionrestore_no_auto_restore', 11:12:07 INFO - 'tabpaint']}, 11:12:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:12:07 INFO - 'tests': ['a11yr', 11:12:07 INFO - 'ts_paint', 11:12:07 INFO - 'tpaint', 11:12:07 INFO - 'sessionrestore', 11:12:07 INFO - 'sessionrestore_no_auto_restore', 11:12:07 INFO - 'tabpaint']}, 11:12:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:12:07 INFO - 'tests': ['tsvgx', 11:12:07 INFO - 'tsvgr_opacity', 11:12:07 INFO - 'tart', 11:12:07 INFO - 'tscrollx', 11:12:07 INFO - 'cart']}, 11:12:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:12:07 INFO - 'tsvgr_opacity', 11:12:07 INFO - 'tart', 11:12:07 INFO - 'tscrollx', 11:12:07 INFO - 'cart']}, 11:12:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:07 INFO - 'talos_options': ['--disable-e10s'], 11:12:07 INFO - 'tests': ['tp5o']}, 11:12:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:07 INFO - 'tests': ['tp5o']}, 11:12:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:07 INFO - 'talos_options': ['--disable-e10s', 11:12:07 INFO - '--xperf_path', 11:12:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:07 INFO - 'tests': ['tp5n']}, 11:12:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:07 INFO - 'talos_options': ['--xperf_path', 11:12:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:07 INFO - 'tests': ['tp5n']}}, 11:12:07 INFO - 'talos.zip': {'path': '', 11:12:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:07 INFO - Running post-action listener: _resource_record_post_action 11:12:07 INFO - [mozharness: 2016-09-03 18:12:07.792829Z] Finished populate-webroot step (success) 11:12:07 INFO - [mozharness: 2016-09-03 18:12:07.792918Z] Running create-virtualenv step. 11:12:07 INFO - Running pre-action listener: _resource_record_pre_action 11:12:07 INFO - Running main action method: create_virtualenv 11:12:07 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:12:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:12:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:07 INFO - Using real prefix '/usr' 11:12:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:10 INFO - Installing pip.................done. 11:12:10 INFO - Return code: 0 11:12:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc124f55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe8850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3370>, '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 0xfe68f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe6d80>, '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': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:12:10 INFO - Using env: {'DISPLAY': ':0', 11:12:10 INFO - 'HOME': '/home/cltbld', 11:12:10 INFO - 'LANG': 'en_US.UTF-8', 11:12:10 INFO - 'LANGUAGE': 'en_US:en', 11:12:10 INFO - 'LOGNAME': 'cltbld', 11:12:10 INFO - 'MAIL': '/var/mail/cltbld', 11:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:10 INFO - 'MOZ_NO_REMOTE': '1', 11:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:10 INFO - 'NO_EM_RESTART': '1', 11:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:10 INFO - 'PWD': '/builds/slave/test', 11:12:10 INFO - 'SHELL': '/bin/bash', 11:12:10 INFO - 'SHLVL': '1', 11:12:10 INFO - 'TERM': 'linux', 11:12:10 INFO - 'TMOUT': '86400', 11:12:10 INFO - 'USER': 'cltbld', 11:12:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 11:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:10 INFO - '_': '/tools/buildbot/bin/python'} 11:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:12:10 INFO - Cleaning up... 11:12:10 INFO - Return code: 0 11:12:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc124f55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe8850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3370>, '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 0xfe68f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe6d80>, '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': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:12:10 INFO - Using env: {'DISPLAY': ':0', 11:12:10 INFO - 'HOME': '/home/cltbld', 11:12:10 INFO - 'LANG': 'en_US.UTF-8', 11:12:10 INFO - 'LANGUAGE': 'en_US:en', 11:12:10 INFO - 'LOGNAME': 'cltbld', 11:12:10 INFO - 'MAIL': '/var/mail/cltbld', 11:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:10 INFO - 'MOZ_NO_REMOTE': '1', 11:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:10 INFO - 'NO_EM_RESTART': '1', 11:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:10 INFO - 'PWD': '/builds/slave/test', 11:12:10 INFO - 'SHELL': '/bin/bash', 11:12:10 INFO - 'SHLVL': '1', 11:12:10 INFO - 'TERM': 'linux', 11:12:10 INFO - 'TMOUT': '86400', 11:12:10 INFO - 'USER': 'cltbld', 11:12:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 11:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:10 INFO - '_': '/tools/buildbot/bin/python'} 11:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:10 INFO - Downloading/unpacking psutil>=3.1.1 11:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:12 INFO - Installing collected packages: psutil 11:12:12 INFO - Running setup.py install for psutil 11:12:12 INFO - building 'psutil._psutil_linux' extension 11:12:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:12:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:12:13 INFO - building 'psutil._psutil_posix' extension 11:12:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:12:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:12:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:13 INFO - Successfully installed psutil 11:12:13 INFO - Cleaning up... 11:12:13 INFO - Return code: 0 11:12:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc124f55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe8850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3370>, '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 0xfe68f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe6d80>, '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': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:12:13 INFO - Using env: {'DISPLAY': ':0', 11:12:13 INFO - 'HOME': '/home/cltbld', 11:12:13 INFO - 'LANG': 'en_US.UTF-8', 11:12:13 INFO - 'LANGUAGE': 'en_US:en', 11:12:13 INFO - 'LOGNAME': 'cltbld', 11:12:13 INFO - 'MAIL': '/var/mail/cltbld', 11:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:13 INFO - 'MOZ_NO_REMOTE': '1', 11:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:13 INFO - 'NO_EM_RESTART': '1', 11:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:13 INFO - 'PWD': '/builds/slave/test', 11:12:13 INFO - 'SHELL': '/bin/bash', 11:12:13 INFO - 'SHLVL': '1', 11:12:13 INFO - 'TERM': 'linux', 11:12:13 INFO - 'TMOUT': '86400', 11:12:13 INFO - 'USER': 'cltbld', 11:12:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 11:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:13 INFO - '_': '/tools/buildbot/bin/python'} 11:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:12:15 INFO - Installing collected packages: mozsystemmonitor 11:12:15 INFO - Running setup.py install for mozsystemmonitor 11:12:15 INFO - Successfully installed mozsystemmonitor 11:12:15 INFO - Cleaning up... 11:12:15 INFO - Return code: 0 11:12:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:15 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 0x7fc124f55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe8850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3370>, '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 0xfe68f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe6d80>, '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': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:12:15 INFO - Using env: {'DISPLAY': ':0', 11:12:15 INFO - 'HOME': '/home/cltbld', 11:12:15 INFO - 'LANG': 'en_US.UTF-8', 11:12:15 INFO - 'LANGUAGE': 'en_US:en', 11:12:15 INFO - 'LOGNAME': 'cltbld', 11:12:15 INFO - 'MAIL': '/var/mail/cltbld', 11:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:15 INFO - 'MOZ_NO_REMOTE': '1', 11:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:15 INFO - 'NO_EM_RESTART': '1', 11:12:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:15 INFO - 'PWD': '/builds/slave/test', 11:12:15 INFO - 'SHELL': '/bin/bash', 11:12:15 INFO - 'SHLVL': '1', 11:12:15 INFO - 'TERM': 'linux', 11:12:15 INFO - 'TMOUT': '86400', 11:12:15 INFO - 'USER': 'cltbld', 11:12:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 11:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:15 INFO - '_': '/tools/buildbot/bin/python'} 11:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:15 INFO - Downloading/unpacking jsonschema==2.5.1 11:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:17 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:17 INFO - warning: no files found matching '*.txt' 11:12:17 INFO - no previously-included directories found matching 'build' 11:12:17 INFO - no previously-included directories found matching 'dist' 11:12:17 INFO - no previously-included directories found matching '.git*' 11:12:18 INFO - Installing collected packages: jsonschema, functools32 11:12:18 INFO - Running setup.py install for functools32 11:12:18 INFO - warning: no files found matching '*.txt' 11:12:18 INFO - no previously-included directories found matching 'build' 11:12:18 INFO - no previously-included directories found matching 'dist' 11:12:18 INFO - no previously-included directories found matching '.git*' 11:12:18 INFO - Successfully installed jsonschema functools32 11:12:18 INFO - Cleaning up... 11:12:18 INFO - Return code: 0 11:12:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:18 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc124f55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe8850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3370>, '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 0xfe68f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe6d80>, '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': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:18 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:12:18 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 functools32==3.2.3-2 11:12:18 INFO - Using env: {'DISPLAY': ':0', 11:12:18 INFO - 'HOME': '/home/cltbld', 11:12:18 INFO - 'LANG': 'en_US.UTF-8', 11:12:18 INFO - 'LANGUAGE': 'en_US:en', 11:12:18 INFO - 'LOGNAME': 'cltbld', 11:12:18 INFO - 'MAIL': '/var/mail/cltbld', 11:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:18 INFO - 'MOZ_NO_REMOTE': '1', 11:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:18 INFO - 'NO_EM_RESTART': '1', 11:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:18 INFO - 'PWD': '/builds/slave/test', 11:12:18 INFO - 'SHELL': '/bin/bash', 11:12:18 INFO - 'SHLVL': '1', 11:12:18 INFO - 'TERM': 'linux', 11:12:18 INFO - 'TMOUT': '86400', 11:12:18 INFO - 'USER': 'cltbld', 11:12:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 11:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:18 INFO - '_': '/tools/buildbot/bin/python'} 11:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:12:18 INFO - Cleaning up... 11:12:18 INFO - Return code: 0 11:12:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:18 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 0x7fc124f55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe8850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3370>, '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 0xfe68f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe6d80>, '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': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:12:18 INFO - Using env: {'DISPLAY': ':0', 11:12:18 INFO - 'HOME': '/home/cltbld', 11:12:18 INFO - 'LANG': 'en_US.UTF-8', 11:12:18 INFO - 'LANGUAGE': 'en_US:en', 11:12:18 INFO - 'LOGNAME': 'cltbld', 11:12:18 INFO - 'MAIL': '/var/mail/cltbld', 11:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:18 INFO - 'MOZ_NO_REMOTE': '1', 11:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:18 INFO - 'NO_EM_RESTART': '1', 11:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:18 INFO - 'PWD': '/builds/slave/test', 11:12:18 INFO - 'SHELL': '/bin/bash', 11:12:18 INFO - 'SHLVL': '1', 11:12:18 INFO - 'TERM': 'linux', 11:12:18 INFO - 'TMOUT': '86400', 11:12:18 INFO - 'USER': 'cltbld', 11:12:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 11:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:18 INFO - '_': '/tools/buildbot/bin/python'} 11:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:18 INFO - Downloading/unpacking blobuploader==1.2.4 11:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:20 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:21 INFO - Downloading docopt-0.6.1.tar.gz 11:12:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:21 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:21 INFO - Running setup.py install for blobuploader 11:12:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:21 INFO - Running setup.py install for requests 11:12:21 INFO - Running setup.py install for docopt 11:12:21 INFO - Successfully installed blobuploader requests docopt 11:12:21 INFO - Cleaning up... 11:12:21 INFO - Return code: 0 11:12:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:21 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 0x7fc124f55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe8850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3370>, '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 0xfe68f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe6d80>, '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': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:12:21 INFO - Using env: {'DISPLAY': ':0', 11:12:21 INFO - 'HOME': '/home/cltbld', 11:12:21 INFO - 'LANG': 'en_US.UTF-8', 11:12:21 INFO - 'LANGUAGE': 'en_US:en', 11:12:21 INFO - 'LOGNAME': 'cltbld', 11:12:21 INFO - 'MAIL': '/var/mail/cltbld', 11:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:21 INFO - 'MOZ_NO_REMOTE': '1', 11:12:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:21 INFO - 'NO_EM_RESTART': '1', 11:12:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:21 INFO - 'PWD': '/builds/slave/test', 11:12:21 INFO - 'SHELL': '/bin/bash', 11:12:21 INFO - 'SHLVL': '1', 11:12:21 INFO - 'TERM': 'linux', 11:12:21 INFO - 'TMOUT': '86400', 11:12:21 INFO - 'USER': 'cltbld', 11:12:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 11:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:21 INFO - '_': '/tools/buildbot/bin/python'} 11:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:22 INFO - Running setup.py (path:/tmp/pip-wdg_hO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:22 INFO - Running setup.py (path:/tmp/pip-R9XUbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:22 INFO - Running setup.py (path:/tmp/pip-C6Btsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:22 INFO - Running setup.py (path:/tmp/pip-AhignM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:22 INFO - Running setup.py (path:/tmp/pip-oKCvvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:22 INFO - Running setup.py (path:/tmp/pip-c0v9as-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:22 INFO - Running setup.py (path:/tmp/pip-00FXEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:22 INFO - Running setup.py (path:/tmp/pip-I92cTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:22 INFO - Running setup.py (path:/tmp/pip-bJsJpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:22 INFO - Running setup.py (path:/tmp/pip-QUxn7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:22 INFO - Running setup.py (path:/tmp/pip-FDmWNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:22 INFO - Running setup.py (path:/tmp/pip-Kg87m5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:22 INFO - Running setup.py (path:/tmp/pip-TfSnG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:23 INFO - Running setup.py (path:/tmp/pip-KP9eXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:23 INFO - Running setup.py (path:/tmp/pip-8blnsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:23 INFO - Running setup.py (path:/tmp/pip-HOem2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:23 INFO - Running setup.py (path:/tmp/pip-AVd1tU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:23 INFO - Running setup.py install for manifestparser 11:12:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:12:23 INFO - Running setup.py install for mozcrash 11:12:23 INFO - Running setup.py install for mozdebug 11:12:23 INFO - Running setup.py install for mozdevice 11:12:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:12:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:12:23 INFO - Running setup.py install for mozfile 11:12:23 INFO - Running setup.py install for mozhttpd 11:12:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:12:23 INFO - Running setup.py install for mozinfo 11:12:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Running setup.py install for mozInstall 11:12:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Running setup.py install for mozleak 11:12:24 INFO - Running setup.py install for mozlog 11:12:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Running setup.py install for moznetwork 11:12:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Running setup.py install for mozprocess 11:12:24 INFO - Running setup.py install for mozprofile 11:12:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Running setup.py install for mozrunner 11:12:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Running setup.py install for mozscreenshot 11:12:24 INFO - Running setup.py install for moztest 11:12:25 INFO - Running setup.py install for mozversion 11:12:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:12:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:25 INFO - Cleaning up... 11:12:25 INFO - Return code: 0 11:12:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:25 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 0x7fc124f55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe8850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3370>, '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 0xfe68f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe6d80>, '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': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:12:25 INFO - Using env: {'DISPLAY': ':0', 11:12:25 INFO - 'HOME': '/home/cltbld', 11:12:25 INFO - 'LANG': 'en_US.UTF-8', 11:12:25 INFO - 'LANGUAGE': 'en_US:en', 11:12:25 INFO - 'LOGNAME': 'cltbld', 11:12:25 INFO - 'MAIL': '/var/mail/cltbld', 11:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:25 INFO - 'MOZ_NO_REMOTE': '1', 11:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:25 INFO - 'NO_EM_RESTART': '1', 11:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:25 INFO - 'PWD': '/builds/slave/test', 11:12:25 INFO - 'SHELL': '/bin/bash', 11:12:25 INFO - 'SHLVL': '1', 11:12:25 INFO - 'TERM': 'linux', 11:12:25 INFO - 'TMOUT': '86400', 11:12:25 INFO - 'USER': 'cltbld', 11:12:25 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 11:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:25 INFO - '_': '/tools/buildbot/bin/python'} 11:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:25 INFO - Running setup.py (path:/tmp/pip-eq6hsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:25 INFO - Running setup.py (path:/tmp/pip-qyLXrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:25 INFO - Running setup.py (path:/tmp/pip-a5hgkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:25 INFO - Running setup.py (path:/tmp/pip-_XJrHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:25 INFO - Running setup.py (path:/tmp/pip-JGc1qS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:25 INFO - Running setup.py (path:/tmp/pip-R22ui6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:25 INFO - Running setup.py (path:/tmp/pip-f7cEKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:25 INFO - Running setup.py (path:/tmp/pip-S9xh1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:25 INFO - Running setup.py (path:/tmp/pip-Qy65CN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:26 INFO - Running setup.py (path:/tmp/pip-qwuNSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:26 INFO - Running setup.py (path:/tmp/pip-IrN9Gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:26 INFO - Running setup.py (path:/tmp/pip-OAHoSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:26 INFO - Running setup.py (path:/tmp/pip-T0WzzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:26 INFO - Running setup.py (path:/tmp/pip-TJdF6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:26 INFO - Running setup.py (path:/tmp/pip-kwRm3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:26 INFO - Running setup.py (path:/tmp/pip-sUe1Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:26 INFO - Running setup.py (path:/tmp/pip-pLxerm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:28 INFO - Downloading blessings-1.6.tar.gz 11:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:28 INFO - Installing collected packages: blessings 11:12:28 INFO - Running setup.py install for blessings 11:12:28 INFO - Successfully installed blessings 11:12:28 INFO - Cleaning up... 11:12:28 INFO - Return code: 0 11:12:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:28 INFO - Reading from file tmpfile_stdout 11:12:28 INFO - Current package versions: 11:12:28 INFO - argparse == 1.2.1 11:12:28 INFO - blessings == 1.6 11:12:28 INFO - blobuploader == 1.2.4 11:12:28 INFO - docopt == 0.6.1 11:12:28 INFO - functools32 == 3.2.3-2 11:12:28 INFO - jsonschema == 2.5.1 11:12:28 INFO - manifestparser == 1.1 11:12:28 INFO - mozInstall == 1.12 11:12:28 INFO - mozcrash == 0.17 11:12:28 INFO - mozdebug == 0.1 11:12:28 INFO - mozdevice == 0.48 11:12:28 INFO - mozfile == 1.2 11:12:28 INFO - mozhttpd == 0.7 11:12:28 INFO - mozinfo == 0.9 11:12:28 INFO - mozleak == 0.1 11:12:28 INFO - mozlog == 3.3 11:12:28 INFO - moznetwork == 0.27 11:12:28 INFO - mozprocess == 0.23 11:12:28 INFO - mozprofile == 0.28 11:12:28 INFO - mozrunner == 6.12 11:12:28 INFO - mozscreenshot == 0.1 11:12:28 INFO - mozsystemmonitor == 0.3 11:12:28 INFO - moztest == 0.7 11:12:28 INFO - mozversion == 1.4 11:12:28 INFO - psutil == 3.1.1 11:12:28 INFO - requests == 1.2.3 11:12:28 INFO - wsgiref == 0.1.2 11:12:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:28 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 0x7fc124f55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe8850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3370>, '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 0xfe68f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe6d80>, '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': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:12:28 INFO - Using env: {'DISPLAY': ':0', 11:12:28 INFO - 'HOME': '/home/cltbld', 11:12:28 INFO - 'LANG': 'en_US.UTF-8', 11:12:28 INFO - 'LANGUAGE': 'en_US:en', 11:12:28 INFO - 'LOGNAME': 'cltbld', 11:12:28 INFO - 'MAIL': '/var/mail/cltbld', 11:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:28 INFO - 'MOZ_NO_REMOTE': '1', 11:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:28 INFO - 'NO_EM_RESTART': '1', 11:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:28 INFO - 'PWD': '/builds/slave/test', 11:12:28 INFO - 'SHELL': '/bin/bash', 11:12:28 INFO - 'SHLVL': '1', 11:12:28 INFO - 'TERM': 'linux', 11:12:28 INFO - 'TMOUT': '86400', 11:12:28 INFO - 'USER': 'cltbld', 11:12:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 11:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:28 INFO - '_': '/tools/buildbot/bin/python'} 11:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:12:29 INFO - Cleaning up... 11:12:29 INFO - Return code: 0 11:12:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc124f55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe8850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3370>, '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 0xfe68f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe6d80>, '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': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:12:29 INFO - Using env: {'DISPLAY': ':0', 11:12:29 INFO - 'HOME': '/home/cltbld', 11:12:29 INFO - 'LANG': 'en_US.UTF-8', 11:12:29 INFO - 'LANGUAGE': 'en_US:en', 11:12:29 INFO - 'LOGNAME': 'cltbld', 11:12:29 INFO - 'MAIL': '/var/mail/cltbld', 11:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:29 INFO - 'MOZ_NO_REMOTE': '1', 11:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:29 INFO - 'NO_EM_RESTART': '1', 11:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:29 INFO - 'PWD': '/builds/slave/test', 11:12:29 INFO - 'SHELL': '/bin/bash', 11:12:29 INFO - 'SHLVL': '1', 11:12:29 INFO - 'TERM': 'linux', 11:12:29 INFO - 'TMOUT': '86400', 11:12:29 INFO - 'USER': 'cltbld', 11:12:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 11:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:29 INFO - '_': '/tools/buildbot/bin/python'} 11:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:12:29 INFO - Cleaning up... 11:12:29 INFO - Return code: 0 11:12:29 INFO - Running post-action listener: _resource_record_post_action 11:12:29 INFO - Running post-action listener: _start_resource_monitoring 11:12:29 INFO - Starting resource monitoring. 11:12:29 INFO - [mozharness: 2016-09-03 18:12:29.389372Z] Finished create-virtualenv step (success) 11:12:29 INFO - [mozharness: 2016-09-03 18:12:29.389877Z] Running install step. 11:12:29 INFO - Running pre-action listener: _resource_record_pre_action 11:12:29 INFO - Running main action method: install 11:12:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:29 INFO - Reading from file tmpfile_stdout 11:12:29 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:12:29 INFO - Reading from file tmpfile_stdout 11:12:29 INFO - Output received: 11:12:29 INFO - Usage: mozinstall [options] installer 11:12:29 INFO - Options: 11:12:29 INFO - -h, --help show this help message and exit 11:12:29 INFO - -d DEST, --destination=DEST 11:12:29 INFO - Directory to install application into. [default: 11:12:29 INFO - "/builds/slave/test"] 11:12:29 INFO - --app=APP Application being installed. [default: firefox] 11:12:29 INFO - mkdir: /builds/slave/test/build/application 11:12:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:12:48 INFO - Reading from file tmpfile_stdout 11:12:48 INFO - Output received: 11:12:48 INFO - /builds/slave/test/build/application/firefox/firefox 11:12:48 INFO - Running post-action listener: _resource_record_post_action 11:12:48 INFO - [mozharness: 2016-09-03 18:12:48.078781Z] Finished install step (success) 11:12:48 INFO - [mozharness: 2016-09-03 18:12:48.079065Z] Running run-tests step. 11:12:48 INFO - Running pre-action listener: _resource_record_pre_action 11:12:48 INFO - Running main action method: run_tests 11:12:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:12:48 INFO - Python 2.7.3 11:12:48 INFO - Return code: 0 11:12:48 INFO - grabbing minidump binary from tooltool 11:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3370>, '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 0xfe68f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe6d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:12:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:12:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:12:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:12:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:12:48 INFO - Return code: 0 11:12:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:12:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:12:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:12:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:12:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:12:48 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/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:12:48 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/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:12:48 INFO - Using env: {'DISPLAY': ':0', 11:12:48 INFO - 'HOME': '/home/cltbld', 11:12:48 INFO - 'LANG': 'en_US.UTF-8', 11:12:48 INFO - 'LANGUAGE': 'en_US:en', 11:12:48 INFO - 'LOGNAME': 'cltbld', 11:12:48 INFO - 'MAIL': '/var/mail/cltbld', 11:12:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:48 INFO - 'MOZ_NO_REMOTE': '1', 11:12:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:48 INFO - 'NO_EM_RESTART': '1', 11:12:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:48 INFO - 'PWD': '/builds/slave/test', 11:12:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:48 INFO - 'SHELL': '/bin/bash', 11:12:48 INFO - 'SHLVL': '1', 11:12:48 INFO - 'TERM': 'linux', 11:12:48 INFO - 'TMOUT': '86400', 11:12:48 INFO - 'USER': 'cltbld', 11:12:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141', 11:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:48 INFO - '_': '/tools/buildbot/bin/python'} 11:12:48 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/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:12:48 INFO - mozversion application_buildid: 20160903083042 11:12:48 INFO - mozversion application_changeset: bcab45259b4fe5787d0d6fea16067e763f2a11ea 11:12:48 INFO - mozversion application_display_name: Nightly 11:12:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:12:48 INFO - mozversion application_name: Firefox 11:12:48 INFO - mozversion application_remotingname: firefox 11:12:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:12:48 INFO - mozversion application_vendor: Mozilla 11:12:48 INFO - mozversion application_version: 51.0a1 11:12:48 INFO - mozversion platform_buildid: 20160903083042 11:12:48 INFO - mozversion platform_changeset: bcab45259b4fe5787d0d6fea16067e763f2a11ea 11:12:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:12:48 INFO - mozversion platform_version: 51.0a1 11:12:48 INFO - using testdate: 1472926368 11:12:48 INFO - actual date: 1472926368 11:12:48 INFO - starting webserver on 'localhost:44583' 11:12:48 INFO - SUITE-START | Running 2 tests 11:12:48 INFO - TEST-START | dromaeo_css 11:12:48 INFO - operating with platform_type : linux_ 11:12:48 INFO - Initialising browser for dromaeo_css test... 11:12:48 INFO - TEST-INFO | started process 21102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp25FIKX/profile http://localhost:44583/getInfo.html) 11:12:53 INFO - PROCESS | 21102 | __metrics Screen width/height:1600/1200 11:12:53 INFO - PROCESS | 21102 | colorDepth:24 11:12:53 INFO - PROCESS | 21102 | Browser inner width/height: 1024/697 11:12:53 INFO - PROCESS | 21102 | __metrics 11:12:54 ERROR - PROCESS | 21102 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 11:12:55 INFO - TEST-INFO | 21102: exit 0 11:12:55 INFO - Browser initialized. 11:12:55 INFO - Running cycle 1/1 for dromaeo_css test... 11:12:55 INFO - TEST-INFO | started process 21222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp25FIKX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:07 INFO - PROCESS | 21222 | RSS: Main: 191356928 11:13:07 INFO - PROCESS | 21222 | 11:13:57 INFO - PROCESS | 21222 | 1472926437142 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:16:06 INFO - PROCESS | 21222 | Cycle 1(1): loaded http://localhost:44583/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44583/tests/dromaeo/cssquery-ext.html) 11:16:07 INFO - PROCESS | 21222 | RSS: Main: 206249984 11:16:07 INFO - PROCESS | 21222 | 11:19:09 INFO - PROCESS | 21222 | Cycle 1(1): loaded http://localhost:44583/tests/dromaeo/cssquery-ext.html (next: http://localhost:44583/tests/dromaeo/cssquery-jquery.html) 11:19:10 INFO - PROCESS | 21222 | RSS: Main: 200441856 11:19:10 INFO - PROCESS | 21222 | 11:22:12 INFO - PROCESS | 21222 | Cycle 1(1): loaded http://localhost:44583/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44583/tests/dromaeo/cssquery-mootools.html) 11:22:13 INFO - PROCESS | 21222 | RSS: Main: 197021696 11:22:13 INFO - PROCESS | 21222 | 11:25:14 INFO - PROCESS | 21222 | Cycle 1(1): loaded http://localhost:44583/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44583/tests/dromaeo/cssquery-prototype.html) 11:25:15 INFO - PROCESS | 21222 | RSS: Main: 193970176 11:25:15 INFO - PROCESS | 21222 | 11:28:17 INFO - PROCESS | 21222 | Cycle 1(1): loaded http://localhost:44583/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44583/tests/dromaeo/cssquery-yui.html) 11:28:18 INFO - PROCESS | 21222 | RSS: Main: 197648384 11:28:18 INFO - PROCESS | 21222 | 11:31:21 INFO - PROCESS | 21222 | Cycle 1(1): loaded http://localhost:44583/tests/dromaeo/cssquery-yui.html (next: http://localhost:44583/tests/dromaeo/cssquery-dojo.html) 11:31:21 INFO - PROCESS | 21222 | RSS: Main: 197890048 11:31:21 INFO - PROCESS | 21222 | 11:31:21 INFO - PROCESS | 21222 | __start_tp_report 11:31:21 INFO - PROCESS | 21222 | _x_x_mozilla_page_load 11:31:21 INFO - PROCESS | 21222 | _x_x_mozilla_page_load_details 11:31:21 INFO - PROCESS | 21222 | |i|pagename|runs| 11:31:21 INFO - PROCESS | 21222 | |0;dojo.html;2958.5414260789576;2959.9852000739993;2967.035713393148;3004.158835526052;3010.7591392688573;5200.765965531551;5325.094733895237;5333.2000199970025;5336.359636843584;5339.599530035248;5253.343332083489;5256.053910296145;5300.151975683892;5337.626366154371;5340.706261155635;4700.130475861968;4816.205326121203;4858.927116093261;4859;4947.653664243504;4911.263310503436;4938.407391113072;4942.308076869242;4945.7032578045255;4994.375703037121;4752.500987396308;4753.263244197155;4853.757312134397;4909.042736666352;4910.288008238803;4717.504662010508;4734.455537613184;4753.215719406294;4778.928316075262;4884.780184891689;4749.833755818529;4752.71483710975;4755.35802666639;4758.928616070727;4822.132016237111;5247.16045432729;5272.657277276965;5281.313429254211;5305.814296499604;5307.2835167252315;5664.858378540528;5671.602987790856;5680.233168522238;5681.602287839853;5731.054376027951;5638.4925356718095;5692.829215123553;5698.116791897262;5698.715064246771;5710.71446427677;5167.22491626259;5281.366236051622;5308.362996440452;5321.494458026481;5329.200619906967;5798.304203495608;5815.680137592389;5819.73811178498;5857.179994800731;5881.5882888198275;5577.135543990688;5582.106862901997;5584.888302233932;5588.832335029955;5592.049351610155;5509.724513774296;5557.416471270459;5574.9721251393485;5611.186377975252;5635.492805647511;5348.465153484621;5375.75809088592;5409.486098820606;5531.585131115183;5629.155626656035;5615.522680572116;5624.240727501735;5624.634398764068;5643.238162848045;5644.491995720405;4365.585269399402;4370.650347972155;4401.933970990438;4413.183561041217;4419.624331931822;3877.399003154459;3880.476135721698;3902.1220225449047;3918.314294998364;3965.2862484752445;5399.784008639689;5434.809781657623;5441.5102640762525;5449.891002180014;5481.424450432727;5707.258056452718;5710.71446427677;5718.228039214653;5719.685417302005;5721.199032135504;5320.308359913187;5376.704281264568;5432.674039557639;5432.945670543323;5509.146082357241;4835.274708793639;4838.612910967114;4839.153148199051;4887.315775791392;4922.92615610759;5914.940850591439;5923.348431672426;5924.963131452065;5931.851703707442;5941.970290148522;5579.330480342385;5643.689597072201;5686.033374326292;5700;5709.429057094258;5889.882202356014;5912.911306330495;5915.290165180206;5928.614640048383;5936.910946335722;5624.3250809903075;5630.23991761107;5632.042552765957;5633.324001119892;5633.915491267716;5563.054280772198;5618.410066942912;5650.802221922213;5657.12314591239;5665.065264231521;5553.888922221452;5555.8888822224135;5568.025595520687;5601.775928962796;5616.410276920865;5481.068218402801;5516.448355164452;5527.64070335443;5535.972320138535;5538.889222215614;5427.077396842626;5436.53789427903;5482.80810171642;5500.28496295479;5571.582131340085;5506.559475242051;5528.7235638218735;5561.777528898799;5569.610127291213;5569.6936668482;5432.918506222489;5447.101228297287;5448.291722076105;5453.182022696627;5507.531859791802 11:31:21 INFO - PROCESS | 21222 | |1;ext.html;551.8078343438748;585.9091840764681;593.9881202375952;598.5241732822406;600.8227572866004;37320.253594928115;41427;41439;41505.58494415055;41518;42353;43050;43081.35377969325;43113;43204.567954320446;8857.070007649201;8913.732588022369;8920.955395223014;9007.639694412215;9027.322950778718;8703.260222881063;8877.644894204224;8903.421277616933;8918.420302680304;8918.420302680337;8895.911040889605;8926.152015558511;8937.061608531109;8937.597808098619;8949.507777072258;8853;8904.866427003568;8932.598033088527;8938.0615035421;8944.284457243404;8831.249343805785;8841.867371989425;8901.599428025755;8903.688370907052;8906.198442140238;41429;41512.792436037926;41796;41877;41892.37161442581;3633.709303255733;3654.9269014619827;3833.731638785286;4120.361343991686;4134.37984302354;31267.84366078155;31843;32072.679273207435;32155.19612009695;32891.6710832891;4298.17738651395;4400.669949753749;4438.60052595268;4580.450345958473;4583.885402864922;332066;334240;334466;337157;337883;57197.428025720044;57688.42311576915;57723.71138144282;57751.71124144436;58008;35331;37019.4447083294;37261.44107838385;38956.61043389587;39152;15701.136437496047;15730.134842583539;15886.88791784564;15901;15949.521514354588;12634.684132896567;12786.041046921519;12802.80795788064;12805.295708736108;12811.743765124646;19064.33274835374;19073.237070517025;19138;19216.327428539935;19260.22959081621;6992.93007069933;7180.5691658500655;7231.45764067697;7248.710051597983;7462.888056679154;876.8640860666607;987.8796294459531;1011.944343061124;1018.3533456255332;1099.3184225779908;31966.840165799487;32002;32220.355592888012;32293.35413291721;32844.67155328416;1014.974625634365;1044.081208536483;1050.2595670052594;1074.3929679730927;1102.8530328458473;15269;16875.409360672562;16891.32434702598;16894.40869569559;17015;545639;547635;550302;552522;554886;57572.42427575754;58248.417515825146;58464;58525;58540;1313.5008696695386;1315.7105436803888;1338.5382043195277;1342.8455727591256;1367.0430698511082;29527.26181845471;30529.35284708358;31159;31414.685853141174;31542.211444714067;50181.74909125431;50506.24240636467;50617.49382506275;50670.23994640157;50822.745886270335;446734;446870;446924;447397;449835;28209.15372538827;28818;28820.711792881804;28897.85551072315;28921.421571568873;46003;46368.768156159;47452.52547474481;47984.28023579719;48453.5154648449;39896.401553977295;40658;40992.79503602463;41656.58343416648;42084.15831683288;40802.183956320114;41303.58696412997;41366.1726765469;41629.79185104055;42061.36907946444;40210.79894600508;40292.79853600713;40951.59048409597;41257.58742412538;43156;30416.695833041387;35744.28511429705;36797.26405471929;37032.62967370292;37581.06047348838;27705;27930.720692792813;28238.15285541437;28424.289392765346;28496.287592810346 11:31:21 INFO - PROCESS | 21222 | |2;jquery.html;399.94400783890245;400.7154920006795;402.9959700402995;408.42616124345295;421.73430738634653;19203;19617.411477655693;19888.502787430305;19992;20143;19006.334778282762;19337.613247735037;19445.41663750086;19595.314164004263;19638.509037274074;5541.695206763627;5585.525230355414;5725.828225153252;5760.654360738369;5770.971145144268;5717.199592057115;5752.942470575283;5800.593958422912;5822;5822.737976791033;5533.612647114704;5649.548036157118;5684.744186511596;5706.343770466408;5713.400092990239;5720.8855822883515;5737.713114344266;5767.971160144193;5776.624519406246;5960.523158147338;5529.419410961831;5624.0439125348785;5660.858478538028;5681.005823980787;5684.37471878093;13835.377408016664;13870.167789932637;13904.513342033082;13939.581812545639;14182;2280.293109136173;2414.1188466209883;2545.770880620753;2903.11455006223;2950.6754257031707;10059.547320370528;10162.898371016343;10412.84380734282;10412.843807342895;10740.462976851204;1895.8672892897503;1904.476269026015;1939.9515012124668;1963.6759934610916;1964.204497178645;74759;88393.99999999936;89490.55254723685;90220.54889725575;90584.54707726419;10717.732056698645;11149;11194.66416007521;11330.263532870336;11420.94289528547;15511.612209694847;15539.223038848013;15562.766558501631;15589;15611.843881561266;8091.474054186459;8266.793330166674;8422.831543369099;8532.061473237938;8573.22840944318;7966.721164759206;8055.065197074597;8112.432129750979;8183.754487365389;8280.130586288473;4635.953640463552;4650.534946505322;4650.837220697259;4837.201861692852;4891.486393928657;1963.1754663041272;1974.9802501975084;1982.3755517012096;1993.8205561499535;2024.0891598780609;865.2472349056361;969.9321047526605;982.9017098290257;1006.7382480555109;1029.5161274201114;18156.273749050153;19335.709964350546;19714.50713732168;19828.206871724968;19935.900320498597;831.2726364431123;914.7438717159206;937.8968313485511;980.8381617033252;1001.7846163074828;10189.54147063384;10874.565017399374;11001;11020.779584408267;11078.615173103362;343019;344789;346878;461828;465398;100013.49993249988;100706.4964675172;102522;104237;106719;1007.1590222164428;1015.5227043289642;1069.2782371898936;1069.550788668761;1074.6561100447939;17167.742483863003;17283.827758814652;17938;18007.549811254823;18162.091895404912;42918.35622465728;43259.35110973401;43296.13407731891;43849.123017538834;43893.34159987539;60089.958304723594;60491;60831;61512;62643.6867815658;7922.207779222032;8052.718154864551;8085.353171746364;8254.133316001973;8264.793380165544;11962.880371196177;12121;12168.878311216775;12422.813657794959;12725;10780.353178808982;10804.837927431252;10924.235303528676;10948.835767463654;11215.66353009411;10644.520996555018;10733.087687546646;10766.138708903112;10830.241883068109;10989.945050274697;10440;10532.26274160832;10708.464576771286;11182.161337899854;11344.546218151512;7878.921210787818;8010.158933312151;8086.555239461886;8151.470154439942;8329.625166867627;8925.776855578662;10337.793244135226;10466.215033872339;10810.35137891729;11210.66368008961 11:31:21 INFO - PROCESS | 21222 | |3;mootools.html;1456.497508359616;1470.6470447092697;1595.9281832317545;1741.9129043547828;1750.9737353939686;7570.697172113123;8114.797130071751;8142.674293028272;8788.91211087889;8816.294696424287;8229.094799572042;8514.872276915836;8551.102134275889;8578.270846978014;8630.95684521578;2373.8694371809543;2373.976260237401;2382.8927698253533;2385;2401.4956859059616;2354.5526349993534;2368.348704106376;2389.354874183969;2403.927882163538;2406.2179791567723;2382.7855493005627;2383.4994651123284;2399.8680072596;2412.9517409651885;2414.2033129067454;2324.476992676651;2338.871362075085;2348.823838212132;2351.600227961242;2378.393509655044;2329.6272596384665;2331.6502524621274;2332.346942856003;2338.941526461835;2345.5308938212424;8615.396922215448;8619.224269815684;8710.433821801562;8712.912870871274;8717.128287171296;5155.072087024334;5234.816781412632;5269.710165940872;5303.628745987782;5306.495882891119;3400.2009527760956;3433.4334834752235;3449.862005519776;3486.1110416843544;3500.8074555899416;1172.0857730969858;1187.4003628167807;1199.7840388730026;1208.5347141350555;1223.62067758995;11552.24910380831;11577.710557235969;11584.798888211297;11650.475728592233;11681.065514758799;4280.143971205771;4433.357163211381;4594.724316541018;4652.62778977681;4657.5575320344515;9847;9865.556049977768;9867.40795552269;9873.160781333523;9881.950590247146;5099.3370861787735;5106.617003724661;5112;5120.18077107661;5123.333966584395;4623.329617205486;4664.673472856935;4807.110684523374;4854.126257273725;4885.316055752198;3648.4527320901548;3731.981340093282;3733.962660373416;3752.399616061417;3759.6992240620684;1121.9270747401392;1141.2923987128033;1144.1418935798151;1146.7075895646556;1164.0861923390266;810.9189081091962;844.5903736687701;865.3293697384578;869.8561391769803;940.0223767282087;5568.693721845257;5657.915131273035;5759.8560035999435;5861.3552509223955;5921.881562368729;935.7941252924346;948.5446985446886;953.77109493721;965.3435663748578;977.8533220017055;3840.231953609289;3918.7648741075627;3940.271049855786;4005.7396269242404;4006.0786019215743;10188.388696678223;10615.681529554126;10638.734031649115;10640.148788096934;10641.627543035956;10532.631357902437;10563.260571759904;10592.311499752492;10597.25819192649;10599.576016959236;7671.2712292332135;7717.382609391348;7840.490368126054;7879.84240315202;8001.799955001172;5581.693006884498;5641.379448260606;5651.717414129359;5726.74229659658;5925.4370834770625;9469.053094690476;9502.097300756417;9509.286803489627;9619.951900240454;9657.613695452384;9547.188488978514;9626.422414655142;9744.805103897741;9754.561044752862;9773.511324433608;6552.27924928267;7074.3633073023675;7195.496315258091;7782.105057918412;8063.596820159086;8317.625706843328;8368.330533557422;8372.162783721578;8388.874166887379;8462.576871156294;7171;7371.262873712801;7451.2176221495965;7618.923810761821;7699.807504812425;7142.5714457132735;7282.308180722823;7282.854342913006;7300.780976570712;7499.100107987077;6770.966145169243;6783.830404239933;6792.049113124265;6806.455483561403;6834.350736680008;4907.877303067452;4967.379077615298;5065.8733531662;5100.336956195671;5197.246399272009;4970.353853998957;5036.974815125901;5126.154184559655;5169.844904652867;5212.817551385683 11:31:21 INFO - PROCESS | 21222 | |4;prototype.html;316.1937060495735;318.37598307317654;326.2740402604206;328.7550774672866;330.55375243421383;5314.787408503656;5414.3232095988005;5540.944590554093;5542.251796007537;5561.888762224753;5318.414974352818;5400;5420.4794770431745;5420.693377040012;5421.918671219935;4260.147970405916;4278;4281.422008028915;4289.034967132401;4309.116631090619;4250.553691862357;4255.914881702364;4300.741955482666;4317.395564620955;4342.630876375496;4264.275073237557;4270.7864606769535;4276.957230427703;4279.2725236709675;4301.311790113583;4265.168292183025;4303.826567583366;4311.116221174668;4313.899955511324;4316.359783282364;3663.9115704048704;3810.923781524382;3812.1422679897078;3813.694904407641;3815.9618403815884;5310.336207974004;5318.149096144598;5319.521243088141;5357.517823395913;5357.678539287655;4852.417709874802;4869.70781753096;4874.65877388583;4893.8776530586665;4918.8278410255825;5573.247611572427;5680.091185410356;5701.857453563653;5723.198752174699;5735.304406928779;4089.85685501009;4098.385242213662;4099.262132816092;4106.260873042851;4108.26051310764;5924.851878703067;5999.220101386835;6020.4280593343565;6024.969875150597;6026.578139530235;4090.570490098556;4255.87232383029;4260.914781704349;4266.381374700713;4293.506246781598;4252.893677658021;4275.679324050647;4282.357646353072;4284.378765079046;4316.8055638827045;4857.368542089505;4867.150482816578;4877.317175595419;4890.315355850113;4919.950800491949;5578.135389014628;5811.476967072984;5821.18503409523;5825.79609713658;5826.1552074948895;1439.6688761584894;1477.6305923519121;1486.8884833637303;1487.5834766265464;1491.127690301186;904.9186222464224;945.9452710228046;949.9857502137473;950.8589692369185;959.9136077753036;4719.362886010414;4904.337914381585;4915.606751459874;4921.5727439042275;4927.605791536668;5109.284700141983;5116.769745361467;5132.743362831843;5230.398504172069;5274.868128296824;4660.743659098782;4828.155072862305;4944.7638090477385;4951.653384263067;4979.0788704089855;2715.945681086367;2730.3993121513236;2737;2759.1998320487237;2779.791515636295;5308.389535203424;5317.867053323621;5342.706151161723;5345.839624811262;5366.8658283542445;5211.697075731067;5240.877444634929;5541.833744987657;6018.608790428608;6021.3677563856045;6154.846128846814;6157.353477884847;6157.599756015845;6160.661163635953;6171.9691401542705;5677.240055582783;5898.705064746831;5898.764049437975;5945.940540594539;5948.7394789979535;5873.177755114202;5917.556183286185;5917.822465326047;5919.556033297434;5929.792457263975;6205.348438413902;6213.720382582885;6220.937790622217;6226.221722284715;6246.969734836105;3968.603139686124;4102.405151253111;4110.86951088453;4114.259433302034;4224.471941007374;5881.911771323348;5920.8815823684145;5925.511285260287;5955.404459554184;5955.464008239106;5658.85852853682;5776.19133321327;5824.592278540631;5853.473187413153;5855.648661080349;5709.885802283848;5713.314402271754;5722.7395178904935;5749.770009199585;5755.942440575541;5791.276090488689;5791.901332787107;5809.709514524341;5826.155207494974;5827.1841942127285;5564.661203278;5749.195112684311;5794.565407594363;5802.216700745515;5857;5654.293213348332;5669.631473954345;5694.177863083773;5709.600327977168;5711.257536520226 11:31:21 INFO - PROCESS | 21222 | |5;yui.html;749.6813854112002;752.2627824731763;790.8615992201363;833.8207285433631;841.305922613843;15279.847201527982;16625.667486650258;16669.583260418494;16670.666586668274;16851.820372573926;15209.315580798862;15438.459653912116;15449.536513904573;15459.45891893784;15466.226688665578;647.6502688548202;781.9374450043982;795.7294519863245;808.5189312359166;808.9110197878229;816.2001238785994;816.2490508731951;817.0767033252416;817.2154731457778;817.6729308276678;856.575994882534;864.023653271802;868.6612221233723;868.7046404222563;870.4603146049427;851.05957916502;860.0023972192258;861.1775754154767;861.1990848510914;863.4344504349662;628.3057221769969;633.7781776378231;633.8668879535303;634.0742515926753;634.1882390540115;14760;14820.481283155146;14846.480373186887;14847.406103755837;14889.925550372178;15805;15838.920805396014;15862.762058569131;15864.286107125206;16056.43802466908;11183.49674264652;11275.718107047307;11308.836684007236;11595.01442377399;11980.28118312904;3900.8634697785724;3921.1765529238896;3923.4114882767526;4062.756234625932;4076.9592304077173;79824.60087699525;81027;81197;82086.58956705238;82632.58683706603;11886.643400697993;11923;11997.520099196108;12038.217515861616;12360.25838449696;23051.423714407272;23135.53728925412;23246.3026109217;23269;23445.648315275284;8335.916640833635;8468.195521425454;8667.826643467095;8828.42615230008;9007.324450666227;4751.667383283137;4826.103654491695;4871.391076115486;4917.409910810726;4954.677945933503;3344.364570731553;3463.930721385558;3470.5661792275964;3472.0104770140388;3479.913002174915;574.1445246582562;574.6925394913701;577.0737965565291;585.2421114656445;588.185363271863;604.9758009679564;693.4868197533789;708.4014008163094;751.102432593046;756.9091708994846;9245;9709.66016189444;9902.249066200435;10099.495025248709;10215.693529194135;643.7714611313011;707.6992278281709;711.4983936324878;725.5574099799119;758.7571976967317;4471;4750.709767395569;4876.268559716071;4887.655894629005;4893.804247830119;124464;125464;130482.47587620771;131264.343678281;138211;61758;88715;102304;104048.47975760073;105186;98575.50712246537;98636;99742.02321790929;100074.4996275014;100630;9188.081191880758;9445.338826282368;9584.66453674118;9598.376105553116;9616.326857119935;54589.72705136449;55275.17087243614;56003.71998140146;56600.7169964164;57134.85730285288;81072;83141;86851.1314886843;86860.56569717363;87217.56391218003;12724.74550508966;12725.681857953625;12839.679008024874;12975.156614820007;13175.14361566495;13081.215127092404;13195.934020329836;13343.266120363085;13441.663958401119;13574.117682350616;12210.511579536718;12338.136330456782;14916.179610121548;14953.850461495245;14962.625934351729;13295.779685264695;13463.528776492776;14109.788353174505;14508.492202772852;15607;11779.362445371435;13428.731425371634;13491.662708431975;13621.455141794217;13949.930250349089;11031.558737650725;11432.657020289405;11878.703032424259;11887.821682674594;12252.571160009356;10931.18016148776;12530.686732831753;12639.684007899876;12892.10754380516;13085.803712944504 11:31:21 INFO - PROCESS | 21222 | __end_tp_report 11:31:21 INFO - PROCESS | 21222 | __start_cc_report 11:31:21 INFO - PROCESS | 21222 | _x_x_mozilla_cycle_collect,325 11:31:21 INFO - PROCESS | 21222 | __end_cc_report 11:31:21 INFO - PROCESS | 21222 | __startTimestamp1472927481661__endTimestamp 11:31:21 INFO - PROCESS | 21222 | 11:31:21 INFO - PROCESS | 21222 | ------- Summary: start ------- 11:31:21 INFO - PROCESS | 21222 | Number of tests: 6 11:31:21 INFO - PROCESS | 21222 | 11:31:21 INFO - PROCESS | 21222 | [#0] dojo.html Cycles:165 Average:5268.66 Median:5481.07 stddev:602.92 (11.0%) stddev-sans-first:576.90 11:31:21 INFO - PROCESS | 21222 | Values: 2958.5 2960.0 2967.0 3004.2 3010.8 5200.8 5325.1 5333.2 5336.4 5339.6 5253.3 5256.1 5300.2 5337.6 5340.7 4700.1 4816.2 4858.9 4859.0 4947.7 4911.3 4938.4 4942.3 4945.7 4994.4 4752.5 4753.3 4853.8 4909.0 4910.3 4717.5 4734.5 4753.2 4778.9 4884.8 4749.8 4752.7 4755.4 4758.9 4822.1 5247.2 5272.7 5281.3 5305.8 5307.3 5664.9 5671.6 5680.2 5681.6 5731.1 5638.5 5692.8 5698.1 5698.7 5710.7 5167.2 5281.4 5308.4 5321.5 5329.2 5798.3 5815.7 5819.7 5857.2 5881.6 5577.1 5582.1 5584.9 5588.8 5592.0 5509.7 5557.4 5575.0 5611.2 5635.5 5348.5 5375.8 5409.5 5531.6 5629.2 5615.5 5624.2 5624.6 5643.2 5644.5 4365.6 4370.7 4401.9 4413.2 4419.6 3877.4 3880.5 3902.1 3918.3 3965.3 5399.8 5434.8 5441.5 5449.9 5481.4 5707.3 5710.7 5718.2 5719.7 5721.2 5320.3 5376.7 5432.7 5432.9 5509.1 4835.3 4838.6 4839.2 4887.3 4922.9 5914.9 5923.3 5925.0 5931.9 5942.0 5579.3 5643.7 5686.0 5700.0 5709.4 5889.9 5912.9 5915.3 5928.6 5936.9 5624.3 5630.2 5632.0 5633.3 5633.9 5563.1 5618.4 5650.8 5657.1 5665.1 5553.9 5555.9 5568.0 5601.8 5616.4 5481.1 5516.4 5527.6 5536.0 5538.9 5427.1 5436.5 5482.8 5500.3 5571.6 5506.6 5528.7 5561.8 5569.6 5569.7 5432.9 5447.1 5448.3 5453.2 5507.5 11:31:21 INFO - PROCESS | 21222 | 11:31:21 INFO - PROCESS | 21222 | [#1] ext.html Cycles:180 Average:59698.34 Median:41434.00 stddev:120263.06 (290.3%) stddev-sans-first:120518.44 11:31:21 INFO - PROCESS | 21222 | Values: 551.8 585.9 594.0 598.5 600.8 37320.3 41427.0 41439.0 41505.6 41518.0 42353.0 43050.0 43081.4 43113.0 43204.6 8857.1 8913.7 8921.0 9007.6 9027.3 8703.3 8877.6 8903.4 8918.4 8918.4 8895.9 8926.2 8937.1 8937.6 8949.5 8853.0 8904.9 8932.6 8938.1 8944.3 8831.2 8841.9 8901.6 8903.7 8906.2 41429.0 41512.8 41796.0 41877.0 41892.4 3633.7 3654.9 3833.7 4120.4 4134.4 31267.8 31843.0 32072.7 32155.2 32891.7 4298.2 4400.7 4438.6 4580.5 4583.9 332066.0 334240.0 334466.0 337157.0 337883.0 57197.4 57688.4 57723.7 57751.7 58008.0 35331.0 37019.4 37261.4 38956.6 39152.0 15701.1 15730.1 15886.9 15901.0 15949.5 12634.7 12786.0 12802.8 12805.3 12811.7 19064.3 19073.2 19138.0 19216.3 19260.2 6992.9 7180.6 7231.5 7248.7 7462.9 876.9 987.9 1011.9 1018.4 1099.3 31966.8 32002.0 32220.4 32293.4 32844.7 1015.0 1044.1 1050.3 1074.4 1102.9 15269.0 16875.4 16891.3 16894.4 17015.0 545639.0 547635.0 550302.0 552522.0 554886.0 57572.4 58248.4 58464.0 58525.0 58540.0 1313.5 1315.7 1338.5 1342.8 1367.0 29527.3 30529.4 31159.0 31414.7 31542.2 50181.7 50506.2 50617.5 50670.2 50822.7 446734.0 446870.0 446924.0 447397.0 449835.0 28209.2 28818.0 28820.7 28897.9 28921.4 46003.0 46368.8 47452.5 47984.3 48453.5 39896.4 40658.0 40992.8 41656.6 42084.2 40802.2 41303.6 41366.2 41629.8 42061.4 40210.8 40292.8 40951.6 41257.6 43156.0 30416.7 35744.3 36797.3 37032.6 37581.1 27705.0 27930.7 28238.2 28424.3 28496.3 11:31:21 INFO - PROCESS | 21222 | 11:31:21 INFO - PROCESS | 21222 | [#2] jquery.html Cycles:180 Average:26546.98 Median:11083.54 stddev:66656.37 (601.4%) stddev-sans-first:66814.44 11:31:21 INFO - PROCESS | 21222 | Values: 399.9 400.7 403.0 408.4 421.7 19203.0 19617.4 19888.5 19992.0 20143.0 19006.3 19337.6 19445.4 19595.3 19638.5 5541.7 5585.5 5725.8 5760.7 5771.0 5717.2 5752.9 5800.6 5822.0 5822.7 5533.6 5649.5 5684.7 5706.3 5713.4 5720.9 5737.7 5768.0 5776.6 5960.5 5529.4 5624.0 5660.9 5681.0 5684.4 13835.4 13870.2 13904.5 13939.6 14182.0 2280.3 2414.1 2545.8 2903.1 2950.7 10059.5 10162.9 10412.8 10412.8 10740.5 1895.9 1904.5 1940.0 1963.7 1964.2 74759.0 88394.0 89490.6 90220.5 90584.5 10717.7 11149.0 11194.7 11330.3 11420.9 15511.6 15539.2 15562.8 15589.0 15611.8 8091.5 8266.8 8422.8 8532.1 8573.2 7966.7 8055.1 8112.4 8183.8 8280.1 4636.0 4650.5 4650.8 4837.2 4891.5 1963.2 1975.0 1982.4 1993.8 2024.1 865.2 969.9 982.9 1006.7 1029.5 18156.3 19335.7 19714.5 19828.2 19935.9 831.3 914.7 937.9 980.8 1001.8 10189.5 10874.6 11001.0 11020.8 11078.6 343019.0 344789.0 346878.0 461828.0 465398.0 100013.5 100706.5 102522.0 104237.0 106719.0 1007.2 1015.5 1069.3 1069.6 1074.7 17167.7 17283.8 17938.0 18007.5 18162.1 42918.4 43259.4 43296.1 43849.1 43893.3 60090.0 60491.0 60831.0 61512.0 62643.7 7922.2 8052.7 8085.4 8254.1 8264.8 11962.9 12121.0 12168.9 12422.8 12725.0 10780.4 10804.8 10924.2 10948.8 11215.7 10644.5 10733.1 10766.1 10830.2 10989.9 10440.0 10532.3 10708.5 11182.2 11344.5 7878.9 8010.2 8086.6 8151.5 8329.6 8925.8 10337.8 10466.2 10810.4 11210.7 11:31:21 INFO - PROCESS | 21222 | 11:31:21 INFO - PROCESS | 21222 | [#3] mootools.html Cycles:180 Average:5622.44 Median:5124.74 stddev:3127.60 (61.0%) stddev-sans-first:3120.70 11:31:21 INFO - PROCESS | 21222 | Values: 1456.5 1470.6 1595.9 1741.9 1751.0 7570.7 8114.8 8142.7 8788.9 8816.3 8229.1 8514.9 8551.1 8578.3 8631.0 2373.9 2374.0 2382.9 2385.0 2401.5 2354.6 2368.3 2389.4 2403.9 2406.2 2382.8 2383.5 2399.9 2413.0 2414.2 2324.5 2338.9 2348.8 2351.6 2378.4 2329.6 2331.7 2332.3 2338.9 2345.5 8615.4 8619.2 8710.4 8712.9 8717.1 5155.1 5234.8 5269.7 5303.6 5306.5 3400.2 3433.4 3449.9 3486.1 3500.8 1172.1 1187.4 1199.8 1208.5 1223.6 11552.2 11577.7 11584.8 11650.5 11681.1 4280.1 4433.4 4594.7 4652.6 4657.6 9847.0 9865.6 9867.4 9873.2 9882.0 5099.3 5106.6 5112.0 5120.2 5123.3 4623.3 4664.7 4807.1 4854.1 4885.3 3648.5 3732.0 3734.0 3752.4 3759.7 1121.9 1141.3 1144.1 1146.7 1164.1 810.9 844.6 865.3 869.9 940.0 5568.7 5657.9 5759.9 5861.4 5921.9 935.8 948.5 953.8 965.3 977.9 3840.2 3918.8 3940.3 4005.7 4006.1 10188.4 10615.7 10638.7 10640.1 10641.6 10532.6 10563.3 10592.3 10597.3 10599.6 7671.3 7717.4 7840.5 7879.8 8001.8 5581.7 5641.4 5651.7 5726.7 5925.4 9469.1 9502.1 9509.3 9620.0 9657.6 9547.2 9626.4 9744.8 9754.6 9773.5 6552.3 7074.4 7195.5 7782.1 8063.6 8317.6 8368.3 8372.2 8388.9 8462.6 7171.0 7371.3 7451.2 7618.9 7699.8 7142.6 7282.3 7282.9 7300.8 7499.1 6771.0 6783.8 6792.0 6806.5 6834.4 4907.9 4967.4 5065.9 5100.3 5197.2 4970.4 5037.0 5126.2 5169.8 5212.8 11:31:21 INFO - PROCESS | 21222 | 11:31:21 INFO - PROCESS | 21222 | [#4] prototype.html Cycles:180 Average:4758.58 Median:5318.01 stddev:1412.78 (26.6%) stddev-sans-first:1376.84 11:31:21 INFO - PROCESS | 21222 | Values: 316.2 318.4 326.3 328.8 330.6 5314.8 5414.3 5540.9 5542.3 5561.9 5318.4 5400.0 5420.5 5420.7 5421.9 4260.1 4278.0 4281.4 4289.0 4309.1 4250.6 4255.9 4300.7 4317.4 4342.6 4264.3 4270.8 4277.0 4279.3 4301.3 4265.2 4303.8 4311.1 4313.9 4316.4 3663.9 3810.9 3812.1 3813.7 3816.0 5310.3 5318.1 5319.5 5357.5 5357.7 4852.4 4869.7 4874.7 4893.9 4918.8 5573.2 5680.1 5701.9 5723.2 5735.3 4089.9 4098.4 4099.3 4106.3 4108.3 5924.9 5999.2 6020.4 6025.0 6026.6 4090.6 4255.9 4260.9 4266.4 4293.5 4252.9 4275.7 4282.4 4284.4 4316.8 4857.4 4867.2 4877.3 4890.3 4920.0 5578.1 5811.5 5821.2 5825.8 5826.2 1439.7 1477.6 1486.9 1487.6 1491.1 904.9 945.9 950.0 950.9 959.9 4719.4 4904.3 4915.6 4921.6 4927.6 5109.3 5116.8 5132.7 5230.4 5274.9 4660.7 4828.2 4944.8 4951.7 4979.1 2715.9 2730.4 2737.0 2759.2 2779.8 5308.4 5317.9 5342.7 5345.8 5366.9 5211.7 5240.9 5541.8 6018.6 6021.4 6154.8 6157.4 6157.6 6160.7 6172.0 5677.2 5898.7 5898.8 5945.9 5948.7 5873.2 5917.6 5917.8 5919.6 5929.8 6205.3 6213.7 6220.9 6226.2 6247.0 3968.6 4102.4 4110.9 4114.3 4224.5 5881.9 5920.9 5925.5 5955.4 5955.5 5658.9 5776.2 5824.6 5853.5 5855.6 5709.9 5713.3 5722.7 5749.8 5755.9 5791.3 5791.9 5809.7 5826.2 5827.2 5564.7 5749.2 5794.6 5802.2 5857.0 5654.3 5669.6 5694.2 5709.6 5711.3 11:31:21 INFO - PROCESS | 21222 | 11:31:21 INFO - PROCESS | 21222 | [#5] yui.html Cycles:180 Average:22136.84 Median:4069.86 stddev:32717.15 (803.9%) stddev-sans-first:32769.51 11:31:21 INFO - PROCESS | 21222 | Values: 749.7 752.3 790.9 833.8 841.3 15279.8 16625.7 16669.6 16670.7 16851.8 15209.3 15438.5 15449.5 15459.5 15466.2 647.7 781.9 795.7 808.5 808.9 816.2 816.2 817.1 817.2 817.7 856.6 864.0 868.7 868.7 870.5 851.1 860.0 861.2 861.2 863.4 628.3 633.8 633.9 634.1 634.2 14760.0 14820.5 14846.5 14847.4 14889.9 15805.0 15838.9 15862.8 15864.3 16056.4 11183.5 11275.7 11308.8 11595.0 11980.3 3900.9 3921.2 3923.4 4062.8 4077.0 79824.6 81027.0 81197.0 82086.6 82632.6 11886.6 11923.0 11997.5 12038.2 12360.3 23051.4 23135.5 23246.3 23269.0 23445.6 8335.9 8468.2 8667.8 8828.4 9007.3 4751.7 4826.1 4871.4 4917.4 4954.7 3344.4 3463.9 3470.6 3472.0 3479.9 574.1 574.7 577.1 585.2 588.2 605.0 693.5 708.4 751.1 756.9 9245.0 9709.7 9902.2 10099.5 10215.7 643.8 707.7 711.5 725.6 758.8 4471.0 4750.7 4876.3 4887.7 4893.8 124464.0 125464.0 130482.5 131264.3 138211.0 61758.0 88715.0 102304.0 104048.5 105186.0 98575.5 98636.0 99742.0 100074.5 100630.0 9188.1 9445.3 9584.7 9598.4 9616.3 54589.7 55275.2 56003.7 56600.7 57134.9 81072.0 83141.0 86851.1 86860.6 87217.6 12724.7 12725.7 12839.7 12975.2 13175.1 13081.2 13195.9 13343.3 13441.7 13574.1 12210.5 12338.1 14916.2 14953.9 14962.6 13295.8 13463.5 14109.8 14508.5 15607.0 11779.4 13428.7 13491.7 13621.5 13949.9 11031.6 11432.7 11878.7 11887.8 12252.6 10931.2 12530.7 12639.7 12892.1 13085.8 11:31:21 INFO - PROCESS | 21222 | -------- Summary: end -------- 11:31:21 INFO - PROCESS | 21222 | 11:31:22 INFO - TEST-INFO | 21222: exit 0 11:31:22 INFO - TEST-OK | dromaeo_css | took 1114323ms 11:31:22 INFO - TEST-START | kraken 11:31:22 INFO - operating with platform_type : linux_ 11:31:22 INFO - Initialising browser for kraken test... 11:31:22 INFO - TEST-INFO | started process 21583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP5kayN/profile http://localhost:44583/getInfo.html) 11:31:27 INFO - PROCESS | 21583 | __metrics Screen width/height:1600/1200 11:31:27 INFO - PROCESS | 21583 | colorDepth:24 11:31:27 INFO - PROCESS | 21583 | Browser inner width/height: 1024/697 11:31:27 INFO - PROCESS | 21583 | __metrics 11:31:28 ERROR - PROCESS | 21583 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 11:31:29 INFO - TEST-INFO | 21583: exit 0 11:31:29 INFO - Browser initialized. 11:31:29 INFO - Running cycle 1/1 for kraken test... 11:31:29 INFO - TEST-INFO | started process 21704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP5kayN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:41 INFO - PROCESS | 21704 | RSS: Main: 191574016 11:31:41 INFO - PROCESS | 21704 | 11:31:44 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44583/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:45 INFO - PROCESS | 21704 | RSS: Main: 204812288 11:31:45 INFO - PROCESS | 21704 | 11:31:48 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44583/tests/kraken/driver.html?testName=audio-dft) 11:31:48 INFO - PROCESS | 21704 | RSS: Main: 203984896 11:31:48 INFO - PROCESS | 21704 | 11:31:51 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44583/tests/kraken/driver.html?testName=audio-fft) 11:31:52 INFO - PROCESS | 21704 | RSS: Main: 195100672 11:31:52 INFO - PROCESS | 21704 | 11:31:54 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44583/tests/kraken/driver.html?testName=audio-oscillator) 11:31:54 INFO - PROCESS | 21704 | RSS: Main: 195772416 11:31:54 INFO - PROCESS | 21704 | 11:31:57 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44583/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:31:57 INFO - PROCESS | 21704 | RSS: Main: 195760128 11:31:57 INFO - PROCESS | 21704 | 11:32:00 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44583/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:01 INFO - PROCESS | 21704 | RSS: Main: 195923968 11:32:01 INFO - PROCESS | 21704 | 11:32:04 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44583/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:05 INFO - PROCESS | 21704 | RSS: Main: 192593920 11:32:05 INFO - PROCESS | 21704 | 11:32:08 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44583/tests/kraken/driver.html?testName=json-parse-financial) 11:32:09 INFO - PROCESS | 21704 | RSS: Main: 193957888 11:32:09 INFO - PROCESS | 21704 | 11:32:10 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44583/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:11 INFO - PROCESS | 21704 | RSS: Main: 194519040 11:32:11 INFO - PROCESS | 21704 | 11:32:13 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:13 INFO - PROCESS | 21704 | RSS: Main: 194535424 11:32:13 INFO - PROCESS | 21704 | 11:32:15 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:16 INFO - PROCESS | 21704 | RSS: Main: 195485696 11:32:16 INFO - PROCESS | 21704 | 11:32:19 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:19 INFO - PROCESS | 21704 | RSS: Main: 194732032 11:32:19 INFO - PROCESS | 21704 | 11:32:22 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:23 INFO - PROCESS | 21704 | RSS: Main: 195137536 11:32:23 INFO - PROCESS | 21704 | 11:32:24 INFO - PROCESS | 21704 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44583/tests/kraken/driver.html?testName=ai-astar) 11:32:25 INFO - PROCESS | 21704 | RSS: Main: 197115904 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | __start_tp_report 11:32:25 INFO - PROCESS | 21704 | _x_x_mozilla_page_load 11:32:25 INFO - PROCESS | 21704 | _x_x_mozilla_page_load_details 11:32:25 INFO - PROCESS | 21704 | |i|pagename|runs| 11:32:25 INFO - PROCESS | 21704 | |0;ai-astar;108;117;116;117;115;114;112;112;112;132 11:32:25 INFO - PROCESS | 21704 | |1;audio-beat-detection;151;120;146;181;123;151;156;120;180;120 11:32:25 INFO - PROCESS | 21704 | |2;audio-dft;163;162;165;172;167;166;163;163;164;162 11:32:25 INFO - PROCESS | 21704 | |3;audio-fft;75;75;75;179;76;76;75;76;189;76 11:32:25 INFO - PROCESS | 21704 | |4;audio-oscillator;82;83;143;83;83;83;145;81;83;150 11:32:25 INFO - PROCESS | 21704 | |5;imaging-gaussian-blur;117;117;118;118;118;118;118;117;118;118 11:32:25 INFO - PROCESS | 21704 | |6;imaging-darkroom;149;152;149;149;148;148;148;147;148;149 11:32:25 INFO - PROCESS | 21704 | |7;imaging-desaturate;97;95;95;95;96;96;98;96;96;96 11:32:25 INFO - PROCESS | 21704 | |8;json-parse-financial;53;53;55;52;54;53;64;58;54;52 11:32:25 INFO - PROCESS | 21704 | |9;json-stringify-tinderbox;62;62;62;63;64;62;64;62;66;63 11:32:25 INFO - PROCESS | 21704 | |10;stanford-crypto-aes;79;79;79;81;80;79;80;85;82;80 11:32:25 INFO - PROCESS | 21704 | |11;stanford-crypto-ccm;133;144;131;142;137;126;127;126;158;128 11:32:25 INFO - PROCESS | 21704 | |12;stanford-crypto-pbkdf2;163;167;167;168;164;168;167;165;166;170 11:32:25 INFO - PROCESS | 21704 | |13;stanford-crypto-sha256-iterative;66;67;69;66;68;65;65;66;64;69 11:32:25 INFO - PROCESS | 21704 | __end_tp_report 11:32:25 INFO - PROCESS | 21704 | __start_cc_report 11:32:25 INFO - PROCESS | 21704 | _x_x_mozilla_cycle_collect,818 11:32:25 INFO - PROCESS | 21704 | __end_cc_report 11:32:25 INFO - PROCESS | 21704 | __startTimestamp1472927545237__endTimestamp 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | ------- Summary: start ------- 11:32:25 INFO - PROCESS | 21704 | Number of tests: 14 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.50 stddev:6.43 (5.6%) stddev-sans-first:6.22 11:32:25 INFO - PROCESS | 21704 | Values: 108.0 117.0 116.0 117.0 115.0 114.0 112.0 112.0 112.0 132.0 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:151.00 stddev:23.74 (15.7%) stddev-sans-first:25.08 11:32:25 INFO - PROCESS | 21704 | Values: 151.0 120.0 146.0 181.0 123.0 151.0 156.0 120.0 180.0 120.0 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:3.06 (1.9%) stddev-sans-first:3.18 11:32:25 INFO - PROCESS | 21704 | Values: 163.0 162.0 165.0 172.0 167.0 166.0 163.0 163.0 164.0 162.0 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#3] audio-fft Cycles:10 Average:97.20 Median:75.50 stddev:45.81 (60.7%) stddev-sans-first:47.88 11:32:25 INFO - PROCESS | 21704 | Values: 75.0 75.0 75.0 179.0 76.0 76.0 75.0 76.0 189.0 76.0 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:83.00 stddev:30.69 (37.0%) stddev-sans-first:31.72 11:32:25 INFO - PROCESS | 21704 | Values: 82.0 83.0 143.0 83.0 83.0 83.0 145.0 81.0 83.0 150.0 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 11:32:25 INFO - PROCESS | 21704 | Values: 117.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.34 (0.9%) stddev-sans-first:1.41 11:32:25 INFO - PROCESS | 21704 | Values: 149.0 152.0 149.0 149.0 148.0 148.0 148.0 147.0 148.0 149.0 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.94 (1.0%) stddev-sans-first:0.93 11:32:25 INFO - PROCESS | 21704 | Values: 97.0 95.0 95.0 95.0 96.0 96.0 98.0 96.0 96.0 96.0 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:3.68 (6.8%) stddev-sans-first:3.84 11:32:25 INFO - PROCESS | 21704 | Values: 53.0 53.0 55.0 52.0 54.0 53.0 64.0 58.0 54.0 52.0 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:1.33 (2.1%) stddev-sans-first:1.36 11:32:25 INFO - PROCESS | 21704 | Values: 62.0 62.0 62.0 63.0 64.0 62.0 64.0 62.0 66.0 63.0 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:1.90 (2.4%) stddev-sans-first:1.94 11:32:25 INFO - PROCESS | 21704 | Values: 79.0 79.0 79.0 81.0 80.0 79.0 80.0 85.0 82.0 80.0 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:135.00 stddev:10.32 (7.6%) stddev-sans-first:10.91 11:32:25 INFO - PROCESS | 21704 | Values: 133.0 144.0 131.0 142.0 137.0 126.0 127.0 126.0 158.0 128.0 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:167.00 stddev:2.07 (1.2%) stddev-sans-first:1.76 11:32:25 INFO - PROCESS | 21704 | Values: 163.0 167.0 167.0 168.0 164.0 168.0 167.0 165.0 166.0 170.0 11:32:25 INFO - PROCESS | 21704 | 11:32:25 INFO - PROCESS | 21704 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:1.72 (2.6%) stddev-sans-first:1.81 11:32:25 INFO - PROCESS | 21704 | Values: 66.0 67.0 69.0 66.0 68.0 65.0 65.0 66.0 64.0 69.0 11:32:25 INFO - PROCESS | 21704 | -------- Summary: end -------- 11:32:25 INFO - PROCESS | 21704 | 11:32:26 INFO - TEST-INFO | 21704: exit 0 11:32:26 INFO - TEST-OK | kraken | took 63855ms 11:32:26 INFO - SUITE-END | took 1178s 11:32:26 INFO - Completed test suite (00:19:38) 11:32:26 INFO - javascript benchmark 11:32:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7216.025650261133, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2958.5414260789576, 2959.9852000739993, 2967.035713393148, 3004.158835526052, 3010.7591392688573, 5200.765965531551, 5325.094733895237, 5333.2000199970025, 5336.359636843584, 5339.599530035248, 5253.343332083489, 5256.053910296145, 5300.151975683892, 5337.626366154371, 5340.706261155635, 4700.130475861968, 4816.205326121203, 4858.927116093261, 4859.0, 4947.653664243504, 4911.263310503436, 4938.407391113072, 4942.308076869242, 4945.7032578045255, 4994.375703037121, 4752.500987396308, 4753.263244197155, 4853.757312134397, 4909.042736666352, 4910.288008238803, 4717.504662010508, 4734.455537613184, 4753.215719406294, 4778.928316075262, 4884.780184891689, 4749.833755818529, 4752.71483710975, 4755.35802666639, 4758.928616070727, 4822.132016237111, 5247.16045432729, 5272.657277276965, 5281.313429254211, 5305.814296499604, 5307.2835167252315, 5664.858378540528, 5671.602987790856, 5680.233168522238, 5681.602287839853, 5731.054376027951, 5638.4925356718095, 5692.829215123553, 5698.116791897262, 5698.715064246771, 5710.71446427677, 5167.22491626259, 5281.366236051622, 5308.362996440452, 5321.494458026481, 5329.200619906967, 5798.304203495608, 5815.680137592389, 5819.73811178498, 5857.179994800731, 5881.5882888198275, 5577.135543990688, 5582.106862901997, 5584.888302233932, 5588.832335029955, 5592.049351610155, 5509.724513774296, 5557.416471270459, 5574.9721251393485, 5611.186377975252, 5635.492805647511, 5348.465153484621, 5375.75809088592, 5409.486098820606, 5531.585131115183, 5629.155626656035, 5615.522680572116, 5624.240727501735, 5624.634398764068, 5643.238162848045, 5644.491995720405, 4365.585269399402, 4370.650347972155, 4401.933970990438, 4413.183561041217, 4419.624331931822, 3877.399003154459, 3880.476135721698, 3902.1220225449047, 3918.314294998364, 3965.2862484752445, 5399.784008639689, 5434.809781657623, 5441.5102640762525, 5449.891002180014, 5481.424450432727, 5707.258056452718, 5710.71446427677, 5718.228039214653, 5719.685417302005, 5721.199032135504, 5320.308359913187, 5376.704281264568, 5432.674039557639, 5432.945670543323, 5509.146082357241, 4835.274708793639, 4838.612910967114, 4839.153148199051, 4887.315775791392, 4922.92615610759, 5914.940850591439, 5923.348431672426, 5924.963131452065, 5931.851703707442, 5941.970290148522, 5579.330480342385, 5643.689597072201, 5686.033374326292, 5700.0, 5709.429057094258, 5889.882202356014, 5912.911306330495, 5915.290165180206, 5928.614640048383, 5936.910946335722, 5624.3250809903075, 5630.23991761107, 5632.042552765957, 5633.324001119892, 5633.915491267716, 5563.054280772198, 5618.410066942912, 5650.802221922213, 5657.12314591239, 5665.065264231521, 5553.888922221452, 5555.8888822224135, 5568.025595520687, 5601.775928962796, 5616.410276920865, 5481.068218402801, 5516.448355164452, 5527.64070335443, 5535.972320138535, 5538.889222215614, 5427.077396842626, 5436.53789427903, 5482.80810171642, 5500.28496295479, 5571.582131340085, 5506.559475242051, 5528.7235638218735, 5561.777528898799, 5569.610127291213, 5569.6936668482, 5432.918506222489, 5447.101228297287, 5448.291722076105, 5453.182022696627, 5507.531859791802], "value": 5226.983815010521, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.8078343438748, 585.9091840764681, 593.9881202375952, 598.5241732822406, 600.8227572866004, 37320.253594928115, 41427.0, 41439.0, 41505.58494415055, 41518.0, 42353.0, 43050.0, 43081.35377969325, 43113.0, 43204.567954320446, 8857.070007649201, 8913.732588022369, 8920.955395223014, 9007.639694412215, 9027.322950778718, 8703.260222881063, 8877.644894204224, 8903.421277616933, 8918.420302680304, 8918.420302680337, 8895.911040889605, 8926.152015558511, 8937.061608531109, 8937.597808098619, 8949.507777072258, 8853.0, 8904.866427003568, 8932.598033088527, 8938.0615035421, 8944.284457243404, 8831.249343805785, 8841.867371989425, 8901.599428025755, 8903.688370907052, 8906.198442140238, 41429.0, 41512.792436037926, 41796.0, 41877.0, 41892.37161442581, 3633.709303255733, 3654.9269014619827, 3833.731638785286, 4120.361343991686, 4134.37984302354, 31267.84366078155, 31843.0, 32072.679273207435, 32155.19612009695, 32891.6710832891, 4298.17738651395, 4400.669949753749, 4438.60052595268, 4580.450345958473, 4583.885402864922, 332066.0, 334240.0, 334466.0, 337157.0, 337883.0, 57197.428025720044, 57688.42311576915, 57723.71138144282, 57751.71124144436, 58008.0, 35331.0, 37019.4447083294, 37261.44107838385, 38956.61043389587, 39152.0, 15701.136437496047, 15730.134842583539, 15886.88791784564, 15901.0, 15949.521514354588, 12634.684132896567, 12786.041046921519, 12802.80795788064, 12805.295708736108, 12811.743765124646, 19064.33274835374, 19073.237070517025, 19138.0, 19216.327428539935, 19260.22959081621, 6992.93007069933, 7180.5691658500655, 7231.45764067697, 7248.710051597983, 7462.888056679154, 876.8640860666607, 987.8796294459531, 1011.944343061124, 1018.3533456255332, 1099.3184225779908, 31966.840165799487, 32002.0, 32220.355592888012, 32293.35413291721, 32844.67155328416, 1014.974625634365, 1044.081208536483, 1050.2595670052594, 1074.3929679730927, 1102.8530328458473, 15269.0, 16875.409360672562, 16891.32434702598, 16894.40869569559, 17015.0, 545639.0, 547635.0, 550302.0, 552522.0, 554886.0, 57572.42427575754, 58248.417515825146, 58464.0, 58525.0, 58540.0, 1313.5008696695386, 1315.7105436803888, 1338.5382043195277, 1342.8455727591256, 1367.0430698511082, 29527.26181845471, 30529.35284708358, 31159.0, 31414.685853141174, 31542.211444714067, 50181.74909125431, 50506.24240636467, 50617.49382506275, 50670.23994640157, 50822.745886270335, 446734.0, 446870.0, 446924.0, 447397.0, 449835.0, 28209.15372538827, 28818.0, 28820.711792881804, 28897.85551072315, 28921.421571568873, 46003.0, 46368.768156159, 47452.52547474481, 47984.28023579719, 48453.5154648449, 39896.401553977295, 40658.0, 40992.79503602463, 41656.58343416648, 42084.15831683288, 40802.183956320114, 41303.58696412997, 41366.1726765469, 41629.79185104055, 42061.36907946444, 40210.79894600508, 40292.79853600713, 40951.59048409597, 41257.58742412538, 43156.0, 30416.695833041387, 35744.28511429705, 36797.26405471929, 37032.62967370292, 37581.06047348838, 27705.0, 27930.720692792813, 28238.15285541437, 28424.289392765346, 28496.287592810346], "value": 19745.9679543136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.94400783890245, 400.7154920006795, 402.9959700402995, 408.42616124345295, 421.73430738634653, 19203.0, 19617.411477655693, 19888.502787430305, 19992.0, 20143.0, 19006.334778282762, 19337.613247735037, 19445.41663750086, 19595.314164004263, 19638.509037274074, 5541.695206763627, 5585.525230355414, 5725.828225153252, 5760.654360738369, 5770.971145144268, 5717.199592057115, 5752.942470575283, 5800.593958422912, 5822.0, 5822.737976791033, 5533.612647114704, 5649.548036157118, 5684.744186511596, 5706.343770466408, 5713.400092990239, 5720.8855822883515, 5737.713114344266, 5767.971160144193, 5776.624519406246, 5960.523158147338, 5529.419410961831, 5624.0439125348785, 5660.858478538028, 5681.005823980787, 5684.37471878093, 13835.377408016664, 13870.167789932637, 13904.513342033082, 13939.581812545639, 14182.0, 2280.293109136173, 2414.1188466209883, 2545.770880620753, 2903.11455006223, 2950.6754257031707, 10059.547320370528, 10162.898371016343, 10412.84380734282, 10412.843807342895, 10740.462976851204, 1895.8672892897503, 1904.476269026015, 1939.9515012124668, 1963.6759934610916, 1964.204497178645, 74759.0, 88393.99999999936, 89490.55254723685, 90220.54889725575, 90584.54707726419, 10717.732056698645, 11149.0, 11194.66416007521, 11330.263532870336, 11420.94289528547, 15511.612209694847, 15539.223038848013, 15562.766558501631, 15589.0, 15611.843881561266, 8091.474054186459, 8266.793330166674, 8422.831543369099, 8532.061473237938, 8573.22840944318, 7966.721164759206, 8055.065197074597, 8112.432129750979, 8183.754487365389, 8280.130586288473, 4635.953640463552, 4650.534946505322, 4650.837220697259, 4837.201861692852, 4891.486393928657, 1963.1754663041272, 1974.9802501975084, 1982.3755517012096, 1993.8205561499535, 2024.0891598780609, 865.2472349056361, 969.9321047526605, 982.9017098290257, 1006.7382480555109, 1029.5161274201114, 18156.273749050153, 19335.709964350546, 19714.50713732168, 19828.206871724968, 19935.900320498597, 831.2726364431123, 914.7438717159206, 937.8968313485511, 980.8381617033252, 1001.7846163074828, 10189.54147063384, 10874.565017399374, 11001.0, 11020.779584408267, 11078.615173103362, 343019.0, 344789.0, 346878.0, 461828.0, 465398.0, 100013.49993249988, 100706.4964675172, 102522.0, 104237.0, 106719.0, 1007.1590222164428, 1015.5227043289642, 1069.2782371898936, 1069.550788668761, 1074.6561100447939, 17167.742483863003, 17283.827758814652, 17938.0, 18007.549811254823, 18162.091895404912, 42918.35622465728, 43259.35110973401, 43296.13407731891, 43849.123017538834, 43893.34159987539, 60089.958304723594, 60491.0, 60831.0, 61512.0, 62643.6867815658, 7922.207779222032, 8052.718154864551, 8085.353171746364, 8254.133316001973, 8264.793380165544, 11962.880371196177, 12121.0, 12168.878311216775, 12422.813657794959, 12725.0, 10780.353178808982, 10804.837927431252, 10924.235303528676, 10948.835767463654, 11215.66353009411, 10644.520996555018, 10733.087687546646, 10766.138708903112, 10830.241883068109, 10989.945050274697, 10440.0, 10532.26274160832, 10708.464576771286, 11182.161337899854, 11344.546218151512, 7878.921210787818, 8010.158933312151, 8086.555239461886, 8151.470154439942, 8329.625166867627, 8925.776855578662, 10337.793244135226, 10466.215033872339, 10810.35137891729, 11210.66368008961], "value": 9046.307167999283, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.497508359616, 1470.6470447092697, 1595.9281832317545, 1741.9129043547828, 1750.9737353939686, 7570.697172113123, 8114.797130071751, 8142.674293028272, 8788.91211087889, 8816.294696424287, 8229.094799572042, 8514.872276915836, 8551.102134275889, 8578.270846978014, 8630.95684521578, 2373.8694371809543, 2373.976260237401, 2382.8927698253533, 2385.0, 2401.4956859059616, 2354.5526349993534, 2368.348704106376, 2389.354874183969, 2403.927882163538, 2406.2179791567723, 2382.7855493005627, 2383.4994651123284, 2399.8680072596, 2412.9517409651885, 2414.2033129067454, 2324.476992676651, 2338.871362075085, 2348.823838212132, 2351.600227961242, 2378.393509655044, 2329.6272596384665, 2331.6502524621274, 2332.346942856003, 2338.941526461835, 2345.5308938212424, 8615.396922215448, 8619.224269815684, 8710.433821801562, 8712.912870871274, 8717.128287171296, 5155.072087024334, 5234.816781412632, 5269.710165940872, 5303.628745987782, 5306.495882891119, 3400.2009527760956, 3433.4334834752235, 3449.862005519776, 3486.1110416843544, 3500.8074555899416, 1172.0857730969858, 1187.4003628167807, 1199.7840388730026, 1208.5347141350555, 1223.62067758995, 11552.24910380831, 11577.710557235969, 11584.798888211297, 11650.475728592233, 11681.065514758799, 4280.143971205771, 4433.357163211381, 4594.724316541018, 4652.62778977681, 4657.5575320344515, 9847.0, 9865.556049977768, 9867.40795552269, 9873.160781333523, 9881.950590247146, 5099.3370861787735, 5106.617003724661, 5112.0, 5120.18077107661, 5123.333966584395, 4623.329617205486, 4664.673472856935, 4807.110684523374, 4854.126257273725, 4885.316055752198, 3648.4527320901548, 3731.981340093282, 3733.962660373416, 3752.399616061417, 3759.6992240620684, 1121.9270747401392, 1141.2923987128033, 1144.1418935798151, 1146.7075895646556, 1164.0861923390266, 810.9189081091962, 844.5903736687701, 865.3293697384578, 869.8561391769803, 940.0223767282087, 5568.693721845257, 5657.915131273035, 5759.8560035999435, 5861.3552509223955, 5921.881562368729, 935.7941252924346, 948.5446985446886, 953.77109493721, 965.3435663748578, 977.8533220017055, 3840.231953609289, 3918.7648741075627, 3940.271049855786, 4005.7396269242404, 4006.0786019215743, 10188.388696678223, 10615.681529554126, 10638.734031649115, 10640.148788096934, 10641.627543035956, 10532.631357902437, 10563.260571759904, 10592.311499752492, 10597.25819192649, 10599.576016959236, 7671.2712292332135, 7717.382609391348, 7840.490368126054, 7879.84240315202, 8001.799955001172, 5581.693006884498, 5641.379448260606, 5651.717414129359, 5726.74229659658, 5925.4370834770625, 9469.053094690476, 9502.097300756417, 9509.286803489627, 9619.951900240454, 9657.613695452384, 9547.188488978514, 9626.422414655142, 9744.805103897741, 9754.561044752862, 9773.511324433608, 6552.27924928267, 7074.3633073023675, 7195.496315258091, 7782.105057918412, 8063.596820159086, 8317.625706843328, 8368.330533557422, 8372.162783721578, 8388.874166887379, 8462.576871156294, 7171.0, 7371.262873712801, 7451.2176221495965, 7618.923810761821, 7699.807504812425, 7142.5714457132735, 7282.308180722823, 7282.854342913006, 7300.780976570712, 7499.100107987077, 6770.966145169243, 6783.830404239933, 6792.049113124265, 6806.455483561403, 6834.350736680008, 4907.877303067452, 4967.379077615298, 5065.8733531662, 5100.336956195671, 5197.246399272009, 4970.353853998957, 5036.974815125901, 5126.154184559655, 5169.844904652867, 5212.817551385683], "value": 4535.856892344832, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.1937060495735, 318.37598307317654, 326.2740402604206, 328.7550774672866, 330.55375243421383, 5314.787408503656, 5414.3232095988005, 5540.944590554093, 5542.251796007537, 5561.888762224753, 5318.414974352818, 5400.0, 5420.4794770431745, 5420.693377040012, 5421.918671219935, 4260.147970405916, 4278.0, 4281.422008028915, 4289.034967132401, 4309.116631090619, 4250.553691862357, 4255.914881702364, 4300.741955482666, 4317.395564620955, 4342.630876375496, 4264.275073237557, 4270.7864606769535, 4276.957230427703, 4279.2725236709675, 4301.311790113583, 4265.168292183025, 4303.826567583366, 4311.116221174668, 4313.899955511324, 4316.359783282364, 3663.9115704048704, 3810.923781524382, 3812.1422679897078, 3813.694904407641, 3815.9618403815884, 5310.336207974004, 5318.149096144598, 5319.521243088141, 5357.517823395913, 5357.678539287655, 4852.417709874802, 4869.70781753096, 4874.65877388583, 4893.8776530586665, 4918.8278410255825, 5573.247611572427, 5680.091185410356, 5701.857453563653, 5723.198752174699, 5735.304406928779, 4089.85685501009, 4098.385242213662, 4099.262132816092, 4106.260873042851, 4108.26051310764, 5924.851878703067, 5999.220101386835, 6020.4280593343565, 6024.969875150597, 6026.578139530235, 4090.570490098556, 4255.87232383029, 4260.914781704349, 4266.381374700713, 4293.506246781598, 4252.893677658021, 4275.679324050647, 4282.357646353072, 4284.378765079046, 4316.8055638827045, 4857.368542089505, 4867.150482816578, 4877.317175595419, 4890.315355850113, 4919.950800491949, 5578.135389014628, 5811.476967072984, 5821.18503409523, 5825.79609713658, 5826.1552074948895, 1439.6688761584894, 1477.6305923519121, 1486.8884833637303, 1487.5834766265464, 1491.127690301186, 904.9186222464224, 945.9452710228046, 949.9857502137473, 950.8589692369185, 959.9136077753036, 4719.362886010414, 4904.337914381585, 4915.606751459874, 4921.5727439042275, 4927.605791536668, 5109.284700141983, 5116.769745361467, 5132.743362831843, 5230.398504172069, 5274.868128296824, 4660.743659098782, 4828.155072862305, 4944.7638090477385, 4951.653384263067, 4979.0788704089855, 2715.945681086367, 2730.3993121513236, 2737.0, 2759.1998320487237, 2779.791515636295, 5308.389535203424, 5317.867053323621, 5342.706151161723, 5345.839624811262, 5366.8658283542445, 5211.697075731067, 5240.877444634929, 5541.833744987657, 6018.608790428608, 6021.3677563856045, 6154.846128846814, 6157.353477884847, 6157.599756015845, 6160.661163635953, 6171.9691401542705, 5677.240055582783, 5898.705064746831, 5898.764049437975, 5945.940540594539, 5948.7394789979535, 5873.177755114202, 5917.556183286185, 5917.822465326047, 5919.556033297434, 5929.792457263975, 6205.348438413902, 6213.720382582885, 6220.937790622217, 6226.221722284715, 6246.969734836105, 3968.603139686124, 4102.405151253111, 4110.86951088453, 4114.259433302034, 4224.471941007374, 5881.911771323348, 5920.8815823684145, 5925.511285260287, 5955.404459554184, 5955.464008239106, 5658.85852853682, 5776.19133321327, 5824.592278540631, 5853.473187413153, 5855.648661080349, 5709.885802283848, 5713.314402271754, 5722.7395178904935, 5749.770009199585, 5755.942440575541, 5791.276090488689, 5791.901332787107, 5809.709514524341, 5826.155207494974, 5827.1841942127285, 5564.661203278, 5749.195112684311, 5794.565407594363, 5802.216700745515, 5857.0, 5654.293213348332, 5669.631473954345, 5694.177863083773, 5709.600327977168, 5711.257536520226], "value": 4303.432330267048, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.6813854112002, 752.2627824731763, 790.8615992201363, 833.8207285433631, 841.305922613843, 15279.847201527982, 16625.667486650258, 16669.583260418494, 16670.666586668274, 16851.820372573926, 15209.315580798862, 15438.459653912116, 15449.536513904573, 15459.45891893784, 15466.226688665578, 647.6502688548202, 781.9374450043982, 795.7294519863245, 808.5189312359166, 808.9110197878229, 816.2001238785994, 816.2490508731951, 817.0767033252416, 817.2154731457778, 817.6729308276678, 856.575994882534, 864.023653271802, 868.6612221233723, 868.7046404222563, 870.4603146049427, 851.05957916502, 860.0023972192258, 861.1775754154767, 861.1990848510914, 863.4344504349662, 628.3057221769969, 633.7781776378231, 633.8668879535303, 634.0742515926753, 634.1882390540115, 14760.0, 14820.481283155146, 14846.480373186887, 14847.406103755837, 14889.925550372178, 15805.0, 15838.920805396014, 15862.762058569131, 15864.286107125206, 16056.43802466908, 11183.49674264652, 11275.718107047307, 11308.836684007236, 11595.01442377399, 11980.28118312904, 3900.8634697785724, 3921.1765529238896, 3923.4114882767526, 4062.756234625932, 4076.9592304077173, 79824.60087699525, 81027.0, 81197.0, 82086.58956705238, 82632.58683706603, 11886.643400697993, 11923.0, 11997.520099196108, 12038.217515861616, 12360.25838449696, 23051.423714407272, 23135.53728925412, 23246.3026109217, 23269.0, 23445.648315275284, 8335.916640833635, 8468.195521425454, 8667.826643467095, 8828.42615230008, 9007.324450666227, 4751.667383283137, 4826.103654491695, 4871.391076115486, 4917.409910810726, 4954.677945933503, 3344.364570731553, 3463.930721385558, 3470.5661792275964, 3472.0104770140388, 3479.913002174915, 574.1445246582562, 574.6925394913701, 577.0737965565291, 585.2421114656445, 588.185363271863, 604.9758009679564, 693.4868197533789, 708.4014008163094, 751.102432593046, 756.9091708994846, 9245.0, 9709.66016189444, 9902.249066200435, 10099.495025248709, 10215.693529194135, 643.7714611313011, 707.6992278281709, 711.4983936324878, 725.5574099799119, 758.7571976967317, 4471.0, 4750.709767395569, 4876.268559716071, 4887.655894629005, 4893.804247830119, 124464.0, 125464.0, 130482.47587620771, 131264.343678281, 138211.0, 61758.0, 88715.0, 102304.0, 104048.47975760073, 105186.0, 98575.50712246537, 98636.0, 99742.02321790929, 100074.4996275014, 100630.0, 9188.081191880758, 9445.338826282368, 9584.66453674118, 9598.376105553116, 9616.326857119935, 54589.72705136449, 55275.17087243614, 56003.71998140146, 56600.7169964164, 57134.85730285288, 81072.0, 83141.0, 86851.1314886843, 86860.56569717363, 87217.56391218003, 12724.74550508966, 12725.681857953625, 12839.679008024874, 12975.156614820007, 13175.14361566495, 13081.215127092404, 13195.934020329836, 13343.266120363085, 13441.663958401119, 13574.117682350616, 12210.511579536718, 12338.136330456782, 14916.179610121548, 14953.850461495245, 14962.625934351729, 13295.779685264695, 13463.528776492776, 14109.788353174505, 14508.492202772852, 15607.0, 11779.362445371435, 13428.731425371634, 13491.662708431975, 13621.455141794217, 13949.930250349089, 11031.558737650725, 11432.657020289405, 11878.703032424259, 11887.821682674594, 12252.571160009356, 10931.18016148776, 12530.686732831753, 12639.684007899876, 12892.10754380516, 13085.803712944504], "value": 7745.839115571999, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 116.0, 117.0, 115.0, 114.0, 112.0, 112.0, 112.0, 132.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 146.0, 181.0, 123.0, 151.0, 156.0, 120.0, 180.0, 120.0], "value": 144.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 172.0, 167.0, 166.0, 163.0, 163.0, 164.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 179.0, 76.0, 76.0, 75.0, 76.0, 189.0, 76.0], "value": 97.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 143.0, 83.0, 83.0, 83.0, 145.0, 81.0, 83.0, 150.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 149.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 55.0, 52.0, 54.0, 53.0, 64.0, 58.0, 54.0, 52.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 64.0, 62.0, 64.0, 62.0, 66.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 81.0, 80.0, 79.0, 80.0, 85.0, 82.0, 80.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 144.0, 131.0, 142.0, 137.0, 126.0, 127.0, 126.0, 158.0, 128.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 167.0, 168.0, 164.0, 168.0, 167.0, 165.0, 166.0, 170.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 66.0, 68.0, 65.0, 65.0, 66.0, 64.0, 69.0], "value": 66.5, "unit": "score"}]}]} 11:32:26 INFO - Return code: 0 11:32:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:32:27 ERROR - # TBPL SUCCESS # 11:32:27 INFO - Running post-action listener: _resource_record_post_action 11:32:27 INFO - [mozharness: 2016-09-03 18:32:27.060746Z] Finished run-tests step (success) 11:32:27 INFO - Running post-run listener: _resource_record_post_run 11:32:27 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 411394048; Read time: 240; Write time: 556956 11:32:27 INFO - TinderboxPrint: CPU usage
13.4% 11:32:27 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 240 11:32:27 INFO - TinderboxPrint: I/O write bytes / time
411,394,048 / 556,956 11:32:27 INFO - TinderboxPrint: CPU idle
8,261.4 (86.5%) 11:32:27 INFO - TinderboxPrint: CPU user
1,216.6 (12.7%) 11:32:27 INFO - TinderboxPrint: Swap in / out
0 / 0 11:32:27 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 118362112; Read time: 0; Write time: 227124 11:32:27 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293031936; Read time: 228; Write time: 329832 11:32:27 INFO - Running post-run listener: _upload_blobber_files 11:32:27 INFO - Blob upload gear active. 11:32:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:32:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:32:27 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'] 11:32:27 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 11:32:28 INFO - (blobuploader) - INFO - Open directory for files ... 11:32:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:32:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:32:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:28 INFO - (blobuploader) - INFO - Done attempting. 11:32:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:32:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:32:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:29 INFO - (blobuploader) - INFO - Done attempting. 11:32:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:32:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:32:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:34 INFO - (blobuploader) - INFO - Done attempting. 11:32:34 INFO - (blobuploader) - INFO - Iteration through files over. 11:32:34 INFO - Return code: 0 11:32:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:32:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:32:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cefadc671dc2da98b4cc71bcab46c10b2248c140b99d8ad840ac58e5235a24b5371fc8e6400d15867b761b2d72ad233f8a4ee7e4c9b71ce0fb68c2ea50da517c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84f613f98800ec3e0dcb2d00dc678c87b41030ab045f7e663c913fc8bd0fde194b8435af392135a888ceba03e94ce662afdc136baa7e1c058d962e27943922a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca45adbd4e6041801ec39e68c8b2d08edc9b5eb4b95f65ab7607a24e4d412a2f07e2c78db2fb03aae31982e06a823a1b92f49011e6747b0483497dd18d2d5ce6"} 11:32:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:32:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:32:34 INFO - Contents: 11:32:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cefadc671dc2da98b4cc71bcab46c10b2248c140b99d8ad840ac58e5235a24b5371fc8e6400d15867b761b2d72ad233f8a4ee7e4c9b71ce0fb68c2ea50da517c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84f613f98800ec3e0dcb2d00dc678c87b41030ab045f7e663c913fc8bd0fde194b8435af392135a888ceba03e94ce662afdc136baa7e1c058d962e27943922a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca45adbd4e6041801ec39e68c8b2d08edc9b5eb4b95f65ab7607a24e4d412a2f07e2c78db2fb03aae31982e06a823a1b92f49011e6747b0483497dd18d2d5ce6"} 11:32:34 INFO - Running post-run listener: copy_logs_to_upload_dir 11:32:34 INFO - Copying logs to upload dir... 11:32:34 INFO - mkdir: /builds/slave/test/build/upload/logs 11:32:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.403642 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-03 11:32:34.184360) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 11:32:34.187458) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141 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/cefadc671dc2da98b4cc71bcab46c10b2248c140b99d8ad840ac58e5235a24b5371fc8e6400d15867b761b2d72ad233f8a4ee7e4c9b71ce0fb68c2ea50da517c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84f613f98800ec3e0dcb2d00dc678c87b41030ab045f7e663c913fc8bd0fde194b8435af392135a888ceba03e94ce662afdc136baa7e1c058d962e27943922a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca45adbd4e6041801ec39e68c8b2d08edc9b5eb4b95f65ab7607a24e4d412a2f07e2c78db2fb03aae31982e06a823a1b92f49011e6747b0483497dd18d2d5ce6"} build_url:https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.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/cefadc671dc2da98b4cc71bcab46c10b2248c140b99d8ad840ac58e5235a24b5371fc8e6400d15867b761b2d72ad233f8a4ee7e4c9b71ce0fb68c2ea50da517c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84f613f98800ec3e0dcb2d00dc678c87b41030ab045f7e663c913fc8bd0fde194b8435af392135a888ceba03e94ce662afdc136baa7e1c058d962e27943922a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca45adbd4e6041801ec39e68c8b2d08edc9b5eb4b95f65ab7607a24e4d412a2f07e2c78db2fb03aae31982e06a823a1b92f49011e6747b0483497dd18d2d5ce6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 11:32:34.212701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:32:34.213052) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472925760.387397-196580141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:32:34.294911) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 11:32:34.295238) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 11:32:34.295533) ========= ========= Total master_lag: 0.21 =========