builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1470460920.17 results: success (0) buildid: 20160805193003 builduid: def840ba1c0b426ca8dec567efe5b95a revision: 731d13870f6a161f47ab8bffe5ee8e2ac92d5195 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 22:22:00.167730) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 22:22:00.168130) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 22:22:00.168420) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 22:22:00.210813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 22:22:00.211080) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 22:22:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 212M=0s 2016-08-05 22:22:00 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.364662 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 22:22:00.590275) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 22:22:00.590633) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016105 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 22:22:00.640393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 22:22:00.640770) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 731d13870f6a161f47ab8bffe5ee8e2ac92d5195 --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 731d13870f6a161f47ab8bffe5ee8e2ac92d5195 --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=bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 22:22:01,065 truncating revision to first 12 chars 2016-08-05 22:22:01,065 Setting DEBUG logging. 2016-08-05 22:22:01,065 attempt 1/10 2016-08-05 22:22:01,065 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/731d13870f6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 22:22:01,750 unpacking tar archive at: mozilla-inbound-731d13870f6a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.038959 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 22:22:01.693533) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 22:22:01.693901) ========= script_repo_revision: 731d13870f6a161f47ab8bffe5ee8e2ac92d5195 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 22:22:01.694343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 22:22:01.694635) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 22:22:01.705694) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-05 22:22:01.705974) ========= /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=bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:22:02 INFO - MultiFileLogger online at 20160805 22:22:02 in /builds/slave/test 22:22:02 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 22:22:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:22:02 INFO - {'append_to_log': False, 22:22:02 INFO - 'base_work_dir': '/builds/slave/test', 22:22:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:22:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:22:02 INFO - 'branch': 'Mozilla-Inbound', 22:22:02 INFO - 'buildbot_json_path': 'buildprops.json', 22:22:02 INFO - 'config_files': ('talos/linux_config.py',), 22:22:02 INFO - 'default_actions': ('clobber', 22:22:02 INFO - 'read-buildbot-config', 22:22:02 INFO - 'download-and-extract', 22:22:02 INFO - 'populate-webroot', 22:22:02 INFO - 'create-virtualenv', 22:22:02 INFO - 'install', 22:22:02 INFO - 'run-tests'), 22:22:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:22:02 INFO - 'download_minidump_stackwalk': True, 22:22:02 INFO - 'download_symbols': 'ondemand', 22:22:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:22:02 INFO - 'tooltool.py': '/tools/tooltool.py', 22:22:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:22:02 INFO - '/tools/misc-python/virtualenv.py')}, 22:22:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:22:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:22:02 INFO - 'installer_path': 'installer.exe', 22:22:02 INFO - 'log_level': 'info', 22:22:02 INFO - 'log_name': 'talos', 22:22:02 INFO - 'log_to_console': True, 22:22:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:22:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:22:02 INFO - 'opt_config_files': (), 22:22:02 INFO - 'pip_index': False, 22:22:02 INFO - 'sps_profile': False, 22:22:02 INFO - 'sps_profile_interval': 0, 22:22:02 INFO - 'suite': 'dromaeojs-e10s', 22:22:02 INFO - 'system_bits': '32', 22:22:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:22:02 INFO - 'title': 'talos-linux64-ix-055', 22:22:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:22:02 INFO - 'use_talos_json': True, 22:22:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:22:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:22:02 INFO - 'work_dir': 'build'} 22:22:02 INFO - [mozharness: 2016-08-06 05:22:02.220658Z] Running clobber step. 22:22:02 INFO - Running pre-action listener: _resource_record_pre_action 22:22:02 INFO - Running main action method: clobber 22:22:02 INFO - rmtree: /builds/slave/test/build 22:22:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:22:03 INFO - Running post-action listener: _resource_record_post_action 22:22:03 INFO - [mozharness: 2016-08-06 05:22:03.207067Z] Finished clobber step (success) 22:22:03 INFO - [mozharness: 2016-08-06 05:22:03.207168Z] Running read-buildbot-config step. 22:22:03 INFO - Running pre-action listener: _resource_record_pre_action 22:22:03 INFO - Running main action method: read_buildbot_config 22:22:03 INFO - Using buildbot properties: 22:22:03 INFO - { 22:22:03 INFO - "project": "", 22:22:03 INFO - "product": "firefox", 22:22:03 INFO - "script_repo_revision": "production", 22:22:03 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:22:03 INFO - "repository": "", 22:22:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:22:03 INFO - "buildid": "20160805193003", 22:22:03 INFO - "pgo_build": "True", 22:22:03 INFO - "basedir": "/builds/slave/test", 22:22:03 INFO - "buildnumber": 959, 22:22:03 INFO - "slavename": "talos-linux64-ix-055", 22:22:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:22:03 INFO - "platform": "ubuntu64_hw", 22:22:03 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:22:03 INFO - "branch": "mozilla-inbound", 22:22:03 INFO - "repo_path": "integration/mozilla-inbound", 22:22:03 INFO - "revision": "731d13870f6a161f47ab8bffe5ee8e2ac92d5195", 22:22:03 INFO - "stage_platform": "linux64-pgo", 22:22:03 INFO - "builduid": "def840ba1c0b426ca8dec567efe5b95a", 22:22:03 INFO - "slavebuilddir": "test" 22:22:03 INFO - } 22:22:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 22:22:03 INFO - Running post-action listener: _resource_record_post_action 22:22:03 INFO - [mozharness: 2016-08-06 05:22:03.209621Z] Finished read-buildbot-config step (success) 22:22:03 INFO - [mozharness: 2016-08-06 05:22:03.209709Z] Running download-and-extract step. 22:22:03 INFO - Running pre-action listener: _resource_record_pre_action 22:22:03 INFO - Running main action method: download_and_extract 22:22:03 INFO - mkdir: /builds/slave/test/build/tests 22:22:03 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')]} 22:22:03 INFO - trying https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:22:03 INFO - Downloading https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/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 22:22:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/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 22:22:03 INFO - Downloaded 1361 bytes. 22:22:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:22:03 INFO - Using the following test package requirements: 22:22:03 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:22:03 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:22:03 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:22:03 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:03 INFO - u'jsshell-linux-x86_64.zip'], 22:22:03 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:22:03 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:22:03 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:22:03 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:22:03 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:22:03 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:22:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:22:03 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')]} 22:22:03 INFO - trying https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:22:03 INFO - Downloading https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/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 22:22:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/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 22:22:05 INFO - Downloaded 21827257 bytes. 22:22:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:22:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:22:06 INFO - Return code: 0 22:22:06 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:06 INFO - trying https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:22:06 INFO - Downloading https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/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 22:22:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/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 22:22:07 INFO - Downloaded 21827257 bytes. 22:22:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:22:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:22:08 INFO - Return code: 0 22:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:08 INFO - trying https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 22:22:08 INFO - Downloading https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/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 22:22:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/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 22:22:09 INFO - Downloaded 14413723 bytes. 22:22:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:22:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:22:09 INFO - Return code: 0 22:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:09 INFO - trying https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:22:09 INFO - Downloading https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/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 22:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/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 22:22:11 INFO - Downloaded 59969378 bytes. 22:22:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:22:11 INFO - mkdir: /builds/slave/test/properties 22:22:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:22:11 INFO - Writing to file /builds/slave/test/properties/build_url 22:22:11 INFO - Contents: 22:22:11 INFO - build_url:https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:22:11 INFO - Running post-action listener: _resource_record_post_action 22:22:11 INFO - Running post-action listener: set_extra_try_arguments 22:22:11 INFO - [mozharness: 2016-08-06 05:22:11.896698Z] Finished download-and-extract step (success) 22:22:11 INFO - [mozharness: 2016-08-06 05:22:11.896930Z] Running populate-webroot step. 22:22:11 INFO - Running pre-action listener: _resource_record_pre_action 22:22:11 INFO - Running main action method: populate_webroot 22:22:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:22:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:22:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:22:11 INFO - '--tppagecycles', 22:22:11 INFO - '7'], 22:22:11 INFO - 'tests': ['tsvgm']}}, 22:22:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:22:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:22:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:22:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:22:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:22:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:22:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:11 INFO - 'talos_options': ['--disable-e10s'], 22:22:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:11 INFO - 'talos_options': ['--disable-e10s'], 22:22:11 INFO - 'tests': ['damp', 'tps']}, 22:22:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:11 INFO - 'tests': ['damp', 'tps']}, 22:22:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:22:11 INFO - 'tests': ['dromaeo_dom']}, 22:22:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:22:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:22:11 INFO - 'tests': ['basic_compositor_video']}, 22:22:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:22:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:22:11 INFO - 'tests': ['a11yr', 22:22:11 INFO - 'ts_paint', 22:22:11 INFO - 'tpaint', 22:22:11 INFO - 'sessionrestore', 22:22:11 INFO - 'sessionrestore_no_auto_restore', 22:22:11 INFO - 'tabpaint']}, 22:22:11 INFO - 'other-e10s': {'tests': ['a11yr', 22:22:11 INFO - 'ts_paint', 22:22:11 INFO - 'tpaint', 22:22:11 INFO - 'sessionrestore', 22:22:11 INFO - 'sessionrestore_no_auto_restore', 22:22:11 INFO - 'tabpaint']}, 22:22:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:22:11 INFO - 'ts_paint', 22:22:11 INFO - 'tpaint', 22:22:11 INFO - 'sessionrestore', 22:22:11 INFO - 'sessionrestore_no_auto_restore', 22:22:11 INFO - 'tabpaint']}, 22:22:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:22:11 INFO - 'ts_paint', 22:22:11 INFO - 'tpaint', 22:22:11 INFO - 'sessionrestore', 22:22:11 INFO - 'sessionrestore_no_auto_restore', 22:22:11 INFO - 'tabpaint']}, 22:22:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:22:11 INFO - 'tests': ['a11yr', 22:22:11 INFO - 'ts_paint', 22:22:11 INFO - 'tpaint', 22:22:11 INFO - 'sessionrestore', 22:22:11 INFO - 'sessionrestore_no_auto_restore', 22:22:11 INFO - 'tabpaint']}, 22:22:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:22:11 INFO - 'tests': ['a11yr', 22:22:11 INFO - 'ts_paint', 22:22:11 INFO - 'tpaint', 22:22:11 INFO - 'sessionrestore', 22:22:11 INFO - 'sessionrestore_no_auto_restore', 22:22:11 INFO - 'tabpaint']}, 22:22:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:22:11 INFO - 'tests': ['tsvgx', 22:22:11 INFO - 'tsvgr_opacity', 22:22:11 INFO - 'tart', 22:22:11 INFO - 'tscrollx', 22:22:11 INFO - 'cart']}, 22:22:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:22:11 INFO - 'tsvgr_opacity', 22:22:11 INFO - 'tart', 22:22:11 INFO - 'tscrollx', 22:22:11 INFO - 'cart']}, 22:22:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:11 INFO - 'talos_options': ['--disable-e10s'], 22:22:11 INFO - 'tests': ['tp5o']}, 22:22:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:11 INFO - 'tests': ['tp5o']}, 22:22:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:11 INFO - 'talos_options': ['--disable-e10s', 22:22:11 INFO - '--xperf_path', 22:22:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:11 INFO - 'tests': ['tp5n']}, 22:22:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:11 INFO - 'talos_options': ['--xperf_path', 22:22:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:11 INFO - 'tests': ['tp5n']}}, 22:22:11 INFO - 'talos.zip': {'path': '', 22:22:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:22:11 INFO - Running post-action listener: _resource_record_post_action 22:22:11 INFO - [mozharness: 2016-08-06 05:22:11.914624Z] Finished populate-webroot step (success) 22:22:11 INFO - [mozharness: 2016-08-06 05:22:11.914712Z] Running create-virtualenv step. 22:22:11 INFO - Running pre-action listener: _resource_record_pre_action 22:22:11 INFO - Running main action method: create_virtualenv 22:22:11 INFO - Creating virtualenv /builds/slave/test/build/venv 22:22:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:22:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:22:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:22:12 INFO - Using real prefix '/usr' 22:22:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:22:12 INFO - Installing distribute.............................................................................................................................................................................................done. 22:22:14 INFO - Installing pip.................done. 22:22:14 INFO - Return code: 0 22:22:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4570>, '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 0x2cf5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', '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 22:22:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:22:14 INFO - Using env: {'DISPLAY': ':0', 22:22:14 INFO - 'HOME': '/home/cltbld', 22:22:14 INFO - 'LANG': 'en_US.UTF-8', 22:22:14 INFO - 'LANGUAGE': 'en_US:en', 22:22:14 INFO - 'LOGNAME': 'cltbld', 22:22:14 INFO - 'MAIL': '/var/mail/cltbld', 22:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:14 INFO - 'MOZ_NO_REMOTE': '1', 22:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:14 INFO - 'NO_EM_RESTART': '1', 22:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:14 INFO - 'PWD': '/builds/slave/test', 22:22:14 INFO - 'SHELL': '/bin/bash', 22:22:14 INFO - 'SHLVL': '1', 22:22:14 INFO - 'TERM': 'linux', 22:22:14 INFO - 'TMOUT': '86400', 22:22:14 INFO - 'USER': 'cltbld', 22:22:14 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', 22:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:14 INFO - '_': '/tools/buildbot/bin/python'} 22:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:22:14 INFO - Cleaning up... 22:22:14 INFO - Return code: 0 22:22:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4570>, '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 0x2cf5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', '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 22:22:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:22:14 INFO - Using env: {'DISPLAY': ':0', 22:22:14 INFO - 'HOME': '/home/cltbld', 22:22:14 INFO - 'LANG': 'en_US.UTF-8', 22:22:14 INFO - 'LANGUAGE': 'en_US:en', 22:22:14 INFO - 'LOGNAME': 'cltbld', 22:22:14 INFO - 'MAIL': '/var/mail/cltbld', 22:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:14 INFO - 'MOZ_NO_REMOTE': '1', 22:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:14 INFO - 'NO_EM_RESTART': '1', 22:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:14 INFO - 'PWD': '/builds/slave/test', 22:22:14 INFO - 'SHELL': '/bin/bash', 22:22:14 INFO - 'SHLVL': '1', 22:22:14 INFO - 'TERM': 'linux', 22:22:14 INFO - 'TMOUT': '86400', 22:22:14 INFO - 'USER': 'cltbld', 22:22:14 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', 22:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:14 INFO - '_': '/tools/buildbot/bin/python'} 22:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:14 INFO - Downloading/unpacking psutil>=3.1.1 22:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:22:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:22:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:22:16 INFO - Installing collected packages: psutil 22:22:16 INFO - Running setup.py install for psutil 22:22:16 INFO - building 'psutil._psutil_linux' extension 22:22:16 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 22:22:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:22:17 INFO - building 'psutil._psutil_posix' extension 22:22:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:22:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:22:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:22:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:22:17 INFO - Successfully installed psutil 22:22:17 INFO - Cleaning up... 22:22:17 INFO - Return code: 0 22:22:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4570>, '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 0x2cf5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', '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 22:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:22:17 INFO - Using env: {'DISPLAY': ':0', 22:22:17 INFO - 'HOME': '/home/cltbld', 22:22:17 INFO - 'LANG': 'en_US.UTF-8', 22:22:17 INFO - 'LANGUAGE': 'en_US:en', 22:22:17 INFO - 'LOGNAME': 'cltbld', 22:22:17 INFO - 'MAIL': '/var/mail/cltbld', 22:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:17 INFO - 'MOZ_NO_REMOTE': '1', 22:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:17 INFO - 'NO_EM_RESTART': '1', 22:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:17 INFO - 'PWD': '/builds/slave/test', 22:22:17 INFO - 'SHELL': '/bin/bash', 22:22:17 INFO - 'SHLVL': '1', 22:22:17 INFO - 'TERM': 'linux', 22:22:17 INFO - 'TMOUT': '86400', 22:22:17 INFO - 'USER': 'cltbld', 22:22:17 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', 22:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:17 INFO - '_': '/tools/buildbot/bin/python'} 22:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:22: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 22:22: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 22:22: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 22:22: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 22:22: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 22:22: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 22:22:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:22:19 INFO - Installing collected packages: mozsystemmonitor 22:22:19 INFO - Running setup.py install for mozsystemmonitor 22:22:19 INFO - Successfully installed mozsystemmonitor 22:22:19 INFO - Cleaning up... 22:22:19 INFO - Return code: 0 22:22:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4570>, '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 0x2cf5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', '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 22:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:22:19 INFO - Using env: {'DISPLAY': ':0', 22:22:19 INFO - 'HOME': '/home/cltbld', 22:22:19 INFO - 'LANG': 'en_US.UTF-8', 22:22:19 INFO - 'LANGUAGE': 'en_US:en', 22:22:19 INFO - 'LOGNAME': 'cltbld', 22:22:19 INFO - 'MAIL': '/var/mail/cltbld', 22:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:19 INFO - 'MOZ_NO_REMOTE': '1', 22:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:19 INFO - 'NO_EM_RESTART': '1', 22:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:19 INFO - 'PWD': '/builds/slave/test', 22:22:19 INFO - 'SHELL': '/bin/bash', 22:22:19 INFO - 'SHLVL': '1', 22:22:19 INFO - 'TERM': 'linux', 22:22:19 INFO - 'TMOUT': '86400', 22:22:19 INFO - 'USER': 'cltbld', 22:22:19 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', 22:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:19 INFO - '_': '/tools/buildbot/bin/python'} 22:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:19 INFO - Downloading/unpacking jsonschema==2.5.1 22:22:19 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 22:22:19 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 22:22:19 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 22:22:19 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 22:22:19 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 22:22:19 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 22:22:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:22:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:22 INFO - Downloading functools32-3.2.3-2.tar.gz 22:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:22:22 INFO - warning: no files found matching '*.txt' 22:22:22 INFO - no previously-included directories found matching 'build' 22:22:22 INFO - no previously-included directories found matching 'dist' 22:22:22 INFO - no previously-included directories found matching '.git*' 22:22:22 INFO - Installing collected packages: jsonschema, functools32 22:22:22 INFO - Running setup.py install for functools32 22:22:22 INFO - warning: no files found matching '*.txt' 22:22:22 INFO - no previously-included directories found matching 'build' 22:22:22 INFO - no previously-included directories found matching 'dist' 22:22:22 INFO - no previously-included directories found matching '.git*' 22:22:22 INFO - Successfully installed jsonschema functools32 22:22:22 INFO - Cleaning up... 22:22:22 INFO - Return code: 0 22:22:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4570>, '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 0x2cf5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', '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 22:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:22:22 INFO - Using env: {'DISPLAY': ':0', 22:22:22 INFO - 'HOME': '/home/cltbld', 22:22:22 INFO - 'LANG': 'en_US.UTF-8', 22:22:22 INFO - 'LANGUAGE': 'en_US:en', 22:22:22 INFO - 'LOGNAME': 'cltbld', 22:22:22 INFO - 'MAIL': '/var/mail/cltbld', 22:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:22 INFO - 'MOZ_NO_REMOTE': '1', 22:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:22 INFO - 'NO_EM_RESTART': '1', 22:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:22 INFO - 'PWD': '/builds/slave/test', 22:22:22 INFO - 'SHELL': '/bin/bash', 22:22:22 INFO - 'SHLVL': '1', 22:22:22 INFO - 'TERM': 'linux', 22:22:22 INFO - 'TMOUT': '86400', 22:22:22 INFO - 'USER': 'cltbld', 22:22:22 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', 22:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:22 INFO - '_': '/tools/buildbot/bin/python'} 22:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:22:22 INFO - Cleaning up... 22:22:22 INFO - Return code: 0 22:22:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4570>, '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 0x2cf5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', '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 22:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:22:22 INFO - Using env: {'DISPLAY': ':0', 22:22:22 INFO - 'HOME': '/home/cltbld', 22:22:22 INFO - 'LANG': 'en_US.UTF-8', 22:22:22 INFO - 'LANGUAGE': 'en_US:en', 22:22:22 INFO - 'LOGNAME': 'cltbld', 22:22:22 INFO - 'MAIL': '/var/mail/cltbld', 22:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:22 INFO - 'MOZ_NO_REMOTE': '1', 22:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:22 INFO - 'NO_EM_RESTART': '1', 22:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:22 INFO - 'PWD': '/builds/slave/test', 22:22:22 INFO - 'SHELL': '/bin/bash', 22:22:22 INFO - 'SHLVL': '1', 22:22:22 INFO - 'TERM': 'linux', 22:22:22 INFO - 'TMOUT': '86400', 22:22:22 INFO - 'USER': 'cltbld', 22:22:22 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', 22:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:22 INFO - '_': '/tools/buildbot/bin/python'} 22:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:22 INFO - Downloading/unpacking blobuploader==1.2.4 22:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:24 INFO - Downloading blobuploader-1.2.4.tar.gz 22:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:22:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:22:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:25 INFO - Downloading docopt-0.6.1.tar.gz 22:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:22:25 INFO - Installing collected packages: blobuploader, requests, docopt 22:22:25 INFO - Running setup.py install for blobuploader 22:22:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:22:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:22:25 INFO - Running setup.py install for requests 22:22:25 INFO - Running setup.py install for docopt 22:22:25 INFO - Successfully installed blobuploader requests docopt 22:22:25 INFO - Cleaning up... 22:22:25 INFO - Return code: 0 22:22:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:22: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')]} 22:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22: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')]} 22:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:25 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 0x2a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4570>, '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 0x2cf5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', '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 22:22:25 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 22:22:25 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 22:22:25 INFO - Using env: {'DISPLAY': ':0', 22:22:25 INFO - 'HOME': '/home/cltbld', 22:22:25 INFO - 'LANG': 'en_US.UTF-8', 22:22:25 INFO - 'LANGUAGE': 'en_US:en', 22:22:25 INFO - 'LOGNAME': 'cltbld', 22:22:25 INFO - 'MAIL': '/var/mail/cltbld', 22:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:25 INFO - 'MOZ_NO_REMOTE': '1', 22:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:25 INFO - 'NO_EM_RESTART': '1', 22:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:25 INFO - 'PWD': '/builds/slave/test', 22:22:25 INFO - 'SHELL': '/bin/bash', 22:22:25 INFO - 'SHLVL': '1', 22:22:25 INFO - 'TERM': 'linux', 22:22:25 INFO - 'TMOUT': '86400', 22:22:25 INFO - 'USER': 'cltbld', 22:22:25 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', 22:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:25 INFO - '_': '/tools/buildbot/bin/python'} 22:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:22:26 INFO - Running setup.py (path:/tmp/pip-w7mJdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:22:26 INFO - Running setup.py (path:/tmp/pip-RIueiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:22:26 INFO - Running setup.py (path:/tmp/pip-Mtk88A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:22:26 INFO - Running setup.py (path:/tmp/pip-PPRgOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:22:26 INFO - Running setup.py (path:/tmp/pip-vO3Qas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:22:26 INFO - Running setup.py (path:/tmp/pip-oNC4xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:22:26 INFO - Running setup.py (path:/tmp/pip-p91Abw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:22:26 INFO - Running setup.py (path:/tmp/pip-voRUXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:22:26 INFO - Running setup.py (path:/tmp/pip-T_kr0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:22:26 INFO - Running setup.py (path:/tmp/pip-wD8mVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:22:26 INFO - Running setup.py (path:/tmp/pip-UFtduZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:22:27 INFO - Running setup.py (path:/tmp/pip-FhyIfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:22:27 INFO - Running setup.py (path:/tmp/pip-YRMQVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:22:27 INFO - Running setup.py (path:/tmp/pip-QiFI23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:27 INFO - Running setup.py (path:/tmp/pip-xkbDag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:22:27 INFO - Running setup.py (path:/tmp/pip-r4SnzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:22:27 INFO - Running setup.py (path:/tmp/pip-0Ixbhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:22:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:22:27 INFO - Running setup.py install for manifestparser 22:22:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:22:27 INFO - Running setup.py install for mozcrash 22:22:27 INFO - Running setup.py install for mozdebug 22:22:27 INFO - Running setup.py install for mozdevice 22:22:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:22:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:22:27 INFO - Running setup.py install for mozfile 22:22:27 INFO - Running setup.py install for mozhttpd 22:22:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:22:28 INFO - Running setup.py install for mozinfo 22:22:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:22:28 INFO - Running setup.py install for mozInstall 22:22:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:22:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:22:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:22:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:22:28 INFO - Running setup.py install for mozleak 22:22:28 INFO - Running setup.py install for mozlog 22:22:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:22:28 INFO - Running setup.py install for moznetwork 22:22:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:22:28 INFO - Running setup.py install for mozprocess 22:22:28 INFO - Running setup.py install for mozprofile 22:22:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:22:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:22:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:22:28 INFO - Running setup.py install for mozrunner 22:22:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:22:28 INFO - Running setup.py install for mozscreenshot 22:22:29 INFO - Running setup.py install for moztest 22:22:29 INFO - Running setup.py install for mozversion 22:22:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:22:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:22:29 INFO - Cleaning up... 22:22:29 INFO - Return code: 0 22:22:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:22: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')]} 22:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22: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')]} 22:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4570>, '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 0x2cf5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', '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 22:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:22:29 INFO - Using env: {'DISPLAY': ':0', 22:22:29 INFO - 'HOME': '/home/cltbld', 22:22:29 INFO - 'LANG': 'en_US.UTF-8', 22:22:29 INFO - 'LANGUAGE': 'en_US:en', 22:22:29 INFO - 'LOGNAME': 'cltbld', 22:22:29 INFO - 'MAIL': '/var/mail/cltbld', 22:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:29 INFO - 'MOZ_NO_REMOTE': '1', 22:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:29 INFO - 'NO_EM_RESTART': '1', 22:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:29 INFO - 'PWD': '/builds/slave/test', 22:22:29 INFO - 'SHELL': '/bin/bash', 22:22:29 INFO - 'SHLVL': '1', 22:22:29 INFO - 'TERM': 'linux', 22:22:29 INFO - 'TMOUT': '86400', 22:22:29 INFO - 'USER': 'cltbld', 22:22:29 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', 22:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:29 INFO - '_': '/tools/buildbot/bin/python'} 22:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:22:29 INFO - Running setup.py (path:/tmp/pip-b3uQBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:22:29 INFO - Running setup.py (path:/tmp/pip-iM0Ve9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:22:29 INFO - Running setup.py (path:/tmp/pip-Ptu8PS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:22:29 INFO - Running setup.py (path:/tmp/pip-2LsQfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:22:29 INFO - Running setup.py (path:/tmp/pip-MQ9V2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:22:29 INFO - Running setup.py (path:/tmp/pip-3a2hds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:22:29 INFO - Running setup.py (path:/tmp/pip-K34WUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:22:29 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)) 22:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:22:29 INFO - Running setup.py (path:/tmp/pip-7AEsji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:22:30 INFO - Running setup.py (path:/tmp/pip-yAwTVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:22:30 INFO - Running setup.py (path:/tmp/pip-fNvhBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:22:30 INFO - Running setup.py (path:/tmp/pip-zppHRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:22:30 INFO - Running setup.py (path:/tmp/pip-0oPVY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:22:30 INFO - Running setup.py (path:/tmp/pip-sraE1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:22:30 INFO - Running setup.py (path:/tmp/pip-iOXE2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:30 INFO - Running setup.py (path:/tmp/pip-JthKUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:22:30 INFO - Running setup.py (path:/tmp/pip-v63NEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:22:30 INFO - Running setup.py (path:/tmp/pip-HZ6Y7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:22:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:32 INFO - Downloading blessings-1.6.tar.gz 22:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:22:32 INFO - Installing collected packages: blessings 22:22:32 INFO - Running setup.py install for blessings 22:22:32 INFO - Successfully installed blessings 22:22:32 INFO - Cleaning up... 22:22:32 INFO - Return code: 0 22:22:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:22:33 INFO - Reading from file tmpfile_stdout 22:22:33 INFO - Current package versions: 22:22:33 INFO - argparse == 1.2.1 22:22:33 INFO - blessings == 1.6 22:22:33 INFO - blobuploader == 1.2.4 22:22:33 INFO - docopt == 0.6.1 22:22:33 INFO - functools32 == 3.2.3-2 22:22:33 INFO - jsonschema == 2.5.1 22:22:33 INFO - manifestparser == 1.1 22:22:33 INFO - mozInstall == 1.12 22:22:33 INFO - mozcrash == 0.17 22:22:33 INFO - mozdebug == 0.1 22:22:33 INFO - mozdevice == 0.48 22:22:33 INFO - mozfile == 1.2 22:22:33 INFO - mozhttpd == 0.7 22:22:33 INFO - mozinfo == 0.9 22:22:33 INFO - mozleak == 0.1 22:22:33 INFO - mozlog == 3.3 22:22:33 INFO - moznetwork == 0.27 22:22:33 INFO - mozprocess == 0.23 22:22:33 INFO - mozprofile == 0.28 22:22:33 INFO - mozrunner == 6.12 22:22:33 INFO - mozscreenshot == 0.1 22:22:33 INFO - mozsystemmonitor == 0.3 22:22:33 INFO - moztest == 0.7 22:22:33 INFO - mozversion == 1.4 22:22:33 INFO - psutil == 3.1.1 22:22:33 INFO - requests == 1.2.3 22:22:33 INFO - wsgiref == 0.1.2 22:22:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4570>, '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 0x2cf5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', '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 22:22:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:22:33 INFO - Using env: {'DISPLAY': ':0', 22:22:33 INFO - 'HOME': '/home/cltbld', 22:22:33 INFO - 'LANG': 'en_US.UTF-8', 22:22:33 INFO - 'LANGUAGE': 'en_US:en', 22:22:33 INFO - 'LOGNAME': 'cltbld', 22:22:33 INFO - 'MAIL': '/var/mail/cltbld', 22:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:33 INFO - 'MOZ_NO_REMOTE': '1', 22:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:33 INFO - 'NO_EM_RESTART': '1', 22:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:33 INFO - 'PWD': '/builds/slave/test', 22:22:33 INFO - 'SHELL': '/bin/bash', 22:22:33 INFO - 'SHLVL': '1', 22:22:33 INFO - 'TERM': 'linux', 22:22:33 INFO - 'TMOUT': '86400', 22:22:33 INFO - 'USER': 'cltbld', 22:22:33 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', 22:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:33 INFO - '_': '/tools/buildbot/bin/python'} 22:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:22:33 INFO - Cleaning up... 22:22:33 INFO - Return code: 0 22:22:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4570>, '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 0x2cf5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5900>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', '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 22:22:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:22:33 INFO - Using env: {'DISPLAY': ':0', 22:22:33 INFO - 'HOME': '/home/cltbld', 22:22:33 INFO - 'LANG': 'en_US.UTF-8', 22:22:33 INFO - 'LANGUAGE': 'en_US:en', 22:22:33 INFO - 'LOGNAME': 'cltbld', 22:22:33 INFO - 'MAIL': '/var/mail/cltbld', 22:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:33 INFO - 'MOZ_NO_REMOTE': '1', 22:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:33 INFO - 'NO_EM_RESTART': '1', 22:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:33 INFO - 'PWD': '/builds/slave/test', 22:22:33 INFO - 'SHELL': '/bin/bash', 22:22:33 INFO - 'SHLVL': '1', 22:22:33 INFO - 'TERM': 'linux', 22:22:33 INFO - 'TMOUT': '86400', 22:22:33 INFO - 'USER': 'cltbld', 22:22:33 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', 22:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:33 INFO - '_': '/tools/buildbot/bin/python'} 22:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:22:33 INFO - Cleaning up... 22:22:33 INFO - Return code: 0 22:22:33 INFO - Running post-action listener: _resource_record_post_action 22:22:33 INFO - Running post-action listener: _start_resource_monitoring 22:22:33 INFO - Starting resource monitoring. 22:22:33 INFO - [mozharness: 2016-08-06 05:22:33.508337Z] Finished create-virtualenv step (success) 22:22:33 INFO - [mozharness: 2016-08-06 05:22:33.508813Z] Running install step. 22:22:33 INFO - Running pre-action listener: _resource_record_pre_action 22:22:33 INFO - Running main action method: install 22:22:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:22:33 INFO - Reading from file tmpfile_stdout 22:22:33 INFO - Detecting whether we're running mozinstall >=1.0... 22:22:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:22:33 INFO - Reading from file tmpfile_stdout 22:22:33 INFO - Output received: 22:22:33 INFO - Usage: mozinstall [options] installer 22:22:33 INFO - Options: 22:22:33 INFO - -h, --help show this help message and exit 22:22:33 INFO - -d DEST, --destination=DEST 22:22:33 INFO - Directory to install application into. [default: 22:22:33 INFO - "/builds/slave/test"] 22:22:33 INFO - --app=APP Application being installed. [default: firefox] 22:22:33 INFO - mkdir: /builds/slave/test/build/application 22:22:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:22:50 INFO - Reading from file tmpfile_stdout 22:22:50 INFO - Output received: 22:22:50 INFO - /builds/slave/test/build/application/firefox/firefox 22:22:50 INFO - Running post-action listener: _resource_record_post_action 22:22:50 INFO - [mozharness: 2016-08-06 05:22:50.860967Z] Finished install step (success) 22:22:50 INFO - [mozharness: 2016-08-06 05:22:50.861213Z] Running run-tests step. 22:22:50 INFO - Running pre-action listener: _resource_record_pre_action 22:22:50 INFO - Running main action method: run_tests 22:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:22:50 INFO - Python 2.7.3 22:22:50 INFO - Return code: 0 22:22:50 INFO - grabbing minidump binary from tooltool 22:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:50 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4570>, '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 0x2cf5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:22:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:22:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:22:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:22:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:22:50 INFO - Return code: 0 22:22:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:22:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:22:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:22:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:22:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:22:50 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/SHyhuRHbRwikE1DLSb2Lig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 22:22:50 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/SHyhuRHbRwikE1DLSb2Lig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 22:22:50 INFO - Using env: {'DISPLAY': ':0', 22:22:50 INFO - 'HOME': '/home/cltbld', 22:22:50 INFO - 'LANG': 'en_US.UTF-8', 22:22:50 INFO - 'LANGUAGE': 'en_US:en', 22:22:50 INFO - 'LOGNAME': 'cltbld', 22:22:50 INFO - 'MAIL': '/var/mail/cltbld', 22:22:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:22:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:50 INFO - 'MOZ_NO_REMOTE': '1', 22:22:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:50 INFO - 'NO_EM_RESTART': '1', 22:22:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:50 INFO - 'PWD': '/builds/slave/test', 22:22:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:22:50 INFO - 'SHELL': '/bin/bash', 22:22:50 INFO - 'SHLVL': '1', 22:22:50 INFO - 'TERM': 'linux', 22:22:50 INFO - 'TMOUT': '86400', 22:22:50 INFO - 'USER': 'cltbld', 22:22:50 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620', 22:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:50 INFO - '_': '/tools/buildbot/bin/python'} 22:22:50 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/SHyhuRHbRwikE1DLSb2Lig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 22:22:51 INFO - mozversion application_buildid: 20160805193003 22:22:51 INFO - mozversion application_changeset: 731d13870f6a161f47ab8bffe5ee8e2ac92d5195 22:22:51 INFO - mozversion application_display_name: Nightly 22:22:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:22:51 INFO - mozversion application_name: Firefox 22:22:51 INFO - mozversion application_remotingname: firefox 22:22:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:22:51 INFO - mozversion application_vendor: Mozilla 22:22:51 INFO - mozversion application_version: 51.0a1 22:22:51 INFO - mozversion platform_buildid: 20160805193003 22:22:51 INFO - mozversion platform_changeset: 731d13870f6a161f47ab8bffe5ee8e2ac92d5195 22:22:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:22:51 INFO - mozversion platform_version: 51.0a1 22:22:51 INFO - using testdate: 1470460971 22:22:51 INFO - actual date: 1470460971 22:22:51 INFO - starting webserver on 'localhost:43672' 22:22:51 INFO - SUITE-START | Running 2 tests 22:22:51 INFO - TEST-START | dromaeo_css 22:22:51 INFO - operating with platform_type : linux_ 22:22:51 INFO - Initialising browser for dromaeo_css test... 22:22:51 INFO - TEST-INFO | started process 9984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDumvpg/profile http://localhost:43672/getInfo.html) 22:22:55 INFO - PROCESS | 9984 | __metrics Screen width/height:1600/1200 22:22:55 INFO - PROCESS | 9984 | colorDepth:24 22:22:55 INFO - PROCESS | 9984 | Browser inner width/height: 1024/697 22:22:55 INFO - PROCESS | 9984 | __metrics 22:22:56 ERROR - PROCESS | 9984 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:22:57 INFO - TEST-INFO | 9984: exit 0 22:22:57 INFO - Browser initialized. 22:22:57 INFO - Running cycle 1/1 for dromaeo_css test... 22:22:57 INFO - TEST-INFO | started process 10104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDumvpg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:23:08 INFO - PROCESS | 10104 | RSS: Main: 163520512 22:23:08 INFO - PROCESS | 10104 | 22:23:58 INFO - PROCESS | 10104 | 1470461038297 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] 22:26:08 INFO - PROCESS | 10104 | Cycle 1(1): loaded http://localhost:43672/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43672/tests/dromaeo/cssquery-ext.html) 22:26:09 INFO - PROCESS | 10104 | RSS: Main: 166531072 22:26:09 INFO - PROCESS | 10104 | 22:29:11 INFO - PROCESS | 10104 | Cycle 1(1): loaded http://localhost:43672/tests/dromaeo/cssquery-ext.html (next: http://localhost:43672/tests/dromaeo/cssquery-jquery.html) 22:29:12 INFO - PROCESS | 10104 | RSS: Main: 165744640 22:29:12 INFO - PROCESS | 10104 | 22:32:14 INFO - PROCESS | 10104 | Cycle 1(1): loaded http://localhost:43672/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43672/tests/dromaeo/cssquery-mootools.html) 22:32:14 INFO - PROCESS | 10104 | RSS: Main: 169639936 22:32:14 INFO - PROCESS | 10104 | 22:35:16 INFO - PROCESS | 10104 | Cycle 1(1): loaded http://localhost:43672/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43672/tests/dromaeo/cssquery-prototype.html) 22:35:17 INFO - PROCESS | 10104 | RSS: Main: 163684352 22:35:17 INFO - PROCESS | 10104 | 22:38:19 INFO - PROCESS | 10104 | Cycle 1(1): loaded http://localhost:43672/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43672/tests/dromaeo/cssquery-yui.html) 22:38:20 INFO - PROCESS | 10104 | RSS: Main: 166141952 22:38:20 INFO - PROCESS | 10104 | 22:41:23 INFO - PROCESS | 10104 | Cycle 1(1): loaded http://localhost:43672/tests/dromaeo/cssquery-yui.html (next: http://localhost:43672/tests/dromaeo/cssquery-dojo.html) 22:41:23 INFO - PROCESS | 10104 | RSS: Main: 169271296 22:41:23 INFO - PROCESS | 10104 | 22:41:23 INFO - PROCESS | 10104 | __start_tp_report 22:41:23 INFO - PROCESS | 10104 | _x_x_mozilla_page_load 22:41:23 INFO - PROCESS | 10104 | _x_x_mozilla_page_load_details 22:41:23 INFO - PROCESS | 10104 | |i|pagename|runs| 22:41:23 INFO - PROCESS | 10104 | |0;dojo.html;3053.7098975597314;3058.0672894767085;3093.8453077346135;3094.195509167616;3096.1949893027804;5321.733913304329;5336.119540275855;5357.517823395893;5414.891702165959;5449.863753406167;5377.516023557879;5381.946180538203;5438.564914806816;5455.481729235717;5460.6177567570185;4929.876753081166;4943.505649435064;4990.476000019982;5005.6996580205305;5018.774155163008;4941.975290123544;5002.374703162105;5053.216751403538;5058.988202359525;5097.617678674096;5041.319421878036;5073.619478539106;5087.872803179913;5098.439171691111;5099.566536844354;4862.586680132157;4894.926576101361;4913.26301054841;4937;4943.604511639096;4908.460069392364;4920.6555541111775;4926.433460152092;4928.876778080541;4979.875503112415;5324.440933701983;5339.359276886798;5382.811601593926;5383.650062745948;5448.046591846411;5578.86052848682;5683.857903552403;5756.481916627482;5760.942390576082;5769.798057068025;5788.218590490272;5805;5850.795222167247;5852.853678658025;5864.648121112747;5378.273933019032;5414.052540805344;5418.756155972991;5440.156775699773;5441.727913604304;5756.222909907193;5802.738876750556;5864.970675146682;5906.49794767441;5941.1088336749835;5698.259226300637;5703.372629010805;5715.142728590745;5717.971410142923;5744.339400968858;5772.134179873053;5783.306003279549;5788.131780232999;5792.536597072224;5806.738696758656;5618.747156377973;5672.631278966854;5706.885862282731;5721.141828725641;5730.283714535683;5611.438856114438;5698.772049118072;5749.482546570829;5753.252077229933;5803.767849286066;4443.422355093817;4472.2620767573635;4483.3723278741;4485.1702435048965;4518.367428559938;3926.096997690547;3936.7834769087976;3992.7205095643026;3994.320965435883;4016.0562267867026;5540.36285827135;5591.664500129924;5597.3003374578175;5633.324001119892;5643.7742490299925;5739.8565035874435;5784.219130417424;5792.4497172768515;5834.154047663065;5836.1245813127525;5437.537809286255;5533.114701647797;5573.442655734394;5581.134924086773;5598.664080155204;4965.975170124127;5021.5229553192385;5024.648274620815;5027.949720502748;5097.108006098918;6144.723487443076;6150.415710507584;6152.415520525543;6157.384261573807;6172.69136543171;5837.29952405714;5844.912326315194;5844.912326315194;5845;5845.3277873045145;5963.463288304073;6047.9395206047375;6082.11809287642;6103.023516237381;6145.877082458236;5671.801486947937;5704.914426283692;5715.971420142872;5738.626989245686;5767.134929760569;5858.765649373977;5866.120081987565;5872.412758724094;5875.676837773964;5888.852778680567;5557.44425557441;5639.407862174413;5691.715414229189;5692.032354499662;5765.4522820332;5672.262605861377;5691.089425691869;5691.601587888974;5707.743151558273;5708.5147762439;5362.276092727432;5631.267935168402;5633.0423827948525;5634.718264086861;5650.3219613646625;5596.832095037155;5636.549076073986;5726.828195154152;5728.856778580569;5729.140628905698;5493.313335833021;5574.804881829279;5584.190292407497;5593.608447408642;5671.461211184931 22:41:23 INFO - PROCESS | 10104 | |1;ext.html;544.3688635949823;554.5646667366118;583.4398976982097;604.8004158627654;631.7978246960969;39302.606973930255;43767.34348984764;43779.562204377944;43800;43905.78047109768;43884;44498.33252501215;44502.55497445024;44523.55476445235;44538.109237815304;8882.42264252823;9000.05499422561;9006.59470323837;9015.233705135071;9023.819523609523;8931.10688931105;8982.685606003792;8985.910140898606;8999.955000224989;9026.86459703105;9015;9031.277497800193;9063.229625481841;9072.138146876036;9094.136057074567;8704.086070962552;8717.041125476193;8722.12778722129;8742.737717868475;8745.387822852403;8793.736187914374;8811.515366654832;8858.73423797287;8886.066962968924;8892.73321800347;40859.79570102131;41328.1734365311;41490;41664.79167604173;41710.58289417098;3308.718758905496;3451.741119416054;3495.0912762681887;3563.768355056913;3772.6981841452616;32525.83737081323;33047.50428743571;33154.17114572131;34511.4823277651;34666.82666586651;4093.1813637272667;4134.586541345871;4186.120914607936;4217.304144816102;4260.1479704059;253906;255375;255416;256343;257118;35539.4669079964;36337.63662363395;60278;60736.69631651902;60948.69525652432;37932.81033594815;38080.80959595184;38159.61840381616;38434;38435.80782096127;14563.41746330135;14709.264536773333;14726.852731472762;14743.705125897637;14779.704405912036;10716.410597417216;10771.138308935266;10777.299475534066;10830.241883068109;10864.511097000654;8684.739457816275;8713.695020674373;8722.171393717586;8792.736217913473;8820.280045391215;3141.8586163622235;3150.558921750957;3182;3208.7433005359517;3216.244182617083;915.9267258619294;927.188709878856;928.9907100929039;977.7115750853516;987.3384832162468;31846.522302165486;31851.20371990719;31908.840455798036;32274;32818;1145.7364806094645;1155.2952698853692;1198.3349241171059;1217.433893239648;1254.6612414647993;17189.914050429667;17400.47798566045;17666.293348265925;17766.91116544409;17805.287788488575;572851;573578;574276;575203;575804;62656.37343626597;62677.68661156665;63112.684436577525;63149.684251578445;63164.68417657882;1342.5703774791973;1363.0935427940508;1378.4555100735354;1395.0653062448184;1403.277312184226;30067.548986764778;31174.68825311718;31642.841785790923;33479.83260083684;33935;53638.46361536335;53924.46075539351;53995.46004539904;54105;54196;455482;458681;460896;460901;462144;29366.853165734035;29623;29935.55096673508;30186.69813301927;30195.69804301929;41311.38032929449;41873.79063104665;42806.78596606997;42861.785691071345;43022.569774303105;41855.16289674128;42730.14539709126;43138.352924706785;43167.56832431761;45002.32496512489;42423;43347.783261083496;43743;43931.9748857883;44463;42459.363109554;43000.78499607482;43279.9180020502;43411.56588434075;46028.30957535707;33572.66427335695;37600.2479950394;37999.24001520009;38157.2368552633;38851.222975539764;29313.85343073271;29699.257518562208;29712.85143574355;29909;30241.395172096876 22:41:23 INFO - PROCESS | 10104 | |2;jquery.html;381.45261549676235;384.39649749892664;398.243337658449;401.2176256300214;415.7900260368514;13498.595042148727;18545.629087418245;18693;20124;20209.090590923406;15812.07047357241;15847.920760396211;16066.196690165474;19006.429807105807;19320.744151630133;5578.497935185833;5691.117876729114;5697.4587414195585;5756.424357564231;5758.481736643701;5509.338879334486;5628.493435590796;5670.177824215486;5676.517496012844;5687.488126068653;5584.357798853143;5619.100943848985;5653.010723123458;5657.773689052433;5665.121906104539;5529.060059789826;5668.489835914766;5681.971590142064;5687.516561092312;5691.886162276773;4811.254255590389;5046;5052.216906379517;5069.264956581312;5086.084504789136;12705.682357941034;12843.678908027281;12934.353282335846;13128.409221585052;13155.934220328932;2210.0938615167706;2236.6533187355985;2282.9086836526517;2427.2718184544565;2833.4049849531625;9690.224782017493;9797;9844.458554779485;9872.654457093968;9910.20718342531;1759.727242277449;1767.8320559546823;1791.7222830461299;1862.4412676197087;1920.9722798302842;76243.61878190574;79527.60236198783;81582;81872.59063704644;82239.5888020562;10527.157827373792;10789.406582637874;11197.496112674786;11414.42927853604;11431.771364572662;15081.47214847497;15200.087994720352;15224.847751522564;15235.695286094216;15251.313690883937;7308.123025237006;7374.557526548424;7508;7519.962400187964;7623.504472209289;6747.730090796314;6821.87596678441;6960.269171736996;7325.816854578678;7499.100107987077;4592.839250626279;4624.375709279271;4632.606228470618;4729.763511824395;4774.21225497789;1767.487428645704;1930.7296978423033;1976.9110390032483;1980.8712433691765;2008.3874418302557;891.7101941868918;961.9663311784194;971.2715463402449;977.7213494154274;1032.4115254304975;18464.723029154575;19174.13716382766;19370.903145484182;19466.707999379738;19805.900970495055;978.4129522286571;989.6585677941099;998.8801343838641;1020.3367810922811;1033.7570670892335;10153.390796552083;10686;10690.625828096136;10699;10794.812570617225;449258;451188;451421.7428912834;458196;458207.1268930969;84807;87136;87359.56320218358;88744.5562772182;91590.54204728933;956.531299663174;978.2907392140642;988.3131223799534;1001.7295330260935;1008.3294609085023;16469.83530164731;16730.749038764672;17096.743548846527;17253.482395528154;17574.121293935506;40295.79852100838;40864;41049.79475102606;41714.165716686104;41976.58023419727;52746;56840.71579642075;57518.42481575131;58778.706106469195;59355;7986.161453047346;8123.47197432165;8149.144339844231;8186.54973976437;8301.169883011651;12542.24746515212;13020.869791301966;13247.66880827987;13287.867121328663;13437.462501499831;10927.398993055458;11028.22802403824;11192.1605879561;11688.357140357362;11993.820092698443;10652.627158049741;10861.619843305447;11032.944835276094;11348.773024539629;11429.199956003;11025.724356890822;11069.833952490559;11223.98984091403;11537.192396532162;11811;7822.530648161129;8034.47775894565;8062.637181326972;8122.309603683753;8175.754727358189;10659.360438373722;10910.781784364426;11421;11743.530258789553;12160.635180944586 22:41:23 INFO - PROCESS | 10104 | |3;mootools.html;1495.170180549795;1513.8032055832741;1669.9833001669988;1741.4775567329798;1794.102948525737;7770.4560680752365;8623.353248506364;8761.430507017056;9270.165685088341;9278.072192780726;8768.298536117096;9075.63697452101;9123.589438475268;9166.266698664107;9184.816303673922;2385.212879749683;2446.4740080882607;2448.902043918241;2448.9755102449017;2451.2891261534132;2343.8242131840093;2400.95198096038;2406.32622865597;2409.265174121892;2422.5518279118332;2426.733059363469;2445.095314733542;2445.2297526279253;2464.4578192797558;2477.7770000699934;2361.6221404575185;2362.3149286707007;2371.27676058802;2383.30884043628;2388.414838364603;2285.0517035430275;2294.4722713775923;2297.6208925527435;2302.1597117052324;2320.4662927526597;8877;8989.640414383417;8996.235319997808;9005.324600654978;9022.548872556412;5307.761150748225;5423.240746295522;5439.3200849893765;5456.236126942231;5478;3436.467347561107;3450.6894379505716;3458.6714262145056;3528.3825330567047;3541.4864844597646;1080.7352198711287;1185.9644210673607;1190.3275897364217;1197.3294954825326;1219.9756004879853;12109.273443593413;12148.088893332946;12163.51345946161;12194.024478041736;12200.877991220152;4414.27164517851;4723.173444647173;4724.078804633064;4867.150482816507;4883.218685010382;10473.371597704163;10511.474426278655;10515;10606.628767993083;10636.202284828669;5356.651817631841;5386.111291636836;5408.945910540923;5442.782288708408;5446.019716451076;4402.449693788277;4809.398825146856;4917.532834380728;4926.556609905126;4993.450720420751;4129.545749967501;4148.0982099925195;4215.156968606291;4232.174725928476;4245.299525578307;1285.119693010291;1339.4441306857545;1342.1276170489066;1350.5745690107585;1361.4758318047425;866.3026263857655;867.1761826265074;887.245841035115;889.2974550105345;904.1546154345708;5880.647161170344;5959.642421454727;6023.879522409527;6157.975881011628;6507.804765857032;926.2451102351562;977.8093271811929;991.2466525440573;992.9007099290013;1026.0765311219814;3861.3242682530445;3913.5890731473355;3997.7801220932547;4008.6793056555407;4055.918881622351;10842.349459032483;11161.665150045512;11237.213395062266;11246.775064498665;11257.549698011988;10860.402677852793;11143.609973651046;11241.381724005094;11330.206885518099;11339.546418143347;7830.334421574116;8058.35533157346;8087.353011759163;8123.0658474276215;8173.79565510867;6242.750289988349;6250.937490625036;6321.683915804283;6364.236291645032;6538.673066346759;9822.165115964937;9885.85171222418;9916.256280778825;9954.900450995687;10003.099721025143;10289;10372.948135259276;10392.42841643717;10477.266591338534;10607.257491975797;7294.890576641248;7579.469437139347;7647.923520764721;7734.806629834299;7826.452148349788;8547.658093676184;8629;8653.61058752345;8654.30765538768;8670.566471676517;7464.216257292906;7693.49992250502;7849.372050236082;7873.1733168016535;7937.325327347009;7214.567125972459;7509.8498030038;7698;7735.7679269622;7740.612969351622;7115.359617634438;7173.784786456415;7190.856182876209;7198.928010720036;7254.274572542704;4955.702657840541;5026.698398096126;5074.949250507448;5090.160123579716;5221.321228240305;5054.82308119214;5064.417591976822;5094.414142373675;5109.489051094861;5195.142801437721 22:41:23 INFO - PROCESS | 10104 | |4;prototype.html;323.5260343596632;324.9252671885466;329.0966297513325;332.4746899898161;333.07903646417645;5411.188321751734;5453.890922181554;5479.479449452306;5511.724413779305;5516.613837031405;5366.892662146754;5399.62202645815;5412.888973300416;5421.9457805421935;5424.972875135619;4090.8568200112927;4130.215259100776;4230.9153816923645;4264.637505812009;4308.9353659695125;4286.314189729644;4289.356596510533;4291.570842915699;4294.592013758688;4299.828006879721;4272.572742725733;4276.123394704078;4302.956970430302;4304.720193187449;4307.117041006586;3985.720999530034;4167.1457351242925;4196.9370459443135;4197.958020419787;4319.589638984291;3666.431703086026;3681.318955993123;3683;3693.8153092345274;3696.537932758405;5333.5199832015305;5362.356517217959;5383.757730902119;5385.7307134643115;5387.622866399353;4483.753393563353;4815.951840481621;4835.6131509479155;4855.83004594841;4867.123917694814;5677.261955945742;5688.488036076773;5697.658140511582;5714.742836572323;5716.485516303511;4020.8793736187963;4038.7374820636564;4041.1311568012725;4054.0270335119653;4057.3305404608204;5852.619579727304;5901.911471327933;5934.1692163097205;5946.524278057745;5975.671338076404;4170.270202714512;4170.520390155171;4174.540800511942;4179.2895207814745;4190.455240818735;4222.796502996631;4228.492580890313;4231.322988321916;4243.6605071594195;4250.893727656833;4704.811807527729;4749.4775574686755;4776;4858.6356023298395;4894.583960363409;5576.832695019156;5665.5467562594895;5693.5160511357;5702.087665973424;5730.169125476783;1452.6150570098932;1464.8535146485267;1466.5160497035952;1467.8678918897351;1467.9119252844864;894.3337213775778;916.0473107967772;928.5125309212582;931.1991687149047;932.1331162019252;5500.7524661390335;5516.889662206733;5525.778968841201;5545.805896793673;5552.222688823568;5805.487679953567;5806.767729290866;5823.505002074871;5871.3541510433815;5888.646681199141;5309.814156504503;5516.172574113834;5518.668879867221;5525.751341189656;5633.436656334334;3071.600691910082;3104.425681248976;3111.9461155637173;3113;3127.217486032939;5860.824175274749;6154.630722156685;6176.444120029129;6192.659403732748;6198.714681218961;5976.581639285208;5998.25021872266;6030.969845150747;6039.184710064173;6067.271927368744;6241.968790156111;6260.40526150015;6279.843003924939;6289.276733175652;6300.21247344082;5619.943800561942;5857.179994800646;5874.882502350015;5898.557608179318;5929.703514824328;5793.565482588739;5831.212786273799;5876.970615146897;5883.235179426647;5900.291964964232;5902.38025007368;6128.1726966858905;6209.068639704081;6236.376362363727;6248.593841400295;4183.435236243068;4183.686223533308;4191.43415638897;4191.664666826708;4200.579942005775;5873;5879.941200587939;5895.086261629454;5904.3800400959;5905.763769449174;5631.465010823965;5754.827355179351;5770.394108618702;5790.739416726173;5809.709514524341;5663.433656634468;5675.687837168995;5703.743331550173;5741.598088133791;5766.394528574439;5094.414142373526;5620.74706638194;5636.844446888296;5660.660360378391;5669.4047125051275;5702.287214098238;5733.512651424676;5735.741891614971;5737.168110624019;5742.885142297047;5608.663480191201;5615.157726341082;5615.859603509945;5655.179998900218;5660.54715622741 22:41:23 INFO - PROCESS | 10104 | |5;yui.html;746.2015643261713;747.3610063395796;753.7399597138985;782.4092809928503;785.9567723775192;15142.318595663193;15870.761938570902;15892.84107158928;15896.205189740525;15935.521934341974;15404.768928466054;15450.381984720598;15483.845161548381;15551.222438878067;15571.143587102704;662.443547420167;788.6017561131621;799.54825523579;811.2739098506833;813.8128230506987;812.7521106062649;820.1552401026922;822.2312138150818;823.3783493462428;823.6499487717726;869.5739087846941;871.2159056848855;872.310874409216;872.7948932000975;872.9301655867547;850.9319254459629;856.2721686566431;864.062492195965;865.091653763549;868.769776009358;629.8205011571725;631.5389765471186;633.4805459523193;633.5153607490273;635.3551145587232;14798.48205312809;14822.629434264121;14831.77752333716;14858.628534286729;14889.925550372287;15479.22603869802;15493.380264789395;15831.525054248392;15905.443309484228;15914.76127858083;11630.418479076097;12010.039196864318;12099.153059285854;12189.146759726822;12521;3951.170254246612;4041.9797901010306;4145.647619952308;4148.979255103735;4155.272827255249;79832;80411;82322.58838705828;82430.58784706038;83189.58405207936;11714.1800073994;12062.51749929993;12194.207376520499;12290.877091228973;12591.87408125907;22855.31434056981;22880.313590592308;22920.4269893254;22929.904462897295;22955.770442295696;8740.956295218482;8862.113788621215;8880.378373513791;9017.549122543847;9289.442633442015;4944.3572335596145;4978.701277923264;5067.5439210470495;5103.744812759347;5127.051495473349;3561.0919215599856;3666.2850744105176;3672.779633222015;3674.797886116289;3695.224002959355;585.3093349847136;597.8595030167907;608.6652341212404;615.9876802463925;617.9011358182669;569.4618585436723;596.3916804859019;670.9533128319837;690.623610132479;726.23019599225;9333.719988400358;9829.24781061304;9923.40459572428;10459;10857.565697372016;606.0998768859657;645.9515536334794;685.348918527401;699.3635791429774;750.4034292737177;4827.155247831615;5072.721000344943;5086.949130508648;5118.344229626284;5119.692818430832;110056;110811.44594276977;110939;111540;117177.41411292889;94546;97043;97061.51469242609;101236.49381753191;101887;57125.428745712845;87705.56147219223;89014;89876;92210;9243.428617135238;9496.287778416785;9581.377210481296;9583.549922027925;9665.014866204163;47872.521274786806;48203.51796482131;49299;50215.74892125516;51087.2336914954;68928;69012;74134;76519;78932.21067789248;11594.072474201876;11604.419779010846;11677.941610291895;11818.885602556968;12007.318975343633;13552.457901683822;13735.862641373858;13762;13894.861051389762;14411.85588144147;12761.680957976125;12982.675433114247;13106.934465327613;13845.100068495516;13898.722025559635;12652.936735316265;13046;13301.80047299272;13721.725565488434;13788.103773254707;11464.157732814396;12733.490660373482;13414.798778018532;13557.525486607921;14166.150030998173;11435.768012177434;11481.885181148416;11598.246114002563;11608.941955290169;11680.883191167979;11200.607978720705;11402.247908806225;11625.767484650429;11895.286282822712;12067 22:41:23 INFO - PROCESS | 10104 | __end_tp_report 22:41:23 INFO - PROCESS | 10104 | __start_cc_report 22:41:23 INFO - PROCESS | 10104 | _x_x_mozilla_cycle_collect,348 22:41:23 INFO - PROCESS | 10104 | __end_cc_report 22:41:23 INFO - PROCESS | 10104 | __startTimestamp1470462083828__endTimestamp 22:41:23 INFO - PROCESS | 10104 | 22:41:23 INFO - PROCESS | 10104 | ------- Summary: start ------- 22:41:23 INFO - PROCESS | 10104 | Number of tests: 6 22:41:23 INFO - PROCESS | 10104 | 22:41:23 INFO - PROCESS | 10104 | [#0] dojo.html Cycles:165 Average:5400.47 Median:5618.75 stddev:613.48 (10.9%) stddev-sans-first:587.09 22:41:23 INFO - PROCESS | 10104 | Values: 3053.7 3058.1 3093.8 3094.2 3096.2 5321.7 5336.1 5357.5 5414.9 5449.9 5377.5 5381.9 5438.6 5455.5 5460.6 4929.9 4943.5 4990.5 5005.7 5018.8 4942.0 5002.4 5053.2 5059.0 5097.6 5041.3 5073.6 5087.9 5098.4 5099.6 4862.6 4894.9 4913.3 4937.0 4943.6 4908.5 4920.7 4926.4 4928.9 4979.9 5324.4 5339.4 5382.8 5383.7 5448.0 5578.9 5683.9 5756.5 5760.9 5769.8 5788.2 5805.0 5850.8 5852.9 5864.6 5378.3 5414.1 5418.8 5440.2 5441.7 5756.2 5802.7 5865.0 5906.5 5941.1 5698.3 5703.4 5715.1 5718.0 5744.3 5772.1 5783.3 5788.1 5792.5 5806.7 5618.7 5672.6 5706.9 5721.1 5730.3 5611.4 5698.8 5749.5 5753.3 5803.8 4443.4 4472.3 4483.4 4485.2 4518.4 3926.1 3936.8 3992.7 3994.3 4016.1 5540.4 5591.7 5597.3 5633.3 5643.8 5739.9 5784.2 5792.4 5834.2 5836.1 5437.5 5533.1 5573.4 5581.1 5598.7 4966.0 5021.5 5024.6 5027.9 5097.1 6144.7 6150.4 6152.4 6157.4 6172.7 5837.3 5844.9 5844.9 5845.0 5845.3 5963.5 6047.9 6082.1 6103.0 6145.9 5671.8 5704.9 5716.0 5738.6 5767.1 5858.8 5866.1 5872.4 5875.7 5888.9 5557.4 5639.4 5691.7 5692.0 5765.5 5672.3 5691.1 5691.6 5707.7 5708.5 5362.3 5631.3 5633.0 5634.7 5650.3 5596.8 5636.5 5726.8 5728.9 5729.1 5493.3 5574.8 5584.2 5593.6 5671.5 22:41:23 INFO - PROCESS | 10104 | 22:41:23 INFO - PROCESS | 10104 | [#1] ext.html Cycles:180 Average:58417.24 Median:42441.18 stddev:119962.82 (282.7%) stddev-sans-first:120220.65 22:41:23 INFO - PROCESS | 10104 | Values: 544.4 554.6 583.4 604.8 631.8 39302.6 43767.3 43779.6 43800.0 43905.8 43884.0 44498.3 44502.6 44523.6 44538.1 8882.4 9000.1 9006.6 9015.2 9023.8 8931.1 8982.7 8985.9 9000.0 9026.9 9015.0 9031.3 9063.2 9072.1 9094.1 8704.1 8717.0 8722.1 8742.7 8745.4 8793.7 8811.5 8858.7 8886.1 8892.7 40859.8 41328.2 41490.0 41664.8 41710.6 3308.7 3451.7 3495.1 3563.8 3772.7 32525.8 33047.5 33154.2 34511.5 34666.8 4093.2 4134.6 4186.1 4217.3 4260.1 253906.0 255375.0 255416.0 256343.0 257118.0 35539.5 36337.6 60278.0 60736.7 60948.7 37932.8 38080.8 38159.6 38434.0 38435.8 14563.4 14709.3 14726.9 14743.7 14779.7 10716.4 10771.1 10777.3 10830.2 10864.5 8684.7 8713.7 8722.2 8792.7 8820.3 3141.9 3150.6 3182.0 3208.7 3216.2 915.9 927.2 929.0 977.7 987.3 31846.5 31851.2 31908.8 32274.0 32818.0 1145.7 1155.3 1198.3 1217.4 1254.7 17189.9 17400.5 17666.3 17766.9 17805.3 572851.0 573578.0 574276.0 575203.0 575804.0 62656.4 62677.7 63112.7 63149.7 63164.7 1342.6 1363.1 1378.5 1395.1 1403.3 30067.5 31174.7 31642.8 33479.8 33935.0 53638.5 53924.5 53995.5 54105.0 54196.0 455482.0 458681.0 460896.0 460901.0 462144.0 29366.9 29623.0 29935.6 30186.7 30195.7 41311.4 41873.8 42806.8 42861.8 43022.6 41855.2 42730.1 43138.4 43167.6 45002.3 42423.0 43347.8 43743.0 43932.0 44463.0 42459.4 43000.8 43279.9 43411.6 46028.3 33572.7 37600.2 37999.2 38157.2 38851.2 29313.9 29699.3 29712.9 29909.0 30241.4 22:41:23 INFO - PROCESS | 10104 | 22:41:23 INFO - PROCESS | 10104 | [#2] jquery.html Cycles:180 Average:27284.72 Median:40956.90 stddev:74985.71 (183.1%) stddev-sans-first:75168.85 22:41:23 INFO - PROCESS | 10104 | Values: 381.5 384.4 398.2 401.2 415.8 13498.6 18545.6 18693.0 20124.0 20209.1 15812.1 15847.9 16066.2 19006.4 19320.7 5578.5 5691.1 5697.5 5756.4 5758.5 5509.3 5628.5 5670.2 5676.5 5687.5 5584.4 5619.1 5653.0 5657.8 5665.1 5529.1 5668.5 5682.0 5687.5 5691.9 4811.3 5046.0 5052.2 5069.3 5086.1 12705.7 12843.7 12934.4 13128.4 13155.9 2210.1 2236.7 2282.9 2427.3 2833.4 9690.2 9797.0 9844.5 9872.7 9910.2 1759.7 1767.8 1791.7 1862.4 1921.0 76243.6 79527.6 81582.0 81872.6 82239.6 10527.2 10789.4 11197.5 11414.4 11431.8 15081.5 15200.1 15224.8 15235.7 15251.3 7308.1 7374.6 7508.0 7520.0 7623.5 6747.7 6821.9 6960.3 7325.8 7499.1 4592.8 4624.4 4632.6 4729.8 4774.2 1767.5 1930.7 1976.9 1980.9 2008.4 891.7 962.0 971.3 977.7 1032.4 18464.7 19174.1 19370.9 19466.7 19805.9 978.4 989.7 998.9 1020.3 1033.8 10153.4 10686.0 10690.6 10699.0 10794.8 449258.0 451188.0 451421.7 458196.0 458207.1 84807.0 87136.0 87359.6 88744.6 91590.5 956.5 978.3 988.3 1001.7 1008.3 16469.8 16730.7 17096.7 17253.5 17574.1 40295.8 40864.0 41049.8 41714.2 41976.6 52746.0 56840.7 57518.4 58778.7 59355.0 7986.2 8123.5 8149.1 8186.5 8301.2 12542.2 13020.9 13247.7 13287.9 13437.5 10927.4 11028.2 11192.2 11688.4 11993.8 10652.6 10861.6 11032.9 11348.8 11429.2 11025.7 11069.8 11224.0 11537.2 11811.0 7822.5 8034.5 8062.6 8122.3 8175.8 10659.4 10910.8 11421.0 11743.5 12160.6 22:41:23 INFO - PROCESS | 10104 | 22:41:23 INFO - PROCESS | 10104 | [#3] mootools.html Cycles:180 Average:5878.14 Median:4941.13 stddev:3315.16 (67.1%) stddev-sans-first:3308.09 22:41:23 INFO - PROCESS | 10104 | Values: 1495.2 1513.8 1670.0 1741.5 1794.1 7770.5 8623.4 8761.4 9270.2 9278.1 8768.3 9075.6 9123.6 9166.3 9184.8 2385.2 2446.5 2448.9 2449.0 2451.3 2343.8 2401.0 2406.3 2409.3 2422.6 2426.7 2445.1 2445.2 2464.5 2477.8 2361.6 2362.3 2371.3 2383.3 2388.4 2285.1 2294.5 2297.6 2302.2 2320.5 8877.0 8989.6 8996.2 9005.3 9022.5 5307.8 5423.2 5439.3 5456.2 5478.0 3436.5 3450.7 3458.7 3528.4 3541.5 1080.7 1186.0 1190.3 1197.3 1220.0 12109.3 12148.1 12163.5 12194.0 12200.9 4414.3 4723.2 4724.1 4867.2 4883.2 10473.4 10511.5 10515.0 10606.6 10636.2 5356.7 5386.1 5408.9 5442.8 5446.0 4402.4 4809.4 4917.5 4926.6 4993.5 4129.5 4148.1 4215.2 4232.2 4245.3 1285.1 1339.4 1342.1 1350.6 1361.5 866.3 867.2 887.2 889.3 904.2 5880.6 5959.6 6023.9 6158.0 6507.8 926.2 977.8 991.2 992.9 1026.1 3861.3 3913.6 3997.8 4008.7 4055.9 10842.3 11161.7 11237.2 11246.8 11257.5 10860.4 11143.6 11241.4 11330.2 11339.5 7830.3 8058.4 8087.4 8123.1 8173.8 6242.8 6250.9 6321.7 6364.2 6538.7 9822.2 9885.9 9916.3 9954.9 10003.1 10289.0 10372.9 10392.4 10477.3 10607.3 7294.9 7579.5 7647.9 7734.8 7826.5 8547.7 8629.0 8653.6 8654.3 8670.6 7464.2 7693.5 7849.4 7873.2 7937.3 7214.6 7509.8 7698.0 7735.8 7740.6 7115.4 7173.8 7190.9 7198.9 7254.3 4955.7 5026.7 5074.9 5090.2 5221.3 5054.8 5064.4 5094.4 5109.5 5195.1 22:41:23 INFO - PROCESS | 10104 | 22:41:23 INFO - PROCESS | 10104 | [#4] prototype.html Cycles:180 Average:4822.11 Median:5522.21 stddev:1436.36 (26.0%) stddev-sans-first:1400.14 22:41:23 INFO - PROCESS | 10104 | Values: 323.5 324.9 329.1 332.5 333.1 5411.2 5453.9 5479.5 5511.7 5516.6 5366.9 5399.6 5412.9 5421.9 5425.0 4090.9 4130.2 4230.9 4264.6 4308.9 4286.3 4289.4 4291.6 4294.6 4299.8 4272.6 4276.1 4303.0 4304.7 4307.1 3985.7 4167.1 4196.9 4198.0 4319.6 3666.4 3681.3 3683.0 3693.8 3696.5 5333.5 5362.4 5383.8 5385.7 5387.6 4483.8 4816.0 4835.6 4855.8 4867.1 5677.3 5688.5 5697.7 5714.7 5716.5 4020.9 4038.7 4041.1 4054.0 4057.3 5852.6 5901.9 5934.2 5946.5 5975.7 4170.3 4170.5 4174.5 4179.3 4190.5 4222.8 4228.5 4231.3 4243.7 4250.9 4704.8 4749.5 4776.0 4858.6 4894.6 5576.8 5665.5 5693.5 5702.1 5730.2 1452.6 1464.9 1466.5 1467.9 1467.9 894.3 916.0 928.5 931.2 932.1 5500.8 5516.9 5525.8 5545.8 5552.2 5805.5 5806.8 5823.5 5871.4 5888.6 5309.8 5516.2 5518.7 5525.8 5633.4 3071.6 3104.4 3111.9 3113.0 3127.2 5860.8 6154.6 6176.4 6192.7 6198.7 5976.6 5998.3 6031.0 6039.2 6067.3 6242.0 6260.4 6279.8 6289.3 6300.2 5619.9 5857.2 5874.9 5898.6 5929.7 5793.6 5831.2 5877.0 5883.2 5900.3 5902.4 6128.2 6209.1 6236.4 6248.6 4183.4 4183.7 4191.4 4191.7 4200.6 5873.0 5879.9 5895.1 5904.4 5905.8 5631.5 5754.8 5770.4 5790.7 5809.7 5663.4 5675.7 5703.7 5741.6 5766.4 5094.4 5620.7 5636.8 5660.7 5669.4 5702.3 5733.5 5735.7 5737.2 5742.9 5608.7 5615.2 5615.9 5655.2 5660.5 22:41:23 INFO - PROCESS | 10104 | 22:41:23 INFO - PROCESS | 10104 | [#5] yui.html Cycles:180 Average:20795.53 Median:26515.34 stddev:29690.84 (112.0%) stddev-sans-first:29735.97 22:41:23 INFO - PROCESS | 10104 | Values: 746.2 747.4 753.7 782.4 786.0 15142.3 15870.8 15892.8 15896.2 15935.5 15404.8 15450.4 15483.8 15551.2 15571.1 662.4 788.6 799.5 811.3 813.8 812.8 820.2 822.2 823.4 823.6 869.6 871.2 872.3 872.8 872.9 850.9 856.3 864.1 865.1 868.8 629.8 631.5 633.5 633.5 635.4 14798.5 14822.6 14831.8 14858.6 14889.9 15479.2 15493.4 15831.5 15905.4 15914.8 11630.4 12010.0 12099.2 12189.1 12521.0 3951.2 4042.0 4145.6 4149.0 4155.3 79832.0 80411.0 82322.6 82430.6 83189.6 11714.2 12062.5 12194.2 12290.9 12591.9 22855.3 22880.3 22920.4 22929.9 22955.8 8741.0 8862.1 8880.4 9017.5 9289.4 4944.4 4978.7 5067.5 5103.7 5127.1 3561.1 3666.3 3672.8 3674.8 3695.2 585.3 597.9 608.7 616.0 617.9 569.5 596.4 671.0 690.6 726.2 9333.7 9829.2 9923.4 10459.0 10857.6 606.1 646.0 685.3 699.4 750.4 4827.2 5072.7 5086.9 5118.3 5119.7 110056.0 110811.4 110939.0 111540.0 117177.4 94546.0 97043.0 97061.5 101236.5 101887.0 57125.4 87705.6 89014.0 89876.0 92210.0 9243.4 9496.3 9581.4 9583.5 9665.0 47872.5 48203.5 49299.0 50215.7 51087.2 68928.0 69012.0 74134.0 76519.0 78932.2 11594.1 11604.4 11677.9 11818.9 12007.3 13552.5 13735.9 13762.0 13894.9 14411.9 12761.7 12982.7 13106.9 13845.1 13898.7 12652.9 13046.0 13301.8 13721.7 13788.1 11464.2 12733.5 13414.8 13557.5 14166.2 11435.8 11481.9 11598.2 11608.9 11680.9 11200.6 11402.2 11625.8 11895.3 12067.0 22:41:23 INFO - PROCESS | 10104 | -------- Summary: end -------- 22:41:23 INFO - PROCESS | 10104 | 22:41:24 INFO - TEST-INFO | 10104: exit 0 22:41:24 INFO - TEST-OK | dromaeo_css | took 1113414ms 22:41:24 INFO - TEST-START | kraken 22:41:24 INFO - operating with platform_type : linux_ 22:41:24 INFO - Initialising browser for kraken test... 22:41:24 INFO - TEST-INFO | started process 10353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXYZLHj/profile http://localhost:43672/getInfo.html) 22:41:28 INFO - PROCESS | 10353 | __metrics Screen width/height:1600/1200 22:41:28 INFO - PROCESS | 10353 | colorDepth:24 22:41:28 INFO - PROCESS | 10353 | Browser inner width/height: 1024/697 22:41:28 INFO - PROCESS | 10353 | __metrics 22:41:29 ERROR - PROCESS | 10353 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:41:30 INFO - TEST-INFO | 10353: exit 0 22:41:30 INFO - Browser initialized. 22:41:30 INFO - Running cycle 1/1 for kraken test... 22:41:30 INFO - TEST-INFO | started process 10471 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXYZLHj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:41:42 INFO - PROCESS | 10471 | RSS: Main: 163692544 22:41:42 INFO - PROCESS | 10471 | 22:41:44 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43672/tests/kraken/driver.html?testName=audio-beat-detection) 22:41:45 INFO - PROCESS | 10471 | RSS: Main: 169443328 22:41:45 INFO - PROCESS | 10471 | 22:41:48 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43672/tests/kraken/driver.html?testName=audio-dft) 22:41:48 INFO - PROCESS | 10471 | RSS: Main: 168103936 22:41:48 INFO - PROCESS | 10471 | 22:41:51 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43672/tests/kraken/driver.html?testName=audio-fft) 22:41:52 INFO - PROCESS | 10471 | RSS: Main: 164782080 22:41:52 INFO - PROCESS | 10471 | 22:41:54 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43672/tests/kraken/driver.html?testName=audio-oscillator) 22:41:55 INFO - PROCESS | 10471 | RSS: Main: 165597184 22:41:55 INFO - PROCESS | 10471 | 22:41:57 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43672/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:41:57 INFO - PROCESS | 10471 | RSS: Main: 165810176 22:41:57 INFO - PROCESS | 10471 | 22:42:01 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43672/tests/kraken/driver.html?testName=imaging-darkroom) 22:42:01 INFO - PROCESS | 10471 | RSS: Main: 166359040 22:42:01 INFO - PROCESS | 10471 | 22:42:05 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43672/tests/kraken/driver.html?testName=imaging-desaturate) 22:42:05 INFO - PROCESS | 10471 | RSS: Main: 163037184 22:42:05 INFO - PROCESS | 10471 | 22:42:08 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43672/tests/kraken/driver.html?testName=json-parse-financial) 22:42:09 INFO - PROCESS | 10471 | RSS: Main: 165253120 22:42:09 INFO - PROCESS | 10471 | 22:42:10 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43672/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:42:11 INFO - PROCESS | 10471 | RSS: Main: 165019648 22:42:11 INFO - PROCESS | 10471 | 22:42:13 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43672/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:42:14 INFO - PROCESS | 10471 | RSS: Main: 165486592 22:42:14 INFO - PROCESS | 10471 | 22:42:16 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43672/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:42:16 INFO - PROCESS | 10471 | RSS: Main: 165937152 22:42:16 INFO - PROCESS | 10471 | 22:42:19 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:42:20 INFO - PROCESS | 10471 | RSS: Main: 165892096 22:42:20 INFO - PROCESS | 10471 | 22:42:22 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:42:23 INFO - PROCESS | 10471 | RSS: Main: 165892096 22:42:23 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:43672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43672/tests/kraken/driver.html?testName=ai-astar) 22:42:25 INFO - PROCESS | 10471 | RSS: Main: 166723584 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | __start_tp_report 22:42:25 INFO - PROCESS | 10471 | _x_x_mozilla_page_load 22:42:25 INFO - PROCESS | 10471 | _x_x_mozilla_page_load_details 22:42:25 INFO - PROCESS | 10471 | |i|pagename|runs| 22:42:25 INFO - PROCESS | 10471 | |0;ai-astar;104;113;107;112;112;114;113;112;112;111 22:42:25 INFO - PROCESS | 10471 | |1;audio-beat-detection;146;120;149;195;122;151;143;126;186;118 22:42:25 INFO - PROCESS | 10471 | |2;audio-dft;164;163;162;161;164;175;164;162;161;163 22:42:25 INFO - PROCESS | 10471 | |3;audio-fft;76;75;76;182;76;75;74;77;176;76 22:42:25 INFO - PROCESS | 10471 | |4;audio-oscillator;85;84;153;85;85;85;136;84;84;153 22:42:25 INFO - PROCESS | 10471 | |5;imaging-gaussian-blur;117;118;117;118;117;117;117;118;117;117 22:42:25 INFO - PROCESS | 10471 | |6;imaging-darkroom;147;146;147;147;147;147;148;147;147;148 22:42:25 INFO - PROCESS | 10471 | |7;imaging-desaturate;97;96;96;96;95;96;96;96;96;96 22:42:25 INFO - PROCESS | 10471 | |8;json-parse-financial;55;54;53;52;53;51;52;51;52;51 22:42:25 INFO - PROCESS | 10471 | |9;json-stringify-tinderbox;60;60;59;59;60;60;60;63;60;59 22:42:25 INFO - PROCESS | 10471 | |10;stanford-crypto-aes;82;82;82;77;78;82;78;81;82;78 22:42:25 INFO - PROCESS | 10471 | |11;stanford-crypto-ccm;127;132;141;131;131;122;125;123;138;141 22:42:25 INFO - PROCESS | 10471 | |12;stanford-crypto-pbkdf2;168;166;161;160;159;159;159;161;163;163 22:42:25 INFO - PROCESS | 10471 | |13;stanford-crypto-sha256-iterative;66;65;64;65;64;63;65;64;62;67 22:42:25 INFO - PROCESS | 10471 | __end_tp_report 22:42:25 INFO - PROCESS | 10471 | __start_cc_report 22:42:25 INFO - PROCESS | 10471 | _x_x_mozilla_cycle_collect,929 22:42:25 INFO - PROCESS | 10471 | __end_cc_report 22:42:25 INFO - PROCESS | 10471 | __startTimestamp1470462145355__endTimestamp 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | ------- Summary: start ------- 22:42:25 INFO - PROCESS | 10471 | Number of tests: 14 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.09 (2.8%) stddev-sans-first:1.99 22:42:25 INFO - PROCESS | 10471 | Values: 104.0 113.0 107.0 112.0 112.0 114.0 113.0 112.0 112.0 111.0 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:147.50 stddev:26.83 (18.2%) stddev-sans-first:28.46 22:42:25 INFO - PROCESS | 10471 | Values: 146.0 120.0 149.0 195.0 122.0 151.0 143.0 126.0 186.0 118.0 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:4.07 (2.5%) stddev-sans-first:4.31 22:42:25 INFO - PROCESS | 10471 | Values: 164.0 163.0 162.0 161.0 164.0 175.0 164.0 162.0 161.0 163.0 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#3] audio-fft Cycles:10 Average:96.30 Median:76.00 stddev:43.62 (57.4%) stddev-sans-first:45.64 22:42:25 INFO - PROCESS | 10471 | Values: 76.0 75.0 76.0 182.0 76.0 75.0 74.0 77.0 176.0 76.0 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:84.50 stddev:30.67 (36.3%) stddev-sans-first:31.80 22:42:25 INFO - PROCESS | 10471 | Values: 85.0 84.0 153.0 85.0 85.0 85.0 136.0 84.0 84.0 153.0 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:42:25 INFO - PROCESS | 10471 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 22:42:25 INFO - PROCESS | 10471 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 22:42:25 INFO - PROCESS | 10471 | Values: 97.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:1.35 (2.6%) stddev-sans-first:1.05 22:42:25 INFO - PROCESS | 10471 | Values: 55.0 54.0 53.0 52.0 53.0 51.0 52.0 51.0 52.0 51.0 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:1.15 (1.9%) stddev-sans-first:1.22 22:42:25 INFO - PROCESS | 10471 | Values: 60.0 60.0 59.0 59.0 60.0 60.0 60.0 63.0 60.0 59.0 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:82.00 stddev:2.15 (2.6%) stddev-sans-first:2.18 22:42:25 INFO - PROCESS | 10471 | Values: 82.0 82.0 82.0 77.0 78.0 82.0 78.0 81.0 82.0 78.0 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:131.50 stddev:7.05 (5.4%) stddev-sans-first:7.32 22:42:25 INFO - PROCESS | 10471 | Values: 127.0 132.0 141.0 131.0 131.0 122.0 125.0 123.0 138.0 141.0 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:3.11 (1.9%) stddev-sans-first:2.39 22:42:25 INFO - PROCESS | 10471 | Values: 168.0 166.0 161.0 160.0 159.0 159.0 159.0 161.0 163.0 163.0 22:42:25 INFO - PROCESS | 10471 | 22:42:25 INFO - PROCESS | 10471 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.43 (2.2%) stddev-sans-first:1.41 22:42:25 INFO - PROCESS | 10471 | Values: 66.0 65.0 64.0 65.0 64.0 63.0 65.0 64.0 62.0 67.0 22:42:25 INFO - PROCESS | 10471 | -------- Summary: end -------- 22:42:25 INFO - PROCESS | 10471 | 22:42:26 INFO - TEST-INFO | 10471: exit 0 22:42:26 INFO - TEST-OK | kraken | took 61808ms 22:42:26 INFO - SUITE-END | took 1175s 22:42:26 INFO - Completed test suite (00:19:35) 22:42:26 INFO - javascript benchmark 22:42:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7197.509730128247, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3053.7098975597314, 3058.0672894767085, 3093.8453077346135, 3094.195509167616, 3096.1949893027804, 5321.733913304329, 5336.119540275855, 5357.517823395893, 5414.891702165959, 5449.863753406167, 5377.516023557879, 5381.946180538203, 5438.564914806816, 5455.481729235717, 5460.6177567570185, 4929.876753081166, 4943.505649435064, 4990.476000019982, 5005.6996580205305, 5018.774155163008, 4941.975290123544, 5002.374703162105, 5053.216751403538, 5058.988202359525, 5097.617678674096, 5041.319421878036, 5073.619478539106, 5087.872803179913, 5098.439171691111, 5099.566536844354, 4862.586680132157, 4894.926576101361, 4913.26301054841, 4937.0, 4943.604511639096, 4908.460069392364, 4920.6555541111775, 4926.433460152092, 4928.876778080541, 4979.875503112415, 5324.440933701983, 5339.359276886798, 5382.811601593926, 5383.650062745948, 5448.046591846411, 5578.86052848682, 5683.857903552403, 5756.481916627482, 5760.942390576082, 5769.798057068025, 5788.218590490272, 5805.0, 5850.795222167247, 5852.853678658025, 5864.648121112747, 5378.273933019032, 5414.052540805344, 5418.756155972991, 5440.156775699773, 5441.727913604304, 5756.222909907193, 5802.738876750556, 5864.970675146682, 5906.49794767441, 5941.1088336749835, 5698.259226300637, 5703.372629010805, 5715.142728590745, 5717.971410142923, 5744.339400968858, 5772.134179873053, 5783.306003279549, 5788.131780232999, 5792.536597072224, 5806.738696758656, 5618.747156377973, 5672.631278966854, 5706.885862282731, 5721.141828725641, 5730.283714535683, 5611.438856114438, 5698.772049118072, 5749.482546570829, 5753.252077229933, 5803.767849286066, 4443.422355093817, 4472.2620767573635, 4483.3723278741, 4485.1702435048965, 4518.367428559938, 3926.096997690547, 3936.7834769087976, 3992.7205095643026, 3994.320965435883, 4016.0562267867026, 5540.36285827135, 5591.664500129924, 5597.3003374578175, 5633.324001119892, 5643.7742490299925, 5739.8565035874435, 5784.219130417424, 5792.4497172768515, 5834.154047663065, 5836.1245813127525, 5437.537809286255, 5533.114701647797, 5573.442655734394, 5581.134924086773, 5598.664080155204, 4965.975170124127, 5021.5229553192385, 5024.648274620815, 5027.949720502748, 5097.108006098918, 6144.723487443076, 6150.415710507584, 6152.415520525543, 6157.384261573807, 6172.69136543171, 5837.29952405714, 5844.912326315194, 5844.912326315194, 5845.0, 5845.3277873045145, 5963.463288304073, 6047.9395206047375, 6082.11809287642, 6103.023516237381, 6145.877082458236, 5671.801486947937, 5704.914426283692, 5715.971420142872, 5738.626989245686, 5767.134929760569, 5858.765649373977, 5866.120081987565, 5872.412758724094, 5875.676837773964, 5888.852778680567, 5557.44425557441, 5639.407862174413, 5691.715414229189, 5692.032354499662, 5765.4522820332, 5672.262605861377, 5691.089425691869, 5691.601587888974, 5707.743151558273, 5708.5147762439, 5362.276092727432, 5631.267935168402, 5633.0423827948525, 5634.718264086861, 5650.3219613646625, 5596.832095037155, 5636.549076073986, 5726.828195154152, 5728.856778580569, 5729.140628905698, 5493.313335833021, 5574.804881829279, 5584.190292407497, 5593.608447408642, 5671.461211184931], "value": 5358.453228865298, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.3688635949823, 554.5646667366118, 583.4398976982097, 604.8004158627654, 631.7978246960969, 39302.606973930255, 43767.34348984764, 43779.562204377944, 43800.0, 43905.78047109768, 43884.0, 44498.33252501215, 44502.55497445024, 44523.55476445235, 44538.109237815304, 8882.42264252823, 9000.05499422561, 9006.59470323837, 9015.233705135071, 9023.819523609523, 8931.10688931105, 8982.685606003792, 8985.910140898606, 8999.955000224989, 9026.86459703105, 9015.0, 9031.277497800193, 9063.229625481841, 9072.138146876036, 9094.136057074567, 8704.086070962552, 8717.041125476193, 8722.12778722129, 8742.737717868475, 8745.387822852403, 8793.736187914374, 8811.515366654832, 8858.73423797287, 8886.066962968924, 8892.73321800347, 40859.79570102131, 41328.1734365311, 41490.0, 41664.79167604173, 41710.58289417098, 3308.718758905496, 3451.741119416054, 3495.0912762681887, 3563.768355056913, 3772.6981841452616, 32525.83737081323, 33047.50428743571, 33154.17114572131, 34511.4823277651, 34666.82666586651, 4093.1813637272667, 4134.586541345871, 4186.120914607936, 4217.304144816102, 4260.1479704059, 253906.0, 255375.0, 255416.0, 256343.0, 257118.0, 35539.4669079964, 36337.63662363395, 60278.0, 60736.69631651902, 60948.69525652432, 37932.81033594815, 38080.80959595184, 38159.61840381616, 38434.0, 38435.80782096127, 14563.41746330135, 14709.264536773333, 14726.852731472762, 14743.705125897637, 14779.704405912036, 10716.410597417216, 10771.138308935266, 10777.299475534066, 10830.241883068109, 10864.511097000654, 8684.739457816275, 8713.695020674373, 8722.171393717586, 8792.736217913473, 8820.280045391215, 3141.8586163622235, 3150.558921750957, 3182.0, 3208.7433005359517, 3216.244182617083, 915.9267258619294, 927.188709878856, 928.9907100929039, 977.7115750853516, 987.3384832162468, 31846.522302165486, 31851.20371990719, 31908.840455798036, 32274.0, 32818.0, 1145.7364806094645, 1155.2952698853692, 1198.3349241171059, 1217.433893239648, 1254.6612414647993, 17189.914050429667, 17400.47798566045, 17666.293348265925, 17766.91116544409, 17805.287788488575, 572851.0, 573578.0, 574276.0, 575203.0, 575804.0, 62656.37343626597, 62677.68661156665, 63112.684436577525, 63149.684251578445, 63164.68417657882, 1342.5703774791973, 1363.0935427940508, 1378.4555100735354, 1395.0653062448184, 1403.277312184226, 30067.548986764778, 31174.68825311718, 31642.841785790923, 33479.83260083684, 33935.0, 53638.46361536335, 53924.46075539351, 53995.46004539904, 54105.0, 54196.0, 455482.0, 458681.0, 460896.0, 460901.0, 462144.0, 29366.853165734035, 29623.0, 29935.55096673508, 30186.69813301927, 30195.69804301929, 41311.38032929449, 41873.79063104665, 42806.78596606997, 42861.785691071345, 43022.569774303105, 41855.16289674128, 42730.14539709126, 43138.352924706785, 43167.56832431761, 45002.32496512489, 42423.0, 43347.783261083496, 43743.0, 43931.9748857883, 44463.0, 42459.363109554, 43000.78499607482, 43279.9180020502, 43411.56588434075, 46028.30957535707, 33572.66427335695, 37600.2479950394, 37999.24001520009, 38157.2368552633, 38851.222975539764, 29313.85343073271, 29699.257518562208, 29712.85143574355, 29909.0, 30241.395172096876], "value": 18854.35561682771, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.45261549676235, 384.39649749892664, 398.243337658449, 401.2176256300214, 415.7900260368514, 13498.595042148727, 18545.629087418245, 18693.0, 20124.0, 20209.090590923406, 15812.07047357241, 15847.920760396211, 16066.196690165474, 19006.429807105807, 19320.744151630133, 5578.497935185833, 5691.117876729114, 5697.4587414195585, 5756.424357564231, 5758.481736643701, 5509.338879334486, 5628.493435590796, 5670.177824215486, 5676.517496012844, 5687.488126068653, 5584.357798853143, 5619.100943848985, 5653.010723123458, 5657.773689052433, 5665.121906104539, 5529.060059789826, 5668.489835914766, 5681.971590142064, 5687.516561092312, 5691.886162276773, 4811.254255590389, 5046.0, 5052.216906379517, 5069.264956581312, 5086.084504789136, 12705.682357941034, 12843.678908027281, 12934.353282335846, 13128.409221585052, 13155.934220328932, 2210.0938615167706, 2236.6533187355985, 2282.9086836526517, 2427.2718184544565, 2833.4049849531625, 9690.224782017493, 9797.0, 9844.458554779485, 9872.654457093968, 9910.20718342531, 1759.727242277449, 1767.8320559546823, 1791.7222830461299, 1862.4412676197087, 1920.9722798302842, 76243.61878190574, 79527.60236198783, 81582.0, 81872.59063704644, 82239.5888020562, 10527.157827373792, 10789.406582637874, 11197.496112674786, 11414.42927853604, 11431.771364572662, 15081.47214847497, 15200.087994720352, 15224.847751522564, 15235.695286094216, 15251.313690883937, 7308.123025237006, 7374.557526548424, 7508.0, 7519.962400187964, 7623.504472209289, 6747.730090796314, 6821.87596678441, 6960.269171736996, 7325.816854578678, 7499.100107987077, 4592.839250626279, 4624.375709279271, 4632.606228470618, 4729.763511824395, 4774.21225497789, 1767.487428645704, 1930.7296978423033, 1976.9110390032483, 1980.8712433691765, 2008.3874418302557, 891.7101941868918, 961.9663311784194, 971.2715463402449, 977.7213494154274, 1032.4115254304975, 18464.723029154575, 19174.13716382766, 19370.903145484182, 19466.707999379738, 19805.900970495055, 978.4129522286571, 989.6585677941099, 998.8801343838641, 1020.3367810922811, 1033.7570670892335, 10153.390796552083, 10686.0, 10690.625828096136, 10699.0, 10794.812570617225, 449258.0, 451188.0, 451421.7428912834, 458196.0, 458207.1268930969, 84807.0, 87136.0, 87359.56320218358, 88744.5562772182, 91590.54204728933, 956.531299663174, 978.2907392140642, 988.3131223799534, 1001.7295330260935, 1008.3294609085023, 16469.83530164731, 16730.749038764672, 17096.743548846527, 17253.482395528154, 17574.121293935506, 40295.79852100838, 40864.0, 41049.79475102606, 41714.165716686104, 41976.58023419727, 52746.0, 56840.71579642075, 57518.42481575131, 58778.706106469195, 59355.0, 7986.161453047346, 8123.47197432165, 8149.144339844231, 8186.54973976437, 8301.169883011651, 12542.24746515212, 13020.869791301966, 13247.66880827987, 13287.867121328663, 13437.462501499831, 10927.398993055458, 11028.22802403824, 11192.1605879561, 11688.357140357362, 11993.820092698443, 10652.627158049741, 10861.619843305447, 11032.944835276094, 11348.773024539629, 11429.199956003, 11025.724356890822, 11069.833952490559, 11223.98984091403, 11537.192396532162, 11811.0, 7822.530648161129, 8034.47775894565, 8062.637181326972, 8122.309603683753, 8175.754727358189, 10659.360438373722, 10910.781784364426, 11421.0, 11743.530258789553, 12160.635180944586], "value": 8798.327932750473, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.170180549795, 1513.8032055832741, 1669.9833001669988, 1741.4775567329798, 1794.102948525737, 7770.4560680752365, 8623.353248506364, 8761.430507017056, 9270.165685088341, 9278.072192780726, 8768.298536117096, 9075.63697452101, 9123.589438475268, 9166.266698664107, 9184.816303673922, 2385.212879749683, 2446.4740080882607, 2448.902043918241, 2448.9755102449017, 2451.2891261534132, 2343.8242131840093, 2400.95198096038, 2406.32622865597, 2409.265174121892, 2422.5518279118332, 2426.733059363469, 2445.095314733542, 2445.2297526279253, 2464.4578192797558, 2477.7770000699934, 2361.6221404575185, 2362.3149286707007, 2371.27676058802, 2383.30884043628, 2388.414838364603, 2285.0517035430275, 2294.4722713775923, 2297.6208925527435, 2302.1597117052324, 2320.4662927526597, 8877.0, 8989.640414383417, 8996.235319997808, 9005.324600654978, 9022.548872556412, 5307.761150748225, 5423.240746295522, 5439.3200849893765, 5456.236126942231, 5478.0, 3436.467347561107, 3450.6894379505716, 3458.6714262145056, 3528.3825330567047, 3541.4864844597646, 1080.7352198711287, 1185.9644210673607, 1190.3275897364217, 1197.3294954825326, 1219.9756004879853, 12109.273443593413, 12148.088893332946, 12163.51345946161, 12194.024478041736, 12200.877991220152, 4414.27164517851, 4723.173444647173, 4724.078804633064, 4867.150482816507, 4883.218685010382, 10473.371597704163, 10511.474426278655, 10515.0, 10606.628767993083, 10636.202284828669, 5356.651817631841, 5386.111291636836, 5408.945910540923, 5442.782288708408, 5446.019716451076, 4402.449693788277, 4809.398825146856, 4917.532834380728, 4926.556609905126, 4993.450720420751, 4129.545749967501, 4148.0982099925195, 4215.156968606291, 4232.174725928476, 4245.299525578307, 1285.119693010291, 1339.4441306857545, 1342.1276170489066, 1350.5745690107585, 1361.4758318047425, 866.3026263857655, 867.1761826265074, 887.245841035115, 889.2974550105345, 904.1546154345708, 5880.647161170344, 5959.642421454727, 6023.879522409527, 6157.975881011628, 6507.804765857032, 926.2451102351562, 977.8093271811929, 991.2466525440573, 992.9007099290013, 1026.0765311219814, 3861.3242682530445, 3913.5890731473355, 3997.7801220932547, 4008.6793056555407, 4055.918881622351, 10842.349459032483, 11161.665150045512, 11237.213395062266, 11246.775064498665, 11257.549698011988, 10860.402677852793, 11143.609973651046, 11241.381724005094, 11330.206885518099, 11339.546418143347, 7830.334421574116, 8058.35533157346, 8087.353011759163, 8123.0658474276215, 8173.79565510867, 6242.750289988349, 6250.937490625036, 6321.683915804283, 6364.236291645032, 6538.673066346759, 9822.165115964937, 9885.85171222418, 9916.256280778825, 9954.900450995687, 10003.099721025143, 10289.0, 10372.948135259276, 10392.42841643717, 10477.266591338534, 10607.257491975797, 7294.890576641248, 7579.469437139347, 7647.923520764721, 7734.806629834299, 7826.452148349788, 8547.658093676184, 8629.0, 8653.61058752345, 8654.30765538768, 8670.566471676517, 7464.216257292906, 7693.49992250502, 7849.372050236082, 7873.1733168016535, 7937.325327347009, 7214.567125972459, 7509.8498030038, 7698.0, 7735.7679269622, 7740.612969351622, 7115.359617634438, 7173.784786456415, 7190.856182876209, 7198.928010720036, 7254.274572542704, 4955.702657840541, 5026.698398096126, 5074.949250507448, 5090.160123579716, 5221.321228240305, 5054.82308119214, 5064.417591976822, 5094.414142373675, 5109.489051094861, 5195.142801437721], "value": 4717.114996041035, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.5260343596632, 324.9252671885466, 329.0966297513325, 332.4746899898161, 333.07903646417645, 5411.188321751734, 5453.890922181554, 5479.479449452306, 5511.724413779305, 5516.613837031405, 5366.892662146754, 5399.62202645815, 5412.888973300416, 5421.9457805421935, 5424.972875135619, 4090.8568200112927, 4130.215259100776, 4230.9153816923645, 4264.637505812009, 4308.9353659695125, 4286.314189729644, 4289.356596510533, 4291.570842915699, 4294.592013758688, 4299.828006879721, 4272.572742725733, 4276.123394704078, 4302.956970430302, 4304.720193187449, 4307.117041006586, 3985.720999530034, 4167.1457351242925, 4196.9370459443135, 4197.958020419787, 4319.589638984291, 3666.431703086026, 3681.318955993123, 3683.0, 3693.8153092345274, 3696.537932758405, 5333.5199832015305, 5362.356517217959, 5383.757730902119, 5385.7307134643115, 5387.622866399353, 4483.753393563353, 4815.951840481621, 4835.6131509479155, 4855.83004594841, 4867.123917694814, 5677.261955945742, 5688.488036076773, 5697.658140511582, 5714.742836572323, 5716.485516303511, 4020.8793736187963, 4038.7374820636564, 4041.1311568012725, 4054.0270335119653, 4057.3305404608204, 5852.619579727304, 5901.911471327933, 5934.1692163097205, 5946.524278057745, 5975.671338076404, 4170.270202714512, 4170.520390155171, 4174.540800511942, 4179.2895207814745, 4190.455240818735, 4222.796502996631, 4228.492580890313, 4231.322988321916, 4243.6605071594195, 4250.893727656833, 4704.811807527729, 4749.4775574686755, 4776.0, 4858.6356023298395, 4894.583960363409, 5576.832695019156, 5665.5467562594895, 5693.5160511357, 5702.087665973424, 5730.169125476783, 1452.6150570098932, 1464.8535146485267, 1466.5160497035952, 1467.8678918897351, 1467.9119252844864, 894.3337213775778, 916.0473107967772, 928.5125309212582, 931.1991687149047, 932.1331162019252, 5500.7524661390335, 5516.889662206733, 5525.778968841201, 5545.805896793673, 5552.222688823568, 5805.487679953567, 5806.767729290866, 5823.505002074871, 5871.3541510433815, 5888.646681199141, 5309.814156504503, 5516.172574113834, 5518.668879867221, 5525.751341189656, 5633.436656334334, 3071.600691910082, 3104.425681248976, 3111.9461155637173, 3113.0, 3127.217486032939, 5860.824175274749, 6154.630722156685, 6176.444120029129, 6192.659403732748, 6198.714681218961, 5976.581639285208, 5998.25021872266, 6030.969845150747, 6039.184710064173, 6067.271927368744, 6241.968790156111, 6260.40526150015, 6279.843003924939, 6289.276733175652, 6300.21247344082, 5619.943800561942, 5857.179994800646, 5874.882502350015, 5898.557608179318, 5929.703514824328, 5793.565482588739, 5831.212786273799, 5876.970615146897, 5883.235179426647, 5900.291964964232, 5902.38025007368, 6128.1726966858905, 6209.068639704081, 6236.376362363727, 6248.593841400295, 4183.435236243068, 4183.686223533308, 4191.43415638897, 4191.664666826708, 4200.579942005775, 5873.0, 5879.941200587939, 5895.086261629454, 5904.3800400959, 5905.763769449174, 5631.465010823965, 5754.827355179351, 5770.394108618702, 5790.739416726173, 5809.709514524341, 5663.433656634468, 5675.687837168995, 5703.743331550173, 5741.598088133791, 5766.394528574439, 5094.414142373526, 5620.74706638194, 5636.844446888296, 5660.660360378391, 5669.4047125051275, 5702.287214098238, 5733.512651424676, 5735.741891614971, 5737.168110624019, 5742.885142297047, 5608.663480191201, 5615.157726341082, 5615.859603509945, 5655.179998900218, 5660.54715622741], "value": 4356.660703471797, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.2015643261713, 747.3610063395796, 753.7399597138985, 782.4092809928503, 785.9567723775192, 15142.318595663193, 15870.761938570902, 15892.84107158928, 15896.205189740525, 15935.521934341974, 15404.768928466054, 15450.381984720598, 15483.845161548381, 15551.222438878067, 15571.143587102704, 662.443547420167, 788.6017561131621, 799.54825523579, 811.2739098506833, 813.8128230506987, 812.7521106062649, 820.1552401026922, 822.2312138150818, 823.3783493462428, 823.6499487717726, 869.5739087846941, 871.2159056848855, 872.310874409216, 872.7948932000975, 872.9301655867547, 850.9319254459629, 856.2721686566431, 864.062492195965, 865.091653763549, 868.769776009358, 629.8205011571725, 631.5389765471186, 633.4805459523193, 633.5153607490273, 635.3551145587232, 14798.48205312809, 14822.629434264121, 14831.77752333716, 14858.628534286729, 14889.925550372287, 15479.22603869802, 15493.380264789395, 15831.525054248392, 15905.443309484228, 15914.76127858083, 11630.418479076097, 12010.039196864318, 12099.153059285854, 12189.146759726822, 12521.0, 3951.170254246612, 4041.9797901010306, 4145.647619952308, 4148.979255103735, 4155.272827255249, 79832.0, 80411.0, 82322.58838705828, 82430.58784706038, 83189.58405207936, 11714.1800073994, 12062.51749929993, 12194.207376520499, 12290.877091228973, 12591.87408125907, 22855.31434056981, 22880.313590592308, 22920.4269893254, 22929.904462897295, 22955.770442295696, 8740.956295218482, 8862.113788621215, 8880.378373513791, 9017.549122543847, 9289.442633442015, 4944.3572335596145, 4978.701277923264, 5067.5439210470495, 5103.744812759347, 5127.051495473349, 3561.0919215599856, 3666.2850744105176, 3672.779633222015, 3674.797886116289, 3695.224002959355, 585.3093349847136, 597.8595030167907, 608.6652341212404, 615.9876802463925, 617.9011358182669, 569.4618585436723, 596.3916804859019, 670.9533128319837, 690.623610132479, 726.23019599225, 9333.719988400358, 9829.24781061304, 9923.40459572428, 10459.0, 10857.565697372016, 606.0998768859657, 645.9515536334794, 685.348918527401, 699.3635791429774, 750.4034292737177, 4827.155247831615, 5072.721000344943, 5086.949130508648, 5118.344229626284, 5119.692818430832, 110056.0, 110811.44594276977, 110939.0, 111540.0, 117177.41411292889, 94546.0, 97043.0, 97061.51469242609, 101236.49381753191, 101887.0, 57125.428745712845, 87705.56147219223, 89014.0, 89876.0, 92210.0, 9243.428617135238, 9496.287778416785, 9581.377210481296, 9583.549922027925, 9665.014866204163, 47872.521274786806, 48203.51796482131, 49299.0, 50215.74892125516, 51087.2336914954, 68928.0, 69012.0, 74134.0, 76519.0, 78932.21067789248, 11594.072474201876, 11604.419779010846, 11677.941610291895, 11818.885602556968, 12007.318975343633, 13552.457901683822, 13735.862641373858, 13762.0, 13894.861051389762, 14411.85588144147, 12761.680957976125, 12982.675433114247, 13106.934465327613, 13845.100068495516, 13898.722025559635, 12652.936735316265, 13046.0, 13301.80047299272, 13721.725565488434, 13788.103773254707, 11464.157732814396, 12733.490660373482, 13414.798778018532, 13557.525486607921, 14166.150030998173, 11435.768012177434, 11481.885181148416, 11598.246114002563, 11608.941955290169, 11680.883191167979, 11200.607978720705, 11402.247908806225, 11625.767484650429, 11895.286282822712, 12067.0], "value": 7609.775752150457, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 107.0, 112.0, 112.0, 114.0, 113.0, 112.0, 112.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 149.0, 195.0, 122.0, 151.0, 143.0, 126.0, 186.0, 118.0], "value": 145.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 161.0, 164.0, 175.0, 164.0, 162.0, 161.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 182.0, 76.0, 75.0, 74.0, 77.0, 176.0, 76.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 153.0, 85.0, 85.0, 85.0, 136.0, 84.0, 84.0, 153.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 52.0, 53.0, 51.0, 52.0, 51.0, 52.0, 51.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0, 63.0, 60.0, 59.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 77.0, 78.0, 82.0, 78.0, 81.0, 82.0, 78.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 132.0, 141.0, 131.0, 131.0, 122.0, 125.0, 123.0, 138.0, 141.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 161.0, 160.0, 159.0, 159.0, 159.0, 161.0, 163.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 64.0, 63.0, 65.0, 64.0, 62.0, 67.0], "value": 64.5, "unit": "score"}]}]} 22:42:26 INFO - Return code: 0 22:42:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:42:26 ERROR - # TBPL SUCCESS # 22:42:26 INFO - Running post-action listener: _resource_record_post_action 22:42:26 INFO - [mozharness: 2016-08-06 05:42:26.692553Z] Finished run-tests step (success) 22:42:26 INFO - Running post-run listener: _resource_record_post_run 22:42:26 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 560140288; Read time: 296; Write time: 518680 22:42:26 INFO - TinderboxPrint: CPU usage
13.3% 22:42:26 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 296 22:42:26 INFO - TinderboxPrint: I/O write bytes / time
560,140,288 / 518,680 22:42:26 INFO - TinderboxPrint: CPU idle
8,255.7 (86.7%) 22:42:26 INFO - TinderboxPrint: CPU user
1,205.5 (12.7%) 22:42:26 INFO - TinderboxPrint: Swap in / out
0 / 0 22:42:26 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 264773632; Read time: 120; Write time: 296024 22:42:26 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295186432; Read time: 164; Write time: 222636 22:42:27 INFO - Running post-run listener: _upload_blobber_files 22:42:27 INFO - Blob upload gear active. 22:42:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:42:27 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 22:42:27 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'] 22:42:27 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 22:42:27 INFO - (blobuploader) - INFO - Open directory for files ... 22:42:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:42:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:42:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:42:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:42:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:42:28 INFO - (blobuploader) - INFO - Done attempting. 22:42:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:42:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:42:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:42:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:42:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:42:33 INFO - (blobuploader) - INFO - Done attempting. 22:42:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:42:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:42:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:42:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:42:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:42:33 INFO - (blobuploader) - INFO - Done attempting. 22:42:33 INFO - (blobuploader) - INFO - Iteration through files over. 22:42:33 INFO - Return code: 0 22:42:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:42:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:42:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39ba285746d4af97d0a4576e43e239ba4ae34d99696aef185d931b88a2c1feaae099533dea0632036ebb5271e62486d311afb5fa3a604035652c5374e0b4cb08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74e51dccfac7d5eda8c3fe854944ab400f5e9bbedad56a1b42df296b309b9764825880a59b9b71edaf96fdcb3a78be06faa73e6ea6003219ee8a92b5716b1aac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c854d3a2fc625523418f0256d32d22aebba3f5b294a72501a504f372e821a8d70bb352093e0af9bc347fe3203e3da7d46a5789c1321d0aa79e94cfc8f1e7d0f"} 22:42:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:42:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:42:33 INFO - Contents: 22:42:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39ba285746d4af97d0a4576e43e239ba4ae34d99696aef185d931b88a2c1feaae099533dea0632036ebb5271e62486d311afb5fa3a604035652c5374e0b4cb08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74e51dccfac7d5eda8c3fe854944ab400f5e9bbedad56a1b42df296b309b9764825880a59b9b71edaf96fdcb3a78be06faa73e6ea6003219ee8a92b5716b1aac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c854d3a2fc625523418f0256d32d22aebba3f5b294a72501a504f372e821a8d70bb352093e0af9bc347fe3203e3da7d46a5789c1321d0aa79e94cfc8f1e7d0f"} 22:42:33 INFO - Running post-run listener: copy_logs_to_upload_dir 22:42:33 INFO - Copying logs to upload dir... 22:42:33 INFO - mkdir: /builds/slave/test/build/upload/logs 22:42:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.921035 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-05 22:42:33.700815) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 22:42:33.705609) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620 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/39ba285746d4af97d0a4576e43e239ba4ae34d99696aef185d931b88a2c1feaae099533dea0632036ebb5271e62486d311afb5fa3a604035652c5374e0b4cb08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74e51dccfac7d5eda8c3fe854944ab400f5e9bbedad56a1b42df296b309b9764825880a59b9b71edaf96fdcb3a78be06faa73e6ea6003219ee8a92b5716b1aac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c854d3a2fc625523418f0256d32d22aebba3f5b294a72501a504f372e821a8d70bb352093e0af9bc347fe3203e3da7d46a5789c1321d0aa79e94cfc8f1e7d0f"} build_url:https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/SHyhuRHbRwikE1DLSb2Lig/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/39ba285746d4af97d0a4576e43e239ba4ae34d99696aef185d931b88a2c1feaae099533dea0632036ebb5271e62486d311afb5fa3a604035652c5374e0b4cb08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74e51dccfac7d5eda8c3fe854944ab400f5e9bbedad56a1b42df296b309b9764825880a59b9b71edaf96fdcb3a78be06faa73e6ea6003219ee8a92b5716b1aac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c854d3a2fc625523418f0256d32d22aebba3f5b294a72501a504f372e821a8d70bb352093e0af9bc347fe3203e3da7d46a5789c1321d0aa79e94cfc8f1e7d0f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 22:42:33.733973) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 22:42:33.734329) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470454267.633028-179481620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 22:42:33.814162) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 22:42:33.814479) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 22:42:33.814765) ========= ========= Total master_lag: 0.23 =========