builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1470695282.05 results: success (0) buildid: 20160808143420 builduid: 92dd9fad2072470cbe047aef47ff9955 revision: a8df38f8ada3aca17303f21b9d447dafd7bbb9d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:02.054094) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:02.054584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:02.055177) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:02.093597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:02.093845) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 15:28:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-08-08 15:28:02 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182389 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:02.290833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:02.291158) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016360 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:02.342194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:02.342575) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a8df38f8ada3aca17303f21b9d447dafd7bbb9d6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev a8df38f8ada3aca17303f21b9d447dafd7bbb9d6 --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=56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 15:28:02,755 truncating revision to first 12 chars 2016-08-08 15:28:02,755 Setting DEBUG logging. 2016-08-08 15:28:02,756 attempt 1/10 2016-08-08 15:28:02,756 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a8df38f8ada3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 15:28:03,074 unpacking tar archive at: autoland-a8df38f8ada3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696734 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:03.052743) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:03.053071) ========= script_repo_revision: a8df38f8ada3aca17303f21b9d447dafd7bbb9d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:03.053495) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:03.053761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 15:28:03.062898) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-08 15:28:03.063228) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:28:03 INFO - MultiFileLogger online at 20160808 15:28:03 in /builds/slave/test 15:28:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 15:28:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:28:03 INFO - {'append_to_log': False, 15:28:03 INFO - 'base_work_dir': '/builds/slave/test', 15:28:03 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 15:28:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:28:03 INFO - 'branch': 'Autoland-Non-PGO', 15:28:03 INFO - 'buildbot_json_path': 'buildprops.json', 15:28:03 INFO - 'config_files': ('talos/linux_config.py',), 15:28:03 INFO - 'default_actions': ('clobber', 15:28:03 INFO - 'read-buildbot-config', 15:28:03 INFO - 'download-and-extract', 15:28:03 INFO - 'populate-webroot', 15:28:03 INFO - 'create-virtualenv', 15:28:03 INFO - 'install', 15:28:03 INFO - 'run-tests'), 15:28:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:28:03 INFO - 'download_minidump_stackwalk': True, 15:28:03 INFO - 'download_symbols': 'ondemand', 15:28:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:28:03 INFO - 'tooltool.py': '/tools/tooltool.py', 15:28:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:28:03 INFO - '/tools/misc-python/virtualenv.py')}, 15:28:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:28:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:28:03 INFO - 'installer_path': 'installer.exe', 15:28:03 INFO - 'log_level': 'info', 15:28:03 INFO - 'log_name': 'talos', 15:28:03 INFO - 'log_to_console': True, 15:28:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:28:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:28:03 INFO - 'opt_config_files': (), 15:28:03 INFO - 'pip_index': False, 15:28:03 INFO - 'sps_profile': False, 15:28:03 INFO - 'sps_profile_interval': 0, 15:28:03 INFO - 'suite': 'dromaeojs-e10s', 15:28:03 INFO - 'system_bits': '32', 15:28:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:28:03 INFO - 'title': 'talos-linux64-ix-037', 15:28:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:28:03 INFO - 'use_talos_json': True, 15:28:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:28:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:28:03 INFO - 'work_dir': 'build'} 15:28:03 INFO - [mozharness: 2016-08-08 22:28:03.566551Z] Running clobber step. 15:28:03 INFO - Running pre-action listener: _resource_record_pre_action 15:28:03 INFO - Running main action method: clobber 15:28:03 INFO - rmtree: /builds/slave/test/build 15:28:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:28:04 INFO - Running post-action listener: _resource_record_post_action 15:28:04 INFO - [mozharness: 2016-08-08 22:28:04.030065Z] Finished clobber step (success) 15:28:04 INFO - [mozharness: 2016-08-08 22:28:04.030165Z] Running read-buildbot-config step. 15:28:04 INFO - Running pre-action listener: _resource_record_pre_action 15:28:04 INFO - Running main action method: read_buildbot_config 15:28:04 INFO - Using buildbot properties: 15:28:04 INFO - { 15:28:04 INFO - "project": "", 15:28:04 INFO - "product": "firefox", 15:28:04 INFO - "script_repo_revision": "production", 15:28:04 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 15:28:04 INFO - "repository": "", 15:28:04 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 15:28:04 INFO - "buildid": "20160808143420", 15:28:04 INFO - "pgo_build": "False", 15:28:04 INFO - "basedir": "/builds/slave/test", 15:28:04 INFO - "buildnumber": 244, 15:28:04 INFO - "slavename": "talos-linux64-ix-037", 15:28:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:28:04 INFO - "platform": "ubuntu64_hw", 15:28:04 INFO - "scheduler": "tests-autoland-linux64-talos", 15:28:04 INFO - "branch": "autoland", 15:28:04 INFO - "repo_path": "integration/autoland", 15:28:04 INFO - "revision": "a8df38f8ada3aca17303f21b9d447dafd7bbb9d6", 15:28:04 INFO - "stage_platform": "linux64", 15:28:04 INFO - "builduid": "92dd9fad2072470cbe047aef47ff9955", 15:28:04 INFO - "slavebuilddir": "test" 15:28:04 INFO - } 15:28:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:28:04 INFO - Running post-action listener: _resource_record_post_action 15:28:04 INFO - [mozharness: 2016-08-08 22:28:04.032627Z] Finished read-buildbot-config step (success) 15:28:04 INFO - [mozharness: 2016-08-08 22:28:04.032716Z] Running download-and-extract step. 15:28:04 INFO - Running pre-action listener: _resource_record_pre_action 15:28:04 INFO - Running main action method: download_and_extract 15:28:04 INFO - mkdir: /builds/slave/test/build/tests 15:28: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')]} 15:28:04 INFO - trying https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:28:04 INFO - Downloading https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/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 15:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/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 15:28:04 INFO - Downloaded 1361 bytes. 15:28:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:28:04 INFO - Using the following test package requirements: 15:28:04 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:28:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:28:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:04 INFO - u'jsshell-linux-x86_64.zip'], 15:28:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:28:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:28:04 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:28:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:28:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:28:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:28: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')]} 15:28:04 INFO - trying https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:28:04 INFO - Downloading https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/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 15:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/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 15:28:05 INFO - Downloaded 20258190 bytes. 15:28:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:28:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:28:06 INFO - Return code: 0 15:28:06 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 15:28: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')]} 15:28:06 INFO - trying https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:28:06 INFO - Downloading https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/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 15:28:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/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 15:28:07 INFO - Downloaded 20258190 bytes. 15:28:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:28:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:28:08 INFO - Return code: 0 15:28:08 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')]} 15:28:08 INFO - trying https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:28:08 INFO - Downloading https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/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 15:28:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/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 15:28:09 INFO - Downloaded 14413723 bytes. 15:28:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:28:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:28:09 INFO - Return code: 0 15:28:09 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')]} 15:28:09 INFO - trying https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:28:09 INFO - Downloading https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/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 15:28:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/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 15:28:11 INFO - Downloaded 56138393 bytes. 15:28:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:28:11 INFO - mkdir: /builds/slave/test/properties 15:28:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:28:11 INFO - Writing to file /builds/slave/test/properties/build_url 15:28:11 INFO - Contents: 15:28:11 INFO - build_url:https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:28:11 INFO - Running post-action listener: _resource_record_post_action 15:28:11 INFO - Running post-action listener: set_extra_try_arguments 15:28:11 INFO - [mozharness: 2016-08-08 22:28:11.814389Z] Finished download-and-extract step (success) 15:28:11 INFO - [mozharness: 2016-08-08 22:28:11.814628Z] Running populate-webroot step. 15:28:11 INFO - Running pre-action listener: _resource_record_pre_action 15:28:11 INFO - Running main action method: populate_webroot 15:28:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:28:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:28:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:28:11 INFO - '--tppagecycles', 15:28:11 INFO - '7'], 15:28:11 INFO - 'tests': ['tsvgm']}}, 15:28:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:28:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:28:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:28:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:28:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:28:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:28:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:11 INFO - 'talos_options': ['--disable-e10s'], 15:28:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:11 INFO - 'talos_options': ['--disable-e10s'], 15:28:11 INFO - 'tests': ['damp', 'tps']}, 15:28:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:11 INFO - 'tests': ['damp', 'tps']}, 15:28:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:28:11 INFO - 'tests': ['dromaeo_dom']}, 15:28:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:28:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:28:11 INFO - 'tests': ['basic_compositor_video']}, 15:28:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:28:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:28:11 INFO - 'tests': ['a11yr', 15:28:11 INFO - 'ts_paint', 15:28:11 INFO - 'tpaint', 15:28:11 INFO - 'sessionrestore', 15:28:11 INFO - 'sessionrestore_no_auto_restore', 15:28:11 INFO - 'tabpaint']}, 15:28:11 INFO - 'other-e10s': {'tests': ['a11yr', 15:28:11 INFO - 'ts_paint', 15:28:11 INFO - 'tpaint', 15:28:11 INFO - 'sessionrestore', 15:28:11 INFO - 'sessionrestore_no_auto_restore', 15:28:11 INFO - 'tabpaint']}, 15:28:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:28:11 INFO - 'ts_paint', 15:28:11 INFO - 'tpaint', 15:28:11 INFO - 'sessionrestore', 15:28:11 INFO - 'sessionrestore_no_auto_restore', 15:28:11 INFO - 'tabpaint']}, 15:28:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:28:11 INFO - 'ts_paint', 15:28:11 INFO - 'tpaint', 15:28:11 INFO - 'sessionrestore', 15:28:11 INFO - 'sessionrestore_no_auto_restore', 15:28:11 INFO - 'tabpaint']}, 15:28:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:28:11 INFO - 'tests': ['a11yr', 15:28:11 INFO - 'ts_paint', 15:28:11 INFO - 'tpaint', 15:28:11 INFO - 'sessionrestore', 15:28:11 INFO - 'sessionrestore_no_auto_restore', 15:28:11 INFO - 'tabpaint']}, 15:28:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:28:11 INFO - 'tests': ['a11yr', 15:28:11 INFO - 'ts_paint', 15:28:11 INFO - 'tpaint', 15:28:11 INFO - 'sessionrestore', 15:28:11 INFO - 'sessionrestore_no_auto_restore', 15:28:11 INFO - 'tabpaint']}, 15:28:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:28:11 INFO - 'tests': ['tsvgx', 15:28:11 INFO - 'tsvgr_opacity', 15:28:11 INFO - 'tart', 15:28:11 INFO - 'tscrollx', 15:28:11 INFO - 'cart']}, 15:28:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:28:11 INFO - 'tsvgr_opacity', 15:28:11 INFO - 'tart', 15:28:11 INFO - 'tscrollx', 15:28:11 INFO - 'cart']}, 15:28:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:11 INFO - 'talos_options': ['--disable-e10s'], 15:28:11 INFO - 'tests': ['tp5o']}, 15:28:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:11 INFO - 'tests': ['tp5o']}, 15:28:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:11 INFO - 'talos_options': ['--disable-e10s', 15:28:11 INFO - '--xperf_path', 15:28:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:11 INFO - 'tests': ['tp5n']}, 15:28:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:11 INFO - 'talos_options': ['--xperf_path', 15:28:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:11 INFO - 'tests': ['tp5n']}}, 15:28:11 INFO - 'talos.zip': {'path': '', 15:28:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:28:11 INFO - Running post-action listener: _resource_record_post_action 15:28:11 INFO - [mozharness: 2016-08-08 22:28:11.830374Z] Finished populate-webroot step (success) 15:28:11 INFO - [mozharness: 2016-08-08 22:28:11.830465Z] Running create-virtualenv step. 15:28:11 INFO - Running pre-action listener: _resource_record_pre_action 15:28:11 INFO - Running main action method: create_virtualenv 15:28:11 INFO - Creating virtualenv /builds/slave/test/build/venv 15:28:11 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 15:28:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:28:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:28:11 INFO - Using real prefix '/usr' 15:28:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:28:12 INFO - Installing distribute.............................................................................................................................................................................................done. 15:28:14 INFO - Installing pip.................done. 15:28:14 INFO - Return code: 0 15:28:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5570>, '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 0x10e6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', '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 15:28:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:28:14 INFO - Using env: {'DISPLAY': ':0', 15:28:14 INFO - 'HOME': '/home/cltbld', 15:28:14 INFO - 'LANG': 'en_US.UTF-8', 15:28:14 INFO - 'LANGUAGE': 'en_US:en', 15:28:14 INFO - 'LOGNAME': 'cltbld', 15:28:14 INFO - 'MAIL': '/var/mail/cltbld', 15:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:14 INFO - 'MOZ_NO_REMOTE': '1', 15:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:14 INFO - 'NO_EM_RESTART': '1', 15:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:14 INFO - 'PWD': '/builds/slave/test', 15:28:14 INFO - 'SHELL': '/bin/bash', 15:28:14 INFO - 'SHLVL': '1', 15:28:14 INFO - 'TERM': 'linux', 15:28:14 INFO - 'TMOUT': '86400', 15:28:14 INFO - 'USER': 'cltbld', 15:28:14 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', 15:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:14 INFO - '_': '/tools/buildbot/bin/python'} 15:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:14 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 15:28:14 INFO - Cleaning up... 15:28:14 INFO - Return code: 0 15:28:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe27030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5570>, '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 0x10e6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', '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 15:28:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:28:14 INFO - Using env: {'DISPLAY': ':0', 15:28:14 INFO - 'HOME': '/home/cltbld', 15:28:14 INFO - 'LANG': 'en_US.UTF-8', 15:28:14 INFO - 'LANGUAGE': 'en_US:en', 15:28:14 INFO - 'LOGNAME': 'cltbld', 15:28:14 INFO - 'MAIL': '/var/mail/cltbld', 15:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:14 INFO - 'MOZ_NO_REMOTE': '1', 15:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:14 INFO - 'NO_EM_RESTART': '1', 15:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:14 INFO - 'PWD': '/builds/slave/test', 15:28:14 INFO - 'SHELL': '/bin/bash', 15:28:14 INFO - 'SHLVL': '1', 15:28:14 INFO - 'TERM': 'linux', 15:28:14 INFO - 'TMOUT': '86400', 15:28:14 INFO - 'USER': 'cltbld', 15:28:14 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', 15:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:14 INFO - '_': '/tools/buildbot/bin/python'} 15:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:14 INFO - Downloading/unpacking psutil>=3.1.1 15:28:14 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 15:28:14 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 15:28:14 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 15:28:14 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 15:28:14 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 15:28:14 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 15:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:28:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:16 INFO - Installing collected packages: psutil 15:28:16 INFO - Running setup.py install for psutil 15:28:17 INFO - building 'psutil._psutil_linux' extension 15:28:17 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 15:28:17 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 15:28:17 INFO - building 'psutil._psutil_posix' extension 15:28:17 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 15:28:17 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 15:28:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:17 INFO - Successfully installed psutil 15:28:17 INFO - Cleaning up... 15:28:17 INFO - Return code: 0 15:28:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:28: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')]} 15:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28: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')]} 15:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5570>, '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 0x10e6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', '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 15:28: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:28: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 mozsystemmonitor==0.3 15:28:17 INFO - Using env: {'DISPLAY': ':0', 15:28:17 INFO - 'HOME': '/home/cltbld', 15:28:17 INFO - 'LANG': 'en_US.UTF-8', 15:28:17 INFO - 'LANGUAGE': 'en_US:en', 15:28:17 INFO - 'LOGNAME': 'cltbld', 15:28:17 INFO - 'MAIL': '/var/mail/cltbld', 15:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:17 INFO - 'MOZ_NO_REMOTE': '1', 15:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:17 INFO - 'NO_EM_RESTART': '1', 15:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:17 INFO - 'PWD': '/builds/slave/test', 15:28:17 INFO - 'SHELL': '/bin/bash', 15:28:17 INFO - 'SHLVL': '1', 15:28:17 INFO - 'TERM': 'linux', 15:28:17 INFO - 'TMOUT': '86400', 15:28:17 INFO - 'USER': 'cltbld', 15:28:17 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', 15:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:17 INFO - '_': '/tools/buildbot/bin/python'} 15:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:28:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:28:19 INFO - Installing collected packages: mozsystemmonitor 15:28:19 INFO - Running setup.py install for mozsystemmonitor 15:28:19 INFO - Successfully installed mozsystemmonitor 15:28:19 INFO - Cleaning up... 15:28:19 INFO - Return code: 0 15:28:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:28:19 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')]} 15:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:19 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')]} 15:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:19 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 0xe27030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5570>, '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 0x10e6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', '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 15:28:19 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 15:28:19 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 15:28:19 INFO - Using env: {'DISPLAY': ':0', 15:28:19 INFO - 'HOME': '/home/cltbld', 15:28:19 INFO - 'LANG': 'en_US.UTF-8', 15:28:19 INFO - 'LANGUAGE': 'en_US:en', 15:28:19 INFO - 'LOGNAME': 'cltbld', 15:28:19 INFO - 'MAIL': '/var/mail/cltbld', 15:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:19 INFO - 'MOZ_NO_REMOTE': '1', 15:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:19 INFO - 'NO_EM_RESTART': '1', 15:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:19 INFO - 'PWD': '/builds/slave/test', 15:28:19 INFO - 'SHELL': '/bin/bash', 15:28:19 INFO - 'SHLVL': '1', 15:28:19 INFO - 'TERM': 'linux', 15:28:19 INFO - 'TMOUT': '86400', 15:28:19 INFO - 'USER': 'cltbld', 15:28:19 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', 15:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:19 INFO - '_': '/tools/buildbot/bin/python'} 15:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:20 INFO - Downloading/unpacking jsonschema==2.5.1 15:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:28:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:28:21 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 15:28:21 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 15:28:21 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 15:28:21 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 15:28:21 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 15:28:21 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 15:28:22 INFO - Downloading functools32-3.2.3-2.tar.gz 15:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:28:22 INFO - warning: no files found matching '*.txt' 15:28:22 INFO - no previously-included directories found matching 'build' 15:28:22 INFO - no previously-included directories found matching 'dist' 15:28:22 INFO - no previously-included directories found matching '.git*' 15:28:22 INFO - Installing collected packages: jsonschema, functools32 15:28:22 INFO - Running setup.py install for functools32 15:28:22 INFO - warning: no files found matching '*.txt' 15:28:22 INFO - no previously-included directories found matching 'build' 15:28:22 INFO - no previously-included directories found matching 'dist' 15:28:22 INFO - no previously-included directories found matching '.git*' 15:28:22 INFO - Successfully installed jsonschema functools32 15:28:22 INFO - Cleaning up... 15:28:22 INFO - Return code: 0 15:28:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:28:22 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')]} 15:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:22 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')]} 15:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:22 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 0xe27030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5570>, '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 0x10e6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', '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 15:28:22 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 15:28:22 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 15:28:22 INFO - Using env: {'DISPLAY': ':0', 15:28:22 INFO - 'HOME': '/home/cltbld', 15:28:22 INFO - 'LANG': 'en_US.UTF-8', 15:28:22 INFO - 'LANGUAGE': 'en_US:en', 15:28:22 INFO - 'LOGNAME': 'cltbld', 15:28:22 INFO - 'MAIL': '/var/mail/cltbld', 15:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:22 INFO - 'MOZ_NO_REMOTE': '1', 15:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:22 INFO - 'NO_EM_RESTART': '1', 15:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:22 INFO - 'PWD': '/builds/slave/test', 15:28:22 INFO - 'SHELL': '/bin/bash', 15:28:22 INFO - 'SHLVL': '1', 15:28:22 INFO - 'TERM': 'linux', 15:28:22 INFO - 'TMOUT': '86400', 15:28:22 INFO - 'USER': 'cltbld', 15:28:22 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', 15:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:22 INFO - '_': '/tools/buildbot/bin/python'} 15:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:28:22 INFO - Cleaning up... 15:28:22 INFO - Return code: 0 15:28:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:28:22 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')]} 15:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:22 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')]} 15:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:22 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 0xe27030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5570>, '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 0x10e6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', '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 15:28:22 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 15:28:22 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 15:28:22 INFO - Using env: {'DISPLAY': ':0', 15:28:22 INFO - 'HOME': '/home/cltbld', 15:28:22 INFO - 'LANG': 'en_US.UTF-8', 15:28:22 INFO - 'LANGUAGE': 'en_US:en', 15:28:22 INFO - 'LOGNAME': 'cltbld', 15:28:22 INFO - 'MAIL': '/var/mail/cltbld', 15:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:22 INFO - 'MOZ_NO_REMOTE': '1', 15:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:22 INFO - 'NO_EM_RESTART': '1', 15:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:22 INFO - 'PWD': '/builds/slave/test', 15:28:22 INFO - 'SHELL': '/bin/bash', 15:28:22 INFO - 'SHLVL': '1', 15:28:22 INFO - 'TERM': 'linux', 15:28:22 INFO - 'TMOUT': '86400', 15:28:22 INFO - 'USER': 'cltbld', 15:28:22 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', 15:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:22 INFO - '_': '/tools/buildbot/bin/python'} 15:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:22 INFO - Downloading/unpacking blobuploader==1.2.4 15:28:22 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 15:28:22 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 15:28:22 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 15:28:22 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 15:28:22 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 15:28:22 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 15:28:24 INFO - Downloading blobuploader-1.2.4.tar.gz 15:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:28:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:28:24 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 15:28:24 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 15:28:24 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 15:28:24 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 15:28:24 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 15:28:24 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 15:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:28:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:28:25 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 15:28:25 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 15:28:25 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 15:28:25 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 15:28:25 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 15:28:25 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 15:28:25 INFO - Downloading docopt-0.6.1.tar.gz 15:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:28:25 INFO - Installing collected packages: blobuploader, requests, docopt 15:28:25 INFO - Running setup.py install for blobuploader 15:28:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:28:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:28:25 INFO - Running setup.py install for requests 15:28:25 INFO - Running setup.py install for docopt 15:28:25 INFO - Successfully installed blobuploader requests docopt 15:28:25 INFO - Cleaning up... 15:28:26 INFO - Return code: 0 15:28:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:26 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')]} 15:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:26 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')]} 15:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:26 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 0xe27030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5570>, '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 0x10e6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', '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 15:28:26 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 15:28:26 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 15:28:26 INFO - Using env: {'DISPLAY': ':0', 15:28:26 INFO - 'HOME': '/home/cltbld', 15:28:26 INFO - 'LANG': 'en_US.UTF-8', 15:28:26 INFO - 'LANGUAGE': 'en_US:en', 15:28:26 INFO - 'LOGNAME': 'cltbld', 15:28:26 INFO - 'MAIL': '/var/mail/cltbld', 15:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:26 INFO - 'MOZ_NO_REMOTE': '1', 15:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:26 INFO - 'NO_EM_RESTART': '1', 15:28:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:26 INFO - 'PWD': '/builds/slave/test', 15:28:26 INFO - 'SHELL': '/bin/bash', 15:28:26 INFO - 'SHLVL': '1', 15:28:26 INFO - 'TERM': 'linux', 15:28:26 INFO - 'TMOUT': '86400', 15:28:26 INFO - 'USER': 'cltbld', 15:28:26 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', 15:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:26 INFO - '_': '/tools/buildbot/bin/python'} 15:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:28:26 INFO - Running setup.py (path:/tmp/pip-d3aqJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:28:26 INFO - Running setup.py (path:/tmp/pip-cTjEYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:28:26 INFO - Running setup.py (path:/tmp/pip-ilL40k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:28:26 INFO - Running setup.py (path:/tmp/pip-LtMwHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:28:26 INFO - Running setup.py (path:/tmp/pip-2JMWAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:28:26 INFO - Running setup.py (path:/tmp/pip-FU__21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:28:26 INFO - Running setup.py (path:/tmp/pip-8xjQCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:28:26 INFO - Running setup.py (path:/tmp/pip-yQGt0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:28:26 INFO - Running setup.py (path:/tmp/pip-KYAsGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:28:26 INFO - Running setup.py (path:/tmp/pip-Y9cvsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:28:26 INFO - Running setup.py (path:/tmp/pip-5UyVeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:28:27 INFO - Running setup.py (path:/tmp/pip-W1KOUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:28:27 INFO - Running setup.py (path:/tmp/pip-rdBOgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:28:27 INFO - Running setup.py (path:/tmp/pip-qinkB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:27 INFO - Running setup.py (path:/tmp/pip-knBrvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:28:27 INFO - Running setup.py (path:/tmp/pip-2ybR_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:28:27 INFO - Running setup.py (path:/tmp/pip-XfDNOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:28:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:28:27 INFO - Running setup.py install for manifestparser 15:28:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:28:27 INFO - Running setup.py install for mozcrash 15:28:27 INFO - Running setup.py install for mozdebug 15:28:27 INFO - Running setup.py install for mozdevice 15:28:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:28:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:28:27 INFO - Running setup.py install for mozfile 15:28:28 INFO - Running setup.py install for mozhttpd 15:28:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:28:28 INFO - Running setup.py install for mozinfo 15:28:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:28:28 INFO - Running setup.py install for mozInstall 15:28:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:28:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:28:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:28:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:28:28 INFO - Running setup.py install for mozleak 15:28:28 INFO - Running setup.py install for mozlog 15:28:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:28:28 INFO - Running setup.py install for moznetwork 15:28:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:28:28 INFO - Running setup.py install for mozprocess 15:28:28 INFO - Running setup.py install for mozprofile 15:28:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:28:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:28:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:28:28 INFO - Running setup.py install for mozrunner 15:28:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:28:28 INFO - Running setup.py install for mozscreenshot 15:28:29 INFO - Running setup.py install for moztest 15:28:29 INFO - Running setup.py install for mozversion 15:28:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:28:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:28:29 INFO - Cleaning up... 15:28:29 INFO - Return code: 0 15:28:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:29 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 0xe27030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5570>, '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 0x10e6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', '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 15:28:29 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 15:28:29 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 15:28:29 INFO - Using env: {'DISPLAY': ':0', 15:28:29 INFO - 'HOME': '/home/cltbld', 15:28:29 INFO - 'LANG': 'en_US.UTF-8', 15:28:29 INFO - 'LANGUAGE': 'en_US:en', 15:28:29 INFO - 'LOGNAME': 'cltbld', 15:28:29 INFO - 'MAIL': '/var/mail/cltbld', 15:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:29 INFO - 'MOZ_NO_REMOTE': '1', 15:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:29 INFO - 'NO_EM_RESTART': '1', 15:28:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:29 INFO - 'PWD': '/builds/slave/test', 15:28:29 INFO - 'SHELL': '/bin/bash', 15:28:29 INFO - 'SHLVL': '1', 15:28:29 INFO - 'TERM': 'linux', 15:28:29 INFO - 'TMOUT': '86400', 15:28:29 INFO - 'USER': 'cltbld', 15:28:29 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', 15:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:29 INFO - '_': '/tools/buildbot/bin/python'} 15:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:28:29 INFO - Running setup.py (path:/tmp/pip-R2PFxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:28:29 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)) 15:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:28:29 INFO - Running setup.py (path:/tmp/pip-JNEt_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:28:29 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)) 15:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:28:29 INFO - Running setup.py (path:/tmp/pip-xebtgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:28:29 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)) 15:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:28:29 INFO - Running setup.py (path:/tmp/pip-otAPjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:28:29 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)) 15:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:28:29 INFO - Running setup.py (path:/tmp/pip-yiqGlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:28:29 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)) 15:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:28:29 INFO - Running setup.py (path:/tmp/pip-WwiK77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:28:29 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)) 15:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:28:29 INFO - Running setup.py (path:/tmp/pip-OdW0KV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:28:30 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)) 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:28:30 INFO - Running setup.py (path:/tmp/pip-eRY_SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:28:30 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)) 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:28:30 INFO - Running setup.py (path:/tmp/pip-6bcxN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:28:30 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)) 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:28:30 INFO - Running setup.py (path:/tmp/pip-TOj0TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:28:30 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)) 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:28:30 INFO - Running setup.py (path:/tmp/pip-CEM3OH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:28:30 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)) 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:28:30 INFO - Running setup.py (path:/tmp/pip-1kZcaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:28:30 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)) 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:28:30 INFO - Running setup.py (path:/tmp/pip-ZkJjOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:28:30 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)) 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:28:30 INFO - Running setup.py (path:/tmp/pip-VzSPpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:28:30 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)) 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:30 INFO - Running setup.py (path:/tmp/pip-0p1S4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:30 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)) 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:28:30 INFO - Running setup.py (path:/tmp/pip-Ilb73r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:28:30 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)) 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:28:30 INFO - Running setup.py (path:/tmp/pip-UULzEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:28:30 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)) 15:28:30 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)) 15:28:30 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)) 15:28:30 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)) 15:28:30 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)) 15:28:30 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)) 15:28:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:28:30 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 15:28:30 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 15:28:30 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 15:28:30 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 15:28:30 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 15:28:30 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 15:28:32 INFO - Downloading blessings-1.6.tar.gz 15:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:28:32 INFO - Installing collected packages: blessings 15:28:32 INFO - Running setup.py install for blessings 15:28:32 INFO - Successfully installed blessings 15:28:32 INFO - Cleaning up... 15:28:32 INFO - Return code: 0 15:28:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:28:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:28:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:28:33 INFO - Reading from file tmpfile_stdout 15:28:33 INFO - Current package versions: 15:28:33 INFO - argparse == 1.2.1 15:28:33 INFO - blessings == 1.6 15:28:33 INFO - blobuploader == 1.2.4 15:28:33 INFO - docopt == 0.6.1 15:28:33 INFO - functools32 == 3.2.3-2 15:28:33 INFO - jsonschema == 2.5.1 15:28:33 INFO - manifestparser == 1.1 15:28:33 INFO - mozInstall == 1.12 15:28:33 INFO - mozcrash == 0.17 15:28:33 INFO - mozdebug == 0.1 15:28:33 INFO - mozdevice == 0.48 15:28:33 INFO - mozfile == 1.2 15:28:33 INFO - mozhttpd == 0.7 15:28:33 INFO - mozinfo == 0.9 15:28:33 INFO - mozleak == 0.1 15:28:33 INFO - mozlog == 3.3 15:28:33 INFO - moznetwork == 0.27 15:28:33 INFO - mozprocess == 0.23 15:28:33 INFO - mozprofile == 0.28 15:28:33 INFO - mozrunner == 6.12 15:28:33 INFO - mozscreenshot == 0.1 15:28:33 INFO - mozsystemmonitor == 0.3 15:28:33 INFO - moztest == 0.7 15:28:33 INFO - mozversion == 1.4 15:28:33 INFO - psutil == 3.1.1 15:28:33 INFO - requests == 1.2.3 15:28:33 INFO - wsgiref == 0.1.2 15:28:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:33 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')]} 15:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:33 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')]} 15:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:33 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 0xe27030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5570>, '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 0x10e6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', '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 15:28:33 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 15:28:33 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 15:28:33 INFO - Using env: {'DISPLAY': ':0', 15:28:33 INFO - 'HOME': '/home/cltbld', 15:28:33 INFO - 'LANG': 'en_US.UTF-8', 15:28:33 INFO - 'LANGUAGE': 'en_US:en', 15:28:33 INFO - 'LOGNAME': 'cltbld', 15:28:33 INFO - 'MAIL': '/var/mail/cltbld', 15:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:33 INFO - 'MOZ_NO_REMOTE': '1', 15:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:33 INFO - 'NO_EM_RESTART': '1', 15:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:33 INFO - 'PWD': '/builds/slave/test', 15:28:33 INFO - 'SHELL': '/bin/bash', 15:28:33 INFO - 'SHLVL': '1', 15:28:33 INFO - 'TERM': 'linux', 15:28:33 INFO - 'TMOUT': '86400', 15:28:33 INFO - 'USER': 'cltbld', 15:28:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', 15:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:33 INFO - '_': '/tools/buildbot/bin/python'} 15:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:33 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)) 15:28:33 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)) 15:28:33 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)) 15:28:33 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)) 15:28:33 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)) 15:28:33 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)) 15:28:33 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)) 15:28:33 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)) 15:28:33 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)) 15:28:33 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)) 15:28:33 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)) 15:28:33 INFO - Cleaning up... 15:28:33 INFO - Return code: 0 15:28:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:28:33 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')]} 15:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:33 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')]} 15:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:33 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 0xe27030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5570>, '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 0x10e6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', '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 15:28:33 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 15:28:33 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 15:28:33 INFO - Using env: {'DISPLAY': ':0', 15:28:33 INFO - 'HOME': '/home/cltbld', 15:28:33 INFO - 'LANG': 'en_US.UTF-8', 15:28:33 INFO - 'LANGUAGE': 'en_US:en', 15:28:33 INFO - 'LOGNAME': 'cltbld', 15:28:33 INFO - 'MAIL': '/var/mail/cltbld', 15:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:33 INFO - 'MOZ_NO_REMOTE': '1', 15:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:33 INFO - 'NO_EM_RESTART': '1', 15:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:33 INFO - 'PWD': '/builds/slave/test', 15:28:33 INFO - 'SHELL': '/bin/bash', 15:28:33 INFO - 'SHLVL': '1', 15:28:33 INFO - 'TERM': 'linux', 15:28:33 INFO - 'TMOUT': '86400', 15:28:33 INFO - 'USER': 'cltbld', 15:28:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', 15:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:33 INFO - '_': '/tools/buildbot/bin/python'} 15:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:28:33 INFO - Cleaning up... 15:28:33 INFO - Return code: 0 15:28:33 INFO - Running post-action listener: _resource_record_post_action 15:28:33 INFO - Running post-action listener: _start_resource_monitoring 15:28:33 INFO - Starting resource monitoring. 15:28:33 INFO - [mozharness: 2016-08-08 22:28:33.575958Z] Finished create-virtualenv step (success) 15:28:33 INFO - [mozharness: 2016-08-08 22:28:33.576392Z] Running install step. 15:28:33 INFO - Running pre-action listener: _resource_record_pre_action 15:28:33 INFO - Running main action method: install 15:28:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:28:33 INFO - Reading from file tmpfile_stdout 15:28:33 INFO - Detecting whether we're running mozinstall >=1.0... 15:28:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:28:33 INFO - Reading from file tmpfile_stdout 15:28:33 INFO - Output received: 15:28:33 INFO - Usage: mozinstall [options] installer 15:28:33 INFO - Options: 15:28:33 INFO - -h, --help show this help message and exit 15:28:33 INFO - -d DEST, --destination=DEST 15:28:33 INFO - Directory to install application into. [default: 15:28:33 INFO - "/builds/slave/test"] 15:28:33 INFO - --app=APP Application being installed. [default: firefox] 15:28:33 INFO - mkdir: /builds/slave/test/build/application 15:28:33 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'] 15:28:33 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 15:28:50 INFO - Reading from file tmpfile_stdout 15:28:50 INFO - Output received: 15:28:50 INFO - /builds/slave/test/build/application/firefox/firefox 15:28:50 INFO - Running post-action listener: _resource_record_post_action 15:28:50 INFO - [mozharness: 2016-08-08 22:28:50.148064Z] Finished install step (success) 15:28:50 INFO - [mozharness: 2016-08-08 22:28:50.148316Z] Running run-tests step. 15:28:50 INFO - Running pre-action listener: _resource_record_pre_action 15:28:50 INFO - Running main action method: run_tests 15:28:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:28:50 INFO - Python 2.7.3 15:28:50 INFO - Return code: 0 15:28:50 INFO - grabbing minidump binary from tooltool 15:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:50 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 0x10e5570>, '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 0x10e6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:28:50 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 15:28:50 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 15:28:50 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 15:28:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:28:50 INFO - Return code: 0 15:28:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:28:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:28:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:28:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:28:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:28:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:28:50 INFO - Using env: {'DISPLAY': ':0', 15:28:50 INFO - 'HOME': '/home/cltbld', 15:28:50 INFO - 'LANG': 'en_US.UTF-8', 15:28:50 INFO - 'LANGUAGE': 'en_US:en', 15:28:50 INFO - 'LOGNAME': 'cltbld', 15:28:50 INFO - 'MAIL': '/var/mail/cltbld', 15:28:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:28:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:50 INFO - 'MOZ_NO_REMOTE': '1', 15:28:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:50 INFO - 'NO_EM_RESTART': '1', 15:28:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:50 INFO - 'PWD': '/builds/slave/test', 15:28:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:28:50 INFO - 'SHELL': '/bin/bash', 15:28:50 INFO - 'SHLVL': '1', 15:28:50 INFO - 'TERM': 'linux', 15:28:50 INFO - 'TMOUT': '86400', 15:28:50 INFO - 'USER': 'cltbld', 15:28:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520', 15:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:50 INFO - '_': '/tools/buildbot/bin/python'} 15:28:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:28:50 INFO - mozversion application_buildid: 20160808143420 15:28:50 INFO - mozversion application_changeset: a8df38f8ada3aca17303f21b9d447dafd7bbb9d6 15:28:50 INFO - mozversion application_display_name: Nightly 15:28:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:28:50 INFO - mozversion application_name: Firefox 15:28:50 INFO - mozversion application_remotingname: firefox 15:28:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:28:50 INFO - mozversion application_vendor: Mozilla 15:28:50 INFO - mozversion application_version: 51.0a1 15:28:50 INFO - mozversion platform_buildid: 20160808143420 15:28:50 INFO - mozversion platform_changeset: a8df38f8ada3aca17303f21b9d447dafd7bbb9d6 15:28:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:28:50 INFO - mozversion platform_version: 51.0a1 15:28:50 INFO - using testdate: 1470695330 15:28:50 INFO - actual date: 1470695330 15:28:50 INFO - starting webserver on 'localhost:49756' 15:28:50 INFO - SUITE-START | Running 2 tests 15:28:50 INFO - TEST-START | dromaeo_css 15:28:50 INFO - operating with platform_type : linux_ 15:28:50 INFO - Initialising browser for dromaeo_css test... 15:28:50 INFO - TEST-INFO | started process 26815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQn35TD/profile http://localhost:49756/getInfo.html) 15:28:55 INFO - PROCESS | 26815 | __metrics Screen width/height:1600/1200 15:28:55 INFO - PROCESS | 26815 | colorDepth:24 15:28:55 INFO - PROCESS | 26815 | Browser inner width/height: 1024/697 15:28:55 INFO - PROCESS | 26815 | __metrics 15:28:55 ERROR - PROCESS | 26815 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:28:56 INFO - TEST-INFO | 26815: exit 0 15:28:56 INFO - Browser initialized. 15:28:56 INFO - Running cycle 1/1 for dromaeo_css test... 15:28:56 INFO - TEST-INFO | started process 26933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQn35TD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:29:08 INFO - PROCESS | 26933 | RSS: Main: 165191680 15:29:08 INFO - PROCESS | 26933 | 15:29:58 INFO - PROCESS | 26933 | 1470695398093 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:32:10 INFO - PROCESS | 26933 | Cycle 1(1): loaded http://localhost:49756/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49756/tests/dromaeo/cssquery-ext.html) 15:32:11 INFO - PROCESS | 26933 | RSS: Main: 166707200 15:32:11 INFO - PROCESS | 26933 | 15:35:14 INFO - PROCESS | 26933 | Cycle 1(1): loaded http://localhost:49756/tests/dromaeo/cssquery-ext.html (next: http://localhost:49756/tests/dromaeo/cssquery-jquery.html) 15:35:14 INFO - PROCESS | 26933 | RSS: Main: 166735872 15:35:14 INFO - PROCESS | 26933 | 15:38:16 INFO - PROCESS | 26933 | Cycle 1(1): loaded http://localhost:49756/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49756/tests/dromaeo/cssquery-mootools.html) 15:38:17 INFO - PROCESS | 26933 | RSS: Main: 169934848 15:38:17 INFO - PROCESS | 26933 | 15:41:19 INFO - PROCESS | 26933 | Cycle 1(1): loaded http://localhost:49756/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49756/tests/dromaeo/cssquery-prototype.html) 15:41:20 INFO - PROCESS | 26933 | RSS: Main: 164347904 15:41:20 INFO - PROCESS | 26933 | 15:44:22 INFO - PROCESS | 26933 | Cycle 1(1): loaded http://localhost:49756/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49756/tests/dromaeo/cssquery-yui.html) 15:44:23 INFO - PROCESS | 26933 | RSS: Main: 166903808 15:44:23 INFO - PROCESS | 26933 | 15:47:26 INFO - PROCESS | 26933 | Cycle 1(1): loaded http://localhost:49756/tests/dromaeo/cssquery-yui.html (next: http://localhost:49756/tests/dromaeo/cssquery-dojo.html) 15:47:26 INFO - PROCESS | 26933 | RSS: Main: 170139648 15:47:26 INFO - PROCESS | 26933 | 15:47:26 INFO - PROCESS | 26933 | __start_tp_report 15:47:26 INFO - PROCESS | 26933 | _x_x_mozilla_page_load 15:47:26 INFO - PROCESS | 26933 | _x_x_mozilla_page_load_details 15:47:26 INFO - PROCESS | 26933 | |i|pagename|runs| 15:47:26 INFO - PROCESS | 26933 | |0;dojo.html;2657.176275354639;2668.159529748129;2696.986515067425;2701.972980270197;2710.701822799493;4676.251799712047;4814.229723244282;4824.710517368956;4868.196747536656;4885.926711099328;4790.496997815231;4822.083804077223;4872.488388719178;4894.926576101361;4901.65688401812;4420.248557745183;4508.368828364015;4522.841700540482;4567.3815066118605;4595.931061034087;4534.591886730193;4578.862634120965;4595.908081838378;4621.168189725848;4633.2818413146015;4323.567643235683;4344.152890186415;4470.508244093147;4485.551444855521;4570.611498022672;4417.889552761175;4426.690131690783;4444.644428445717;4560.771961401917;4566.725996440225;4368.344748287751;4409.140217657558;4417.668674849399;4453.844115455976;4466.687331886769;4678.970626462173;4794.592459640935;4834.492378300298;4835.153848076572;4844.927326090112;5097.7196254206;5115.616328775357;5154.716490593016;5158.071547121516;5208;5137.101007323703;5170.715610641413;5179.04187725272;5190.532852043297;5231.503007214308;4706.835260765857;4824.807007719652;4833.371661683994;4847.054824309296;4874.707517548958;5336.946630533723;5361.946380536145;5362.973185134049;5413.160960051198;5430.782768689287;5123.513266239701;5132.461091585405;5138.8972220556125;5141.074606570854;5199.298094757235;4909.926351104737;5084.8220312288895;5153.891913238596;5225.268462415265;5235.712035838065;5105.8723531911255;5131.846044618667;5136.203888397305;5139.717315547681;5169.224616307584;5118.206677964921;5124.92312615311;5138.409082955433;5141.562967147759;5185.688858668492;4245.448091748115;4394.802233899418;4434.733915964988;4453.487848897354;4469;3887.8833634990997;3896.123372241223;3896.59085795993;3933.3903244997073;3952.110775075585;4500.954990450119;4509.684322097487;4519.638428925678;4544.795484203219;4564.041551274203;4938.160512712848;5125.692458452505;5165.638405311592;5188.662736922163;5268.947310526923;4438.755868427203;4452.198604251201;4468.218061839165;4483.125790470827;4493.1013797240685;4660.4407471103;4677.204875171229;4679.4618618858585;4691.249400095969;4721.834735784231;4637.536246375403;4762.595179409789;4824.782884770264;4839.056384005226;4866.562009419169;5161.380634323905;5169.172932330809;5193.42872284056;5205.141151709925;5230.0585894539345;4820.276958456259;4830.565249127455;4852.975735121302;4868.634852386014;4907.803687852589;4869.975650121727;5027.396712394389;5061.519155680205;5115.616328775432;5119.027384797026;5207.505286997881;5210.426853046086;5214.661047031931;5218.712970786643;5227.451117632746;5045.217991211368;5057.949420505748;5065.670731402447;5065.924011139909;5112.463191365002;4810.903781924412;4873;4892.437369702529;4914.336564563738;5060.671056381323;4849.95150048495;4862.07620552094;4892.584130348961;4910.263460480956;4918.1393256180745;4981.850544483671;4992.425871024733;4994.725290109079;5010.348654674869;5029.673071250357;4709.740964246999;4883.072216278895;4931.827386041471;4936.136176169228;4994.101061808764 15:47:26 INFO - PROCESS | 26933 | |1;ext.html;549.3572520151425;552.2654869024198;565.3611419096421;571.8456016875441;575.989139060948;34352.82823585882;38736.80631596842;38766.03084922875;38779.61220387802;38832.80583597078;38727.22545549087;39138.412923806165;39220.80389598055;39280.41079383804;39343;7635.312821846032;7739.380849532024;7764.534127952313;7770.533767973911;7774.49465784725;7630.351420129296;7712.730054448096;7720.073591169067;7751;7754.728584499544;7337.816554586151;7364.410847132217;7391.778246652609;7403.074615673041;7418.072740907387;7688.423368247404;7703.114141873701;7722.922770772333;7735.419843511731;7739.845203095907;7691.30778229962;7699.037620297463;7737.110232323299;7744.612769361565;7746.535207887545;29725.55411668805;29788.10635680933;29963.400731985457;30010.549841752392;30048.399032019457;2574.1376638826014;2725.523033469135;2829.6604407471236;2840.630718006646;3157.842107894619;25714.22857314265;26520.734792652212;27637.170884873485;27807.443851123066;28150.43699126006;3255.3814775192636;3259.2992506610954;3303.785253958485;3317.402867483852;3343.699067083974;217230;218059;218688;219845.9999999984;219994;31352;31786.841065794986;32020.519692204634;32110.518342224885;32368.83815580907;33270.16824579405;33357.66642333545;33482.66517334795;33554.328913421596;33564.32871342608;12636.684082898;12793.104482686309;12799.488020479263;12802.16785908913;12833.743325133444;9585.952070239744;9618.51907404627;9623.711288661212;9634.71095867111;9660.275479339078;7819.609019549;7857.724979625686;7882.369410447151;7938.206179382016;7944.960275198702;3008.473517134493;3095.086949349947;3101.65881753007;3122.6252849658185;3129.3115514586752;839.2488722593245;872.6378552900475;878.7056336127469;892.2772554231094;960.7934294126796;27563;28315.292117696812;28419;28460.71539284622;28604.14187574376;910.5356268303213;945.5177859291811;966.1594412860856;967.1199208720031;997.1574019953129;14165.220912849685;15215.391384344503;15312.923435382974;16054.75917861233;16146.192690365435;426634;429039;429042;429208;430758.84620576695;48766;49213.50786492161;49491;49645;49701.50298496969;940.7695114696943;984.3355734878928;985.5762022330467;986.0829428631441;1158.6002829023973;26759;28373.85813071004;28638.713612863605;29211.41577168487;29603.25991850135;43195.920101997704;44181.337279940184;44206;44245.55754442414;44255.778721107476;360175;361466;361877;363614;366484;24959;25038.248852534452;27238.319042023315;27479.587806183325;27540.58689119705;40901.30294457486;40928.1814363717;41078.38382424326;41729.1654166921;42559.787201063795;35634.61471160236;35798.642013579534;36097;36140.4578931311;36609.63390366062;36021.63978360288;36037.639623604475;36546.8172659135;36716.63283367132;37214.44178337381;32828.67171328352;34063.4890476648;34710;36716;36795;31220.531692024182;33613;33698.494522582674;33782.49326260157;33832.66167338295;21742.0156369281;21958.670619941033;22015;22135.778642213372;22188.556228875656 15:47:26 INFO - PROCESS | 26933 | |2;jquery.html;343.2979556806331;360.11411926660406;362.14533700466905;364.58619466905054;369.254106704457;15993.84006159938;17229.483115506522;17457.65084698305;17933.117022712624;17960.999999999967;14727.631809204748;15374.69250614987;15468.381264749396;15478.61303467414;15495.535133945972;4322.394864718934;4563.26987681971;4584.633229341644;4636.629069674418;4637.095766325568;3529.1177205698577;4601.930971035437;4630.837920672777;5226.503482169188;5482.342118945732;5558.888822223553;5566.55467562594;5592.5805564582815;5595.104783234683;5600.5799565032585;5495.835124946258;5522.972385138069;5525.972370138164;5536.667799932017;5539.972300138474;5305.65513241638;5351.973240133774;5362.115250983583;5366.711989122621;5371.59713021521;12698.555550555779;18309;19969;21093.789062109336;21261.149554017975;1928.3829174664113;1982.672858978267;2124.426404870692;2449.8162637802056;2467.6915385576804;9221.631134754602;9314.534273286308;9356.251499879992;11678.708032299175;13220.405081771343;1714.3314107498086;1719.5185348102552;1724.0690027385322;1733.3586572967956;1783.839454449106;68611.65694171497;69811.65094174497;71848.28151718469;71897;72302.99999999948;8188.754337369888;8787.780305492413;8904.8664270036;9528.523573821281;9859.211263098934;11585.131115166396;11735.295882247092;11737.647870563897;11766.823497647541;11805.232659877252;6681.966590167115;7137.785866424016;7153.6780844862105;7177.533460325062;7338.77983660491;6642.86714265712;6705.6982435790505;6850.965745171242;6854.314568543105;6855.554388964801;4341.60925516705;4375.51232580924;4378.562143785596;4456.487503937024;4592.471865735483;1621.2542230573831;1632.8040635123623;1754.0791084680645;1788.534980904948;1792.27412897774;799.5322736199389;827.2224109337204;836.7615229659518;863.7106569299355;910.5902343945252;16934.237959291862;17272.65454690899;17383.304667813398;17674.293028278724;17881.46355609334;816.2164322250587;821.0926925747083;843.9451435656663;868.5743985447085;869.6130222051127;9675.225981921429;9757.170640495495;9951.80096398068;10032.598696052077;10126.59493620247;378073;390767;392299;395645;398192;46144;64472.032919506244;78093.21906780972;78729;81257.34341954626;723.7683941138785;753.066197914582;763.0957315581054;768.9692412303557;772.2663469703804;13612.86387136116;13795.310234488035;13797.310134493035;14024.509142179975;14461.421543138156;37057.44413833741;37078.44382334213;37632.247355053296;37807.67673131427;38689.6131038686;50812.49187508078;51757.7412112937;52029.21956170736;52247.47752522426;53677.463225367246;6919.584824910521;7116.822079448055;7206.243344448967;7282.198958114497;7346.853062938604;10606.734831629272;10733.731656708645;11023.72440688957;11089.611863585058;11283.717907052389;9351.906480935104;9431.575579099093;9475.47884866339;9531.761705957406;9685.225181985565;9017.954910225408;9163.358564900393;9383.624655013722;9387.342885997914;9741.220702343937;8896.822063558564;9182.494962777111;9330.766730831783;9429.3399462037;9531.428114313163;7072.611006394698;7104.751333703295;7231.746888858865;7293.343599076109;7347.26527347261;7267.563946163247;8712.607932643174;8724.91275087241;9189.081091890757;9385.671501497414 15:47:26 INFO - PROCESS | 26933 | |3;mootools.html;1380.4133243371564;1406.507722297196;1472.8306244781854;1682.4195652499884;1684.4946516045184;6327.209098862642;7361.30067643573;7498.887516687254;7943.5631040292765;7944.642491087893;7312.524685895426;7621.8475630487355;7663.5785031823225;7665.348445382149;7671.846563068735;2085.228465467779;2129.7124888140056;2130.7869213078725;2131.2114517628497;2144.1959265275523;1983.4049785064494;2003.3689387842855;2108.652072408051;2166.696662467248;2167.4581354661336;2105.2842033708534;2114.1966052899875;2124.702541644171;2124.9043793029273;2128.2125613523017;2068.6793547000166;2079.324219628619;2081.552466219755;2081.8542702010864;2084.1663334666105;2023.6964455331818;2041.469218003315;2042.1218875883364;2045.1819272291054;2050.5693804301113;7511.286427789351;7541.811454713621;7618.580978046205;7624.733134340271;7628.961855190744;4332.306830907071;4444.2222611042935;4456.977715111436;4457.77711114443;4460.553944605514;2796.972030279712;2802.7757779377803;2872.5260332045186;2882.30824602094;2901.840398778066;871.8692196170625;913.8583519554413;921.6589861751128;942.5664194470552;949.1931857920712;10641.5211315491;10696.78606427875;10730.570777168903;10750.78498430027;10754.78490430187;3992.161646054361;4063.715539912237;4232.32282834745;4235.5552666969525;4269.786510674516;9168.495732734631;9184.954075229714;9211.76970575741;9217.354785165107;9275.21160701348;4467.195904737114;4468.419105516327;4484.68607197493;4489.573490518461;4491.618212451913;3397.5073614325784;4002.45966794479;4122.773247471418;4176.0395109124465;4182.728122672017;3590.5152804371596;3641.217138315275;3666.651668091527;3726.6459686329754;3739.1586892948867;1116.2242241642143;1117.8267368557886;1121.1535290855352;1122.169594500064;1133.637236084445;588.3968931844893;608.40984245282;711.068500264655;719.7444907057919;722.7867779005206;4787.42550893888;4937.975310123498;4940.950590494121;4950.059488697208;5127.333786431035;797.7247849491916;889.8086911314099;894.5080205886736;903.8056817784208;949.2168960607527;3059.541068839692;3205.9038228853174;3482.721382289411;3500.387432199355;3569.803660798629;9586.137247647745;9785.510724463891;9796.559154837907;9813;9829.508524573743;9632.614695412105;9741.782277215349;9745.074217949283;9751.707448776548;9759.951200243953;6877.277885821916;7221.783346499718;7272.963635181896;7446.069241344832;7461.179270280265;4993.725345105909;5120.078385890575;5120.48795120485;5221.086309895829;5351.491608297206;8709.650004249352;8878.911210887809;8956.552172391484;9020.188183063556;9026.413283136575;9005.279577633904;9080.500572468578;9118.088191180828;9145.542722863696;9178.219851312713;5602.1036634138345;6406.071119687526;6410.551261411843;6496.252930913006;6562.934370656423;7162;7200.675969581277;7214.350708436266;7237.457190710613;7259.891101633585;6429.7749578764515;6487.351264873475;6506.284308725942;6572.244191917991;6730.831729206613;6401.64790936503;6472.061551075162;6513.967430162819;6520.771772987922;6541.182352205974;5726.856828579319;5821.27234095738;5849.707514624337;5855.180274761452;5877.529797616095;4369.759663218553;4432.29083346663;4477.171723231213;4540.432445944257;4556.043230921411;4259.531451540266;4287.185434767384;4346.826126955013;4394.318880573516;4420.889477762953 15:47:26 INFO - PROCESS | 26933 | |4;prototype.html;279.3477230666394;279.57085873184656;283.37374402570316;285.2398358374931;285.47187702749915;5031.471695471973;5112.086110916779;5113.718745468997;5116.795328186878;5121.564667003305;5013.523715247045;5033.6224783141315;5046.646734728571;5047.924281135786;5051.77267022984;3735.7858695923796;3806.591561122375;3894.2990261752875;3945.388464787948;3945.3884647879627;3893.7274390792654;3911.7261791674596;3922.3920292354733;3930.150640785422;3931.4692516510336;3863.237784983736;3873.341531939577;3895.9026024349337;3901.9804900975455;3902.492675952122;3762.191128907298;3843.3089440646027;3885.9805700971597;3903.3169195390833;3905.882823515285;3369.275605744777;3373.2241584435474;3383.188034871613;3383.712384447325;3394.62659107498;4834.299026641117;4880.365552478191;4889.511048895118;4891.902161956741;4892.339534162878;4315.956840431587;4408.911821763579;4420.20436321462;4421.292593185107;4422.933655995163;5248.475152484759;5251.973740131275;5273.894522109536;5284.313039304904;5288.23320618512;3760.868369607078;3762.529683789526;3772.302124107049;3772.8868133956025;3774.698024158088;5368.3826359968325;5526.309211348582;5529.861753456155;5541.27963364764;5541.584381171388;3841.3469710148784;3844.500214972036;3862.6523612874976;3867.7292589518465;3867.8259478323544;3900.941485877714;3906.480320193516;3919.6080391960577;3921.039345360405;3923.489946306962;4435.3125265583885;4447.822087116479;4453.51011388747;4455.376247325377;4458.888527786831;5130.3574462131555;5228.719496259921;5239.659422137549;5280.709560974106;5317.9202311965355;1330.4611632288938;1344.5411728274735;1346.279740338914;1346.4614154338146;1352.3508715816463;816.8366326734558;857.7598272483715;859.8538248497646;869.5869462005497;872.3675335381797;4405.515393306734;4464.709793863389;4601.861944141681;4610.239310513794;4624.167649822997;5438.483344082306;5448.482394172547;5475.260839786658;5477.534409575231;5491.297697713721;4590.301588412309;4617.699849509771;4639.350490931272;4645.094206629675;4657.278121891112;2749.477599256135;2913.766898648103;2929.516629756109;2931.296488842705;2935.7211064948797;5119.49144918987;5125.2568377585785;5138.3577052868395;5151.356080489939;5151.407588127413;5339.786408543692;5606.664034899229;5618.174093419655;5618.550515958796;5621.915671264935;5123.718195499283;5125.205593133071;5126.820561280338;5152.278680984665;5157.607445989562;5496.983058134258;5512.283403157564;5513.365962914316;5522.420145884625;5537.944620553743;5225.451327610546;5381.13901775714;5388.110961691277;5416;5422.966387604648;5138.332016837787;5148.9742551287;5155.896882062413;5155.943031678422;5160.174372100446;3738.4018557030745;3746;3763.1532905096133;3765;3779.527559055118;5301.274335226709;5445.401005889428;5480.671159730429;5483.917741233964;5515.227868098389;5306.708131052829;5309.256704061511;5309.548688361532;5319.324412809952;5320.707361095177;5277.815276465305;5331.493508116722;5344.812931547377;5345.251664766858;5353.705546194997;5032.597392208688;5248.291480650063;5290.576753859605;5303.602229832701;5306.487651019441;5128.564072053917;5187.714675692873;5328.786848526015;5358.39248225523;5385.165299378603;5197.610179236497;5204.557612602971;5213.817516386908;5236.842894713165;5238 15:47:26 INFO - PROCESS | 26933 | |5;yui.html;586.5893874287999;625.2497003595685;646.3019938466457;663.7942237906252;734.8609655034699;12171.45228464719;12866.485340586378;12884.355782210887;12908.419121139548;13743.725125497484;13382;13630.863691363083;13693.863061369384;13706.794398084037;13739.587812365646;630.3696303696304;755.4221020918988;765.9693612255503;768.2854944901239;771.8301973565834;745.880659094545;762.6225018615793;765.7740966414893;768.4121646940096;769.1616138409133;801.1467786807061;806.7378102116835;806.9273765361116;806.9475484093545;808.8665370213937;802.9638666260032;803.5982008995502;804.0391731880405;804.16768644453;805.0379796143611;582.9883402331972;585.9941400585982;587.6709042935927;587.6738410182347;587.9647221166744;13308.933455332759;13366.264855432948;13369.131006484547;13380.531681391105;13392.263425511594;13382.330883455885;13515.121517101357;13636;13691.589252322447;14143.929280353635;9642.373245739005;9696.272779541563;9780;9802.803943921153;9993.00069992995;3338.4992251162275;3358.7984720916825;3365.2596428785628;3373.2578832657023;3411.4712219606;53874;55608.721956389956;64518.67740661267;65056;65773.67113164451;10037.498125093716;10122.696319110439;10381.823137342293;10668.1998850085;10736.677899663022;18435.72346414805;18464.907675461538;18533.443996680122;18597.628047438975;18965.43103706891;6918.5502942308585;7035.788926332219;7046.048783414173;7091.078159839188;7107.324804143598;3793.8103094845146;3797.1456422305314;3812.4662547243406;3836.55879573847;3866.168773713609;2901.3181902252954;3000.819950802959;3017.109952563999;3038.9696103039128;3049.9085027449214;509.4625170445142;510.84419252127714;515.2683189870393;517.6842126302952;524.4519477146391;465.82997206020235;523.1263789471516;524.0566979436998;548.4186762032178;551.5670198893849;7805.14143444232;8151.388645851584;8317.251447369767;8344.040435350013;8361.665533378718;545.4082320682026;548.9761594625994;558.5810642018486;561.6742289472096;561.9775208991676;3761.962380376161;3830.4445855351373;3867.091233560111;3880.1463677990796;4010.939835902464;59760.70119649374;60292;61557.38442615606;106378.46810766052;110582;53110.46889531132;53754.73122634362;53985.73007134939;72974;82253;51383.22925156126;52164;57619.711901441064;71395.92906106413;76277.61861190658;7668.539887606538;7898.486598371088;7956.2043795619975;7966.402519811153;7994.760157195294;47544.7622761884;48034;48226;49110.508894912025;49286.50713492819;45800;68414.65792671005;70672.29327706656;71218.64390678014;71795.64102179455;11300.660980170607;11434.542618295174;11467.139964502863;11669.76660466803;12283.078769092175;12598.748025039631;12658.683532911751;13025.47898084066;13098.607041788762;13518.59444216675;11720.765584688088;12288.262704237774;12288.938555307166;12728.809067864175;12852.678683032998;11601.419929003685;11782.587609433971;11896;11901.285922844658;11908.583199587973;11877.406129693309;11910.821337680116;11950.701232469259;11968.222065566059;12371.566995155126;9756.560954756911;10004.099631033241;10021.699349019542;10435.634752783617;10444.060034596923;8973.865392019256;9037.909620903707;9492.382995105296;9882.50587470638;9961.40231586107 15:47:26 INFO - PROCESS | 26933 | __end_tp_report 15:47:26 INFO - PROCESS | 26933 | __start_cc_report 15:47:26 INFO - PROCESS | 26933 | _x_x_mozilla_cycle_collect,392 15:47:26 INFO - PROCESS | 26933 | __end_cc_report 15:47:26 INFO - PROCESS | 26933 | __startTimestamp1470696446717__endTimestamp 15:47:26 INFO - PROCESS | 26933 | 15:47:26 INFO - PROCESS | 26933 | ------- Summary: start ------- 15:47:26 INFO - PROCESS | 26933 | Number of tests: 6 15:47:26 INFO - PROCESS | 26933 | 15:47:26 INFO - PROCESS | 26933 | [#0] dojo.html Cycles:165 Average:4777.85 Median:4868.63 stddev:490.69 (10.1%) stddev-sans-first:463.14 15:47:26 INFO - PROCESS | 26933 | Values: 2657.2 2668.2 2697.0 2702.0 2710.7 4676.3 4814.2 4824.7 4868.2 4885.9 4790.5 4822.1 4872.5 4894.9 4901.7 4420.2 4508.4 4522.8 4567.4 4595.9 4534.6 4578.9 4595.9 4621.2 4633.3 4323.6 4344.2 4470.5 4485.6 4570.6 4417.9 4426.7 4444.6 4560.8 4566.7 4368.3 4409.1 4417.7 4453.8 4466.7 4679.0 4794.6 4834.5 4835.2 4844.9 5097.7 5115.6 5154.7 5158.1 5208.0 5137.1 5170.7 5179.0 5190.5 5231.5 4706.8 4824.8 4833.4 4847.1 4874.7 5336.9 5361.9 5363.0 5413.2 5430.8 5123.5 5132.5 5138.9 5141.1 5199.3 4909.9 5084.8 5153.9 5225.3 5235.7 5105.9 5131.8 5136.2 5139.7 5169.2 5118.2 5124.9 5138.4 5141.6 5185.7 4245.4 4394.8 4434.7 4453.5 4469.0 3887.9 3896.1 3896.6 3933.4 3952.1 4501.0 4509.7 4519.6 4544.8 4564.0 4938.2 5125.7 5165.6 5188.7 5268.9 4438.8 4452.2 4468.2 4483.1 4493.1 4660.4 4677.2 4679.5 4691.2 4721.8 4637.5 4762.6 4824.8 4839.1 4866.6 5161.4 5169.2 5193.4 5205.1 5230.1 4820.3 4830.6 4853.0 4868.6 4907.8 4870.0 5027.4 5061.5 5115.6 5119.0 5207.5 5210.4 5214.7 5218.7 5227.5 5045.2 5057.9 5065.7 5065.9 5112.5 4810.9 4873.0 4892.4 4914.3 5060.7 4850.0 4862.1 4892.6 4910.3 4918.1 4981.9 4992.4 4994.7 5010.3 5029.7 4709.7 4883.1 4931.8 4936.1 4994.1 15:47:26 INFO - PROCESS | 26933 | 15:47:26 INFO - PROCESS | 26933 | [#1] ext.html Cycles:180 Average:46871.19 Median:36578.23 stddev:92424.16 (252.7%) stddev-sans-first:92618.00 15:47:26 INFO - PROCESS | 26933 | Values: 549.4 552.3 565.4 571.8 576.0 34352.8 38736.8 38766.0 38779.6 38832.8 38727.2 39138.4 39220.8 39280.4 39343.0 7635.3 7739.4 7764.5 7770.5 7774.5 7630.4 7712.7 7720.1 7751.0 7754.7 7337.8 7364.4 7391.8 7403.1 7418.1 7688.4 7703.1 7722.9 7735.4 7739.8 7691.3 7699.0 7737.1 7744.6 7746.5 29725.6 29788.1 29963.4 30010.5 30048.4 2574.1 2725.5 2829.7 2840.6 3157.8 25714.2 26520.7 27637.2 27807.4 28150.4 3255.4 3259.3 3303.8 3317.4 3343.7 217230.0 218059.0 218688.0 219846.0 219994.0 31352.0 31786.8 32020.5 32110.5 32368.8 33270.2 33357.7 33482.7 33554.3 33564.3 12636.7 12793.1 12799.5 12802.2 12833.7 9586.0 9618.5 9623.7 9634.7 9660.3 7819.6 7857.7 7882.4 7938.2 7945.0 3008.5 3095.1 3101.7 3122.6 3129.3 839.2 872.6 878.7 892.3 960.8 27563.0 28315.3 28419.0 28460.7 28604.1 910.5 945.5 966.2 967.1 997.2 14165.2 15215.4 15312.9 16054.8 16146.2 426634.0 429039.0 429042.0 429208.0 430758.8 48766.0 49213.5 49491.0 49645.0 49701.5 940.8 984.3 985.6 986.1 1158.6 26759.0 28373.9 28638.7 29211.4 29603.3 43195.9 44181.3 44206.0 44245.6 44255.8 360175.0 361466.0 361877.0 363614.0 366484.0 24959.0 25038.2 27238.3 27479.6 27540.6 40901.3 40928.2 41078.4 41729.2 42559.8 35634.6 35798.6 36097.0 36140.5 36609.6 36021.6 36037.6 36546.8 36716.6 37214.4 32828.7 34063.5 34710.0 36716.0 36795.0 31220.5 33613.0 33698.5 33782.5 33832.7 21742.0 21958.7 22015.0 22135.8 22188.6 15:47:26 INFO - PROCESS | 26933 | 15:47:26 INFO - PROCESS | 26933 | [#2] jquery.html Cycles:180 Average:23884.68 Median:5364.41 stddev:64564.73 (1203.6%) stddev-sans-first:64721.65 15:47:26 INFO - PROCESS | 26933 | Values: 343.3 360.1 362.1 364.6 369.3 15993.8 17229.5 17457.7 17933.1 17961.0 14727.6 15374.7 15468.4 15478.6 15495.5 4322.4 4563.3 4584.6 4636.6 4637.1 3529.1 4601.9 4630.8 5226.5 5482.3 5558.9 5566.6 5592.6 5595.1 5600.6 5495.8 5523.0 5526.0 5536.7 5540.0 5305.7 5352.0 5362.1 5366.7 5371.6 12698.6 18309.0 19969.0 21093.8 21261.1 1928.4 1982.7 2124.4 2449.8 2467.7 9221.6 9314.5 9356.3 11678.7 13220.4 1714.3 1719.5 1724.1 1733.4 1783.8 68611.7 69811.7 71848.3 71897.0 72303.0 8188.8 8787.8 8904.9 9528.5 9859.2 11585.1 11735.3 11737.6 11766.8 11805.2 6682.0 7137.8 7153.7 7177.5 7338.8 6642.9 6705.7 6851.0 6854.3 6855.6 4341.6 4375.5 4378.6 4456.5 4592.5 1621.3 1632.8 1754.1 1788.5 1792.3 799.5 827.2 836.8 863.7 910.6 16934.2 17272.7 17383.3 17674.3 17881.5 816.2 821.1 843.9 868.6 869.6 9675.2 9757.2 9951.8 10032.6 10126.6 378073.0 390767.0 392299.0 395645.0 398192.0 46144.0 64472.0 78093.2 78729.0 81257.3 723.8 753.1 763.1 769.0 772.3 13612.9 13795.3 13797.3 14024.5 14461.4 37057.4 37078.4 37632.2 37807.7 38689.6 50812.5 51757.7 52029.2 52247.5 53677.5 6919.6 7116.8 7206.2 7282.2 7346.9 10606.7 10733.7 11023.7 11089.6 11283.7 9351.9 9431.6 9475.5 9531.8 9685.2 9018.0 9163.4 9383.6 9387.3 9741.2 8896.8 9182.5 9330.8 9429.3 9531.4 7072.6 7104.8 7231.7 7293.3 7347.3 7267.6 8712.6 8724.9 9189.1 9385.7 15:47:26 INFO - PROCESS | 26933 | 15:47:26 INFO - PROCESS | 26933 | [#3] mootools.html Cycles:180 Average:5030.22 Median:5120.28 stddev:2887.44 (56.4%) stddev-sans-first:2882.51 15:47:26 INFO - PROCESS | 26933 | Values: 1380.4 1406.5 1472.8 1682.4 1684.5 6327.2 7361.3 7498.9 7943.6 7944.6 7312.5 7621.8 7663.6 7665.3 7671.8 2085.2 2129.7 2130.8 2131.2 2144.2 1983.4 2003.4 2108.7 2166.7 2167.5 2105.3 2114.2 2124.7 2124.9 2128.2 2068.7 2079.3 2081.6 2081.9 2084.2 2023.7 2041.5 2042.1 2045.2 2050.6 7511.3 7541.8 7618.6 7624.7 7629.0 4332.3 4444.2 4457.0 4457.8 4460.6 2797.0 2802.8 2872.5 2882.3 2901.8 871.9 913.9 921.7 942.6 949.2 10641.5 10696.8 10730.6 10750.8 10754.8 3992.2 4063.7 4232.3 4235.6 4269.8 9168.5 9185.0 9211.8 9217.4 9275.2 4467.2 4468.4 4484.7 4489.6 4491.6 3397.5 4002.5 4122.8 4176.0 4182.7 3590.5 3641.2 3666.7 3726.6 3739.2 1116.2 1117.8 1121.2 1122.2 1133.6 588.4 608.4 711.1 719.7 722.8 4787.4 4938.0 4941.0 4950.1 5127.3 797.7 889.8 894.5 903.8 949.2 3059.5 3205.9 3482.7 3500.4 3569.8 9586.1 9785.5 9796.6 9813.0 9829.5 9632.6 9741.8 9745.1 9751.7 9760.0 6877.3 7221.8 7273.0 7446.1 7461.2 4993.7 5120.1 5120.5 5221.1 5351.5 8709.7 8878.9 8956.6 9020.2 9026.4 9005.3 9080.5 9118.1 9145.5 9178.2 5602.1 6406.1 6410.6 6496.3 6562.9 7162.0 7200.7 7214.4 7237.5 7259.9 6429.8 6487.4 6506.3 6572.2 6730.8 6401.6 6472.1 6514.0 6520.8 6541.2 5726.9 5821.3 5849.7 5855.2 5877.5 4369.8 4432.3 4477.2 4540.4 4556.0 4259.5 4287.2 4346.8 4394.3 4420.9 15:47:26 INFO - PROCESS | 26933 | 15:47:26 INFO - PROCESS | 26933 | [#4] prototype.html Cycles:180 Average:4382.97 Median:5049.85 stddev:1292.22 (25.6%) stddev-sans-first:1258.61 15:47:26 INFO - PROCESS | 26933 | Values: 279.3 279.6 283.4 285.2 285.5 5031.5 5112.1 5113.7 5116.8 5121.6 5013.5 5033.6 5046.6 5047.9 5051.8 3735.8 3806.6 3894.3 3945.4 3945.4 3893.7 3911.7 3922.4 3930.2 3931.5 3863.2 3873.3 3895.9 3902.0 3902.5 3762.2 3843.3 3886.0 3903.3 3905.9 3369.3 3373.2 3383.2 3383.7 3394.6 4834.3 4880.4 4889.5 4891.9 4892.3 4316.0 4408.9 4420.2 4421.3 4422.9 5248.5 5252.0 5273.9 5284.3 5288.2 3760.9 3762.5 3772.3 3772.9 3774.7 5368.4 5526.3 5529.9 5541.3 5541.6 3841.3 3844.5 3862.7 3867.7 3867.8 3900.9 3906.5 3919.6 3921.0 3923.5 4435.3 4447.8 4453.5 4455.4 4458.9 5130.4 5228.7 5239.7 5280.7 5317.9 1330.5 1344.5 1346.3 1346.5 1352.4 816.8 857.8 859.9 869.6 872.4 4405.5 4464.7 4601.9 4610.2 4624.2 5438.5 5448.5 5475.3 5477.5 5491.3 4590.3 4617.7 4639.4 4645.1 4657.3 2749.5 2913.8 2929.5 2931.3 2935.7 5119.5 5125.3 5138.4 5151.4 5151.4 5339.8 5606.7 5618.2 5618.6 5621.9 5123.7 5125.2 5126.8 5152.3 5157.6 5497.0 5512.3 5513.4 5522.4 5537.9 5225.5 5381.1 5388.1 5416.0 5423.0 5138.3 5149.0 5155.9 5155.9 5160.2 3738.4 3746.0 3763.2 3765.0 3779.5 5301.3 5445.4 5480.7 5483.9 5515.2 5306.7 5309.3 5309.5 5319.3 5320.7 5277.8 5331.5 5344.8 5345.3 5353.7 5032.6 5248.3 5290.6 5303.6 5306.5 5128.6 5187.7 5328.8 5358.4 5385.2 5197.6 5204.6 5213.8 5236.8 5238.0 15:47:26 INFO - PROCESS | 26933 | 15:47:26 INFO - PROCESS | 26933 | [#5] yui.html Cycles:180 Average:16544.41 Median:25949.25 stddev:22449.24 (86.5%) stddev-sans-first:22480.24 15:47:26 INFO - PROCESS | 26933 | Values: 586.6 625.2 646.3 663.8 734.9 12171.5 12866.5 12884.4 12908.4 13743.7 13382.0 13630.9 13693.9 13706.8 13739.6 630.4 755.4 766.0 768.3 771.8 745.9 762.6 765.8 768.4 769.2 801.1 806.7 806.9 806.9 808.9 803.0 803.6 804.0 804.2 805.0 583.0 586.0 587.7 587.7 588.0 13308.9 13366.3 13369.1 13380.5 13392.3 13382.3 13515.1 13636.0 13691.6 14143.9 9642.4 9696.3 9780.0 9802.8 9993.0 3338.5 3358.8 3365.3 3373.3 3411.5 53874.0 55608.7 64518.7 65056.0 65773.7 10037.5 10122.7 10381.8 10668.2 10736.7 18435.7 18464.9 18533.4 18597.6 18965.4 6918.6 7035.8 7046.0 7091.1 7107.3 3793.8 3797.1 3812.5 3836.6 3866.2 2901.3 3000.8 3017.1 3039.0 3049.9 509.5 510.8 515.3 517.7 524.5 465.8 523.1 524.1 548.4 551.6 7805.1 8151.4 8317.3 8344.0 8361.7 545.4 549.0 558.6 561.7 562.0 3762.0 3830.4 3867.1 3880.1 4010.9 59760.7 60292.0 61557.4 106378.5 110582.0 53110.5 53754.7 53985.7 72974.0 82253.0 51383.2 52164.0 57619.7 71395.9 76277.6 7668.5 7898.5 7956.2 7966.4 7994.8 47544.8 48034.0 48226.0 49110.5 49286.5 45800.0 68414.7 70672.3 71218.6 71795.6 11300.7 11434.5 11467.1 11669.8 12283.1 12598.7 12658.7 13025.5 13098.6 13518.6 11720.8 12288.3 12288.9 12728.8 12852.7 11601.4 11782.6 11896.0 11901.3 11908.6 11877.4 11910.8 11950.7 11968.2 12371.6 9756.6 10004.1 10021.7 10435.6 10444.1 8973.9 9037.9 9492.4 9882.5 9961.4 15:47:26 INFO - PROCESS | 26933 | -------- Summary: end -------- 15:47:26 INFO - PROCESS | 26933 | 15:47:27 INFO - TEST-INFO | 26933: exit 0 15:47:27 INFO - TEST-OK | dromaeo_css | took 1117125ms 15:47:27 INFO - TEST-START | kraken 15:47:27 INFO - operating with platform_type : linux_ 15:47:27 INFO - Initialising browser for kraken test... 15:47:27 INFO - TEST-INFO | started process 27184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyHeM5z/profile http://localhost:49756/getInfo.html) 15:47:32 INFO - PROCESS | 27184 | __metrics Screen width/height:1600/1200 15:47:32 INFO - PROCESS | 27184 | colorDepth:24 15:47:32 INFO - PROCESS | 27184 | Browser inner width/height: 1024/697 15:47:32 INFO - PROCESS | 27184 | __metrics 15:47:32 ERROR - PROCESS | 27184 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:47:33 INFO - TEST-INFO | 27184: exit 0 15:47:33 INFO - Browser initialized. 15:47:33 INFO - Running cycle 1/1 for kraken test... 15:47:33 INFO - TEST-INFO | started process 27303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyHeM5z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:47:45 INFO - PROCESS | 27303 | RSS: Main: 165064704 15:47:45 INFO - PROCESS | 27303 | 15:47:48 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49756/tests/kraken/driver.html?testName=audio-beat-detection) 15:47:49 INFO - PROCESS | 27303 | RSS: Main: 169668608 15:47:49 INFO - PROCESS | 27303 | 15:47:52 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49756/tests/kraken/driver.html?testName=audio-dft) 15:47:52 INFO - PROCESS | 27303 | RSS: Main: 168902656 15:47:52 INFO - PROCESS | 27303 | 15:47:55 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49756/tests/kraken/driver.html?testName=audio-fft) 15:47:56 INFO - PROCESS | 27303 | RSS: Main: 164990976 15:47:56 INFO - PROCESS | 27303 | 15:47:58 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49756/tests/kraken/driver.html?testName=audio-oscillator) 15:47:59 INFO - PROCESS | 27303 | RSS: Main: 165728256 15:47:59 INFO - PROCESS | 27303 | 15:48:01 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49756/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:48:02 INFO - PROCESS | 27303 | RSS: Main: 166047744 15:48:02 INFO - PROCESS | 27303 | 15:48:05 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49756/tests/kraken/driver.html?testName=imaging-darkroom) 15:48:05 INFO - PROCESS | 27303 | RSS: Main: 166322176 15:48:05 INFO - PROCESS | 27303 | 15:48:09 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49756/tests/kraken/driver.html?testName=imaging-desaturate) 15:48:10 INFO - PROCESS | 27303 | RSS: Main: 164093952 15:48:10 INFO - PROCESS | 27303 | 15:48:13 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49756/tests/kraken/driver.html?testName=json-parse-financial) 15:48:13 INFO - PROCESS | 27303 | RSS: Main: 165908480 15:48:13 INFO - PROCESS | 27303 | 15:48:15 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49756/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:48:16 INFO - PROCESS | 27303 | RSS: Main: 165883904 15:48:16 INFO - PROCESS | 27303 | 15:48:17 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49756/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:48:18 INFO - PROCESS | 27303 | RSS: Main: 166010880 15:48:18 INFO - PROCESS | 27303 | 15:48:20 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49756/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:48:21 INFO - PROCESS | 27303 | RSS: Main: 166273024 15:48:21 INFO - PROCESS | 27303 | 15:48:24 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:48:25 INFO - PROCESS | 27303 | RSS: Main: 166940672 15:48:25 INFO - PROCESS | 27303 | 15:48:27 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:48:28 INFO - PROCESS | 27303 | RSS: Main: 166535168 15:48:28 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:49756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49756/tests/kraken/driver.html?testName=ai-astar) 15:48:30 INFO - PROCESS | 27303 | RSS: Main: 167538688 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | __start_tp_report 15:48:30 INFO - PROCESS | 27303 | _x_x_mozilla_page_load 15:48:30 INFO - PROCESS | 27303 | _x_x_mozilla_page_load_details 15:48:30 INFO - PROCESS | 27303 | |i|pagename|runs| 15:48:30 INFO - PROCESS | 27303 | |0;ai-astar;106;118;113;116;116;115;116;117;114;114 15:48:30 INFO - PROCESS | 27303 | |1;audio-beat-detection;161;122;151;180;123;151;151;134;185;124 15:48:30 INFO - PROCESS | 27303 | |2;audio-dft;164;165;166;169;163;163;166;165;163;164 15:48:30 INFO - PROCESS | 27303 | |3;audio-fft;76;77;77;169;77;76;77;76;163;79 15:48:30 INFO - PROCESS | 27303 | |4;audio-oscillator;85;87;153;85;86;85;131;85;84;140 15:48:30 INFO - PROCESS | 27303 | |5;imaging-gaussian-blur;118;118;118;117;117;119;118;118;118;117 15:48:30 INFO - PROCESS | 27303 | |6;imaging-darkroom;148;148;148;148;148;149;149;149;148;148 15:48:30 INFO - PROCESS | 27303 | |7;imaging-desaturate;95;95;96;96;95;96;95;97;95;96 15:48:30 INFO - PROCESS | 27303 | |8;json-parse-financial;63;63;64;64;65;65;62;65;64;71 15:48:30 INFO - PROCESS | 27303 | |9;json-stringify-tinderbox;65;65;65;65;65;65;66;65;66;68 15:48:30 INFO - PROCESS | 27303 | |10;stanford-crypto-aes;81;81;87;80;92;80;80;90;86;84 15:48:30 INFO - PROCESS | 27303 | |11;stanford-crypto-ccm;143;131;132;135;132;151;132;134;217;142 15:48:30 INFO - PROCESS | 27303 | |12;stanford-crypto-pbkdf2;170;174;169;172;166;166;168;170;170;168 15:48:30 INFO - PROCESS | 27303 | |13;stanford-crypto-sha256-iterative;69;69;69;69;68;68;68;68;67;66 15:48:30 INFO - PROCESS | 27303 | __end_tp_report 15:48:30 INFO - PROCESS | 27303 | __start_cc_report 15:48:30 INFO - PROCESS | 27303 | _x_x_mozilla_cycle_collect,976 15:48:30 INFO - PROCESS | 27303 | __end_cc_report 15:48:30 INFO - PROCESS | 27303 | __startTimestamp1470696510573__endTimestamp 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | ------- Summary: start ------- 15:48:30 INFO - PROCESS | 27303 | Number of tests: 14 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#0] ai-astar Cycles:10 Average:114.50 Median:116.00 stddev:3.34 (2.9%) stddev-sans-first:1.59 15:48:30 INFO - PROCESS | 27303 | Values: 106.0 118.0 113.0 116.0 116.0 115.0 116.0 117.0 114.0 114.0 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:151.00 stddev:22.76 (15.1%) stddev-sans-first:23.66 15:48:30 INFO - PROCESS | 27303 | Values: 161.0 122.0 151.0 180.0 123.0 151.0 151.0 134.0 185.0 124.0 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:1.87 (1.1%) stddev-sans-first:1.96 15:48:30 INFO - PROCESS | 27303 | Values: 164.0 165.0 166.0 169.0 163.0 163.0 166.0 165.0 163.0 164.0 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#3] audio-fft Cycles:10 Average:94.70 Median:77.00 stddev:37.62 (48.9%) stddev-sans-first:39.28 15:48:30 INFO - PROCESS | 27303 | Values: 76.0 77.0 77.0 169.0 77.0 76.0 77.0 76.0 163.0 79.0 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:85.00 stddev:27.58 (32.4%) stddev-sans-first:28.55 15:48:30 INFO - PROCESS | 27303 | Values: 85.0 87.0 153.0 85.0 86.0 85.0 131.0 85.0 84.0 140.0 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 15:48:30 INFO - PROCESS | 27303 | Values: 118.0 118.0 118.0 117.0 117.0 119.0 118.0 118.0 118.0 117.0 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 15:48:30 INFO - PROCESS | 27303 | Values: 148.0 148.0 148.0 148.0 148.0 149.0 149.0 149.0 148.0 148.0 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 15:48:30 INFO - PROCESS | 27303 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 95.0 97.0 95.0 96.0 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.50 stddev:2.46 (3.8%) stddev-sans-first:2.54 15:48:30 INFO - PROCESS | 27303 | Values: 63.0 63.0 64.0 64.0 65.0 65.0 62.0 65.0 64.0 71.0 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 15:48:30 INFO - PROCESS | 27303 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 66.0 68.0 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:85.00 stddev:4.46 (5.2%) stddev-sans-first:4.59 15:48:30 INFO - PROCESS | 27303 | Values: 81.0 81.0 87.0 80.0 92.0 80.0 80.0 90.0 86.0 84.0 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:138.50 stddev:26.16 (18.9%) stddev-sans-first:27.73 15:48:30 INFO - PROCESS | 27303 | Values: 143.0 131.0 132.0 135.0 132.0 151.0 132.0 134.0 217.0 142.0 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:170.00 stddev:2.50 (1.5%) stddev-sans-first:2.64 15:48:30 INFO - PROCESS | 27303 | Values: 170.0 174.0 169.0 172.0 166.0 166.0 168.0 170.0 170.0 168.0 15:48:30 INFO - PROCESS | 27303 | 15:48:30 INFO - PROCESS | 27303 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:0.99 (1.5%) stddev-sans-first:1.00 15:48:30 INFO - PROCESS | 27303 | Values: 69.0 69.0 69.0 69.0 68.0 68.0 68.0 68.0 67.0 66.0 15:48:30 INFO - PROCESS | 27303 | -------- Summary: end -------- 15:48:30 INFO - PROCESS | 27303 | 15:48:31 INFO - TEST-INFO | 27303: exit 0 15:48:31 INFO - TEST-OK | kraken | took 64114ms 15:48:31 INFO - SUITE-END | took 1181s 15:48:31 INFO - Completed test suite (00:19:41) 15:48:31 INFO - javascript benchmark 15:48:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6271.927973870154, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2657.176275354639, 2668.159529748129, 2696.986515067425, 2701.972980270197, 2710.701822799493, 4676.251799712047, 4814.229723244282, 4824.710517368956, 4868.196747536656, 4885.926711099328, 4790.496997815231, 4822.083804077223, 4872.488388719178, 4894.926576101361, 4901.65688401812, 4420.248557745183, 4508.368828364015, 4522.841700540482, 4567.3815066118605, 4595.931061034087, 4534.591886730193, 4578.862634120965, 4595.908081838378, 4621.168189725848, 4633.2818413146015, 4323.567643235683, 4344.152890186415, 4470.508244093147, 4485.551444855521, 4570.611498022672, 4417.889552761175, 4426.690131690783, 4444.644428445717, 4560.771961401917, 4566.725996440225, 4368.344748287751, 4409.140217657558, 4417.668674849399, 4453.844115455976, 4466.687331886769, 4678.970626462173, 4794.592459640935, 4834.492378300298, 4835.153848076572, 4844.927326090112, 5097.7196254206, 5115.616328775357, 5154.716490593016, 5158.071547121516, 5208.0, 5137.101007323703, 5170.715610641413, 5179.04187725272, 5190.532852043297, 5231.503007214308, 4706.835260765857, 4824.807007719652, 4833.371661683994, 4847.054824309296, 4874.707517548958, 5336.946630533723, 5361.946380536145, 5362.973185134049, 5413.160960051198, 5430.782768689287, 5123.513266239701, 5132.461091585405, 5138.8972220556125, 5141.074606570854, 5199.298094757235, 4909.926351104737, 5084.8220312288895, 5153.891913238596, 5225.268462415265, 5235.712035838065, 5105.8723531911255, 5131.846044618667, 5136.203888397305, 5139.717315547681, 5169.224616307584, 5118.206677964921, 5124.92312615311, 5138.409082955433, 5141.562967147759, 5185.688858668492, 4245.448091748115, 4394.802233899418, 4434.733915964988, 4453.487848897354, 4469.0, 3887.8833634990997, 3896.123372241223, 3896.59085795993, 3933.3903244997073, 3952.110775075585, 4500.954990450119, 4509.684322097487, 4519.638428925678, 4544.795484203219, 4564.041551274203, 4938.160512712848, 5125.692458452505, 5165.638405311592, 5188.662736922163, 5268.947310526923, 4438.755868427203, 4452.198604251201, 4468.218061839165, 4483.125790470827, 4493.1013797240685, 4660.4407471103, 4677.204875171229, 4679.4618618858585, 4691.249400095969, 4721.834735784231, 4637.536246375403, 4762.595179409789, 4824.782884770264, 4839.056384005226, 4866.562009419169, 5161.380634323905, 5169.172932330809, 5193.42872284056, 5205.141151709925, 5230.0585894539345, 4820.276958456259, 4830.565249127455, 4852.975735121302, 4868.634852386014, 4907.803687852589, 4869.975650121727, 5027.396712394389, 5061.519155680205, 5115.616328775432, 5119.027384797026, 5207.505286997881, 5210.426853046086, 5214.661047031931, 5218.712970786643, 5227.451117632746, 5045.217991211368, 5057.949420505748, 5065.670731402447, 5065.924011139909, 5112.463191365002, 4810.903781924412, 4873.0, 4892.437369702529, 4914.336564563738, 5060.671056381323, 4849.95150048495, 4862.07620552094, 4892.584130348961, 4910.263460480956, 4918.1393256180745, 4981.850544483671, 4992.425871024733, 4994.725290109079, 5010.348654674869, 5029.673071250357, 4709.740964246999, 4883.072216278895, 4931.827386041471, 4936.136176169228, 4994.101061808764], "value": 4747.02881104118, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.3572520151425, 552.2654869024198, 565.3611419096421, 571.8456016875441, 575.989139060948, 34352.82823585882, 38736.80631596842, 38766.03084922875, 38779.61220387802, 38832.80583597078, 38727.22545549087, 39138.412923806165, 39220.80389598055, 39280.41079383804, 39343.0, 7635.312821846032, 7739.380849532024, 7764.534127952313, 7770.533767973911, 7774.49465784725, 7630.351420129296, 7712.730054448096, 7720.073591169067, 7751.0, 7754.728584499544, 7337.816554586151, 7364.410847132217, 7391.778246652609, 7403.074615673041, 7418.072740907387, 7688.423368247404, 7703.114141873701, 7722.922770772333, 7735.419843511731, 7739.845203095907, 7691.30778229962, 7699.037620297463, 7737.110232323299, 7744.612769361565, 7746.535207887545, 29725.55411668805, 29788.10635680933, 29963.400731985457, 30010.549841752392, 30048.399032019457, 2574.1376638826014, 2725.523033469135, 2829.6604407471236, 2840.630718006646, 3157.842107894619, 25714.22857314265, 26520.734792652212, 27637.170884873485, 27807.443851123066, 28150.43699126006, 3255.3814775192636, 3259.2992506610954, 3303.785253958485, 3317.402867483852, 3343.699067083974, 217230.0, 218059.0, 218688.0, 219845.9999999984, 219994.0, 31352.0, 31786.841065794986, 32020.519692204634, 32110.518342224885, 32368.83815580907, 33270.16824579405, 33357.66642333545, 33482.66517334795, 33554.328913421596, 33564.32871342608, 12636.684082898, 12793.104482686309, 12799.488020479263, 12802.16785908913, 12833.743325133444, 9585.952070239744, 9618.51907404627, 9623.711288661212, 9634.71095867111, 9660.275479339078, 7819.609019549, 7857.724979625686, 7882.369410447151, 7938.206179382016, 7944.960275198702, 3008.473517134493, 3095.086949349947, 3101.65881753007, 3122.6252849658185, 3129.3115514586752, 839.2488722593245, 872.6378552900475, 878.7056336127469, 892.2772554231094, 960.7934294126796, 27563.0, 28315.292117696812, 28419.0, 28460.71539284622, 28604.14187574376, 910.5356268303213, 945.5177859291811, 966.1594412860856, 967.1199208720031, 997.1574019953129, 14165.220912849685, 15215.391384344503, 15312.923435382974, 16054.75917861233, 16146.192690365435, 426634.0, 429039.0, 429042.0, 429208.0, 430758.84620576695, 48766.0, 49213.50786492161, 49491.0, 49645.0, 49701.50298496969, 940.7695114696943, 984.3355734878928, 985.5762022330467, 986.0829428631441, 1158.6002829023973, 26759.0, 28373.85813071004, 28638.713612863605, 29211.41577168487, 29603.25991850135, 43195.920101997704, 44181.337279940184, 44206.0, 44245.55754442414, 44255.778721107476, 360175.0, 361466.0, 361877.0, 363614.0, 366484.0, 24959.0, 25038.248852534452, 27238.319042023315, 27479.587806183325, 27540.58689119705, 40901.30294457486, 40928.1814363717, 41078.38382424326, 41729.1654166921, 42559.787201063795, 35634.61471160236, 35798.642013579534, 36097.0, 36140.4578931311, 36609.63390366062, 36021.63978360288, 36037.639623604475, 36546.8172659135, 36716.63283367132, 37214.44178337381, 32828.67171328352, 34063.4890476648, 34710.0, 36716.0, 36795.0, 31220.531692024182, 33613.0, 33698.494522582674, 33782.49326260157, 33832.66167338295, 21742.0156369281, 21958.670619941033, 22015.0, 22135.778642213372, 22188.556228875656], "value": 15841.028976511352, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.2979556806331, 360.11411926660406, 362.14533700466905, 364.58619466905054, 369.254106704457, 15993.84006159938, 17229.483115506522, 17457.65084698305, 17933.117022712624, 17960.999999999967, 14727.631809204748, 15374.69250614987, 15468.381264749396, 15478.61303467414, 15495.535133945972, 4322.394864718934, 4563.26987681971, 4584.633229341644, 4636.629069674418, 4637.095766325568, 3529.1177205698577, 4601.930971035437, 4630.837920672777, 5226.503482169188, 5482.342118945732, 5558.888822223553, 5566.55467562594, 5592.5805564582815, 5595.104783234683, 5600.5799565032585, 5495.835124946258, 5522.972385138069, 5525.972370138164, 5536.667799932017, 5539.972300138474, 5305.65513241638, 5351.973240133774, 5362.115250983583, 5366.711989122621, 5371.59713021521, 12698.555550555779, 18309.0, 19969.0, 21093.789062109336, 21261.149554017975, 1928.3829174664113, 1982.672858978267, 2124.426404870692, 2449.8162637802056, 2467.6915385576804, 9221.631134754602, 9314.534273286308, 9356.251499879992, 11678.708032299175, 13220.405081771343, 1714.3314107498086, 1719.5185348102552, 1724.0690027385322, 1733.3586572967956, 1783.839454449106, 68611.65694171497, 69811.65094174497, 71848.28151718469, 71897.0, 72302.99999999948, 8188.754337369888, 8787.780305492413, 8904.8664270036, 9528.523573821281, 9859.211263098934, 11585.131115166396, 11735.295882247092, 11737.647870563897, 11766.823497647541, 11805.232659877252, 6681.966590167115, 7137.785866424016, 7153.6780844862105, 7177.533460325062, 7338.77983660491, 6642.86714265712, 6705.6982435790505, 6850.965745171242, 6854.314568543105, 6855.554388964801, 4341.60925516705, 4375.51232580924, 4378.562143785596, 4456.487503937024, 4592.471865735483, 1621.2542230573831, 1632.8040635123623, 1754.0791084680645, 1788.534980904948, 1792.27412897774, 799.5322736199389, 827.2224109337204, 836.7615229659518, 863.7106569299355, 910.5902343945252, 16934.237959291862, 17272.65454690899, 17383.304667813398, 17674.293028278724, 17881.46355609334, 816.2164322250587, 821.0926925747083, 843.9451435656663, 868.5743985447085, 869.6130222051127, 9675.225981921429, 9757.170640495495, 9951.80096398068, 10032.598696052077, 10126.59493620247, 378073.0, 390767.0, 392299.0, 395645.0, 398192.0, 46144.0, 64472.032919506244, 78093.21906780972, 78729.0, 81257.34341954626, 723.7683941138785, 753.066197914582, 763.0957315581054, 768.9692412303557, 772.2663469703804, 13612.86387136116, 13795.310234488035, 13797.310134493035, 14024.509142179975, 14461.421543138156, 37057.44413833741, 37078.44382334213, 37632.247355053296, 37807.67673131427, 38689.6131038686, 50812.49187508078, 51757.7412112937, 52029.21956170736, 52247.47752522426, 53677.463225367246, 6919.584824910521, 7116.822079448055, 7206.243344448967, 7282.198958114497, 7346.853062938604, 10606.734831629272, 10733.731656708645, 11023.72440688957, 11089.611863585058, 11283.717907052389, 9351.906480935104, 9431.575579099093, 9475.47884866339, 9531.761705957406, 9685.225181985565, 9017.954910225408, 9163.358564900393, 9383.624655013722, 9387.342885997914, 9741.220702343937, 8896.822063558564, 9182.494962777111, 9330.766730831783, 9429.3399462037, 9531.428114313163, 7072.611006394698, 7104.751333703295, 7231.746888858865, 7293.343599076109, 7347.26527347261, 7267.563946163247, 8712.607932643174, 8724.91275087241, 9189.081091890757, 9385.671501497414], "value": 7888.937080842322, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.4133243371564, 1406.507722297196, 1472.8306244781854, 1682.4195652499884, 1684.4946516045184, 6327.209098862642, 7361.30067643573, 7498.887516687254, 7943.5631040292765, 7944.642491087893, 7312.524685895426, 7621.8475630487355, 7663.5785031823225, 7665.348445382149, 7671.846563068735, 2085.228465467779, 2129.7124888140056, 2130.7869213078725, 2131.2114517628497, 2144.1959265275523, 1983.4049785064494, 2003.3689387842855, 2108.652072408051, 2166.696662467248, 2167.4581354661336, 2105.2842033708534, 2114.1966052899875, 2124.702541644171, 2124.9043793029273, 2128.2125613523017, 2068.6793547000166, 2079.324219628619, 2081.552466219755, 2081.8542702010864, 2084.1663334666105, 2023.6964455331818, 2041.469218003315, 2042.1218875883364, 2045.1819272291054, 2050.5693804301113, 7511.286427789351, 7541.811454713621, 7618.580978046205, 7624.733134340271, 7628.961855190744, 4332.306830907071, 4444.2222611042935, 4456.977715111436, 4457.77711114443, 4460.553944605514, 2796.972030279712, 2802.7757779377803, 2872.5260332045186, 2882.30824602094, 2901.840398778066, 871.8692196170625, 913.8583519554413, 921.6589861751128, 942.5664194470552, 949.1931857920712, 10641.5211315491, 10696.78606427875, 10730.570777168903, 10750.78498430027, 10754.78490430187, 3992.161646054361, 4063.715539912237, 4232.32282834745, 4235.5552666969525, 4269.786510674516, 9168.495732734631, 9184.954075229714, 9211.76970575741, 9217.354785165107, 9275.21160701348, 4467.195904737114, 4468.419105516327, 4484.68607197493, 4489.573490518461, 4491.618212451913, 3397.5073614325784, 4002.45966794479, 4122.773247471418, 4176.0395109124465, 4182.728122672017, 3590.5152804371596, 3641.217138315275, 3666.651668091527, 3726.6459686329754, 3739.1586892948867, 1116.2242241642143, 1117.8267368557886, 1121.1535290855352, 1122.169594500064, 1133.637236084445, 588.3968931844893, 608.40984245282, 711.068500264655, 719.7444907057919, 722.7867779005206, 4787.42550893888, 4937.975310123498, 4940.950590494121, 4950.059488697208, 5127.333786431035, 797.7247849491916, 889.8086911314099, 894.5080205886736, 903.8056817784208, 949.2168960607527, 3059.541068839692, 3205.9038228853174, 3482.721382289411, 3500.387432199355, 3569.803660798629, 9586.137247647745, 9785.510724463891, 9796.559154837907, 9813.0, 9829.508524573743, 9632.614695412105, 9741.782277215349, 9745.074217949283, 9751.707448776548, 9759.951200243953, 6877.277885821916, 7221.783346499718, 7272.963635181896, 7446.069241344832, 7461.179270280265, 4993.725345105909, 5120.078385890575, 5120.48795120485, 5221.086309895829, 5351.491608297206, 8709.650004249352, 8878.911210887809, 8956.552172391484, 9020.188183063556, 9026.413283136575, 9005.279577633904, 9080.500572468578, 9118.088191180828, 9145.542722863696, 9178.219851312713, 5602.1036634138345, 6406.071119687526, 6410.551261411843, 6496.252930913006, 6562.934370656423, 7162.0, 7200.675969581277, 7214.350708436266, 7237.457190710613, 7259.891101633585, 6429.7749578764515, 6487.351264873475, 6506.284308725942, 6572.244191917991, 6730.831729206613, 6401.64790936503, 6472.061551075162, 6513.967430162819, 6520.771772987922, 6541.182352205974, 5726.856828579319, 5821.27234095738, 5849.707514624337, 5855.180274761452, 5877.529797616095, 4369.759663218553, 4432.29083346663, 4477.171723231213, 4540.432445944257, 4556.043230921411, 4259.531451540266, 4287.185434767384, 4346.826126955013, 4394.318880573516, 4420.889477762953], "value": 4020.69380349032, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.3477230666394, 279.57085873184656, 283.37374402570316, 285.2398358374931, 285.47187702749915, 5031.471695471973, 5112.086110916779, 5113.718745468997, 5116.795328186878, 5121.564667003305, 5013.523715247045, 5033.6224783141315, 5046.646734728571, 5047.924281135786, 5051.77267022984, 3735.7858695923796, 3806.591561122375, 3894.2990261752875, 3945.388464787948, 3945.3884647879627, 3893.7274390792654, 3911.7261791674596, 3922.3920292354733, 3930.150640785422, 3931.4692516510336, 3863.237784983736, 3873.341531939577, 3895.9026024349337, 3901.9804900975455, 3902.492675952122, 3762.191128907298, 3843.3089440646027, 3885.9805700971597, 3903.3169195390833, 3905.882823515285, 3369.275605744777, 3373.2241584435474, 3383.188034871613, 3383.712384447325, 3394.62659107498, 4834.299026641117, 4880.365552478191, 4889.511048895118, 4891.902161956741, 4892.339534162878, 4315.956840431587, 4408.911821763579, 4420.20436321462, 4421.292593185107, 4422.933655995163, 5248.475152484759, 5251.973740131275, 5273.894522109536, 5284.313039304904, 5288.23320618512, 3760.868369607078, 3762.529683789526, 3772.302124107049, 3772.8868133956025, 3774.698024158088, 5368.3826359968325, 5526.309211348582, 5529.861753456155, 5541.27963364764, 5541.584381171388, 3841.3469710148784, 3844.500214972036, 3862.6523612874976, 3867.7292589518465, 3867.8259478323544, 3900.941485877714, 3906.480320193516, 3919.6080391960577, 3921.039345360405, 3923.489946306962, 4435.3125265583885, 4447.822087116479, 4453.51011388747, 4455.376247325377, 4458.888527786831, 5130.3574462131555, 5228.719496259921, 5239.659422137549, 5280.709560974106, 5317.9202311965355, 1330.4611632288938, 1344.5411728274735, 1346.279740338914, 1346.4614154338146, 1352.3508715816463, 816.8366326734558, 857.7598272483715, 859.8538248497646, 869.5869462005497, 872.3675335381797, 4405.515393306734, 4464.709793863389, 4601.861944141681, 4610.239310513794, 4624.167649822997, 5438.483344082306, 5448.482394172547, 5475.260839786658, 5477.534409575231, 5491.297697713721, 4590.301588412309, 4617.699849509771, 4639.350490931272, 4645.094206629675, 4657.278121891112, 2749.477599256135, 2913.766898648103, 2929.516629756109, 2931.296488842705, 2935.7211064948797, 5119.49144918987, 5125.2568377585785, 5138.3577052868395, 5151.356080489939, 5151.407588127413, 5339.786408543692, 5606.664034899229, 5618.174093419655, 5618.550515958796, 5621.915671264935, 5123.718195499283, 5125.205593133071, 5126.820561280338, 5152.278680984665, 5157.607445989562, 5496.983058134258, 5512.283403157564, 5513.365962914316, 5522.420145884625, 5537.944620553743, 5225.451327610546, 5381.13901775714, 5388.110961691277, 5416.0, 5422.966387604648, 5138.332016837787, 5148.9742551287, 5155.896882062413, 5155.943031678422, 5160.174372100446, 3738.4018557030745, 3746.0, 3763.1532905096133, 3765.0, 3779.527559055118, 5301.274335226709, 5445.401005889428, 5480.671159730429, 5483.917741233964, 5515.227868098389, 5306.708131052829, 5309.256704061511, 5309.548688361532, 5319.324412809952, 5320.707361095177, 5277.815276465305, 5331.493508116722, 5344.812931547377, 5345.251664766858, 5353.705546194997, 5032.597392208688, 5248.291480650063, 5290.576753859605, 5303.602229832701, 5306.487651019441, 5128.564072053917, 5187.714675692873, 5328.786848526015, 5358.39248225523, 5385.165299378603, 5197.610179236497, 5204.557612602971, 5213.817516386908, 5236.842894713165, 5238.0], "value": 3960.434271410974, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.5893874287999, 625.2497003595685, 646.3019938466457, 663.7942237906252, 734.8609655034699, 12171.45228464719, 12866.485340586378, 12884.355782210887, 12908.419121139548, 13743.725125497484, 13382.0, 13630.863691363083, 13693.863061369384, 13706.794398084037, 13739.587812365646, 630.3696303696304, 755.4221020918988, 765.9693612255503, 768.2854944901239, 771.8301973565834, 745.880659094545, 762.6225018615793, 765.7740966414893, 768.4121646940096, 769.1616138409133, 801.1467786807061, 806.7378102116835, 806.9273765361116, 806.9475484093545, 808.8665370213937, 802.9638666260032, 803.5982008995502, 804.0391731880405, 804.16768644453, 805.0379796143611, 582.9883402331972, 585.9941400585982, 587.6709042935927, 587.6738410182347, 587.9647221166744, 13308.933455332759, 13366.264855432948, 13369.131006484547, 13380.531681391105, 13392.263425511594, 13382.330883455885, 13515.121517101357, 13636.0, 13691.589252322447, 14143.929280353635, 9642.373245739005, 9696.272779541563, 9780.0, 9802.803943921153, 9993.00069992995, 3338.4992251162275, 3358.7984720916825, 3365.2596428785628, 3373.2578832657023, 3411.4712219606, 53874.0, 55608.721956389956, 64518.67740661267, 65056.0, 65773.67113164451, 10037.498125093716, 10122.696319110439, 10381.823137342293, 10668.1998850085, 10736.677899663022, 18435.72346414805, 18464.907675461538, 18533.443996680122, 18597.628047438975, 18965.43103706891, 6918.5502942308585, 7035.788926332219, 7046.048783414173, 7091.078159839188, 7107.324804143598, 3793.8103094845146, 3797.1456422305314, 3812.4662547243406, 3836.55879573847, 3866.168773713609, 2901.3181902252954, 3000.819950802959, 3017.109952563999, 3038.9696103039128, 3049.9085027449214, 509.4625170445142, 510.84419252127714, 515.2683189870393, 517.6842126302952, 524.4519477146391, 465.82997206020235, 523.1263789471516, 524.0566979436998, 548.4186762032178, 551.5670198893849, 7805.14143444232, 8151.388645851584, 8317.251447369767, 8344.040435350013, 8361.665533378718, 545.4082320682026, 548.9761594625994, 558.5810642018486, 561.6742289472096, 561.9775208991676, 3761.962380376161, 3830.4445855351373, 3867.091233560111, 3880.1463677990796, 4010.939835902464, 59760.70119649374, 60292.0, 61557.38442615606, 106378.46810766052, 110582.0, 53110.46889531132, 53754.73122634362, 53985.73007134939, 72974.0, 82253.0, 51383.22925156126, 52164.0, 57619.711901441064, 71395.92906106413, 76277.61861190658, 7668.539887606538, 7898.486598371088, 7956.2043795619975, 7966.402519811153, 7994.760157195294, 47544.7622761884, 48034.0, 48226.0, 49110.508894912025, 49286.50713492819, 45800.0, 68414.65792671005, 70672.29327706656, 71218.64390678014, 71795.64102179455, 11300.660980170607, 11434.542618295174, 11467.139964502863, 11669.76660466803, 12283.078769092175, 12598.748025039631, 12658.683532911751, 13025.47898084066, 13098.607041788762, 13518.59444216675, 11720.765584688088, 12288.262704237774, 12288.938555307166, 12728.809067864175, 12852.678683032998, 11601.419929003685, 11782.587609433971, 11896.0, 11901.285922844658, 11908.583199587973, 11877.406129693309, 11910.821337680116, 11950.701232469259, 11968.222065566059, 12371.566995155126, 9756.560954756911, 10004.099631033241, 10021.699349019542, 10435.634752783617, 10444.060034596923, 8973.865392019256, 9037.909620903707, 9492.382995105296, 9882.50587470638, 9961.40231586107], "value": 6443.105777500561, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 113.0, 116.0, 116.0, 115.0, 116.0, 117.0, 114.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 122.0, 151.0, 180.0, 123.0, 151.0, 151.0, 134.0, 185.0, 124.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 166.0, 169.0, 163.0, 163.0, 166.0, 165.0, 163.0, 164.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 169.0, 77.0, 76.0, 77.0, 76.0, 163.0, 79.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 153.0, 85.0, 86.0, 85.0, 131.0, 85.0, 84.0, 140.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 119.0, 118.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 149.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 65.0, 65.0, 62.0, 65.0, 64.0, 71.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 68.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 87.0, 80.0, 92.0, 80.0, 80.0, 90.0, 86.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 131.0, 132.0, 135.0, 132.0, 151.0, 132.0, 134.0, 217.0, 142.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 169.0, 172.0, 166.0, 166.0, 168.0, 170.0, 170.0, 168.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 67.0, 66.0], "value": 68.1, "unit": "score"}]}]} 15:48:31 INFO - Return code: 0 15:48:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:48:31 ERROR - # TBPL SUCCESS # 15:48:31 INFO - Running post-action listener: _resource_record_post_action 15:48:31 INFO - [mozharness: 2016-08-08 22:48:31.871189Z] Finished run-tests step (success) 15:48:31 INFO - Running post-run listener: _resource_record_post_run 15:48:31 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 550019072; Read time: 0; Write time: 509760 15:48:31 INFO - TinderboxPrint: CPU usage
13.3% 15:48:31 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:48:31 INFO - TinderboxPrint: I/O write bytes / time
550,019,072 / 509,760 15:48:31 INFO - TinderboxPrint: CPU idle
8,284.7 (86.7%) 15:48:31 INFO - TinderboxPrint: CPU user
1,218.1 (12.7%) 15:48:31 INFO - TinderboxPrint: Swap in / out
0 / 0 15:48:31 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251219968; Read time: 0; Write time: 277596 15:48:31 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 298799104; Read time: 0; Write time: 232164 15:48:32 INFO - Running post-run listener: _upload_blobber_files 15:48:32 INFO - Blob upload gear active. 15:48:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:48:32 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:48:32 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:48:32 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:48:32 INFO - (blobuploader) - INFO - Open directory for files ... 15:48:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:48:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:48:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:33 INFO - (blobuploader) - INFO - Done attempting. 15:48:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:48:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:48:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:37 INFO - (blobuploader) - INFO - Done attempting. 15:48:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:48:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:48:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:38 INFO - (blobuploader) - INFO - Done attempting. 15:48:38 INFO - (blobuploader) - INFO - Iteration through files over. 15:48:38 INFO - Return code: 0 15:48:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:48:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:48:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b59cecfa999ce848794d79c02619cea6255e33e15d95ac1cacfe585aaeb3f3f9b8f959291a3b7db4f1d69892c54694041cd901f7c9312c3de4d806b814ebf2a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e5b1bc8130c07dd17bbda49843b8c56347cde6d8799d17b028483ede11b74e8ad520735cc737fd5bf1e94487c0629a7762c0717ffd1f410a93a0bbdb81637e1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79ae7f52786033a6d2a26166c7e89f52640a576006ab175506b083d384abb86661e43f612d64a1be12b8f035540afc15c160e30ede9625134bb46925f4c8617d"} 15:48:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:48:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:48:38 INFO - Contents: 15:48:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b59cecfa999ce848794d79c02619cea6255e33e15d95ac1cacfe585aaeb3f3f9b8f959291a3b7db4f1d69892c54694041cd901f7c9312c3de4d806b814ebf2a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e5b1bc8130c07dd17bbda49843b8c56347cde6d8799d17b028483ede11b74e8ad520735cc737fd5bf1e94487c0629a7762c0717ffd1f410a93a0bbdb81637e1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79ae7f52786033a6d2a26166c7e89f52640a576006ab175506b083d384abb86661e43f612d64a1be12b8f035540afc15c160e30ede9625134bb46925f4c8617d"} 15:48:38 INFO - Running post-run listener: copy_logs_to_upload_dir 15:48:38 INFO - Copying logs to upload dir... 15:48:38 INFO - mkdir: /builds/slave/test/build/upload/logs 15:48:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.988863 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-08 15:48:38.072054) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 15:48:38.075686) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b59cecfa999ce848794d79c02619cea6255e33e15d95ac1cacfe585aaeb3f3f9b8f959291a3b7db4f1d69892c54694041cd901f7c9312c3de4d806b814ebf2a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e5b1bc8130c07dd17bbda49843b8c56347cde6d8799d17b028483ede11b74e8ad520735cc737fd5bf1e94487c0629a7762c0717ffd1f410a93a0bbdb81637e1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79ae7f52786033a6d2a26166c7e89f52640a576006ab175506b083d384abb86661e43f612d64a1be12b8f035540afc15c160e30ede9625134bb46925f4c8617d"} build_url:https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/UVQYUJDqQi6EhaxucS6xgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b59cecfa999ce848794d79c02619cea6255e33e15d95ac1cacfe585aaeb3f3f9b8f959291a3b7db4f1d69892c54694041cd901f7c9312c3de4d806b814ebf2a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e5b1bc8130c07dd17bbda49843b8c56347cde6d8799d17b028483ede11b74e8ad520735cc737fd5bf1e94487c0629a7762c0717ffd1f410a93a0bbdb81637e1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79ae7f52786033a6d2a26166c7e89f52640a576006ab175506b083d384abb86661e43f612d64a1be12b8f035540afc15c160e30ede9625134bb46925f4c8617d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 15:48:38.101939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:48:38.102348) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1470695051.983105-426888520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:48:38.186429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 15:48:38.186748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 15:48:38.187052) ========= ========= Total master_lag: 0.18 =========