builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1472501248.04 results: success (0) buildid: 20160829113010 builduid: 0421491084ba42cc92067c52ddf37a9d revision: 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.039407) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.039994) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.040281) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.055597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.055886) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 13:07:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.0M=0s 2016-08-29 13:07:29 (31.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124007 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.194450) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.194769) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014899 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.252080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.252499) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 13:07:29,414 truncating revision to first 12 chars 2016-08-29 13:07:29,414 Setting DEBUG logging. 2016-08-29 13:07:29,414 attempt 1/10 2016-08-29 13:07:29,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2ec253835380?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 13:07:29,698 unpacking tar archive at: fx-team-2ec253835380/testing/mozharness/ program finished with exit code 0 elapsedTime=0.709218 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.977507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.977847) ========= script_repo_revision: 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.978253) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.978518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 13:07:28.987352) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-08-29 13:07:28.987754) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:07:30 INFO - MultiFileLogger online at 20160829 13:07:30 in /builds/slave/test 13:07:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:07:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:07:30 INFO - {'append_to_log': False, 13:07:30 INFO - 'base_work_dir': '/builds/slave/test', 13:07:30 INFO - 'blob_upload_branch': 'Fx-Team', 13:07:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:07:30 INFO - 'branch': 'Fx-Team', 13:07:30 INFO - 'buildbot_json_path': 'buildprops.json', 13:07:30 INFO - 'config_files': ('talos/linux_config.py',), 13:07:30 INFO - 'default_actions': ('clobber', 13:07:30 INFO - 'read-buildbot-config', 13:07:30 INFO - 'download-and-extract', 13:07:30 INFO - 'populate-webroot', 13:07:30 INFO - 'create-virtualenv', 13:07:30 INFO - 'install', 13:07:30 INFO - 'run-tests'), 13:07:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:07:30 INFO - 'download_minidump_stackwalk': True, 13:07:30 INFO - 'download_symbols': 'ondemand', 13:07:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:07:30 INFO - 'tooltool.py': '/tools/tooltool.py', 13:07:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:07:30 INFO - '/tools/misc-python/virtualenv.py')}, 13:07:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:07:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:07:30 INFO - 'installer_path': 'installer.exe', 13:07:30 INFO - 'log_level': 'info', 13:07:30 INFO - 'log_name': 'talos', 13:07:30 INFO - 'log_to_console': True, 13:07:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:07:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:07:30 INFO - 'opt_config_files': (), 13:07:30 INFO - 'pip_index': False, 13:07:30 INFO - 'sps_profile': False, 13:07:30 INFO - 'sps_profile_interval': 0, 13:07:30 INFO - 'suite': 'dromaeojs-e10s', 13:07:30 INFO - 'system_bits': '32', 13:07:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:07:30 INFO - 'title': 'talos-linux64-ix-050', 13:07:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:07:30 INFO - 'use_talos_json': True, 13:07:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:07:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:07:30 INFO - 'work_dir': 'build'} 13:07:30 INFO - [mozharness: 2016-08-29 20:07:30.231808Z] Running clobber step. 13:07:30 INFO - Running pre-action listener: _resource_record_pre_action 13:07:30 INFO - Running main action method: clobber 13:07:30 INFO - rmtree: /builds/slave/test/build 13:07:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:07:30 INFO - Running post-action listener: _resource_record_post_action 13:07:30 INFO - [mozharness: 2016-08-29 20:07:30.700568Z] Finished clobber step (success) 13:07:30 INFO - [mozharness: 2016-08-29 20:07:30.700669Z] Running read-buildbot-config step. 13:07:30 INFO - Running pre-action listener: _resource_record_pre_action 13:07:30 INFO - Running main action method: read_buildbot_config 13:07:30 INFO - Using buildbot properties: 13:07:30 INFO - { 13:07:30 INFO - "project": "", 13:07:30 INFO - "product": "firefox", 13:07:30 INFO - "script_repo_revision": "production", 13:07:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:07:30 INFO - "repository": "", 13:07:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 13:07:30 INFO - "buildid": "20160829113010", 13:07:30 INFO - "pgo_build": "True", 13:07:30 INFO - "basedir": "/builds/slave/test", 13:07:30 INFO - "buildnumber": 1088, 13:07:30 INFO - "slavename": "talos-linux64-ix-050", 13:07:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:07:30 INFO - "platform": "ubuntu64_hw", 13:07:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:07:30 INFO - "branch": "fx-team", 13:07:30 INFO - "repo_path": "integration/fx-team", 13:07:30 INFO - "revision": "2ec2538353807a17b8b23f2440c9a52ec3f3ccc5", 13:07:30 INFO - "stage_platform": "linux64-pgo", 13:07:30 INFO - "builduid": "0421491084ba42cc92067c52ddf37a9d", 13:07:30 INFO - "slavebuilddir": "test" 13:07:30 INFO - } 13:07:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 13:07:30 INFO - Running post-action listener: _resource_record_post_action 13:07:30 INFO - [mozharness: 2016-08-29 20:07:30.703497Z] Finished read-buildbot-config step (success) 13:07:30 INFO - [mozharness: 2016-08-29 20:07:30.703587Z] Running download-and-extract step. 13:07:30 INFO - Running pre-action listener: _resource_record_pre_action 13:07:30 INFO - Running main action method: download_and_extract 13:07:30 INFO - mkdir: /builds/slave/test/build/tests 13:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:30 INFO - trying https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:07:30 INFO - Downloading https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/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 13:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/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 13:07:31 INFO - Downloaded 1361 bytes. 13:07:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:07:31 INFO - Using the following test package requirements: 13:07:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:07:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:07:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:31 INFO - u'jsshell-linux-x86_64.zip'], 13:07:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:07:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:07:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:07:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:07:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:07:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:31 INFO - trying https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:07:31 INFO - Downloading https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/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 13:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/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 13:07:32 INFO - Downloaded 21875418 bytes. 13:07:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 13:07:36 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 13:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:36 INFO - trying https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:07:36 INFO - Downloading https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/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 13:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/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 13:07:37 INFO - Downloaded 21875418 bytes. 13:07:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 13:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:42 INFO - trying https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:42 INFO - Downloading https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/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 13:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/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 13:08:13 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip: The read operation timed out 13:08:13 INFO - retry: attempt #1 caught exception: The read operation timed out 13:08:13 INFO - retry: Failed, sleeping 30 seconds before retrying 13:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/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 #2 13:08:44 INFO - Downloaded 14413998 bytes. 13:08:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 13:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:45 INFO - trying https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:08:45 INFO - Downloading https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/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 13:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/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 13:08:46 INFO - Downloaded 59730140 bytes. 13:08:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:08:46 INFO - mkdir: /builds/slave/test/properties 13:08:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:08:46 INFO - Writing to file /builds/slave/test/properties/build_url 13:08:46 INFO - Contents: 13:08:46 INFO - build_url:https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:08:47 INFO - Running post-action listener: _resource_record_post_action 13:08:47 INFO - Running post-action listener: set_extra_try_arguments 13:08:47 INFO - [mozharness: 2016-08-29 20:08:47.186774Z] Finished download-and-extract step (success) 13:08:47 INFO - [mozharness: 2016-08-29 20:08:47.187006Z] Running populate-webroot step. 13:08:47 INFO - Running pre-action listener: _resource_record_pre_action 13:08:47 INFO - Running main action method: populate_webroot 13:08:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:08:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:08:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:08:47 INFO - '--tppagecycles', 13:08:47 INFO - '7'], 13:08:47 INFO - 'tests': ['tsvgm']}}, 13:08:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:08:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:08:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:08:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:08:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:08:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:08:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:47 INFO - 'talos_options': ['--disable-e10s'], 13:08:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:47 INFO - 'talos_options': ['--disable-e10s'], 13:08:47 INFO - 'tests': ['damp', 'tps']}, 13:08:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:47 INFO - 'tests': ['damp', 'tps']}, 13:08:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:08:47 INFO - 'tests': ['dromaeo_dom']}, 13:08:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:08:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:08:47 INFO - 'tests': ['basic_compositor_video']}, 13:08:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:08:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:08:47 INFO - 'tests': ['a11yr', 13:08:47 INFO - 'ts_paint', 13:08:47 INFO - 'tpaint', 13:08:47 INFO - 'sessionrestore', 13:08:47 INFO - 'sessionrestore_no_auto_restore', 13:08:47 INFO - 'tabpaint']}, 13:08:47 INFO - 'other-e10s': {'tests': ['a11yr', 13:08:47 INFO - 'ts_paint', 13:08:47 INFO - 'tpaint', 13:08:47 INFO - 'sessionrestore', 13:08:47 INFO - 'sessionrestore_no_auto_restore', 13:08:47 INFO - 'tabpaint']}, 13:08:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:08:47 INFO - 'ts_paint', 13:08:47 INFO - 'tpaint', 13:08:47 INFO - 'sessionrestore', 13:08:47 INFO - 'sessionrestore_no_auto_restore', 13:08:47 INFO - 'tabpaint']}, 13:08:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:08:47 INFO - 'ts_paint', 13:08:47 INFO - 'tpaint', 13:08:47 INFO - 'sessionrestore', 13:08:47 INFO - 'sessionrestore_no_auto_restore', 13:08:47 INFO - 'tabpaint']}, 13:08:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:08:47 INFO - 'tests': ['a11yr', 13:08:47 INFO - 'ts_paint', 13:08:47 INFO - 'tpaint', 13:08:47 INFO - 'sessionrestore', 13:08:47 INFO - 'sessionrestore_no_auto_restore', 13:08:47 INFO - 'tabpaint']}, 13:08:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:08:47 INFO - 'tests': ['a11yr', 13:08:47 INFO - 'ts_paint', 13:08:47 INFO - 'tpaint', 13:08:47 INFO - 'sessionrestore', 13:08:47 INFO - 'sessionrestore_no_auto_restore', 13:08:47 INFO - 'tabpaint']}, 13:08:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:08:47 INFO - 'tests': ['tsvgx', 13:08:47 INFO - 'tsvgr_opacity', 13:08:47 INFO - 'tart', 13:08:47 INFO - 'tscrollx', 13:08:47 INFO - 'cart']}, 13:08:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:08:47 INFO - 'tsvgr_opacity', 13:08:47 INFO - 'tart', 13:08:47 INFO - 'tscrollx', 13:08:47 INFO - 'cart']}, 13:08:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:47 INFO - 'talos_options': ['--disable-e10s'], 13:08:47 INFO - 'tests': ['tp5o']}, 13:08:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:47 INFO - 'tests': ['tp5o']}, 13:08:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:47 INFO - 'talos_options': ['--disable-e10s', 13:08:47 INFO - '--xperf_path', 13:08:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:47 INFO - 'tests': ['tp5n']}, 13:08:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:47 INFO - 'talos_options': ['--xperf_path', 13:08:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:47 INFO - 'tests': ['tp5n']}}, 13:08:47 INFO - 'talos.zip': {'path': '', 13:08:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:08:47 INFO - Running post-action listener: _resource_record_post_action 13:08:47 INFO - [mozharness: 2016-08-29 20:08:47.209610Z] Finished populate-webroot step (success) 13:08:47 INFO - [mozharness: 2016-08-29 20:08:47.209700Z] Running create-virtualenv step. 13:08:47 INFO - Running pre-action listener: _resource_record_pre_action 13:08:47 INFO - Running main action method: create_virtualenv 13:08:47 INFO - Creating virtualenv /builds/slave/test/build/venv 13:08:47 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 13:08:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:08:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:08:47 INFO - Using real prefix '/usr' 13:08:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:08:47 INFO - Installing distribute.............................................................................................................................................................................................done. 13:08:49 INFO - Installing pip.................done. 13:08:49 INFO - Return code: 0 13:08:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ccf5f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2370>, '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 0x21f58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f5d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', '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 13:08:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:08:49 INFO - Using env: {'DISPLAY': ':0', 13:08:49 INFO - 'HOME': '/home/cltbld', 13:08:49 INFO - 'LANG': 'en_US.UTF-8', 13:08:49 INFO - 'LANGUAGE': 'en_US:en', 13:08:49 INFO - 'LOGNAME': 'cltbld', 13:08:49 INFO - 'MAIL': '/var/mail/cltbld', 13:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:49 INFO - 'MOZ_NO_REMOTE': '1', 13:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:49 INFO - 'NO_EM_RESTART': '1', 13:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:49 INFO - 'PWD': '/builds/slave/test', 13:08:49 INFO - 'SHELL': '/bin/bash', 13:08:49 INFO - 'SHLVL': '1', 13:08:49 INFO - 'TERM': 'linux', 13:08:49 INFO - 'TMOUT': '86400', 13:08:49 INFO - 'USER': 'cltbld', 13:08:49 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', 13:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:49 INFO - '_': '/tools/buildbot/bin/python'} 13:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:50 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 13:08:50 INFO - Cleaning up... 13:08:50 INFO - Return code: 0 13:08:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:08: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')]} 13:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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')]} 13:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ccf5f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2370>, '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 0x21f58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f5d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', '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 13:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:08:50 INFO - Using env: {'DISPLAY': ':0', 13:08:50 INFO - 'HOME': '/home/cltbld', 13:08:50 INFO - 'LANG': 'en_US.UTF-8', 13:08:50 INFO - 'LANGUAGE': 'en_US:en', 13:08:50 INFO - 'LOGNAME': 'cltbld', 13:08:50 INFO - 'MAIL': '/var/mail/cltbld', 13:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:50 INFO - 'MOZ_NO_REMOTE': '1', 13:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:50 INFO - 'NO_EM_RESTART': '1', 13:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:50 INFO - 'PWD': '/builds/slave/test', 13:08:50 INFO - 'SHELL': '/bin/bash', 13:08:50 INFO - 'SHLVL': '1', 13:08:50 INFO - 'TERM': 'linux', 13:08:50 INFO - 'TMOUT': '86400', 13:08:50 INFO - 'USER': 'cltbld', 13:08:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', 13:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:50 INFO - '_': '/tools/buildbot/bin/python'} 13:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:50 INFO - Downloading/unpacking psutil>=3.1.1 13:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:08:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:52 INFO - Installing collected packages: psutil 13:08:52 INFO - Running setup.py install for psutil 13:08:52 INFO - building 'psutil._psutil_linux' extension 13:08:52 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 13:08:52 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 13:08:52 INFO - building 'psutil._psutil_posix' extension 13:08:52 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 13:08:52 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 13:08:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:52 INFO - Successfully installed psutil 13:08:52 INFO - Cleaning up... 13:08:52 INFO - Return code: 0 13:08:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:52 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 0x7f8ccf5f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2370>, '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 0x21f58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f5d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', '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 13:08:52 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 13:08:52 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 13:08:52 INFO - Using env: {'DISPLAY': ':0', 13:08:52 INFO - 'HOME': '/home/cltbld', 13:08:52 INFO - 'LANG': 'en_US.UTF-8', 13:08:52 INFO - 'LANGUAGE': 'en_US:en', 13:08:52 INFO - 'LOGNAME': 'cltbld', 13:08:52 INFO - 'MAIL': '/var/mail/cltbld', 13:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:52 INFO - 'MOZ_NO_REMOTE': '1', 13:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:52 INFO - 'NO_EM_RESTART': '1', 13:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:52 INFO - 'PWD': '/builds/slave/test', 13:08:52 INFO - 'SHELL': '/bin/bash', 13:08:52 INFO - 'SHLVL': '1', 13:08:52 INFO - 'TERM': 'linux', 13:08:52 INFO - 'TMOUT': '86400', 13:08:52 INFO - 'USER': 'cltbld', 13:08:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', 13:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:52 INFO - '_': '/tools/buildbot/bin/python'} 13:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:08:54 INFO - Installing collected packages: mozsystemmonitor 13:08:54 INFO - Running setup.py install for mozsystemmonitor 13:08:55 INFO - Successfully installed mozsystemmonitor 13:08:55 INFO - Cleaning up... 13:08:55 INFO - Return code: 0 13:08:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ccf5f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2370>, '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 0x21f58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f5d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', '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 13:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:08:55 INFO - Using env: {'DISPLAY': ':0', 13:08:55 INFO - 'HOME': '/home/cltbld', 13:08:55 INFO - 'LANG': 'en_US.UTF-8', 13:08:55 INFO - 'LANGUAGE': 'en_US:en', 13:08:55 INFO - 'LOGNAME': 'cltbld', 13:08:55 INFO - 'MAIL': '/var/mail/cltbld', 13:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:55 INFO - 'MOZ_NO_REMOTE': '1', 13:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:55 INFO - 'NO_EM_RESTART': '1', 13:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:55 INFO - 'PWD': '/builds/slave/test', 13:08:55 INFO - 'SHELL': '/bin/bash', 13:08:55 INFO - 'SHLVL': '1', 13:08:55 INFO - 'TERM': 'linux', 13:08:55 INFO - 'TMOUT': '86400', 13:08:55 INFO - 'USER': 'cltbld', 13:08:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', 13:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:55 INFO - '_': '/tools/buildbot/bin/python'} 13:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:55 INFO - Downloading/unpacking jsonschema==2.5.1 13:08:55 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 13:08:55 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 13:08:55 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 13:08:55 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 13:08:55 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 13:08:55 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 13:08:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:08:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:08:57 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 13:08:57 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 13:08:57 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 13:08:57 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 13:08:57 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 13:08:57 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 13:08:57 INFO - Downloading functools32-3.2.3-2.tar.gz 13:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:08:57 INFO - warning: no files found matching '*.txt' 13:08:57 INFO - no previously-included directories found matching 'build' 13:08:57 INFO - no previously-included directories found matching 'dist' 13:08:57 INFO - no previously-included directories found matching '.git*' 13:08:57 INFO - Installing collected packages: jsonschema, functools32 13:08:57 INFO - Running setup.py install for functools32 13:08:57 INFO - warning: no files found matching '*.txt' 13:08:57 INFO - no previously-included directories found matching 'build' 13:08:57 INFO - no previously-included directories found matching 'dist' 13:08:57 INFO - no previously-included directories found matching '.git*' 13:08:57 INFO - Successfully installed jsonschema functools32 13:08:57 INFO - Cleaning up... 13:08:57 INFO - Return code: 0 13:08:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:08:57 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')]} 13:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:57 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')]} 13:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:57 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 0x7f8ccf5f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2370>, '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 0x21f58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f5d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', '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 13:08:57 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 13:08:57 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 13:08:57 INFO - Using env: {'DISPLAY': ':0', 13:08:57 INFO - 'HOME': '/home/cltbld', 13:08:57 INFO - 'LANG': 'en_US.UTF-8', 13:08:57 INFO - 'LANGUAGE': 'en_US:en', 13:08:57 INFO - 'LOGNAME': 'cltbld', 13:08:57 INFO - 'MAIL': '/var/mail/cltbld', 13:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:57 INFO - 'MOZ_NO_REMOTE': '1', 13:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:57 INFO - 'NO_EM_RESTART': '1', 13:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:57 INFO - 'PWD': '/builds/slave/test', 13:08:57 INFO - 'SHELL': '/bin/bash', 13:08:57 INFO - 'SHLVL': '1', 13:08:57 INFO - 'TERM': 'linux', 13:08:57 INFO - 'TMOUT': '86400', 13:08:57 INFO - 'USER': 'cltbld', 13:08:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', 13:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:57 INFO - '_': '/tools/buildbot/bin/python'} 13:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:08:57 INFO - Cleaning up... 13:08:57 INFO - Return code: 0 13:08:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:08:57 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')]} 13:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:57 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')]} 13:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:57 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 0x7f8ccf5f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2370>, '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 0x21f58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f5d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', '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 13:08:57 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 13:08:57 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 13:08:57 INFO - Using env: {'DISPLAY': ':0', 13:08:57 INFO - 'HOME': '/home/cltbld', 13:08:57 INFO - 'LANG': 'en_US.UTF-8', 13:08:57 INFO - 'LANGUAGE': 'en_US:en', 13:08:57 INFO - 'LOGNAME': 'cltbld', 13:08:57 INFO - 'MAIL': '/var/mail/cltbld', 13:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:57 INFO - 'MOZ_NO_REMOTE': '1', 13:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:57 INFO - 'NO_EM_RESTART': '1', 13:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:57 INFO - 'PWD': '/builds/slave/test', 13:08:57 INFO - 'SHELL': '/bin/bash', 13:08:57 INFO - 'SHLVL': '1', 13:08:57 INFO - 'TERM': 'linux', 13:08:57 INFO - 'TMOUT': '86400', 13:08:57 INFO - 'USER': 'cltbld', 13:08:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', 13:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:57 INFO - '_': '/tools/buildbot/bin/python'} 13:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:58 INFO - Downloading/unpacking blobuploader==1.2.4 13:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:59 INFO - Downloading blobuploader-1.2.4.tar.gz 13:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:09:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:09:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 INFO - Downloading docopt-0.6.1.tar.gz 13:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:09:00 INFO - Installing collected packages: blobuploader, requests, docopt 13:09:00 INFO - Running setup.py install for blobuploader 13:09:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:09:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:09:00 INFO - Running setup.py install for requests 13:09:01 INFO - Running setup.py install for docopt 13:09:01 INFO - Successfully installed blobuploader requests docopt 13:09:01 INFO - Cleaning up... 13:09:01 INFO - Return code: 0 13:09:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:01 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 0x7f8ccf5f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2370>, '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 0x21f58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f5d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', '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 13:09:01 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 13:09:01 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 13:09:01 INFO - Using env: {'DISPLAY': ':0', 13:09:01 INFO - 'HOME': '/home/cltbld', 13:09:01 INFO - 'LANG': 'en_US.UTF-8', 13:09:01 INFO - 'LANGUAGE': 'en_US:en', 13:09:01 INFO - 'LOGNAME': 'cltbld', 13:09:01 INFO - 'MAIL': '/var/mail/cltbld', 13:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:01 INFO - 'MOZ_NO_REMOTE': '1', 13:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:01 INFO - 'NO_EM_RESTART': '1', 13:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:01 INFO - 'PWD': '/builds/slave/test', 13:09:01 INFO - 'SHELL': '/bin/bash', 13:09:01 INFO - 'SHLVL': '1', 13:09:01 INFO - 'TERM': 'linux', 13:09:01 INFO - 'TMOUT': '86400', 13:09:01 INFO - 'USER': 'cltbld', 13:09:01 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', 13:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:01 INFO - '_': '/tools/buildbot/bin/python'} 13:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:01 INFO - Running setup.py (path:/tmp/pip-Wet2Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:01 INFO - Running setup.py (path:/tmp/pip-qw5RVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:01 INFO - Running setup.py (path:/tmp/pip-KppL8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:01 INFO - Running setup.py (path:/tmp/pip-BewoL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:01 INFO - Running setup.py (path:/tmp/pip-Iy8tge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:01 INFO - Running setup.py (path:/tmp/pip-lGQd3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:01 INFO - Running setup.py (path:/tmp/pip-P5AcuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:02 INFO - Running setup.py (path:/tmp/pip-RN_xSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:02 INFO - Running setup.py (path:/tmp/pip-2_CPIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:02 INFO - Running setup.py (path:/tmp/pip-KvtbBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:02 INFO - Running setup.py (path:/tmp/pip-qbjanu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:02 INFO - Running setup.py (path:/tmp/pip-3DbSGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:02 INFO - Running setup.py (path:/tmp/pip-VHhlm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:02 INFO - Running setup.py (path:/tmp/pip-tzHzLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:02 INFO - Running setup.py (path:/tmp/pip-pgo2FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:02 INFO - Running setup.py (path:/tmp/pip-Xmm6uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:02 INFO - Running setup.py (path:/tmp/pip-QNKm6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:09:02 INFO - Running setup.py install for manifestparser 13:09:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:09:02 INFO - Running setup.py install for mozcrash 13:09:02 INFO - Running setup.py install for mozdebug 13:09:03 INFO - Running setup.py install for mozdevice 13:09:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:09:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:09:03 INFO - Running setup.py install for mozfile 13:09:03 INFO - Running setup.py install for mozhttpd 13:09:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:09:03 INFO - Running setup.py install for mozinfo 13:09:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:09:03 INFO - Running setup.py install for mozInstall 13:09:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:09:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:09:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:09:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:09:03 INFO - Running setup.py install for mozleak 13:09:03 INFO - Running setup.py install for mozlog 13:09:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:09:03 INFO - Running setup.py install for moznetwork 13:09:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:09:03 INFO - Running setup.py install for mozprocess 13:09:03 INFO - Running setup.py install for mozprofile 13:09:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:09:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:09:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:09:04 INFO - Running setup.py install for mozrunner 13:09:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:09:04 INFO - Running setup.py install for mozscreenshot 13:09:04 INFO - Running setup.py install for moztest 13:09:04 INFO - Running setup.py install for mozversion 13:09:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:09:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:09:04 INFO - Cleaning up... 13:09:04 INFO - Return code: 0 13:09:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:04 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 0x7f8ccf5f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2370>, '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 0x21f58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f5d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', '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 13:09:04 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 13:09:04 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 13:09:04 INFO - Using env: {'DISPLAY': ':0', 13:09:04 INFO - 'HOME': '/home/cltbld', 13:09:04 INFO - 'LANG': 'en_US.UTF-8', 13:09:04 INFO - 'LANGUAGE': 'en_US:en', 13:09:04 INFO - 'LOGNAME': 'cltbld', 13:09:04 INFO - 'MAIL': '/var/mail/cltbld', 13:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:04 INFO - 'MOZ_NO_REMOTE': '1', 13:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:04 INFO - 'NO_EM_RESTART': '1', 13:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:04 INFO - 'PWD': '/builds/slave/test', 13:09:04 INFO - 'SHELL': '/bin/bash', 13:09:04 INFO - 'SHLVL': '1', 13:09:04 INFO - 'TERM': 'linux', 13:09:04 INFO - 'TMOUT': '86400', 13:09:04 INFO - 'USER': 'cltbld', 13:09:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', 13:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:04 INFO - '_': '/tools/buildbot/bin/python'} 13:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:04 INFO - Running setup.py (path:/tmp/pip-I8R2kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:04 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)) 13:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:04 INFO - Running setup.py (path:/tmp/pip-ftyTik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:04 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)) 13:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:04 INFO - Running setup.py (path:/tmp/pip-9KxvQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:04 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)) 13:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:04 INFO - Running setup.py (path:/tmp/pip-WykdAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:05 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)) 13:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:05 INFO - Running setup.py (path:/tmp/pip-fCzuYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:05 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)) 13:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:05 INFO - Running setup.py (path:/tmp/pip-KriHPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:05 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)) 13:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:05 INFO - Running setup.py (path:/tmp/pip-1nf8Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:05 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)) 13:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:05 INFO - Running setup.py (path:/tmp/pip-cSuNlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:05 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)) 13:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:05 INFO - Running setup.py (path:/tmp/pip-NMsurx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:05 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)) 13:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:05 INFO - Running setup.py (path:/tmp/pip-CaMzyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:05 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)) 13:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:05 INFO - Running setup.py (path:/tmp/pip-RzBQ_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:05 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)) 13:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:05 INFO - Running setup.py (path:/tmp/pip-uUVPT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:05 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)) 13:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:05 INFO - Running setup.py (path:/tmp/pip-lsf4Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:05 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)) 13:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:05 INFO - Running setup.py (path:/tmp/pip-yyVX7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:05 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)) 13:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:05 INFO - Running setup.py (path:/tmp/pip-IBoC3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:05 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)) 13:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:05 INFO - Running setup.py (path:/tmp/pip-ahnMaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:05 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)) 13:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:05 INFO - Running setup.py (path:/tmp/pip-Z9cO1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:06 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)) 13:09:06 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)) 13:09:06 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)) 13:09:06 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)) 13:09:06 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)) 13:09:06 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)) 13:09:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:07 INFO - Downloading blessings-1.6.tar.gz 13:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:09:07 INFO - Installing collected packages: blessings 13:09:07 INFO - Running setup.py install for blessings 13:09:08 INFO - Successfully installed blessings 13:09:08 INFO - Cleaning up... 13:09:08 INFO - Return code: 0 13:09:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:09:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:08 INFO - Reading from file tmpfile_stdout 13:09:08 INFO - Current package versions: 13:09:08 INFO - argparse == 1.2.1 13:09:08 INFO - blessings == 1.6 13:09:08 INFO - blobuploader == 1.2.4 13:09:08 INFO - docopt == 0.6.1 13:09:08 INFO - functools32 == 3.2.3-2 13:09:08 INFO - jsonschema == 2.5.1 13:09:08 INFO - manifestparser == 1.1 13:09:08 INFO - mozInstall == 1.12 13:09:08 INFO - mozcrash == 0.17 13:09:08 INFO - mozdebug == 0.1 13:09:08 INFO - mozdevice == 0.48 13:09:08 INFO - mozfile == 1.2 13:09:08 INFO - mozhttpd == 0.7 13:09:08 INFO - mozinfo == 0.9 13:09:08 INFO - mozleak == 0.1 13:09:08 INFO - mozlog == 3.3 13:09:08 INFO - moznetwork == 0.27 13:09:08 INFO - mozprocess == 0.23 13:09:08 INFO - mozprofile == 0.28 13:09:08 INFO - mozrunner == 6.12 13:09:08 INFO - mozscreenshot == 0.1 13:09:08 INFO - mozsystemmonitor == 0.3 13:09:08 INFO - moztest == 0.7 13:09:08 INFO - mozversion == 1.4 13:09:08 INFO - psutil == 3.1.1 13:09:08 INFO - requests == 1.2.3 13:09:08 INFO - wsgiref == 0.1.2 13:09:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:08 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 0x7f8ccf5f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2370>, '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 0x21f58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f5d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', '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 13:09:08 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 13:09:08 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 13:09:08 INFO - Using env: {'DISPLAY': ':0', 13:09:08 INFO - 'HOME': '/home/cltbld', 13:09:08 INFO - 'LANG': 'en_US.UTF-8', 13:09:08 INFO - 'LANGUAGE': 'en_US:en', 13:09:08 INFO - 'LOGNAME': 'cltbld', 13:09:08 INFO - 'MAIL': '/var/mail/cltbld', 13:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:08 INFO - 'MOZ_NO_REMOTE': '1', 13:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:08 INFO - 'NO_EM_RESTART': '1', 13:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:08 INFO - 'PWD': '/builds/slave/test', 13:09:08 INFO - 'SHELL': '/bin/bash', 13:09:08 INFO - 'SHLVL': '1', 13:09:08 INFO - 'TERM': 'linux', 13:09:08 INFO - 'TMOUT': '86400', 13:09:08 INFO - 'USER': 'cltbld', 13:09:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', 13:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:08 INFO - '_': '/tools/buildbot/bin/python'} 13:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:08 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)) 13:09:08 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)) 13:09:08 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)) 13:09:08 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)) 13:09:08 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)) 13:09:08 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)) 13:09:08 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)) 13:09:08 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)) 13:09:08 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)) 13:09:08 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)) 13:09:08 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)) 13:09:08 INFO - Cleaning up... 13:09:08 INFO - Return code: 0 13:09:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:08 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 0x7f8ccf5f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2370>, '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 0x21f58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f5d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', '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 13:09:08 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 13:09:08 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 13:09:08 INFO - Using env: {'DISPLAY': ':0', 13:09:08 INFO - 'HOME': '/home/cltbld', 13:09:08 INFO - 'LANG': 'en_US.UTF-8', 13:09:08 INFO - 'LANGUAGE': 'en_US:en', 13:09:08 INFO - 'LOGNAME': 'cltbld', 13:09:08 INFO - 'MAIL': '/var/mail/cltbld', 13:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:08 INFO - 'MOZ_NO_REMOTE': '1', 13:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:08 INFO - 'NO_EM_RESTART': '1', 13:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:08 INFO - 'PWD': '/builds/slave/test', 13:09:08 INFO - 'SHELL': '/bin/bash', 13:09:08 INFO - 'SHLVL': '1', 13:09:08 INFO - 'TERM': 'linux', 13:09:08 INFO - 'TMOUT': '86400', 13:09:08 INFO - 'USER': 'cltbld', 13:09:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', 13:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:08 INFO - '_': '/tools/buildbot/bin/python'} 13:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:09:08 INFO - Cleaning up... 13:09:08 INFO - Return code: 0 13:09:08 INFO - Running post-action listener: _resource_record_post_action 13:09:08 INFO - Running post-action listener: _start_resource_monitoring 13:09:08 INFO - Starting resource monitoring. 13:09:08 INFO - [mozharness: 2016-08-29 20:09:08.819641Z] Finished create-virtualenv step (success) 13:09:08 INFO - [mozharness: 2016-08-29 20:09:08.820138Z] Running install step. 13:09:08 INFO - Running pre-action listener: _resource_record_pre_action 13:09:08 INFO - Running main action method: install 13:09:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:09 INFO - Reading from file tmpfile_stdout 13:09:09 INFO - Detecting whether we're running mozinstall >=1.0... 13:09:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:09:09 INFO - Reading from file tmpfile_stdout 13:09:09 INFO - Output received: 13:09:09 INFO - Usage: mozinstall [options] installer 13:09:09 INFO - Options: 13:09:09 INFO - -h, --help show this help message and exit 13:09:09 INFO - -d DEST, --destination=DEST 13:09:09 INFO - Directory to install application into. [default: 13:09:09 INFO - "/builds/slave/test"] 13:09:09 INFO - --app=APP Application being installed. [default: firefox] 13:09:09 INFO - mkdir: /builds/slave/test/build/application 13:09:09 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'] 13:09:09 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 13:09:26 INFO - Reading from file tmpfile_stdout 13:09:26 INFO - Output received: 13:09:26 INFO - /builds/slave/test/build/application/firefox/firefox 13:09:26 INFO - Running post-action listener: _resource_record_post_action 13:09:26 INFO - [mozharness: 2016-08-29 20:09:26.124478Z] Finished install step (success) 13:09:26 INFO - [mozharness: 2016-08-29 20:09:26.124824Z] Running run-tests step. 13:09:26 INFO - Running pre-action listener: _resource_record_pre_action 13:09:26 INFO - Running main action method: run_tests 13:09:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:09:26 INFO - Python 2.7.3 13:09:26 INFO - Return code: 0 13:09:26 INFO - grabbing minidump binary from tooltool 13:09: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')]} 13:09:26 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 0x21f2370>, '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 0x21f58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f5d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:09:26 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 13:09:26 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 13:09:26 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 13:09:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:09:26 INFO - Return code: 0 13:09:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:09:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:09:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:09:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:09:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:09:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:09:26 INFO - Using env: {'DISPLAY': ':0', 13:09:26 INFO - 'HOME': '/home/cltbld', 13:09:26 INFO - 'LANG': 'en_US.UTF-8', 13:09:26 INFO - 'LANGUAGE': 'en_US:en', 13:09:26 INFO - 'LOGNAME': 'cltbld', 13:09:26 INFO - 'MAIL': '/var/mail/cltbld', 13:09:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:09:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:26 INFO - 'MOZ_NO_REMOTE': '1', 13:09:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:26 INFO - 'NO_EM_RESTART': '1', 13:09:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:26 INFO - 'PWD': '/builds/slave/test', 13:09:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:09:26 INFO - 'SHELL': '/bin/bash', 13:09:26 INFO - 'SHLVL': '1', 13:09:26 INFO - 'TERM': 'linux', 13:09:26 INFO - 'TMOUT': '86400', 13:09:26 INFO - 'USER': 'cltbld', 13:09:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608', 13:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:26 INFO - '_': '/tools/buildbot/bin/python'} 13:09:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:09:26 INFO - mozversion application_buildid: 20160829113010 13:09:26 INFO - mozversion application_changeset: 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 13:09:26 INFO - mozversion application_display_name: Nightly 13:09:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:09:26 INFO - mozversion application_name: Firefox 13:09:26 INFO - mozversion application_remotingname: firefox 13:09:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:09:26 INFO - mozversion application_vendor: Mozilla 13:09:26 INFO - mozversion application_version: 51.0a1 13:09:26 INFO - mozversion platform_buildid: 20160829113010 13:09:26 INFO - mozversion platform_changeset: 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 13:09:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:09:26 INFO - mozversion platform_version: 51.0a1 13:09:26 INFO - using testdate: 1472501366 13:09:26 INFO - actual date: 1472501366 13:09:26 INFO - starting webserver on 'localhost:45049' 13:09:26 INFO - SUITE-START | Running 2 tests 13:09:26 INFO - TEST-START | dromaeo_css 13:09:26 INFO - operating with platform_type : linux_ 13:09:26 INFO - Initialising browser for dromaeo_css test... 13:09:26 INFO - TEST-INFO | started process 11503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu6n2eZ/profile http://localhost:45049/getInfo.html) 13:09:30 INFO - PROCESS | 11503 | __metrics Screen width/height:1600/1200 13:09:30 INFO - PROCESS | 11503 | colorDepth:24 13:09:30 INFO - PROCESS | 11503 | Browser inner width/height: 1024/697 13:09:30 INFO - PROCESS | 11503 | __metrics 13:09:31 ERROR - PROCESS | 11503 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 13:09:32 INFO - TEST-INFO | 11503: exit 0 13:09:32 INFO - Browser initialized. 13:09:32 INFO - Running cycle 1/1 for dromaeo_css test... 13:09:32 INFO - TEST-INFO | started process 11625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu6n2eZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:44 INFO - PROCESS | 11625 | RSS: Main: 191180800 13:09:44 INFO - PROCESS | 11625 | 13:10:34 INFO - PROCESS | 11625 | 1472501434030 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] 13:12:44 INFO - PROCESS | 11625 | Cycle 1(1): loaded http://localhost:45049/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45049/tests/dromaeo/cssquery-ext.html) 13:12:45 INFO - PROCESS | 11625 | RSS: Main: 206671872 13:12:45 INFO - PROCESS | 11625 | 13:15:47 INFO - PROCESS | 11625 | Cycle 1(1): loaded http://localhost:45049/tests/dromaeo/cssquery-ext.html (next: http://localhost:45049/tests/dromaeo/cssquery-jquery.html) 13:15:47 INFO - PROCESS | 11625 | RSS: Main: 201420800 13:15:47 INFO - PROCESS | 11625 | 13:18:49 INFO - PROCESS | 11625 | Cycle 1(1): loaded http://localhost:45049/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45049/tests/dromaeo/cssquery-mootools.html) 13:18:50 INFO - PROCESS | 11625 | RSS: Main: 199557120 13:18:50 INFO - PROCESS | 11625 | 13:21:52 INFO - PROCESS | 11625 | Cycle 1(1): loaded http://localhost:45049/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45049/tests/dromaeo/cssquery-prototype.html) 13:21:53 INFO - PROCESS | 11625 | RSS: Main: 193462272 13:21:53 INFO - PROCESS | 11625 | 13:24:55 INFO - PROCESS | 11625 | Cycle 1(1): loaded http://localhost:45049/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45049/tests/dromaeo/cssquery-yui.html) 13:24:56 INFO - PROCESS | 11625 | RSS: Main: 197079040 13:24:56 INFO - PROCESS | 11625 | 13:27:59 INFO - PROCESS | 11625 | Cycle 1(1): loaded http://localhost:45049/tests/dromaeo/cssquery-yui.html (next: http://localhost:45049/tests/dromaeo/cssquery-dojo.html) 13:27:59 INFO - PROCESS | 11625 | RSS: Main: 197877760 13:27:59 INFO - PROCESS | 11625 | 13:27:59 INFO - PROCESS | 11625 | __start_tp_report 13:27:59 INFO - PROCESS | 11625 | _x_x_mozilla_page_load 13:27:59 INFO - PROCESS | 11625 | _x_x_mozilla_page_load_details 13:27:59 INFO - PROCESS | 11625 | |i|pagename|runs| 13:27:59 INFO - PROCESS | 11625 | |0;dojo.html;3105.0219180958;3112.050824498527;3125.687431256874;3128.1710346758114;3139.3407384449265;5381.973090134548;5399.37907140678;5438.401775804658;5487.862803429911;5500.559955203584;5473.753681084351;5483.095289277275;5496.945030549693;5531.474509921561;5555.194496797962;4913.533214344649;4989.550940415362;5018.924716129261;5066.2907192992825;5164.483551644843;5096.439391666913;5109.795608175668;5118.974405127988;5173.9482605174035;5175.430702622709;4923.655344125913;4936.111499930011;4983.825566105205;5004.024215278022;5008.173651347523;4965.3048573199785;4982.5017498250245;4991.101601711691;5012.824551140692;5043.848684539433;4904.681195722266;4960.479149689267;4972.776225069844;4982.900341993176;5003.974185292006;5365.141577347645;5396.811111611114;5463.644863083887;5494.423085576037;5501.284832971728;5846.532277417797;5851.034579294412;5854.238948936653;5858.47273745365;5888.175655408247;5891.175235467038;5902.291724992985;5914.763409463616;5915.1718759373725;5915.881682366328;5410.567154627621;5417.079096553634;5457.126859702428;5464.043792336365;5469.0155771960635;5977.910331345033;6001.759929602855;6001.879962400728;6009.939900601025;6056.06131049688;5712.714364281853;5720.914186287209;5725.885482290331;5726.284214473191;5741.024025915604;5674.375818659944;5757;5784.1034639630925;5815.563832712563;5844.240248767633;5640.379558248589;5742.684152371659;5803.709814509258;5833.300003999547;5839.036558967808;5797.159411885337;5864.970675146682;5865.560082993792;5869.178315035899;5895.94104058954;4474.6420286377015;4487.102579484116;4494.797734101973;4542.250528662799;4571.588557029883;4012.53855806586;4035.394690796404;4055.5538890721996;4065.735727177724;4076.0217547788316;5593.496585307342;5622.887542249214;5628.352739434936;5642.520385767174;5649.209110724501;5801.12983052537;5864.794732184353;5927.9407205928255;5930.970345148246;5973.104034394789;5616.9608622404985;5665.631733937281;5670.518005969457;5693.117566777156;5712.828615141552;5127.538521533005;5128.102582048126;5132.897342053138;5153.407358153785;5203.14148165556;6029.035354343372;6046.395360463918;6118.204633397719;6127.234095738033;6129.988551888978;5897.262842144732;5926.051831706906;5936.881262374642;6005.729742161526;6015.0676645120075;6058.545609079249;6093.482054025458;6108.847278818065;6110.388961104032;6125.387461253839;5649.180868773922;5729.598928074995;5752.309722833287;5780.335261444988;5810.738516766671;5874.030784920611;5905.4685078343155;5950.434708702666;5953.839001394686;5974.2233509643465;5739.311282646109;5753.3958934311295;5756.827295181151;5773.451522105393;5774.884502310014;5579.553635709215;5698.914516282176;5740.512056475246;5744.971275143597;5758.740856661377;5671.688057156731;5696.088625819849;5714.79998200061;5718.1136923776885;5764.913526297193;5716.456936591017;5821;5821.970890145522;5828.854278642898;5861.824145275648;5572.331320241597;5587.3015873015875;5607.775688972395;5677.716114194356;5711.371749107678 13:27:59 INFO - PROCESS | 11625 | |1;ext.html;548.9150422949614;583.7110630238033;584.2667452347306;588.8410129265097;636.8216899268201;37596.81201593992;41459;41473.792631036806;41494.377584336224;41633;41977.37033944485;42475.36286955698;43014.13971720564;43103.78448107763;43355.56644433563;8685.435446695961;8843.204111629952;8847.159519845636;8856.468611883276;8879.245264152554;8643.870341944876;8778.648854045863;8804.8679269811;8818.691345802898;8825.911740882606;8781.824363512726;8809.867851982226;8852.026277109513;8856.51289179095;8867.778305542348;8715.084916083782;8745.912540874573;8792.252658524001;8844.55777211137;8851.601677924476;8694.652213911437;8761.824763504757;8791.78020549485;8794.12058794122;8794.12058794122;39523.20953580941;40087.39868901969;40155.19689606191;40204.59795402038;40222.396664050066;3308.983455082733;3453.792772433662;3515.736319776027;3583.946240806364;3841.4621952926614;31798.841005795053;32186.839065804754;32243.355132897446;33730.662693373;33773.15567110817;4273.380359847804;4342.5874541918465;4431.26884064129;4457.777111144463;4461.308497182942;231743;233024;233806;234440;235580.82209589015;54665.1800222997;55161;55311;55726.72136639291;55814.441855580924;36359;37147;37370.81314593464;58735.65057397656;58957.705211473665;17295.45443184144;17509.12454377276;17570.38503652366;17705.645887082443;17717.114144292733;13517.864821351857;13607.795883061763;13614.18314901109;13627.931860340635;13629.931850340685;18618.16218270181;18622.716775141795;18704.812951870306;18910.716339254923;19099.90450047741;7067.540609860343;7227.566346019255;7444.947571495769;7448.329650331496;7530.6611202496015;903.8011637439753;1000.1648623399398;1085.3542142425244;1097.3361116524547;1105.0165352835982;32534.186645334055;32578.511322330185;32597.18507037343;33018.66981330204;33196.50205246875;1092.7814437112609;1094.8029354716227;1098.873629532614;1116.7822274656526;1122.910167186623;16477.670446591;17045.659086818196;17106.230219640147;17115.914420427816;17159.828401715822;527257;531569;532990;535074;536095;57296.42703572911;57815.42184578184;57905.420945790844;58087.41912580904;58513.41486585165;1317.960461186166;1366.357811828439;1367.3505085084705;1370.095736813698;1376.064276292131;29425.85287073551;31358.453024311802;31818.204544886565;32266.193345166557;32474.188145296557;50134.49865501298;50716;50790.492095078574;50923.745381272856;50949.981000380525;354438;355779;356743;357338;357489;28737.42525149527;29166.125016249545;29238.269043273238;29238.561421579117;29330.560041598965;47269.76365118152;47628.7618561905;47674.28488572744;47732.284015740486;48396.5160348392;39805.40291895682;40153.39769903512;40829.688866674995;41028.384574232005;41819.7909010453;40117.77291223093;40353.79823100866;41285;41802.581974181085;41936.64219597839;41387;42737.786311068245;43545;44056.559434406525;44230.55769442264;31829.20426989251;35857;37295.87655653512;37591.43612845864;37865.432018520296;28348;28397;28402.147935561967;28631.570526442538;28761.56857647179 13:27:59 INFO - PROCESS | 11625 | |2;jquery.html;396.5103097674373;399.4068807820388;408.7118581400113;413.39437723734727;425.09454861145775;17918.46244612662;18813.529661758464;19141.904290478527;19537.99999999998;19646.312379066734;18767.343142989997;19117.139728712205;19296.9035154824;19440.805591944078;19562.804371956277;5639.577031722617;5685.317761868561;5762.654240745548;5793.71031448428;5846.678432686201;5680.914786278188;5730.484256416921;5762.164486149506;5769.942300577003;5771.769129234825;5527.226188333637;5625.099984002561;5656.321241451011;5693.487586117249;5720.8855822883515;5590.357108932484;5637.802676906309;5641.379448260688;5665.3201615806165;5676.148577713335;4985.576226020793;5134.486551344873;5136.922946155811;5149.433562308143;5155.329807125087;22357.552848943094;22438.88780556087;22654.66018009731;22812.543749124925;22865.428364291027;2014.2547257514666;2143.185589475989;2200.4938864061196;2408.0247499762622;2426.9514609707885;9980.650677226335;10430.217733670004;10442.530086146066;10470.267081304235;10514.631987880464;1941.4855063408208;1948.2888745607893;1973.792751761073;1987.7415935928236;2006.588649326899;82281.58859205665;84689.57655211746;85413.54435185797;85667;86174;10857.45712714361;11308.71728206785;11488;11635.476403561861;11790.115741319436;15894.60263493422;15919.442819501262;15954.920225399032;16006.839931600534;16008.759868601981;7943.364530837519;8242.752717418487;8322.750317490485;8344;8461.492310461392;7806.297433230923;7857.371410287277;7935.387059758138;8090.757277281691;8149.348052155813;4725.834595789131;4764.595009424169;4816.373871396766;4899.6570240083565;4971.801127954841;1988.4034789563073;2047.9897600511902;2056.979430205709;2084.48930012148;2093.884836334016;890.8084761776249;935.8081593273363;988.6786794291884;1015.28422462164;1070.4112737994071;18621.627567448846;19254.903725481283;19293.903530482257;19328.033598320028;19525;979.740368802268;983.8327484327539;993.4833886379187;1034.622362837574;1036.9222308326905;10235.232357573062;10700.197485188643;10828.675139745821;10942.23404361687;10949.124070074375;426953;452104;472670;476488;477526;84697;84942.57528712317;87741;90054.54972725094;90593.54703226441;948.2177203806887;966.917811985989;1016.4815943868532;1025.1183981775666;1031.0359813574332;15897.443589474313;16685.66628667444;17291.82708172902;17617.82382176213;17634.1182940855;38562.80718596389;41953.580464194965;43157.56842431661;43368.34947475727;43418.921351011515;56587;60114.39885601088;61117.69441152766;61452;63228.68385658226;8491.15088491146;8534.317254619491;8714.782130446789;8904.86642700373;9153.359264851662;13015.284159371326;13021;13122.671933201746;13368.264745439094;13479.32603369808;11491.48288327044;11706.122040847142;11796.410179491162;11842.526298947945;11905.226160299553;10645.201609879136;11116.49975751077;11273.436328183394;11562.76874462523;11850.111241656738;11667.941660291644;11670.94164529172;11793.056555475712;11795.646130616095;12135.725748796249;7458.73894413693;8604.354673399395;8696.43473174267;8757.080506546721;9014.143656352637;11420.600278990196;11590.362530060927;11716.824247636463;12050.216735912138;12052.216605920587 13:27:59 INFO - PROCESS | 11625 | |3;mootools.html;1490.9552713418598;1530.1431198528824;1674.238221609168;1763.6560870630217;1801.9008954507506;7901.683932642687;8641.351898607598;8751.34364922631;9428;9429.81140377192;8565.528895910738;8713.520756358397;8926.062763409846;8936.776580585489;8941;2378.5361854438434;2432.282476669378;2436.0864675746593;2437.500312435955;2441.5483135619966;2374.8931298091543;2387.498625288683;2437.475942672325;2439.3779586205583;2448.167623008177;2391.306521108885;2405.627127795186;2427.2960841355984;2459.606462965926;2463.9753602463925;2347.342744031657;2373.311739595515;2377.524495100978;2386.451116243265;2393.0667039854297;2338.9064437422485;2343.484433424644;2368.834181607288;2374.584447721659;2376.9762302376926;9038;9154;9188.540572971324;9254.907450925539;9263.583138758771;5471.972640136773;5567.8886422271735;5580.107182850765;5605.215269862222;5610.859728506779;3474;3510.929781404383;3573.76770509916;3615.1865830188262;3645.8177091145335;1240.466599362283;1284.775164346245;1325.9469621215237;1328.4951718346965;1359.8096266522596;12594.244345339217;12930.870691293061;12941.805872911913;12946.935265323613;12948.611541653765;4727.669063165614;4794.7362895040405;4825.686330388514;4832.492588278251;5002.299678045077;10831.241813073168;10832.512536935857;10847.566097356175;10853.674389768319;10871.402072886067;5431.321084864392;5451.127819548932;5470.671759694431;5480.945190548123;5498.972505137449;4349.325854492558;4943.8516844494725;4992.8751781205765;5027.949720502821;5097.08252514551;4131.193439335211;4161.83352665896;4198.6011328923705;4201.642860356843;4203.495580530356;1293.1056002955715;1299.7197760206188;1308.653206900172;1313.2251971336957;1316.8419789625307;873.4671850171391;954.1508057828538;972.7130496503407;977.2621670638622;994.8408254679216;6179.258488981351;6237.625742455467;6413.711382987777;6439.195100612424;6552.803415897531;456.8081405809568;464.45890537523405;468.24144885285375;469.38744937856427;470.1302590208156;4142.4378907433675;4170.395292682605;4177.937330940038;4343.153085148366;4364.367166760802;10501.527431265611;10983.890161098287;11026.503807328689;11029.669109926715;11035;10699.25105242641;10731.409772462433;10799;10812.621558245424;10828.78342433147;8075.313598344089;8120.553369564731;8292.12932642076;8293.087760346358;8447.32421406286;6382;6579.17760279965;6609.438197753245;6656.201255849329;6657.901446261506;10362.637307694195;10412.323198992344;10452.529636166542;10712.35725856451;10741.194410419093;10378.169746420117;10530.631427899987;10589.523471443958;10639.255252132276;10660.147188224768;7918.683252669829;8117.391195660231;8144.5520496373265;8189.262966333059;8364.372672049742;9056.592453339746;9086;9147.268218542633;9163.129502697233;9229.538523073954;7998;8066.23370779775;8089.838203235785;8142.7557173284895;8157.06193787722;7744.49660772048;7969.800754981172;8035.316998055231;8067.475614085066;8355.164483551596;7046.929530704628;7048;7065.293470652894;7167.3907717842485;7255;5278.445763194963;5385.111456609772;5424.186372044225;5479.53423958968;5510.8071217507195;5418.349798024262;5514.779408823602;5563.332400112013;5573.219749235192;5719.799807006735 13:27:59 INFO - PROCESS | 11625 | |4;prototype.html;328.68437416718484;343.3236524047626;346.1467482655255;349.6905238863605;352.4748125293311;5339.6262261641605;5357.517823395893;5488.972555137224;5595.461248156759;5613.719314034297;5383.730813459321;5450.928647114091;5463.890722185554;5466.562674986001;5479.342478902528;4302.784860756965;4326.58897404746;4340.826366945318;4358.498772641139;4365.890852728676;4097.692673049518;4251.659867210631;4309.095090031097;4366.5633436656235;4394.7143435676735;4239.851605193819;4246.2569050416205;4253.191893540233;4256.1487702459635;4263.403123562688;4254.468191476066;4257.787110644455;4260.744355338658;4264.55222201669;4279.1227798301425;3647.6170002149656;3717.7955212463303;3724.553053633554;3724.7392682512236;3726.850925962958;5348.491893270172;5354.215807779971;5370.650907690988;5373.462653734634;5377.274068000848;4771.188897887368;4806.807727690888;4808.711477311373;4840.540148685905;4850.417949846006;5459.270810128493;5625.971870140623;5667.838093190886;5691.260136182311;5699.458551437607;4050.7037747920676;4052.4326594276827;4056.391541268804;4060.3909413587903;4067.718668619405;5822.82531524055;5955.196048533436;5969.641821490724;5973.522118230531;5989.191459153046;4165.187788381237;4183.748975061506;4183.958160418357;4187.874363769091;4192.496900371914;4233.280342341809;4239.321708526621;4250.086231460251;4257.23369793434;4264.33902745075;4833;4842.627112714745;4852.539008794159;4858;4920.532549407801;5411.56707463402;5561.859818737149;5669.2346533218315;5738.626989245686;5829.154772557956;1443.826740791112;1462.8610282023192;1474.9852501474847;1477.2909003678294;1479.5709244319241;887.8845750052581;915.455304094063;940.1350757303161;941.5292353823088;947.3557980573277;4834.20235661119;4851.175300198975;4856.854294371175;4935.481774413706;4950.331705219749;5135.969777831097;5171.948280517222;5176.534111929869;5192.7403629818355;5197.324347834758;4709.552592503706;4857.562819346205;4888.633352498506;4904;4908.803647854117;2693.393986353055;2710.7424794644476;2736.0834120569434;2746.258510202234;2758.7655049321033;5233.450487698737;5265.447128051576;5307.575393968474;5307.8142265021315;5353.2773075634295;4863.416390033219;5173.32746742921;5246.478521228801;5257.894842103136;5288.524032837063;5279.841604751864;5282.8415147544865;5310.778520940128;5321.361436627552;5377.128467503391;5151.974240128776;5160.612954028538;5188.870278243074;5194.636375453682;5202.297689811979;5120.3133743704475;5489.313835770528;5930.522455546035;5940.55445841555;5955.707052784623;6172.179207133817;6191.19514463117;6197.535184861244;6212.689365531615;6222.128901953821;3986.123052928351;4223.324268117087;4259.3175695600685;4279.636230920407;4280.336547835091;5778.537716982715;5885.234919460443;5896.705164741831;5900.645961242168;5939.316978547522;5716.685582293014;5724.542036636975;5794.85512862165;5827.446392592697;5835.824925252249;5754.769809207585;5768.884622307614;5774.335951365479;5795.76816927335;5800.8259752207505;5595.580331475075;5670;5691;5732.197492350991;5741.712914354349;5802.823941022117;5835.3581106077445;5849.824505264849;5889.234399528034;5899.67551784656;5582.944170558242;5644.6330988485615;5702.942970570241;5746.942530574641;5769.192313076257 13:27:59 INFO - PROCESS | 11625 | |5;yui.html;744.3784439992606;747.237817426225;772.2702046565994;821.2649678537709;869.578254546545;14770.63073423165;15928.247892731804;15956.920215398906;16018.19909004551;16053.117078560703;14120.576382708536;14543.709125817504;14662.486812961548;14713;14735.336909839056;794.1581923161467;803.1647087029482;819.9877001844948;823.2672921100195;824.3611201318996;821.289584509401;831.1688311688312;831.2809419851815;831.4553967151526;832.4797001873828;836.9539675317855;838.4550042472412;838.5429940682312;840.8780726794611;843.3253397282181;815.9510429374257;830.2942498875967;830.4602008694336;832.1927730101852;832.3632421197789;611.9388061193845;613.2242712968099;613.96009259398;614.1800696070707;618.6288227063726;16449.25978330978;16721.311475409813;16739;16741.6651666966;16746.162691865356;15435.614109647237;15477;15478.61303467411;15560.533184004498;15583.688326233525;12510.249385036926;12617.747645047048;12628.936855315756;12721.681957951032;12971.67570810728;3855.7622445831375;3875.65119139276;3878.8254528546;3930.508686414198;3973.6225058619384;59302.70348648272;59957;60992;79506.60246698787;81099.9999999994;11633.302001879914;11654.671980015477;11695.181337306478;11822.113341499422;11902.583409580797;21181.894090529757;21504;21504.677429838564;21525.56948861014;21721.239756608444;8230.300424463869;8244.464109832841;8276.172382761675;8474.025487068942;8656.61045252965;4492.842750503717;4573.336866154389;4623.653226008063;4846.539578740014;4905.117078925828;3463.653634636516;3595;3598.298331825269;3604.2431089471506;3648.543932008499;628.1300398947491;635.0093853588417;646.4795839349368;651.5146216068964;655.380665271314;612.1827360473728;662.8839953008204;676.35746041261;682.3006418421159;691.5988726538595;9291.58187881547;9544.42733435996;9640.234729154774;9731.513424328756;9856.408615483095;605.2736715940889;609.7469848908241;622.9283632382334;627.8461776864698;652.0317328766778;4417.359482874966;4878.512148785164;4896.314515967696;4916.680415773035;4924.8276310328965;72909.27090729131;83870;123333;132842.33578832043;133015;111081;112148;113266;113645.4317728406;117835;94682.52658736662;94737.52631236799;95408.52295738616;95491.52254238824;99150.00849991552;8880.378373513791;9191.77020574491;9210.67098463721;9301.348905576544;9491.240700744062;47088.52911470841;56541.43458565526;58337;58394.4160558389;59222;49347.25979110244;71050.64474677593;71985;73720.26279737134;74286;13446.126001809851;13464.581471849262;13584.796228056784;13742.450301988209;13816.585502434944;15012.639405204462;15396.69206615839;15968.201589920689;16196.757048644044;16256.918715406347;14103.717925641224;14255.714885702435;14568.125912445286;14965.102093874402;15017.549473515812;14255;14774.261286935396;15299.46451874179;15455.227238637799;15479.303431345392;14717;14775.630609234855;14905.478308259158;14919.552413427615;15163.393464261748;11284.266522676;11752.23610465317;11890.702732431759;11901.880981190423;12201.328926909106;10738.463076846283;11198.593181727389;12312;12362.258264503798;12413.193142445713 13:27:59 INFO - PROCESS | 11625 | __end_tp_report 13:27:59 INFO - PROCESS | 11625 | __start_cc_report 13:27:59 INFO - PROCESS | 11625 | _x_x_mozilla_cycle_collect,321 13:27:59 INFO - PROCESS | 11625 | __end_cc_report 13:27:59 INFO - PROCESS | 11625 | __startTimestamp1472502479492__endTimestamp 13:27:59 INFO - PROCESS | 11625 | 13:27:59 INFO - PROCESS | 11625 | ------- Summary: start ------- 13:27:59 INFO - PROCESS | 11625 | Number of tests: 6 13:27:59 INFO - PROCESS | 11625 | 13:27:59 INFO - PROCESS | 11625 | [#0] dojo.html Cycles:165 Average:5464.22 Median:5693.12 stddev:619.02 (10.9%) stddev-sans-first:592.61 13:27:59 INFO - PROCESS | 11625 | Values: 3105.0 3112.1 3125.7 3128.2 3139.3 5382.0 5399.4 5438.4 5487.9 5500.6 5473.8 5483.1 5496.9 5531.5 5555.2 4913.5 4989.6 5018.9 5066.3 5164.5 5096.4 5109.8 5119.0 5173.9 5175.4 4923.7 4936.1 4983.8 5004.0 5008.2 4965.3 4982.5 4991.1 5012.8 5043.8 4904.7 4960.5 4972.8 4982.9 5004.0 5365.1 5396.8 5463.6 5494.4 5501.3 5846.5 5851.0 5854.2 5858.5 5888.2 5891.2 5902.3 5914.8 5915.2 5915.9 5410.6 5417.1 5457.1 5464.0 5469.0 5977.9 6001.8 6001.9 6009.9 6056.1 5712.7 5720.9 5725.9 5726.3 5741.0 5674.4 5757.0 5784.1 5815.6 5844.2 5640.4 5742.7 5803.7 5833.3 5839.0 5797.2 5865.0 5865.6 5869.2 5895.9 4474.6 4487.1 4494.8 4542.3 4571.6 4012.5 4035.4 4055.6 4065.7 4076.0 5593.5 5622.9 5628.4 5642.5 5649.2 5801.1 5864.8 5927.9 5931.0 5973.1 5617.0 5665.6 5670.5 5693.1 5712.8 5127.5 5128.1 5132.9 5153.4 5203.1 6029.0 6046.4 6118.2 6127.2 6130.0 5897.3 5926.1 5936.9 6005.7 6015.1 6058.5 6093.5 6108.8 6110.4 6125.4 5649.2 5729.6 5752.3 5780.3 5810.7 5874.0 5905.5 5950.4 5953.8 5974.2 5739.3 5753.4 5756.8 5773.5 5774.9 5579.6 5698.9 5740.5 5745.0 5758.7 5671.7 5696.1 5714.8 5718.1 5764.9 5716.5 5821.0 5822.0 5828.9 5861.8 5572.3 5587.3 5607.8 5677.7 5711.4 13:27:59 INFO - PROCESS | 11625 | 13:27:59 INFO - PROCESS | 11625 | [#1] ext.html Cycles:180 Average:54158.04 Median:40288.10 stddev:104534.13 (259.5%) stddev-sans-first:104749.88 13:27:59 INFO - PROCESS | 11625 | Values: 548.9 583.7 584.3 588.8 636.8 37596.8 41459.0 41473.8 41494.4 41633.0 41977.4 42475.4 43014.1 43103.8 43355.6 8685.4 8843.2 8847.2 8856.5 8879.2 8643.9 8778.6 8804.9 8818.7 8825.9 8781.8 8809.9 8852.0 8856.5 8867.8 8715.1 8745.9 8792.3 8844.6 8851.6 8694.7 8761.8 8791.8 8794.1 8794.1 39523.2 40087.4 40155.2 40204.6 40222.4 3309.0 3453.8 3515.7 3583.9 3841.5 31798.8 32186.8 32243.4 33730.7 33773.2 4273.4 4342.6 4431.3 4457.8 4461.3 231743.0 233024.0 233806.0 234440.0 235580.8 54665.2 55161.0 55311.0 55726.7 55814.4 36359.0 37147.0 37370.8 58735.7 58957.7 17295.5 17509.1 17570.4 17705.6 17717.1 13517.9 13607.8 13614.2 13627.9 13629.9 18618.2 18622.7 18704.8 18910.7 19099.9 7067.5 7227.6 7444.9 7448.3 7530.7 903.8 1000.2 1085.4 1097.3 1105.0 32534.2 32578.5 32597.2 33018.7 33196.5 1092.8 1094.8 1098.9 1116.8 1122.9 16477.7 17045.7 17106.2 17115.9 17159.8 527257.0 531569.0 532990.0 535074.0 536095.0 57296.4 57815.4 57905.4 58087.4 58513.4 1318.0 1366.4 1367.4 1370.1 1376.1 29425.9 31358.5 31818.2 32266.2 32474.2 50134.5 50716.0 50790.5 50923.7 50950.0 354438.0 355779.0 356743.0 357338.0 357489.0 28737.4 29166.1 29238.3 29238.6 29330.6 47269.8 47628.8 47674.3 47732.3 48396.5 39805.4 40153.4 40829.7 41028.4 41819.8 40117.8 40353.8 41285.0 41802.6 41936.6 41387.0 42737.8 43545.0 44056.6 44230.6 31829.2 35857.0 37295.9 37591.4 37865.4 28348.0 28397.0 28402.1 28631.6 28761.6 13:27:59 INFO - PROCESS | 11625 | 13:27:59 INFO - PROCESS | 11625 | [#2] jquery.html Cycles:180 Average:28262.83 Median:20494.88 stddev:76279.81 (372.2%) stddev-sans-first:76465.10 13:27:59 INFO - PROCESS | 11625 | Values: 396.5 399.4 408.7 413.4 425.1 17918.5 18813.5 19141.9 19538.0 19646.3 18767.3 19117.1 19296.9 19440.8 19562.8 5639.6 5685.3 5762.7 5793.7 5846.7 5680.9 5730.5 5762.2 5769.9 5771.8 5527.2 5625.1 5656.3 5693.5 5720.9 5590.4 5637.8 5641.4 5665.3 5676.1 4985.6 5134.5 5136.9 5149.4 5155.3 22357.6 22438.9 22654.7 22812.5 22865.4 2014.3 2143.2 2200.5 2408.0 2427.0 9980.7 10430.2 10442.5 10470.3 10514.6 1941.5 1948.3 1973.8 1987.7 2006.6 82281.6 84689.6 85413.5 85667.0 86174.0 10857.5 11308.7 11488.0 11635.5 11790.1 15894.6 15919.4 15954.9 16006.8 16008.8 7943.4 8242.8 8322.8 8344.0 8461.5 7806.3 7857.4 7935.4 8090.8 8149.3 4725.8 4764.6 4816.4 4899.7 4971.8 1988.4 2048.0 2057.0 2084.5 2093.9 890.8 935.8 988.7 1015.3 1070.4 18621.6 19254.9 19293.9 19328.0 19525.0 979.7 983.8 993.5 1034.6 1036.9 10235.2 10700.2 10828.7 10942.2 10949.1 426953.0 452104.0 472670.0 476488.0 477526.0 84697.0 84942.6 87741.0 90054.5 90593.5 948.2 966.9 1016.5 1025.1 1031.0 15897.4 16685.7 17291.8 17617.8 17634.1 38562.8 41953.6 43157.6 43368.3 43418.9 56587.0 60114.4 61117.7 61452.0 63228.7 8491.2 8534.3 8714.8 8904.9 9153.4 13015.3 13021.0 13122.7 13368.3 13479.3 11491.5 11706.1 11796.4 11842.5 11905.2 10645.2 11116.5 11273.4 11562.8 11850.1 11667.9 11670.9 11793.1 11795.6 12135.7 7458.7 8604.4 8696.4 8757.1 9014.1 11420.6 11590.4 11716.8 12050.2 12052.2 13:27:59 INFO - PROCESS | 11625 | 13:27:59 INFO - PROCESS | 11625 | [#3] mootools.html Cycles:180 Average:6012.45 Median:2598.90 stddev:3405.79 (131.0%) stddev-sans-first:3398.39 13:27:59 INFO - PROCESS | 11625 | Values: 1491.0 1530.1 1674.2 1763.7 1801.9 7901.7 8641.4 8751.3 9428.0 9429.8 8565.5 8713.5 8926.1 8936.8 8941.0 2378.5 2432.3 2436.1 2437.5 2441.5 2374.9 2387.5 2437.5 2439.4 2448.2 2391.3 2405.6 2427.3 2459.6 2464.0 2347.3 2373.3 2377.5 2386.5 2393.1 2338.9 2343.5 2368.8 2374.6 2377.0 9038.0 9154.0 9188.5 9254.9 9263.6 5472.0 5567.9 5580.1 5605.2 5610.9 3474.0 3510.9 3573.8 3615.2 3645.8 1240.5 1284.8 1325.9 1328.5 1359.8 12594.2 12930.9 12941.8 12946.9 12948.6 4727.7 4794.7 4825.7 4832.5 5002.3 10831.2 10832.5 10847.6 10853.7 10871.4 5431.3 5451.1 5470.7 5480.9 5499.0 4349.3 4943.9 4992.9 5027.9 5097.1 4131.2 4161.8 4198.6 4201.6 4203.5 1293.1 1299.7 1308.7 1313.2 1316.8 873.5 954.2 972.7 977.3 994.8 6179.3 6237.6 6413.7 6439.2 6552.8 456.8 464.5 468.2 469.4 470.1 4142.4 4170.4 4177.9 4343.2 4364.4 10501.5 10983.9 11026.5 11029.7 11035.0 10699.3 10731.4 10799.0 10812.6 10828.8 8075.3 8120.6 8292.1 8293.1 8447.3 6382.0 6579.2 6609.4 6656.2 6657.9 10362.6 10412.3 10452.5 10712.4 10741.2 10378.2 10530.6 10589.5 10639.3 10660.1 7918.7 8117.4 8144.6 8189.3 8364.4 9056.6 9086.0 9147.3 9163.1 9229.5 7998.0 8066.2 8089.8 8142.8 8157.1 7744.5 7969.8 8035.3 8067.5 8355.2 7046.9 7048.0 7065.3 7167.4 7255.0 5278.4 5385.1 5424.2 5479.5 5510.8 5418.3 5514.8 5563.3 5573.2 5719.8 13:27:59 INFO - PROCESS | 11625 | 13:27:59 INFO - PROCESS | 11625 | [#4] prototype.html Cycles:180 Average:4683.74 Median:5195.98 stddev:1370.21 (26.4%) stddev-sans-first:1334.50 13:27:59 INFO - PROCESS | 11625 | Values: 328.7 343.3 346.1 349.7 352.5 5339.6 5357.5 5489.0 5595.5 5613.7 5383.7 5450.9 5463.9 5466.6 5479.3 4302.8 4326.6 4340.8 4358.5 4365.9 4097.7 4251.7 4309.1 4366.6 4394.7 4239.9 4246.3 4253.2 4256.1 4263.4 4254.5 4257.8 4260.7 4264.6 4279.1 3647.6 3717.8 3724.6 3724.7 3726.9 5348.5 5354.2 5370.7 5373.5 5377.3 4771.2 4806.8 4808.7 4840.5 4850.4 5459.3 5626.0 5667.8 5691.3 5699.5 4050.7 4052.4 4056.4 4060.4 4067.7 5822.8 5955.2 5969.6 5973.5 5989.2 4165.2 4183.7 4184.0 4187.9 4192.5 4233.3 4239.3 4250.1 4257.2 4264.3 4833.0 4842.6 4852.5 4858.0 4920.5 5411.6 5561.9 5669.2 5738.6 5829.2 1443.8 1462.9 1475.0 1477.3 1479.6 887.9 915.5 940.1 941.5 947.4 4834.2 4851.2 4856.9 4935.5 4950.3 5136.0 5171.9 5176.5 5192.7 5197.3 4709.6 4857.6 4888.6 4904.0 4908.8 2693.4 2710.7 2736.1 2746.3 2758.8 5233.5 5265.4 5307.6 5307.8 5353.3 4863.4 5173.3 5246.5 5257.9 5288.5 5279.8 5282.8 5310.8 5321.4 5377.1 5152.0 5160.6 5188.9 5194.6 5202.3 5120.3 5489.3 5930.5 5940.6 5955.7 6172.2 6191.2 6197.5 6212.7 6222.1 3986.1 4223.3 4259.3 4279.6 4280.3 5778.5 5885.2 5896.7 5900.6 5939.3 5716.7 5724.5 5794.9 5827.4 5835.8 5754.8 5768.9 5774.3 5795.8 5800.8 5595.6 5670.0 5691.0 5732.2 5741.7 5802.8 5835.4 5849.8 5889.2 5899.7 5582.9 5644.6 5702.9 5746.9 5769.2 13:27:59 INFO - PROCESS | 11625 | 13:27:59 INFO - PROCESS | 11625 | [#5] yui.html Cycles:180 Average:21322.39 Median:4598.50 stddev:30988.07 (673.9%) stddev-sans-first:31036.48 13:27:59 INFO - PROCESS | 11625 | Values: 744.4 747.2 772.3 821.3 869.6 14770.6 15928.2 15956.9 16018.2 16053.1 14120.6 14543.7 14662.5 14713.0 14735.3 794.2 803.2 820.0 823.3 824.4 821.3 831.2 831.3 831.5 832.5 837.0 838.5 838.5 840.9 843.3 816.0 830.3 830.5 832.2 832.4 611.9 613.2 614.0 614.2 618.6 16449.3 16721.3 16739.0 16741.7 16746.2 15435.6 15477.0 15478.6 15560.5 15583.7 12510.2 12617.7 12628.9 12721.7 12971.7 3855.8 3875.7 3878.8 3930.5 3973.6 59302.7 59957.0 60992.0 79506.6 81100.0 11633.3 11654.7 11695.2 11822.1 11902.6 21181.9 21504.0 21504.7 21525.6 21721.2 8230.3 8244.5 8276.2 8474.0 8656.6 4492.8 4573.3 4623.7 4846.5 4905.1 3463.7 3595.0 3598.3 3604.2 3648.5 628.1 635.0 646.5 651.5 655.4 612.2 662.9 676.4 682.3 691.6 9291.6 9544.4 9640.2 9731.5 9856.4 605.3 609.7 622.9 627.8 652.0 4417.4 4878.5 4896.3 4916.7 4924.8 72909.3 83870.0 123333.0 132842.3 133015.0 111081.0 112148.0 113266.0 113645.4 117835.0 94682.5 94737.5 95408.5 95491.5 99150.0 8880.4 9191.8 9210.7 9301.3 9491.2 47088.5 56541.4 58337.0 58394.4 59222.0 49347.3 71050.6 71985.0 73720.3 74286.0 13446.1 13464.6 13584.8 13742.5 13816.6 15012.6 15396.7 15968.2 16196.8 16256.9 14103.7 14255.7 14568.1 14965.1 15017.5 14255.0 14774.3 15299.5 15455.2 15479.3 14717.0 14775.6 14905.5 14919.6 15163.4 11284.3 11752.2 11890.7 11901.9 12201.3 10738.5 11198.6 12312.0 12362.3 12413.2 13:27:59 INFO - PROCESS | 11625 | -------- Summary: end -------- 13:27:59 INFO - PROCESS | 11625 | 13:28:00 INFO - TEST-INFO | 11625: exit 0 13:28:00 INFO - TEST-OK | dromaeo_css | took 1114091ms 13:28:00 INFO - TEST-START | kraken 13:28:00 INFO - operating with platform_type : linux_ 13:28:00 INFO - Initialising browser for kraken test... 13:28:00 INFO - TEST-INFO | started process 11988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplnxTkP/profile http://localhost:45049/getInfo.html) 13:28:05 INFO - PROCESS | 11988 | __metrics Screen width/height:1600/1200 13:28:05 INFO - PROCESS | 11988 | colorDepth:24 13:28:05 INFO - PROCESS | 11988 | Browser inner width/height: 1024/697 13:28:05 INFO - PROCESS | 11988 | __metrics 13:28:05 ERROR - PROCESS | 11988 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 13:28:06 INFO - TEST-INFO | 11988: exit 0 13:28:06 INFO - Browser initialized. 13:28:06 INFO - Running cycle 1/1 for kraken test... 13:28:06 INFO - TEST-INFO | started process 12107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplnxTkP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:18 INFO - PROCESS | 12107 | RSS: Main: 192122880 13:28:18 INFO - PROCESS | 12107 | 13:28:21 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45049/tests/kraken/driver.html?testName=audio-beat-detection) 13:28:22 INFO - PROCESS | 12107 | RSS: Main: 204910592 13:28:22 INFO - PROCESS | 12107 | 13:28:24 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45049/tests/kraken/driver.html?testName=audio-dft) 13:28:25 INFO - PROCESS | 12107 | RSS: Main: 204357632 13:28:25 INFO - PROCESS | 12107 | 13:28:28 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45049/tests/kraken/driver.html?testName=audio-fft) 13:28:28 INFO - PROCESS | 12107 | RSS: Main: 196194304 13:28:28 INFO - PROCESS | 12107 | 13:28:31 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45049/tests/kraken/driver.html?testName=audio-oscillator) 13:28:31 INFO - PROCESS | 12107 | RSS: Main: 197332992 13:28:31 INFO - PROCESS | 12107 | 13:28:33 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45049/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:28:34 INFO - PROCESS | 12107 | RSS: Main: 197066752 13:28:34 INFO - PROCESS | 12107 | 13:28:37 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45049/tests/kraken/driver.html?testName=imaging-darkroom) 13:28:38 INFO - PROCESS | 12107 | RSS: Main: 197984256 13:28:38 INFO - PROCESS | 12107 | 13:28:41 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45049/tests/kraken/driver.html?testName=imaging-desaturate) 13:28:42 INFO - PROCESS | 12107 | RSS: Main: 195301376 13:28:42 INFO - PROCESS | 12107 | 13:28:45 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45049/tests/kraken/driver.html?testName=json-parse-financial) 13:28:45 INFO - PROCESS | 12107 | RSS: Main: 196550656 13:28:45 INFO - PROCESS | 12107 | 13:28:47 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45049/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:28:47 INFO - PROCESS | 12107 | RSS: Main: 196845568 13:28:47 INFO - PROCESS | 12107 | 13:28:49 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45049/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:28:50 INFO - PROCESS | 12107 | RSS: Main: 196734976 13:28:50 INFO - PROCESS | 12107 | 13:28:52 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45049/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:28:53 INFO - PROCESS | 12107 | RSS: Main: 197541888 13:28:53 INFO - PROCESS | 12107 | 13:28:55 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:28:56 INFO - PROCESS | 12107 | RSS: Main: 197255168 13:28:56 INFO - PROCESS | 12107 | 13:28:59 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:28:59 INFO - PROCESS | 12107 | RSS: Main: 197722112 13:28:59 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | Cycle 1(1): loaded http://localhost:45049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45049/tests/kraken/driver.html?testName=ai-astar) 13:29:01 INFO - PROCESS | 12107 | RSS: Main: 199278592 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | __start_tp_report 13:29:01 INFO - PROCESS | 12107 | _x_x_mozilla_page_load 13:29:01 INFO - PROCESS | 12107 | _x_x_mozilla_page_load_details 13:29:01 INFO - PROCESS | 12107 | |i|pagename|runs| 13:29:01 INFO - PROCESS | 12107 | |0;ai-astar;116;112;112;115;115;111;112;112;114;131 13:29:01 INFO - PROCESS | 12107 | |1;audio-beat-detection;157;127;152;182;121;147;148;124;181;121 13:29:01 INFO - PROCESS | 12107 | |2;audio-dft;165;166;165;175;165;161;163;164;162;164 13:29:01 INFO - PROCESS | 12107 | |3;audio-fft;76;77;76;179;77;77;76;77;172;76 13:29:01 INFO - PROCESS | 12107 | |4;audio-oscillator;83;83;154;82;83;84;152;82;83;142 13:29:01 INFO - PROCESS | 12107 | |5;imaging-gaussian-blur;117;118;117;118;117;117;118;117;117;117 13:29:01 INFO - PROCESS | 12107 | |6;imaging-darkroom;147;146;148;147;147;146;147;146;147;147 13:29:01 INFO - PROCESS | 12107 | |7;imaging-desaturate;96;97;96;98;95;95;96;96;96;96 13:29:01 INFO - PROCESS | 12107 | |8;json-parse-financial;58;55;54;54;55;54;56;53;56;53 13:29:01 INFO - PROCESS | 12107 | |9;json-stringify-tinderbox;61;63;66;62;64;62;62;62;62;62 13:29:01 INFO - PROCESS | 12107 | |10;stanford-crypto-aes;80;80;80;83;80;85;81;80;80;80 13:29:01 INFO - PROCESS | 12107 | |11;stanford-crypto-ccm;132;128;149;133;129;130;141;131;165;147 13:29:01 INFO - PROCESS | 12107 | |12;stanford-crypto-pbkdf2;166;171;164;164;165;176;164;168;168;167 13:29:01 INFO - PROCESS | 12107 | |13;stanford-crypto-sha256-iterative;70;70;67;70;66;65;69;66;65;65 13:29:01 INFO - PROCESS | 12107 | __end_tp_report 13:29:01 INFO - PROCESS | 12107 | __start_cc_report 13:29:01 INFO - PROCESS | 12107 | _x_x_mozilla_cycle_collect,804 13:29:01 INFO - PROCESS | 12107 | __end_cc_report 13:29:01 INFO - PROCESS | 12107 | __startTimestamp1472502541923__endTimestamp 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | ------- Summary: start ------- 13:29:01 INFO - PROCESS | 12107 | Number of tests: 14 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#0] ai-astar Cycles:10 Average:115.00 Median:114.50 stddev:5.87 (5.1%) stddev-sans-first:6.21 13:29:01 INFO - PROCESS | 12107 | Values: 116.0 112.0 112.0 115.0 115.0 111.0 112.0 112.0 114.0 131.0 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:150.00 stddev:23.04 (15.4%) stddev-sans-first:24.09 13:29:01 INFO - PROCESS | 12107 | Values: 157.0 127.0 152.0 182.0 121.0 147.0 148.0 124.0 181.0 121.0 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:3.83 (2.3%) stddev-sans-first:4.06 13:29:01 INFO - PROCESS | 12107 | Values: 165.0 166.0 165.0 175.0 165.0 161.0 163.0 164.0 162.0 164.0 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#3] audio-fft Cycles:10 Average:96.30 Median:76.50 stddev:41.78 (54.6%) stddev-sans-first:43.66 13:29:01 INFO - PROCESS | 12107 | Values: 76.0 77.0 76.0 179.0 77.0 77.0 76.0 77.0 172.0 76.0 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:83.00 stddev:32.26 (38.9%) stddev-sans-first:33.41 13:29:01 INFO - PROCESS | 12107 | Values: 83.0 83.0 154.0 82.0 83.0 84.0 152.0 82.0 83.0 142.0 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:29:01 INFO - PROCESS | 12107 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:29:01 INFO - PROCESS | 12107 | Values: 147.0 146.0 148.0 147.0 147.0 146.0 147.0 146.0 147.0 147.0 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 13:29:01 INFO - PROCESS | 12107 | Values: 96.0 97.0 96.0 98.0 95.0 95.0 96.0 96.0 96.0 96.0 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.55 (2.8%) stddev-sans-first:1.13 13:29:01 INFO - PROCESS | 12107 | Values: 58.0 55.0 54.0 54.0 55.0 54.0 56.0 53.0 56.0 53.0 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.00 stddev:1.43 (2.3%) stddev-sans-first:1.39 13:29:01 INFO - PROCESS | 12107 | Values: 61.0 63.0 66.0 62.0 64.0 62.0 62.0 62.0 62.0 62.0 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:1.73 (2.2%) stddev-sans-first:1.80 13:29:01 INFO - PROCESS | 12107 | Values: 80.0 80.0 80.0 83.0 80.0 85.0 81.0 80.0 80.0 80.0 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:137.00 stddev:11.98 (8.7%) stddev-sans-first:12.48 13:29:01 INFO - PROCESS | 12107 | Values: 132.0 128.0 149.0 133.0 129.0 130.0 141.0 131.0 165.0 147.0 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:167.50 stddev:3.80 (2.3%) stddev-sans-first:4.00 13:29:01 INFO - PROCESS | 12107 | Values: 166.0 171.0 164.0 164.0 165.0 176.0 164.0 168.0 168.0 167.0 13:29:01 INFO - PROCESS | 12107 | 13:29:01 INFO - PROCESS | 12107 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:2.21 (3.3%) stddev-sans-first:2.12 13:29:01 INFO - PROCESS | 12107 | Values: 70.0 70.0 67.0 70.0 66.0 65.0 69.0 66.0 65.0 65.0 13:29:01 INFO - PROCESS | 12107 | -------- Summary: end -------- 13:29:01 INFO - PROCESS | 12107 | 13:29:03 INFO - TEST-INFO | 12107: exit 0 13:29:03 INFO - TEST-OK | kraken | took 62627ms 13:29:03 INFO - SUITE-END | took 1176s 13:29:03 INFO - Completed test suite (00:19:37) 13:29:03 INFO - javascript benchmark 13:29:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7306.510811390079, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.0219180958, 3112.050824498527, 3125.687431256874, 3128.1710346758114, 3139.3407384449265, 5381.973090134548, 5399.37907140678, 5438.401775804658, 5487.862803429911, 5500.559955203584, 5473.753681084351, 5483.095289277275, 5496.945030549693, 5531.474509921561, 5555.194496797962, 4913.533214344649, 4989.550940415362, 5018.924716129261, 5066.2907192992825, 5164.483551644843, 5096.439391666913, 5109.795608175668, 5118.974405127988, 5173.9482605174035, 5175.430702622709, 4923.655344125913, 4936.111499930011, 4983.825566105205, 5004.024215278022, 5008.173651347523, 4965.3048573199785, 4982.5017498250245, 4991.101601711691, 5012.824551140692, 5043.848684539433, 4904.681195722266, 4960.479149689267, 4972.776225069844, 4982.900341993176, 5003.974185292006, 5365.141577347645, 5396.811111611114, 5463.644863083887, 5494.423085576037, 5501.284832971728, 5846.532277417797, 5851.034579294412, 5854.238948936653, 5858.47273745365, 5888.175655408247, 5891.175235467038, 5902.291724992985, 5914.763409463616, 5915.1718759373725, 5915.881682366328, 5410.567154627621, 5417.079096553634, 5457.126859702428, 5464.043792336365, 5469.0155771960635, 5977.910331345033, 6001.759929602855, 6001.879962400728, 6009.939900601025, 6056.06131049688, 5712.714364281853, 5720.914186287209, 5725.885482290331, 5726.284214473191, 5741.024025915604, 5674.375818659944, 5757.0, 5784.1034639630925, 5815.563832712563, 5844.240248767633, 5640.379558248589, 5742.684152371659, 5803.709814509258, 5833.300003999547, 5839.036558967808, 5797.159411885337, 5864.970675146682, 5865.560082993792, 5869.178315035899, 5895.94104058954, 4474.6420286377015, 4487.102579484116, 4494.797734101973, 4542.250528662799, 4571.588557029883, 4012.53855806586, 4035.394690796404, 4055.5538890721996, 4065.735727177724, 4076.0217547788316, 5593.496585307342, 5622.887542249214, 5628.352739434936, 5642.520385767174, 5649.209110724501, 5801.12983052537, 5864.794732184353, 5927.9407205928255, 5930.970345148246, 5973.104034394789, 5616.9608622404985, 5665.631733937281, 5670.518005969457, 5693.117566777156, 5712.828615141552, 5127.538521533005, 5128.102582048126, 5132.897342053138, 5153.407358153785, 5203.14148165556, 6029.035354343372, 6046.395360463918, 6118.204633397719, 6127.234095738033, 6129.988551888978, 5897.262842144732, 5926.051831706906, 5936.881262374642, 6005.729742161526, 6015.0676645120075, 6058.545609079249, 6093.482054025458, 6108.847278818065, 6110.388961104032, 6125.387461253839, 5649.180868773922, 5729.598928074995, 5752.309722833287, 5780.335261444988, 5810.738516766671, 5874.030784920611, 5905.4685078343155, 5950.434708702666, 5953.839001394686, 5974.2233509643465, 5739.311282646109, 5753.3958934311295, 5756.827295181151, 5773.451522105393, 5774.884502310014, 5579.553635709215, 5698.914516282176, 5740.512056475246, 5744.971275143597, 5758.740856661377, 5671.688057156731, 5696.088625819849, 5714.79998200061, 5718.1136923776885, 5764.913526297193, 5716.456936591017, 5821.0, 5821.970890145522, 5828.854278642898, 5861.824145275648, 5572.331320241597, 5587.3015873015875, 5607.775688972395, 5677.716114194356, 5711.371749107678], "value": 5421.938924967379, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.9150422949614, 583.7110630238033, 584.2667452347306, 588.8410129265097, 636.8216899268201, 37596.81201593992, 41459.0, 41473.792631036806, 41494.377584336224, 41633.0, 41977.37033944485, 42475.36286955698, 43014.13971720564, 43103.78448107763, 43355.56644433563, 8685.435446695961, 8843.204111629952, 8847.159519845636, 8856.468611883276, 8879.245264152554, 8643.870341944876, 8778.648854045863, 8804.8679269811, 8818.691345802898, 8825.911740882606, 8781.824363512726, 8809.867851982226, 8852.026277109513, 8856.51289179095, 8867.778305542348, 8715.084916083782, 8745.912540874573, 8792.252658524001, 8844.55777211137, 8851.601677924476, 8694.652213911437, 8761.824763504757, 8791.78020549485, 8794.12058794122, 8794.12058794122, 39523.20953580941, 40087.39868901969, 40155.19689606191, 40204.59795402038, 40222.396664050066, 3308.983455082733, 3453.792772433662, 3515.736319776027, 3583.946240806364, 3841.4621952926614, 31798.841005795053, 32186.839065804754, 32243.355132897446, 33730.662693373, 33773.15567110817, 4273.380359847804, 4342.5874541918465, 4431.26884064129, 4457.777111144463, 4461.308497182942, 231743.0, 233024.0, 233806.0, 234440.0, 235580.82209589015, 54665.1800222997, 55161.0, 55311.0, 55726.72136639291, 55814.441855580924, 36359.0, 37147.0, 37370.81314593464, 58735.65057397656, 58957.705211473665, 17295.45443184144, 17509.12454377276, 17570.38503652366, 17705.645887082443, 17717.114144292733, 13517.864821351857, 13607.795883061763, 13614.18314901109, 13627.931860340635, 13629.931850340685, 18618.16218270181, 18622.716775141795, 18704.812951870306, 18910.716339254923, 19099.90450047741, 7067.540609860343, 7227.566346019255, 7444.947571495769, 7448.329650331496, 7530.6611202496015, 903.8011637439753, 1000.1648623399398, 1085.3542142425244, 1097.3361116524547, 1105.0165352835982, 32534.186645334055, 32578.511322330185, 32597.18507037343, 33018.66981330204, 33196.50205246875, 1092.7814437112609, 1094.8029354716227, 1098.873629532614, 1116.7822274656526, 1122.910167186623, 16477.670446591, 17045.659086818196, 17106.230219640147, 17115.914420427816, 17159.828401715822, 527257.0, 531569.0, 532990.0, 535074.0, 536095.0, 57296.42703572911, 57815.42184578184, 57905.420945790844, 58087.41912580904, 58513.41486585165, 1317.960461186166, 1366.357811828439, 1367.3505085084705, 1370.095736813698, 1376.064276292131, 29425.85287073551, 31358.453024311802, 31818.204544886565, 32266.193345166557, 32474.188145296557, 50134.49865501298, 50716.0, 50790.492095078574, 50923.745381272856, 50949.981000380525, 354438.0, 355779.0, 356743.0, 357338.0, 357489.0, 28737.42525149527, 29166.125016249545, 29238.269043273238, 29238.561421579117, 29330.560041598965, 47269.76365118152, 47628.7618561905, 47674.28488572744, 47732.284015740486, 48396.5160348392, 39805.40291895682, 40153.39769903512, 40829.688866674995, 41028.384574232005, 41819.7909010453, 40117.77291223093, 40353.79823100866, 41285.0, 41802.581974181085, 41936.64219597839, 41387.0, 42737.786311068245, 43545.0, 44056.559434406525, 44230.55769442264, 31829.20426989251, 35857.0, 37295.87655653512, 37591.43612845864, 37865.432018520296, 28348.0, 28397.0, 28402.147935561967, 28631.570526442538, 28761.56857647179], "value": 19613.000518016186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.5103097674373, 399.4068807820388, 408.7118581400113, 413.39437723734727, 425.09454861145775, 17918.46244612662, 18813.529661758464, 19141.904290478527, 19537.99999999998, 19646.312379066734, 18767.343142989997, 19117.139728712205, 19296.9035154824, 19440.805591944078, 19562.804371956277, 5639.577031722617, 5685.317761868561, 5762.654240745548, 5793.71031448428, 5846.678432686201, 5680.914786278188, 5730.484256416921, 5762.164486149506, 5769.942300577003, 5771.769129234825, 5527.226188333637, 5625.099984002561, 5656.321241451011, 5693.487586117249, 5720.8855822883515, 5590.357108932484, 5637.802676906309, 5641.379448260688, 5665.3201615806165, 5676.148577713335, 4985.576226020793, 5134.486551344873, 5136.922946155811, 5149.433562308143, 5155.329807125087, 22357.552848943094, 22438.88780556087, 22654.66018009731, 22812.543749124925, 22865.428364291027, 2014.2547257514666, 2143.185589475989, 2200.4938864061196, 2408.0247499762622, 2426.9514609707885, 9980.650677226335, 10430.217733670004, 10442.530086146066, 10470.267081304235, 10514.631987880464, 1941.4855063408208, 1948.2888745607893, 1973.792751761073, 1987.7415935928236, 2006.588649326899, 82281.58859205665, 84689.57655211746, 85413.54435185797, 85667.0, 86174.0, 10857.45712714361, 11308.71728206785, 11488.0, 11635.476403561861, 11790.115741319436, 15894.60263493422, 15919.442819501262, 15954.920225399032, 16006.839931600534, 16008.759868601981, 7943.364530837519, 8242.752717418487, 8322.750317490485, 8344.0, 8461.492310461392, 7806.297433230923, 7857.371410287277, 7935.387059758138, 8090.757277281691, 8149.348052155813, 4725.834595789131, 4764.595009424169, 4816.373871396766, 4899.6570240083565, 4971.801127954841, 1988.4034789563073, 2047.9897600511902, 2056.979430205709, 2084.48930012148, 2093.884836334016, 890.8084761776249, 935.8081593273363, 988.6786794291884, 1015.28422462164, 1070.4112737994071, 18621.627567448846, 19254.903725481283, 19293.903530482257, 19328.033598320028, 19525.0, 979.740368802268, 983.8327484327539, 993.4833886379187, 1034.622362837574, 1036.9222308326905, 10235.232357573062, 10700.197485188643, 10828.675139745821, 10942.23404361687, 10949.124070074375, 426953.0, 452104.0, 472670.0, 476488.0, 477526.0, 84697.0, 84942.57528712317, 87741.0, 90054.54972725094, 90593.54703226441, 948.2177203806887, 966.917811985989, 1016.4815943868532, 1025.1183981775666, 1031.0359813574332, 15897.443589474313, 16685.66628667444, 17291.82708172902, 17617.82382176213, 17634.1182940855, 38562.80718596389, 41953.580464194965, 43157.56842431661, 43368.34947475727, 43418.921351011515, 56587.0, 60114.39885601088, 61117.69441152766, 61452.0, 63228.68385658226, 8491.15088491146, 8534.317254619491, 8714.782130446789, 8904.86642700373, 9153.359264851662, 13015.284159371326, 13021.0, 13122.671933201746, 13368.264745439094, 13479.32603369808, 11491.48288327044, 11706.122040847142, 11796.410179491162, 11842.526298947945, 11905.226160299553, 10645.201609879136, 11116.49975751077, 11273.436328183394, 11562.76874462523, 11850.111241656738, 11667.941660291644, 11670.94164529172, 11793.056555475712, 11795.646130616095, 12135.725748796249, 7458.73894413693, 8604.354673399395, 8696.43473174267, 8757.080506546721, 9014.143656352637, 11420.600278990196, 11590.362530060927, 11716.824247636463, 12050.216735912138, 12052.216605920587], "value": 9223.094785942216, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.9552713418598, 1530.1431198528824, 1674.238221609168, 1763.6560870630217, 1801.9008954507506, 7901.683932642687, 8641.351898607598, 8751.34364922631, 9428.0, 9429.81140377192, 8565.528895910738, 8713.520756358397, 8926.062763409846, 8936.776580585489, 8941.0, 2378.5361854438434, 2432.282476669378, 2436.0864675746593, 2437.500312435955, 2441.5483135619966, 2374.8931298091543, 2387.498625288683, 2437.475942672325, 2439.3779586205583, 2448.167623008177, 2391.306521108885, 2405.627127795186, 2427.2960841355984, 2459.606462965926, 2463.9753602463925, 2347.342744031657, 2373.311739595515, 2377.524495100978, 2386.451116243265, 2393.0667039854297, 2338.9064437422485, 2343.484433424644, 2368.834181607288, 2374.584447721659, 2376.9762302376926, 9038.0, 9154.0, 9188.540572971324, 9254.907450925539, 9263.583138758771, 5471.972640136773, 5567.8886422271735, 5580.107182850765, 5605.215269862222, 5610.859728506779, 3474.0, 3510.929781404383, 3573.76770509916, 3615.1865830188262, 3645.8177091145335, 1240.466599362283, 1284.775164346245, 1325.9469621215237, 1328.4951718346965, 1359.8096266522596, 12594.244345339217, 12930.870691293061, 12941.805872911913, 12946.935265323613, 12948.611541653765, 4727.669063165614, 4794.7362895040405, 4825.686330388514, 4832.492588278251, 5002.299678045077, 10831.241813073168, 10832.512536935857, 10847.566097356175, 10853.674389768319, 10871.402072886067, 5431.321084864392, 5451.127819548932, 5470.671759694431, 5480.945190548123, 5498.972505137449, 4349.325854492558, 4943.8516844494725, 4992.8751781205765, 5027.949720502821, 5097.08252514551, 4131.193439335211, 4161.83352665896, 4198.6011328923705, 4201.642860356843, 4203.495580530356, 1293.1056002955715, 1299.7197760206188, 1308.653206900172, 1313.2251971336957, 1316.8419789625307, 873.4671850171391, 954.1508057828538, 972.7130496503407, 977.2621670638622, 994.8408254679216, 6179.258488981351, 6237.625742455467, 6413.711382987777, 6439.195100612424, 6552.803415897531, 456.8081405809568, 464.45890537523405, 468.24144885285375, 469.38744937856427, 470.1302590208156, 4142.4378907433675, 4170.395292682605, 4177.937330940038, 4343.153085148366, 4364.367166760802, 10501.527431265611, 10983.890161098287, 11026.503807328689, 11029.669109926715, 11035.0, 10699.25105242641, 10731.409772462433, 10799.0, 10812.621558245424, 10828.78342433147, 8075.313598344089, 8120.553369564731, 8292.12932642076, 8293.087760346358, 8447.32421406286, 6382.0, 6579.17760279965, 6609.438197753245, 6656.201255849329, 6657.901446261506, 10362.637307694195, 10412.323198992344, 10452.529636166542, 10712.35725856451, 10741.194410419093, 10378.169746420117, 10530.631427899987, 10589.523471443958, 10639.255252132276, 10660.147188224768, 7918.683252669829, 8117.391195660231, 8144.5520496373265, 8189.262966333059, 8364.372672049742, 9056.592453339746, 9086.0, 9147.268218542633, 9163.129502697233, 9229.538523073954, 7998.0, 8066.23370779775, 8089.838203235785, 8142.7557173284895, 8157.06193787722, 7744.49660772048, 7969.800754981172, 8035.316998055231, 8067.475614085066, 8355.164483551596, 7046.929530704628, 7048.0, 7065.293470652894, 7167.3907717842485, 7255.0, 5278.445763194963, 5385.111456609772, 5424.186372044225, 5479.53423958968, 5510.8071217507195, 5418.349798024262, 5514.779408823602, 5563.332400112013, 5573.219749235192, 5719.799807006735], "value": 4740.277823150433, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.68437416718484, 343.3236524047626, 346.1467482655255, 349.6905238863605, 352.4748125293311, 5339.6262261641605, 5357.517823395893, 5488.972555137224, 5595.461248156759, 5613.719314034297, 5383.730813459321, 5450.928647114091, 5463.890722185554, 5466.562674986001, 5479.342478902528, 4302.784860756965, 4326.58897404746, 4340.826366945318, 4358.498772641139, 4365.890852728676, 4097.692673049518, 4251.659867210631, 4309.095090031097, 4366.5633436656235, 4394.7143435676735, 4239.851605193819, 4246.2569050416205, 4253.191893540233, 4256.1487702459635, 4263.403123562688, 4254.468191476066, 4257.787110644455, 4260.744355338658, 4264.55222201669, 4279.1227798301425, 3647.6170002149656, 3717.7955212463303, 3724.553053633554, 3724.7392682512236, 3726.850925962958, 5348.491893270172, 5354.215807779971, 5370.650907690988, 5373.462653734634, 5377.274068000848, 4771.188897887368, 4806.807727690888, 4808.711477311373, 4840.540148685905, 4850.417949846006, 5459.270810128493, 5625.971870140623, 5667.838093190886, 5691.260136182311, 5699.458551437607, 4050.7037747920676, 4052.4326594276827, 4056.391541268804, 4060.3909413587903, 4067.718668619405, 5822.82531524055, 5955.196048533436, 5969.641821490724, 5973.522118230531, 5989.191459153046, 4165.187788381237, 4183.748975061506, 4183.958160418357, 4187.874363769091, 4192.496900371914, 4233.280342341809, 4239.321708526621, 4250.086231460251, 4257.23369793434, 4264.33902745075, 4833.0, 4842.627112714745, 4852.539008794159, 4858.0, 4920.532549407801, 5411.56707463402, 5561.859818737149, 5669.2346533218315, 5738.626989245686, 5829.154772557956, 1443.826740791112, 1462.8610282023192, 1474.9852501474847, 1477.2909003678294, 1479.5709244319241, 887.8845750052581, 915.455304094063, 940.1350757303161, 941.5292353823088, 947.3557980573277, 4834.20235661119, 4851.175300198975, 4856.854294371175, 4935.481774413706, 4950.331705219749, 5135.969777831097, 5171.948280517222, 5176.534111929869, 5192.7403629818355, 5197.324347834758, 4709.552592503706, 4857.562819346205, 4888.633352498506, 4904.0, 4908.803647854117, 2693.393986353055, 2710.7424794644476, 2736.0834120569434, 2746.258510202234, 2758.7655049321033, 5233.450487698737, 5265.447128051576, 5307.575393968474, 5307.8142265021315, 5353.2773075634295, 4863.416390033219, 5173.32746742921, 5246.478521228801, 5257.894842103136, 5288.524032837063, 5279.841604751864, 5282.8415147544865, 5310.778520940128, 5321.361436627552, 5377.128467503391, 5151.974240128776, 5160.612954028538, 5188.870278243074, 5194.636375453682, 5202.297689811979, 5120.3133743704475, 5489.313835770528, 5930.522455546035, 5940.55445841555, 5955.707052784623, 6172.179207133817, 6191.19514463117, 6197.535184861244, 6212.689365531615, 6222.128901953821, 3986.123052928351, 4223.324268117087, 4259.3175695600685, 4279.636230920407, 4280.336547835091, 5778.537716982715, 5885.234919460443, 5896.705164741831, 5900.645961242168, 5939.316978547522, 5716.685582293014, 5724.542036636975, 5794.85512862165, 5827.446392592697, 5835.824925252249, 5754.769809207585, 5768.884622307614, 5774.335951365479, 5795.76816927335, 5800.8259752207505, 5595.580331475075, 5670.0, 5691.0, 5732.197492350991, 5741.712914354349, 5802.823941022117, 5835.3581106077445, 5849.824505264849, 5889.234399528034, 5899.67551784656, 5582.944170558242, 5644.6330988485615, 5702.942970570241, 5746.942530574641, 5769.192313076257], "value": 4249.203855703603, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.3784439992606, 747.237817426225, 772.2702046565994, 821.2649678537709, 869.578254546545, 14770.63073423165, 15928.247892731804, 15956.920215398906, 16018.19909004551, 16053.117078560703, 14120.576382708536, 14543.709125817504, 14662.486812961548, 14713.0, 14735.336909839056, 794.1581923161467, 803.1647087029482, 819.9877001844948, 823.2672921100195, 824.3611201318996, 821.289584509401, 831.1688311688312, 831.2809419851815, 831.4553967151526, 832.4797001873828, 836.9539675317855, 838.4550042472412, 838.5429940682312, 840.8780726794611, 843.3253397282181, 815.9510429374257, 830.2942498875967, 830.4602008694336, 832.1927730101852, 832.3632421197789, 611.9388061193845, 613.2242712968099, 613.96009259398, 614.1800696070707, 618.6288227063726, 16449.25978330978, 16721.311475409813, 16739.0, 16741.6651666966, 16746.162691865356, 15435.614109647237, 15477.0, 15478.61303467411, 15560.533184004498, 15583.688326233525, 12510.249385036926, 12617.747645047048, 12628.936855315756, 12721.681957951032, 12971.67570810728, 3855.7622445831375, 3875.65119139276, 3878.8254528546, 3930.508686414198, 3973.6225058619384, 59302.70348648272, 59957.0, 60992.0, 79506.60246698787, 81099.9999999994, 11633.302001879914, 11654.671980015477, 11695.181337306478, 11822.113341499422, 11902.583409580797, 21181.894090529757, 21504.0, 21504.677429838564, 21525.56948861014, 21721.239756608444, 8230.300424463869, 8244.464109832841, 8276.172382761675, 8474.025487068942, 8656.61045252965, 4492.842750503717, 4573.336866154389, 4623.653226008063, 4846.539578740014, 4905.117078925828, 3463.653634636516, 3595.0, 3598.298331825269, 3604.2431089471506, 3648.543932008499, 628.1300398947491, 635.0093853588417, 646.4795839349368, 651.5146216068964, 655.380665271314, 612.1827360473728, 662.8839953008204, 676.35746041261, 682.3006418421159, 691.5988726538595, 9291.58187881547, 9544.42733435996, 9640.234729154774, 9731.513424328756, 9856.408615483095, 605.2736715940889, 609.7469848908241, 622.9283632382334, 627.8461776864698, 652.0317328766778, 4417.359482874966, 4878.512148785164, 4896.314515967696, 4916.680415773035, 4924.8276310328965, 72909.27090729131, 83870.0, 123333.0, 132842.33578832043, 133015.0, 111081.0, 112148.0, 113266.0, 113645.4317728406, 117835.0, 94682.52658736662, 94737.52631236799, 95408.52295738616, 95491.52254238824, 99150.00849991552, 8880.378373513791, 9191.77020574491, 9210.67098463721, 9301.348905576544, 9491.240700744062, 47088.52911470841, 56541.43458565526, 58337.0, 58394.4160558389, 59222.0, 49347.25979110244, 71050.64474677593, 71985.0, 73720.26279737134, 74286.0, 13446.126001809851, 13464.581471849262, 13584.796228056784, 13742.450301988209, 13816.585502434944, 15012.639405204462, 15396.69206615839, 15968.201589920689, 16196.757048644044, 16256.918715406347, 14103.717925641224, 14255.714885702435, 14568.125912445286, 14965.102093874402, 15017.549473515812, 14255.0, 14774.261286935396, 15299.46451874179, 15455.227238637799, 15479.303431345392, 14717.0, 14775.630609234855, 14905.478308259158, 14919.552413427615, 15163.393464261748, 11284.266522676, 11752.23610465317, 11890.702732431759, 11901.880981190423, 12201.328926909106, 10738.463076846283, 11198.593181727389, 12312.0, 12362.258264503798, 12413.193142445713], "value": 7700.706802307096, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 112.0, 115.0, 115.0, 111.0, 112.0, 112.0, 114.0, 131.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 152.0, 182.0, 121.0, 147.0, 148.0, 124.0, 181.0, 121.0], "value": 146.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 165.0, 175.0, 165.0, 161.0, 163.0, 164.0, 162.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 179.0, 77.0, 77.0, 76.0, 77.0, 172.0, 76.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 154.0, 82.0, 83.0, 84.0, 152.0, 82.0, 83.0, 142.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 98.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 54.0, 54.0, 55.0, 54.0, 56.0, 53.0, 56.0, 53.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 66.0, 62.0, 64.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 83.0, 80.0, 85.0, 81.0, 80.0, 80.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 128.0, 149.0, 133.0, 129.0, 130.0, 141.0, 131.0, 165.0, 147.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 164.0, 164.0, 165.0, 176.0, 164.0, 168.0, 168.0, 167.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 67.0, 70.0, 66.0, 65.0, 69.0, 66.0, 65.0, 65.0], "value": 67.3, "unit": "score"}]}]} 13:29:03 INFO - Return code: 0 13:29:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:29:03 ERROR - # TBPL SUCCESS # 13:29:03 INFO - Running post-action listener: _resource_record_post_action 13:29:03 INFO - [mozharness: 2016-08-29 20:29:03.722147Z] Finished run-tests step (success) 13:29:03 INFO - Running post-run listener: _resource_record_post_run 13:29:03 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394215424; Read time: 12; Write time: 295480 13:29:03 INFO - TinderboxPrint: CPU usage
13.5% 13:29:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:29:03 INFO - TinderboxPrint: I/O write bytes / time
394,215,424 / 295,480 13:29:03 INFO - TinderboxPrint: CPU idle
8,238.6 (86.5%) 13:29:03 INFO - TinderboxPrint: CPU user
1,220.7 (12.8%) 13:29:03 INFO - TinderboxPrint: Swap in / out
0 / 0 13:29:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105578496; Read time: 0; Write time: 99460 13:29:03 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288636928; Read time: 0; Write time: 196020 13:29:04 INFO - Running post-run listener: _upload_blobber_files 13:29:04 INFO - Blob upload gear active. 13:29:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:29:04 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 13:29:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:29:04 INFO - (blobuploader) - INFO - Open directory for files ... 13:29:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:29:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:29:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:05 INFO - (blobuploader) - INFO - Done attempting. 13:29:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:29:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:29:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:09 INFO - (blobuploader) - INFO - Done attempting. 13:29:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:29:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:29:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:09 INFO - (blobuploader) - INFO - Done attempting. 13:29:09 INFO - (blobuploader) - INFO - Iteration through files over. 13:29:09 INFO - Return code: 0 13:29:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:29:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:29:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3daa66e9e48a25f4ce5ae33c6ab0ba271a84f8173acbc8e189c7b263bda716ad3c1ab62756ee8b4f6335df7825c8c4940b93eb2af7e7fb99c983f08ab8a5744", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb69aae9152092eca11f69ddda0a8599254d1edf1e0bbb9e4f781d5dd908976d7e449a30c6532036193987a79407784fad53c3fa8a50ceeef551aba69426648", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3caae6ded4caca242ea4386305f9e8cada6ceb9c3b5a1ceb0fc254031cc8b00cfabdbc6de33a881e1b2f2c4a008f7654ad1c18743505d28c5f114caec71deeb"} 13:29:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:29:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:29:09 INFO - Contents: 13:29:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3daa66e9e48a25f4ce5ae33c6ab0ba271a84f8173acbc8e189c7b263bda716ad3c1ab62756ee8b4f6335df7825c8c4940b93eb2af7e7fb99c983f08ab8a5744", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb69aae9152092eca11f69ddda0a8599254d1edf1e0bbb9e4f781d5dd908976d7e449a30c6532036193987a79407784fad53c3fa8a50ceeef551aba69426648", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3caae6ded4caca242ea4386305f9e8cada6ceb9c3b5a1ceb0fc254031cc8b00cfabdbc6de33a881e1b2f2c4a008f7654ad1c18743505d28c5f114caec71deeb"} 13:29:09 INFO - Running post-run listener: copy_logs_to_upload_dir 13:29:09 INFO - Copying logs to upload dir... 13:29:09 INFO - mkdir: /builds/slave/test/build/upload/logs 13:29:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1299.851504 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-08-29 13:29:08.844326) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 13:29:08.848032) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3daa66e9e48a25f4ce5ae33c6ab0ba271a84f8173acbc8e189c7b263bda716ad3c1ab62756ee8b4f6335df7825c8c4940b93eb2af7e7fb99c983f08ab8a5744", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb69aae9152092eca11f69ddda0a8599254d1edf1e0bbb9e4f781d5dd908976d7e449a30c6532036193987a79407784fad53c3fa8a50ceeef551aba69426648", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3caae6ded4caca242ea4386305f9e8cada6ceb9c3b5a1ceb0fc254031cc8b00cfabdbc6de33a881e1b2f2c4a008f7654ad1c18743505d28c5f114caec71deeb"} build_url:https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/bwPJKOLwSEWbNhdlbDVmTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3daa66e9e48a25f4ce5ae33c6ab0ba271a84f8173acbc8e189c7b263bda716ad3c1ab62756ee8b4f6335df7825c8c4940b93eb2af7e7fb99c983f08ab8a5744", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb69aae9152092eca11f69ddda0a8599254d1edf1e0bbb9e4f781d5dd908976d7e449a30c6532036193987a79407784fad53c3fa8a50ceeef551aba69426648", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3caae6ded4caca242ea4386305f9e8cada6ceb9c3b5a1ceb0fc254031cc8b00cfabdbc6de33a881e1b2f2c4a008f7654ad1c18743505d28c5f114caec71deeb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 13:29:08.873214) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:29:08.873551) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1472498381.343818-2024941608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:29:08.957652) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 13:29:08.957994) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 13:29:08.958281) ========= ========= Total master_lag: 0.17 =========