builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1472594318.63 results: success (0) buildid: 20160830113002 builduid: e82ae37e1bb84e928a85df11fc662701 revision: 6a5af5a4c2efd7df3bd8eb6f87ad6ef654854090 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 14:58:38.629177) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 14:58:38.629675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 14:58:38.630256) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 14:58:38.660900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 14:58:38.661276) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 14:58:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.4M=0s 2016-08-30 14:58:39 (42.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130933 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 14:58:38.806957) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 14:58:38.807311) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015094 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 14:58:38.858903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 14:58:38.859343) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6a5af5a4c2efd7df3bd8eb6f87ad6ef654854090 --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 6a5af5a4c2efd7df3bd8eb6f87ad6ef654854090 --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=a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 14:58:39,302 truncating revision to first 12 chars 2016-08-30 14:58:39,302 Setting DEBUG logging. 2016-08-30 14:58:39,302 attempt 1/10 2016-08-30 14:58:39,302 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6a5af5a4c2ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 14:58:40,683 unpacking tar archive at: fx-team-6a5af5a4c2ef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.677573 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 14:58:40.555566) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 14:58:40.556385) ========= script_repo_revision: 6a5af5a4c2efd7df3bd8eb6f87ad6ef654854090 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 14:58:40.557320) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 14:58:40.558001) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 14:58:40.569818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-30 14:58:40.570123) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:58:41 INFO - MultiFileLogger online at 20160830 14:58:41 in /builds/slave/test 14:58:41 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 14:58:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:58:41 INFO - {'append_to_log': False, 14:58:41 INFO - 'base_work_dir': '/builds/slave/test', 14:58:41 INFO - 'blob_upload_branch': 'Fx-Team', 14:58:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:58:41 INFO - 'branch': 'Fx-Team', 14:58:41 INFO - 'buildbot_json_path': 'buildprops.json', 14:58:41 INFO - 'config_files': ('talos/linux_config.py',), 14:58:41 INFO - 'default_actions': ('clobber', 14:58:41 INFO - 'read-buildbot-config', 14:58:41 INFO - 'download-and-extract', 14:58:41 INFO - 'populate-webroot', 14:58:41 INFO - 'create-virtualenv', 14:58:41 INFO - 'install', 14:58:41 INFO - 'run-tests'), 14:58:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:58:41 INFO - 'download_minidump_stackwalk': True, 14:58:41 INFO - 'download_symbols': 'ondemand', 14:58:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:58:41 INFO - 'tooltool.py': '/tools/tooltool.py', 14:58:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:58:41 INFO - '/tools/misc-python/virtualenv.py')}, 14:58:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:58:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:58:41 INFO - 'installer_path': 'installer.exe', 14:58:41 INFO - 'log_level': 'info', 14:58:41 INFO - 'log_name': 'talos', 14:58:41 INFO - 'log_to_console': True, 14:58:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:58:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:58:41 INFO - 'opt_config_files': (), 14:58:41 INFO - 'pip_index': False, 14:58:41 INFO - 'sps_profile': False, 14:58:41 INFO - 'sps_profile_interval': 0, 14:58:41 INFO - 'suite': 'dromaeojs', 14:58:41 INFO - 'system_bits': '32', 14:58:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:58:41 INFO - 'title': 'talos-linux64-ix-064', 14:58:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:58:41 INFO - 'use_talos_json': True, 14:58:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:58:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:58:41 INFO - 'work_dir': 'build'} 14:58:41 INFO - [mozharness: 2016-08-30 21:58:41.105666Z] Running clobber step. 14:58:41 INFO - Running pre-action listener: _resource_record_pre_action 14:58:41 INFO - Running main action method: clobber 14:58:41 INFO - rmtree: /builds/slave/test/build 14:58:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:58:41 INFO - Running post-action listener: _resource_record_post_action 14:58:41 INFO - [mozharness: 2016-08-30 21:58:41.569597Z] Finished clobber step (success) 14:58:41 INFO - [mozharness: 2016-08-30 21:58:41.569700Z] Running read-buildbot-config step. 14:58:41 INFO - Running pre-action listener: _resource_record_pre_action 14:58:41 INFO - Running main action method: read_buildbot_config 14:58:41 INFO - Using buildbot properties: 14:58:41 INFO - { 14:58:41 INFO - "project": "", 14:58:41 INFO - "product": "firefox", 14:58:41 INFO - "script_repo_revision": "production", 14:58:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:58:41 INFO - "repository": "", 14:58:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:58:41 INFO - "buildid": "20160830113002", 14:58:41 INFO - "pgo_build": "True", 14:58:41 INFO - "basedir": "/builds/slave/test", 14:58:41 INFO - "buildnumber": 1507, 14:58:41 INFO - "slavename": "talos-linux64-ix-064", 14:58:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:58:41 INFO - "platform": "ubuntu64_hw", 14:58:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:58:41 INFO - "branch": "fx-team", 14:58:41 INFO - "repo_path": "integration/fx-team", 14:58:41 INFO - "revision": "6a5af5a4c2efd7df3bd8eb6f87ad6ef654854090", 14:58:41 INFO - "stage_platform": "linux64-pgo", 14:58:41 INFO - "builduid": "e82ae37e1bb84e928a85df11fc662701", 14:58:41 INFO - "slavebuilddir": "test" 14:58:41 INFO - } 14:58:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:58:41 INFO - Running post-action listener: _resource_record_post_action 14:58:41 INFO - [mozharness: 2016-08-30 21:58:41.572243Z] Finished read-buildbot-config step (success) 14:58:41 INFO - [mozharness: 2016-08-30 21:58:41.572335Z] Running download-and-extract step. 14:58:41 INFO - Running pre-action listener: _resource_record_pre_action 14:58:41 INFO - Running main action method: download_and_extract 14:58:41 INFO - mkdir: /builds/slave/test/build/tests 14:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:41 INFO - trying https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:58:41 INFO - Downloading https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/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 14:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/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 14:58:42 INFO - Downloaded 1361 bytes. 14:58:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:58:42 INFO - Using the following test package requirements: 14:58:42 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:58:42 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:58:42 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:58:42 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:42 INFO - u'jsshell-linux-x86_64.zip'], 14:58:42 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:58:42 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:58:42 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:58:42 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:58:42 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:58:42 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:58:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:58: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')]} 14:58:42 INFO - trying https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:58:42 INFO - Downloading https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/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 14:58:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/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 14:58:43 INFO - Downloaded 21886933 bytes. 14:58:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 14:58:47 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 14:58: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')]} 14:58:47 INFO - trying https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:58:47 INFO - Downloading https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/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 14:58:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/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 14:58:48 INFO - Downloaded 21886933 bytes. 14:58:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 14:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:52 INFO - trying https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:58:52 INFO - Downloading https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/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 14:58:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/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 14:58:53 INFO - Downloaded 14413998 bytes. 14:58:53 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 14:58: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')]} 14:58:53 INFO - trying https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:58:53 INFO - Downloading https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/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 14:58:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/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 14:58:55 INFO - Downloaded 59730092 bytes. 14:58:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:58:55 INFO - mkdir: /builds/slave/test/properties 14:58:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:58:55 INFO - Writing to file /builds/slave/test/properties/build_url 14:58:55 INFO - Contents: 14:58:55 INFO - build_url:https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:58:56 INFO - Running post-action listener: _resource_record_post_action 14:58:56 INFO - Running post-action listener: set_extra_try_arguments 14:58:56 INFO - [mozharness: 2016-08-30 21:58:56.133809Z] Finished download-and-extract step (success) 14:58:56 INFO - [mozharness: 2016-08-30 21:58:56.134038Z] Running populate-webroot step. 14:58:56 INFO - Running pre-action listener: _resource_record_pre_action 14:58:56 INFO - Running main action method: populate_webroot 14:58:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:58:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:58:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:58:56 INFO - '--tppagecycles', 14:58:56 INFO - '7'], 14:58:56 INFO - 'tests': ['tsvgm']}}, 14:58:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:58:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:58:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:58:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:58:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:58:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:58:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:56 INFO - 'talos_options': ['--disable-e10s'], 14:58:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:58:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:58:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:56 INFO - 'talos_options': ['--disable-e10s'], 14:58:56 INFO - 'tests': ['damp', 'tps']}, 14:58:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:56 INFO - 'tests': ['damp', 'tps']}, 14:58:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:58:56 INFO - 'tests': ['dromaeo_dom']}, 14:58:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:58:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:58:56 INFO - 'tests': ['basic_compositor_video']}, 14:58:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:58:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:58:56 INFO - 'tests': ['a11yr', 14:58:56 INFO - 'ts_paint', 14:58:56 INFO - 'tpaint', 14:58:56 INFO - 'sessionrestore', 14:58:56 INFO - 'sessionrestore_no_auto_restore', 14:58:56 INFO - 'tabpaint']}, 14:58:56 INFO - 'other-e10s': {'tests': ['a11yr', 14:58:56 INFO - 'ts_paint', 14:58:56 INFO - 'tpaint', 14:58:56 INFO - 'sessionrestore', 14:58:56 INFO - 'sessionrestore_no_auto_restore', 14:58:56 INFO - 'tabpaint']}, 14:58:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:58:56 INFO - 'ts_paint', 14:58:56 INFO - 'tpaint', 14:58:56 INFO - 'sessionrestore', 14:58:56 INFO - 'sessionrestore_no_auto_restore', 14:58:56 INFO - 'tabpaint']}, 14:58:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:58:56 INFO - 'ts_paint', 14:58:56 INFO - 'tpaint', 14:58:56 INFO - 'sessionrestore', 14:58:56 INFO - 'sessionrestore_no_auto_restore', 14:58:56 INFO - 'tabpaint']}, 14:58:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:58:56 INFO - 'tests': ['a11yr', 14:58:56 INFO - 'ts_paint', 14:58:56 INFO - 'tpaint', 14:58:56 INFO - 'sessionrestore', 14:58:56 INFO - 'sessionrestore_no_auto_restore', 14:58:56 INFO - 'tabpaint']}, 14:58:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:58:56 INFO - 'tests': ['a11yr', 14:58:56 INFO - 'ts_paint', 14:58:56 INFO - 'tpaint', 14:58:56 INFO - 'sessionrestore', 14:58:56 INFO - 'sessionrestore_no_auto_restore', 14:58:56 INFO - 'tabpaint']}, 14:58:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:58:56 INFO - 'tests': ['tsvgx', 14:58:56 INFO - 'tsvgr_opacity', 14:58:56 INFO - 'tart', 14:58:56 INFO - 'tscrollx', 14:58:56 INFO - 'cart']}, 14:58:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:58:56 INFO - 'tsvgr_opacity', 14:58:56 INFO - 'tart', 14:58:56 INFO - 'tscrollx', 14:58:56 INFO - 'cart']}, 14:58:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:56 INFO - 'talos_options': ['--disable-e10s'], 14:58:56 INFO - 'tests': ['tp5o']}, 14:58:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:56 INFO - 'tests': ['tp5o']}, 14:58:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:56 INFO - 'talos_options': ['--disable-e10s', 14:58:56 INFO - '--xperf_path', 14:58:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:58:56 INFO - 'tests': ['tp5n']}, 14:58:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:56 INFO - 'talos_options': ['--xperf_path', 14:58:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:58:56 INFO - 'tests': ['tp5n']}}, 14:58:56 INFO - 'talos.zip': {'path': '', 14:58:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:58:56 INFO - Running post-action listener: _resource_record_post_action 14:58:56 INFO - [mozharness: 2016-08-30 21:58:56.150988Z] Finished populate-webroot step (success) 14:58:56 INFO - [mozharness: 2016-08-30 21:58:56.151079Z] Running create-virtualenv step. 14:58:56 INFO - Running pre-action listener: _resource_record_pre_action 14:58:56 INFO - Running main action method: create_virtualenv 14:58:56 INFO - Creating virtualenv /builds/slave/test/build/venv 14:58:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:58:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:58:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:58:56 INFO - Using real prefix '/usr' 14:58:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:58:56 INFO - Installing distribute.............................................................................................................................................................................................done. 14:58:58 INFO - Installing pip.................done. 14:58:58 INFO - Return code: 0 14:58:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e140c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038370>, '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 0x103b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:58:58 INFO - Using env: {'DISPLAY': ':0', 14:58:58 INFO - 'HOME': '/home/cltbld', 14:58:58 INFO - 'LANG': 'en_US.UTF-8', 14:58:58 INFO - 'LANGUAGE': 'en_US:en', 14:58:58 INFO - 'LOGNAME': 'cltbld', 14:58:58 INFO - 'MAIL': '/var/mail/cltbld', 14:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:58 INFO - 'MOZ_NO_REMOTE': '1', 14:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:58 INFO - 'NO_EM_RESTART': '1', 14:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:58 INFO - 'PWD': '/builds/slave/test', 14:58:58 INFO - 'SHELL': '/bin/bash', 14:58:58 INFO - 'SHLVL': '1', 14:58:58 INFO - 'TERM': 'linux', 14:58:58 INFO - 'TMOUT': '86400', 14:58:58 INFO - 'USER': 'cltbld', 14:58:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 14:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:58 INFO - '_': '/tools/buildbot/bin/python'} 14:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:58:58 INFO - Cleaning up... 14:58:58 INFO - Return code: 0 14:58:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1e140c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038370>, '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 0x103b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:58:58 INFO - Using env: {'DISPLAY': ':0', 14:58:58 INFO - 'HOME': '/home/cltbld', 14:58:58 INFO - 'LANG': 'en_US.UTF-8', 14:58:58 INFO - 'LANGUAGE': 'en_US:en', 14:58:58 INFO - 'LOGNAME': 'cltbld', 14:58:58 INFO - 'MAIL': '/var/mail/cltbld', 14:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:58 INFO - 'MOZ_NO_REMOTE': '1', 14:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:58 INFO - 'NO_EM_RESTART': '1', 14:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:58 INFO - 'PWD': '/builds/slave/test', 14:58:58 INFO - 'SHELL': '/bin/bash', 14:58:58 INFO - 'SHLVL': '1', 14:58:58 INFO - 'TERM': 'linux', 14:58:58 INFO - 'TMOUT': '86400', 14:58:58 INFO - 'USER': 'cltbld', 14:58:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 14:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:58 INFO - '_': '/tools/buildbot/bin/python'} 14:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:59 INFO - Downloading/unpacking psutil>=3.1.1 14:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:59:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:01 INFO - Installing collected packages: psutil 14:59:01 INFO - Running setup.py install for psutil 14:59:01 INFO - building 'psutil._psutil_linux' extension 14:59:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:59:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:59:01 INFO - building 'psutil._psutil_posix' extension 14:59:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:59:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:59:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:01 INFO - Successfully installed psutil 14:59:01 INFO - Cleaning up... 14:59:01 INFO - Return code: 0 14:59:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e140c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038370>, '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 0x103b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:59:01 INFO - Using env: {'DISPLAY': ':0', 14:59:01 INFO - 'HOME': '/home/cltbld', 14:59:01 INFO - 'LANG': 'en_US.UTF-8', 14:59:01 INFO - 'LANGUAGE': 'en_US:en', 14:59:01 INFO - 'LOGNAME': 'cltbld', 14:59:01 INFO - 'MAIL': '/var/mail/cltbld', 14:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:01 INFO - 'MOZ_NO_REMOTE': '1', 14:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:01 INFO - 'NO_EM_RESTART': '1', 14:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:01 INFO - 'PWD': '/builds/slave/test', 14:59:01 INFO - 'SHELL': '/bin/bash', 14:59:01 INFO - 'SHLVL': '1', 14:59:01 INFO - 'TERM': 'linux', 14:59:01 INFO - 'TMOUT': '86400', 14:59:01 INFO - 'USER': 'cltbld', 14:59:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 14:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:01 INFO - '_': '/tools/buildbot/bin/python'} 14:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:59:03 INFO - Installing collected packages: mozsystemmonitor 14:59:03 INFO - Running setup.py install for mozsystemmonitor 14:59:03 INFO - Successfully installed mozsystemmonitor 14:59:03 INFO - Cleaning up... 14:59:04 INFO - Return code: 0 14:59:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:04 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 0x7f1e140c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038370>, '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 0x103b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:59:04 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 14:59:04 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 14:59:04 INFO - Using env: {'DISPLAY': ':0', 14:59:04 INFO - 'HOME': '/home/cltbld', 14:59:04 INFO - 'LANG': 'en_US.UTF-8', 14:59:04 INFO - 'LANGUAGE': 'en_US:en', 14:59:04 INFO - 'LOGNAME': 'cltbld', 14:59:04 INFO - 'MAIL': '/var/mail/cltbld', 14:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:04 INFO - 'MOZ_NO_REMOTE': '1', 14:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:04 INFO - 'NO_EM_RESTART': '1', 14:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:04 INFO - 'PWD': '/builds/slave/test', 14:59:04 INFO - 'SHELL': '/bin/bash', 14:59:04 INFO - 'SHLVL': '1', 14:59:04 INFO - 'TERM': 'linux', 14:59:04 INFO - 'TMOUT': '86400', 14:59:04 INFO - 'USER': 'cltbld', 14:59:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 14:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:04 INFO - '_': '/tools/buildbot/bin/python'} 14:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:04 INFO - Downloading/unpacking jsonschema==2.5.1 14:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:59:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:06 INFO - Downloading functools32-3.2.3-2.tar.gz 14:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:59:06 INFO - warning: no files found matching '*.txt' 14:59:06 INFO - no previously-included directories found matching 'build' 14:59:06 INFO - no previously-included directories found matching 'dist' 14:59:06 INFO - no previously-included directories found matching '.git*' 14:59:06 INFO - Installing collected packages: jsonschema, functools32 14:59:06 INFO - Running setup.py install for functools32 14:59:06 INFO - warning: no files found matching '*.txt' 14:59:06 INFO - no previously-included directories found matching 'build' 14:59:06 INFO - no previously-included directories found matching 'dist' 14:59:06 INFO - no previously-included directories found matching '.git*' 14:59:06 INFO - Successfully installed jsonschema functools32 14:59:06 INFO - Cleaning up... 14:59:06 INFO - Return code: 0 14:59:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:59:06 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')]} 14:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:06 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')]} 14:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:06 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 0x7f1e140c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038370>, '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 0x103b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:59:06 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 14:59:06 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 14:59:06 INFO - Using env: {'DISPLAY': ':0', 14:59:06 INFO - 'HOME': '/home/cltbld', 14:59:06 INFO - 'LANG': 'en_US.UTF-8', 14:59:06 INFO - 'LANGUAGE': 'en_US:en', 14:59:06 INFO - 'LOGNAME': 'cltbld', 14:59:06 INFO - 'MAIL': '/var/mail/cltbld', 14:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:06 INFO - 'MOZ_NO_REMOTE': '1', 14:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:06 INFO - 'NO_EM_RESTART': '1', 14:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:06 INFO - 'PWD': '/builds/slave/test', 14:59:06 INFO - 'SHELL': '/bin/bash', 14:59:06 INFO - 'SHLVL': '1', 14:59:06 INFO - 'TERM': 'linux', 14:59:06 INFO - 'TMOUT': '86400', 14:59:06 INFO - 'USER': 'cltbld', 14:59:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 14:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:06 INFO - '_': '/tools/buildbot/bin/python'} 14:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:59:06 INFO - Cleaning up... 14:59:06 INFO - Return code: 0 14:59:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:59:06 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')]} 14:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:06 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')]} 14:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:06 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 0x7f1e140c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038370>, '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 0x103b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:59:06 INFO - Using env: {'DISPLAY': ':0', 14:59:06 INFO - 'HOME': '/home/cltbld', 14:59:06 INFO - 'LANG': 'en_US.UTF-8', 14:59:06 INFO - 'LANGUAGE': 'en_US:en', 14:59:06 INFO - 'LOGNAME': 'cltbld', 14:59:06 INFO - 'MAIL': '/var/mail/cltbld', 14:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:06 INFO - 'MOZ_NO_REMOTE': '1', 14:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:06 INFO - 'NO_EM_RESTART': '1', 14:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:06 INFO - 'PWD': '/builds/slave/test', 14:59:06 INFO - 'SHELL': '/bin/bash', 14:59:06 INFO - 'SHLVL': '1', 14:59:06 INFO - 'TERM': 'linux', 14:59:06 INFO - 'TMOUT': '86400', 14:59:06 INFO - 'USER': 'cltbld', 14:59:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 14:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:06 INFO - '_': '/tools/buildbot/bin/python'} 14:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:07 INFO - Downloading/unpacking blobuploader==1.2.4 14:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:08 INFO - Downloading blobuploader-1.2.4.tar.gz 14:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:59:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:59:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:09 INFO - Downloading docopt-0.6.1.tar.gz 14:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:59:09 INFO - Installing collected packages: blobuploader, requests, docopt 14:59:09 INFO - Running setup.py install for blobuploader 14:59:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:59:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:59:09 INFO - Running setup.py install for requests 14:59:10 INFO - Running setup.py install for docopt 14:59:10 INFO - Successfully installed blobuploader requests docopt 14:59:10 INFO - Cleaning up... 14:59:10 INFO - Return code: 0 14:59:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:10 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 0x7f1e140c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038370>, '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 0x103b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:59:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:59:10 INFO - Using env: {'DISPLAY': ':0', 14:59:10 INFO - 'HOME': '/home/cltbld', 14:59:10 INFO - 'LANG': 'en_US.UTF-8', 14:59:10 INFO - 'LANGUAGE': 'en_US:en', 14:59:10 INFO - 'LOGNAME': 'cltbld', 14:59:10 INFO - 'MAIL': '/var/mail/cltbld', 14:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:10 INFO - 'MOZ_NO_REMOTE': '1', 14:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:10 INFO - 'NO_EM_RESTART': '1', 14:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:10 INFO - 'PWD': '/builds/slave/test', 14:59:10 INFO - 'SHELL': '/bin/bash', 14:59:10 INFO - 'SHLVL': '1', 14:59:10 INFO - 'TERM': 'linux', 14:59:10 INFO - 'TMOUT': '86400', 14:59:10 INFO - 'USER': 'cltbld', 14:59:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 14:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:10 INFO - '_': '/tools/buildbot/bin/python'} 14:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:10 INFO - Running setup.py (path:/tmp/pip-N2yvuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:10 INFO - Running setup.py (path:/tmp/pip-qbado5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:10 INFO - Running setup.py (path:/tmp/pip-zwR7e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:10 INFO - Running setup.py (path:/tmp/pip-FBjLUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:10 INFO - Running setup.py (path:/tmp/pip-npAvtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:10 INFO - Running setup.py (path:/tmp/pip-dBps1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:10 INFO - Running setup.py (path:/tmp/pip-Ex9Pn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:11 INFO - Running setup.py (path:/tmp/pip-SJn6BX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:11 INFO - Running setup.py (path:/tmp/pip-q1f_bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:11 INFO - Running setup.py (path:/tmp/pip-i3qd7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:11 INFO - Running setup.py (path:/tmp/pip-fzNziH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:11 INFO - Running setup.py (path:/tmp/pip-uDJH__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:11 INFO - Running setup.py (path:/tmp/pip-4HnJ1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:11 INFO - Running setup.py (path:/tmp/pip-f5Vjrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:11 INFO - Running setup.py (path:/tmp/pip-N4MFnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:11 INFO - Running setup.py (path:/tmp/pip-89QN73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:11 INFO - Running setup.py (path:/tmp/pip-Vzy9QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:59:11 INFO - Running setup.py install for manifestparser 14:59:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:59:11 INFO - Running setup.py install for mozcrash 14:59:11 INFO - Running setup.py install for mozdebug 14:59:12 INFO - Running setup.py install for mozdevice 14:59:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:59:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:59:12 INFO - Running setup.py install for mozfile 14:59:12 INFO - Running setup.py install for mozhttpd 14:59:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:59:12 INFO - Running setup.py install for mozinfo 14:59:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:59:12 INFO - Running setup.py install for mozInstall 14:59:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:59:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:59:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:59:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:59:12 INFO - Running setup.py install for mozleak 14:59:12 INFO - Running setup.py install for mozlog 14:59:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:59:12 INFO - Running setup.py install for moznetwork 14:59:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:59:12 INFO - Running setup.py install for mozprocess 14:59:13 INFO - Running setup.py install for mozprofile 14:59:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:59:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:59:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:59:13 INFO - Running setup.py install for mozrunner 14:59:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:59:13 INFO - Running setup.py install for mozscreenshot 14:59:13 INFO - Running setup.py install for moztest 14:59:13 INFO - Running setup.py install for mozversion 14:59:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:59:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:59:13 INFO - Cleaning up... 14:59:13 INFO - Return code: 0 14:59:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:13 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 0x7f1e140c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038370>, '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 0x103b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:59:13 INFO - Using env: {'DISPLAY': ':0', 14:59:13 INFO - 'HOME': '/home/cltbld', 14:59:13 INFO - 'LANG': 'en_US.UTF-8', 14:59:13 INFO - 'LANGUAGE': 'en_US:en', 14:59:13 INFO - 'LOGNAME': 'cltbld', 14:59:13 INFO - 'MAIL': '/var/mail/cltbld', 14:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:13 INFO - 'MOZ_NO_REMOTE': '1', 14:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:13 INFO - 'NO_EM_RESTART': '1', 14:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:13 INFO - 'PWD': '/builds/slave/test', 14:59:13 INFO - 'SHELL': '/bin/bash', 14:59:13 INFO - 'SHLVL': '1', 14:59:13 INFO - 'TERM': 'linux', 14:59:13 INFO - 'TMOUT': '86400', 14:59:13 INFO - 'USER': 'cltbld', 14:59:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 14:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:13 INFO - '_': '/tools/buildbot/bin/python'} 14:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:13 INFO - Running setup.py (path:/tmp/pip-Ho1MuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:13 INFO - Running setup.py (path:/tmp/pip-0MJJJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:13 INFO - Running setup.py (path:/tmp/pip-jsZAEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:14 INFO - Running setup.py (path:/tmp/pip-MiEoJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:14 INFO - Running setup.py (path:/tmp/pip-aXGh7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:14 INFO - Running setup.py (path:/tmp/pip-H_tF4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:14 INFO - Running setup.py (path:/tmp/pip-zdRT92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:14 INFO - Running setup.py (path:/tmp/pip-CJR8OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:14 INFO - Running setup.py (path:/tmp/pip-OlLrin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:14 INFO - Running setup.py (path:/tmp/pip-pkacmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:14 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)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:14 INFO - Running setup.py (path:/tmp/pip-27bU2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:14 INFO - Running setup.py (path:/tmp/pip-wkSSJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:14 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)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:14 INFO - Running setup.py (path:/tmp/pip-7wI_t1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:14 INFO - Running setup.py (path:/tmp/pip-GB9_Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:14 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)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:14 INFO - Running setup.py (path:/tmp/pip-8F0gFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:14 INFO - Running setup.py (path:/tmp/pip-oQzkAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:14 INFO - Running setup.py (path:/tmp/pip-NSc7y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:59:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:16 INFO - Downloading blessings-1.6.tar.gz 14:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:59:16 INFO - Installing collected packages: blessings 14:59:16 INFO - Running setup.py install for blessings 14:59:17 INFO - Successfully installed blessings 14:59:17 INFO - Cleaning up... 14:59:17 INFO - Return code: 0 14:59:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:17 INFO - Reading from file tmpfile_stdout 14:59:17 INFO - Current package versions: 14:59:17 INFO - argparse == 1.2.1 14:59:17 INFO - blessings == 1.6 14:59:17 INFO - blobuploader == 1.2.4 14:59:17 INFO - docopt == 0.6.1 14:59:17 INFO - functools32 == 3.2.3-2 14:59:17 INFO - jsonschema == 2.5.1 14:59:17 INFO - manifestparser == 1.1 14:59:17 INFO - mozInstall == 1.12 14:59:17 INFO - mozcrash == 0.17 14:59:17 INFO - mozdebug == 0.1 14:59:17 INFO - mozdevice == 0.48 14:59:17 INFO - mozfile == 1.2 14:59:17 INFO - mozhttpd == 0.7 14:59:17 INFO - mozinfo == 0.9 14:59:17 INFO - mozleak == 0.1 14:59:17 INFO - mozlog == 3.3 14:59:17 INFO - moznetwork == 0.27 14:59:17 INFO - mozprocess == 0.23 14:59:17 INFO - mozprofile == 0.28 14:59:17 INFO - mozrunner == 6.12 14:59:17 INFO - mozscreenshot == 0.1 14:59:17 INFO - mozsystemmonitor == 0.3 14:59:17 INFO - moztest == 0.7 14:59:17 INFO - mozversion == 1.4 14:59:17 INFO - psutil == 3.1.1 14:59:17 INFO - requests == 1.2.3 14:59:17 INFO - wsgiref == 0.1.2 14:59:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:17 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')]} 14:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:17 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')]} 14:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:17 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 0x7f1e140c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038370>, '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 0x103b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:59:17 INFO - Using env: {'DISPLAY': ':0', 14:59:17 INFO - 'HOME': '/home/cltbld', 14:59:17 INFO - 'LANG': 'en_US.UTF-8', 14:59:17 INFO - 'LANGUAGE': 'en_US:en', 14:59:17 INFO - 'LOGNAME': 'cltbld', 14:59:17 INFO - 'MAIL': '/var/mail/cltbld', 14:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:17 INFO - 'MOZ_NO_REMOTE': '1', 14:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:17 INFO - 'NO_EM_RESTART': '1', 14:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:17 INFO - 'PWD': '/builds/slave/test', 14:59:17 INFO - 'SHELL': '/bin/bash', 14:59:17 INFO - 'SHLVL': '1', 14:59:17 INFO - 'TERM': 'linux', 14:59:17 INFO - 'TMOUT': '86400', 14:59:17 INFO - 'USER': 'cltbld', 14:59:17 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 14:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:17 INFO - '_': '/tools/buildbot/bin/python'} 14:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:59:17 INFO - Cleaning up... 14:59:17 INFO - Return code: 0 14:59:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:59:17 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')]} 14:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:17 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')]} 14:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:17 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 0x7f1e140c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038370>, '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 0x103b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:59:17 INFO - Using env: {'DISPLAY': ':0', 14:59:17 INFO - 'HOME': '/home/cltbld', 14:59:17 INFO - 'LANG': 'en_US.UTF-8', 14:59:17 INFO - 'LANGUAGE': 'en_US:en', 14:59:17 INFO - 'LOGNAME': 'cltbld', 14:59:17 INFO - 'MAIL': '/var/mail/cltbld', 14:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:17 INFO - 'MOZ_NO_REMOTE': '1', 14:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:17 INFO - 'NO_EM_RESTART': '1', 14:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:17 INFO - 'PWD': '/builds/slave/test', 14:59:17 INFO - 'SHELL': '/bin/bash', 14:59:17 INFO - 'SHLVL': '1', 14:59:17 INFO - 'TERM': 'linux', 14:59:17 INFO - 'TMOUT': '86400', 14:59:17 INFO - 'USER': 'cltbld', 14:59:17 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 14:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:17 INFO - '_': '/tools/buildbot/bin/python'} 14:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:59:17 INFO - Cleaning up... 14:59:17 INFO - Return code: 0 14:59:17 INFO - Running post-action listener: _resource_record_post_action 14:59:17 INFO - Running post-action listener: _start_resource_monitoring 14:59:17 INFO - Starting resource monitoring. 14:59:17 INFO - [mozharness: 2016-08-30 21:59:17.852989Z] Finished create-virtualenv step (success) 14:59:17 INFO - [mozharness: 2016-08-30 21:59:17.853449Z] Running install step. 14:59:17 INFO - Running pre-action listener: _resource_record_pre_action 14:59:17 INFO - Running main action method: install 14:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:18 INFO - Reading from file tmpfile_stdout 14:59:18 INFO - Detecting whether we're running mozinstall >=1.0... 14:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:59:18 INFO - Reading from file tmpfile_stdout 14:59:18 INFO - Output received: 14:59:18 INFO - Usage: mozinstall [options] installer 14:59:18 INFO - Options: 14:59:18 INFO - -h, --help show this help message and exit 14:59:18 INFO - -d DEST, --destination=DEST 14:59:18 INFO - Directory to install application into. [default: 14:59:18 INFO - "/builds/slave/test"] 14:59:18 INFO - --app=APP Application being installed. [default: firefox] 14:59:18 INFO - mkdir: /builds/slave/test/build/application 14:59:18 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'] 14:59:18 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 14:59:35 INFO - Reading from file tmpfile_stdout 14:59:35 INFO - Output received: 14:59:35 INFO - /builds/slave/test/build/application/firefox/firefox 14:59:35 INFO - Running post-action listener: _resource_record_post_action 14:59:35 INFO - [mozharness: 2016-08-30 21:59:35.151608Z] Finished install step (success) 14:59:35 INFO - [mozharness: 2016-08-30 21:59:35.151891Z] Running run-tests step. 14:59:35 INFO - Running pre-action listener: _resource_record_pre_action 14:59:35 INFO - Running main action method: run_tests 14:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:59:35 INFO - Python 2.7.3 14:59:35 INFO - Return code: 0 14:59:35 INFO - grabbing minidump binary from tooltool 14:59:35 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')]} 14:59:35 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 0x1038370>, '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 0x103b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:59:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:59:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:59:35 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 14:59:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:59:35 INFO - Return code: 0 14:59:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:59:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:59:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:59:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:59:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:59:35 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/f6bfGfmuR6qBo4MgzvC7bQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:59:35 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/f6bfGfmuR6qBo4MgzvC7bQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:59:35 INFO - Using env: {'DISPLAY': ':0', 14:59:35 INFO - 'HOME': '/home/cltbld', 14:59:35 INFO - 'LANG': 'en_US.UTF-8', 14:59:35 INFO - 'LANGUAGE': 'en_US:en', 14:59:35 INFO - 'LOGNAME': 'cltbld', 14:59:35 INFO - 'MAIL': '/var/mail/cltbld', 14:59:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:59:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:35 INFO - 'MOZ_NO_REMOTE': '1', 14:59:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:35 INFO - 'NO_EM_RESTART': '1', 14:59:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:35 INFO - 'PWD': '/builds/slave/test', 14:59:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:59:35 INFO - 'SHELL': '/bin/bash', 14:59:35 INFO - 'SHLVL': '1', 14:59:35 INFO - 'TERM': 'linux', 14:59:35 INFO - 'TMOUT': '86400', 14:59:35 INFO - 'USER': 'cltbld', 14:59:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652', 14:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:35 INFO - '_': '/tools/buildbot/bin/python'} 14:59:35 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/f6bfGfmuR6qBo4MgzvC7bQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:59:35 INFO - mozversion application_buildid: 20160830113002 14:59:35 INFO - mozversion application_changeset: 6a5af5a4c2efd7df3bd8eb6f87ad6ef654854090 14:59:35 INFO - mozversion application_display_name: Nightly 14:59:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:59:35 INFO - mozversion application_name: Firefox 14:59:35 INFO - mozversion application_remotingname: firefox 14:59:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:59:35 INFO - mozversion application_vendor: Mozilla 14:59:35 INFO - mozversion application_version: 51.0a1 14:59:35 INFO - mozversion platform_buildid: 20160830113002 14:59:35 INFO - mozversion platform_changeset: 6a5af5a4c2efd7df3bd8eb6f87ad6ef654854090 14:59:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:59:35 INFO - mozversion platform_version: 51.0a1 14:59:35 INFO - using testdate: 1472594375 14:59:35 INFO - actual date: 1472594375 14:59:35 INFO - starting webserver on 'localhost:50669' 14:59:35 INFO - SUITE-START | Running 2 tests 14:59:35 INFO - TEST-START | dromaeo_css 14:59:35 INFO - operating with platform_type : linux_ 14:59:35 INFO - Initialising browser for dromaeo_css test... 14:59:35 INFO - TEST-INFO | started process 20502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptrbqNQ/profile http://localhost:50669/getInfo.html) 14:59:40 INFO - PROCESS | 20502 | __metrics Screen width/height:1600/1200 14:59:40 INFO - PROCESS | 20502 | colorDepth:24 14:59:40 INFO - PROCESS | 20502 | Browser inner width/height: 1024/697 14:59:40 INFO - PROCESS | 20502 | __metrics 14:59:40 INFO - PROCESS | 20502 | 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" 14:59:40 INFO - PROCESS | 20502 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:59:41 INFO - PROCESS | 20502 | console.error: PushService: 14:59:41 INFO - PROCESS | 20502 | stateChangeProcessEnqueue: Error transitioning state 14:59:41 INFO - PROCESS | 20502 | UnknownError 14:59:42 INFO - TEST-INFO | 20502: exit 0 14:59:42 INFO - Browser initialized. 14:59:42 INFO - Running cycle 1/1 for dromaeo_css test... 14:59:42 INFO - TEST-INFO | started process 20585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptrbqNQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:54 INFO - PROCESS | 20585 | RSS: Main: 180400128 14:59:54 INFO - PROCESS | 20585 | 15:00:45 INFO - PROCESS | 20585 | 1472594445494 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] 15:02:54 INFO - PROCESS | 20585 | Cycle 1(1): loaded http://localhost:50669/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50669/tests/dromaeo/cssquery-ext.html) 15:02:55 INFO - PROCESS | 20585 | RSS: Main: 299974656 15:02:55 INFO - PROCESS | 20585 | 15:05:58 INFO - PROCESS | 20585 | Cycle 1(1): loaded http://localhost:50669/tests/dromaeo/cssquery-ext.html (next: http://localhost:50669/tests/dromaeo/cssquery-jquery.html) 15:05:58 INFO - PROCESS | 20585 | RSS: Main: 277544960 15:05:58 INFO - PROCESS | 20585 | 15:09:00 INFO - PROCESS | 20585 | Cycle 1(1): loaded http://localhost:50669/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50669/tests/dromaeo/cssquery-mootools.html) 15:09:01 INFO - PROCESS | 20585 | RSS: Main: 255516672 15:09:01 INFO - PROCESS | 20585 | 15:12:03 INFO - PROCESS | 20585 | Cycle 1(1): loaded http://localhost:50669/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50669/tests/dromaeo/cssquery-prototype.html) 15:12:03 INFO - PROCESS | 20585 | RSS: Main: 268460032 15:12:03 INFO - PROCESS | 20585 | 15:15:06 INFO - PROCESS | 20585 | Cycle 1(1): loaded http://localhost:50669/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50669/tests/dromaeo/cssquery-yui.html) 15:15:07 INFO - PROCESS | 20585 | RSS: Main: 217030656 15:15:07 INFO - PROCESS | 20585 | 15:18:09 INFO - PROCESS | 20585 | Cycle 1(1): loaded http://localhost:50669/tests/dromaeo/cssquery-yui.html (next: http://localhost:50669/tests/dromaeo/cssquery-dojo.html) 15:18:10 INFO - PROCESS | 20585 | RSS: Main: 307515392 15:18:10 INFO - PROCESS | 20585 | 15:18:10 INFO - PROCESS | 20585 | __start_tp_report 15:18:10 INFO - PROCESS | 20585 | _x_x_mozilla_page_load 15:18:10 INFO - PROCESS | 20585 | _x_x_mozilla_page_load_details 15:18:10 INFO - PROCESS | 20585 | |i|pagename|runs| 15:18:10 INFO - PROCESS | 20585 | |0;dojo.html;2973.5093709537928;3012.1264833198375;3019.758419326453;3046.893358732445;3075.738562222211;5069.746512674361;5138.743062846852;5151.15006024006;5218.347706536683;5248.501392367729;5217.191335343018;5232.398274198468;5258.211268309756;5261.710605916673;5292.735363231833;4687.554682305184;4744.881377965561;4772.021735544223;4787.54518320759;4943.9258411123865;4846.39420072491;4880.755962201893;4891.8777030574165;4895.9755201224125;4924.70451772893;4634.3048542718525;4693.859184224479;4711.081339138835;4737.928931066037;4783.904321913559;4657.278121891112;4672.836450724209;4677.7193368398;4735.550122738335;4796.2326027835725;4692.859214223578;4695.1548721230165;4722.787474563653;4778.402699662543;4782.617390608743;5077.746112694387;5128.666636668642;5161.148410512261;5162.096633089194;5178.948210517884;5458.317710286215;5461.399246082928;5474.972625136888;5480.890382192374;5481.12302031677;5317.521423071903;5534.280543529356;5542.251796007527;5584.664920104766;5599.468050535193;5116.76974536143;5161.870953226162;5170.25031370453;5185.118529849935;5217.765200565984;5624.21261023457;5643.943560564342;5645.125005624135;5645.633033852787;5650.5479561634975;5260.237265596544;5438.537724293479;5440.591955603346;5440.591955603346;5445;5447.319085114361;5475.479829416199;5493.148561972901;5532.917006244909;5595.776168953196;5497.285352904177;5499.532539734168;5501.927124210821;5509.696966666872;5516.365617953907;5290.444503327172;5507.394186639466;5518.641288316247;5529.502344788988;5591.6365436246515;4304.203722311382;4326.935095973563;4337.327714204303;4396.472423309224;4396.670249731283;3871.3031654302495;3879.282332768447;3882.6893848492055;3921.039345360348;3926.587708290588;5293.894122117613;5297.860959893641;5347.946520534822;5349.304590403222;5352.116900711417;5345.412004679482;5394.541463975527;5522;5562.082256427644;5579.13523403873;5340.465953404629;5340.973295133499;5345.037893179187;5345.064613692588;5391.406945236021;4847.418309802846;4854.271859221145;4855.878603034952;4861.6353773467135;4910.779014944336;5515.917261241085;5644.294463192101;5653.434656534314;5674.06377947634;5783.59514833966;5517.944820551743;5523.530499907392;5528.612997090326;5539.695316757617;5573.164025396223;5739.139129130664;5739.598228124159;5740.225069615549;5746.13807928814;5746.798862039808;5222.582193424441;5436.67379957188;5437.537809286255;5459.399466058651;5483.917741233805;5572.665640061609;5599.048161812583;5603.32760068778;5609.326880774333;5654.434556544313;5409.134538473825;5466.098093814476;5469.288992430958;5471.069918113851;5476.315460567429;5175.223716442413;5319.095753721799;5339.973300133474;5365.38298095724;5494.917576236439;5355.919661205163;5358.839234822962;5363;5363.892722145613;5413.918791218213;5339.919901201408;5441.347038355264;5443.992861320668;5452.2094296327605;5501.559875209893;5217.921731173959;5315.920261196008;5375.623706340519;5409.864753381197;5426 15:18:10 INFO - PROCESS | 20585 | |1;ext.html;552.0070150891501;581.2298704216912;602.0006788730706;610.960287581307;617.966011869347;42172.36741448877;43800.56199438005;43826.12347753047;43872.78063609677;47220.29169562459;44964;45406.54593454064;45425.31862022064;45466;45585;8864.290856731446;9015.188633023026;9017.053209413016;9022.278217742565;9022.593983270735;8859.468431894107;8940.865887011667;8944.150305720947;8952.462852228855;8954.641814327419;8941.821163576724;8986.775330616754;8987.37088403812;8989.056149104315;8997.280217582578;8959.059298773633;8993.280537557046;8997.055309192507;9001.594928228213;9005.099490050943;8909.064548222474;8977.730668079968;8982.416142950688;8983.46099234048;8983.55082245885;41872.37191442131;41881;42126.36810447846;42131;42210;3453.4129198036144;3667.5232219811255;3671.650143907901;3943.507061617298;4165.541790403053;31869.681303187135;32387.19032024218;32475.51286730701;32562.674373256203;33858;4158.147579746144;4189.2668782962855;4222.472190976128;4438;4455.643548516111;330053;331368.9999999976;332175;332709;333388;48580.271295930586;49144.50855491399;49157.50842491529;55508.72245638746;55978.72010639921;53969.460305396446;57577.712111440014;58297.708511457175;58746.41253587495;65356.346436535976;14570.854291457163;14851;14851.628709282355;14856.702865942836;14859.925700371645;10924.836127458095;10960.342379457257;10961.287516311573;10976.243800991802;10977.945110274557;14832.480863169738;16218.513444596681;16506.25721842496;16590.83409165893;17035.659286814443;5689.715514224355;5947.2455625590555;5948.85127871798;5984.581079324405;6039.4262545058145;916.706653870755;936.5176933879058;942.2085448223526;1034.3483605328595;1049.4385503755607;31767.205819854687;31915.840420797747;32148;32180;32368.838155809543;1075.634284343327;1083.182197440943;1083.4853444613902;1102.3716481605409;1127.656064900197;15635.218239088;16568.420105296256;16743.665126697397;16750.16249187536;16785.748213776802;875811.7978792004;897494;898282;900138;902964;57687.42312576905;58515;58556.4144358551;58580;58703;1316.0918965913488;1330.221820235154;1353.0731448957495;1362.420971087284;1372.4235820955223;30066.62882069954;32445.35109297848;32565.511517327734;32950.340993179525;32954.17614559655;51094.48905511046;51514.74242628763;51578.22632660438;51638;51640;455517;455573;456445;457331;457532;26646.733532664424;27847.72152278451;27946.720532795225;28138.155855324374;28160.577591335736;38144;39412.2117557653;44599;49990;50643.24035139549;38835.611643883196;39937.80031099826;40236.798816005736;40661.59338406578;42350.576494234665;39752.60247397489;40086.1982760349;40504.59495405126;41767.58232417637;42285.788571056946;39409;39762.60237397589;39850.402243965786;40153.59846401498;40538.59461405348;34329.65670343264;36355.818220908724;36616.81691591525;36668.26663466769;37174;26718.732812672402;27426.725732742416;27816.443671126868;29538.37538935379;29791.85104074466 15:18:10 INFO - PROCESS | 20585 | |2;jquery.html;382.7665124274193;384.30824515871427;388.6123060563582;393.21945937314433;415.6923876331514;14560.708785824278;17905.462836114923;18730.344437944674;19491.902540487295;19606.803931960676;17857.464276071707;18867.716984245246;19721.309754158607;19812.10845511952;19888.303909363174;5617.8033768818095;5683.943160568393;5831.7958871439505;5868.911966320508;5953.88092238155;5652.547796176316;5802.767889284423;5847.8538036549;5849.736761845727;5851.385604511529;5713.457221563945;5716.1997320375185;5738.7991420300295;5760.308762948452;5768.480836724694;5725.685087320196;5731.971340143294;5732.971335143339;5739.942600574003;6496.285408605049;5831.795887143972;5844.736986835603;5849.61977471463;5851.882962340729;5853.88292234153;14072.648183795385;18961.525961851064;19191.904040479847;22966.65550016751;23129.306120816404;2350.3771500552366;2360.280114565057;2413.855168689884;2471.6910386201725;2561.859097749623;10135.695929122137;10162.898371016343;10589.258751887372;10597.046265836112;10823.404712740796;1820.8816426932208;1824.3158815444208;1832.3769918227867;1855.2208072609537;1976.743023406948;73514;78041.21958780453;80011;81739.5913020437;81938.14103204939;10591.523381447852;10921.290116142425;11061.391623460788;11165.776684466266;11418.20072594927;13851.30743462843;14166.787498187536;15714.764278535831;15723.135227562365;15735.977161484467;7421.628918554051;7500.212477689873;7668.80827979305;7796.688132474751;7817.843643127219;7040.788776336718;7192.244814294529;7233.132024157029;7428.405727541784;7437.962810185914;4649.767511624405;4655.720656760537;4732.52674732524;4806.086843499724;4874.46380898101;1989.353460125465;1997.470670272379;2013.3959812056326;2039.775624681284;2060.8047332547085;867.9566021699017;891.772597987509;953.7758626722715;957.1911734584265;959.2757468111671;18342;19397.2241110354;19434.80565194358;19451;19920.103595338245;935.9298052646079;971.2084651009404;974.5322245322285;1001.7578203028193;1011.726833754882;10318.638847640446;10870.130389568816;11005.284656497302;11025.779484410266;11111.222214444912;450878;456821;457854;459422;461362;88353.8633818586;89703;89901.55049224712;91185.54407227921;91350;965.0590674092844;980.9411435313904;1005.2510879394897;1006.6979906028163;1020.1175982774846;16680.33114701642;17233.31066757366;17660;17707.822921771134;17783.28866845312;38589.80705096456;40294.39558406568;41276.793616031726;43479.56520434755;44252.45116421038;52994;54232.72883635714;55596.44403555913;56122.71938640281;58095;7627.237276272328;8535.658573656985;8608.09614990417;8801.207891289814;8895.421797583136;12741.8088728671;13238.933805330911;13467.59597212046;13597.456101756216;13634.386452609855;11234.606788762354;11311.208215424842;11456.255343402652;11761.764764704829;11916.331713559935;10687;10757.892421075689;11381.658550243506;11553.942230288794;11832.290062595928;11447.771044579229;11735.119866010255;11837.881621183678;11916.10629202796;12436.751264974831;7579.696812127674;7722.498037627536;7783.455158138876;7823.530588164728;7952.721654742057;11345.262557933707;11416.657500275005;11561.30632162073;11633.6509904703;12219.26684398939 15:18:10 INFO - PROCESS | 20585 | |3;mootools.html;1309.9803502947452;1430.8783753380958;1445.0534899640736;1584.1841451652401;1743.2678275124454;7942.642581083851;8269.462484938482;8364.790880227989;8577.485350878951;8582.742517724462;8419.705310314124;8484.957575212115;8508.234258916696;8520.40357174998;8530.189631984967;1985;2275.340151356109;2284.2918695204457;2310.295359915225;2310.8844557772127;2330.0330362899376;2353.8823058847074;2355.152145227725;2360.1857359211044;2360.232924299601;2312.1213938703268;2316.8494047886916;2324.5583339165505;2358.151065616377;2362.3739708977137;2237.7985981261763;2242.573910956913;2243.798058174772;2303.8041766449705;2313.34069790109;2282.5549017941507;2286.817054635625;2302.9193978210683;2311.179531266393;2315.9305220843403;8738;8792.296616270683;8803.515806630632;8803.691870784556;8813.07462716412;4961.454240033593;5045.672031317952;5090.847274581768;5096.311997880276;5098.847034588968;2998;3099.395617854519;3148.275896543808;3152.716255537013;3159.1154476746547;1060.842433697351;1068.2522234435926;1097.5774326884127;1101.531848964187;1101.801675698374;11943.10426717991;11983.10126740498;12028.63914082579;12053.035757139496;12069.155159138863;4281.400603915455;4330.545292744279;4481.439820022497;4538.659600529973;4543.386642803245;9268.25853931684;9276.07239276067;9284.907150928539;9291.256699464027;9333.859992100124;5119.692818430906;5150.845474635767;5155.32980712505;5159.845204643867;5165.380154381423;4183.037901282662;4196.978731862404;4318.093200427946;4632.768361581908;4819.542143496362;3570.6786389225094;3611.349957007764;3741.2330472253125;3750.0999760057935;3751.9062023449633;1114.3982249585295;1136.363636363639;1142.4801715219555;1143.5711608146944;1144.9141314401454;929.3169520402499;938.8921870400857;941.223490620241;943.0899182289124;972.4068318325957;5580.86047848807;5595.524380427628;5757.280339957505;5765.625234359753;5790.073588225863;928.3176865004217;929.4887811703536;945.9432434053979;973.4597298499401;978.6525783346951;3486.529318542015;3595.137167079882;3646.835892384796;3800.790956497364;3916.334223182009;10500.369977801356;10743.462826858782;10839.187060970302;10892.67321980326;10913.945430272797;10689.518971646294;10697.893021069845;10751.139908807276;10769.461526923622;10805.40570268627;7626.923730762622;7883.724069657649;7948.403869709795;8083.272505474418;8098.473599216032;5779.450952159538;5791.247137872049;5878.764849405976;5903.498202652822;6050.152978582913;9224.308176886627;9512.553918268743;9614.807703846023;9719.951400242953;9721.951390243003;9732.902670973199;9741.220702343653;9890.307678462439;9939.801203975736;9989.900100999188;6663.733450661919;7418.554886706815;7536.773896783106;7562.659680314289;7614.695412183451;8281.710140145065;8468.407211495136;8479.15208479147;8482.61828217744;8486.40595158333;7340.082489688789;7383.667734951832;7417.703291868264;7420.6289685516585;7591.127020392725;7083.433325334064;7490.363319117718;7498.925010750041;7558.811029724301;7685.654145563351;6672.299408562031;6790.660466976533;6798.320167983162;6803.727850886107;6821.113255276782;4888.853334399973;5054;5092.516210959953;5138.665986710852;5157.458466860926;4829.372181616367;4878.243872199815;5003.574696150868;5070.543651071422;5114.64197506171 15:18:10 INFO - PROCESS | 20585 | |4;prototype.html;321.51932860373745;329.30680916670406;336.2669380749964;337.88005258133364;343.90714507083106;5042.193249080148;5145.687849598352;5170.9482905170935;5193.688378697276;5245.26566280721;5117.106670531899;5139.408967968685;5146.948530514694;5169.6898186108765;5175.353080864892;4105.240530501852;4107.54816970133;4108.342665173573;4108.917821643566;4147.253494371012;3993.8003099845037;4039.515258169024;4069.857554985576;4114.835406583748;4130.938035929464;4068.7558746475306;4080.489938757655;4096.815643296059;4098.610631989956;4107.774072426016;4076.490438695178;4077.6533994610495;4077.9211695169956;4078.5105787305415;4078.632923036911;3651.178484840916;3656.067702735812;3661.41417373219;3683.208110256281;3690.8892733218045;4982.451930287665;5031.899362012739;5051.545360917498;5060.493950604947;5086.694798312114;4622.913615300402;4638.46657634373;4655.393889108253;4655.813767449298;4657.767111644438;5272.84538761369;5323.653962492425;5346.358436987547;5347.502699244218;5383.2732581101445;3766.3408903441787;3907.1404291056206;3951.5455722591983;3963.6432721054957;3965.484487016698;5303.469653034705;5512.6968016759065;5577.27495425592;5587.93246498794;5596.608237423382;3908.472356231929;3916.6083391661177;3926.2932672118723;4084.9183016339507;4094.1197642507004;4125.546189919107;4133.483314585676;4133.627973482401;4152.131540806649;4165.125323682;4573.199690054227;4697.037107392976;4700.929486057712;4704.647151463654;4732.787024583902;5400.972995134999;5406.756695948613;5411.945880541223;5445.591580631469;5458.972705136449;1412.3291436567754;1421.8862491000696;1425.1164278147614;1444.689391780751;1447.8055604126637;892.6340200517757;935.6584846530967;938.7512309238058;941.3786900645541;942.4627962061559;4614.861554153381;4650.860539167926;4652.62778977681;4666.533346665306;4680.648951328664;4829.1790395632825;4832.275158726219;4835.347228124158;4838;4839;4362.541933097043;4610.216263235258;4621.514740952219;4638.605718513897;4653.674242802971;2553.646567319324;2571.6785401824773;2575.459153577732;2578.23941937129;2582.1924652743155;4991;4992.251162325608;4994.976029913859;5005.824796132118;5011.273365362002;4709.222978208557;4929.87675308113;4937.975310123426;4949.510595030495;4950.302085363485;4926.433460152129;4926.630502712311;4969.82605608802;4995.375578052744;4996.275540046673;4835.637327200404;4870.2271773662715;4873.780679869344;4907.288443175791;4910.741059112848;4450.46594408673;4846.660733748604;4850.248211527219;4856.0575769692405;4866.878328041827;5027;5035.647504674637;5472;5511.200875872896;5630.4369563043365;3996.620321069494;4010.63904248619;4043.5552089269568;4045.575214602542;4045.8179381927293;5511.834644960658;5514.641548299348;5520.66875987442;5530.087535556588;5536.7231638418725;5161.993411284763;5305;5319.45735736632;5334.706591137525;5397.757100930389;5267.288915996444;5283.498067683564;5284.059404456845;5294.152935530296;5311.893762124813;5320.733963301742;5333.973330133324;5340.866478338073;5343.465653434625;5383.219433182245;5147.742612869267;5359.4104648487855;5360.678359298455;5376.973115134399;5378.757955891916;5202.687838729688;5213.687178769286;5228.189630607262;5250.474952504719;5255.395629502504 15:18:10 INFO - PROCESS | 20585 | |5;yui.html;734.9081364829397;747.2266204478366;781.5076501803863;785.4266385538557;825.4670012347157;15033.548993530198;15731.528054158394;16388.508344749676;16406.42577509789;16410;15677.529674109795;15726.606834829136;15797.921010394932;15823.208839558034;15914.84085159148;801.3549092980148;809.6073404398862;810.1979040749645;810.5541951926447;811.2860682599304;650.2099948562495;770.3682979956438;797.8683517219652;798.648594618369;803.1286054630733;844.7423535821572;849.4351256414477;849.6983570832358;850.5024560632038;850.5364576305928;841.1420351241729;843.7510934274404;843.9915600844005;844.0883845446933;844.4553263145299;505.1311743800657;604.5647134063468;615.062030403638;619.3311223878201;625.0093601641404;13666.93166534161;13695.657608559766;13702.10936289148;13708.725825483434;13731.862681373159;13112.737745245042;13679.452821887113;14419.927900360535;14547.563573092824;14714.0435871668;13305.334733263298;13484.595462136054;13645.727085458335;13648.823403118635;13840.30798460073;4429.734215947054;4435.014104197538;4468.731876087445;4518.593326600589;4544.613892762706;81775;82130.58934705288;82170;82263.17736822616;83234;9861.802763944681;10458.26792124544;10522.789544209227;11395.601153959571;11699.29804211733;21836.521739130436;21892.78107218939;22102.22642207515;22493.662595061087;22518.32445026652;7834.7257845976255;7947.761567152995;8003.919960800434;8013.078495972921;8268.131846156188;4342.739435633872;4396.296592545177;4451.265541185733;4571.702839315434;4604.217283061887;3067.0798760372245;3187.3147273336344;3197.8081315121167;3198.104530731399;3199.888003919898;561.9690916999523;565.7086600400797;569.1548051144048;577.96243244189;587.8794847056344;641.5893827950116;703.7853454696265;707.5294928872345;707.8725829350664;714.0360513307098;8939.195472407515;9447.244220462484;9548.37935534188;9693.854592180982;9740.902590974;677.9864402711918;695.57917459936;707.0384277382756;708.5713143548182;710.1868360726938;4444.31113177458;4540.931886021713;4566.657500687462;4614.953850461519;4648.372469716545;70669.29330706627;96833;124335;126602.36698816447;128013;100899.49550252201;105213;106352.46823765986;110094.44952775184;111486;56496.43503564912;82132;84566;94878;96745;9076.319276054455;9145.314101442551;9199.86200206984;9298;9482.241420686467;54539.45460545344;55587;56001.71999139978;56531;57356;46170.53829461797;70790.64604676944;75720.62139689266;78548;79406.60296698479;10994.120470362512;11149.163812713916;11331.402391908032;11482.885171148182;11621.360825154698;12567.622971310875;12811.167274127152;13014.609561713163;13125.278109704059;13334.666633334244;11398.886011139783;12103.945178365346;12732.23606583608;12870.935645321713;15358.846411535742;13167.47330106785;13575.932120339336;13695.657608559866;13738.931305343809;14033.087849289763;11323.660290191307;11479;12250.938745306217;12374.876251237372;12377.443015064164;11280.32318060919;11427.200095993201;11639.709007274885;11909.22590031645;12314.75370492603;10066.899331006596;12335.69160770988;12421.689457763267;12504.124711270124;12713.87286127127 15:18:10 INFO - PROCESS | 20585 | __end_tp_report 15:18:10 INFO - PROCESS | 20585 | __start_cc_report 15:18:10 INFO - PROCESS | 20585 | _x_x_mozilla_cycle_collect,956 15:18:10 INFO - PROCESS | 20585 | __end_cc_report 15:18:10 INFO - PROCESS | 20585 | __startTimestamp1472595490021__endTimestamp 15:18:10 INFO - PROCESS | 20585 | 15:18:10 INFO - PROCESS | 20585 | ------- Summary: start ------- 15:18:10 INFO - PROCESS | 20585 | Number of tests: 6 15:18:10 INFO - PROCESS | 20585 | 15:18:10 INFO - PROCESS | 20585 | [#0] dojo.html Cycles:165 Average:5160.56 Median:5347.95 stddev:554.85 (10.4%) stddev-sans-first:529.36 15:18:10 INFO - PROCESS | 20585 | Values: 2973.5 3012.1 3019.8 3046.9 3075.7 5069.7 5138.7 5151.2 5218.3 5248.5 5217.2 5232.4 5258.2 5261.7 5292.7 4687.6 4744.9 4772.0 4787.5 4943.9 4846.4 4880.8 4891.9 4896.0 4924.7 4634.3 4693.9 4711.1 4737.9 4783.9 4657.3 4672.8 4677.7 4735.6 4796.2 4692.9 4695.2 4722.8 4778.4 4782.6 5077.7 5128.7 5161.1 5162.1 5178.9 5458.3 5461.4 5475.0 5480.9 5481.1 5317.5 5534.3 5542.3 5584.7 5599.5 5116.8 5161.9 5170.3 5185.1 5217.8 5624.2 5643.9 5645.1 5645.6 5650.5 5260.2 5438.5 5440.6 5440.6 5445.0 5447.3 5475.5 5493.1 5532.9 5595.8 5497.3 5499.5 5501.9 5509.7 5516.4 5290.4 5507.4 5518.6 5529.5 5591.6 4304.2 4326.9 4337.3 4396.5 4396.7 3871.3 3879.3 3882.7 3921.0 3926.6 5293.9 5297.9 5347.9 5349.3 5352.1 5345.4 5394.5 5522.0 5562.1 5579.1 5340.5 5341.0 5345.0 5345.1 5391.4 4847.4 4854.3 4855.9 4861.6 4910.8 5515.9 5644.3 5653.4 5674.1 5783.6 5517.9 5523.5 5528.6 5539.7 5573.2 5739.1 5739.6 5740.2 5746.1 5746.8 5222.6 5436.7 5437.5 5459.4 5483.9 5572.7 5599.0 5603.3 5609.3 5654.4 5409.1 5466.1 5469.3 5471.1 5476.3 5175.2 5319.1 5340.0 5365.4 5494.9 5355.9 5358.8 5363.0 5363.9 5413.9 5339.9 5441.3 5444.0 5452.2 5501.6 5217.9 5315.9 5375.6 5409.9 5426.0 15:18:10 INFO - PROCESS | 20585 | 15:18:10 INFO - PROCESS | 20585 | [#1] ext.html Cycles:180 Average:69766.39 Median:23157.82 stddev:165166.08 (713.2%) stddev-sans-first:165547.66 15:18:10 INFO - PROCESS | 20585 | Values: 552.0 581.2 602.0 611.0 618.0 42172.4 43800.6 43826.1 43872.8 47220.3 44964.0 45406.5 45425.3 45466.0 45585.0 8864.3 9015.2 9017.1 9022.3 9022.6 8859.5 8940.9 8944.2 8952.5 8954.6 8941.8 8986.8 8987.4 8989.1 8997.3 8959.1 8993.3 8997.1 9001.6 9005.1 8909.1 8977.7 8982.4 8983.5 8983.6 41872.4 41881.0 42126.4 42131.0 42210.0 3453.4 3667.5 3671.7 3943.5 4165.5 31869.7 32387.2 32475.5 32562.7 33858.0 4158.1 4189.3 4222.5 4438.0 4455.6 330053.0 331369.0 332175.0 332709.0 333388.0 48580.3 49144.5 49157.5 55508.7 55978.7 53969.5 57577.7 58297.7 58746.4 65356.3 14570.9 14851.0 14851.6 14856.7 14859.9 10924.8 10960.3 10961.3 10976.2 10977.9 14832.5 16218.5 16506.3 16590.8 17035.7 5689.7 5947.2 5948.9 5984.6 6039.4 916.7 936.5 942.2 1034.3 1049.4 31767.2 31915.8 32148.0 32180.0 32368.8 1075.6 1083.2 1083.5 1102.4 1127.7 15635.2 16568.4 16743.7 16750.2 16785.7 875811.8 897494.0 898282.0 900138.0 902964.0 57687.4 58515.0 58556.4 58580.0 58703.0 1316.1 1330.2 1353.1 1362.4 1372.4 30066.6 32445.4 32565.5 32950.3 32954.2 51094.5 51514.7 51578.2 51638.0 51640.0 455517.0 455573.0 456445.0 457331.0 457532.0 26646.7 27847.7 27946.7 28138.2 28160.6 38144.0 39412.2 44599.0 49990.0 50643.2 38835.6 39937.8 40236.8 40661.6 42350.6 39752.6 40086.2 40504.6 41767.6 42285.8 39409.0 39762.6 39850.4 40153.6 40538.6 34329.7 36355.8 36616.8 36668.3 37174.0 26718.7 27426.7 27816.4 29538.4 29791.9 15:18:10 INFO - PROCESS | 20585 | 15:18:10 INFO - PROCESS | 20585 | [#2] jquery.html Cycles:180 Average:27741.30 Median:383.54 stddev:75505.99 (19686.7%) stddev-sans-first:75689.86 15:18:10 INFO - PROCESS | 20585 | Values: 382.8 384.3 388.6 393.2 415.7 14560.7 17905.5 18730.3 19491.9 19606.8 17857.5 18867.7 19721.3 19812.1 19888.3 5617.8 5683.9 5831.8 5868.9 5953.9 5652.5 5802.8 5847.9 5849.7 5851.4 5713.5 5716.2 5738.8 5760.3 5768.5 5725.7 5732.0 5733.0 5739.9 6496.3 5831.8 5844.7 5849.6 5851.9 5853.9 14072.6 18961.5 19191.9 22966.7 23129.3 2350.4 2360.3 2413.9 2471.7 2561.9 10135.7 10162.9 10589.3 10597.0 10823.4 1820.9 1824.3 1832.4 1855.2 1976.7 73514.0 78041.2 80011.0 81739.6 81938.1 10591.5 10921.3 11061.4 11165.8 11418.2 13851.3 14166.8 15714.8 15723.1 15736.0 7421.6 7500.2 7668.8 7796.7 7817.8 7040.8 7192.2 7233.1 7428.4 7438.0 4649.8 4655.7 4732.5 4806.1 4874.5 1989.4 1997.5 2013.4 2039.8 2060.8 868.0 891.8 953.8 957.2 959.3 18342.0 19397.2 19434.8 19451.0 19920.1 935.9 971.2 974.5 1001.8 1011.7 10318.6 10870.1 11005.3 11025.8 11111.2 450878.0 456821.0 457854.0 459422.0 461362.0 88353.9 89703.0 89901.6 91185.5 91350.0 965.1 980.9 1005.3 1006.7 1020.1 16680.3 17233.3 17660.0 17707.8 17783.3 38589.8 40294.4 41276.8 43479.6 44252.5 52994.0 54232.7 55596.4 56122.7 58095.0 7627.2 8535.7 8608.1 8801.2 8895.4 12741.8 13238.9 13467.6 13597.5 13634.4 11234.6 11311.2 11456.3 11761.8 11916.3 10687.0 10757.9 11381.7 11553.9 11832.3 11447.8 11735.1 11837.9 11916.1 12436.8 7579.7 7722.5 7783.5 7823.5 7952.7 11345.3 11416.7 11561.3 11633.7 12219.3 15:18:10 INFO - PROCESS | 20585 | 15:18:10 INFO - PROCESS | 20585 | [#3] mootools.html Cycles:180 Average:5599.06 Median:5097.58 stddev:3195.93 (62.7%) stddev-sans-first:3188.64 15:18:10 INFO - PROCESS | 20585 | Values: 1310.0 1430.9 1445.1 1584.2 1743.3 7942.6 8269.5 8364.8 8577.5 8582.7 8419.7 8485.0 8508.2 8520.4 8530.2 1985.0 2275.3 2284.3 2310.3 2310.9 2330.0 2353.9 2355.2 2360.2 2360.2 2312.1 2316.8 2324.6 2358.2 2362.4 2237.8 2242.6 2243.8 2303.8 2313.3 2282.6 2286.8 2302.9 2311.2 2315.9 8738.0 8792.3 8803.5 8803.7 8813.1 4961.5 5045.7 5090.8 5096.3 5098.8 2998.0 3099.4 3148.3 3152.7 3159.1 1060.8 1068.3 1097.6 1101.5 1101.8 11943.1 11983.1 12028.6 12053.0 12069.2 4281.4 4330.5 4481.4 4538.7 4543.4 9268.3 9276.1 9284.9 9291.3 9333.9 5119.7 5150.8 5155.3 5159.8 5165.4 4183.0 4197.0 4318.1 4632.8 4819.5 3570.7 3611.3 3741.2 3750.1 3751.9 1114.4 1136.4 1142.5 1143.6 1144.9 929.3 938.9 941.2 943.1 972.4 5580.9 5595.5 5757.3 5765.6 5790.1 928.3 929.5 945.9 973.5 978.7 3486.5 3595.1 3646.8 3800.8 3916.3 10500.4 10743.5 10839.2 10892.7 10913.9 10689.5 10697.9 10751.1 10769.5 10805.4 7626.9 7883.7 7948.4 8083.3 8098.5 5779.5 5791.2 5878.8 5903.5 6050.2 9224.3 9512.6 9614.8 9720.0 9722.0 9732.9 9741.2 9890.3 9939.8 9989.9 6663.7 7418.6 7536.8 7562.7 7614.7 8281.7 8468.4 8479.2 8482.6 8486.4 7340.1 7383.7 7417.7 7420.6 7591.1 7083.4 7490.4 7498.9 7558.8 7685.7 6672.3 6790.7 6798.3 6803.7 6821.1 4888.9 5054.0 5092.5 5138.7 5157.5 4829.4 4878.2 5003.6 5070.5 5114.6 15:18:10 INFO - PROCESS | 20585 | 15:18:10 INFO - PROCESS | 20585 | [#4] prototype.html Cycles:180 Average:4395.45 Median:4861.47 stddev:1240.10 (25.5%) stddev-sans-first:1205.29 15:18:10 INFO - PROCESS | 20585 | Values: 321.5 329.3 336.3 337.9 343.9 5042.2 5145.7 5170.9 5193.7 5245.3 5117.1 5139.4 5146.9 5169.7 5175.4 4105.2 4107.5 4108.3 4108.9 4147.3 3993.8 4039.5 4069.9 4114.8 4130.9 4068.8 4080.5 4096.8 4098.6 4107.8 4076.5 4077.7 4077.9 4078.5 4078.6 3651.2 3656.1 3661.4 3683.2 3690.9 4982.5 5031.9 5051.5 5060.5 5086.7 4622.9 4638.5 4655.4 4655.8 4657.8 5272.8 5323.7 5346.4 5347.5 5383.3 3766.3 3907.1 3951.5 3963.6 3965.5 5303.5 5512.7 5577.3 5587.9 5596.6 3908.5 3916.6 3926.3 4084.9 4094.1 4125.5 4133.5 4133.6 4152.1 4165.1 4573.2 4697.0 4700.9 4704.6 4732.8 5401.0 5406.8 5411.9 5445.6 5459.0 1412.3 1421.9 1425.1 1444.7 1447.8 892.6 935.7 938.8 941.4 942.5 4614.9 4650.9 4652.6 4666.5 4680.6 4829.2 4832.3 4835.3 4838.0 4839.0 4362.5 4610.2 4621.5 4638.6 4653.7 2553.6 2571.7 2575.5 2578.2 2582.2 4991.0 4992.3 4995.0 5005.8 5011.3 4709.2 4929.9 4938.0 4949.5 4950.3 4926.4 4926.6 4969.8 4995.4 4996.3 4835.6 4870.2 4873.8 4907.3 4910.7 4450.5 4846.7 4850.2 4856.1 4866.9 5027.0 5035.6 5472.0 5511.2 5630.4 3996.6 4010.6 4043.6 4045.6 4045.8 5511.8 5514.6 5520.7 5530.1 5536.7 5162.0 5305.0 5319.5 5334.7 5397.8 5267.3 5283.5 5284.1 5294.2 5311.9 5320.7 5334.0 5340.9 5343.5 5383.2 5147.7 5359.4 5360.7 5377.0 5378.8 5202.7 5213.7 5228.2 5250.5 5255.4 15:18:10 INFO - PROCESS | 20585 | 15:18:10 INFO - PROCESS | 20585 | [#5] yui.html Cycles:180 Average:20837.42 Median:4542.77 stddev:30540.13 (672.3%) stddev-sans-first:30588.50 15:18:10 INFO - PROCESS | 20585 | Values: 734.9 747.2 781.5 785.4 825.5 15033.5 15731.5 16388.5 16406.4 16410.0 15677.5 15726.6 15797.9 15823.2 15914.8 801.4 809.6 810.2 810.6 811.3 650.2 770.4 797.9 798.6 803.1 844.7 849.4 849.7 850.5 850.5 841.1 843.8 844.0 844.1 844.5 505.1 604.6 615.1 619.3 625.0 13666.9 13695.7 13702.1 13708.7 13731.9 13112.7 13679.5 14419.9 14547.6 14714.0 13305.3 13484.6 13645.7 13648.8 13840.3 4429.7 4435.0 4468.7 4518.6 4544.6 81775.0 82130.6 82170.0 82263.2 83234.0 9861.8 10458.3 10522.8 11395.6 11699.3 21836.5 21892.8 22102.2 22493.7 22518.3 7834.7 7947.8 8003.9 8013.1 8268.1 4342.7 4396.3 4451.3 4571.7 4604.2 3067.1 3187.3 3197.8 3198.1 3199.9 562.0 565.7 569.2 578.0 587.9 641.6 703.8 707.5 707.9 714.0 8939.2 9447.2 9548.4 9693.9 9740.9 678.0 695.6 707.0 708.6 710.2 4444.3 4540.9 4566.7 4615.0 4648.4 70669.3 96833.0 124335.0 126602.4 128013.0 100899.5 105213.0 106352.5 110094.4 111486.0 56496.4 82132.0 84566.0 94878.0 96745.0 9076.3 9145.3 9199.9 9298.0 9482.2 54539.5 55587.0 56001.7 56531.0 57356.0 46170.5 70790.6 75720.6 78548.0 79406.6 10994.1 11149.2 11331.4 11482.9 11621.4 12567.6 12811.2 13014.6 13125.3 13334.7 11398.9 12103.9 12732.2 12870.9 15358.8 13167.5 13575.9 13695.7 13738.9 14033.1 11323.7 11479.0 12250.9 12374.9 12377.4 11280.3 11427.2 11639.7 11909.2 12314.8 10066.9 12335.7 12421.7 12504.1 12713.9 15:18:10 INFO - PROCESS | 20585 | -------- Summary: end -------- 15:18:10 INFO - PROCESS | 20585 | 15:18:10 INFO - TEST-INFO | 20585: exit 0 15:18:10 INFO - TEST-OK | dromaeo_css | took 1115542ms 15:18:10 INFO - TEST-START | kraken 15:18:10 INFO - operating with platform_type : linux_ 15:18:10 INFO - Initialising browser for kraken test... 15:18:10 INFO - TEST-INFO | started process 20898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUkHJ0I/profile http://localhost:50669/getInfo.html) 15:18:15 INFO - PROCESS | 20898 | __metrics Screen width/height:1600/1200 15:18:15 INFO - PROCESS | 20898 | colorDepth:24 15:18:15 INFO - PROCESS | 20898 | Browser inner width/height: 1024/697 15:18:15 INFO - PROCESS | 20898 | __metrics 15:18:16 INFO - PROCESS | 20898 | 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" 15:18:16 INFO - PROCESS | 20898 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:18:17 INFO - PROCESS | 20898 | console.error: PushService: 15:18:17 INFO - PROCESS | 20898 | stateChangeProcessEnqueue: Error transitioning state 15:18:17 INFO - PROCESS | 20898 | UnknownError 15:18:17 INFO - TEST-INFO | 20898: exit 0 15:18:17 INFO - Browser initialized. 15:18:17 INFO - Running cycle 1/1 for kraken test... 15:18:17 INFO - TEST-INFO | started process 20978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUkHJ0I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:29 INFO - PROCESS | 20978 | RSS: Main: 180346880 15:18:29 INFO - PROCESS | 20978 | 15:18:32 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50669/tests/kraken/driver.html?testName=audio-beat-detection) 15:18:33 INFO - PROCESS | 20978 | RSS: Main: 242376704 15:18:33 INFO - PROCESS | 20978 | 15:18:35 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50669/tests/kraken/driver.html?testName=audio-dft) 15:18:36 INFO - PROCESS | 20978 | RSS: Main: 224874496 15:18:36 INFO - PROCESS | 20978 | 15:18:39 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50669/tests/kraken/driver.html?testName=audio-fft) 15:18:40 INFO - PROCESS | 20978 | RSS: Main: 302678016 15:18:40 INFO - PROCESS | 20978 | 15:18:42 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50669/tests/kraken/driver.html?testName=audio-oscillator) 15:18:42 INFO - PROCESS | 20978 | RSS: Main: 212234240 15:18:42 INFO - PROCESS | 20978 | 15:18:44 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50669/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:18:45 INFO - PROCESS | 20978 | RSS: Main: 213745664 15:18:45 INFO - PROCESS | 20978 | 15:18:48 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50669/tests/kraken/driver.html?testName=imaging-darkroom) 15:18:49 INFO - PROCESS | 20978 | RSS: Main: 252829696 15:18:49 INFO - PROCESS | 20978 | 15:18:52 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50669/tests/kraken/driver.html?testName=imaging-desaturate) 15:18:53 INFO - PROCESS | 20978 | RSS: Main: 251392000 15:18:53 INFO - PROCESS | 20978 | 15:18:55 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50669/tests/kraken/driver.html?testName=json-parse-financial) 15:18:56 INFO - PROCESS | 20978 | RSS: Main: 251531264 15:18:56 INFO - PROCESS | 20978 | 15:18:58 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50669/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:18:58 INFO - PROCESS | 20978 | RSS: Main: 214093824 15:18:58 INFO - PROCESS | 20978 | 15:19:00 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50669/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:19:01 INFO - PROCESS | 20978 | RSS: Main: 221151232 15:19:01 INFO - PROCESS | 20978 | 15:19:03 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50669/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:19:03 INFO - PROCESS | 20978 | RSS: Main: 222253056 15:19:03 INFO - PROCESS | 20978 | 15:19:06 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50669/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:19:06 INFO - PROCESS | 20978 | RSS: Main: 223866880 15:19:06 INFO - PROCESS | 20978 | 15:19:09 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50669/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:19:10 INFO - PROCESS | 20978 | RSS: Main: 221777920 15:19:10 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | Cycle 1(1): loaded http://localhost:50669/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50669/tests/kraken/driver.html?testName=ai-astar) 15:19:12 INFO - PROCESS | 20978 | RSS: Main: 272683008 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | __start_tp_report 15:19:12 INFO - PROCESS | 20978 | _x_x_mozilla_page_load 15:19:12 INFO - PROCESS | 20978 | _x_x_mozilla_page_load_details 15:19:12 INFO - PROCESS | 20978 | |i|pagename|runs| 15:19:12 INFO - PROCESS | 20978 | |0;ai-astar;113;114;130;113;112;113;112;112;114;113 15:19:12 INFO - PROCESS | 20978 | |1;audio-beat-detection;154;117;153;179;118;148;146;119;172;123 15:19:12 INFO - PROCESS | 20978 | |2;audio-dft;160;160;162;162;160;161;161;161;162;162 15:19:12 INFO - PROCESS | 20978 | |3;audio-fft;74;76;75;175;77;77;75;75;166;75 15:19:12 INFO - PROCESS | 20978 | |4;audio-oscillator;83;83;153;81;82;82;152;82;82;153 15:19:12 INFO - PROCESS | 20978 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;116;117 15:19:12 INFO - PROCESS | 20978 | |6;imaging-darkroom;146;146;145;146;146;146;145;146;146;146 15:19:12 INFO - PROCESS | 20978 | |7;imaging-desaturate;96;95;94;95;96;95;95;95;95;95 15:19:12 INFO - PROCESS | 20978 | |8;json-parse-financial;54;54;53;53;55;54;55;54;54;53 15:19:12 INFO - PROCESS | 20978 | |9;json-stringify-tinderbox;62;63;62;62;63;62;62;63;62;62 15:19:12 INFO - PROCESS | 20978 | |10;stanford-crypto-aes;85;79;78;87;84;79;79;78;80;81 15:19:12 INFO - PROCESS | 20978 | |11;stanford-crypto-ccm;135;124;125;127;128;126;124;138;174;134 15:19:12 INFO - PROCESS | 20978 | |12;stanford-crypto-pbkdf2;167;174;168;164;166;166;160;160;160;162 15:19:12 INFO - PROCESS | 20978 | |13;stanford-crypto-sha256-iterative;67;66;67;65;65;64;65;71;64;63 15:19:12 INFO - PROCESS | 20978 | __end_tp_report 15:19:12 INFO - PROCESS | 20978 | __start_cc_report 15:19:12 INFO - PROCESS | 20978 | _x_x_mozilla_cycle_collect,1709 15:19:12 INFO - PROCESS | 20978 | __end_cc_report 15:19:12 INFO - PROCESS | 20978 | __startTimestamp1472595552250__endTimestamp 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | ------- Summary: start ------- 15:19:12 INFO - PROCESS | 20978 | Number of tests: 14 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#0] ai-astar Cycles:10 Average:114.60 Median:113.00 stddev:5.46 (4.8%) stddev-sans-first:5.76 15:19:12 INFO - PROCESS | 20978 | Values: 113.0 114.0 130.0 113.0 112.0 113.0 112.0 112.0 114.0 113.0 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:150.50 stddev:22.78 (15.1%) stddev-sans-first:23.80 15:19:12 INFO - PROCESS | 20978 | Values: 154.0 117.0 153.0 179.0 118.0 148.0 146.0 119.0 172.0 123.0 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.83 15:19:12 INFO - PROCESS | 20978 | Values: 160.0 160.0 162.0 162.0 160.0 161.0 161.0 161.0 162.0 162.0 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.00 stddev:40.12 (53.5%) stddev-sans-first:41.87 15:19:12 INFO - PROCESS | 20978 | Values: 74.0 76.0 75.0 175.0 77.0 77.0 75.0 75.0 166.0 75.0 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:82.00 stddev:34.07 (41.6%) stddev-sans-first:35.34 15:19:12 INFO - PROCESS | 20978 | Values: 83.0 83.0 153.0 81.0 82.0 82.0 152.0 82.0 82.0 153.0 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 15:19:12 INFO - PROCESS | 20978 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 15:19:12 INFO - PROCESS | 20978 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 15:19:12 INFO - PROCESS | 20978 | Values: 96.0 95.0 94.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 15:19:12 INFO - PROCESS | 20978 | Values: 54.0 54.0 53.0 53.0 55.0 54.0 55.0 54.0 54.0 53.0 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 15:19:12 INFO - PROCESS | 20978 | Values: 62.0 63.0 62.0 62.0 63.0 62.0 62.0 63.0 62.0 62.0 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.50 stddev:3.20 (4.0%) stddev-sans-first:3.05 15:19:12 INFO - PROCESS | 20978 | Values: 85.0 79.0 78.0 87.0 84.0 79.0 79.0 78.0 80.0 81.0 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:131.00 stddev:15.07 (11.5%) stddev-sans-first:15.98 15:19:12 INFO - PROCESS | 20978 | Values: 135.0 124.0 125.0 127.0 128.0 126.0 124.0 138.0 174.0 134.0 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:166.00 stddev:4.47 (2.7%) stddev-sans-first:4.67 15:19:12 INFO - PROCESS | 20978 | Values: 167.0 174.0 168.0 164.0 166.0 166.0 160.0 160.0 160.0 162.0 15:19:12 INFO - PROCESS | 20978 | 15:19:12 INFO - PROCESS | 20978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.50 stddev:2.26 (3.5%) stddev-sans-first:2.35 15:19:12 INFO - PROCESS | 20978 | Values: 67.0 66.0 67.0 65.0 65.0 64.0 65.0 71.0 64.0 63.0 15:19:12 INFO - PROCESS | 20978 | -------- Summary: end -------- 15:19:12 INFO - PROCESS | 20978 | 15:19:13 INFO - TEST-INFO | 20978: exit 0 15:19:13 INFO - TEST-OK | kraken | took 62490ms 15:19:13 INFO - SUITE-END | took 1178s 15:19:13 INFO - Completed test suite (00:19:38) 15:19:13 INFO - javascript benchmark 15:19:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2973.5093709537928, 3012.1264833198375, 3019.758419326453, 3046.893358732445, 3075.738562222211, 5069.746512674361, 5138.743062846852, 5151.15006024006, 5218.347706536683, 5248.501392367729, 5217.191335343018, 5232.398274198468, 5258.211268309756, 5261.710605916673, 5292.735363231833, 4687.554682305184, 4744.881377965561, 4772.021735544223, 4787.54518320759, 4943.9258411123865, 4846.39420072491, 4880.755962201893, 4891.8777030574165, 4895.9755201224125, 4924.70451772893, 4634.3048542718525, 4693.859184224479, 4711.081339138835, 4737.928931066037, 4783.904321913559, 4657.278121891112, 4672.836450724209, 4677.7193368398, 4735.550122738335, 4796.2326027835725, 4692.859214223578, 4695.1548721230165, 4722.787474563653, 4778.402699662543, 4782.617390608743, 5077.746112694387, 5128.666636668642, 5161.148410512261, 5162.096633089194, 5178.948210517884, 5458.317710286215, 5461.399246082928, 5474.972625136888, 5480.890382192374, 5481.12302031677, 5317.521423071903, 5534.280543529356, 5542.251796007527, 5584.664920104766, 5599.468050535193, 5116.76974536143, 5161.870953226162, 5170.25031370453, 5185.118529849935, 5217.765200565984, 5624.21261023457, 5643.943560564342, 5645.125005624135, 5645.633033852787, 5650.5479561634975, 5260.237265596544, 5438.537724293479, 5440.591955603346, 5440.591955603346, 5445.0, 5447.319085114361, 5475.479829416199, 5493.148561972901, 5532.917006244909, 5595.776168953196, 5497.285352904177, 5499.532539734168, 5501.927124210821, 5509.696966666872, 5516.365617953907, 5290.444503327172, 5507.394186639466, 5518.641288316247, 5529.502344788988, 5591.6365436246515, 4304.203722311382, 4326.935095973563, 4337.327714204303, 4396.472423309224, 4396.670249731283, 3871.3031654302495, 3879.282332768447, 3882.6893848492055, 3921.039345360348, 3926.587708290588, 5293.894122117613, 5297.860959893641, 5347.946520534822, 5349.304590403222, 5352.116900711417, 5345.412004679482, 5394.541463975527, 5522.0, 5562.082256427644, 5579.13523403873, 5340.465953404629, 5340.973295133499, 5345.037893179187, 5345.064613692588, 5391.406945236021, 4847.418309802846, 4854.271859221145, 4855.878603034952, 4861.6353773467135, 4910.779014944336, 5515.917261241085, 5644.294463192101, 5653.434656534314, 5674.06377947634, 5783.59514833966, 5517.944820551743, 5523.530499907392, 5528.612997090326, 5539.695316757617, 5573.164025396223, 5739.139129130664, 5739.598228124159, 5740.225069615549, 5746.13807928814, 5746.798862039808, 5222.582193424441, 5436.67379957188, 5437.537809286255, 5459.399466058651, 5483.917741233805, 5572.665640061609, 5599.048161812583, 5603.32760068778, 5609.326880774333, 5654.434556544313, 5409.134538473825, 5466.098093814476, 5469.288992430958, 5471.069918113851, 5476.315460567429, 5175.223716442413, 5319.095753721799, 5339.973300133474, 5365.38298095724, 5494.917576236439, 5355.919661205163, 5358.839234822962, 5363.0, 5363.892722145613, 5413.918791218213, 5339.919901201408, 5441.347038355264, 5443.992861320668, 5452.2094296327605, 5501.559875209893, 5217.921731173959, 5315.920261196008, 5375.623706340519, 5409.864753381197, 5426.0], "value": 5124.937465739055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.0070150891501, 581.2298704216912, 602.0006788730706, 610.960287581307, 617.966011869347, 42172.36741448877, 43800.56199438005, 43826.12347753047, 43872.78063609677, 47220.29169562459, 44964.0, 45406.54593454064, 45425.31862022064, 45466.0, 45585.0, 8864.290856731446, 9015.188633023026, 9017.053209413016, 9022.278217742565, 9022.593983270735, 8859.468431894107, 8940.865887011667, 8944.150305720947, 8952.462852228855, 8954.641814327419, 8941.821163576724, 8986.775330616754, 8987.37088403812, 8989.056149104315, 8997.280217582578, 8959.059298773633, 8993.280537557046, 8997.055309192507, 9001.594928228213, 9005.099490050943, 8909.064548222474, 8977.730668079968, 8982.416142950688, 8983.46099234048, 8983.55082245885, 41872.37191442131, 41881.0, 42126.36810447846, 42131.0, 42210.0, 3453.4129198036144, 3667.5232219811255, 3671.650143907901, 3943.507061617298, 4165.541790403053, 31869.681303187135, 32387.19032024218, 32475.51286730701, 32562.674373256203, 33858.0, 4158.147579746144, 4189.2668782962855, 4222.472190976128, 4438.0, 4455.643548516111, 330053.0, 331368.9999999976, 332175.0, 332709.0, 333388.0, 48580.271295930586, 49144.50855491399, 49157.50842491529, 55508.72245638746, 55978.72010639921, 53969.460305396446, 57577.712111440014, 58297.708511457175, 58746.41253587495, 65356.346436535976, 14570.854291457163, 14851.0, 14851.628709282355, 14856.702865942836, 14859.925700371645, 10924.836127458095, 10960.342379457257, 10961.287516311573, 10976.243800991802, 10977.945110274557, 14832.480863169738, 16218.513444596681, 16506.25721842496, 16590.83409165893, 17035.659286814443, 5689.715514224355, 5947.2455625590555, 5948.85127871798, 5984.581079324405, 6039.4262545058145, 916.706653870755, 936.5176933879058, 942.2085448223526, 1034.3483605328595, 1049.4385503755607, 31767.205819854687, 31915.840420797747, 32148.0, 32180.0, 32368.838155809543, 1075.634284343327, 1083.182197440943, 1083.4853444613902, 1102.3716481605409, 1127.656064900197, 15635.218239088, 16568.420105296256, 16743.665126697397, 16750.16249187536, 16785.748213776802, 875811.7978792004, 897494.0, 898282.0, 900138.0, 902964.0, 57687.42312576905, 58515.0, 58556.4144358551, 58580.0, 58703.0, 1316.0918965913488, 1330.221820235154, 1353.0731448957495, 1362.420971087284, 1372.4235820955223, 30066.62882069954, 32445.35109297848, 32565.511517327734, 32950.340993179525, 32954.17614559655, 51094.48905511046, 51514.74242628763, 51578.22632660438, 51638.0, 51640.0, 455517.0, 455573.0, 456445.0, 457331.0, 457532.0, 26646.733532664424, 27847.72152278451, 27946.720532795225, 28138.155855324374, 28160.577591335736, 38144.0, 39412.2117557653, 44599.0, 49990.0, 50643.24035139549, 38835.611643883196, 39937.80031099826, 40236.798816005736, 40661.59338406578, 42350.576494234665, 39752.60247397489, 40086.1982760349, 40504.59495405126, 41767.58232417637, 42285.788571056946, 39409.0, 39762.60237397589, 39850.402243965786, 40153.59846401498, 40538.59461405348, 34329.65670343264, 36355.818220908724, 36616.81691591525, 36668.26663466769, 37174.0, 26718.732812672402, 27426.725732742416, 27816.443671126868, 29538.37538935379, 29791.85104074466], "value": 19934.555477448415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.7665124274193, 384.30824515871427, 388.6123060563582, 393.21945937314433, 415.6923876331514, 14560.708785824278, 17905.462836114923, 18730.344437944674, 19491.902540487295, 19606.803931960676, 17857.464276071707, 18867.716984245246, 19721.309754158607, 19812.10845511952, 19888.303909363174, 5617.8033768818095, 5683.943160568393, 5831.7958871439505, 5868.911966320508, 5953.88092238155, 5652.547796176316, 5802.767889284423, 5847.8538036549, 5849.736761845727, 5851.385604511529, 5713.457221563945, 5716.1997320375185, 5738.7991420300295, 5760.308762948452, 5768.480836724694, 5725.685087320196, 5731.971340143294, 5732.971335143339, 5739.942600574003, 6496.285408605049, 5831.795887143972, 5844.736986835603, 5849.61977471463, 5851.882962340729, 5853.88292234153, 14072.648183795385, 18961.525961851064, 19191.904040479847, 22966.65550016751, 23129.306120816404, 2350.3771500552366, 2360.280114565057, 2413.855168689884, 2471.6910386201725, 2561.859097749623, 10135.695929122137, 10162.898371016343, 10589.258751887372, 10597.046265836112, 10823.404712740796, 1820.8816426932208, 1824.3158815444208, 1832.3769918227867, 1855.2208072609537, 1976.743023406948, 73514.0, 78041.21958780453, 80011.0, 81739.5913020437, 81938.14103204939, 10591.523381447852, 10921.290116142425, 11061.391623460788, 11165.776684466266, 11418.20072594927, 13851.30743462843, 14166.787498187536, 15714.764278535831, 15723.135227562365, 15735.977161484467, 7421.628918554051, 7500.212477689873, 7668.80827979305, 7796.688132474751, 7817.843643127219, 7040.788776336718, 7192.244814294529, 7233.132024157029, 7428.405727541784, 7437.962810185914, 4649.767511624405, 4655.720656760537, 4732.52674732524, 4806.086843499724, 4874.46380898101, 1989.353460125465, 1997.470670272379, 2013.3959812056326, 2039.775624681284, 2060.8047332547085, 867.9566021699017, 891.772597987509, 953.7758626722715, 957.1911734584265, 959.2757468111671, 18342.0, 19397.2241110354, 19434.80565194358, 19451.0, 19920.103595338245, 935.9298052646079, 971.2084651009404, 974.5322245322285, 1001.7578203028193, 1011.726833754882, 10318.638847640446, 10870.130389568816, 11005.284656497302, 11025.779484410266, 11111.222214444912, 450878.0, 456821.0, 457854.0, 459422.0, 461362.0, 88353.8633818586, 89703.0, 89901.55049224712, 91185.54407227921, 91350.0, 965.0590674092844, 980.9411435313904, 1005.2510879394897, 1006.6979906028163, 1020.1175982774846, 16680.33114701642, 17233.31066757366, 17660.0, 17707.822921771134, 17783.28866845312, 38589.80705096456, 40294.39558406568, 41276.793616031726, 43479.56520434755, 44252.45116421038, 52994.0, 54232.72883635714, 55596.44403555913, 56122.71938640281, 58095.0, 7627.237276272328, 8535.658573656985, 8608.09614990417, 8801.207891289814, 8895.421797583136, 12741.8088728671, 13238.933805330911, 13467.59597212046, 13597.456101756216, 13634.386452609855, 11234.606788762354, 11311.208215424842, 11456.255343402652, 11761.764764704829, 11916.331713559935, 10687.0, 10757.892421075689, 11381.658550243506, 11553.942230288794, 11832.290062595928, 11447.771044579229, 11735.119866010255, 11837.881621183678, 11916.10629202796, 12436.751264974831, 7579.696812127674, 7722.498037627536, 7783.455158138876, 7823.530588164728, 7952.721654742057, 11345.262557933707, 11416.657500275005, 11561.30632162073, 11633.6509904703, 12219.26684398939], "value": 9065.244764823181, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.9803502947452, 1430.8783753380958, 1445.0534899640736, 1584.1841451652401, 1743.2678275124454, 7942.642581083851, 8269.462484938482, 8364.790880227989, 8577.485350878951, 8582.742517724462, 8419.705310314124, 8484.957575212115, 8508.234258916696, 8520.40357174998, 8530.189631984967, 1985.0, 2275.340151356109, 2284.2918695204457, 2310.295359915225, 2310.8844557772127, 2330.0330362899376, 2353.8823058847074, 2355.152145227725, 2360.1857359211044, 2360.232924299601, 2312.1213938703268, 2316.8494047886916, 2324.5583339165505, 2358.151065616377, 2362.3739708977137, 2237.7985981261763, 2242.573910956913, 2243.798058174772, 2303.8041766449705, 2313.34069790109, 2282.5549017941507, 2286.817054635625, 2302.9193978210683, 2311.179531266393, 2315.9305220843403, 8738.0, 8792.296616270683, 8803.515806630632, 8803.691870784556, 8813.07462716412, 4961.454240033593, 5045.672031317952, 5090.847274581768, 5096.311997880276, 5098.847034588968, 2998.0, 3099.395617854519, 3148.275896543808, 3152.716255537013, 3159.1154476746547, 1060.842433697351, 1068.2522234435926, 1097.5774326884127, 1101.531848964187, 1101.801675698374, 11943.10426717991, 11983.10126740498, 12028.63914082579, 12053.035757139496, 12069.155159138863, 4281.400603915455, 4330.545292744279, 4481.439820022497, 4538.659600529973, 4543.386642803245, 9268.25853931684, 9276.07239276067, 9284.907150928539, 9291.256699464027, 9333.859992100124, 5119.692818430906, 5150.845474635767, 5155.32980712505, 5159.845204643867, 5165.380154381423, 4183.037901282662, 4196.978731862404, 4318.093200427946, 4632.768361581908, 4819.542143496362, 3570.6786389225094, 3611.349957007764, 3741.2330472253125, 3750.0999760057935, 3751.9062023449633, 1114.3982249585295, 1136.363636363639, 1142.4801715219555, 1143.5711608146944, 1144.9141314401454, 929.3169520402499, 938.8921870400857, 941.223490620241, 943.0899182289124, 972.4068318325957, 5580.86047848807, 5595.524380427628, 5757.280339957505, 5765.625234359753, 5790.073588225863, 928.3176865004217, 929.4887811703536, 945.9432434053979, 973.4597298499401, 978.6525783346951, 3486.529318542015, 3595.137167079882, 3646.835892384796, 3800.790956497364, 3916.334223182009, 10500.369977801356, 10743.462826858782, 10839.187060970302, 10892.67321980326, 10913.945430272797, 10689.518971646294, 10697.893021069845, 10751.139908807276, 10769.461526923622, 10805.40570268627, 7626.923730762622, 7883.724069657649, 7948.403869709795, 8083.272505474418, 8098.473599216032, 5779.450952159538, 5791.247137872049, 5878.764849405976, 5903.498202652822, 6050.152978582913, 9224.308176886627, 9512.553918268743, 9614.807703846023, 9719.951400242953, 9721.951390243003, 9732.902670973199, 9741.220702343653, 9890.307678462439, 9939.801203975736, 9989.900100999188, 6663.733450661919, 7418.554886706815, 7536.773896783106, 7562.659680314289, 7614.695412183451, 8281.710140145065, 8468.407211495136, 8479.15208479147, 8482.61828217744, 8486.40595158333, 7340.082489688789, 7383.667734951832, 7417.703291868264, 7420.6289685516585, 7591.127020392725, 7083.433325334064, 7490.363319117718, 7498.925010750041, 7558.811029724301, 7685.654145563351, 6672.299408562031, 6790.660466976533, 6798.320167983162, 6803.727850886107, 6821.113255276782, 4888.853334399973, 5054.0, 5092.516210959953, 5138.665986710852, 5157.458466860926, 4829.372181616367, 4878.243872199815, 5003.574696150868, 5070.543651071422, 5114.64197506171], "value": 4478.063194611329, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.51932860373745, 329.30680916670406, 336.2669380749964, 337.88005258133364, 343.90714507083106, 5042.193249080148, 5145.687849598352, 5170.9482905170935, 5193.688378697276, 5245.26566280721, 5117.106670531899, 5139.408967968685, 5146.948530514694, 5169.6898186108765, 5175.353080864892, 4105.240530501852, 4107.54816970133, 4108.342665173573, 4108.917821643566, 4147.253494371012, 3993.8003099845037, 4039.515258169024, 4069.857554985576, 4114.835406583748, 4130.938035929464, 4068.7558746475306, 4080.489938757655, 4096.815643296059, 4098.610631989956, 4107.774072426016, 4076.490438695178, 4077.6533994610495, 4077.9211695169956, 4078.5105787305415, 4078.632923036911, 3651.178484840916, 3656.067702735812, 3661.41417373219, 3683.208110256281, 3690.8892733218045, 4982.451930287665, 5031.899362012739, 5051.545360917498, 5060.493950604947, 5086.694798312114, 4622.913615300402, 4638.46657634373, 4655.393889108253, 4655.813767449298, 4657.767111644438, 5272.84538761369, 5323.653962492425, 5346.358436987547, 5347.502699244218, 5383.2732581101445, 3766.3408903441787, 3907.1404291056206, 3951.5455722591983, 3963.6432721054957, 3965.484487016698, 5303.469653034705, 5512.6968016759065, 5577.27495425592, 5587.93246498794, 5596.608237423382, 3908.472356231929, 3916.6083391661177, 3926.2932672118723, 4084.9183016339507, 4094.1197642507004, 4125.546189919107, 4133.483314585676, 4133.627973482401, 4152.131540806649, 4165.125323682, 4573.199690054227, 4697.037107392976, 4700.929486057712, 4704.647151463654, 4732.787024583902, 5400.972995134999, 5406.756695948613, 5411.945880541223, 5445.591580631469, 5458.972705136449, 1412.3291436567754, 1421.8862491000696, 1425.1164278147614, 1444.689391780751, 1447.8055604126637, 892.6340200517757, 935.6584846530967, 938.7512309238058, 941.3786900645541, 942.4627962061559, 4614.861554153381, 4650.860539167926, 4652.62778977681, 4666.533346665306, 4680.648951328664, 4829.1790395632825, 4832.275158726219, 4835.347228124158, 4838.0, 4839.0, 4362.541933097043, 4610.216263235258, 4621.514740952219, 4638.605718513897, 4653.674242802971, 2553.646567319324, 2571.6785401824773, 2575.459153577732, 2578.23941937129, 2582.1924652743155, 4991.0, 4992.251162325608, 4994.976029913859, 5005.824796132118, 5011.273365362002, 4709.222978208557, 4929.87675308113, 4937.975310123426, 4949.510595030495, 4950.302085363485, 4926.433460152129, 4926.630502712311, 4969.82605608802, 4995.375578052744, 4996.275540046673, 4835.637327200404, 4870.2271773662715, 4873.780679869344, 4907.288443175791, 4910.741059112848, 4450.46594408673, 4846.660733748604, 4850.248211527219, 4856.0575769692405, 4866.878328041827, 5027.0, 5035.647504674637, 5472.0, 5511.200875872896, 5630.4369563043365, 3996.620321069494, 4010.63904248619, 4043.5552089269568, 4045.575214602542, 4045.8179381927293, 5511.834644960658, 5514.641548299348, 5520.66875987442, 5530.087535556588, 5536.7231638418725, 5161.993411284763, 5305.0, 5319.45735736632, 5334.706591137525, 5397.757100930389, 5267.288915996444, 5283.498067683564, 5284.059404456845, 5294.152935530296, 5311.893762124813, 5320.733963301742, 5333.973330133324, 5340.866478338073, 5343.465653434625, 5383.219433182245, 5147.742612869267, 5359.4104648487855, 5360.678359298455, 5376.973115134399, 5378.757955891916, 5202.687838729688, 5213.687178769286, 5228.189630607262, 5250.474952504719, 5255.395629502504], "value": 4008.377732465614, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.9081364829397, 747.2266204478366, 781.5076501803863, 785.4266385538557, 825.4670012347157, 15033.548993530198, 15731.528054158394, 16388.508344749676, 16406.42577509789, 16410.0, 15677.529674109795, 15726.606834829136, 15797.921010394932, 15823.208839558034, 15914.84085159148, 801.3549092980148, 809.6073404398862, 810.1979040749645, 810.5541951926447, 811.2860682599304, 650.2099948562495, 770.3682979956438, 797.8683517219652, 798.648594618369, 803.1286054630733, 844.7423535821572, 849.4351256414477, 849.6983570832358, 850.5024560632038, 850.5364576305928, 841.1420351241729, 843.7510934274404, 843.9915600844005, 844.0883845446933, 844.4553263145299, 505.1311743800657, 604.5647134063468, 615.062030403638, 619.3311223878201, 625.0093601641404, 13666.93166534161, 13695.657608559766, 13702.10936289148, 13708.725825483434, 13731.862681373159, 13112.737745245042, 13679.452821887113, 14419.927900360535, 14547.563573092824, 14714.0435871668, 13305.334733263298, 13484.595462136054, 13645.727085458335, 13648.823403118635, 13840.30798460073, 4429.734215947054, 4435.014104197538, 4468.731876087445, 4518.593326600589, 4544.613892762706, 81775.0, 82130.58934705288, 82170.0, 82263.17736822616, 83234.0, 9861.802763944681, 10458.26792124544, 10522.789544209227, 11395.601153959571, 11699.29804211733, 21836.521739130436, 21892.78107218939, 22102.22642207515, 22493.662595061087, 22518.32445026652, 7834.7257845976255, 7947.761567152995, 8003.919960800434, 8013.078495972921, 8268.131846156188, 4342.739435633872, 4396.296592545177, 4451.265541185733, 4571.702839315434, 4604.217283061887, 3067.0798760372245, 3187.3147273336344, 3197.8081315121167, 3198.104530731399, 3199.888003919898, 561.9690916999523, 565.7086600400797, 569.1548051144048, 577.96243244189, 587.8794847056344, 641.5893827950116, 703.7853454696265, 707.5294928872345, 707.8725829350664, 714.0360513307098, 8939.195472407515, 9447.244220462484, 9548.37935534188, 9693.854592180982, 9740.902590974, 677.9864402711918, 695.57917459936, 707.0384277382756, 708.5713143548182, 710.1868360726938, 4444.31113177458, 4540.931886021713, 4566.657500687462, 4614.953850461519, 4648.372469716545, 70669.29330706627, 96833.0, 124335.0, 126602.36698816447, 128013.0, 100899.49550252201, 105213.0, 106352.46823765986, 110094.44952775184, 111486.0, 56496.43503564912, 82132.0, 84566.0, 94878.0, 96745.0, 9076.319276054455, 9145.314101442551, 9199.86200206984, 9298.0, 9482.241420686467, 54539.45460545344, 55587.0, 56001.71999139978, 56531.0, 57356.0, 46170.53829461797, 70790.64604676944, 75720.62139689266, 78548.0, 79406.60296698479, 10994.120470362512, 11149.163812713916, 11331.402391908032, 11482.885171148182, 11621.360825154698, 12567.622971310875, 12811.167274127152, 13014.609561713163, 13125.278109704059, 13334.666633334244, 11398.886011139783, 12103.945178365346, 12732.23606583608, 12870.935645321713, 15358.846411535742, 13167.47330106785, 13575.932120339336, 13695.657608559866, 13738.931305343809, 14033.087849289763, 11323.660290191307, 11479.0, 12250.938745306217, 12374.876251237372, 12377.443015064164, 11280.32318060919, 11427.200095993201, 11639.709007274885, 11909.22590031645, 12314.75370492603, 10066.899331006596, 12335.69160770988, 12421.689457763267, 12504.124711270124, 12713.87286127127], "value": 7450.860386438854, "unit": "score"}], "name": "dromaeo_css", "value": 7060.435442284081, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 130.0, 113.0, 112.0, 113.0, 112.0, 112.0, 114.0, 113.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 117.0, 153.0, 179.0, 118.0, 148.0, 146.0, 119.0, 172.0, 123.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 162.0, 160.0, 161.0, 161.0, 161.0, 162.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 175.0, 77.0, 77.0, 75.0, 75.0, 166.0, 75.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 153.0, 81.0, 82.0, 82.0, 152.0, 82.0, 82.0, 153.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 55.0, 54.0, 55.0, 54.0, 54.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 78.0, 87.0, 84.0, 79.0, 79.0, 78.0, 80.0, 81.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 124.0, 125.0, 127.0, 128.0, 126.0, 124.0, 138.0, 174.0, 134.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 174.0, 168.0, 164.0, 166.0, 166.0, 160.0, 160.0, 160.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 65.0, 65.0, 64.0, 65.0, 71.0, 64.0, 63.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1535.4, "alertThreshold": 2.0}]} 15:19:13 INFO - Return code: 0 15:19:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:19:14 INFO - # TBPL SUCCESS # 15:19:14 INFO - Running post-action listener: _resource_record_post_action 15:19:14 INFO - [mozharness: 2016-08-30 22:19:14.040373Z] Finished run-tests step (success) 15:19:14 INFO - Running post-run listener: _resource_record_post_run 15:19:14 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 418340864; Read time: 312; Write time: 282936 15:19:14 INFO - TinderboxPrint: CPU usage
13.1% 15:19:14 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 312 15:19:14 INFO - TinderboxPrint: I/O write bytes / time
418,340,864 / 282,936 15:19:14 INFO - TinderboxPrint: CPU idle
8,293.3 (86.9%) 15:19:14 INFO - TinderboxPrint: CPU user
1,195.2 (12.5%) 15:19:14 INFO - TinderboxPrint: Swap in / out
0 / 0 15:19:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 129708032; Read time: 0; Write time: 97424 15:19:14 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288632832; Read time: 300; Write time: 185512 15:19:14 INFO - Running post-run listener: _upload_blobber_files 15:19:14 INFO - Blob upload gear active. 15:19:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:19:14 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 15:19:14 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'] 15:19:14 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 15:19:15 INFO - (blobuploader) - INFO - Open directory for files ... 15:19:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:19:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:19:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:15 INFO - (blobuploader) - INFO - Done attempting. 15:19:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:19:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:19:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:19 INFO - (blobuploader) - INFO - Done attempting. 15:19:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:19:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:19:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:20 INFO - (blobuploader) - INFO - Done attempting. 15:19:20 INFO - (blobuploader) - INFO - Iteration through files over. 15:19:20 INFO - Return code: 0 15:19:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:19:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:19:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/816518d145911103daae886e7b9ca6ebfe9c3930b23631df8f0cb742d47cdf058b3b939be064b36466c1611c5716c7fde24eb72f49ef5ef54158a049694ffa38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6dfa23a332f1b186b0d2873c67e905157b2f6195cdc395bb3e0af8b227a54297541a8b074fd7eb5377e5f60780bcc53f280db109f87bfc809e0911f85bfdb8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06a3811c45e5d3469bfb6c82a296e2d3d2df4d608a6c9204ed55f33e9057280dcd0c124be375358c2eb7f4f4b3bc1c827052f9ec912c25f639400bb97587e71d"} 15:19:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:19:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:19:20 INFO - Contents: 15:19:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/816518d145911103daae886e7b9ca6ebfe9c3930b23631df8f0cb742d47cdf058b3b939be064b36466c1611c5716c7fde24eb72f49ef5ef54158a049694ffa38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6dfa23a332f1b186b0d2873c67e905157b2f6195cdc395bb3e0af8b227a54297541a8b074fd7eb5377e5f60780bcc53f280db109f87bfc809e0911f85bfdb8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06a3811c45e5d3469bfb6c82a296e2d3d2df4d608a6c9204ed55f33e9057280dcd0c124be375358c2eb7f4f4b3bc1c827052f9ec912c25f639400bb97587e71d"} 15:19:20 INFO - Running post-run listener: copy_logs_to_upload_dir 15:19:20 INFO - Copying logs to upload dir... 15:19:20 INFO - mkdir: /builds/slave/test/build/upload/logs 15:19:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.386865 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-30 15:19:19.949070) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 15:19:19.955205) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652 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/816518d145911103daae886e7b9ca6ebfe9c3930b23631df8f0cb742d47cdf058b3b939be064b36466c1611c5716c7fde24eb72f49ef5ef54158a049694ffa38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6dfa23a332f1b186b0d2873c67e905157b2f6195cdc395bb3e0af8b227a54297541a8b074fd7eb5377e5f60780bcc53f280db109f87bfc809e0911f85bfdb8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06a3811c45e5d3469bfb6c82a296e2d3d2df4d608a6c9204ed55f33e9057280dcd0c124be375358c2eb7f4f4b3bc1c827052f9ec912c25f639400bb97587e71d"} build_url:https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/f6bfGfmuR6qBo4MgzvC7bQ/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/816518d145911103daae886e7b9ca6ebfe9c3930b23631df8f0cb742d47cdf058b3b939be064b36466c1611c5716c7fde24eb72f49ef5ef54158a049694ffa38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6dfa23a332f1b186b0d2873c67e905157b2f6195cdc395bb3e0af8b227a54297541a8b074fd7eb5377e5f60780bcc53f280db109f87bfc809e0911f85bfdb8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06a3811c45e5d3469bfb6c82a296e2d3d2df4d608a6c9204ed55f33e9057280dcd0c124be375358c2eb7f4f4b3bc1c827052f9ec912c25f639400bb97587e71d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 15:19:19.980674) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 15:19:19.981014) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1472594004.306538-1670751652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 15:19:20.066619) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 15:19:20.066957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 15:19:20.067275) ========= ========= Total master_lag: 0.16 =========