builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1470819987.97 results: success (0) buildid: 20160809233002 builduid: 64a68fd7ce8141209c4f9a6ff74e83ac revision: 3269dd1a824d1b42cb021d1fb6858885179940b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 02:06:27.971996) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 02:06:27.972471) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 02:06:27.972798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 02:06:27.988680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:06:27.988979) ========= 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=6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 02:06:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.3M=0s 2016-08-10 02:06:29 (38.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117237 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:06:28.122000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:06:28.122317) ========= 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=6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022075 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:06:28.173961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 02:06:28.174328) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3269dd1a824d1b42cb021d1fb6858885179940b0 --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 3269dd1a824d1b42cb021d1fb6858885179940b0 --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=6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 02:06:29,255 truncating revision to first 12 chars 2016-08-10 02:06:29,255 Setting DEBUG logging. 2016-08-10 02:06:29,255 attempt 1/10 2016-08-10 02:06:29,255 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3269dd1a824d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 02:06:30,409 unpacking tar archive at: fx-team-3269dd1a824d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.494365 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 02:06:29.684462) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 02:06:29.684997) ========= script_repo_revision: 3269dd1a824d1b42cb021d1fb6858885179940b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 02:06:29.685651) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 02:06:29.686116) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 02:06:29.697743) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-10 02:06:29.698325) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:06:30 INFO - MultiFileLogger online at 20160810 02:06:30 in /builds/slave/test 02:06:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:06:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:06:30 INFO - {'append_to_log': False, 02:06:30 INFO - 'base_work_dir': '/builds/slave/test', 02:06:30 INFO - 'blob_upload_branch': 'Fx-Team', 02:06:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:06:30 INFO - 'branch': 'Fx-Team', 02:06:30 INFO - 'buildbot_json_path': 'buildprops.json', 02:06:30 INFO - 'config_files': ('talos/linux_config.py',), 02:06:30 INFO - 'default_actions': ('clobber', 02:06:30 INFO - 'read-buildbot-config', 02:06:30 INFO - 'download-and-extract', 02:06:30 INFO - 'populate-webroot', 02:06:30 INFO - 'create-virtualenv', 02:06:30 INFO - 'install', 02:06:30 INFO - 'run-tests'), 02:06:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:06:30 INFO - 'download_minidump_stackwalk': True, 02:06:30 INFO - 'download_symbols': 'ondemand', 02:06:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:06:30 INFO - 'tooltool.py': '/tools/tooltool.py', 02:06:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:06:30 INFO - '/tools/misc-python/virtualenv.py')}, 02:06:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:06:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:06:30 INFO - 'installer_path': 'installer.exe', 02:06:30 INFO - 'log_level': 'info', 02:06:30 INFO - 'log_name': 'talos', 02:06:30 INFO - 'log_to_console': True, 02:06:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:06:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:06:30 INFO - 'opt_config_files': (), 02:06:30 INFO - 'pip_index': False, 02:06:30 INFO - 'sps_profile': False, 02:06:30 INFO - 'sps_profile_interval': 0, 02:06:30 INFO - 'suite': 'dromaeojs', 02:06:30 INFO - 'system_bits': '32', 02:06:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:06:30 INFO - 'title': 'talos-linux64-ix-050', 02:06:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:06:30 INFO - 'use_talos_json': True, 02:06:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:06:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:06:30 INFO - 'work_dir': 'build'} 02:06:30 INFO - [mozharness: 2016-08-10 09:06:30.862616Z] Running clobber step. 02:06:30 INFO - Running pre-action listener: _resource_record_pre_action 02:06:30 INFO - Running main action method: clobber 02:06:30 INFO - rmtree: /builds/slave/test/build 02:06:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:06:31 INFO - Running post-action listener: _resource_record_post_action 02:06:31 INFO - [mozharness: 2016-08-10 09:06:31.839232Z] Finished clobber step (success) 02:06:31 INFO - [mozharness: 2016-08-10 09:06:31.839332Z] Running read-buildbot-config step. 02:06:31 INFO - Running pre-action listener: _resource_record_pre_action 02:06:31 INFO - Running main action method: read_buildbot_config 02:06:31 INFO - Using buildbot properties: 02:06:31 INFO - { 02:06:31 INFO - "project": "", 02:06:31 INFO - "product": "firefox", 02:06:31 INFO - "script_repo_revision": "production", 02:06:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:06:31 INFO - "repository": "", 02:06:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:06:31 INFO - "buildid": "20160809233002", 02:06:31 INFO - "pgo_build": "True", 02:06:31 INFO - "basedir": "/builds/slave/test", 02:06:31 INFO - "buildnumber": 1448, 02:06:31 INFO - "slavename": "talos-linux64-ix-050", 02:06:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:06:31 INFO - "platform": "ubuntu64_hw", 02:06:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:06:31 INFO - "branch": "fx-team", 02:06:31 INFO - "repo_path": "integration/fx-team", 02:06:31 INFO - "revision": "3269dd1a824d1b42cb021d1fb6858885179940b0", 02:06:31 INFO - "stage_platform": "linux64-pgo", 02:06:31 INFO - "builduid": "64a68fd7ce8141209c4f9a6ff74e83ac", 02:06:31 INFO - "slavebuilddir": "test" 02:06:31 INFO - } 02:06:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:06:31 INFO - Running post-action listener: _resource_record_post_action 02:06:31 INFO - [mozharness: 2016-08-10 09:06:31.841800Z] Finished read-buildbot-config step (success) 02:06:31 INFO - [mozharness: 2016-08-10 09:06:31.841889Z] Running download-and-extract step. 02:06:31 INFO - Running pre-action listener: _resource_record_pre_action 02:06:31 INFO - Running main action method: download_and_extract 02:06:31 INFO - mkdir: /builds/slave/test/build/tests 02:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:31 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:06:31 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 02:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 02:06:32 INFO - Downloaded 1361 bytes. 02:06:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:06:32 INFO - Using the following test package requirements: 02:06:32 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:06:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:06:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:06:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:32 INFO - u'jsshell-linux-x86_64.zip'], 02:06:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:06:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:06:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:06:32 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:06:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:06:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:06:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:32 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:06:32 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 02:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 02:06:33 INFO - Downloaded 21831225 bytes. 02:06:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:06:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:06:34 INFO - Return code: 0 02:06:34 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 02:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:34 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:06:34 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 02:06:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 02:06:35 INFO - Downloaded 21831225 bytes. 02:06:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:06:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:06:36 INFO - Return code: 0 02:06:36 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')]} 02:06:36 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:36 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 02:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 02:06:37 INFO - Downloaded 14413723 bytes. 02:06:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:06:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:06:37 INFO - Return code: 0 02:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:37 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:06:37 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 02:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 02:06:38 INFO - Downloaded 59300254 bytes. 02:06:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:06:38 INFO - mkdir: /builds/slave/test/properties 02:06:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:06:38 INFO - Writing to file /builds/slave/test/properties/build_url 02:06:38 INFO - Contents: 02:06:38 INFO - build_url:https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:06:39 INFO - Running post-action listener: _resource_record_post_action 02:06:39 INFO - Running post-action listener: set_extra_try_arguments 02:06:39 INFO - [mozharness: 2016-08-10 09:06:39.473115Z] Finished download-and-extract step (success) 02:06:39 INFO - [mozharness: 2016-08-10 09:06:39.473350Z] Running populate-webroot step. 02:06:39 INFO - Running pre-action listener: _resource_record_pre_action 02:06:39 INFO - Running main action method: populate_webroot 02:06:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:06:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:06:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:06:39 INFO - '--tppagecycles', 02:06:39 INFO - '7'], 02:06:39 INFO - 'tests': ['tsvgm']}}, 02:06:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:06:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:06:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:06:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:06:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:06:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:06:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:39 INFO - 'talos_options': ['--disable-e10s'], 02:06:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:39 INFO - 'talos_options': ['--disable-e10s'], 02:06:39 INFO - 'tests': ['damp', 'tps']}, 02:06:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:39 INFO - 'tests': ['damp', 'tps']}, 02:06:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:06:39 INFO - 'tests': ['dromaeo_dom']}, 02:06:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:06:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:06:39 INFO - 'tests': ['basic_compositor_video']}, 02:06:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:06:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:06:39 INFO - 'tests': ['a11yr', 02:06:39 INFO - 'ts_paint', 02:06:39 INFO - 'tpaint', 02:06:39 INFO - 'sessionrestore', 02:06:39 INFO - 'sessionrestore_no_auto_restore', 02:06:39 INFO - 'tabpaint']}, 02:06:39 INFO - 'other-e10s': {'tests': ['a11yr', 02:06:39 INFO - 'ts_paint', 02:06:39 INFO - 'tpaint', 02:06:39 INFO - 'sessionrestore', 02:06:39 INFO - 'sessionrestore_no_auto_restore', 02:06:39 INFO - 'tabpaint']}, 02:06:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:06:39 INFO - 'ts_paint', 02:06:39 INFO - 'tpaint', 02:06:39 INFO - 'sessionrestore', 02:06:39 INFO - 'sessionrestore_no_auto_restore', 02:06:39 INFO - 'tabpaint']}, 02:06:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:06:39 INFO - 'ts_paint', 02:06:39 INFO - 'tpaint', 02:06:39 INFO - 'sessionrestore', 02:06:39 INFO - 'sessionrestore_no_auto_restore', 02:06:39 INFO - 'tabpaint']}, 02:06:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:06:39 INFO - 'tests': ['a11yr', 02:06:39 INFO - 'ts_paint', 02:06:39 INFO - 'tpaint', 02:06:39 INFO - 'sessionrestore', 02:06:39 INFO - 'sessionrestore_no_auto_restore', 02:06:39 INFO - 'tabpaint']}, 02:06:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:06:39 INFO - 'tests': ['a11yr', 02:06:39 INFO - 'ts_paint', 02:06:39 INFO - 'tpaint', 02:06:39 INFO - 'sessionrestore', 02:06:39 INFO - 'sessionrestore_no_auto_restore', 02:06:39 INFO - 'tabpaint']}, 02:06:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:06:39 INFO - 'tests': ['tsvgx', 02:06:39 INFO - 'tsvgr_opacity', 02:06:39 INFO - 'tart', 02:06:39 INFO - 'tscrollx', 02:06:39 INFO - 'cart']}, 02:06:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:06:39 INFO - 'tsvgr_opacity', 02:06:39 INFO - 'tart', 02:06:39 INFO - 'tscrollx', 02:06:39 INFO - 'cart']}, 02:06:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:39 INFO - 'talos_options': ['--disable-e10s'], 02:06:39 INFO - 'tests': ['tp5o']}, 02:06:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:39 INFO - 'tests': ['tp5o']}, 02:06:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:39 INFO - 'talos_options': ['--disable-e10s', 02:06:39 INFO - '--xperf_path', 02:06:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:39 INFO - 'tests': ['tp5n']}, 02:06:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:39 INFO - 'talos_options': ['--xperf_path', 02:06:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:39 INFO - 'tests': ['tp5n']}}, 02:06:39 INFO - 'talos.zip': {'path': '', 02:06:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:06:39 INFO - Running post-action listener: _resource_record_post_action 02:06:39 INFO - [mozharness: 2016-08-10 09:06:39.489330Z] Finished populate-webroot step (success) 02:06:39 INFO - [mozharness: 2016-08-10 09:06:39.489419Z] Running create-virtualenv step. 02:06:39 INFO - Running pre-action listener: _resource_record_pre_action 02:06:39 INFO - Running main action method: create_virtualenv 02:06:39 INFO - Creating virtualenv /builds/slave/test/build/venv 02:06:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:06:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:06:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:06:39 INFO - Using real prefix '/usr' 02:06:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:06:40 INFO - Installing distribute.............................................................................................................................................................................................done. 02:06:42 INFO - Installing pip.................done. 02:06:42 INFO - Return code: 0 02:06:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3b0>, '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 0x24bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bf740>, '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': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', '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 02:06:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:06:42 INFO - Using env: {'DISPLAY': ':0', 02:06:42 INFO - 'HOME': '/home/cltbld', 02:06:42 INFO - 'LANG': 'en_US.UTF-8', 02:06:42 INFO - 'LANGUAGE': 'en_US:en', 02:06:42 INFO - 'LOGNAME': 'cltbld', 02:06:42 INFO - 'MAIL': '/var/mail/cltbld', 02:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:42 INFO - 'MOZ_NO_REMOTE': '1', 02:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:42 INFO - 'NO_EM_RESTART': '1', 02:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:42 INFO - 'PWD': '/builds/slave/test', 02:06:42 INFO - 'SHELL': '/bin/bash', 02:06:42 INFO - 'SHLVL': '1', 02:06:42 INFO - 'TERM': 'linux', 02:06:42 INFO - 'TMOUT': '86400', 02:06:42 INFO - 'USER': 'cltbld', 02:06:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', 02:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:42 INFO - '_': '/tools/buildbot/bin/python'} 02:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:06:42 INFO - Cleaning up... 02:06:42 INFO - Return code: 0 02:06:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3b0>, '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 0x24bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bf740>, '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': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', '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 02:06:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:06:42 INFO - Using env: {'DISPLAY': ':0', 02:06:42 INFO - 'HOME': '/home/cltbld', 02:06:42 INFO - 'LANG': 'en_US.UTF-8', 02:06:42 INFO - 'LANGUAGE': 'en_US:en', 02:06:42 INFO - 'LOGNAME': 'cltbld', 02:06:42 INFO - 'MAIL': '/var/mail/cltbld', 02:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:42 INFO - 'MOZ_NO_REMOTE': '1', 02:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:42 INFO - 'NO_EM_RESTART': '1', 02:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:42 INFO - 'PWD': '/builds/slave/test', 02:06:42 INFO - 'SHELL': '/bin/bash', 02:06:42 INFO - 'SHLVL': '1', 02:06:42 INFO - 'TERM': 'linux', 02:06:42 INFO - 'TMOUT': '86400', 02:06:42 INFO - 'USER': 'cltbld', 02:06:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', 02:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:42 INFO - '_': '/tools/buildbot/bin/python'} 02:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:42 INFO - Downloading/unpacking psutil>=3.1.1 02:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:06:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:44 INFO - Installing collected packages: psutil 02:06:44 INFO - Running setup.py install for psutil 02:06:44 INFO - building 'psutil._psutil_linux' extension 02:06:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:06:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:06:44 INFO - building 'psutil._psutil_posix' extension 02:06:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:06:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:06:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:44 INFO - Successfully installed psutil 02:06:44 INFO - Cleaning up... 02:06:45 INFO - Return code: 0 02:06:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:06:45 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')]} 02:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:45 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')]} 02:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:45 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 0x21ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3b0>, '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 0x24bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bf740>, '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': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', '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 02:06:45 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 02:06:45 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 02:06:45 INFO - Using env: {'DISPLAY': ':0', 02:06:45 INFO - 'HOME': '/home/cltbld', 02:06:45 INFO - 'LANG': 'en_US.UTF-8', 02:06:45 INFO - 'LANGUAGE': 'en_US:en', 02:06:45 INFO - 'LOGNAME': 'cltbld', 02:06:45 INFO - 'MAIL': '/var/mail/cltbld', 02:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:45 INFO - 'MOZ_NO_REMOTE': '1', 02:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:45 INFO - 'NO_EM_RESTART': '1', 02:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:45 INFO - 'PWD': '/builds/slave/test', 02:06:45 INFO - 'SHELL': '/bin/bash', 02:06:45 INFO - 'SHLVL': '1', 02:06:45 INFO - 'TERM': 'linux', 02:06:45 INFO - 'TMOUT': '86400', 02:06:45 INFO - 'USER': 'cltbld', 02:06:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', 02:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:45 INFO - '_': '/tools/buildbot/bin/python'} 02:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:06:47 INFO - Installing collected packages: mozsystemmonitor 02:06:47 INFO - Running setup.py install for mozsystemmonitor 02:06:47 INFO - Successfully installed mozsystemmonitor 02:06:47 INFO - Cleaning up... 02:06:47 INFO - Return code: 0 02:06:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3b0>, '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 0x24bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bf740>, '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': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', '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 02:06:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:06:47 INFO - Using env: {'DISPLAY': ':0', 02:06:47 INFO - 'HOME': '/home/cltbld', 02:06:47 INFO - 'LANG': 'en_US.UTF-8', 02:06:47 INFO - 'LANGUAGE': 'en_US:en', 02:06:47 INFO - 'LOGNAME': 'cltbld', 02:06:47 INFO - 'MAIL': '/var/mail/cltbld', 02:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:47 INFO - 'MOZ_NO_REMOTE': '1', 02:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:47 INFO - 'NO_EM_RESTART': '1', 02:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:47 INFO - 'PWD': '/builds/slave/test', 02:06:47 INFO - 'SHELL': '/bin/bash', 02:06:47 INFO - 'SHLVL': '1', 02:06:47 INFO - 'TERM': 'linux', 02:06:47 INFO - 'TMOUT': '86400', 02:06:47 INFO - 'USER': 'cltbld', 02:06:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', 02:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:47 INFO - '_': '/tools/buildbot/bin/python'} 02:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:47 INFO - Downloading/unpacking jsonschema==2.5.1 02:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:06:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:49 INFO - Downloading functools32-3.2.3-2.tar.gz 02:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:06:49 INFO - warning: no files found matching '*.txt' 02:06:49 INFO - no previously-included directories found matching 'build' 02:06:49 INFO - no previously-included directories found matching 'dist' 02:06:49 INFO - no previously-included directories found matching '.git*' 02:06:49 INFO - Installing collected packages: jsonschema, functools32 02:06:49 INFO - Running setup.py install for functools32 02:06:49 INFO - warning: no files found matching '*.txt' 02:06:49 INFO - no previously-included directories found matching 'build' 02:06:49 INFO - no previously-included directories found matching 'dist' 02:06:49 INFO - no previously-included directories found matching '.git*' 02:06:49 INFO - Successfully installed jsonschema functools32 02:06:49 INFO - Cleaning up... 02:06:49 INFO - Return code: 0 02:06:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3b0>, '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 0x24bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bf740>, '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': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', '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 02:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:06:49 INFO - Using env: {'DISPLAY': ':0', 02:06:49 INFO - 'HOME': '/home/cltbld', 02:06:49 INFO - 'LANG': 'en_US.UTF-8', 02:06:49 INFO - 'LANGUAGE': 'en_US:en', 02:06:49 INFO - 'LOGNAME': 'cltbld', 02:06:49 INFO - 'MAIL': '/var/mail/cltbld', 02:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:49 INFO - 'MOZ_NO_REMOTE': '1', 02:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:49 INFO - 'NO_EM_RESTART': '1', 02:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:49 INFO - 'PWD': '/builds/slave/test', 02:06:49 INFO - 'SHELL': '/bin/bash', 02:06:49 INFO - 'SHLVL': '1', 02:06:49 INFO - 'TERM': 'linux', 02:06:49 INFO - 'TMOUT': '86400', 02:06:49 INFO - 'USER': 'cltbld', 02:06:49 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', 02:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:49 INFO - '_': '/tools/buildbot/bin/python'} 02:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:06:50 INFO - Cleaning up... 02:06:50 INFO - Return code: 0 02:06:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:50 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 0x21ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3b0>, '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 0x24bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bf740>, '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': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', '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 02:06:50 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 02:06:50 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 02:06:50 INFO - Using env: {'DISPLAY': ':0', 02:06:50 INFO - 'HOME': '/home/cltbld', 02:06:50 INFO - 'LANG': 'en_US.UTF-8', 02:06:50 INFO - 'LANGUAGE': 'en_US:en', 02:06:50 INFO - 'LOGNAME': 'cltbld', 02:06:50 INFO - 'MAIL': '/var/mail/cltbld', 02:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:50 INFO - 'MOZ_NO_REMOTE': '1', 02:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:50 INFO - 'NO_EM_RESTART': '1', 02:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:50 INFO - 'PWD': '/builds/slave/test', 02:06:50 INFO - 'SHELL': '/bin/bash', 02:06:50 INFO - 'SHLVL': '1', 02:06:50 INFO - 'TERM': 'linux', 02:06:50 INFO - 'TMOUT': '86400', 02:06:50 INFO - 'USER': 'cltbld', 02:06:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', 02:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:50 INFO - '_': '/tools/buildbot/bin/python'} 02:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:50 INFO - Downloading/unpacking blobuploader==1.2.4 02:06:50 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 02:06:50 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 02:06:50 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 02:06:50 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 02:06:50 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 02:06:50 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 02:06:52 INFO - Downloading blobuploader-1.2.4.tar.gz 02:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:06:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:06:52 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 02:06:52 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 02:06:52 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 02:06:52 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 02:06:52 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 02:06:52 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 02:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:06:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:06:52 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 02:06:52 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 02:06:52 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 02:06:52 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 02:06:52 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 02:06:52 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 02:06:52 INFO - Downloading docopt-0.6.1.tar.gz 02:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:06:52 INFO - Installing collected packages: blobuploader, requests, docopt 02:06:52 INFO - Running setup.py install for blobuploader 02:06:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:06:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:06:53 INFO - Running setup.py install for requests 02:06:53 INFO - Running setup.py install for docopt 02:06:53 INFO - Successfully installed blobuploader requests docopt 02:06:53 INFO - Cleaning up... 02:06:53 INFO - Return code: 0 02:06:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06: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')]} 02:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:53 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 0x21ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3b0>, '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 0x24bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bf740>, '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': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', '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 02:06:53 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 02:06:53 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 02:06:53 INFO - Using env: {'DISPLAY': ':0', 02:06:53 INFO - 'HOME': '/home/cltbld', 02:06:53 INFO - 'LANG': 'en_US.UTF-8', 02:06:53 INFO - 'LANGUAGE': 'en_US:en', 02:06:53 INFO - 'LOGNAME': 'cltbld', 02:06:53 INFO - 'MAIL': '/var/mail/cltbld', 02:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:53 INFO - 'MOZ_NO_REMOTE': '1', 02:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:53 INFO - 'NO_EM_RESTART': '1', 02:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:53 INFO - 'PWD': '/builds/slave/test', 02:06:53 INFO - 'SHELL': '/bin/bash', 02:06:53 INFO - 'SHLVL': '1', 02:06:53 INFO - 'TERM': 'linux', 02:06:53 INFO - 'TMOUT': '86400', 02:06:53 INFO - 'USER': 'cltbld', 02:06:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', 02:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:53 INFO - '_': '/tools/buildbot/bin/python'} 02:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:53 INFO - Running setup.py (path:/tmp/pip-Hyi1U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:53 INFO - Running setup.py (path:/tmp/pip-6Q89KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:53 INFO - Running setup.py (path:/tmp/pip-cZ3g1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:54 INFO - Running setup.py (path:/tmp/pip-T3jR9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:54 INFO - Running setup.py (path:/tmp/pip-KdM7ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:54 INFO - Running setup.py (path:/tmp/pip-KixCJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:54 INFO - Running setup.py (path:/tmp/pip-t4Ml50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:54 INFO - Running setup.py (path:/tmp/pip-4F0P1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:54 INFO - Running setup.py (path:/tmp/pip-iYQb6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:54 INFO - Running setup.py (path:/tmp/pip-cNnRB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:54 INFO - Running setup.py (path:/tmp/pip-SUQSUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:54 INFO - Running setup.py (path:/tmp/pip-WkBJ7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:54 INFO - Running setup.py (path:/tmp/pip-eiwChZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:54 INFO - Running setup.py (path:/tmp/pip-23UPU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:54 INFO - Running setup.py (path:/tmp/pip-v0Z5HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:54 INFO - Running setup.py (path:/tmp/pip-5jZOcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:54 INFO - Running setup.py (path:/tmp/pip-vUz8s0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:55 INFO - Running setup.py install for manifestparser 02:06:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:06:55 INFO - Running setup.py install for mozcrash 02:06:55 INFO - Running setup.py install for mozdebug 02:06:55 INFO - Running setup.py install for mozdevice 02:06:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:06:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:06:55 INFO - Running setup.py install for mozfile 02:06:55 INFO - Running setup.py install for mozhttpd 02:06:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:06:55 INFO - Running setup.py install for mozinfo 02:06:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:06:55 INFO - Running setup.py install for mozInstall 02:06:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:06:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:06:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:06:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:06:55 INFO - Running setup.py install for mozleak 02:06:55 INFO - Running setup.py install for mozlog 02:06:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Running setup.py install for moznetwork 02:06:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Running setup.py install for mozprocess 02:06:56 INFO - Running setup.py install for mozprofile 02:06:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Running setup.py install for mozrunner 02:06:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Running setup.py install for mozscreenshot 02:06:56 INFO - Running setup.py install for moztest 02:06:56 INFO - Running setup.py install for mozversion 02:06:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:56 INFO - Cleaning up... 02:06:56 INFO - Return code: 0 02:06:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:56 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 0x21ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3b0>, '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 0x24bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bf740>, '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': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', '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 02:06:56 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 02:06:56 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 02:06:56 INFO - Using env: {'DISPLAY': ':0', 02:06:56 INFO - 'HOME': '/home/cltbld', 02:06:56 INFO - 'LANG': 'en_US.UTF-8', 02:06:56 INFO - 'LANGUAGE': 'en_US:en', 02:06:56 INFO - 'LOGNAME': 'cltbld', 02:06:56 INFO - 'MAIL': '/var/mail/cltbld', 02:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:56 INFO - 'MOZ_NO_REMOTE': '1', 02:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:56 INFO - 'NO_EM_RESTART': '1', 02:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:56 INFO - 'PWD': '/builds/slave/test', 02:06:56 INFO - 'SHELL': '/bin/bash', 02:06:56 INFO - 'SHLVL': '1', 02:06:56 INFO - 'TERM': 'linux', 02:06:56 INFO - 'TMOUT': '86400', 02:06:56 INFO - 'USER': 'cltbld', 02:06:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', 02:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:56 INFO - '_': '/tools/buildbot/bin/python'} 02:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:57 INFO - Running setup.py (path:/tmp/pip-n2ezi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:57 INFO - Running setup.py (path:/tmp/pip-KDk3aU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:57 INFO - Running setup.py (path:/tmp/pip-TJ9Jvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:57 INFO - Running setup.py (path:/tmp/pip-ptVXTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:57 INFO - Running setup.py (path:/tmp/pip-BtkumV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:57 INFO - Running setup.py (path:/tmp/pip-t0QcXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:57 INFO - Running setup.py (path:/tmp/pip-lCyGRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:57 INFO - Running setup.py (path:/tmp/pip-L6vCyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:57 INFO - Running setup.py (path:/tmp/pip-0zdCiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:57 INFO - Running setup.py (path:/tmp/pip-J_QqKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:57 INFO - Running setup.py (path:/tmp/pip-UBeyk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:57 INFO - Running setup.py (path:/tmp/pip-V59vdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:57 INFO - Running setup.py (path:/tmp/pip-XyGpjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:58 INFO - Running setup.py (path:/tmp/pip-T5q221-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:58 INFO - Running setup.py (path:/tmp/pip-Mpg5aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:58 INFO - Running setup.py (path:/tmp/pip-3kZWLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:58 INFO - Running setup.py (path:/tmp/pip-jq3sZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:58 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)) 02:06:58 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)) 02:06:58 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)) 02:06:58 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)) 02:06:58 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)) 02:06:58 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)) 02:06:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:00 INFO - Downloading blessings-1.6.tar.gz 02:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:07:00 INFO - Installing collected packages: blessings 02:07:00 INFO - Running setup.py install for blessings 02:07:00 INFO - Successfully installed blessings 02:07:00 INFO - Cleaning up... 02:07:00 INFO - Return code: 0 02:07:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:07:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:00 INFO - Reading from file tmpfile_stdout 02:07:00 INFO - Current package versions: 02:07:00 INFO - argparse == 1.2.1 02:07:00 INFO - blessings == 1.6 02:07:00 INFO - blobuploader == 1.2.4 02:07:00 INFO - docopt == 0.6.1 02:07:00 INFO - functools32 == 3.2.3-2 02:07:00 INFO - jsonschema == 2.5.1 02:07:00 INFO - manifestparser == 1.1 02:07:00 INFO - mozInstall == 1.12 02:07:00 INFO - mozcrash == 0.17 02:07:00 INFO - mozdebug == 0.1 02:07:00 INFO - mozdevice == 0.48 02:07:00 INFO - mozfile == 1.2 02:07:00 INFO - mozhttpd == 0.7 02:07:00 INFO - mozinfo == 0.9 02:07:00 INFO - mozleak == 0.1 02:07:00 INFO - mozlog == 3.3 02:07:00 INFO - moznetwork == 0.27 02:07:00 INFO - mozprocess == 0.23 02:07:00 INFO - mozprofile == 0.28 02:07:00 INFO - mozrunner == 6.12 02:07:00 INFO - mozscreenshot == 0.1 02:07:00 INFO - mozsystemmonitor == 0.3 02:07:00 INFO - moztest == 0.7 02:07:00 INFO - mozversion == 1.4 02:07:00 INFO - psutil == 3.1.1 02:07:00 INFO - requests == 1.2.3 02:07:00 INFO - wsgiref == 0.1.2 02:07:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:00 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 0x21ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3b0>, '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 0x24bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bf740>, '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': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', '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 02:07:00 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 02:07:00 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 02:07:00 INFO - Using env: {'DISPLAY': ':0', 02:07:00 INFO - 'HOME': '/home/cltbld', 02:07:00 INFO - 'LANG': 'en_US.UTF-8', 02:07:00 INFO - 'LANGUAGE': 'en_US:en', 02:07:00 INFO - 'LOGNAME': 'cltbld', 02:07:00 INFO - 'MAIL': '/var/mail/cltbld', 02:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:00 INFO - 'MOZ_NO_REMOTE': '1', 02:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:00 INFO - 'NO_EM_RESTART': '1', 02:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:00 INFO - 'PWD': '/builds/slave/test', 02:07:00 INFO - 'SHELL': '/bin/bash', 02:07:00 INFO - 'SHLVL': '1', 02:07:00 INFO - 'TERM': 'linux', 02:07:00 INFO - 'TMOUT': '86400', 02:07:00 INFO - 'USER': 'cltbld', 02:07:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', 02:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:00 INFO - '_': '/tools/buildbot/bin/python'} 02:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:00 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)) 02:07:00 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)) 02:07:00 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)) 02:07:00 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)) 02:07:00 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)) 02:07:00 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)) 02:07:00 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)) 02:07:00 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)) 02:07:00 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)) 02:07:00 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)) 02:07:00 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)) 02:07:00 INFO - Cleaning up... 02:07:00 INFO - Return code: 0 02:07:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3b0>, '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 0x24bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bf740>, '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': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', '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 02:07:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:07:00 INFO - Using env: {'DISPLAY': ':0', 02:07:00 INFO - 'HOME': '/home/cltbld', 02:07:00 INFO - 'LANG': 'en_US.UTF-8', 02:07:00 INFO - 'LANGUAGE': 'en_US:en', 02:07:00 INFO - 'LOGNAME': 'cltbld', 02:07:00 INFO - 'MAIL': '/var/mail/cltbld', 02:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:00 INFO - 'MOZ_NO_REMOTE': '1', 02:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:00 INFO - 'NO_EM_RESTART': '1', 02:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:00 INFO - 'PWD': '/builds/slave/test', 02:07:00 INFO - 'SHELL': '/bin/bash', 02:07:00 INFO - 'SHLVL': '1', 02:07:00 INFO - 'TERM': 'linux', 02:07:00 INFO - 'TMOUT': '86400', 02:07:00 INFO - 'USER': 'cltbld', 02:07:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', 02:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:00 INFO - '_': '/tools/buildbot/bin/python'} 02:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:07:01 INFO - Cleaning up... 02:07:01 INFO - Return code: 0 02:07:01 INFO - Running post-action listener: _resource_record_post_action 02:07:01 INFO - Running post-action listener: _start_resource_monitoring 02:07:01 INFO - Starting resource monitoring. 02:07:01 INFO - [mozharness: 2016-08-10 09:07:01.094599Z] Finished create-virtualenv step (success) 02:07:01 INFO - [mozharness: 2016-08-10 09:07:01.095080Z] Running install step. 02:07:01 INFO - Running pre-action listener: _resource_record_pre_action 02:07:01 INFO - Running main action method: install 02:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:01 INFO - Reading from file tmpfile_stdout 02:07:01 INFO - Detecting whether we're running mozinstall >=1.0... 02:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:07:01 INFO - Reading from file tmpfile_stdout 02:07:01 INFO - Output received: 02:07:01 INFO - Usage: mozinstall [options] installer 02:07:01 INFO - Options: 02:07:01 INFO - -h, --help show this help message and exit 02:07:01 INFO - -d DEST, --destination=DEST 02:07:01 INFO - Directory to install application into. [default: 02:07:01 INFO - "/builds/slave/test"] 02:07:01 INFO - --app=APP Application being installed. [default: firefox] 02:07:01 INFO - mkdir: /builds/slave/test/build/application 02:07:01 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'] 02:07:01 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 02:07:18 INFO - Reading from file tmpfile_stdout 02:07:18 INFO - Output received: 02:07:18 INFO - /builds/slave/test/build/application/firefox/firefox 02:07:18 INFO - Running post-action listener: _resource_record_post_action 02:07:18 INFO - [mozharness: 2016-08-10 09:07:18.299436Z] Finished install step (success) 02:07:18 INFO - [mozharness: 2016-08-10 09:07:18.299683Z] Running run-tests step. 02:07:18 INFO - Running pre-action listener: _resource_record_pre_action 02:07:18 INFO - Running main action method: run_tests 02:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:07:18 INFO - Python 2.7.3 02:07:18 INFO - Return code: 0 02:07:18 INFO - grabbing minidump binary from tooltool 02:07: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')]} 02:07:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3b0>, '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 0x24bf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bf740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:07:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:07:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:07:18 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 02:07:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:07:18 INFO - Return code: 0 02:07:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:07:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:07:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:07:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:07:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:07:18 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:07:18 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:07:18 INFO - Using env: {'DISPLAY': ':0', 02:07:18 INFO - 'HOME': '/home/cltbld', 02:07:18 INFO - 'LANG': 'en_US.UTF-8', 02:07:18 INFO - 'LANGUAGE': 'en_US:en', 02:07:18 INFO - 'LOGNAME': 'cltbld', 02:07:18 INFO - 'MAIL': '/var/mail/cltbld', 02:07:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:07:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:18 INFO - 'MOZ_NO_REMOTE': '1', 02:07:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:18 INFO - 'NO_EM_RESTART': '1', 02:07:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:18 INFO - 'PWD': '/builds/slave/test', 02:07:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:07:18 INFO - 'SHELL': '/bin/bash', 02:07:18 INFO - 'SHLVL': '1', 02:07:18 INFO - 'TERM': 'linux', 02:07:18 INFO - 'TMOUT': '86400', 02:07:18 INFO - 'USER': 'cltbld', 02:07:18 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168', 02:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:18 INFO - '_': '/tools/buildbot/bin/python'} 02:07:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:07:18 INFO - mozversion application_buildid: 20160809233002 02:07:18 INFO - mozversion application_changeset: 3269dd1a824d1b42cb021d1fb6858885179940b0 02:07:18 INFO - mozversion application_display_name: Nightly 02:07:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:07:18 INFO - mozversion application_name: Firefox 02:07:18 INFO - mozversion application_remotingname: firefox 02:07:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:07:18 INFO - mozversion application_vendor: Mozilla 02:07:18 INFO - mozversion application_version: 51.0a1 02:07:18 INFO - mozversion platform_buildid: 20160809233002 02:07:18 INFO - mozversion platform_changeset: 3269dd1a824d1b42cb021d1fb6858885179940b0 02:07:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:07:18 INFO - mozversion platform_version: 51.0a1 02:07:18 INFO - using testdate: 1470820038 02:07:18 INFO - actual date: 1470820038 02:07:18 INFO - starting webserver on 'localhost:60590' 02:07:18 INFO - SUITE-START | Running 2 tests 02:07:18 INFO - TEST-START | dromaeo_css 02:07:18 INFO - operating with platform_type : linux_ 02:07:18 INFO - Initialising browser for dromaeo_css test... 02:07:18 INFO - TEST-INFO | started process 23158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppkQqzO/profile http://localhost:60590/getInfo.html) 02:07:22 INFO - PROCESS | 23158 | __metrics Screen width/height:1600/1200 02:07:22 INFO - PROCESS | 23158 | colorDepth:24 02:07:22 INFO - PROCESS | 23158 | Browser inner width/height: 1024/697 02:07:22 INFO - PROCESS | 23158 | __metrics 02:07:23 INFO - PROCESS | 23158 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:07:23 INFO - PROCESS | 23158 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:07:24 INFO - TEST-INFO | 23158: exit 0 02:07:24 INFO - Browser initialized. 02:07:24 INFO - Running cycle 1/1 for dromaeo_css test... 02:07:24 INFO - TEST-INFO | started process 23237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppkQqzO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:35 INFO - PROCESS | 23237 | RSS: Main: 155222016 02:07:35 INFO - PROCESS | 23237 | 02:08:26 INFO - PROCESS | 23237 | 1470820106627 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] 02:10:37 INFO - PROCESS | 23237 | Cycle 1(1): loaded http://localhost:60590/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60590/tests/dromaeo/cssquery-ext.html) 02:10:38 INFO - PROCESS | 23237 | RSS: Main: 290701312 02:10:38 INFO - PROCESS | 23237 | 02:13:40 INFO - PROCESS | 23237 | Cycle 1(1): loaded http://localhost:60590/tests/dromaeo/cssquery-ext.html (next: http://localhost:60590/tests/dromaeo/cssquery-jquery.html) 02:13:41 INFO - PROCESS | 23237 | RSS: Main: 239067136 02:13:41 INFO - PROCESS | 23237 | 02:16:43 INFO - PROCESS | 23237 | Cycle 1(1): loaded http://localhost:60590/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60590/tests/dromaeo/cssquery-mootools.html) 02:16:44 INFO - PROCESS | 23237 | RSS: Main: 187142144 02:16:44 INFO - PROCESS | 23237 | 02:19:46 INFO - PROCESS | 23237 | Cycle 1(1): loaded http://localhost:60590/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60590/tests/dromaeo/cssquery-prototype.html) 02:19:46 INFO - PROCESS | 23237 | RSS: Main: 217968640 02:19:46 INFO - PROCESS | 23237 | 02:22:49 INFO - PROCESS | 23237 | Cycle 1(1): loaded http://localhost:60590/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60590/tests/dromaeo/cssquery-yui.html) 02:22:50 INFO - PROCESS | 23237 | RSS: Main: 188440576 02:22:50 INFO - PROCESS | 23237 | 02:25:53 INFO - PROCESS | 23237 | Cycle 1(1): loaded http://localhost:60590/tests/dromaeo/cssquery-yui.html (next: http://localhost:60590/tests/dromaeo/cssquery-dojo.html) 02:25:53 INFO - PROCESS | 23237 | RSS: Main: 275857408 02:25:53 INFO - PROCESS | 23237 | 02:25:53 INFO - PROCESS | 23237 | __start_tp_report 02:25:53 INFO - PROCESS | 23237 | _x_x_mozilla_page_load 02:25:53 INFO - PROCESS | 23237 | _x_x_mozilla_page_load_details 02:25:53 INFO - PROCESS | 23237 | |i|pagename|runs| 02:25:53 INFO - PROCESS | 23237 | |0;dojo.html;3045.4974929136692;3047.771417143714;3074.2007078159677;3086.5833112529817;3090.520969249767;5201.063808514476;5250.921236181461;5286.89426211476;5369.060414427474;5379.139337705968;5302.655327403716;5337.6797392156495;5349.170878513827;5355.036093503168;5412.648177868446;4810.735409552473;4886.511348865103;4891.706497610137;4902.215645496722;4998.825041123561;4895.290182923474;4910.582600478963;4940.382452193476;4957.1820649592955;4965.577925876305;4736.147493451177;4750.738709371018;4762.309465127537;4782.282657601353;4907.582855457291;4771.045790841846;4782.736949467778;4784.354112194878;4822.107910036654;4864.246041863516;4758.167320718895;4806.495317991596;4807.086653535817;4835.685680430761;4895.11887860185;5154.871128221787;5223.4776522347465;5298.231756395339;5327;5380.677159370451;5732.426757324276;5774.393688662672;5776.220210271602;5779.306483221998;5783.103618939072;5753.884922301572;5763.942360576382;5816.563757718188;5817.0983497557945;5833.212516310286;5181.274621553023;5205.141151710001;5241.082810508222;5243.370795504564;5387.0303345397815;5760.107183386582;5768.423157684198;5777.595568310178;5804.709764511842;5809.390014048548;5551.833444996657;5555.055640541118;5599.524040456607;5604.215409842625;5605.831825045255;5568.415316391802;5639.238702775073;5670.886582268332;5701.230333904869;5709.714514274269;5697.886042279131;5702.686352250583;5704.11586204139;5705;5750.539956803445;5664.433556644302;5676.631018983835;5703.344115426696;5709.172170035405;5719.19931209631;4281.400603915455;4289.356596510486;4332.631726303236;4384.342348647729;4402.452909334262;3917.666998305176;3930.3514920037874;3946.980265098656;3949.249642567903;3955.129871428281;5295.788168473218;5336.599755018389;5359;5404.7297635118875;5451.373092094381;5669.914951275734;5673.120666296731;5675.318961724537;5691.4877661010705;5724.084146536534;5328.8401347959625;5338.332708411449;5359.330083739533;5367.892642147213;5439.755211015514;4783.832565860178;4909.2881532177635;4928.088303663762;4939.925901111486;4952.876178095505;5939.109133629903;5943.435373639497;5947.672877991752;5956.255468066492;5996.13056106862;5670.404607516316;5686.744096515584;5718.085106382959;5723.313202415737;5724.0555308375315;5798.33319168301;5820.097884827858;5838.795642152504;5856.824295271149;5933.1396947443245;5543.1408131739645;5566.832995010156;5582.246396736551;5588.692621905834;5635.126555383922;5653.208550802973;5664.631798933056;5669.20631111653;5684.090545512699;5684.090545512699;5382.03123437785;5538.113901775697;5613.298337707786;5657.236273103078;5670.291213598301;5705;5706.514946229617;5707.429257074259;5712.971435142964;5750.913736294043;5666.206731057738;5704;5717.628354156966;5720.628159169807;5723.7424315905055;5472.2338872557075;5636.351819540805;5646.689432081275;5679.687617180929;5789.421057894177;5564.749586268546;5572.164175373564;5596.356419011866;5611.579131565068;5623.746931388016 02:25:53 INFO - PROCESS | 23237 | |1;ext.html;553.022648298297;585.1164741240725;595.4878804228363;601.0773462734703;609.9782863703296;31773.52339714906;42549;43399.56600433995;43448;43462;44050.7797461013;44562.33156502647;44571.108577828425;44577;44611.77694111525;8978.461292322465;9155.084491550859;9170.72487825363;9189.908100918972;9190.448573085636;9027.142421469982;9095.045020272843;9125.813644226275;9126.13301736334;9131.36080474367;9132.497712625804;9152.725418237464;9199.908000919972;9200.309976751736;9211.86182207264;9078.86381704275;9127;9148.679796207167;9154.633814647406;9155.862662060108;9000.099990001014;9062.275017998545;9077.137671921157;9081.182693557612;9081.68214112503;42673.786631066956;43014.78492607548;43061;43065;43130;3679.871204507856;3764.8682296119778;3926.862559810393;3938.4879965604573;4534.206513860095;32420.18949526257;32990.34019319624;33295.83352083224;33387;33496.33007339839;4335.349697545362;4349.978250108761;4432.955670443286;4479.216137175981;4596.4024676791805;348512;348569.99999999744;349582;349625;349711;58519;59276;59310;59641;59654.70172649109;61339.6933015332;61384.693076534335;61484;61499.385006149365;61610;17350.219240134225;17580.38468653591;17589.384371546934;17597;17600.823991759917;13688.93155534216;13720.862791372158;13726.313684315744;13781.931090344684;13784.517541885985;15897;16642.833571664127;16666.83333166677;16792.916035419745;17068.31726730917;6469.741210351627;6592.9340706593275;6863.142107236596;6871.793846184622;6930.653467326613;990.8067926754358;1035.3942943378208;1065.174489770434;1070.4112737994071;1105.9778804423865;32547.51178732321;32749.67250327514;32848;32938.44159327654;33010.504842427385;1100.7193165742685;1115.297362661518;1124.8931351521592;1153.9249948753304;1169.3919162035693;16894.239759210865;17088.829111708972;17099.487015389557;17109.657806843792;17347;543430;545400;547799;548757;549266;58383;58448;58522.7073864628;58607.413925861045;58634;1218.3238302741886;1347.2522749873915;1375.7523645743663;1407.5566196648228;1417.7377185220766;32410.351792963538;33969.66030339665;34430.13924651803;34444.65555344414;34618.82690586531;50830.74584627053;51250.23124653208;51344.74327628338;51395;51463.742681287855;319964;320445;320745;321933;322334;32972.87529483368;34291.58110882969;35448.645513544536;41211.38182927199;41855.58144418517;46379;47546.28680569725;47907.520924790304;47967;48096.51903480921;39649;41367.793161034;41650.58349416467;41734;43119.1376172481;41683.7915810419;41694.79152604217;41890.58109418989;42463.5753642472;43197;31517.745104410613;40655;41554.37668435036;42375.57624423716;44953.32570011387;34912.47631285583;36874.8156259217;37376.62623373731;37552;37945.62054379421;28256.85871570629;28584.857075714488;28697.28256793597;28754.424911501235;28986.27534311659 02:25:53 INFO - PROCESS | 23237 | |2;jquery.html;352.4888911078936;371.6784980991442;388.976661400316;390.3812457255251;402.9838806447742;15664;17808.64382712345;19633.803661963375;20022.1991120355;20463.386098417035;18447.354342598013;18974.715379269288;19802;20275.898620506912;20304.086316115772;5279.234510995903;5307.52232299093;5329.680219186852;5476.507114359707;5479.53423958964;5165.7158856262895;5315.813946511873;5324.094903866333;5326.973365133188;5330.040592693314;3915.804209789513;4103.1793641271715;4103.733257338264;5616.803411880585;5917.467427931507;5924.259467566554;5925.88148237035;5946.732397042122;5947.732352044169;7132.714691412337;7220.530665506778;7267.49127561071;7392.96303518479;7395.149557800868;7399.038125043764;27141.592876106875;27335.589966150525;27484.03805866785;27574;27653.446931061466;2573.163721790426;2710.905118320869;2755.338718707496;3175.2696879717564;3341.766076374655;16001.759973600289;16105;16653;16714;16834.915825420918;1953.134682020761;2037.0527704617425;2108.2410332280365;2180.90185941633;2211.4139752965475;80261;85902;88143.11856881413;92939.53530232373;97543.51228243884;16007.439739609057;17614.647707046042;18125.093745312683;18126;18211.72682409765;31769.682303176673;32802.343953120806;32843.34313313768;32897.177570560925;32977.34045319128;9732.951335243279;9778.315517913677;9828.459434731016;9985.60057597688;10373.170146388271;7968.561729104839;7991.680332786624;8038;8257.463264887883;8293.875591866126;8983;9090.636374545076;9140;9144.771380715536;9374.343795934356;3172.53998170264;3213.3091385352263;3251.5122731589977;3427.5715535558056;3639.6906262967946;988.8566157907208;1010.9848352274722;1045.1064339989352;1069.25152393325;1077.1275267033727;20046.89976550108;20567.38297851067;20759.273425430038;20852.582948340947;20853.96469432531;996.3125443444001;1008.1481148429565;1020.9795804083876;1048.5858086055964;1061.315451533772;9754.512274386252;11155.888441115647;11259.55818820192;11296.096312294996;11381;465122;469898;485940;496755;499420;89630.55184724035;93663.53168234116;95205.5239723797;95309.52345238229;95892;962.9807403851884;969.7769513012047;982.9852552211722;991.3556188477403;993.9204863610894;17264.654706906043;17765.378211763044;17934.820651793838;18086.366977155736;18313.725294120333;41140;42414;42466.78766606147;42649;42970.92572685708;58034.4196558029;58531.70734146302;58665.052517726464;58753.70623147028;60549.69725151346;8795.956020219857;8837.160469755363;8968.551572421484;9116.680916167903;9154.176124148858;12885.677858053248;13207.405666744828;13260.80108798388;13497.325133743077;13760.655983600089;11709.824352634547;11829.231099978473;11892.167548271538;11895.881041189477;12044.277343359427;11518.136139789382;11548.364839933549;11554.191206615793;11891.583794567148;11942.641720748392;11901.51231096113;11963.102767292314;11982.58060967862;12020.579279725167;12375.133740638068;8879.156480134377;8928.51805728518;9194.816103678022;9212.216961558075;9306.162445379949;10907.727306817393;11403.600873969372;11729.237599556001;11992.220505667105;12009.39953002329 02:25:53 INFO - PROCESS | 23237 | |3;mootools.html;1243.3099629705516;1261.3125846413704;1312.5734136405665;1387.9514217002406;1720.6988776964029;8468.491890486568;8805.515696636683;8841.204291613762;9168;9197.356185067049;9018.09819018098;9111.453312801237;9121.452712837234;9122.27021838253;9134.314926380515;2361.586722323595;2383.1420688552107;2386.7016622922133;2391.5695174868515;2392;2350.8589484630975;2413.9758602414013;2415.4685969086772;2419.358869899478;2423.8545687258734;2367.029517897662;2368.7749663781915;2379.7144342678903;2398.20859116492;2406.5186962607463;2279.589673858705;2286.588414085464;2306.2850516339904;2314.5023819878807;2381.7499162588024;2271.0915633746467;2295.2999335202758;2301.1485750272504;2303.1823702585675;2303.7120359955006;9000.729978100668;9174.357794954356;9214.723558293195;9245;9248.907510924872;5284.630075894689;5413.648112872651;5419.674819510803;5422.267993820823;5429.67421954684;3584.8924532264073;3585.8924232273075;3650.7079433645245;3658.1037645776687;3679.22736225393;1112.6995711158022;1119.216548416104;1154.1401655766424;1154.7344110854467;1164.0745607242263;12925.224486530838;12927.353632318347;12945.741085178244;13006.804897926539;13034.80447793284;4342.261815491311;4409.382686423904;4569.862904112882;4590.449146102489;4600.35595016698;9791.755206119904;9839.655612053544;9847.704568862946;9849.310548261696;9850.359726617748;5298.682079075268;5299.231611416323;5306.602004849652;5309.044372012998;5314.946850531523;4062.5734297898885;4345.391645169679;4481.708688935209;4940.110780059624;4999.600031997432;3869.361555343337;3905.6484916357663;3981.5222173338807;4006.4791577094793;4006.8397264109694;1175.9294442333317;1195.8684544700077;1199.622119032502;1204.9397530123458;1207.2997661356392;928.7817362919709;991.6430085169334;1007.8538611901233;1028.5937054863286;1050.9579616815395;6056;6092.208012958287;6307.590006649553;6367.076679148183;6610.4050635443045;462.64607575204997;477.96893201941765;480.38510706295995;486.17835857400877;490.872373182975;4201.6008479194425;4295.613394794484;4303.225419424471;4338.717983331137;4340.066885619543;11278.266912650815;11728.824067638821;11747.88252117485;11755.588554400554;11806.52773889052;11017.44912754375;11561.653150405502;11596.478158482889;11605.825912611317;11618.88381116195;8442.451240669337;8592.570371481526;8625.870611940825;8636.611352489153;8648;6249.218847644044;6257.906131408124;6330.461910737455;6370.331115233019;6458.483321334376;10611.89388106109;10786.137109031415;10813.080888124283;10828;10955.178361622751;9554.235661147231;10593.841092383465;10830.566777328819;11112.888871111185;11113.277636953571;7864.2922137007945;8079.8384032317845;8153.551554664313;8363.95818020906;8366.581670916308;8814.64741410362;8864.73405797827;8869.64521419136;8942;8998.460092394478;7982.680692772224;7984.560849153352;8025.759227223192;8173.5504547250475;8390.412671112963;7880.408969327209;7880.763577092696;7932.206779322021;7961.761147165595;8046.959765201136;7127.75052873147;7250.238724933806;7264.382527485223;7264.455165862687;7271.745488907863;5235.764390602356;5375.865603359947;5492.368377636623;5520.972395137998;5689.118186681071;5351.625386222927;5376.166694162411;5408.54027407659;5440.619156658996;5546.372819100188 02:25:53 INFO - PROCESS | 23237 | |4;prototype.html;317.7696170276551;327.54471284913967;334.04915294679085;337.1537441023032;340.8585437043627;5094.974525127378;5196.96060787843;5235.973820130899;5284;5285.339332583427;5154.144507977126;5188.8702782430455;5211.739413029352;5219.9478005220035;5224.712640804754;4141.813618387165;4143;4149.336106223005;4151.605597468236;4166.500019997589;3918.1771827916173;4047.291723948312;4129.648979836717;4133.379993001044;4154.089119005246;4032.516098068236;4041.1917616476676;4041.191761647682;4046.341000189923;4064.5935406459266;4029.7783621900635;4030.0454279674336;4034.233495635849;4037.1723796621623;4068.247374235776;3632.872849450283;3639.5632524097277;3647.1611529348133;3653.2328211075705;3654.9269014619827;5035.672681275705;5043.571296439807;5059.974700126476;5080.568151707109;5108.335916330853;4620.8151673933;4622.075584883037;4622.098690755304;4633.32816741574;4635.6986795858165;5388.78444862205;5391.595630327741;5410.024486532391;5423.728813559345;5446.809361672362;3835.6931445484292;3904.902377440558;3944.5660977292473;3944.5858184890462;3957.3272543667645;5577.386487486373;5595.944040559583;5596.468335508121;5603.439656034405;5638.689872057035;4022.431251811796;4029.9119237806212;4035.6973227008093;4039.7576145431367;4057.2494088593703;3949.229900169497;4030.6170913763144;4038.990252436891;4070.1249231414795;4101.302778527657;4600.585947264695;4611.792469338888;4623.144718227139;4639.37368455261;4646.907061858744;5373.973130134403;5423.620346575781;5463.562914966793;5481.917771233435;5500.3949565547755;1291.9354032298347;1317.703516708752;1342.7381660576289;1347.690031292808;1349.9807645227986;910.3036177324352;930.5905401623264;947.9715608531756;951.6241084771476;952.0812416018437;5178.870528236825;5189.7405129743365;5190.974045129826;5197.766100525486;5200.479952004769;5455.290812194468;5470.91793623096;5474.233607294982;5532.474414930575;5542.087979647015;4972.8756781080765;5166.948330516647;5175.611829112756;5194.740262986836;5197.636165468457;2563.2182184433927;2580.316216202708;2585.289045512499;2592.546304396723;2622.645942797736;4991.251312303184;5006.499350064964;5010.248462730547;5013.543363751808;5036.230073459583;4704.95295047052;4947.406311242674;4952.554270115635;4980.477049909779;5000.249912530585;5002.624803139779;5032.559208783737;5054.292399064134;5066.125533552609;5091.84724458252;4879.341288926092;4885.218365061573;4898.681585697061;4907.190313598217;4935.728534930613;4511.233090374579;4849.927251091166;4861.229099413301;4884.340614017062;4899.04468628614;5027.773750181177;5036.269740887624;5041.823536176216;5054.848354549369;5093.668911520739;3612.8193590320902;3634.9818250908575;3639.4168536686625;3663.908402289964;3684.207895302523;4911.238757992517;4911.975440122919;4936.925946110883;5137.743112844268;5534.861628459321;5366.0877650798675;5404.243405923095;5425.891482170414;5432.370288913389;5432.511074003359;5421.376541697755;5430.8099216527235;5539.6150962259435;5550.333959924835;5567.8886422272135;5281.920771188512;5373.489518495737;5439.401665816836;5445.809396671098;5539.695316757456;5454.290942177491;5461.508464238238;5466.890662186814;5485.4640700603895;5492.841616070696;5284.392294885984;5415.810446634349;5431.701256430934;5435.211894275229;5441.28599491159 02:25:53 INFO - PROCESS | 23237 | |5;yui.html;766.2031487253257;793.1315209845221;813.6948644258404;814.8818421328912;841.0538144587341;15793.526194214162;16490.67018659626;16866.831331686695;16893.070881101536;16924.661506769873;15567.922160389182;15595.1422671753;15712.764308535352;15758.448454304102;15785.368585256605;669.8894682377402;823.4976664234827;836.6444261189001;838.0948575538434;838.9874151887726;803.2489622203229;834.3033566971556;835.5822088955522;838.4340570115178;839.8194388206534;891.0109778146252;891.5052146058935;893.1024320557863;893.4862454088925;893.5755516129851;507.3404574053752;880.295763389286;882.0694167653091;882.9426087304337;885.5085427587686;621.4779585148452;622.6699849079995;625.0468036244717;626.4017862940881;629.6033498895666;14308.856911430961;14317.928410357881;14326.785098223534;14347.85652143486;14357.851371890223;14253;14539.927300363537;14950.62623434412;15220.695586088326;15328.616784580363;13842.238676872768;13852.93073534636;14021.929890350584;14104.929475352661;14620.561383158521;4556.863294101182;4665.650076244296;4695.849516868355;4791.9520804791855;4815.951840481585;85303.57348213281;85964.57017714871;86198.5690071552;86295.13704862933;86458.5677071617;9956.502174891226;10963.232573719763;11105.222634415513;11281.097512199005;11601.941990289995;21731.23940662069;21952.45118872041;22119.44701382478;22163;22271.220507282167;8207.877091075647;8306.169383061646;8445.535495547681;8452.535110568855;8586.22723954847;4683.1336202802595;4752.3584316116885;4901.411830580353;4970.304157417964;5070.847874563769;3428.502867084259;3550.1657110578994;3553.9644603553634;3677.7057835373107;3835.1562656215588;657.7829316325601;662.4898827902488;668.6322522612544;682.1643486728717;685.8353995041155;715.8282012317111;719.6509692798988;733.0104359115259;760.8820632801925;789.5223389849174;10197.847032294521;10306.896931030744;10597.523111460003;10863.45682715861;10925.541753105488;633.9936600634027;689.6276010954028;700.5376451541957;719.6150059718026;722.584513904507;4897.755112244374;5025.422076461181;5034.924476132861;5188.792448302026;5228.346456692913;71164;71228;71792.64103679448;93387;125736.37131814282;109465.45267273772;110408.4479577597;114680;115351;120101.39949300197;98666.50666746621;98715;100334;100945;102508;9255.490947997656;9630.807383852423;9720.368176068532;9744.658936937456;9836.21310295189;59209.70395147997;59841.401585983585;60841.39158608357;60954.39045609487;61960.69019654873;81267;85136;89350;89902.55048724975;92465.07534924564;12416.441260143134;12486.125971182293;12719.55481558141;12734.108612397415;12768.872311276768;13426.328683565978;13755.10591811529;13962.79055814184;14671.853281467476;14727.337269823098;7627.733029343946;12819.807702884278;13450.12574182675;13842.792358114435;14429.567112986628;14033.29833508341;14068.94482913806;14117.2941352934;14276.643083922985;15130.924345378202;14010.509632162826;14366.56334366555;14411.567652970427;14785.11289322644;14943.402263909322;10713.946430267799;11107.666769996913;11182.608608698656;11486.195966282614;11592.594259200887;10956.726081848017;11528.250663706833;11631.302121872377;11778.46996885125;12307.20003199789 02:25:53 INFO - PROCESS | 23237 | __end_tp_report 02:25:53 INFO - PROCESS | 23237 | __start_cc_report 02:25:53 INFO - PROCESS | 23237 | _x_x_mozilla_cycle_collect,1208 02:25:53 INFO - PROCESS | 23237 | __end_cc_report 02:25:53 INFO - PROCESS | 23237 | __startTimestamp1470821153488__endTimestamp 02:25:53 INFO - PROCESS | 23237 | 02:25:53 INFO - PROCESS | 23237 | ------- Summary: start ------- 02:25:53 INFO - PROCESS | 23237 | Number of tests: 6 02:25:53 INFO - PROCESS | 23237 | 02:25:53 INFO - PROCESS | 23237 | [#0] dojo.html Cycles:165 Average:5305.80 Median:5566.83 stddev:608.57 (10.9%) stddev-sans-first:584.03 02:25:53 INFO - PROCESS | 23237 | Values: 3045.5 3047.8 3074.2 3086.6 3090.5 5201.1 5250.9 5286.9 5369.1 5379.1 5302.7 5337.7 5349.2 5355.0 5412.6 4810.7 4886.5 4891.7 4902.2 4998.8 4895.3 4910.6 4940.4 4957.2 4965.6 4736.1 4750.7 4762.3 4782.3 4907.6 4771.0 4782.7 4784.4 4822.1 4864.2 4758.2 4806.5 4807.1 4835.7 4895.1 5154.9 5223.5 5298.2 5327.0 5380.7 5732.4 5774.4 5776.2 5779.3 5783.1 5753.9 5763.9 5816.6 5817.1 5833.2 5181.3 5205.1 5241.1 5243.4 5387.0 5760.1 5768.4 5777.6 5804.7 5809.4 5551.8 5555.1 5599.5 5604.2 5605.8 5568.4 5639.2 5670.9 5701.2 5709.7 5697.9 5702.7 5704.1 5705.0 5750.5 5664.4 5676.6 5703.3 5709.2 5719.2 4281.4 4289.4 4332.6 4384.3 4402.5 3917.7 3930.4 3947.0 3949.2 3955.1 5295.8 5336.6 5359.0 5404.7 5451.4 5669.9 5673.1 5675.3 5691.5 5724.1 5328.8 5338.3 5359.3 5367.9 5439.8 4783.8 4909.3 4928.1 4939.9 4952.9 5939.1 5943.4 5947.7 5956.3 5996.1 5670.4 5686.7 5718.1 5723.3 5724.1 5798.3 5820.1 5838.8 5856.8 5933.1 5543.1 5566.8 5582.2 5588.7 5635.1 5653.2 5664.6 5669.2 5684.1 5684.1 5382.0 5538.1 5613.3 5657.2 5670.3 5705.0 5706.5 5707.4 5713.0 5750.9 5666.2 5704.0 5717.6 5720.6 5723.7 5472.2 5636.4 5646.7 5679.7 5789.4 5564.7 5572.2 5596.4 5611.6 5623.7 02:25:53 INFO - PROCESS | 23237 | 02:25:53 INFO - PROCESS | 23237 | [#1] ext.html Cycles:180 Average:57782.19 Median:42506.29 stddev:110702.03 (260.4%) stddev-sans-first:110929.19 02:25:53 INFO - PROCESS | 23237 | Values: 553.0 585.1 595.5 601.1 610.0 31773.5 42549.0 43399.6 43448.0 43462.0 44050.8 44562.3 44571.1 44577.0 44611.8 8978.5 9155.1 9170.7 9189.9 9190.4 9027.1 9095.0 9125.8 9126.1 9131.4 9132.5 9152.7 9199.9 9200.3 9211.9 9078.9 9127.0 9148.7 9154.6 9155.9 9000.1 9062.3 9077.1 9081.2 9081.7 42673.8 43014.8 43061.0 43065.0 43130.0 3679.9 3764.9 3926.9 3938.5 4534.2 32420.2 32990.3 33295.8 33387.0 33496.3 4335.3 4350.0 4433.0 4479.2 4596.4 348512.0 348570.0 349582.0 349625.0 349711.0 58519.0 59276.0 59310.0 59641.0 59654.7 61339.7 61384.7 61484.0 61499.4 61610.0 17350.2 17580.4 17589.4 17597.0 17600.8 13688.9 13720.9 13726.3 13781.9 13784.5 15897.0 16642.8 16666.8 16792.9 17068.3 6469.7 6592.9 6863.1 6871.8 6930.7 990.8 1035.4 1065.2 1070.4 1106.0 32547.5 32749.7 32848.0 32938.4 33010.5 1100.7 1115.3 1124.9 1153.9 1169.4 16894.2 17088.8 17099.5 17109.7 17347.0 543430.0 545400.0 547799.0 548757.0 549266.0 58383.0 58448.0 58522.7 58607.4 58634.0 1218.3 1347.3 1375.8 1407.6 1417.7 32410.4 33969.7 34430.1 34444.7 34618.8 50830.7 51250.2 51344.7 51395.0 51463.7 319964.0 320445.0 320745.0 321933.0 322334.0 32972.9 34291.6 35448.6 41211.4 41855.6 46379.0 47546.3 47907.5 47967.0 48096.5 39649.0 41367.8 41650.6 41734.0 43119.1 41683.8 41694.8 41890.6 42463.6 43197.0 31517.7 40655.0 41554.4 42375.6 44953.3 34912.5 36874.8 37376.6 37552.0 37945.6 28256.9 28584.9 28697.3 28754.4 28986.3 02:25:53 INFO - PROCESS | 23237 | 02:25:53 INFO - PROCESS | 23237 | [#2] jquery.html Cycles:180 Average:30443.83 Median:3384.67 stddev:79790.13 (2357.4%) stddev-sans-first:79981.97 02:25:53 INFO - PROCESS | 23237 | Values: 352.5 371.7 389.0 390.4 403.0 15664.0 17808.6 19633.8 20022.2 20463.4 18447.4 18974.7 19802.0 20275.9 20304.1 5279.2 5307.5 5329.7 5476.5 5479.5 5165.7 5315.8 5324.1 5327.0 5330.0 3915.8 4103.2 4103.7 5616.8 5917.5 5924.3 5925.9 5946.7 5947.7 7132.7 7220.5 7267.5 7393.0 7395.1 7399.0 27141.6 27335.6 27484.0 27574.0 27653.4 2573.2 2710.9 2755.3 3175.3 3341.8 16001.8 16105.0 16653.0 16714.0 16834.9 1953.1 2037.1 2108.2 2180.9 2211.4 80261.0 85902.0 88143.1 92939.5 97543.5 16007.4 17614.6 18125.1 18126.0 18211.7 31769.7 32802.3 32843.3 32897.2 32977.3 9733.0 9778.3 9828.5 9985.6 10373.2 7968.6 7991.7 8038.0 8257.5 8293.9 8983.0 9090.6 9140.0 9144.8 9374.3 3172.5 3213.3 3251.5 3427.6 3639.7 988.9 1011.0 1045.1 1069.3 1077.1 20046.9 20567.4 20759.3 20852.6 20854.0 996.3 1008.1 1021.0 1048.6 1061.3 9754.5 11155.9 11259.6 11296.1 11381.0 465122.0 469898.0 485940.0 496755.0 499420.0 89630.6 93663.5 95205.5 95309.5 95892.0 963.0 969.8 983.0 991.4 993.9 17264.7 17765.4 17934.8 18086.4 18313.7 41140.0 42414.0 42466.8 42649.0 42970.9 58034.4 58531.7 58665.1 58753.7 60549.7 8796.0 8837.2 8968.6 9116.7 9154.2 12885.7 13207.4 13260.8 13497.3 13760.7 11709.8 11829.2 11892.2 11895.9 12044.3 11518.1 11548.4 11554.2 11891.6 11942.6 11901.5 11963.1 11982.6 12020.6 12375.1 8879.2 8928.5 9194.8 9212.2 9306.2 10907.7 11403.6 11729.2 11992.2 12009.4 02:25:53 INFO - PROCESS | 23237 | 02:25:53 INFO - PROCESS | 23237 | [#3] mootools.html Cycles:180 Average:5990.08 Median:470.31 stddev:3493.53 (742.8%) stddev-sans-first:3485.11 02:25:53 INFO - PROCESS | 23237 | Values: 1243.3 1261.3 1312.6 1388.0 1720.7 8468.5 8805.5 8841.2 9168.0 9197.4 9018.1 9111.5 9121.5 9122.3 9134.3 2361.6 2383.1 2386.7 2391.6 2392.0 2350.9 2414.0 2415.5 2419.4 2423.9 2367.0 2368.8 2379.7 2398.2 2406.5 2279.6 2286.6 2306.3 2314.5 2381.7 2271.1 2295.3 2301.1 2303.2 2303.7 9000.7 9174.4 9214.7 9245.0 9248.9 5284.6 5413.6 5419.7 5422.3 5429.7 3584.9 3585.9 3650.7 3658.1 3679.2 1112.7 1119.2 1154.1 1154.7 1164.1 12925.2 12927.4 12945.7 13006.8 13034.8 4342.3 4409.4 4569.9 4590.4 4600.4 9791.8 9839.7 9847.7 9849.3 9850.4 5298.7 5299.2 5306.6 5309.0 5314.9 4062.6 4345.4 4481.7 4940.1 4999.6 3869.4 3905.6 3981.5 4006.5 4006.8 1175.9 1195.9 1199.6 1204.9 1207.3 928.8 991.6 1007.9 1028.6 1051.0 6056.0 6092.2 6307.6 6367.1 6610.4 462.6 478.0 480.4 486.2 490.9 4201.6 4295.6 4303.2 4338.7 4340.1 11278.3 11728.8 11747.9 11755.6 11806.5 11017.4 11561.7 11596.5 11605.8 11618.9 8442.5 8592.6 8625.9 8636.6 8648.0 6249.2 6257.9 6330.5 6370.3 6458.5 10611.9 10786.1 10813.1 10828.0 10955.2 9554.2 10593.8 10830.6 11112.9 11113.3 7864.3 8079.8 8153.6 8364.0 8366.6 8814.6 8864.7 8869.6 8942.0 8998.5 7982.7 7984.6 8025.8 8173.6 8390.4 7880.4 7880.8 7932.2 7961.8 8047.0 7127.8 7250.2 7264.4 7264.5 7271.7 5235.8 5375.9 5492.4 5521.0 5689.1 5351.6 5376.2 5408.5 5440.6 5546.4 02:25:53 INFO - PROCESS | 23237 | 02:25:53 INFO - PROCESS | 23237 | [#4] prototype.html Cycles:180 Average:4439.88 Median:5004.56 stddev:1283.48 (25.6%) stddev-sans-first:1249.23 02:25:53 INFO - PROCESS | 23237 | Values: 317.8 327.5 334.0 337.2 340.9 5095.0 5197.0 5236.0 5284.0 5285.3 5154.1 5188.9 5211.7 5219.9 5224.7 4141.8 4143.0 4149.3 4151.6 4166.5 3918.2 4047.3 4129.6 4133.4 4154.1 4032.5 4041.2 4041.2 4046.3 4064.6 4029.8 4030.0 4034.2 4037.2 4068.2 3632.9 3639.6 3647.2 3653.2 3654.9 5035.7 5043.6 5060.0 5080.6 5108.3 4620.8 4622.1 4622.1 4633.3 4635.7 5388.8 5391.6 5410.0 5423.7 5446.8 3835.7 3904.9 3944.6 3944.6 3957.3 5577.4 5595.9 5596.5 5603.4 5638.7 4022.4 4029.9 4035.7 4039.8 4057.2 3949.2 4030.6 4039.0 4070.1 4101.3 4600.6 4611.8 4623.1 4639.4 4646.9 5374.0 5423.6 5463.6 5481.9 5500.4 1291.9 1317.7 1342.7 1347.7 1350.0 910.3 930.6 948.0 951.6 952.1 5178.9 5189.7 5191.0 5197.8 5200.5 5455.3 5470.9 5474.2 5532.5 5542.1 4972.9 5166.9 5175.6 5194.7 5197.6 2563.2 2580.3 2585.3 2592.5 2622.6 4991.3 5006.5 5010.2 5013.5 5036.2 4705.0 4947.4 4952.6 4980.5 5000.2 5002.6 5032.6 5054.3 5066.1 5091.8 4879.3 4885.2 4898.7 4907.2 4935.7 4511.2 4849.9 4861.2 4884.3 4899.0 5027.8 5036.3 5041.8 5054.8 5093.7 3612.8 3635.0 3639.4 3663.9 3684.2 4911.2 4912.0 4936.9 5137.7 5534.9 5366.1 5404.2 5425.9 5432.4 5432.5 5421.4 5430.8 5539.6 5550.3 5567.9 5281.9 5373.5 5439.4 5445.8 5539.7 5454.3 5461.5 5466.9 5485.5 5492.8 5284.4 5415.8 5431.7 5435.2 5441.3 02:25:53 INFO - PROCESS | 23237 | 02:25:53 INFO - PROCESS | 23237 | [#5] yui.html Cycles:180 Average:21897.70 Median:4724.10 stddev:31642.12 (669.8%) stddev-sans-first:31691.11 02:25:53 INFO - PROCESS | 23237 | Values: 766.2 793.1 813.7 814.9 841.1 15793.5 16490.7 16866.8 16893.1 16924.7 15567.9 15595.1 15712.8 15758.4 15785.4 669.9 823.5 836.6 838.1 839.0 803.2 834.3 835.6 838.4 839.8 891.0 891.5 893.1 893.5 893.6 507.3 880.3 882.1 882.9 885.5 621.5 622.7 625.0 626.4 629.6 14308.9 14317.9 14326.8 14347.9 14357.9 14253.0 14539.9 14950.6 15220.7 15328.6 13842.2 13852.9 14021.9 14104.9 14620.6 4556.9 4665.7 4695.8 4792.0 4816.0 85303.6 85964.6 86198.6 86295.1 86458.6 9956.5 10963.2 11105.2 11281.1 11601.9 21731.2 21952.5 22119.4 22163.0 22271.2 8207.9 8306.2 8445.5 8452.5 8586.2 4683.1 4752.4 4901.4 4970.3 5070.8 3428.5 3550.2 3554.0 3677.7 3835.2 657.8 662.5 668.6 682.2 685.8 715.8 719.7 733.0 760.9 789.5 10197.8 10306.9 10597.5 10863.5 10925.5 634.0 689.6 700.5 719.6 722.6 4897.8 5025.4 5034.9 5188.8 5228.3 71164.0 71228.0 71792.6 93387.0 125736.4 109465.5 110408.4 114680.0 115351.0 120101.4 98666.5 98715.0 100334.0 100945.0 102508.0 9255.5 9630.8 9720.4 9744.7 9836.2 59209.7 59841.4 60841.4 60954.4 61960.7 81267.0 85136.0 89350.0 89902.6 92465.1 12416.4 12486.1 12719.6 12734.1 12768.9 13426.3 13755.1 13962.8 14671.9 14727.3 7627.7 12819.8 13450.1 13842.8 14429.6 14033.3 14068.9 14117.3 14276.6 15130.9 14010.5 14366.6 14411.6 14785.1 14943.4 10713.9 11107.7 11182.6 11486.2 11592.6 10956.7 11528.3 11631.3 11778.5 12307.2 02:25:53 INFO - PROCESS | 23237 | -------- Summary: end -------- 02:25:53 INFO - PROCESS | 23237 | 02:25:54 INFO - TEST-INFO | 23237: exit 0 02:25:54 INFO - TEST-OK | dromaeo_css | took 1115673ms 02:25:54 INFO - TEST-START | kraken 02:25:54 INFO - operating with platform_type : linux_ 02:25:54 INFO - Initialising browser for kraken test... 02:25:54 INFO - TEST-INFO | started process 23435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphEwty3/profile http://localhost:60590/getInfo.html) 02:25:57 INFO - PROCESS | 23435 | __metrics Screen width/height:1600/1200 02:25:57 INFO - PROCESS | 23435 | colorDepth:24 02:25:57 INFO - PROCESS | 23435 | Browser inner width/height: 1024/697 02:25:57 INFO - PROCESS | 23435 | __metrics 02:25:58 INFO - PROCESS | 23435 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:25:58 INFO - PROCESS | 23435 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:25:59 INFO - TEST-INFO | 23435: exit 0 02:25:59 INFO - Browser initialized. 02:25:59 INFO - Running cycle 1/1 for kraken test... 02:25:59 INFO - TEST-INFO | started process 23517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphEwty3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:11 INFO - PROCESS | 23517 | RSS: Main: 155824128 02:26:11 INFO - PROCESS | 23517 | 02:26:13 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60590/tests/kraken/driver.html?testName=audio-beat-detection) 02:26:14 INFO - PROCESS | 23517 | RSS: Main: 212221952 02:26:14 INFO - PROCESS | 23517 | 02:26:17 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60590/tests/kraken/driver.html?testName=audio-dft) 02:26:17 INFO - PROCESS | 23517 | RSS: Main: 191299584 02:26:17 INFO - PROCESS | 23517 | 02:26:20 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60590/tests/kraken/driver.html?testName=audio-fft) 02:26:21 INFO - PROCESS | 23517 | RSS: Main: 268140544 02:26:21 INFO - PROCESS | 23517 | 02:26:23 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60590/tests/kraken/driver.html?testName=audio-oscillator) 02:26:24 INFO - PROCESS | 23517 | RSS: Main: 178790400 02:26:24 INFO - PROCESS | 23517 | 02:26:26 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60590/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:26:26 INFO - PROCESS | 23517 | RSS: Main: 182640640 02:26:26 INFO - PROCESS | 23517 | 02:26:29 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60590/tests/kraken/driver.html?testName=imaging-darkroom) 02:26:30 INFO - PROCESS | 23517 | RSS: Main: 219324416 02:26:30 INFO - PROCESS | 23517 | 02:26:33 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60590/tests/kraken/driver.html?testName=imaging-desaturate) 02:26:34 INFO - PROCESS | 23517 | RSS: Main: 218566656 02:26:34 INFO - PROCESS | 23517 | 02:26:37 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60590/tests/kraken/driver.html?testName=json-parse-financial) 02:26:37 INFO - PROCESS | 23517 | RSS: Main: 218480640 02:26:37 INFO - PROCESS | 23517 | 02:26:39 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60590/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:26:39 INFO - PROCESS | 23517 | RSS: Main: 183132160 02:26:39 INFO - PROCESS | 23517 | 02:26:41 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60590/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:26:42 INFO - PROCESS | 23517 | RSS: Main: 187490304 02:26:42 INFO - PROCESS | 23517 | 02:26:44 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60590/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:44 INFO - PROCESS | 23517 | RSS: Main: 192114688 02:26:44 INFO - PROCESS | 23517 | 02:26:47 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:48 INFO - PROCESS | 23517 | RSS: Main: 187400192 02:26:48 INFO - PROCESS | 23517 | 02:26:50 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:26:51 INFO - PROCESS | 23517 | RSS: Main: 191348736 02:26:51 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | Cycle 1(1): loaded http://localhost:60590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60590/tests/kraken/driver.html?testName=ai-astar) 02:26:53 INFO - PROCESS | 23517 | RSS: Main: 242274304 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | __start_tp_report 02:26:53 INFO - PROCESS | 23517 | _x_x_mozilla_page_load 02:26:53 INFO - PROCESS | 23517 | _x_x_mozilla_page_load_details 02:26:53 INFO - PROCESS | 23517 | |i|pagename|runs| 02:26:53 INFO - PROCESS | 23517 | |0;ai-astar;101;110;111;110;114;115;112;111;114;111 02:26:53 INFO - PROCESS | 23517 | |1;audio-beat-detection;146;116;124;185;120;118;149;116;149;116 02:26:53 INFO - PROCESS | 23517 | |2;audio-dft;161;161;161;162;161;159;162;162;160;160 02:26:53 INFO - PROCESS | 23517 | |3;audio-fft;75;76;74;102;74;76;74;74;106;76 02:26:53 INFO - PROCESS | 23517 | |4;audio-oscillator;84;84;132;83;84;84;118;84;84;128 02:26:53 INFO - PROCESS | 23517 | |5;imaging-gaussian-blur;116;116;117;117;117;116;117;117;116;116 02:26:53 INFO - PROCESS | 23517 | |6;imaging-darkroom;145;146;146;146;146;145;146;146;146;146 02:26:53 INFO - PROCESS | 23517 | |7;imaging-desaturate;97;95;94;95;95;95;94;95;94;96 02:26:53 INFO - PROCESS | 23517 | |8;json-parse-financial;51;50;49;50;50;50;51;49;50;50 02:26:53 INFO - PROCESS | 23517 | |9;json-stringify-tinderbox;61;62;61;61;62;63;61;61;61;62 02:26:53 INFO - PROCESS | 23517 | |10;stanford-crypto-aes;77;75;75;75;78;81;86;75;74;75 02:26:53 INFO - PROCESS | 23517 | |11;stanford-crypto-ccm;122;123;127;125;128;122;121;126;147;122 02:26:53 INFO - PROCESS | 23517 | |12;stanford-crypto-pbkdf2;166;161;163;159;163;158;160;161;160;162 02:26:53 INFO - PROCESS | 23517 | |13;stanford-crypto-sha256-iterative;64;63;64;63;66;63;64;68;63;61 02:26:53 INFO - PROCESS | 23517 | __end_tp_report 02:26:53 INFO - PROCESS | 23517 | __start_cc_report 02:26:53 INFO - PROCESS | 23517 | _x_x_mozilla_cycle_collect,1664 02:26:53 INFO - PROCESS | 23517 | __end_cc_report 02:26:53 INFO - PROCESS | 23517 | __startTimestamp1470821213332__endTimestamp 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | ------- Summary: start ------- 02:26:53 INFO - PROCESS | 23517 | Number of tests: 14 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:3.90 (3.5%) stddev-sans-first:1.87 02:26:53 INFO - PROCESS | 23517 | Values: 101.0 110.0 111.0 110.0 114.0 115.0 112.0 111.0 114.0 111.0 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:135.00 stddev:22.90 (17.0%) stddev-sans-first:23.86 02:26:53 INFO - PROCESS | 23517 | Values: 146.0 116.0 124.0 185.0 120.0 118.0 149.0 116.0 149.0 116.0 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 02:26:53 INFO - PROCESS | 23517 | Values: 161.0 161.0 161.0 162.0 161.0 159.0 162.0 162.0 160.0 160.0 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#3] audio-fft Cycles:10 Average:80.70 Median:74.50 stddev:12.35 (16.6%) stddev-sans-first:12.92 02:26:53 INFO - PROCESS | 23517 | Values: 75.0 76.0 74.0 102.0 74.0 76.0 74.0 74.0 106.0 76.0 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:84.00 stddev:20.64 (24.6%) stddev-sans-first:21.39 02:26:53 INFO - PROCESS | 23517 | Values: 84.0 84.0 132.0 83.0 84.0 84.0 118.0 84.0 84.0 128.0 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:26:53 INFO - PROCESS | 23517 | Values: 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 02:26:53 INFO - PROCESS | 23517 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.94 (1.0%) stddev-sans-first:0.67 02:26:53 INFO - PROCESS | 23517 | Values: 97.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 96.0 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:0.67 (1.3%) stddev-sans-first:0.60 02:26:53 INFO - PROCESS | 23517 | Values: 51.0 50.0 49.0 50.0 50.0 50.0 51.0 49.0 50.0 50.0 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 02:26:53 INFO - PROCESS | 23517 | Values: 61.0 62.0 61.0 61.0 62.0 63.0 61.0 61.0 61.0 62.0 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.00 stddev:3.75 (4.9%) stddev-sans-first:3.98 02:26:53 INFO - PROCESS | 23517 | Values: 77.0 75.0 75.0 75.0 78.0 81.0 86.0 75.0 74.0 75.0 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:125.50 stddev:7.66 (6.1%) stddev-sans-first:7.97 02:26:53 INFO - PROCESS | 23517 | Values: 122.0 123.0 127.0 125.0 128.0 122.0 121.0 126.0 147.0 122.0 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.50 stddev:2.31 (1.4%) stddev-sans-first:1.72 02:26:53 INFO - PROCESS | 23517 | Values: 166.0 161.0 163.0 159.0 163.0 158.0 160.0 161.0 160.0 162.0 02:26:53 INFO - PROCESS | 23517 | 02:26:53 INFO - PROCESS | 23517 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.91 (3.0%) stddev-sans-first:2.03 02:26:53 INFO - PROCESS | 23517 | Values: 64.0 63.0 64.0 63.0 66.0 63.0 64.0 68.0 63.0 61.0 02:26:53 INFO - PROCESS | 23517 | -------- Summary: end -------- 02:26:53 INFO - PROCESS | 23517 | 02:26:54 INFO - TEST-INFO | 23517: exit 0 02:26:54 INFO - TEST-OK | kraken | took 60081ms 02:26:54 INFO - SUITE-END | took 1175s 02:26:54 INFO - Completed test suite (00:19:35) 02:26:54 INFO - javascript benchmark 02:26:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3045.4974929136692, 3047.771417143714, 3074.2007078159677, 3086.5833112529817, 3090.520969249767, 5201.063808514476, 5250.921236181461, 5286.89426211476, 5369.060414427474, 5379.139337705968, 5302.655327403716, 5337.6797392156495, 5349.170878513827, 5355.036093503168, 5412.648177868446, 4810.735409552473, 4886.511348865103, 4891.706497610137, 4902.215645496722, 4998.825041123561, 4895.290182923474, 4910.582600478963, 4940.382452193476, 4957.1820649592955, 4965.577925876305, 4736.147493451177, 4750.738709371018, 4762.309465127537, 4782.282657601353, 4907.582855457291, 4771.045790841846, 4782.736949467778, 4784.354112194878, 4822.107910036654, 4864.246041863516, 4758.167320718895, 4806.495317991596, 4807.086653535817, 4835.685680430761, 4895.11887860185, 5154.871128221787, 5223.4776522347465, 5298.231756395339, 5327.0, 5380.677159370451, 5732.426757324276, 5774.393688662672, 5776.220210271602, 5779.306483221998, 5783.103618939072, 5753.884922301572, 5763.942360576382, 5816.563757718188, 5817.0983497557945, 5833.212516310286, 5181.274621553023, 5205.141151710001, 5241.082810508222, 5243.370795504564, 5387.0303345397815, 5760.107183386582, 5768.423157684198, 5777.595568310178, 5804.709764511842, 5809.390014048548, 5551.833444996657, 5555.055640541118, 5599.524040456607, 5604.215409842625, 5605.831825045255, 5568.415316391802, 5639.238702775073, 5670.886582268332, 5701.230333904869, 5709.714514274269, 5697.886042279131, 5702.686352250583, 5704.11586204139, 5705.0, 5750.539956803445, 5664.433556644302, 5676.631018983835, 5703.344115426696, 5709.172170035405, 5719.19931209631, 4281.400603915455, 4289.356596510486, 4332.631726303236, 4384.342348647729, 4402.452909334262, 3917.666998305176, 3930.3514920037874, 3946.980265098656, 3949.249642567903, 3955.129871428281, 5295.788168473218, 5336.599755018389, 5359.0, 5404.7297635118875, 5451.373092094381, 5669.914951275734, 5673.120666296731, 5675.318961724537, 5691.4877661010705, 5724.084146536534, 5328.8401347959625, 5338.332708411449, 5359.330083739533, 5367.892642147213, 5439.755211015514, 4783.832565860178, 4909.2881532177635, 4928.088303663762, 4939.925901111486, 4952.876178095505, 5939.109133629903, 5943.435373639497, 5947.672877991752, 5956.255468066492, 5996.13056106862, 5670.404607516316, 5686.744096515584, 5718.085106382959, 5723.313202415737, 5724.0555308375315, 5798.33319168301, 5820.097884827858, 5838.795642152504, 5856.824295271149, 5933.1396947443245, 5543.1408131739645, 5566.832995010156, 5582.246396736551, 5588.692621905834, 5635.126555383922, 5653.208550802973, 5664.631798933056, 5669.20631111653, 5684.090545512699, 5684.090545512699, 5382.03123437785, 5538.113901775697, 5613.298337707786, 5657.236273103078, 5670.291213598301, 5705.0, 5706.514946229617, 5707.429257074259, 5712.971435142964, 5750.913736294043, 5666.206731057738, 5704.0, 5717.628354156966, 5720.628159169807, 5723.7424315905055, 5472.2338872557075, 5636.351819540805, 5646.689432081275, 5679.687617180929, 5789.421057894177, 5564.749586268546, 5572.164175373564, 5596.356419011866, 5611.579131565068, 5623.746931388016], "value": 5264.268003178023, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.022648298297, 585.1164741240725, 595.4878804228363, 601.0773462734703, 609.9782863703296, 31773.52339714906, 42549.0, 43399.56600433995, 43448.0, 43462.0, 44050.7797461013, 44562.33156502647, 44571.108577828425, 44577.0, 44611.77694111525, 8978.461292322465, 9155.084491550859, 9170.72487825363, 9189.908100918972, 9190.448573085636, 9027.142421469982, 9095.045020272843, 9125.813644226275, 9126.13301736334, 9131.36080474367, 9132.497712625804, 9152.725418237464, 9199.908000919972, 9200.309976751736, 9211.86182207264, 9078.86381704275, 9127.0, 9148.679796207167, 9154.633814647406, 9155.862662060108, 9000.099990001014, 9062.275017998545, 9077.137671921157, 9081.182693557612, 9081.68214112503, 42673.786631066956, 43014.78492607548, 43061.0, 43065.0, 43130.0, 3679.871204507856, 3764.8682296119778, 3926.862559810393, 3938.4879965604573, 4534.206513860095, 32420.18949526257, 32990.34019319624, 33295.83352083224, 33387.0, 33496.33007339839, 4335.349697545362, 4349.978250108761, 4432.955670443286, 4479.216137175981, 4596.4024676791805, 348512.0, 348569.99999999744, 349582.0, 349625.0, 349711.0, 58519.0, 59276.0, 59310.0, 59641.0, 59654.70172649109, 61339.6933015332, 61384.693076534335, 61484.0, 61499.385006149365, 61610.0, 17350.219240134225, 17580.38468653591, 17589.384371546934, 17597.0, 17600.823991759917, 13688.93155534216, 13720.862791372158, 13726.313684315744, 13781.931090344684, 13784.517541885985, 15897.0, 16642.833571664127, 16666.83333166677, 16792.916035419745, 17068.31726730917, 6469.741210351627, 6592.9340706593275, 6863.142107236596, 6871.793846184622, 6930.653467326613, 990.8067926754358, 1035.3942943378208, 1065.174489770434, 1070.4112737994071, 1105.9778804423865, 32547.51178732321, 32749.67250327514, 32848.0, 32938.44159327654, 33010.504842427385, 1100.7193165742685, 1115.297362661518, 1124.8931351521592, 1153.9249948753304, 1169.3919162035693, 16894.239759210865, 17088.829111708972, 17099.487015389557, 17109.657806843792, 17347.0, 543430.0, 545400.0, 547799.0, 548757.0, 549266.0, 58383.0, 58448.0, 58522.7073864628, 58607.413925861045, 58634.0, 1218.3238302741886, 1347.2522749873915, 1375.7523645743663, 1407.5566196648228, 1417.7377185220766, 32410.351792963538, 33969.66030339665, 34430.13924651803, 34444.65555344414, 34618.82690586531, 50830.74584627053, 51250.23124653208, 51344.74327628338, 51395.0, 51463.742681287855, 319964.0, 320445.0, 320745.0, 321933.0, 322334.0, 32972.87529483368, 34291.58110882969, 35448.645513544536, 41211.38182927199, 41855.58144418517, 46379.0, 47546.28680569725, 47907.520924790304, 47967.0, 48096.51903480921, 39649.0, 41367.793161034, 41650.58349416467, 41734.0, 43119.1376172481, 41683.7915810419, 41694.79152604217, 41890.58109418989, 42463.5753642472, 43197.0, 31517.745104410613, 40655.0, 41554.37668435036, 42375.57624423716, 44953.32570011387, 34912.47631285583, 36874.8156259217, 37376.62623373731, 37552.0, 37945.62054379421, 28256.85871570629, 28584.857075714488, 28697.28256793597, 28754.424911501235, 28986.27534311659], "value": 20336.677344611988, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.4888911078936, 371.6784980991442, 388.976661400316, 390.3812457255251, 402.9838806447742, 15664.0, 17808.64382712345, 19633.803661963375, 20022.1991120355, 20463.386098417035, 18447.354342598013, 18974.715379269288, 19802.0, 20275.898620506912, 20304.086316115772, 5279.234510995903, 5307.52232299093, 5329.680219186852, 5476.507114359707, 5479.53423958964, 5165.7158856262895, 5315.813946511873, 5324.094903866333, 5326.973365133188, 5330.040592693314, 3915.804209789513, 4103.1793641271715, 4103.733257338264, 5616.803411880585, 5917.467427931507, 5924.259467566554, 5925.88148237035, 5946.732397042122, 5947.732352044169, 7132.714691412337, 7220.530665506778, 7267.49127561071, 7392.96303518479, 7395.149557800868, 7399.038125043764, 27141.592876106875, 27335.589966150525, 27484.03805866785, 27574.0, 27653.446931061466, 2573.163721790426, 2710.905118320869, 2755.338718707496, 3175.2696879717564, 3341.766076374655, 16001.759973600289, 16105.0, 16653.0, 16714.0, 16834.915825420918, 1953.134682020761, 2037.0527704617425, 2108.2410332280365, 2180.90185941633, 2211.4139752965475, 80261.0, 85902.0, 88143.11856881413, 92939.53530232373, 97543.51228243884, 16007.439739609057, 17614.647707046042, 18125.093745312683, 18126.0, 18211.72682409765, 31769.682303176673, 32802.343953120806, 32843.34313313768, 32897.177570560925, 32977.34045319128, 9732.951335243279, 9778.315517913677, 9828.459434731016, 9985.60057597688, 10373.170146388271, 7968.561729104839, 7991.680332786624, 8038.0, 8257.463264887883, 8293.875591866126, 8983.0, 9090.636374545076, 9140.0, 9144.771380715536, 9374.343795934356, 3172.53998170264, 3213.3091385352263, 3251.5122731589977, 3427.5715535558056, 3639.6906262967946, 988.8566157907208, 1010.9848352274722, 1045.1064339989352, 1069.25152393325, 1077.1275267033727, 20046.89976550108, 20567.38297851067, 20759.273425430038, 20852.582948340947, 20853.96469432531, 996.3125443444001, 1008.1481148429565, 1020.9795804083876, 1048.5858086055964, 1061.315451533772, 9754.512274386252, 11155.888441115647, 11259.55818820192, 11296.096312294996, 11381.0, 465122.0, 469898.0, 485940.0, 496755.0, 499420.0, 89630.55184724035, 93663.53168234116, 95205.5239723797, 95309.52345238229, 95892.0, 962.9807403851884, 969.7769513012047, 982.9852552211722, 991.3556188477403, 993.9204863610894, 17264.654706906043, 17765.378211763044, 17934.820651793838, 18086.366977155736, 18313.725294120333, 41140.0, 42414.0, 42466.78766606147, 42649.0, 42970.92572685708, 58034.4196558029, 58531.70734146302, 58665.052517726464, 58753.70623147028, 60549.69725151346, 8795.956020219857, 8837.160469755363, 8968.551572421484, 9116.680916167903, 9154.176124148858, 12885.677858053248, 13207.405666744828, 13260.80108798388, 13497.325133743077, 13760.655983600089, 11709.824352634547, 11829.231099978473, 11892.167548271538, 11895.881041189477, 12044.277343359427, 11518.136139789382, 11548.364839933549, 11554.191206615793, 11891.583794567148, 11942.641720748392, 11901.51231096113, 11963.102767292314, 11982.58060967862, 12020.579279725167, 12375.133740638068, 8879.156480134377, 8928.51805728518, 9194.816103678022, 9212.216961558075, 9306.162445379949, 10907.727306817393, 11403.600873969372, 11729.237599556001, 11992.220505667105, 12009.39953002329], "value": 10310.831505852724, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1243.3099629705516, 1261.3125846413704, 1312.5734136405665, 1387.9514217002406, 1720.6988776964029, 8468.491890486568, 8805.515696636683, 8841.204291613762, 9168.0, 9197.356185067049, 9018.09819018098, 9111.453312801237, 9121.452712837234, 9122.27021838253, 9134.314926380515, 2361.586722323595, 2383.1420688552107, 2386.7016622922133, 2391.5695174868515, 2392.0, 2350.8589484630975, 2413.9758602414013, 2415.4685969086772, 2419.358869899478, 2423.8545687258734, 2367.029517897662, 2368.7749663781915, 2379.7144342678903, 2398.20859116492, 2406.5186962607463, 2279.589673858705, 2286.588414085464, 2306.2850516339904, 2314.5023819878807, 2381.7499162588024, 2271.0915633746467, 2295.2999335202758, 2301.1485750272504, 2303.1823702585675, 2303.7120359955006, 9000.729978100668, 9174.357794954356, 9214.723558293195, 9245.0, 9248.907510924872, 5284.630075894689, 5413.648112872651, 5419.674819510803, 5422.267993820823, 5429.67421954684, 3584.8924532264073, 3585.8924232273075, 3650.7079433645245, 3658.1037645776687, 3679.22736225393, 1112.6995711158022, 1119.216548416104, 1154.1401655766424, 1154.7344110854467, 1164.0745607242263, 12925.224486530838, 12927.353632318347, 12945.741085178244, 13006.804897926539, 13034.80447793284, 4342.261815491311, 4409.382686423904, 4569.862904112882, 4590.449146102489, 4600.35595016698, 9791.755206119904, 9839.655612053544, 9847.704568862946, 9849.310548261696, 9850.359726617748, 5298.682079075268, 5299.231611416323, 5306.602004849652, 5309.044372012998, 5314.946850531523, 4062.5734297898885, 4345.391645169679, 4481.708688935209, 4940.110780059624, 4999.600031997432, 3869.361555343337, 3905.6484916357663, 3981.5222173338807, 4006.4791577094793, 4006.8397264109694, 1175.9294442333317, 1195.8684544700077, 1199.622119032502, 1204.9397530123458, 1207.2997661356392, 928.7817362919709, 991.6430085169334, 1007.8538611901233, 1028.5937054863286, 1050.9579616815395, 6056.0, 6092.208012958287, 6307.590006649553, 6367.076679148183, 6610.4050635443045, 462.64607575204997, 477.96893201941765, 480.38510706295995, 486.17835857400877, 490.872373182975, 4201.6008479194425, 4295.613394794484, 4303.225419424471, 4338.717983331137, 4340.066885619543, 11278.266912650815, 11728.824067638821, 11747.88252117485, 11755.588554400554, 11806.52773889052, 11017.44912754375, 11561.653150405502, 11596.478158482889, 11605.825912611317, 11618.88381116195, 8442.451240669337, 8592.570371481526, 8625.870611940825, 8636.611352489153, 8648.0, 6249.218847644044, 6257.906131408124, 6330.461910737455, 6370.331115233019, 6458.483321334376, 10611.89388106109, 10786.137109031415, 10813.080888124283, 10828.0, 10955.178361622751, 9554.235661147231, 10593.841092383465, 10830.566777328819, 11112.888871111185, 11113.277636953571, 7864.2922137007945, 8079.8384032317845, 8153.551554664313, 8363.95818020906, 8366.581670916308, 8814.64741410362, 8864.73405797827, 8869.64521419136, 8942.0, 8998.460092394478, 7982.680692772224, 7984.560849153352, 8025.759227223192, 8173.5504547250475, 8390.412671112963, 7880.408969327209, 7880.763577092696, 7932.206779322021, 7961.761147165595, 8046.959765201136, 7127.75052873147, 7250.238724933806, 7264.382527485223, 7264.455165862687, 7271.745488907863, 5235.764390602356, 5375.865603359947, 5492.368377636623, 5520.972395137998, 5689.118186681071, 5351.625386222927, 5376.166694162411, 5408.54027407659, 5440.619156658996, 5546.372819100188], "value": 4665.306762217601, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.7696170276551, 327.54471284913967, 334.04915294679085, 337.1537441023032, 340.8585437043627, 5094.974525127378, 5196.96060787843, 5235.973820130899, 5284.0, 5285.339332583427, 5154.144507977126, 5188.8702782430455, 5211.739413029352, 5219.9478005220035, 5224.712640804754, 4141.813618387165, 4143.0, 4149.336106223005, 4151.605597468236, 4166.500019997589, 3918.1771827916173, 4047.291723948312, 4129.648979836717, 4133.379993001044, 4154.089119005246, 4032.516098068236, 4041.1917616476676, 4041.191761647682, 4046.341000189923, 4064.5935406459266, 4029.7783621900635, 4030.0454279674336, 4034.233495635849, 4037.1723796621623, 4068.247374235776, 3632.872849450283, 3639.5632524097277, 3647.1611529348133, 3653.2328211075705, 3654.9269014619827, 5035.672681275705, 5043.571296439807, 5059.974700126476, 5080.568151707109, 5108.335916330853, 4620.8151673933, 4622.075584883037, 4622.098690755304, 4633.32816741574, 4635.6986795858165, 5388.78444862205, 5391.595630327741, 5410.024486532391, 5423.728813559345, 5446.809361672362, 3835.6931445484292, 3904.902377440558, 3944.5660977292473, 3944.5858184890462, 3957.3272543667645, 5577.386487486373, 5595.944040559583, 5596.468335508121, 5603.439656034405, 5638.689872057035, 4022.431251811796, 4029.9119237806212, 4035.6973227008093, 4039.7576145431367, 4057.2494088593703, 3949.229900169497, 4030.6170913763144, 4038.990252436891, 4070.1249231414795, 4101.302778527657, 4600.585947264695, 4611.792469338888, 4623.144718227139, 4639.37368455261, 4646.907061858744, 5373.973130134403, 5423.620346575781, 5463.562914966793, 5481.917771233435, 5500.3949565547755, 1291.9354032298347, 1317.703516708752, 1342.7381660576289, 1347.690031292808, 1349.9807645227986, 910.3036177324352, 930.5905401623264, 947.9715608531756, 951.6241084771476, 952.0812416018437, 5178.870528236825, 5189.7405129743365, 5190.974045129826, 5197.766100525486, 5200.479952004769, 5455.290812194468, 5470.91793623096, 5474.233607294982, 5532.474414930575, 5542.087979647015, 4972.8756781080765, 5166.948330516647, 5175.611829112756, 5194.740262986836, 5197.636165468457, 2563.2182184433927, 2580.316216202708, 2585.289045512499, 2592.546304396723, 2622.645942797736, 4991.251312303184, 5006.499350064964, 5010.248462730547, 5013.543363751808, 5036.230073459583, 4704.95295047052, 4947.406311242674, 4952.554270115635, 4980.477049909779, 5000.249912530585, 5002.624803139779, 5032.559208783737, 5054.292399064134, 5066.125533552609, 5091.84724458252, 4879.341288926092, 4885.218365061573, 4898.681585697061, 4907.190313598217, 4935.728534930613, 4511.233090374579, 4849.927251091166, 4861.229099413301, 4884.340614017062, 4899.04468628614, 5027.773750181177, 5036.269740887624, 5041.823536176216, 5054.848354549369, 5093.668911520739, 3612.8193590320902, 3634.9818250908575, 3639.4168536686625, 3663.908402289964, 3684.207895302523, 4911.238757992517, 4911.975440122919, 4936.925946110883, 5137.743112844268, 5534.861628459321, 5366.0877650798675, 5404.243405923095, 5425.891482170414, 5432.370288913389, 5432.511074003359, 5421.376541697755, 5430.8099216527235, 5539.6150962259435, 5550.333959924835, 5567.8886422272135, 5281.920771188512, 5373.489518495737, 5439.401665816836, 5445.809396671098, 5539.695316757456, 5454.290942177491, 5461.508464238238, 5466.890662186814, 5485.4640700603895, 5492.841616070696, 5284.392294885984, 5415.810446634349, 5431.701256430934, 5435.211894275229, 5441.28599491159], "value": 4034.7549532978937, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.2031487253257, 793.1315209845221, 813.6948644258404, 814.8818421328912, 841.0538144587341, 15793.526194214162, 16490.67018659626, 16866.831331686695, 16893.070881101536, 16924.661506769873, 15567.922160389182, 15595.1422671753, 15712.764308535352, 15758.448454304102, 15785.368585256605, 669.8894682377402, 823.4976664234827, 836.6444261189001, 838.0948575538434, 838.9874151887726, 803.2489622203229, 834.3033566971556, 835.5822088955522, 838.4340570115178, 839.8194388206534, 891.0109778146252, 891.5052146058935, 893.1024320557863, 893.4862454088925, 893.5755516129851, 507.3404574053752, 880.295763389286, 882.0694167653091, 882.9426087304337, 885.5085427587686, 621.4779585148452, 622.6699849079995, 625.0468036244717, 626.4017862940881, 629.6033498895666, 14308.856911430961, 14317.928410357881, 14326.785098223534, 14347.85652143486, 14357.851371890223, 14253.0, 14539.927300363537, 14950.62623434412, 15220.695586088326, 15328.616784580363, 13842.238676872768, 13852.93073534636, 14021.929890350584, 14104.929475352661, 14620.561383158521, 4556.863294101182, 4665.650076244296, 4695.849516868355, 4791.9520804791855, 4815.951840481585, 85303.57348213281, 85964.57017714871, 86198.5690071552, 86295.13704862933, 86458.5677071617, 9956.502174891226, 10963.232573719763, 11105.222634415513, 11281.097512199005, 11601.941990289995, 21731.23940662069, 21952.45118872041, 22119.44701382478, 22163.0, 22271.220507282167, 8207.877091075647, 8306.169383061646, 8445.535495547681, 8452.535110568855, 8586.22723954847, 4683.1336202802595, 4752.3584316116885, 4901.411830580353, 4970.304157417964, 5070.847874563769, 3428.502867084259, 3550.1657110578994, 3553.9644603553634, 3677.7057835373107, 3835.1562656215588, 657.7829316325601, 662.4898827902488, 668.6322522612544, 682.1643486728717, 685.8353995041155, 715.8282012317111, 719.6509692798988, 733.0104359115259, 760.8820632801925, 789.5223389849174, 10197.847032294521, 10306.896931030744, 10597.523111460003, 10863.45682715861, 10925.541753105488, 633.9936600634027, 689.6276010954028, 700.5376451541957, 719.6150059718026, 722.584513904507, 4897.755112244374, 5025.422076461181, 5034.924476132861, 5188.792448302026, 5228.346456692913, 71164.0, 71228.0, 71792.64103679448, 93387.0, 125736.37131814282, 109465.45267273772, 110408.4479577597, 114680.0, 115351.0, 120101.39949300197, 98666.50666746621, 98715.0, 100334.0, 100945.0, 102508.0, 9255.490947997656, 9630.807383852423, 9720.368176068532, 9744.658936937456, 9836.21310295189, 59209.70395147997, 59841.401585983585, 60841.39158608357, 60954.39045609487, 61960.69019654873, 81267.0, 85136.0, 89350.0, 89902.55048724975, 92465.07534924564, 12416.441260143134, 12486.125971182293, 12719.55481558141, 12734.108612397415, 12768.872311276768, 13426.328683565978, 13755.10591811529, 13962.79055814184, 14671.853281467476, 14727.337269823098, 7627.733029343946, 12819.807702884278, 13450.12574182675, 13842.792358114435, 14429.567112986628, 14033.29833508341, 14068.94482913806, 14117.2941352934, 14276.643083922985, 15130.924345378202, 14010.509632162826, 14366.56334366555, 14411.567652970427, 14785.11289322644, 14943.402263909322, 10713.946430267799, 11107.666769996913, 11182.608608698656, 11486.195966282614, 11592.594259200887, 10956.726081848017, 11528.250663706833, 11631.302121872377, 11778.46996885125, 12307.20003199789], "value": 7838.926860231834, "unit": "score"}], "name": "dromaeo_css", "value": 7390.137608151523, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 111.0, 110.0, 114.0, 115.0, 112.0, 111.0, 114.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 124.0, 185.0, 120.0, 118.0, 149.0, 116.0, 149.0, 116.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 159.0, 162.0, 162.0, 160.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 102.0, 74.0, 76.0, 74.0, 74.0, 106.0, 76.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 132.0, 83.0, 84.0, 84.0, 118.0, 84.0, 84.0, 128.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 50.0, 50.0, 50.0, 51.0, 49.0, 50.0, 50.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 63.0, 61.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 75.0, 78.0, 81.0, 86.0, 75.0, 74.0, 75.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 127.0, 125.0, 128.0, 122.0, 121.0, 126.0, 147.0, 122.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 163.0, 159.0, 163.0, 158.0, 160.0, 161.0, 160.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 66.0, 63.0, 64.0, 68.0, 63.0, 61.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1480.3, "alertThreshold": 2.0}]} 02:26:54 INFO - Return code: 0 02:26:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:26:54 INFO - # TBPL SUCCESS # 02:26:54 INFO - Running post-action listener: _resource_record_post_action 02:26:54 INFO - [mozharness: 2016-08-10 09:26:54.620828Z] Finished run-tests step (success) 02:26:54 INFO - Running post-run listener: _resource_record_post_run 02:26:54 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559337472; Read time: 12; Write time: 457952 02:26:54 INFO - TinderboxPrint: CPU usage
13.1% 02:26:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:26:54 INFO - TinderboxPrint: I/O write bytes / time
559,337,472 / 457,952 02:26:54 INFO - TinderboxPrint: CPU idle
8,275.6 (86.9%) 02:26:54 INFO - TinderboxPrint: CPU user
1,200.5 (12.6%) 02:26:54 INFO - TinderboxPrint: Swap in / out
0 / 0 02:26:54 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 263692288; Read time: 0; Write time: 256268 02:26:54 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 295116800; Read time: 0; Write time: 201604 02:26:55 INFO - Running post-run listener: _upload_blobber_files 02:26:55 INFO - Blob upload gear active. 02:26:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:26:55 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 02:26:55 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'] 02:26:55 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 02:26:55 INFO - (blobuploader) - INFO - Open directory for files ... 02:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:26:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:56 INFO - (blobuploader) - INFO - Done attempting. 02:26:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:26:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:26:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:59 INFO - (blobuploader) - INFO - Done attempting. 02:26:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:26:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:00 INFO - (blobuploader) - INFO - Done attempting. 02:27:00 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:00 INFO - Return code: 0 02:27:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:27:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10b25cd1bbe15951c9b5e72b76c927348880fd4ea5e8b8ea73e105f2298119c73588233e89564d0c63aba608576e5b8b723b1d9c1641be6780846f4eb68d1b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a0c60256e857f860ace63763b19ab4766a1be66f847267f6fea6c714c6de45eab231e995ebb1c77607b17e3f2bbc1e64e8b2c83b83e51571eaced3eb0fa4ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/250c81b13e74cc0abfba5a4d19a6e4a87dc2a18c210258d78b6f4ad4e362eeba492bf6c3ca629194b01ce2e2dcd6146ac60e131c45223a16b86f75803c3cbd66"} 02:27:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:27:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:27:00 INFO - Contents: 02:27:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10b25cd1bbe15951c9b5e72b76c927348880fd4ea5e8b8ea73e105f2298119c73588233e89564d0c63aba608576e5b8b723b1d9c1641be6780846f4eb68d1b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a0c60256e857f860ace63763b19ab4766a1be66f847267f6fea6c714c6de45eab231e995ebb1c77607b17e3f2bbc1e64e8b2c83b83e51571eaced3eb0fa4ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/250c81b13e74cc0abfba5a4d19a6e4a87dc2a18c210258d78b6f4ad4e362eeba492bf6c3ca629194b01ce2e2dcd6146ac60e131c45223a16b86f75803c3cbd66"} 02:27:00 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:00 INFO - Copying logs to upload dir... 02:27:00 INFO - mkdir: /builds/slave/test/build/upload/logs 02:27:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.202834 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-10 02:26:59.911659) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 02:26:59.914850) ========= 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=6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10b25cd1bbe15951c9b5e72b76c927348880fd4ea5e8b8ea73e105f2298119c73588233e89564d0c63aba608576e5b8b723b1d9c1641be6780846f4eb68d1b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a0c60256e857f860ace63763b19ab4766a1be66f847267f6fea6c714c6de45eab231e995ebb1c77607b17e3f2bbc1e64e8b2c83b83e51571eaced3eb0fa4ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/250c81b13e74cc0abfba5a4d19a6e4a87dc2a18c210258d78b6f4ad4e362eeba492bf6c3ca629194b01ce2e2dcd6146ac60e131c45223a16b86f75803c3cbd66"} build_url:https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10b25cd1bbe15951c9b5e72b76c927348880fd4ea5e8b8ea73e105f2298119c73588233e89564d0c63aba608576e5b8b723b1d9c1641be6780846f4eb68d1b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a0c60256e857f860ace63763b19ab4766a1be66f847267f6fea6c714c6de45eab231e995ebb1c77607b17e3f2bbc1e64e8b2c83b83e51571eaced3eb0fa4ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/250c81b13e74cc0abfba5a4d19a6e4a87dc2a18c210258d78b6f4ad4e362eeba492bf6c3ca629194b01ce2e2dcd6146ac60e131c45223a16b86f75803c3cbd66"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 02:26:59.940892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:26:59.941264) ========= 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=6dbc10da6d83fee962c624be000001a8-1470813942.600538-54463168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:27:00.025614) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 02:27:00.025974) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 02:27:00.026309) ========= ========= Total master_lag: 0.17 =========