builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1472199291.34 results: success (0) buildid: 20160825223021 builduid: 20a68942304e46068a7fa76cdb580889 revision: e78454e242072bbcada626874f2900bbe1c3e647 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:51.345099) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:51.346027) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:51.346580) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:51.365878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:51.366259) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-26 01:14:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2016-08-26 01:14:51 (19.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158171 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:51.542127) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:51.542856) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023023 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:51.601924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:51.602323) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e78454e242072bbcada626874f2900bbe1c3e647 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e78454e242072bbcada626874f2900bbe1c3e647 --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=5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-26 01:14:51,945 truncating revision to first 12 chars 2016-08-26 01:14:51,945 Setting DEBUG logging. 2016-08-26 01:14:51,945 attempt 1/10 2016-08-26 01:14:51,945 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e78454e24207?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 01:14:52,226 unpacking tar archive at: mozilla-inbound-e78454e24207/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619882 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:52.235850) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:52.236185) ========= script_repo_revision: e78454e242072bbcada626874f2900bbe1c3e647 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:52.236615) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:52.236923) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 01:14:52.247467) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-26 01:14:52.248006) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:14:52 INFO - MultiFileLogger online at 20160826 01:14:52 in /builds/slave/test 01:14:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:14:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:14:52 INFO - {'append_to_log': False, 01:14:52 INFO - 'base_work_dir': '/builds/slave/test', 01:14:52 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:14:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:14:52 INFO - 'branch': 'Mozilla-Inbound', 01:14:52 INFO - 'buildbot_json_path': 'buildprops.json', 01:14:52 INFO - 'config_files': ('talos/linux_config.py',), 01:14:52 INFO - 'default_actions': ('clobber', 01:14:52 INFO - 'read-buildbot-config', 01:14:52 INFO - 'download-and-extract', 01:14:52 INFO - 'populate-webroot', 01:14:52 INFO - 'create-virtualenv', 01:14:52 INFO - 'install', 01:14:52 INFO - 'run-tests'), 01:14:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:14:52 INFO - 'download_minidump_stackwalk': True, 01:14:52 INFO - 'download_symbols': 'ondemand', 01:14:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:14:52 INFO - 'tooltool.py': '/tools/tooltool.py', 01:14:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:14:52 INFO - '/tools/misc-python/virtualenv.py')}, 01:14:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:14:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:14:52 INFO - 'installer_path': 'installer.exe', 01:14:52 INFO - 'log_level': 'info', 01:14:52 INFO - 'log_name': 'talos', 01:14:52 INFO - 'log_to_console': True, 01:14:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:14:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:14:52 INFO - 'opt_config_files': (), 01:14:52 INFO - 'pip_index': False, 01:14:52 INFO - 'sps_profile': False, 01:14:52 INFO - 'sps_profile_interval': 0, 01:14:52 INFO - 'suite': 'dromaeojs-e10s', 01:14:52 INFO - 'system_bits': '32', 01:14:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:14:52 INFO - 'title': 'talos-linux64-ix-051', 01:14:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:14:52 INFO - 'use_talos_json': True, 01:14:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:14:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:14:52 INFO - 'work_dir': 'build'} 01:14:52 INFO - [mozharness: 2016-08-26 08:14:52.690716Z] Running clobber step. 01:14:52 INFO - Running pre-action listener: _resource_record_pre_action 01:14:52 INFO - Running main action method: clobber 01:14:52 INFO - rmtree: /builds/slave/test/build 01:14:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:14:53 INFO - Running post-action listener: _resource_record_post_action 01:14:53 INFO - [mozharness: 2016-08-26 08:14:53.154428Z] Finished clobber step (success) 01:14:53 INFO - [mozharness: 2016-08-26 08:14:53.154530Z] Running read-buildbot-config step. 01:14:53 INFO - Running pre-action listener: _resource_record_pre_action 01:14:53 INFO - Running main action method: read_buildbot_config 01:14:53 INFO - Using buildbot properties: 01:14:53 INFO - { 01:14:53 INFO - "project": "", 01:14:53 INFO - "product": "firefox", 01:14:53 INFO - "script_repo_revision": "production", 01:14:53 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:14:53 INFO - "repository": "", 01:14:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:14:53 INFO - "buildid": "20160825223021", 01:14:53 INFO - "pgo_build": "True", 01:14:53 INFO - "basedir": "/builds/slave/test", 01:14:53 INFO - "buildnumber": 1274, 01:14:53 INFO - "slavename": "talos-linux64-ix-051", 01:14:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:14:53 INFO - "platform": "ubuntu64_hw", 01:14:53 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:14:53 INFO - "branch": "mozilla-inbound", 01:14:53 INFO - "repo_path": "integration/mozilla-inbound", 01:14:53 INFO - "revision": "e78454e242072bbcada626874f2900bbe1c3e647", 01:14:53 INFO - "stage_platform": "linux64-pgo", 01:14:53 INFO - "builduid": "20a68942304e46068a7fa76cdb580889", 01:14:53 INFO - "slavebuilddir": "test" 01:14:53 INFO - } 01:14:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 01:14:53 INFO - Running post-action listener: _resource_record_post_action 01:14:53 INFO - [mozharness: 2016-08-26 08:14:53.156962Z] Finished read-buildbot-config step (success) 01:14:53 INFO - [mozharness: 2016-08-26 08:14:53.157051Z] Running download-and-extract step. 01:14:53 INFO - Running pre-action listener: _resource_record_pre_action 01:14:53 INFO - Running main action method: download_and_extract 01:14:53 INFO - mkdir: /builds/slave/test/build/tests 01:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:53 INFO - trying https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 01:14:53 INFO - Downloading https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/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 01:14:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/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 01:14:53 INFO - Downloaded 1361 bytes. 01:14:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 01:14:53 INFO - Using the following test package requirements: 01:14:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 01:14:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:14:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:14:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:53 INFO - u'jsshell-linux-x86_64.zip'], 01:14:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:14:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 01:14:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:14:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:14:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:14:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:14:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:53 INFO - trying https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 01:14:53 INFO - Downloading https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/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 01:14:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/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 01:14:54 INFO - Downloaded 21871778 bytes. 01:14:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 01:14:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:59 INFO - trying https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 01:14:59 INFO - Downloading https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/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 01:14:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/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 01:15:00 INFO - Downloaded 21871778 bytes. 01:15:00 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 01:15: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')]} 01:15:04 INFO - trying https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 01:15:04 INFO - Downloading https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/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 01:15:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/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 01:15:05 INFO - Downloaded 14413981 bytes. 01:15:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 01:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:05 INFO - trying https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 01:15:05 INFO - Downloading https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/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 01:15:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/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 01:15:07 INFO - Downloaded 59710219 bytes. 01:15:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 01:15:07 INFO - mkdir: /builds/slave/test/properties 01:15:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:15:07 INFO - Writing to file /builds/slave/test/properties/build_url 01:15:07 INFO - Contents: 01:15:07 INFO - build_url:https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 01:15:07 INFO - Running post-action listener: _resource_record_post_action 01:15:07 INFO - Running post-action listener: set_extra_try_arguments 01:15:07 INFO - [mozharness: 2016-08-26 08:15:07.669307Z] Finished download-and-extract step (success) 01:15:07 INFO - [mozharness: 2016-08-26 08:15:07.669544Z] Running populate-webroot step. 01:15:07 INFO - Running pre-action listener: _resource_record_pre_action 01:15:07 INFO - Running main action method: populate_webroot 01:15:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:15:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:15:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:15:07 INFO - '--tppagecycles', 01:15:07 INFO - '7'], 01:15:07 INFO - 'tests': ['tsvgm']}}, 01:15:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:15:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:15:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:15:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:15:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:15:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:15:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:07 INFO - 'talos_options': ['--disable-e10s'], 01:15:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:15:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:15:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:07 INFO - 'talos_options': ['--disable-e10s'], 01:15:07 INFO - 'tests': ['damp', 'tps']}, 01:15:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:07 INFO - 'tests': ['damp', 'tps']}, 01:15:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:15:07 INFO - 'tests': ['dromaeo_dom']}, 01:15:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:15:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:15:07 INFO - 'tests': ['basic_compositor_video']}, 01:15:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:15:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:15:07 INFO - 'tests': ['a11yr', 01:15:07 INFO - 'ts_paint', 01:15:07 INFO - 'tpaint', 01:15:07 INFO - 'sessionrestore', 01:15:07 INFO - 'sessionrestore_no_auto_restore', 01:15:07 INFO - 'tabpaint']}, 01:15:07 INFO - 'other-e10s': {'tests': ['a11yr', 01:15:07 INFO - 'ts_paint', 01:15:07 INFO - 'tpaint', 01:15:07 INFO - 'sessionrestore', 01:15:07 INFO - 'sessionrestore_no_auto_restore', 01:15:07 INFO - 'tabpaint']}, 01:15:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:15:07 INFO - 'ts_paint', 01:15:07 INFO - 'tpaint', 01:15:07 INFO - 'sessionrestore', 01:15:07 INFO - 'sessionrestore_no_auto_restore', 01:15:07 INFO - 'tabpaint']}, 01:15:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:15:07 INFO - 'ts_paint', 01:15:07 INFO - 'tpaint', 01:15:07 INFO - 'sessionrestore', 01:15:07 INFO - 'sessionrestore_no_auto_restore', 01:15:07 INFO - 'tabpaint']}, 01:15:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:15:07 INFO - 'tests': ['a11yr', 01:15:07 INFO - 'ts_paint', 01:15:07 INFO - 'tpaint', 01:15:07 INFO - 'sessionrestore', 01:15:07 INFO - 'sessionrestore_no_auto_restore', 01:15:07 INFO - 'tabpaint']}, 01:15:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:15:07 INFO - 'tests': ['a11yr', 01:15:07 INFO - 'ts_paint', 01:15:07 INFO - 'tpaint', 01:15:07 INFO - 'sessionrestore', 01:15:07 INFO - 'sessionrestore_no_auto_restore', 01:15:07 INFO - 'tabpaint']}, 01:15:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:15:07 INFO - 'tests': ['tsvgx', 01:15:07 INFO - 'tsvgr_opacity', 01:15:07 INFO - 'tart', 01:15:07 INFO - 'tscrollx', 01:15:07 INFO - 'cart']}, 01:15:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:15:07 INFO - 'tsvgr_opacity', 01:15:07 INFO - 'tart', 01:15:07 INFO - 'tscrollx', 01:15:07 INFO - 'cart']}, 01:15:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:07 INFO - 'talos_options': ['--disable-e10s'], 01:15:07 INFO - 'tests': ['tp5o']}, 01:15:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:07 INFO - 'tests': ['tp5o']}, 01:15:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:07 INFO - 'talos_options': ['--disable-e10s', 01:15:07 INFO - '--xperf_path', 01:15:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:15:07 INFO - 'tests': ['tp5n']}, 01:15:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:15:07 INFO - 'talos_options': ['--xperf_path', 01:15:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:15:07 INFO - 'tests': ['tp5n']}}, 01:15:07 INFO - 'talos.zip': {'path': '', 01:15:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:15:07 INFO - Running post-action listener: _resource_record_post_action 01:15:07 INFO - [mozharness: 2016-08-26 08:15:07.687904Z] Finished populate-webroot step (success) 01:15:07 INFO - [mozharness: 2016-08-26 08:15:07.687993Z] Running create-virtualenv step. 01:15:07 INFO - Running pre-action listener: _resource_record_pre_action 01:15:07 INFO - Running main action method: create_virtualenv 01:15:07 INFO - Creating virtualenv /builds/slave/test/build/venv 01:15:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:15:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:15:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:15:07 INFO - Using real prefix '/usr' 01:15:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:15:08 INFO - Installing distribute.............................................................................................................................................................................................done. 01:15:10 INFO - Installing pip.................done. 01:15:10 INFO - Return code: 0 01:15:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56ede77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e67230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61090>, '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 0x1e649b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64e40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', '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 01:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:15:10 INFO - Using env: {'DISPLAY': ':0', 01:15:10 INFO - 'HOME': '/home/cltbld', 01:15:10 INFO - 'LANG': 'en_US.UTF-8', 01:15:10 INFO - 'LANGUAGE': 'en_US:en', 01:15:10 INFO - 'LOGNAME': 'cltbld', 01:15:10 INFO - 'MAIL': '/var/mail/cltbld', 01:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:10 INFO - 'MOZ_NO_REMOTE': '1', 01:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:10 INFO - 'NO_EM_RESTART': '1', 01:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:10 INFO - 'PWD': '/builds/slave/test', 01:15:10 INFO - 'SHELL': '/bin/bash', 01:15:10 INFO - 'SHLVL': '1', 01:15:10 INFO - 'TERM': 'linux', 01:15:10 INFO - 'TMOUT': '86400', 01:15:10 INFO - 'USER': 'cltbld', 01:15:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', 01:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:10 INFO - '_': '/tools/buildbot/bin/python'} 01:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:15:10 INFO - Cleaning up... 01:15:10 INFO - Return code: 0 01:15:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56ede77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e67230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61090>, '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 0x1e649b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64e40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', '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 01:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:15:10 INFO - Using env: {'DISPLAY': ':0', 01:15:10 INFO - 'HOME': '/home/cltbld', 01:15:10 INFO - 'LANG': 'en_US.UTF-8', 01:15:10 INFO - 'LANGUAGE': 'en_US:en', 01:15:10 INFO - 'LOGNAME': 'cltbld', 01:15:10 INFO - 'MAIL': '/var/mail/cltbld', 01:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:10 INFO - 'MOZ_NO_REMOTE': '1', 01:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:10 INFO - 'NO_EM_RESTART': '1', 01:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:10 INFO - 'PWD': '/builds/slave/test', 01:15:10 INFO - 'SHELL': '/bin/bash', 01:15:10 INFO - 'SHLVL': '1', 01:15:10 INFO - 'TERM': 'linux', 01:15:10 INFO - 'TMOUT': '86400', 01:15:10 INFO - 'USER': 'cltbld', 01:15:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', 01:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:10 INFO - '_': '/tools/buildbot/bin/python'} 01:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:10 INFO - Downloading/unpacking psutil>=3.1.1 01:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:15:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:15:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:15:12 INFO - Installing collected packages: psutil 01:15:12 INFO - Running setup.py install for psutil 01:15:12 INFO - building 'psutil._psutil_linux' extension 01:15:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:15:12 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 01:15:12 INFO - building 'psutil._psutil_posix' extension 01:15:12 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 01:15:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:15:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:15:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:15:13 INFO - Successfully installed psutil 01:15:13 INFO - Cleaning up... 01:15:13 INFO - Return code: 0 01:15:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56ede77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e67230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61090>, '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 0x1e649b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64e40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', '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 01:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:15:13 INFO - Using env: {'DISPLAY': ':0', 01:15:13 INFO - 'HOME': '/home/cltbld', 01:15:13 INFO - 'LANG': 'en_US.UTF-8', 01:15:13 INFO - 'LANGUAGE': 'en_US:en', 01:15:13 INFO - 'LOGNAME': 'cltbld', 01:15:13 INFO - 'MAIL': '/var/mail/cltbld', 01:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:13 INFO - 'MOZ_NO_REMOTE': '1', 01:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:13 INFO - 'NO_EM_RESTART': '1', 01:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:13 INFO - 'PWD': '/builds/slave/test', 01:15:13 INFO - 'SHELL': '/bin/bash', 01:15:13 INFO - 'SHLVL': '1', 01:15:13 INFO - 'TERM': 'linux', 01:15:13 INFO - 'TMOUT': '86400', 01:15:13 INFO - 'USER': 'cltbld', 01:15:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', 01:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:13 INFO - '_': '/tools/buildbot/bin/python'} 01:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:15:15 INFO - Installing collected packages: mozsystemmonitor 01:15:15 INFO - Running setup.py install for mozsystemmonitor 01:15:15 INFO - Successfully installed mozsystemmonitor 01:15:15 INFO - Cleaning up... 01:15:15 INFO - Return code: 0 01:15:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56ede77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e67230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61090>, '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 0x1e649b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64e40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', '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 01:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:15:15 INFO - Using env: {'DISPLAY': ':0', 01:15:15 INFO - 'HOME': '/home/cltbld', 01:15:15 INFO - 'LANG': 'en_US.UTF-8', 01:15:15 INFO - 'LANGUAGE': 'en_US:en', 01:15:15 INFO - 'LOGNAME': 'cltbld', 01:15:15 INFO - 'MAIL': '/var/mail/cltbld', 01:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:15 INFO - 'MOZ_NO_REMOTE': '1', 01:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:15 INFO - 'NO_EM_RESTART': '1', 01:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:15 INFO - 'PWD': '/builds/slave/test', 01:15:15 INFO - 'SHELL': '/bin/bash', 01:15:15 INFO - 'SHLVL': '1', 01:15:15 INFO - 'TERM': 'linux', 01:15:15 INFO - 'TMOUT': '86400', 01:15:15 INFO - 'USER': 'cltbld', 01:15:15 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', 01:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:15 INFO - '_': '/tools/buildbot/bin/python'} 01:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:15 INFO - Downloading/unpacking jsonschema==2.5.1 01:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:15:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:17 INFO - Downloading functools32-3.2.3-2.tar.gz 01:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:15:17 INFO - warning: no files found matching '*.txt' 01:15:17 INFO - no previously-included directories found matching 'build' 01:15:17 INFO - no previously-included directories found matching 'dist' 01:15:17 INFO - no previously-included directories found matching '.git*' 01:15:17 INFO - Installing collected packages: jsonschema, functools32 01:15:17 INFO - Running setup.py install for functools32 01:15:18 INFO - warning: no files found matching '*.txt' 01:15:18 INFO - no previously-included directories found matching 'build' 01:15:18 INFO - no previously-included directories found matching 'dist' 01:15:18 INFO - no previously-included directories found matching '.git*' 01:15:18 INFO - Successfully installed jsonschema functools32 01:15:18 INFO - Cleaning up... 01:15:18 INFO - Return code: 0 01:15:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56ede77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e67230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61090>, '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 0x1e649b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64e40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', '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 01:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:15:18 INFO - Using env: {'DISPLAY': ':0', 01:15:18 INFO - 'HOME': '/home/cltbld', 01:15:18 INFO - 'LANG': 'en_US.UTF-8', 01:15:18 INFO - 'LANGUAGE': 'en_US:en', 01:15:18 INFO - 'LOGNAME': 'cltbld', 01:15:18 INFO - 'MAIL': '/var/mail/cltbld', 01:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:18 INFO - 'MOZ_NO_REMOTE': '1', 01:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:18 INFO - 'NO_EM_RESTART': '1', 01:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:18 INFO - 'PWD': '/builds/slave/test', 01:15:18 INFO - 'SHELL': '/bin/bash', 01:15:18 INFO - 'SHLVL': '1', 01:15:18 INFO - 'TERM': 'linux', 01:15:18 INFO - 'TMOUT': '86400', 01:15:18 INFO - 'USER': 'cltbld', 01:15:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', 01:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:18 INFO - '_': '/tools/buildbot/bin/python'} 01:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:15:18 INFO - Cleaning up... 01:15:18 INFO - Return code: 0 01:15:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56ede77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e67230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61090>, '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 0x1e649b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64e40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', '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 01:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:15:18 INFO - Using env: {'DISPLAY': ':0', 01:15:18 INFO - 'HOME': '/home/cltbld', 01:15:18 INFO - 'LANG': 'en_US.UTF-8', 01:15:18 INFO - 'LANGUAGE': 'en_US:en', 01:15:18 INFO - 'LOGNAME': 'cltbld', 01:15:18 INFO - 'MAIL': '/var/mail/cltbld', 01:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:18 INFO - 'MOZ_NO_REMOTE': '1', 01:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:18 INFO - 'NO_EM_RESTART': '1', 01:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:18 INFO - 'PWD': '/builds/slave/test', 01:15:18 INFO - 'SHELL': '/bin/bash', 01:15:18 INFO - 'SHLVL': '1', 01:15:18 INFO - 'TERM': 'linux', 01:15:18 INFO - 'TMOUT': '86400', 01:15:18 INFO - 'USER': 'cltbld', 01:15:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', 01:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:18 INFO - '_': '/tools/buildbot/bin/python'} 01:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:18 INFO - Downloading/unpacking blobuploader==1.2.4 01:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:20 INFO - Downloading blobuploader-1.2.4.tar.gz 01:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:15:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:15:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:21 INFO - Downloading docopt-0.6.1.tar.gz 01:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:15:21 INFO - Installing collected packages: blobuploader, requests, docopt 01:15:21 INFO - Running setup.py install for blobuploader 01:15:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:15:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:15:21 INFO - Running setup.py install for requests 01:15:21 INFO - Running setup.py install for docopt 01:15:21 INFO - Successfully installed blobuploader requests docopt 01:15:21 INFO - Cleaning up... 01:15:21 INFO - Return code: 0 01:15:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56ede77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e67230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61090>, '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 0x1e649b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64e40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', '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 01:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:15:21 INFO - Using env: {'DISPLAY': ':0', 01:15:21 INFO - 'HOME': '/home/cltbld', 01:15:21 INFO - 'LANG': 'en_US.UTF-8', 01:15:21 INFO - 'LANGUAGE': 'en_US:en', 01:15:21 INFO - 'LOGNAME': 'cltbld', 01:15:21 INFO - 'MAIL': '/var/mail/cltbld', 01:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:21 INFO - 'MOZ_NO_REMOTE': '1', 01:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:21 INFO - 'NO_EM_RESTART': '1', 01:15:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:21 INFO - 'PWD': '/builds/slave/test', 01:15:21 INFO - 'SHELL': '/bin/bash', 01:15:21 INFO - 'SHLVL': '1', 01:15:21 INFO - 'TERM': 'linux', 01:15:21 INFO - 'TMOUT': '86400', 01:15:21 INFO - 'USER': 'cltbld', 01:15:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', 01:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:21 INFO - '_': '/tools/buildbot/bin/python'} 01:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:15:22 INFO - Running setup.py (path:/tmp/pip-1dtz9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:15:22 INFO - Running setup.py (path:/tmp/pip-RS7wCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:15:22 INFO - Running setup.py (path:/tmp/pip-pZyP6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:15:22 INFO - Running setup.py (path:/tmp/pip-mtyDR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:15:22 INFO - Running setup.py (path:/tmp/pip-Z1sp7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:15:22 INFO - Running setup.py (path:/tmp/pip-F7Vbzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:15:22 INFO - Running setup.py (path:/tmp/pip-ZSOOJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:15:22 INFO - Running setup.py (path:/tmp/pip-gUs0wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:15:22 INFO - Running setup.py (path:/tmp/pip-LVz06a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:15:22 INFO - Running setup.py (path:/tmp/pip-1KtXpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:15:22 INFO - Running setup.py (path:/tmp/pip-WZ3sKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:15:22 INFO - Running setup.py (path:/tmp/pip-6A0clX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:15:22 INFO - Running setup.py (path:/tmp/pip-z6Xkqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:15:22 INFO - Running setup.py (path:/tmp/pip-9PeJ6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:15:23 INFO - Running setup.py (path:/tmp/pip-II13kX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:15:23 INFO - Running setup.py (path:/tmp/pip-WmQTzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:15:23 INFO - Running setup.py (path:/tmp/pip-UcLx7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:15:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:15:23 INFO - Running setup.py install for manifestparser 01:15:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:15:23 INFO - Running setup.py install for mozcrash 01:15:23 INFO - Running setup.py install for mozdebug 01:15:23 INFO - Running setup.py install for mozdevice 01:15:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:15:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:15:23 INFO - Running setup.py install for mozfile 01:15:23 INFO - Running setup.py install for mozhttpd 01:15:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:15:23 INFO - Running setup.py install for mozinfo 01:15:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:15:23 INFO - Running setup.py install for mozInstall 01:15:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:15:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:15:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:15:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:15:24 INFO - Running setup.py install for mozleak 01:15:24 INFO - Running setup.py install for mozlog 01:15:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:15:24 INFO - Running setup.py install for moznetwork 01:15:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:15:24 INFO - Running setup.py install for mozprocess 01:15:24 INFO - Running setup.py install for mozprofile 01:15:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:15:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:15:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:15:24 INFO - Running setup.py install for mozrunner 01:15:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:15:24 INFO - Running setup.py install for mozscreenshot 01:15:24 INFO - Running setup.py install for moztest 01:15:24 INFO - Running setup.py install for mozversion 01:15:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:15:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:15:25 INFO - Cleaning up... 01:15:25 INFO - Return code: 0 01:15:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56ede77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e67230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61090>, '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 0x1e649b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64e40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', '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 01:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:15:25 INFO - Using env: {'DISPLAY': ':0', 01:15:25 INFO - 'HOME': '/home/cltbld', 01:15:25 INFO - 'LANG': 'en_US.UTF-8', 01:15:25 INFO - 'LANGUAGE': 'en_US:en', 01:15:25 INFO - 'LOGNAME': 'cltbld', 01:15:25 INFO - 'MAIL': '/var/mail/cltbld', 01:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:25 INFO - 'MOZ_NO_REMOTE': '1', 01:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:25 INFO - 'NO_EM_RESTART': '1', 01:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:25 INFO - 'PWD': '/builds/slave/test', 01:15:25 INFO - 'SHELL': '/bin/bash', 01:15:25 INFO - 'SHLVL': '1', 01:15:25 INFO - 'TERM': 'linux', 01:15:25 INFO - 'TMOUT': '86400', 01:15:25 INFO - 'USER': 'cltbld', 01:15:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', 01:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:25 INFO - '_': '/tools/buildbot/bin/python'} 01:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:15:25 INFO - Running setup.py (path:/tmp/pip-MbLBDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:15:25 INFO - Running setup.py (path:/tmp/pip-Yi8Sli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:15:25 INFO - Running setup.py (path:/tmp/pip-VCDBid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:15:25 INFO - Running setup.py (path:/tmp/pip-TbScdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:15:25 INFO - Running setup.py (path:/tmp/pip-Zae9LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:15:25 INFO - Running setup.py (path:/tmp/pip-zQ_Y2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:15:25 INFO - Running setup.py (path:/tmp/pip-aGf4Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:15:25 INFO - Running setup.py (path:/tmp/pip-3T81lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:15:25 INFO - Running setup.py (path:/tmp/pip-cP6MLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:15:25 INFO - Running setup.py (path:/tmp/pip-Ik56gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:15:25 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)) 01:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:15:25 INFO - Running setup.py (path:/tmp/pip-6B08Vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:15:26 INFO - Running setup.py (path:/tmp/pip-EI3Wkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:15:26 INFO - Running setup.py (path:/tmp/pip-44Azhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:15:26 INFO - Running setup.py (path:/tmp/pip-N_DYSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:15:26 INFO - Running setup.py (path:/tmp/pip-ln4rzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:15:26 INFO - Running setup.py (path:/tmp/pip-rVRJZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:15:26 INFO - Running setup.py (path:/tmp/pip-IIwros-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:15:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:15:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:15:28 INFO - Downloading blessings-1.6.tar.gz 01:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:15:28 INFO - Installing collected packages: blessings 01:15:28 INFO - Running setup.py install for blessings 01:15:28 INFO - Successfully installed blessings 01:15:28 INFO - Cleaning up... 01:15:28 INFO - Return code: 0 01:15:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:15:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:15:29 INFO - Reading from file tmpfile_stdout 01:15:29 INFO - Current package versions: 01:15:29 INFO - argparse == 1.2.1 01:15:29 INFO - blessings == 1.6 01:15:29 INFO - blobuploader == 1.2.4 01:15:29 INFO - docopt == 0.6.1 01:15:29 INFO - functools32 == 3.2.3-2 01:15:29 INFO - jsonschema == 2.5.1 01:15:29 INFO - manifestparser == 1.1 01:15:29 INFO - mozInstall == 1.12 01:15:29 INFO - mozcrash == 0.17 01:15:29 INFO - mozdebug == 0.1 01:15:29 INFO - mozdevice == 0.48 01:15:29 INFO - mozfile == 1.2 01:15:29 INFO - mozhttpd == 0.7 01:15:29 INFO - mozinfo == 0.9 01:15:29 INFO - mozleak == 0.1 01:15:29 INFO - mozlog == 3.3 01:15:29 INFO - moznetwork == 0.27 01:15:29 INFO - mozprocess == 0.23 01:15:29 INFO - mozprofile == 0.28 01:15:29 INFO - mozrunner == 6.12 01:15:29 INFO - mozscreenshot == 0.1 01:15:29 INFO - mozsystemmonitor == 0.3 01:15:29 INFO - moztest == 0.7 01:15:29 INFO - mozversion == 1.4 01:15:29 INFO - psutil == 3.1.1 01:15:29 INFO - requests == 1.2.3 01:15:29 INFO - wsgiref == 0.1.2 01:15:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:29 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 0x7f56ede77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e67230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61090>, '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 0x1e649b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64e40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', '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 01:15:29 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 01:15:29 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 01:15:29 INFO - Using env: {'DISPLAY': ':0', 01:15:29 INFO - 'HOME': '/home/cltbld', 01:15:29 INFO - 'LANG': 'en_US.UTF-8', 01:15:29 INFO - 'LANGUAGE': 'en_US:en', 01:15:29 INFO - 'LOGNAME': 'cltbld', 01:15:29 INFO - 'MAIL': '/var/mail/cltbld', 01:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:29 INFO - 'MOZ_NO_REMOTE': '1', 01:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:29 INFO - 'NO_EM_RESTART': '1', 01:15:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:29 INFO - 'PWD': '/builds/slave/test', 01:15:29 INFO - 'SHELL': '/bin/bash', 01:15:29 INFO - 'SHLVL': '1', 01:15:29 INFO - 'TERM': 'linux', 01:15:29 INFO - 'TMOUT': '86400', 01:15:29 INFO - 'USER': 'cltbld', 01:15:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', 01:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:29 INFO - '_': '/tools/buildbot/bin/python'} 01:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:15:29 INFO - Cleaning up... 01:15:29 INFO - Return code: 0 01:15:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:15:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56ede77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e67230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61090>, '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 0x1e649b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64e40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', '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 01:15:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:15:29 INFO - Using env: {'DISPLAY': ':0', 01:15:29 INFO - 'HOME': '/home/cltbld', 01:15:29 INFO - 'LANG': 'en_US.UTF-8', 01:15:29 INFO - 'LANGUAGE': 'en_US:en', 01:15:29 INFO - 'LOGNAME': 'cltbld', 01:15:29 INFO - 'MAIL': '/var/mail/cltbld', 01:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:29 INFO - 'MOZ_NO_REMOTE': '1', 01:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:29 INFO - 'NO_EM_RESTART': '1', 01:15:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:29 INFO - 'PWD': '/builds/slave/test', 01:15:29 INFO - 'SHELL': '/bin/bash', 01:15:29 INFO - 'SHLVL': '1', 01:15:29 INFO - 'TERM': 'linux', 01:15:29 INFO - 'TMOUT': '86400', 01:15:29 INFO - 'USER': 'cltbld', 01:15:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', 01:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:29 INFO - '_': '/tools/buildbot/bin/python'} 01:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:15:29 INFO - Cleaning up... 01:15:29 INFO - Return code: 0 01:15:29 INFO - Running post-action listener: _resource_record_post_action 01:15:29 INFO - Running post-action listener: _start_resource_monitoring 01:15:29 INFO - Starting resource monitoring. 01:15:29 INFO - [mozharness: 2016-08-26 08:15:29.545001Z] Finished create-virtualenv step (success) 01:15:29 INFO - [mozharness: 2016-08-26 08:15:29.545631Z] Running install step. 01:15:29 INFO - Running pre-action listener: _resource_record_pre_action 01:15:29 INFO - Running main action method: install 01:15:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:15:29 INFO - Reading from file tmpfile_stdout 01:15:29 INFO - Detecting whether we're running mozinstall >=1.0... 01:15:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:15:29 INFO - Reading from file tmpfile_stdout 01:15:29 INFO - Output received: 01:15:29 INFO - Usage: mozinstall [options] installer 01:15:29 INFO - Options: 01:15:29 INFO - -h, --help show this help message and exit 01:15:29 INFO - -d DEST, --destination=DEST 01:15:29 INFO - Directory to install application into. [default: 01:15:29 INFO - "/builds/slave/test"] 01:15:29 INFO - --app=APP Application being installed. [default: firefox] 01:15:29 INFO - mkdir: /builds/slave/test/build/application 01:15:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:15:46 INFO - Reading from file tmpfile_stdout 01:15:46 INFO - Output received: 01:15:46 INFO - /builds/slave/test/build/application/firefox/firefox 01:15:46 INFO - Running post-action listener: _resource_record_post_action 01:15:46 INFO - [mozharness: 2016-08-26 08:15:46.831004Z] Finished install step (success) 01:15:46 INFO - [mozharness: 2016-08-26 08:15:46.831252Z] Running run-tests step. 01:15:46 INFO - Running pre-action listener: _resource_record_pre_action 01:15:46 INFO - Running main action method: run_tests 01:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:15:46 INFO - Python 2.7.3 01:15:46 INFO - Return code: 0 01:15:46 INFO - grabbing minidump binary from tooltool 01:15:46 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')]} 01:15:46 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 0x1e61090>, '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 0x1e649b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e64e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:15:46 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 01:15:46 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 01:15:46 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 01:15:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:15:46 INFO - Return code: 0 01:15:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:15:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:15:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:15:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:15:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 01:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 01:15:46 INFO - Using env: {'DISPLAY': ':0', 01:15:46 INFO - 'HOME': '/home/cltbld', 01:15:46 INFO - 'LANG': 'en_US.UTF-8', 01:15:46 INFO - 'LANGUAGE': 'en_US:en', 01:15:46 INFO - 'LOGNAME': 'cltbld', 01:15:46 INFO - 'MAIL': '/var/mail/cltbld', 01:15:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:15:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:46 INFO - 'MOZ_NO_REMOTE': '1', 01:15:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:46 INFO - 'NO_EM_RESTART': '1', 01:15:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:46 INFO - 'PWD': '/builds/slave/test', 01:15:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:15:46 INFO - 'SHELL': '/bin/bash', 01:15:46 INFO - 'SHLVL': '1', 01:15:46 INFO - 'TERM': 'linux', 01:15:46 INFO - 'TMOUT': '86400', 01:15:46 INFO - 'USER': 'cltbld', 01:15:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414', 01:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:46 INFO - '_': '/tools/buildbot/bin/python'} 01:15:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 01:15:47 INFO - mozversion application_buildid: 20160825223021 01:15:47 INFO - mozversion application_changeset: e78454e242072bbcada626874f2900bbe1c3e647 01:15:47 INFO - mozversion application_display_name: Nightly 01:15:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:15:47 INFO - mozversion application_name: Firefox 01:15:47 INFO - mozversion application_remotingname: firefox 01:15:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:15:47 INFO - mozversion application_vendor: Mozilla 01:15:47 INFO - mozversion application_version: 51.0a1 01:15:47 INFO - mozversion platform_buildid: 20160825223021 01:15:47 INFO - mozversion platform_changeset: e78454e242072bbcada626874f2900bbe1c3e647 01:15:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:15:47 INFO - mozversion platform_version: 51.0a1 01:15:47 INFO - using testdate: 1472199347 01:15:47 INFO - actual date: 1472199347 01:15:47 INFO - starting webserver on 'localhost:58647' 01:15:47 INFO - SUITE-START | Running 2 tests 01:15:47 INFO - TEST-START | dromaeo_css 01:15:47 INFO - operating with platform_type : linux_ 01:15:47 INFO - Initialising browser for dromaeo_css test... 01:15:47 INFO - TEST-INFO | started process 25913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg46Fzs/profile http://localhost:58647/getInfo.html) 01:15:51 INFO - PROCESS | 25913 | __metrics Screen width/height:1600/1200 01:15:51 INFO - PROCESS | 25913 | colorDepth:24 01:15:51 INFO - PROCESS | 25913 | Browser inner width/height: 1024/697 01:15:51 INFO - PROCESS | 25913 | __metrics 01:15:52 ERROR - PROCESS | 25913 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 01:15:53 INFO - TEST-INFO | 25913: exit 0 01:15:53 INFO - Browser initialized. 01:15:53 INFO - Running cycle 1/1 for dromaeo_css test... 01:15:53 INFO - TEST-INFO | started process 26034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg46Fzs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:16:05 INFO - PROCESS | 26034 | RSS: Main: 191201280 01:16:05 INFO - PROCESS | 26034 | 01:16:54 INFO - PROCESS | 26034 | 1472199414863 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] 01:19:04 INFO - PROCESS | 26034 | Cycle 1(1): loaded http://localhost:58647/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58647/tests/dromaeo/cssquery-ext.html) 01:19:05 INFO - PROCESS | 26034 | RSS: Main: 206655488 01:19:05 INFO - PROCESS | 26034 | 01:22:07 INFO - PROCESS | 26034 | Cycle 1(1): loaded http://localhost:58647/tests/dromaeo/cssquery-ext.html (next: http://localhost:58647/tests/dromaeo/cssquery-jquery.html) 01:22:08 INFO - PROCESS | 26034 | RSS: Main: 201969664 01:22:08 INFO - PROCESS | 26034 | 01:25:10 INFO - PROCESS | 26034 | Cycle 1(1): loaded http://localhost:58647/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58647/tests/dromaeo/cssquery-mootools.html) 01:25:10 INFO - PROCESS | 26034 | RSS: Main: 197705728 01:25:10 INFO - PROCESS | 26034 | 01:28:12 INFO - PROCESS | 26034 | Cycle 1(1): loaded http://localhost:58647/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58647/tests/dromaeo/cssquery-prototype.html) 01:28:13 INFO - PROCESS | 26034 | RSS: Main: 194330624 01:28:13 INFO - PROCESS | 26034 | 01:31:15 INFO - PROCESS | 26034 | Cycle 1(1): loaded http://localhost:58647/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58647/tests/dromaeo/cssquery-yui.html) 01:31:16 INFO - PROCESS | 26034 | RSS: Main: 197439488 01:31:16 INFO - PROCESS | 26034 | 01:34:18 INFO - PROCESS | 26034 | Cycle 1(1): loaded http://localhost:58647/tests/dromaeo/cssquery-yui.html (next: http://localhost:58647/tests/dromaeo/cssquery-dojo.html) 01:34:19 INFO - PROCESS | 26034 | RSS: Main: 198787072 01:34:19 INFO - PROCESS | 26034 | 01:34:19 INFO - PROCESS | 26034 | __start_tp_report 01:34:19 INFO - PROCESS | 26034 | _x_x_mozilla_page_load 01:34:19 INFO - PROCESS | 26034 | _x_x_mozilla_page_load_details 01:34:19 INFO - PROCESS | 26034 | |i|pagename|runs| 01:34:19 INFO - PROCESS | 26034 | |0;dojo.html;3064.2952121012167;3091.1499337682135;3108.2074071111865;3146.842657867106;3152.747780177586;5403.378611459683;5444.128939369702;5468.7812487500505;5483.780648774049;5512.641678290908;5486.451354864512;5502.614816962814;5505.449455054492;5539.806106786264;5550.27846379971;4930.260460930862;5000.699958002513;5011.574016208627;5031.698098114107;5068.4424713281505;4589.380433641466;5033.094043072246;5046.171528218123;5048.545630893219;5101.183810590306;4861.319415281846;4873.780679869415;4894;4919.11455937931;4937.456879743261;4950.183219768734;4962.280469331963;4965.677230979974;4980.576650984671;5018.121828680003;4878.609711223094;4905.2151655734915;4918.483559226302;4923.901521969577;4975.7263350515705;5318;5431.782728690848;5531.0873705838485;5543.057680194376;5547.278853749027;5879.176915231871;5894.97052514739;5896.7936122235515;5900.4984576310635;5932.19915311436;5921.141434492018;5923.763049478016;5931.258592675916;5933.397982544732;5937.8812423751715;5375.569954403677;5496.725163741837;5499.560035197174;5507.779688812403;5548.639338442988;6064.423879731418;6095.559247229214;6096.542759292982;6105.997654215468;6108.677166059137;5753.33836608787;5786.797462088806;5788.942110578841;5790.160426738099;5856.648601083949;5698.601097923189;5871.236739223959;5890;5926.762929482858;5938.317093534212;5891.852703682443;5906.822795316061;5908.822735317947;5909.113632955091;5923.259592550931;5935.317438494542;5950.256217972754;5964.671943043088;5965.194698715704;5971.671558064349;4467.15124126415;4494.955050449519;4524.773761311922;4530.343100250445;4552.430946131733;4031.1534577738416;4038.3336749436603;4045.110075783323;4048.736832105904;4075.612816782401;5618.91571626426;5648.74580643872;5671.120976248688;5672.546196304285;5715.799947001835;5707.828765137053;5851.502622277154;5888.61723987948;5937.7921772737745;5941.940580594225;5554.000279949648;5561.610687251854;5646.322441307069;5660.235868157828;5680.403557626472;5090.9236361454605;5091.541761241506;5100.974495127575;5125.538701516882;5208.661437006583;5911.615744976562;6045.697715114139;6082;6090.33006369299;6104.755809767559;5920.141579471038;5925.377835327228;5936.079907614327;5939;5982.341942386421;6086.72609732572;6090.147379366981;6093.6039157454625;6097.634141951497;6109.419605137505;5654.688992105309;5706.9714651426475;5711.371749107512;5790.305163380422;5836.503897168788;5838.795642152504;5846.035404158266;5869.53043756507;5906.852328691817;5924.170616113834;5729.083346664514;5768.855778605568;5783.681897495678;5846.590738648254;5885.705714714161;5718.1136923776885;5743.770249190153;5754.309482862083;5755.8561035974435;5759.136129580596;5561.582881284001;5689.687067211177;5764.827055188351;5769.903718293511;5772.336181339199;5758.798442054508;5804.970975145097;5834.766609335579;5914.526837853047;5915.08316210988;5681.261436013292;5713.143028545585;5720.056190728649;5727.570432217683;5742.712864356849 01:34:19 INFO - PROCESS | 26034 | |1;ext.html;568.7895478672889;576.084026398027;590.5275779376498;610.7556977209116;635.5868685354521;38610.61389386105;39812.40281395778;42955.57044429555;43057.35413968793;43303;43504.347434788506;44063.77968110163;44398.778006110006;44438;44528;8736.432131911406;8955.641774329019;8962.507062111581;8987.505687187202;9013.459192448441;8673.349498787584;8706;8784.51685157316;8786.86819697705;8807.383483156182;8664.176903194219;8701.216890479856;8724.083971182998;8759.2992560595;8795.384323097354;8763.737087887373;8789.472631642122;8799.340049496313;8806.119388061206;8820.338474614398;8869.113088691143;8936.8659470108;8937.731868043904;8958.686445974425;8960.641574337084;40604.59395406038;40968.38547421791;41143.38284925729;41178.38232426516;41200;3328.334333133383;3540.0972751948348;3599.5680518337967;3680.300742858848;3958.168784555247;32325.83837080823;32392.35215295681;32471.025869223962;32521.186970325933;32801.50797738036;3916.7454115482687;4045.2314060328445;4063.97968010161;4070.2266569352023;4090.406891000818;359186;360106;360184;360336;361059;33791.155221119174;57022.42977570254;57064.42935570591;57130.42869571251;57302.7134864323;36106.8194659025;37698.24603507969;37706.62293377031;37825.05437364088;38044;15619.140947247783;15645.061296322257;15689.764653530206;15774.526764197093;15783.684326313409;12986.935065324613;13024.739505209844;13038.608841734764;13063.216207027608;13102.541411050568;8509.65961361551;8621.715245459958;8680.73957781255;8727.04002559718;8753.431026983226;3345.2138747394342;3400.2179498715436;3406.454967205285;3418.8119653418803;3443.5241151157975;1010.4846528270488;1011.7116621762763;1041.776018156085;1085.945702714861;1103.089950790601;31449.056528304187;31771.364572708415;31867;31902.202444938597;32393.838030810166;1070.9143268538498;1077.8706555213425;1086.3319058778793;1109.5395410904384;1131.3890499130378;15972.76040859388;16708.49874503767;16736.6652666946;16882.577935551464;16958.321667133423;573000;573091.941782044;575934;575954;577464;57011;57102;57791.13313300304;57791.71104144453;57847.710761445924;1307.9673008174873;1358.2665360705307;1368.206440264644;1370.8080868678394;1373.5467295792364;29810;30312.5453118199;30771.230719232197;30778;31037.689623104383;50176.749116254185;50330;50514.242286365;50523;50592;443723;446057;447278;450317;451399;28061.57907631428;28467.430651386443;28494.715052850035;28555;28605.14184574466;47094;48013.75993120012;48100;48109.27836082392;48546.27180592223;38941.80529097337;39803.2039359217;40350.39474407827;40388.59611403966;41854.37218441665;41893.37159942542;41902;42158.78920605377;42284.57715422806;42754.57245427506;39663;40705;40739;40820.59179408168;43279.78360108179;34583.30833383369;37812.243755125295;38151.61848381592;39023.0266606109;39153.41269880897;28078.157655270374;28334.574981374884;28474;28868.42263154767;28902.855485722437 01:34:19 INFO - PROCESS | 26034 | |2;jquery.html;398.5177934699014;402.53105132520614;406.81896556032564;409.9651529619983;424.05012771392074;13824.308784560782;18696.15867285972;19467.805321946777;20276.89861550692;20374;18389.356372526963;19115.904420477913;19117.904410477964;19183.808161918376;19437.902810485964;5155.613329000321;5361.356637203541;5760.452756988079;5786.797462088828;5809.535237181015;5677.801276955307;5779.219805326269;5785.132230165488;5795.3045634523705;5796.5652576056755;5652.830415087534;5863;5912.645241285515;6006.579539432241;6037.094435834638;5748.109043098327;5854.707264636793;5922.2597175353085;5939.7921072762465;5983.730732117044;5655.179998900177;5675.602707810455;5687.601867869251;5710.857228569277;5724.656520608777;14049.78925316121;14259;14297.49958751449;14300.499482518062;14383.065100768417;2347.225415612844;2378.595638741418;2404.5551572959057;2477.826552141351;2901.7678585713093;14311.35598898052;14522.419103235858;14639;14773;15119.47081852141;1884.6984482482874;1960.6372821028156;1971.7141014552953;1997.3808119482862;2008.4476768888526;84817;86389.56805215997;87498.12501874963;89283;91277.99999999933;11094.1124710023;11320.773584528264;11402.258853174517;11704.94147529257;11729.296242225322;15854.128022958617;15864.795829105296;15867.682646347008;15928.283227254802;16005.199740013186;8047.476914000688;8558.186972237627;8570.4000719949;8664.653413863502;8689.782755431039;8135.633896474673;8261.83476330482;8307;8443.915560844312;8529.530875801767;4817.108834865491;4851.248056551241;4869.391326084239;4931.802727890916;4935.679180853233;1992.8306093981885;2053.0966374795044;2069.772325044274;2075.3981345409966;2103.589799989018;916.8716379706847;919.9328778616773;952.1288021460286;996.566493575297;1021.9795604087876;17890.731639025424;19044.71432928507;19190.13644386006;19573.804261957484;19767.901160494104;985.940843549375;988.9950550247203;997.2271489595477;1010.8180527505119;1026.1893104447404;10238.699746106653;10792.46037698112;10915.781684366268;10933.945330273456;10949.397783121845;414640;418296;429618;434191;434653;93056;97372;97603.51198243964;97864.61744604116;98306.5084674572;975.331897650112;1006.993006993007;1010.4695035106481;1039.0700323210835;1041.0214398465419;16462.83537164613;16664.41674541385;16968.32126714967;17084.40204592833;17482.30070797205;39993.60006400015;41163.38254926239;41437.171256575304;42010;42254.366184506645;55278.72360638332;56843;57135.42864571301;57339.42660573341;57803.4219657798;8512.191341822518;8519.3184545235;8642.740717778477;8763.956180219058;8777.824443511221;9211.217046551119;12218.51125954952;12838.743225135258;13350;13369.26469044212;10985.835212471979;11047.558097676003;11107.94446027797;11277.943610281896;12168.391580421121;11360.375179365214;11418.429078545872;11783.293002419883;11907.226030308002;12043.578474753342;11401.657950261506;11761.176717629683;12082.577109801116;12220.816687749513;12275.263484190977;7451.962740186264;7850.842983140191;8609.397342185986;8726.083761204982;8747.91252087471;11568.595099171489;11792.941035294769;11832.645020649394;12072.637820865388;12295 01:34:19 INFO - PROCESS | 26034 | |3;mootools.html;1461.269365317341;1473.8305094914085;1624.9113094226866;1739.0000749569;1775.8135395783443;8050.275475207231;8776.956115219415;8844.955775221122;9575.186109180719;9580.185684216842;8923.107689231074;9291.442513449198;9292.67475638351;9297.674581389652;9313.720588382359;2443.035001174535;2468.395243165418;2470.468849197422;2479.590867506859;2482.503499300138;2383.2731017039796;2485.962710559343;2500.712418071918;2501.7873480754156;2506.248125562333;2447.90208391665;2449.742777008415;2495.15164843953;2496.051500429834;2496.325991982164;2410.2769169249154;2420.2739178246543;2432.2946345559767;2433.0997530913496;2437.2566367257978;2401.5677178107935;2414.6136618141013;2417.033186725306;2417.7703118203744;2436.3421876093357;9328.300377471716;9359.719208423758;9419.717408477756;9426.670066547638;9480.146786789222;5355.705436201008;5452.863678408032;5459.317585301837;5468.835934921959;5485.780568777244;3402.6937575618067;3550.14796448853;3612.096975756061;3659.2864391443677;3659.9085022874374;1170.9882901170965;1197.383347575999;1209.9516019359214;1214.6538236602614;1236.5733821831454;13056.543020994219;13056.543020994219;13143.934280328633;13217;13262.734745305137;4432.246518091933;4685.1332503486965;4793.113274044313;4854.563089321978;4881.072596206709;10946.890531094747;10965.451727413598;11005.339679619248;11018.779624407467;11022.834657480144;5444.455554444524;5455.427180146107;5455.563554915597;5464.043792336325;5471.23402723619;4344.218040752695;4873.512648735098;4983.950160498421;5001.8499445016705;5009.223570346602;4110.609492098246;4137.27424905135;4159.480064991876;4180.829367777027;4204.873853784391;1239.5537606461667;1247.5321754342121;1271.5740227023866;1299.883010529057;1300.0834411739702;959.3907868503551;970.5632465390461;982.7199248214367;982.921366290695;990.9058639429243;5827.7668893244645;5948.137520059654;5978.85052873673;6060.515158787286;6108.144859719643;461.82219845359106;466.3820437919702;471.6792979656947;485.15582885779196;487.25936576403666;4250.404943307939;4297.72064815786;4325.8269669213505;4369.868903932887;4387.298032314814;11041;11396.886031139748;11469.31184128955;11478.253913495597;11592.536298547964;10323.48382580868;10814.29707069038;10872.619458319079;10971.561137554409;11431.14266430021;8507.447015943944;8585.356098292654;8650.95674521636;8795.692150774692;8835.69075082369;6228.480908286803;6414.775482858077;6424.743010279536;6440.806775796734;6616.172978377703;10434.217433692655;10786.946065269623;10792.892071079188;10955.397453140155;11018.1185505161;10658.946705266424;10859.782804343711;10868.891311086787;10924.836127457935;11016;7855.960720196363;8585.399022068395;8600.741977740678;8631.956840215758;8825;8953.820923581623;8953.910460895308;8964.14840590143;8988.685396011108;8992.820143597222;8115.715949941724;8120.512769233865;8204.589770511331;8226.465279756796;8340.624671889658;7835.37317014626;7879.448438609243;8030.63862126194;8057.677692892219;8214.58927053657;7112.822179445555;7204.0994875640545;7240.05879235696;7290.708371665074;7435.8141046474275;5312.681239125664;5345.705986170798;5350.598705097055;5418.539424148991;5439.238506608999;4808.447028591757;4824.855254342376;4833;4875.219964805756;4898.534639209412 01:34:19 INFO - PROCESS | 26034 | |4;prototype.html;326.3375348043471;334.9832508374581;335.7247057412922;345.7666075399105;346.8543211851022;5405.324334458192;5550.278463799706;5585.8603534911645;5604.131359639257;5629.39562224766;5476.26070480485;5487.945120548803;5496;5503.679117011919;5505.724713764316;4267.893302667435;4269.402283680287;4274.273373526508;4275.700700950934;4300.462442194726;4155.854545090922;4217.671433498454;4218.282891908368;4296.677749168809;4307.224699554079;4184.811683474251;4186.497620285555;4186.727862688931;4194.706370554062;4208.978955105235;4184.497860256758;4202.243596152706;4207.116505533811;4215.620594146526;4235.322348424237;3691.3909204981146;3692.1877187018813;3694.501242332278;3700.6299370063048;3707.8516859325596;5206.947930520684;5265.499777521168;5266.7366631668265;5340.973295133538;5384;4791.993681326926;4803.207470767319;4808.182608956451;4822.373091498082;4879.780409881529;5562.415946325618;5717.771289148429;5770.365259821417;5779.971100144515;5782.10377391505;3992.86024989124;3995.1610161866042;4001.359782434826;4004.199160167949;4039.636432721069;5946.643201407929;6006.759729610811;6034.487068599175;6043.697815109227;6056.818295451099;4033.979830100831;4114.0948991221885;4114.403411505315;4115.464989551399;4155.293600087993;3949.4075888616935;4160.167966406731;4161.834686287844;4188.790560471964;4195.370694395865;4815.662903596784;4824.179889418807;4846.321514987904;4850.423612326008;4884.535969082932;5755.841559415219;5766.135079738073;5775.971120144372;5833.300003999547;5841.240638716939;1398.3707331700775;1446.5226475263348;1453.1353844462528;1454.7599646058281;1456.730504856605;876.9342299327449;908.6637943960644;908.9681861134828;910.4264313482596;927.3230541704594;4841;4849.345338379274;4870.683405578626;4889.804407823718;4931.630127740434;5051.772670229849;5124.950019992033;5166.545890701962;5176.844694659167;5197.168453047494;4905.5283414975365;4971.428285747185;4973.776180071905;4988.825391111293;5183.844484665466;3097.566340712302;3131.4050330437144;3144.9685503145133;3156.210947263184;3170.1916011416943;6119.450718583211;6140.850702254175;6161.383861613893;6162.22972128484;6181.392837862189;5965.55258355625;5974;5984.970075149597;5998.820035398945;6027.30685971119;6081.908771368433;6082.813851298954;6095.817125486243;6116.969415152985;6128.601640893327;5553.250311207935;5882.764689412375;5932.228810254639;5936.970315148396;5951.464368206882;5873.823785286449;5899.734511947058;5906;5909;5923.289205295392;6153.461634591352;6162.506999439945;6170.382961703974;6176.382361763787;6191.938080619136;3979.8607048753156;4061.5329237136925;4146.5853414658295;4163.916721665611;4175.102352994121;5808.718074288014;5812.651240925558;5872.911906321494;5897.321807992136;5911.940880591139;5692.971535142297;5727.391743201756;5741.511971482304;5757.481826635623;5784.392638773036;5547.08777891594;5705.4009329019855;5729.28383952006;5730.828075157752;5749.568782341425;5764.337101233412;5779.768809247583;5791.059994901755;5804.564657650778;5817.731084876817;5436.972815135899;5724.799632013026;5749.712514374348;5794.82615521535;5867.266591676041;5638.295213098363;5642.125470552071;5663.490285874291;5681.857953551194;5710.457506536873 01:34:19 INFO - PROCESS | 26034 | |5;yui.html;682.8054004608688;757.5833291689569;765.9502132361396;792.6789650191671;829.0962850492962;14774.556763297105;14797.408103675867;15061.246937653128;15477.845221547781;15840.920795396021;14668;14706.63233419165;14744.33650485728;14766.483173088916;14780.704385912275;793.2900054451262;801.9839603207947;821.9876701849477;823.8970128733908;824.5217773691245;818.664347617477;825.8018075661828;831.0359982420393;831.9209675080888;831.9750407487754;852.0882655558555;860.2730692564804;862.2843040276587;864.1617630898019;867.9566021698921;857.995710021449;860.0238729042551;860.6385318166323;863.223099210709;864.3042350907517;623.8565130020075;626.0702856258453;627.3694936588745;627.4885967936164;629.4775336470764;16545.586360340967;16684.49946501607;16687.91656041724;16698.4155554555;16733.414330498497;13203.933980330134;15105.47130850415;15251.847481525154;15302.234888255543;15451.922740386339;12945.54690585825;13584.592462226148;13604.115732477358;13611.455541778318;13691.452341906312;4493.707908985938;4529.411176547061;4567.406237189178;4625.514320996281;4629.8148074077;82286;82363;82763.10329138511;84456;84719;10827.971342722429;10953.233273670767;11200.943995279971;11260.00316932089;11643.941780291214;20661.58676826455;20874.89562552208;20973.161073556887;20977;20983.160673572886;8072.152423995396;8333.583320833934;8370.581470926429;8458.407911446262;8488.278496327881;4787.569118779326;4833.782479788348;4876.4879687633;4899.387576552931;5009.849704508871;3392.9491057634154;3549.9645003549635;3556.395412779834;3558.448440491728;3558.768680035789;608.5618354784548;610.3896103896104;614.118739608663;625.7841044839523;626.9561130720897;702.2766550453042;719.4280546965175;737.4211244173406;762.7406681728128;765.5636287316177;9869.457179855033;10191.388516689023;10349.896501034893;10351.741206469898;10636.30863993838;643.4594940250118;741.4068745003975;744.2044582993104;764.2815753191982;764.7055883484787;4695.95304046962;4782.091402633558;4858;4898.167311557044;4929.112759703216;81626.18373816185;128933.35533322461;131960;132215;134663;99745;106668.7332506691;107336.46331768291;110113;111116.4444177774;89877.55061224652;91099.54450227706;91382.54308728414;93579.53210233769;94736.52631736797;8897.332700047393;9160.267178625827;9280.814383712423;9317.39436936597;9421.905780942103;53186.73406632942;53837;54111;54779.72610136924;55551.444485554624;78735.03162420985;79302.60348698219;80817;82255.17744822476;82476;11204.607838725931;11525.711857203636;11611.187216895074;11827.645170644895;11889.881101188877;13070.80393794075;13072.084954053125;13095.345232738135;13418.530351437652;13641.658958526115;12441.93779031099;12489.125761196992;12528.12303138808;12848;13446.126001809851;12544.87455125437;12619.558315458915;12709.300988445724;13300.201987880759;13409.798853017017;12414.937925310676;12439.626811195678;12474.875251247371;12607.243565386107;12690.302033388252;9814.807471150483;10226.539805708611;10427;10481.947590262;10790.67627971162;9694.806103878023;10402.375857448576;10427.895721042692;10463.581456741646;10498.94750526273 01:34:19 INFO - PROCESS | 26034 | __end_tp_report 01:34:19 INFO - PROCESS | 26034 | __start_cc_report 01:34:19 INFO - PROCESS | 26034 | _x_x_mozilla_cycle_collect,323 01:34:19 INFO - PROCESS | 26034 | __end_cc_report 01:34:19 INFO - PROCESS | 26034 | __startTimestamp1472200459095__endTimestamp 01:34:19 INFO - PROCESS | 26034 | 01:34:19 INFO - PROCESS | 26034 | ------- Summary: start ------- 01:34:19 INFO - PROCESS | 26034 | Number of tests: 6 01:34:19 INFO - PROCESS | 26034 | 01:34:19 INFO - PROCESS | 26034 | [#0] dojo.html Cycles:165 Average:5473.55 Median:5713.14 stddev:638.92 (11.2%) stddev-sans-first:612.29 01:34:19 INFO - PROCESS | 26034 | Values: 3064.3 3091.1 3108.2 3146.8 3152.7 5403.4 5444.1 5468.8 5483.8 5512.6 5486.5 5502.6 5505.4 5539.8 5550.3 4930.3 5000.7 5011.6 5031.7 5068.4 4589.4 5033.1 5046.2 5048.5 5101.2 4861.3 4873.8 4894.0 4919.1 4937.5 4950.2 4962.3 4965.7 4980.6 5018.1 4878.6 4905.2 4918.5 4923.9 4975.7 5318.0 5431.8 5531.1 5543.1 5547.3 5879.2 5895.0 5896.8 5900.5 5932.2 5921.1 5923.8 5931.3 5933.4 5937.9 5375.6 5496.7 5499.6 5507.8 5548.6 6064.4 6095.6 6096.5 6106.0 6108.7 5753.3 5786.8 5788.9 5790.2 5856.6 5698.6 5871.2 5890.0 5926.8 5938.3 5891.9 5906.8 5908.8 5909.1 5923.3 5935.3 5950.3 5964.7 5965.2 5971.7 4467.2 4495.0 4524.8 4530.3 4552.4 4031.2 4038.3 4045.1 4048.7 4075.6 5618.9 5648.7 5671.1 5672.5 5715.8 5707.8 5851.5 5888.6 5937.8 5941.9 5554.0 5561.6 5646.3 5660.2 5680.4 5090.9 5091.5 5101.0 5125.5 5208.7 5911.6 6045.7 6082.0 6090.3 6104.8 5920.1 5925.4 5936.1 5939.0 5982.3 6086.7 6090.1 6093.6 6097.6 6109.4 5654.7 5707.0 5711.4 5790.3 5836.5 5838.8 5846.0 5869.5 5906.9 5924.2 5729.1 5768.9 5783.7 5846.6 5885.7 5718.1 5743.8 5754.3 5755.9 5759.1 5561.6 5689.7 5764.8 5769.9 5772.3 5758.8 5805.0 5834.8 5914.5 5915.1 5681.3 5713.1 5720.1 5727.6 5742.7 01:34:19 INFO - PROCESS | 26034 | 01:34:19 INFO - PROCESS | 26034 | [#1] ext.html Cycles:180 Average:60614.31 Median:22334.29 stddev:124934.80 (559.4%) stddev-sans-first:125203.94 01:34:19 INFO - PROCESS | 26034 | Values: 568.8 576.1 590.5 610.8 635.6 38610.6 39812.4 42955.6 43057.4 43303.0 43504.3 44063.8 44398.8 44438.0 44528.0 8736.4 8955.6 8962.5 8987.5 9013.5 8673.3 8706.0 8784.5 8786.9 8807.4 8664.2 8701.2 8724.1 8759.3 8795.4 8763.7 8789.5 8799.3 8806.1 8820.3 8869.1 8936.9 8937.7 8958.7 8960.6 40604.6 40968.4 41143.4 41178.4 41200.0 3328.3 3540.1 3599.6 3680.3 3958.2 32325.8 32392.4 32471.0 32521.2 32801.5 3916.7 4045.2 4064.0 4070.2 4090.4 359186.0 360106.0 360184.0 360336.0 361059.0 33791.2 57022.4 57064.4 57130.4 57302.7 36106.8 37698.2 37706.6 37825.1 38044.0 15619.1 15645.1 15689.8 15774.5 15783.7 12986.9 13024.7 13038.6 13063.2 13102.5 8509.7 8621.7 8680.7 8727.0 8753.4 3345.2 3400.2 3406.5 3418.8 3443.5 1010.5 1011.7 1041.8 1085.9 1103.1 31449.1 31771.4 31867.0 31902.2 32393.8 1070.9 1077.9 1086.3 1109.5 1131.4 15972.8 16708.5 16736.7 16882.6 16958.3 573000.0 573091.9 575934.0 575954.0 577464.0 57011.0 57102.0 57791.1 57791.7 57847.7 1308.0 1358.3 1368.2 1370.8 1373.5 29810.0 30312.5 30771.2 30778.0 31037.7 50176.7 50330.0 50514.2 50523.0 50592.0 443723.0 446057.0 447278.0 450317.0 451399.0 28061.6 28467.4 28494.7 28555.0 28605.1 47094.0 48013.8 48100.0 48109.3 48546.3 38941.8 39803.2 40350.4 40388.6 41854.4 41893.4 41902.0 42158.8 42284.6 42754.6 39663.0 40705.0 40739.0 40820.6 43279.8 34583.3 37812.2 38151.6 39023.0 39153.4 28078.2 28334.6 28474.0 28868.4 28902.9 01:34:19 INFO - PROCESS | 26034 | 01:34:19 INFO - PROCESS | 26034 | [#2] jquery.html Cycles:180 Average:27398.02 Median:1650.14 stddev:70964.99 (4300.5%) stddev-sans-first:71135.11 01:34:19 INFO - PROCESS | 26034 | Values: 398.5 402.5 406.8 410.0 424.1 13824.3 18696.2 19467.8 20276.9 20374.0 18389.4 19115.9 19117.9 19183.8 19437.9 5155.6 5361.4 5760.5 5786.8 5809.5 5677.8 5779.2 5785.1 5795.3 5796.6 5652.8 5863.0 5912.6 6006.6 6037.1 5748.1 5854.7 5922.3 5939.8 5983.7 5655.2 5675.6 5687.6 5710.9 5724.7 14049.8 14259.0 14297.5 14300.5 14383.1 2347.2 2378.6 2404.6 2477.8 2901.8 14311.4 14522.4 14639.0 14773.0 15119.5 1884.7 1960.6 1971.7 1997.4 2008.4 84817.0 86389.6 87498.1 89283.0 91278.0 11094.1 11320.8 11402.3 11704.9 11729.3 15854.1 15864.8 15867.7 15928.3 16005.2 8047.5 8558.2 8570.4 8664.7 8689.8 8135.6 8261.8 8307.0 8443.9 8529.5 4817.1 4851.2 4869.4 4931.8 4935.7 1992.8 2053.1 2069.8 2075.4 2103.6 916.9 919.9 952.1 996.6 1022.0 17890.7 19044.7 19190.1 19573.8 19767.9 985.9 989.0 997.2 1010.8 1026.2 10238.7 10792.5 10915.8 10933.9 10949.4 414640.0 418296.0 429618.0 434191.0 434653.0 93056.0 97372.0 97603.5 97864.6 98306.5 975.3 1007.0 1010.5 1039.1 1041.0 16462.8 16664.4 16968.3 17084.4 17482.3 39993.6 41163.4 41437.2 42010.0 42254.4 55278.7 56843.0 57135.4 57339.4 57803.4 8512.2 8519.3 8642.7 8764.0 8777.8 9211.2 12218.5 12838.7 13350.0 13369.3 10985.8 11047.6 11107.9 11277.9 12168.4 11360.4 11418.4 11783.3 11907.2 12043.6 11401.7 11761.2 12082.6 12220.8 12275.3 7452.0 7850.8 8609.4 8726.1 8747.9 11568.6 11792.9 11832.6 12072.6 12295.0 01:34:19 INFO - PROCESS | 26034 | 01:34:19 INFO - PROCESS | 26034 | [#3] mootools.html Cycles:180 Average:6062.70 Median:2632.40 stddev:3508.14 (133.3%) stddev-sans-first:3500.94 01:34:19 INFO - PROCESS | 26034 | Values: 1461.3 1473.8 1624.9 1739.0 1775.8 8050.3 8777.0 8845.0 9575.2 9580.2 8923.1 9291.4 9292.7 9297.7 9313.7 2443.0 2468.4 2470.5 2479.6 2482.5 2383.3 2486.0 2500.7 2501.8 2506.2 2447.9 2449.7 2495.2 2496.1 2496.3 2410.3 2420.3 2432.3 2433.1 2437.3 2401.6 2414.6 2417.0 2417.8 2436.3 9328.3 9359.7 9419.7 9426.7 9480.1 5355.7 5452.9 5459.3 5468.8 5485.8 3402.7 3550.1 3612.1 3659.3 3659.9 1171.0 1197.4 1210.0 1214.7 1236.6 13056.5 13056.5 13143.9 13217.0 13262.7 4432.2 4685.1 4793.1 4854.6 4881.1 10946.9 10965.5 11005.3 11018.8 11022.8 5444.5 5455.4 5455.6 5464.0 5471.2 4344.2 4873.5 4984.0 5001.8 5009.2 4110.6 4137.3 4159.5 4180.8 4204.9 1239.6 1247.5 1271.6 1299.9 1300.1 959.4 970.6 982.7 982.9 990.9 5827.8 5948.1 5978.9 6060.5 6108.1 461.8 466.4 471.7 485.2 487.3 4250.4 4297.7 4325.8 4369.9 4387.3 11041.0 11396.9 11469.3 11478.3 11592.5 10323.5 10814.3 10872.6 10971.6 11431.1 8507.4 8585.4 8651.0 8795.7 8835.7 6228.5 6414.8 6424.7 6440.8 6616.2 10434.2 10786.9 10792.9 10955.4 11018.1 10658.9 10859.8 10868.9 10924.8 11016.0 7856.0 8585.4 8600.7 8632.0 8825.0 8953.8 8953.9 8964.1 8988.7 8992.8 8115.7 8120.5 8204.6 8226.5 8340.6 7835.4 7879.4 8030.6 8057.7 8214.6 7112.8 7204.1 7240.1 7290.7 7435.8 5312.7 5345.7 5350.6 5418.5 5439.2 4808.4 4824.9 4833.0 4875.2 4898.5 01:34:19 INFO - PROCESS | 26034 | 01:34:19 INFO - PROCESS | 26034 | [#4] prototype.html Cycles:180 Average:4777.62 Median:5421.15 stddev:1428.56 (26.4%) stddev-sans-first:1392.96 01:34:19 INFO - PROCESS | 26034 | Values: 326.3 335.0 335.7 345.8 346.9 5405.3 5550.3 5585.9 5604.1 5629.4 5476.3 5487.9 5496.0 5503.7 5505.7 4267.9 4269.4 4274.3 4275.7 4300.5 4155.9 4217.7 4218.3 4296.7 4307.2 4184.8 4186.5 4186.7 4194.7 4209.0 4184.5 4202.2 4207.1 4215.6 4235.3 3691.4 3692.2 3694.5 3700.6 3707.9 5206.9 5265.5 5266.7 5341.0 5384.0 4792.0 4803.2 4808.2 4822.4 4879.8 5562.4 5717.8 5770.4 5780.0 5782.1 3992.9 3995.2 4001.4 4004.2 4039.6 5946.6 6006.8 6034.5 6043.7 6056.8 4034.0 4114.1 4114.4 4115.5 4155.3 3949.4 4160.2 4161.8 4188.8 4195.4 4815.7 4824.2 4846.3 4850.4 4884.5 5755.8 5766.1 5776.0 5833.3 5841.2 1398.4 1446.5 1453.1 1454.8 1456.7 876.9 908.7 909.0 910.4 927.3 4841.0 4849.3 4870.7 4889.8 4931.6 5051.8 5125.0 5166.5 5176.8 5197.2 4905.5 4971.4 4973.8 4988.8 5183.8 3097.6 3131.4 3145.0 3156.2 3170.2 6119.5 6140.9 6161.4 6162.2 6181.4 5965.6 5974.0 5985.0 5998.8 6027.3 6081.9 6082.8 6095.8 6117.0 6128.6 5553.3 5882.8 5932.2 5937.0 5951.5 5873.8 5899.7 5906.0 5909.0 5923.3 6153.5 6162.5 6170.4 6176.4 6191.9 3979.9 4061.5 4146.6 4163.9 4175.1 5808.7 5812.7 5872.9 5897.3 5911.9 5693.0 5727.4 5741.5 5757.5 5784.4 5547.1 5705.4 5729.3 5730.8 5749.6 5764.3 5779.8 5791.1 5804.6 5817.7 5437.0 5724.8 5749.7 5794.8 5867.3 5638.3 5642.1 5663.5 5681.9 5710.5 01:34:19 INFO - PROCESS | 26034 | 01:34:19 INFO - PROCESS | 26034 | [#5] yui.html Cycles:180 Average:21737.57 Median:4739.02 stddev:32435.99 (684.4%) stddev-sans-first:32488.46 01:34:19 INFO - PROCESS | 26034 | Values: 682.8 757.6 766.0 792.7 829.1 14774.6 14797.4 15061.2 15477.8 15840.9 14668.0 14706.6 14744.3 14766.5 14780.7 793.3 802.0 822.0 823.9 824.5 818.7 825.8 831.0 831.9 832.0 852.1 860.3 862.3 864.2 868.0 858.0 860.0 860.6 863.2 864.3 623.9 626.1 627.4 627.5 629.5 16545.6 16684.5 16687.9 16698.4 16733.4 13203.9 15105.5 15251.8 15302.2 15451.9 12945.5 13584.6 13604.1 13611.5 13691.5 4493.7 4529.4 4567.4 4625.5 4629.8 82286.0 82363.0 82763.1 84456.0 84719.0 10828.0 10953.2 11200.9 11260.0 11643.9 20661.6 20874.9 20973.2 20977.0 20983.2 8072.2 8333.6 8370.6 8458.4 8488.3 4787.6 4833.8 4876.5 4899.4 5009.8 3392.9 3550.0 3556.4 3558.4 3558.8 608.6 610.4 614.1 625.8 627.0 702.3 719.4 737.4 762.7 765.6 9869.5 10191.4 10349.9 10351.7 10636.3 643.5 741.4 744.2 764.3 764.7 4696.0 4782.1 4858.0 4898.2 4929.1 81626.2 128933.4 131960.0 132215.0 134663.0 99745.0 106668.7 107336.5 110113.0 111116.4 89877.6 91099.5 91382.5 93579.5 94736.5 8897.3 9160.3 9280.8 9317.4 9421.9 53186.7 53837.0 54111.0 54779.7 55551.4 78735.0 79302.6 80817.0 82255.2 82476.0 11204.6 11525.7 11611.2 11827.6 11889.9 13070.8 13072.1 13095.3 13418.5 13641.7 12441.9 12489.1 12528.1 12848.0 13446.1 12544.9 12619.6 12709.3 13300.2 13409.8 12414.9 12439.6 12474.9 12607.2 12690.3 9814.8 10226.5 10427.0 10481.9 10790.7 9694.8 10402.4 10427.9 10463.6 10498.9 01:34:19 INFO - PROCESS | 26034 | -------- Summary: end -------- 01:34:19 INFO - PROCESS | 26034 | 01:34:20 INFO - TEST-INFO | 26034: exit 0 01:34:20 INFO - TEST-OK | dromaeo_css | took 1113032ms 01:34:20 INFO - TEST-START | kraken 01:34:20 INFO - operating with platform_type : linux_ 01:34:20 INFO - Initialising browser for kraken test... 01:34:20 INFO - TEST-INFO | started process 26397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2N8ZrW/profile http://localhost:58647/getInfo.html) 01:34:24 INFO - PROCESS | 26397 | __metrics Screen width/height:1600/1200 01:34:24 INFO - PROCESS | 26397 | colorDepth:24 01:34:24 INFO - PROCESS | 26397 | Browser inner width/height: 1024/697 01:34:24 INFO - PROCESS | 26397 | __metrics 01:34:25 ERROR - PROCESS | 26397 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 01:34:26 INFO - TEST-INFO | 26397: exit 0 01:34:26 INFO - Browser initialized. 01:34:26 INFO - Running cycle 1/1 for kraken test... 01:34:26 INFO - TEST-INFO | started process 26517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2N8ZrW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:34:38 INFO - PROCESS | 26517 | RSS: Main: 190631936 01:34:38 INFO - PROCESS | 26517 | 01:34:40 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58647/tests/kraken/driver.html?testName=audio-beat-detection) 01:34:41 INFO - PROCESS | 26517 | RSS: Main: 203988992 01:34:41 INFO - PROCESS | 26517 | 01:34:44 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58647/tests/kraken/driver.html?testName=audio-dft) 01:34:45 INFO - PROCESS | 26517 | RSS: Main: 202760192 01:34:45 INFO - PROCESS | 26517 | 01:34:48 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58647/tests/kraken/driver.html?testName=audio-fft) 01:34:48 INFO - PROCESS | 26517 | RSS: Main: 195928064 01:34:48 INFO - PROCESS | 26517 | 01:34:50 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58647/tests/kraken/driver.html?testName=audio-oscillator) 01:34:51 INFO - PROCESS | 26517 | RSS: Main: 197206016 01:34:51 INFO - PROCESS | 26517 | 01:34:53 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58647/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:34:54 INFO - PROCESS | 26517 | RSS: Main: 197640192 01:34:54 INFO - PROCESS | 26517 | 01:34:57 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58647/tests/kraken/driver.html?testName=imaging-darkroom) 01:34:57 INFO - PROCESS | 26517 | RSS: Main: 198041600 01:34:57 INFO - PROCESS | 26517 | 01:35:01 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58647/tests/kraken/driver.html?testName=imaging-desaturate) 01:35:01 INFO - PROCESS | 26517 | RSS: Main: 195145728 01:35:01 INFO - PROCESS | 26517 | 01:35:04 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58647/tests/kraken/driver.html?testName=json-parse-financial) 01:35:05 INFO - PROCESS | 26517 | RSS: Main: 196927488 01:35:05 INFO - PROCESS | 26517 | 01:35:07 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58647/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:35:07 INFO - PROCESS | 26517 | RSS: Main: 197300224 01:35:07 INFO - PROCESS | 26517 | 01:35:09 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:35:10 INFO - PROCESS | 26517 | RSS: Main: 196943872 01:35:10 INFO - PROCESS | 26517 | 01:35:12 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:35:12 INFO - PROCESS | 26517 | RSS: Main: 197996544 01:35:12 INFO - PROCESS | 26517 | 01:35:15 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:35:16 INFO - PROCESS | 26517 | RSS: Main: 197632000 01:35:16 INFO - PROCESS | 26517 | 01:35:19 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:35:19 INFO - PROCESS | 26517 | RSS: Main: 197861376 01:35:19 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58647/tests/kraken/driver.html?testName=ai-astar) 01:35:21 INFO - PROCESS | 26517 | RSS: Main: 199798784 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | __start_tp_report 01:35:21 INFO - PROCESS | 26517 | _x_x_mozilla_page_load 01:35:21 INFO - PROCESS | 26517 | _x_x_mozilla_page_load_details 01:35:21 INFO - PROCESS | 26517 | |i|pagename|runs| 01:35:21 INFO - PROCESS | 26517 | |0;ai-astar;117;113;113;113;114;113;112;113;112;129 01:35:21 INFO - PROCESS | 26517 | |1;audio-beat-detection;152;120;149;184;123;160;149;126;189;125 01:35:21 INFO - PROCESS | 26517 | |2;audio-dft;162;164;166;170;165;165;162;172;163;161 01:35:21 INFO - PROCESS | 26517 | |3;audio-fft;76;75;75;192;77;76;76;77;159;77 01:35:21 INFO - PROCESS | 26517 | |4;audio-oscillator;83;83;156;83;83;83;138;83;82;149 01:35:21 INFO - PROCESS | 26517 | |5;imaging-gaussian-blur;118;118;117;118;118;118;117;118;119;118 01:35:21 INFO - PROCESS | 26517 | |6;imaging-darkroom;148;147;148;148;149;147;147;147;148;149 01:35:21 INFO - PROCESS | 26517 | |7;imaging-desaturate;98;97;97;97;97;97;97;98;98;95 01:35:21 INFO - PROCESS | 26517 | |8;json-parse-financial;54;54;53;54;53;54;55;53;54;55 01:35:21 INFO - PROCESS | 26517 | |9;json-stringify-tinderbox;61;63;66;62;62;61;62;61;63;62 01:35:21 INFO - PROCESS | 26517 | |10;stanford-crypto-aes;80;81;81;81;80;86;83;79;96;89 01:35:21 INFO - PROCESS | 26517 | |11;stanford-crypto-ccm;145;124;137;136;126;141;126;144;176;125 01:35:21 INFO - PROCESS | 26517 | |12;stanford-crypto-pbkdf2;163;166;163;166;176;165;168;163;171;175 01:35:21 INFO - PROCESS | 26517 | |13;stanford-crypto-sha256-iterative;66;66;68;67;70;65;64;66;64;64 01:35:21 INFO - PROCESS | 26517 | __end_tp_report 01:35:21 INFO - PROCESS | 26517 | __start_cc_report 01:35:21 INFO - PROCESS | 26517 | _x_x_mozilla_cycle_collect,831 01:35:21 INFO - PROCESS | 26517 | __end_cc_report 01:35:21 INFO - PROCESS | 26517 | __startTimestamp1472200521696__endTimestamp 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | ------- Summary: start ------- 01:35:21 INFO - PROCESS | 26517 | Number of tests: 14 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#0] ai-astar Cycles:10 Average:114.90 Median:113.00 stddev:5.15 (4.6%) stddev-sans-first:5.41 01:35:21 INFO - PROCESS | 26517 | Values: 117.0 113.0 113.0 113.0 114.0 113.0 112.0 113.0 112.0 129.0 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:150.50 stddev:24.86 (16.5%) stddev-sans-first:26.31 01:35:21 INFO - PROCESS | 26517 | Values: 152.0 120.0 149.0 184.0 123.0 160.0 149.0 126.0 189.0 125.0 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:3.56 (2.2%) stddev-sans-first:3.61 01:35:21 INFO - PROCESS | 26517 | Values: 162.0 164.0 166.0 170.0 165.0 165.0 162.0 172.0 163.0 161.0 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#3] audio-fft Cycles:10 Average:96.00 Median:76.00 stddev:42.62 (56.1%) stddev-sans-first:44.59 01:35:21 INFO - PROCESS | 26517 | Values: 76.0 75.0 75.0 192.0 77.0 76.0 76.0 77.0 159.0 77.0 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:83.00 stddev:31.60 (38.1%) stddev-sans-first:32.73 01:35:21 INFO - PROCESS | 26517 | Values: 83.0 83.0 156.0 83.0 83.0 83.0 138.0 83.0 82.0 149.0 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 01:35:21 INFO - PROCESS | 26517 | Values: 118.0 118.0 117.0 118.0 118.0 118.0 117.0 118.0 119.0 118.0 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 01:35:21 INFO - PROCESS | 26517 | Values: 148.0 147.0 148.0 148.0 149.0 147.0 147.0 147.0 148.0 149.0 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 01:35:21 INFO - PROCESS | 26517 | Values: 98.0 97.0 97.0 97.0 97.0 97.0 97.0 98.0 98.0 95.0 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 01:35:21 INFO - PROCESS | 26517 | Values: 54.0 54.0 53.0 54.0 53.0 54.0 55.0 53.0 54.0 55.0 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:1.49 (2.4%) stddev-sans-first:1.51 01:35:21 INFO - PROCESS | 26517 | Values: 61.0 63.0 66.0 62.0 62.0 61.0 62.0 61.0 63.0 62.0 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:82.00 stddev:5.34 (6.5%) stddev-sans-first:5.50 01:35:21 INFO - PROCESS | 26517 | Values: 80.0 81.0 81.0 81.0 80.0 86.0 83.0 79.0 96.0 89.0 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:139.00 stddev:15.62 (11.2%) stddev-sans-first:16.36 01:35:21 INFO - PROCESS | 26517 | Values: 145.0 124.0 137.0 136.0 126.0 141.0 126.0 144.0 176.0 125.0 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:167.00 stddev:4.86 (2.9%) stddev-sans-first:4.86 01:35:21 INFO - PROCESS | 26517 | Values: 163.0 166.0 163.0 166.0 176.0 165.0 168.0 163.0 171.0 175.0 01:35:21 INFO - PROCESS | 26517 | 01:35:21 INFO - PROCESS | 26517 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.94 (2.9%) stddev-sans-first:2.06 01:35:21 INFO - PROCESS | 26517 | Values: 66.0 66.0 68.0 67.0 70.0 65.0 64.0 66.0 64.0 64.0 01:35:21 INFO - PROCESS | 26517 | -------- Summary: end -------- 01:35:21 INFO - PROCESS | 26517 | 01:35:22 INFO - TEST-INFO | 26517: exit 0 01:35:22 INFO - TEST-OK | kraken | took 62636ms 01:35:22 INFO - SUITE-END | took 1175s 01:35:22 INFO - Completed test suite (00:19:35) 01:35:22 INFO - javascript benchmark 01:35:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7280.946335132733, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.2952121012167, 3091.1499337682135, 3108.2074071111865, 3146.842657867106, 3152.747780177586, 5403.378611459683, 5444.128939369702, 5468.7812487500505, 5483.780648774049, 5512.641678290908, 5486.451354864512, 5502.614816962814, 5505.449455054492, 5539.806106786264, 5550.27846379971, 4930.260460930862, 5000.699958002513, 5011.574016208627, 5031.698098114107, 5068.4424713281505, 4589.380433641466, 5033.094043072246, 5046.171528218123, 5048.545630893219, 5101.183810590306, 4861.319415281846, 4873.780679869415, 4894.0, 4919.11455937931, 4937.456879743261, 4950.183219768734, 4962.280469331963, 4965.677230979974, 4980.576650984671, 5018.121828680003, 4878.609711223094, 4905.2151655734915, 4918.483559226302, 4923.901521969577, 4975.7263350515705, 5318.0, 5431.782728690848, 5531.0873705838485, 5543.057680194376, 5547.278853749027, 5879.176915231871, 5894.97052514739, 5896.7936122235515, 5900.4984576310635, 5932.19915311436, 5921.141434492018, 5923.763049478016, 5931.258592675916, 5933.397982544732, 5937.8812423751715, 5375.569954403677, 5496.725163741837, 5499.560035197174, 5507.779688812403, 5548.639338442988, 6064.423879731418, 6095.559247229214, 6096.542759292982, 6105.997654215468, 6108.677166059137, 5753.33836608787, 5786.797462088806, 5788.942110578841, 5790.160426738099, 5856.648601083949, 5698.601097923189, 5871.236739223959, 5890.0, 5926.762929482858, 5938.317093534212, 5891.852703682443, 5906.822795316061, 5908.822735317947, 5909.113632955091, 5923.259592550931, 5935.317438494542, 5950.256217972754, 5964.671943043088, 5965.194698715704, 5971.671558064349, 4467.15124126415, 4494.955050449519, 4524.773761311922, 4530.343100250445, 4552.430946131733, 4031.1534577738416, 4038.3336749436603, 4045.110075783323, 4048.736832105904, 4075.612816782401, 5618.91571626426, 5648.74580643872, 5671.120976248688, 5672.546196304285, 5715.799947001835, 5707.828765137053, 5851.502622277154, 5888.61723987948, 5937.7921772737745, 5941.940580594225, 5554.000279949648, 5561.610687251854, 5646.322441307069, 5660.235868157828, 5680.403557626472, 5090.9236361454605, 5091.541761241506, 5100.974495127575, 5125.538701516882, 5208.661437006583, 5911.615744976562, 6045.697715114139, 6082.0, 6090.33006369299, 6104.755809767559, 5920.141579471038, 5925.377835327228, 5936.079907614327, 5939.0, 5982.341942386421, 6086.72609732572, 6090.147379366981, 6093.6039157454625, 6097.634141951497, 6109.419605137505, 5654.688992105309, 5706.9714651426475, 5711.371749107512, 5790.305163380422, 5836.503897168788, 5838.795642152504, 5846.035404158266, 5869.53043756507, 5906.852328691817, 5924.170616113834, 5729.083346664514, 5768.855778605568, 5783.681897495678, 5846.590738648254, 5885.705714714161, 5718.1136923776885, 5743.770249190153, 5754.309482862083, 5755.8561035974435, 5759.136129580596, 5561.582881284001, 5689.687067211177, 5764.827055188351, 5769.903718293511, 5772.336181339199, 5758.798442054508, 5804.970975145097, 5834.766609335579, 5914.526837853047, 5915.08316210988, 5681.261436013292, 5713.143028545585, 5720.056190728649, 5727.570432217683, 5742.712864356849], "value": 5428.953703604125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7895478672889, 576.084026398027, 590.5275779376498, 610.7556977209116, 635.5868685354521, 38610.61389386105, 39812.40281395778, 42955.57044429555, 43057.35413968793, 43303.0, 43504.347434788506, 44063.77968110163, 44398.778006110006, 44438.0, 44528.0, 8736.432131911406, 8955.641774329019, 8962.507062111581, 8987.505687187202, 9013.459192448441, 8673.349498787584, 8706.0, 8784.51685157316, 8786.86819697705, 8807.383483156182, 8664.176903194219, 8701.216890479856, 8724.083971182998, 8759.2992560595, 8795.384323097354, 8763.737087887373, 8789.472631642122, 8799.340049496313, 8806.119388061206, 8820.338474614398, 8869.113088691143, 8936.8659470108, 8937.731868043904, 8958.686445974425, 8960.641574337084, 40604.59395406038, 40968.38547421791, 41143.38284925729, 41178.38232426516, 41200.0, 3328.334333133383, 3540.0972751948348, 3599.5680518337967, 3680.300742858848, 3958.168784555247, 32325.83837080823, 32392.35215295681, 32471.025869223962, 32521.186970325933, 32801.50797738036, 3916.7454115482687, 4045.2314060328445, 4063.97968010161, 4070.2266569352023, 4090.406891000818, 359186.0, 360106.0, 360184.0, 360336.0, 361059.0, 33791.155221119174, 57022.42977570254, 57064.42935570591, 57130.42869571251, 57302.7134864323, 36106.8194659025, 37698.24603507969, 37706.62293377031, 37825.05437364088, 38044.0, 15619.140947247783, 15645.061296322257, 15689.764653530206, 15774.526764197093, 15783.684326313409, 12986.935065324613, 13024.739505209844, 13038.608841734764, 13063.216207027608, 13102.541411050568, 8509.65961361551, 8621.715245459958, 8680.73957781255, 8727.04002559718, 8753.431026983226, 3345.2138747394342, 3400.2179498715436, 3406.454967205285, 3418.8119653418803, 3443.5241151157975, 1010.4846528270488, 1011.7116621762763, 1041.776018156085, 1085.945702714861, 1103.089950790601, 31449.056528304187, 31771.364572708415, 31867.0, 31902.202444938597, 32393.838030810166, 1070.9143268538498, 1077.8706555213425, 1086.3319058778793, 1109.5395410904384, 1131.3890499130378, 15972.76040859388, 16708.49874503767, 16736.6652666946, 16882.577935551464, 16958.321667133423, 573000.0, 573091.941782044, 575934.0, 575954.0, 577464.0, 57011.0, 57102.0, 57791.13313300304, 57791.71104144453, 57847.710761445924, 1307.9673008174873, 1358.2665360705307, 1368.206440264644, 1370.8080868678394, 1373.5467295792364, 29810.0, 30312.5453118199, 30771.230719232197, 30778.0, 31037.689623104383, 50176.749116254185, 50330.0, 50514.242286365, 50523.0, 50592.0, 443723.0, 446057.0, 447278.0, 450317.0, 451399.0, 28061.57907631428, 28467.430651386443, 28494.715052850035, 28555.0, 28605.14184574466, 47094.0, 48013.75993120012, 48100.0, 48109.27836082392, 48546.27180592223, 38941.80529097337, 39803.2039359217, 40350.39474407827, 40388.59611403966, 41854.37218441665, 41893.37159942542, 41902.0, 42158.78920605377, 42284.57715422806, 42754.57245427506, 39663.0, 40705.0, 40739.0, 40820.59179408168, 43279.78360108179, 34583.30833383369, 37812.243755125295, 38151.61848381592, 39023.0266606109, 39153.41269880897, 28078.157655270374, 28334.574981374884, 28474.0, 28868.42263154767, 28902.855485722437], "value": 18930.42032264487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.5177934699014, 402.53105132520614, 406.81896556032564, 409.9651529619983, 424.05012771392074, 13824.308784560782, 18696.15867285972, 19467.805321946777, 20276.89861550692, 20374.0, 18389.356372526963, 19115.904420477913, 19117.904410477964, 19183.808161918376, 19437.902810485964, 5155.613329000321, 5361.356637203541, 5760.452756988079, 5786.797462088828, 5809.535237181015, 5677.801276955307, 5779.219805326269, 5785.132230165488, 5795.3045634523705, 5796.5652576056755, 5652.830415087534, 5863.0, 5912.645241285515, 6006.579539432241, 6037.094435834638, 5748.109043098327, 5854.707264636793, 5922.2597175353085, 5939.7921072762465, 5983.730732117044, 5655.179998900177, 5675.602707810455, 5687.601867869251, 5710.857228569277, 5724.656520608777, 14049.78925316121, 14259.0, 14297.49958751449, 14300.499482518062, 14383.065100768417, 2347.225415612844, 2378.595638741418, 2404.5551572959057, 2477.826552141351, 2901.7678585713093, 14311.35598898052, 14522.419103235858, 14639.0, 14773.0, 15119.47081852141, 1884.6984482482874, 1960.6372821028156, 1971.7141014552953, 1997.3808119482862, 2008.4476768888526, 84817.0, 86389.56805215997, 87498.12501874963, 89283.0, 91277.99999999933, 11094.1124710023, 11320.773584528264, 11402.258853174517, 11704.94147529257, 11729.296242225322, 15854.128022958617, 15864.795829105296, 15867.682646347008, 15928.283227254802, 16005.199740013186, 8047.476914000688, 8558.186972237627, 8570.4000719949, 8664.653413863502, 8689.782755431039, 8135.633896474673, 8261.83476330482, 8307.0, 8443.915560844312, 8529.530875801767, 4817.108834865491, 4851.248056551241, 4869.391326084239, 4931.802727890916, 4935.679180853233, 1992.8306093981885, 2053.0966374795044, 2069.772325044274, 2075.3981345409966, 2103.589799989018, 916.8716379706847, 919.9328778616773, 952.1288021460286, 996.566493575297, 1021.9795604087876, 17890.731639025424, 19044.71432928507, 19190.13644386006, 19573.804261957484, 19767.901160494104, 985.940843549375, 988.9950550247203, 997.2271489595477, 1010.8180527505119, 1026.1893104447404, 10238.699746106653, 10792.46037698112, 10915.781684366268, 10933.945330273456, 10949.397783121845, 414640.0, 418296.0, 429618.0, 434191.0, 434653.0, 93056.0, 97372.0, 97603.51198243964, 97864.61744604116, 98306.5084674572, 975.331897650112, 1006.993006993007, 1010.4695035106481, 1039.0700323210835, 1041.0214398465419, 16462.83537164613, 16664.41674541385, 16968.32126714967, 17084.40204592833, 17482.30070797205, 39993.60006400015, 41163.38254926239, 41437.171256575304, 42010.0, 42254.366184506645, 55278.72360638332, 56843.0, 57135.42864571301, 57339.42660573341, 57803.4219657798, 8512.191341822518, 8519.3184545235, 8642.740717778477, 8763.956180219058, 8777.824443511221, 9211.217046551119, 12218.51125954952, 12838.743225135258, 13350.0, 13369.26469044212, 10985.835212471979, 11047.558097676003, 11107.94446027797, 11277.943610281896, 12168.391580421121, 11360.375179365214, 11418.429078545872, 11783.293002419883, 11907.226030308002, 12043.578474753342, 11401.657950261506, 11761.176717629683, 12082.577109801116, 12220.816687749513, 12275.263484190977, 7451.962740186264, 7850.842983140191, 8609.397342185986, 8726.083761204982, 8747.91252087471, 11568.595099171489, 11792.941035294769, 11832.645020649394, 12072.637820865388, 12295.0], "value": 9242.469878120182, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.269365317341, 1473.8305094914085, 1624.9113094226866, 1739.0000749569, 1775.8135395783443, 8050.275475207231, 8776.956115219415, 8844.955775221122, 9575.186109180719, 9580.185684216842, 8923.107689231074, 9291.442513449198, 9292.67475638351, 9297.674581389652, 9313.720588382359, 2443.035001174535, 2468.395243165418, 2470.468849197422, 2479.590867506859, 2482.503499300138, 2383.2731017039796, 2485.962710559343, 2500.712418071918, 2501.7873480754156, 2506.248125562333, 2447.90208391665, 2449.742777008415, 2495.15164843953, 2496.051500429834, 2496.325991982164, 2410.2769169249154, 2420.2739178246543, 2432.2946345559767, 2433.0997530913496, 2437.2566367257978, 2401.5677178107935, 2414.6136618141013, 2417.033186725306, 2417.7703118203744, 2436.3421876093357, 9328.300377471716, 9359.719208423758, 9419.717408477756, 9426.670066547638, 9480.146786789222, 5355.705436201008, 5452.863678408032, 5459.317585301837, 5468.835934921959, 5485.780568777244, 3402.6937575618067, 3550.14796448853, 3612.096975756061, 3659.2864391443677, 3659.9085022874374, 1170.9882901170965, 1197.383347575999, 1209.9516019359214, 1214.6538236602614, 1236.5733821831454, 13056.543020994219, 13056.543020994219, 13143.934280328633, 13217.0, 13262.734745305137, 4432.246518091933, 4685.1332503486965, 4793.113274044313, 4854.563089321978, 4881.072596206709, 10946.890531094747, 10965.451727413598, 11005.339679619248, 11018.779624407467, 11022.834657480144, 5444.455554444524, 5455.427180146107, 5455.563554915597, 5464.043792336325, 5471.23402723619, 4344.218040752695, 4873.512648735098, 4983.950160498421, 5001.8499445016705, 5009.223570346602, 4110.609492098246, 4137.27424905135, 4159.480064991876, 4180.829367777027, 4204.873853784391, 1239.5537606461667, 1247.5321754342121, 1271.5740227023866, 1299.883010529057, 1300.0834411739702, 959.3907868503551, 970.5632465390461, 982.7199248214367, 982.921366290695, 990.9058639429243, 5827.7668893244645, 5948.137520059654, 5978.85052873673, 6060.515158787286, 6108.144859719643, 461.82219845359106, 466.3820437919702, 471.6792979656947, 485.15582885779196, 487.25936576403666, 4250.404943307939, 4297.72064815786, 4325.8269669213505, 4369.868903932887, 4387.298032314814, 11041.0, 11396.886031139748, 11469.31184128955, 11478.253913495597, 11592.536298547964, 10323.48382580868, 10814.29707069038, 10872.619458319079, 10971.561137554409, 11431.14266430021, 8507.447015943944, 8585.356098292654, 8650.95674521636, 8795.692150774692, 8835.69075082369, 6228.480908286803, 6414.775482858077, 6424.743010279536, 6440.806775796734, 6616.172978377703, 10434.217433692655, 10786.946065269623, 10792.892071079188, 10955.397453140155, 11018.1185505161, 10658.946705266424, 10859.782804343711, 10868.891311086787, 10924.836127457935, 11016.0, 7855.960720196363, 8585.399022068395, 8600.741977740678, 8631.956840215758, 8825.0, 8953.820923581623, 8953.910460895308, 8964.14840590143, 8988.685396011108, 8992.820143597222, 8115.715949941724, 8120.512769233865, 8204.589770511331, 8226.465279756796, 8340.624671889658, 7835.37317014626, 7879.448438609243, 8030.63862126194, 8057.677692892219, 8214.58927053657, 7112.822179445555, 7204.0994875640545, 7240.05879235696, 7290.708371665074, 7435.8141046474275, 5312.681239125664, 5345.705986170798, 5350.598705097055, 5418.539424148991, 5439.238506608999, 4808.447028591757, 4824.855254342376, 4833.0, 4875.219964805756, 4898.534639209412], "value": 4750.989762711577, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.3375348043471, 334.9832508374581, 335.7247057412922, 345.7666075399105, 346.8543211851022, 5405.324334458192, 5550.278463799706, 5585.8603534911645, 5604.131359639257, 5629.39562224766, 5476.26070480485, 5487.945120548803, 5496.0, 5503.679117011919, 5505.724713764316, 4267.893302667435, 4269.402283680287, 4274.273373526508, 4275.700700950934, 4300.462442194726, 4155.854545090922, 4217.671433498454, 4218.282891908368, 4296.677749168809, 4307.224699554079, 4184.811683474251, 4186.497620285555, 4186.727862688931, 4194.706370554062, 4208.978955105235, 4184.497860256758, 4202.243596152706, 4207.116505533811, 4215.620594146526, 4235.322348424237, 3691.3909204981146, 3692.1877187018813, 3694.501242332278, 3700.6299370063048, 3707.8516859325596, 5206.947930520684, 5265.499777521168, 5266.7366631668265, 5340.973295133538, 5384.0, 4791.993681326926, 4803.207470767319, 4808.182608956451, 4822.373091498082, 4879.780409881529, 5562.415946325618, 5717.771289148429, 5770.365259821417, 5779.971100144515, 5782.10377391505, 3992.86024989124, 3995.1610161866042, 4001.359782434826, 4004.199160167949, 4039.636432721069, 5946.643201407929, 6006.759729610811, 6034.487068599175, 6043.697815109227, 6056.818295451099, 4033.979830100831, 4114.0948991221885, 4114.403411505315, 4115.464989551399, 4155.293600087993, 3949.4075888616935, 4160.167966406731, 4161.834686287844, 4188.790560471964, 4195.370694395865, 4815.662903596784, 4824.179889418807, 4846.321514987904, 4850.423612326008, 4884.535969082932, 5755.841559415219, 5766.135079738073, 5775.971120144372, 5833.300003999547, 5841.240638716939, 1398.3707331700775, 1446.5226475263348, 1453.1353844462528, 1454.7599646058281, 1456.730504856605, 876.9342299327449, 908.6637943960644, 908.9681861134828, 910.4264313482596, 927.3230541704594, 4841.0, 4849.345338379274, 4870.683405578626, 4889.804407823718, 4931.630127740434, 5051.772670229849, 5124.950019992033, 5166.545890701962, 5176.844694659167, 5197.168453047494, 4905.5283414975365, 4971.428285747185, 4973.776180071905, 4988.825391111293, 5183.844484665466, 3097.566340712302, 3131.4050330437144, 3144.9685503145133, 3156.210947263184, 3170.1916011416943, 6119.450718583211, 6140.850702254175, 6161.383861613893, 6162.22972128484, 6181.392837862189, 5965.55258355625, 5974.0, 5984.970075149597, 5998.820035398945, 6027.30685971119, 6081.908771368433, 6082.813851298954, 6095.817125486243, 6116.969415152985, 6128.601640893327, 5553.250311207935, 5882.764689412375, 5932.228810254639, 5936.970315148396, 5951.464368206882, 5873.823785286449, 5899.734511947058, 5906.0, 5909.0, 5923.289205295392, 6153.461634591352, 6162.506999439945, 6170.382961703974, 6176.382361763787, 6191.938080619136, 3979.8607048753156, 4061.5329237136925, 4146.5853414658295, 4163.916721665611, 4175.102352994121, 5808.718074288014, 5812.651240925558, 5872.911906321494, 5897.321807992136, 5911.940880591139, 5692.971535142297, 5727.391743201756, 5741.511971482304, 5757.481826635623, 5784.392638773036, 5547.08777891594, 5705.4009329019855, 5729.28383952006, 5730.828075157752, 5749.568782341425, 5764.337101233412, 5779.768809247583, 5791.059994901755, 5804.564657650778, 5817.731084876817, 5436.972815135899, 5724.799632013026, 5749.712514374348, 5794.82615521535, 5867.266591676041, 5638.295213098363, 5642.125470552071, 5663.490285874291, 5681.857953551194, 5710.457506536873], "value": 4318.893272085126, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.8054004608688, 757.5833291689569, 765.9502132361396, 792.6789650191671, 829.0962850492962, 14774.556763297105, 14797.408103675867, 15061.246937653128, 15477.845221547781, 15840.920795396021, 14668.0, 14706.63233419165, 14744.33650485728, 14766.483173088916, 14780.704385912275, 793.2900054451262, 801.9839603207947, 821.9876701849477, 823.8970128733908, 824.5217773691245, 818.664347617477, 825.8018075661828, 831.0359982420393, 831.9209675080888, 831.9750407487754, 852.0882655558555, 860.2730692564804, 862.2843040276587, 864.1617630898019, 867.9566021698921, 857.995710021449, 860.0238729042551, 860.6385318166323, 863.223099210709, 864.3042350907517, 623.8565130020075, 626.0702856258453, 627.3694936588745, 627.4885967936164, 629.4775336470764, 16545.586360340967, 16684.49946501607, 16687.91656041724, 16698.4155554555, 16733.414330498497, 13203.933980330134, 15105.47130850415, 15251.847481525154, 15302.234888255543, 15451.922740386339, 12945.54690585825, 13584.592462226148, 13604.115732477358, 13611.455541778318, 13691.452341906312, 4493.707908985938, 4529.411176547061, 4567.406237189178, 4625.514320996281, 4629.8148074077, 82286.0, 82363.0, 82763.10329138511, 84456.0, 84719.0, 10827.971342722429, 10953.233273670767, 11200.943995279971, 11260.00316932089, 11643.941780291214, 20661.58676826455, 20874.89562552208, 20973.161073556887, 20977.0, 20983.160673572886, 8072.152423995396, 8333.583320833934, 8370.581470926429, 8458.407911446262, 8488.278496327881, 4787.569118779326, 4833.782479788348, 4876.4879687633, 4899.387576552931, 5009.849704508871, 3392.9491057634154, 3549.9645003549635, 3556.395412779834, 3558.448440491728, 3558.768680035789, 608.5618354784548, 610.3896103896104, 614.118739608663, 625.7841044839523, 626.9561130720897, 702.2766550453042, 719.4280546965175, 737.4211244173406, 762.7406681728128, 765.5636287316177, 9869.457179855033, 10191.388516689023, 10349.896501034893, 10351.741206469898, 10636.30863993838, 643.4594940250118, 741.4068745003975, 744.2044582993104, 764.2815753191982, 764.7055883484787, 4695.95304046962, 4782.091402633558, 4858.0, 4898.167311557044, 4929.112759703216, 81626.18373816185, 128933.35533322461, 131960.0, 132215.0, 134663.0, 99745.0, 106668.7332506691, 107336.46331768291, 110113.0, 111116.4444177774, 89877.55061224652, 91099.54450227706, 91382.54308728414, 93579.53210233769, 94736.52631736797, 8897.332700047393, 9160.267178625827, 9280.814383712423, 9317.39436936597, 9421.905780942103, 53186.73406632942, 53837.0, 54111.0, 54779.72610136924, 55551.444485554624, 78735.03162420985, 79302.60348698219, 80817.0, 82255.17744822476, 82476.0, 11204.607838725931, 11525.711857203636, 11611.187216895074, 11827.645170644895, 11889.881101188877, 13070.80393794075, 13072.084954053125, 13095.345232738135, 13418.530351437652, 13641.658958526115, 12441.93779031099, 12489.125761196992, 12528.12303138808, 12848.0, 13446.126001809851, 12544.87455125437, 12619.558315458915, 12709.300988445724, 13300.201987880759, 13409.798853017017, 12414.937925310676, 12439.626811195678, 12474.875251247371, 12607.243565386107, 12690.302033388252, 9814.807471150483, 10226.539805708611, 10427.0, 10481.947590262, 10790.67627971162, 9694.806103878023, 10402.375857448576, 10427.895721042692, 10463.581456741646, 10498.94750526273], "value": 7643.0228330877035, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1560.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 113.0, 113.0, 114.0, 113.0, 112.0, 113.0, 112.0, 129.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 120.0, 149.0, 184.0, 123.0, 160.0, 149.0, 126.0, 189.0, 125.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 166.0, 170.0, 165.0, 165.0, 162.0, 172.0, 163.0, 161.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 192.0, 77.0, 76.0, 76.0, 77.0, 159.0, 77.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 156.0, 83.0, 83.0, 83.0, 138.0, 83.0, 82.0, 149.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 119.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 149.0, 147.0, 147.0, 147.0, 148.0, 149.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 98.0, 98.0, 95.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 53.0, 54.0, 55.0, 53.0, 54.0, 55.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 66.0, 62.0, 62.0, 61.0, 62.0, 61.0, 63.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 81.0, 81.0, 80.0, 86.0, 83.0, 79.0, 96.0, 89.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 137.0, 136.0, 126.0, 141.0, 126.0, 144.0, 176.0, 125.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 163.0, 166.0, 176.0, 165.0, 168.0, 163.0, 171.0, 175.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 67.0, 70.0, 65.0, 64.0, 66.0, 64.0, 64.0], "value": 66.0, "unit": "score"}]}]} 01:35:22 INFO - Return code: 0 01:35:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:35:23 ERROR - # TBPL SUCCESS # 01:35:23 INFO - Running post-action listener: _resource_record_post_action 01:35:23 INFO - [mozharness: 2016-08-26 08:35:23.020238Z] Finished run-tests step (success) 01:35:23 INFO - Running post-run listener: _resource_record_post_run 01:35:23 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418377728; Read time: 12; Write time: 287252 01:35:23 INFO - TinderboxPrint: CPU usage
13.3% 01:35:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:35:23 INFO - TinderboxPrint: I/O write bytes / time
418,377,728 / 287,252 01:35:23 INFO - TinderboxPrint: CPU idle
8,243.1 (86.6%) 01:35:23 INFO - TinderboxPrint: CPU user
1,210.6 (12.7%) 01:35:23 INFO - TinderboxPrint: Swap in / out
0 / 0 01:35:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128798720; Read time: 0; Write time: 89988 01:35:23 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 288681984; Read time: 0; Write time: 197244 01:35:23 INFO - Running post-run listener: _upload_blobber_files 01:35:23 INFO - Blob upload gear active. 01:35:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:35:23 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 01:35:23 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:35:23 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:35:24 INFO - (blobuploader) - INFO - Open directory for files ... 01:35:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:35:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:35:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:35:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:35:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:35:25 INFO - (blobuploader) - INFO - Done attempting. 01:35:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:35:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:35:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:35:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:35:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:35:30 INFO - (blobuploader) - INFO - Done attempting. 01:35:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:35:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:35:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:35:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:35:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:35:31 INFO - (blobuploader) - INFO - Done attempting. 01:35:31 INFO - (blobuploader) - INFO - Iteration through files over. 01:35:31 INFO - Return code: 0 01:35:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:35:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:35:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1b172ce9fe52d1a06092fdc1482a18bee2e5bd6da16799f1c499feb70658ef427f9cb435813b0353bbc2b89e733e832a7a8b381d5e6f0d5d35e0394ad5520264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/43e13e40390405ea15259def95388c44b3f9c08f7578036e137a7728e06a5e932be275ae16e3b5e9549b9343f9d1d6f44d0123dfe4240d4f4cc634a7e06afd88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/420b5023d2e02ee1c069aadff43709a25290f3ec6a514dde221691fc3878dea683b539d4b4253f8ab5d998d4a853e8314b0103bffdeb17b050800cf94748b343"} 01:35:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:35:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:35:31 INFO - Contents: 01:35:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1b172ce9fe52d1a06092fdc1482a18bee2e5bd6da16799f1c499feb70658ef427f9cb435813b0353bbc2b89e733e832a7a8b381d5e6f0d5d35e0394ad5520264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/43e13e40390405ea15259def95388c44b3f9c08f7578036e137a7728e06a5e932be275ae16e3b5e9549b9343f9d1d6f44d0123dfe4240d4f4cc634a7e06afd88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/420b5023d2e02ee1c069aadff43709a25290f3ec6a514dde221691fc3878dea683b539d4b4253f8ab5d998d4a853e8314b0103bffdeb17b050800cf94748b343"} 01:35:31 INFO - Running post-run listener: copy_logs_to_upload_dir 01:35:31 INFO - Copying logs to upload dir... 01:35:31 INFO - mkdir: /builds/slave/test/build/upload/logs 01:35:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.706160 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-26 01:35:30.969151) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 01:35:30.972436) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414 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/Mozilla-Inbound/sha512/1b172ce9fe52d1a06092fdc1482a18bee2e5bd6da16799f1c499feb70658ef427f9cb435813b0353bbc2b89e733e832a7a8b381d5e6f0d5d35e0394ad5520264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/43e13e40390405ea15259def95388c44b3f9c08f7578036e137a7728e06a5e932be275ae16e3b5e9549b9343f9d1d6f44d0123dfe4240d4f4cc634a7e06afd88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/420b5023d2e02ee1c069aadff43709a25290f3ec6a514dde221691fc3878dea683b539d4b4253f8ab5d998d4a853e8314b0103bffdeb17b050800cf94748b343"} build_url:https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/QFauMh6JQ8eAKOZeTqCgEg/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/Mozilla-Inbound/sha512/1b172ce9fe52d1a06092fdc1482a18bee2e5bd6da16799f1c499feb70658ef427f9cb435813b0353bbc2b89e733e832a7a8b381d5e6f0d5d35e0394ad5520264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/43e13e40390405ea15259def95388c44b3f9c08f7578036e137a7728e06a5e932be275ae16e3b5e9549b9343f9d1d6f44d0123dfe4240d4f4cc634a7e06afd88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/420b5023d2e02ee1c069aadff43709a25290f3ec6a514dde221691fc3878dea683b539d4b4253f8ab5d998d4a853e8314b0103bffdeb17b050800cf94748b343"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 01:35:30.999543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 01:35:31.000396) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1472197610.876302-2055939414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 01:35:31.083673) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 01:35:31.083999) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 01:35:31.084292) ========= ========= Total master_lag: 0.18 =========