builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1471882061.0 results: success (0) buildid: 20160822073008 builduid: 5b69268762924a61891fc21c777b70aa revision: 194fe275b4e60ded2af6b25173eec421f0dba8ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.001982) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.002442) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.002924) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.039767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.040122) ========= 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=31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 09:07:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 14.2M=0.001s 2016-08-22 09:07:41 (14.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075853 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.130927) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.131529) ========= 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=31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014499 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.183220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.183693) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 194fe275b4e60ded2af6b25173eec421f0dba8ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 194fe275b4e60ded2af6b25173eec421f0dba8ad --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=31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 09:07:42,075 truncating revision to first 12 chars 2016-08-22 09:07:42,075 Setting DEBUG logging. 2016-08-22 09:07:42,075 attempt 1/10 2016-08-22 09:07:42,075 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/194fe275b4e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 09:07:42,383 unpacking tar archive at: mozilla-central-194fe275b4e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647688 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.849615) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.850194) ========= script_repo_revision: 194fe275b4e60ded2af6b25173eec421f0dba8ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.851012) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.851371) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 09:07:41.865622) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-22 09:07:41.865933) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:07:42 INFO - MultiFileLogger online at 20160822 09:07:42 in /builds/slave/test 09:07:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:07:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:07:42 INFO - {'append_to_log': False, 09:07:42 INFO - 'base_work_dir': '/builds/slave/test', 09:07:42 INFO - 'blob_upload_branch': 'Firefox', 09:07:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:07:42 INFO - 'branch': 'Firefox', 09:07:42 INFO - 'buildbot_json_path': 'buildprops.json', 09:07:42 INFO - 'config_files': ('talos/linux_config.py',), 09:07:42 INFO - 'default_actions': ('clobber', 09:07:42 INFO - 'read-buildbot-config', 09:07:42 INFO - 'download-and-extract', 09:07:42 INFO - 'populate-webroot', 09:07:42 INFO - 'create-virtualenv', 09:07:42 INFO - 'install', 09:07:42 INFO - 'run-tests'), 09:07:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:07:42 INFO - 'download_minidump_stackwalk': True, 09:07:42 INFO - 'download_symbols': 'ondemand', 09:07:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:07:42 INFO - 'tooltool.py': '/tools/tooltool.py', 09:07:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:07:42 INFO - '/tools/misc-python/virtualenv.py')}, 09:07:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:07:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:07:42 INFO - 'installer_path': 'installer.exe', 09:07:42 INFO - 'log_level': 'info', 09:07:42 INFO - 'log_name': 'talos', 09:07:42 INFO - 'log_to_console': True, 09:07:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:07:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:07:42 INFO - 'opt_config_files': (), 09:07:42 INFO - 'pip_index': False, 09:07:42 INFO - 'sps_profile': False, 09:07:42 INFO - 'sps_profile_interval': 0, 09:07:42 INFO - 'suite': 'dromaeojs', 09:07:42 INFO - 'system_bits': '32', 09:07:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:07:42 INFO - 'title': 'talos-linux64-ix-014', 09:07:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:07:42 INFO - 'use_talos_json': True, 09:07:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:07:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:07:42 INFO - 'work_dir': 'build'} 09:07:42 INFO - [mozharness: 2016-08-22 16:07:42.857417Z] Running clobber step. 09:07:42 INFO - Running pre-action listener: _resource_record_pre_action 09:07:42 INFO - Running main action method: clobber 09:07:42 INFO - rmtree: /builds/slave/test/build 09:07:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:07:43 INFO - Running post-action listener: _resource_record_post_action 09:07:43 INFO - [mozharness: 2016-08-22 16:07:43.311696Z] Finished clobber step (success) 09:07:43 INFO - [mozharness: 2016-08-22 16:07:43.311796Z] Running read-buildbot-config step. 09:07:43 INFO - Running pre-action listener: _resource_record_pre_action 09:07:43 INFO - Running main action method: read_buildbot_config 09:07:43 INFO - Using buildbot properties: 09:07:43 INFO - { 09:07:43 INFO - "project": "", 09:07:43 INFO - "product": "firefox", 09:07:43 INFO - "script_repo_revision": "production", 09:07:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:07:43 INFO - "repository": "", 09:07:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 09:07:43 INFO - "buildid": "20160822073008", 09:07:43 INFO - "pgo_build": "True", 09:07:43 INFO - "basedir": "/builds/slave/test", 09:07:43 INFO - "buildnumber": 426, 09:07:43 INFO - "slavename": "talos-linux64-ix-014", 09:07:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:07:43 INFO - "platform": "ubuntu64_hw", 09:07:43 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:07:43 INFO - "branch": "mozilla-central", 09:07:43 INFO - "repo_path": "mozilla-central", 09:07:43 INFO - "revision": "194fe275b4e60ded2af6b25173eec421f0dba8ad", 09:07:43 INFO - "stage_platform": "linux64-pgo", 09:07:43 INFO - "builduid": "5b69268762924a61891fc21c777b70aa", 09:07:43 INFO - "slavebuilddir": "test" 09:07:43 INFO - } 09:07:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:07:43 INFO - Running post-action listener: _resource_record_post_action 09:07:43 INFO - [mozharness: 2016-08-22 16:07:43.314233Z] Finished read-buildbot-config step (success) 09:07:43 INFO - [mozharness: 2016-08-22 16:07:43.314321Z] Running download-and-extract step. 09:07:43 INFO - Running pre-action listener: _resource_record_pre_action 09:07:43 INFO - Running main action method: download_and_extract 09:07:43 INFO - mkdir: /builds/slave/test/build/tests 09:07:43 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')]} 09:07:43 INFO - trying https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:07:43 INFO - Downloading https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/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 09:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/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 09:07:43 INFO - Downloaded 1361 bytes. 09:07:43 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:07:43 INFO - Using the following test package requirements: 09:07:43 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:43 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:07:43 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:07:43 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:43 INFO - u'jsshell-linux-x86_64.zip'], 09:07:43 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:07:43 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:43 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:07:43 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:07:43 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:07:43 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:07:43 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:07:43 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')]} 09:07:43 INFO - trying https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:07:43 INFO - Downloading https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/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 09:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/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 09:07:44 INFO - Downloaded 21919866 bytes. 09:07:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 09:07:48 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 09:07:48 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')]} 09:07:48 INFO - trying https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:07:48 INFO - Downloading https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/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 09:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/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 09:07:49 INFO - Downloaded 21919866 bytes. 09:07:49 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 09:07:54 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')]} 09:07:54 INFO - trying https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:07:54 INFO - Downloading https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/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 09:07:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/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 09:07:55 INFO - Downloaded 14413981 bytes. 09:07:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 09:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:55 INFO - trying https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:07:55 INFO - Downloading https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/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 09:07:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/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 09:07:56 INFO - Downloaded 59805195 bytes. 09:07:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:07:56 INFO - mkdir: /builds/slave/test/properties 09:07:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:07:56 INFO - Writing to file /builds/slave/test/properties/build_url 09:07:56 INFO - Contents: 09:07:56 INFO - build_url:https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:07:57 INFO - Running post-action listener: _resource_record_post_action 09:07:57 INFO - Running post-action listener: set_extra_try_arguments 09:07:57 INFO - [mozharness: 2016-08-22 16:07:57.140787Z] Finished download-and-extract step (success) 09:07:57 INFO - [mozharness: 2016-08-22 16:07:57.141082Z] Running populate-webroot step. 09:07:57 INFO - Running pre-action listener: _resource_record_pre_action 09:07:57 INFO - Running main action method: populate_webroot 09:07:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:07:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:07:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:07:57 INFO - '--tppagecycles', 09:07:57 INFO - '7'], 09:07:57 INFO - 'tests': ['tsvgm']}}, 09:07:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:07:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:07:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:07:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:07:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:07:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:07:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:57 INFO - 'talos_options': ['--disable-e10s'], 09:07:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:57 INFO - 'talos_options': ['--disable-e10s'], 09:07:57 INFO - 'tests': ['damp', 'tps']}, 09:07:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:57 INFO - 'tests': ['damp', 'tps']}, 09:07:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:07:57 INFO - 'tests': ['dromaeo_dom']}, 09:07:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:07:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:07:57 INFO - 'tests': ['basic_compositor_video']}, 09:07:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:07:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:07:57 INFO - 'tests': ['a11yr', 09:07:57 INFO - 'ts_paint', 09:07:57 INFO - 'tpaint', 09:07:57 INFO - 'sessionrestore', 09:07:57 INFO - 'sessionrestore_no_auto_restore', 09:07:57 INFO - 'tabpaint']}, 09:07:57 INFO - 'other-e10s': {'tests': ['a11yr', 09:07:57 INFO - 'ts_paint', 09:07:57 INFO - 'tpaint', 09:07:57 INFO - 'sessionrestore', 09:07:57 INFO - 'sessionrestore_no_auto_restore', 09:07:57 INFO - 'tabpaint']}, 09:07:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:07:57 INFO - 'ts_paint', 09:07:57 INFO - 'tpaint', 09:07:57 INFO - 'sessionrestore', 09:07:57 INFO - 'sessionrestore_no_auto_restore', 09:07:57 INFO - 'tabpaint']}, 09:07:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:07:57 INFO - 'ts_paint', 09:07:57 INFO - 'tpaint', 09:07:57 INFO - 'sessionrestore', 09:07:57 INFO - 'sessionrestore_no_auto_restore', 09:07:57 INFO - 'tabpaint']}, 09:07:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:07:57 INFO - 'tests': ['a11yr', 09:07:57 INFO - 'ts_paint', 09:07:57 INFO - 'tpaint', 09:07:57 INFO - 'sessionrestore', 09:07:57 INFO - 'sessionrestore_no_auto_restore', 09:07:57 INFO - 'tabpaint']}, 09:07:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:07:57 INFO - 'tests': ['a11yr', 09:07:57 INFO - 'ts_paint', 09:07:57 INFO - 'tpaint', 09:07:57 INFO - 'sessionrestore', 09:07:57 INFO - 'sessionrestore_no_auto_restore', 09:07:57 INFO - 'tabpaint']}, 09:07:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:07:57 INFO - 'tests': ['tsvgx', 09:07:57 INFO - 'tsvgr_opacity', 09:07:57 INFO - 'tart', 09:07:57 INFO - 'tscrollx', 09:07:57 INFO - 'cart']}, 09:07:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:07:57 INFO - 'tsvgr_opacity', 09:07:57 INFO - 'tart', 09:07:57 INFO - 'tscrollx', 09:07:57 INFO - 'cart']}, 09:07:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:57 INFO - 'talos_options': ['--disable-e10s'], 09:07:57 INFO - 'tests': ['tp5o']}, 09:07:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:57 INFO - 'tests': ['tp5o']}, 09:07:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:57 INFO - 'talos_options': ['--disable-e10s', 09:07:57 INFO - '--xperf_path', 09:07:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:57 INFO - 'tests': ['tp5n']}, 09:07:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:57 INFO - 'talos_options': ['--xperf_path', 09:07:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:57 INFO - 'tests': ['tp5n']}}, 09:07:57 INFO - 'talos.zip': {'path': '', 09:07:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:07:57 INFO - Running post-action listener: _resource_record_post_action 09:07:57 INFO - [mozharness: 2016-08-22 16:07:57.160875Z] Finished populate-webroot step (success) 09:07:57 INFO - [mozharness: 2016-08-22 16:07:57.160969Z] Running create-virtualenv step. 09:07:57 INFO - Running pre-action listener: _resource_record_pre_action 09:07:57 INFO - Running main action method: create_virtualenv 09:07:57 INFO - Creating virtualenv /builds/slave/test/build/venv 09:07:57 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 09:07:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:07:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:07:57 INFO - Using real prefix '/usr' 09:07:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:07:57 INFO - Installing distribute.............................................................................................................................................................................................done. 09:07:59 INFO - Installing pip.................done. 09:07:59 INFO - Return code: 0 09:07:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:59 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 0x7fc9234f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705760>, '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 0x2706660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706af0>, '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': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', '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 09:07:59 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 09:07:59 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 09:07:59 INFO - Using env: {'DISPLAY': ':0', 09:07:59 INFO - 'HOME': '/home/cltbld', 09:07:59 INFO - 'LANG': 'en_US.UTF-8', 09:07:59 INFO - 'LANGUAGE': 'en_US:en', 09:07:59 INFO - 'LOGNAME': 'cltbld', 09:07:59 INFO - 'MAIL': '/var/mail/cltbld', 09:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:59 INFO - 'MOZ_NO_REMOTE': '1', 09:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:59 INFO - 'NO_EM_RESTART': '1', 09:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:59 INFO - 'PWD': '/builds/slave/test', 09:07:59 INFO - 'SHELL': '/bin/bash', 09:07:59 INFO - 'SHLVL': '1', 09:07:59 INFO - 'TERM': 'linux', 09:07:59 INFO - 'TMOUT': '86400', 09:07:59 INFO - 'USER': 'cltbld', 09:07:59 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', 09:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:59 INFO - '_': '/tools/buildbot/bin/python'} 09:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:59 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 09:07:59 INFO - Cleaning up... 09:07:59 INFO - Return code: 0 09:07:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:59 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 0x7fc9234f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705760>, '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 0x2706660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706af0>, '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': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', '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 09:07:59 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 09:07:59 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 09:07:59 INFO - Using env: {'DISPLAY': ':0', 09:07:59 INFO - 'HOME': '/home/cltbld', 09:07:59 INFO - 'LANG': 'en_US.UTF-8', 09:07:59 INFO - 'LANGUAGE': 'en_US:en', 09:07:59 INFO - 'LOGNAME': 'cltbld', 09:07:59 INFO - 'MAIL': '/var/mail/cltbld', 09:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:59 INFO - 'MOZ_NO_REMOTE': '1', 09:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:59 INFO - 'NO_EM_RESTART': '1', 09:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:59 INFO - 'PWD': '/builds/slave/test', 09:07:59 INFO - 'SHELL': '/bin/bash', 09:07:59 INFO - 'SHLVL': '1', 09:07:59 INFO - 'TERM': 'linux', 09:07:59 INFO - 'TMOUT': '86400', 09:07:59 INFO - 'USER': 'cltbld', 09:07:59 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', 09:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:59 INFO - '_': '/tools/buildbot/bin/python'} 09:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:00 INFO - Downloading/unpacking psutil>=3.1.1 09:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:08:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:02 INFO - Installing collected packages: psutil 09:08:02 INFO - Running setup.py install for psutil 09:08:02 INFO - building 'psutil._psutil_linux' extension 09:08:02 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 09:08:02 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 09:08:02 INFO - building 'psutil._psutil_posix' extension 09:08:02 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 09:08:02 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 09:08:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:02 INFO - Successfully installed psutil 09:08:02 INFO - Cleaning up... 09:08:02 INFO - Return code: 0 09:08:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:08:02 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')]} 09:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:02 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')]} 09:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:02 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 0x7fc9234f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705760>, '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 0x2706660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706af0>, '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': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', '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 09:08:02 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 09:08:02 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 09:08:02 INFO - Using env: {'DISPLAY': ':0', 09:08:02 INFO - 'HOME': '/home/cltbld', 09:08:02 INFO - 'LANG': 'en_US.UTF-8', 09:08:02 INFO - 'LANGUAGE': 'en_US:en', 09:08:02 INFO - 'LOGNAME': 'cltbld', 09:08:02 INFO - 'MAIL': '/var/mail/cltbld', 09:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:02 INFO - 'MOZ_NO_REMOTE': '1', 09:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:02 INFO - 'NO_EM_RESTART': '1', 09:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:02 INFO - 'PWD': '/builds/slave/test', 09:08:02 INFO - 'SHELL': '/bin/bash', 09:08:02 INFO - 'SHLVL': '1', 09:08:02 INFO - 'TERM': 'linux', 09:08:02 INFO - 'TMOUT': '86400', 09:08:02 INFO - 'USER': 'cltbld', 09:08:02 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', 09:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:02 INFO - '_': '/tools/buildbot/bin/python'} 09:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:08:02 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 09:08:02 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 09:08:02 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 09:08:02 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 09:08:02 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 09:08:02 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 09:08:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:08:04 INFO - Installing collected packages: mozsystemmonitor 09:08:04 INFO - Running setup.py install for mozsystemmonitor 09:08:04 INFO - Successfully installed mozsystemmonitor 09:08:04 INFO - Cleaning up... 09:08:05 INFO - Return code: 0 09:08:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:05 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 0x7fc9234f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705760>, '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 0x2706660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706af0>, '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': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', '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 09:08:05 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 09:08:05 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 09:08:05 INFO - Using env: {'DISPLAY': ':0', 09:08:05 INFO - 'HOME': '/home/cltbld', 09:08:05 INFO - 'LANG': 'en_US.UTF-8', 09:08:05 INFO - 'LANGUAGE': 'en_US:en', 09:08:05 INFO - 'LOGNAME': 'cltbld', 09:08:05 INFO - 'MAIL': '/var/mail/cltbld', 09:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:05 INFO - 'MOZ_NO_REMOTE': '1', 09:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:05 INFO - 'NO_EM_RESTART': '1', 09:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:05 INFO - 'PWD': '/builds/slave/test', 09:08:05 INFO - 'SHELL': '/bin/bash', 09:08:05 INFO - 'SHLVL': '1', 09:08:05 INFO - 'TERM': 'linux', 09:08:05 INFO - 'TMOUT': '86400', 09:08:05 INFO - 'USER': 'cltbld', 09:08:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', 09:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:05 INFO - '_': '/tools/buildbot/bin/python'} 09:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:05 INFO - Downloading/unpacking jsonschema==2.5.1 09:08:05 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 09:08:05 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 09:08:05 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 09:08:05 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 09:08:05 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 09:08:05 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 09:08:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:08:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:07 INFO - Downloading functools32-3.2.3-2.tar.gz 09:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:08:07 INFO - warning: no files found matching '*.txt' 09:08:07 INFO - no previously-included directories found matching 'build' 09:08:07 INFO - no previously-included directories found matching 'dist' 09:08:07 INFO - no previously-included directories found matching '.git*' 09:08:07 INFO - Installing collected packages: jsonschema, functools32 09:08:07 INFO - Running setup.py install for functools32 09:08:07 INFO - warning: no files found matching '*.txt' 09:08:07 INFO - no previously-included directories found matching 'build' 09:08:07 INFO - no previously-included directories found matching 'dist' 09:08:07 INFO - no previously-included directories found matching '.git*' 09:08:07 INFO - Successfully installed jsonschema functools32 09:08:07 INFO - Cleaning up... 09:08:07 INFO - Return code: 0 09:08:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:08:07 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')]} 09:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:07 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')]} 09:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:07 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 0x7fc9234f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705760>, '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 0x2706660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706af0>, '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': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', '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 09:08:07 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 09:08:07 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 09:08:07 INFO - Using env: {'DISPLAY': ':0', 09:08:07 INFO - 'HOME': '/home/cltbld', 09:08:07 INFO - 'LANG': 'en_US.UTF-8', 09:08:07 INFO - 'LANGUAGE': 'en_US:en', 09:08:07 INFO - 'LOGNAME': 'cltbld', 09:08:07 INFO - 'MAIL': '/var/mail/cltbld', 09:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:07 INFO - 'MOZ_NO_REMOTE': '1', 09:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:07 INFO - 'NO_EM_RESTART': '1', 09:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:07 INFO - 'PWD': '/builds/slave/test', 09:08:07 INFO - 'SHELL': '/bin/bash', 09:08:07 INFO - 'SHLVL': '1', 09:08:07 INFO - 'TERM': 'linux', 09:08:07 INFO - 'TMOUT': '86400', 09:08:07 INFO - 'USER': 'cltbld', 09:08:07 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', 09:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:07 INFO - '_': '/tools/buildbot/bin/python'} 09:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:08:07 INFO - Cleaning up... 09:08:07 INFO - Return code: 0 09:08:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:08:07 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')]} 09:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:07 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')]} 09:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:07 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 0x7fc9234f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705760>, '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 0x2706660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706af0>, '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': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', '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 09:08:07 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 09:08:07 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 09:08:07 INFO - Using env: {'DISPLAY': ':0', 09:08:07 INFO - 'HOME': '/home/cltbld', 09:08:07 INFO - 'LANG': 'en_US.UTF-8', 09:08:07 INFO - 'LANGUAGE': 'en_US:en', 09:08:07 INFO - 'LOGNAME': 'cltbld', 09:08:07 INFO - 'MAIL': '/var/mail/cltbld', 09:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:07 INFO - 'MOZ_NO_REMOTE': '1', 09:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:07 INFO - 'NO_EM_RESTART': '1', 09:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:07 INFO - 'PWD': '/builds/slave/test', 09:08:07 INFO - 'SHELL': '/bin/bash', 09:08:07 INFO - 'SHLVL': '1', 09:08:07 INFO - 'TERM': 'linux', 09:08:07 INFO - 'TMOUT': '86400', 09:08:07 INFO - 'USER': 'cltbld', 09:08:07 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', 09:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:07 INFO - '_': '/tools/buildbot/bin/python'} 09:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:07 INFO - Downloading/unpacking blobuploader==1.2.4 09:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:09 INFO - Downloading blobuploader-1.2.4.tar.gz 09:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:08:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:08:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:10 INFO - Downloading docopt-0.6.1.tar.gz 09:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:08:10 INFO - Installing collected packages: blobuploader, requests, docopt 09:08:10 INFO - Running setup.py install for blobuploader 09:08:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:08:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:08:10 INFO - Running setup.py install for requests 09:08:11 INFO - Running setup.py install for docopt 09:08:11 INFO - Successfully installed blobuploader requests docopt 09:08:11 INFO - Cleaning up... 09:08:11 INFO - Return code: 0 09:08:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:11 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')]} 09:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:11 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')]} 09:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:11 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 0x7fc9234f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705760>, '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 0x2706660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706af0>, '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': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', '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 09:08:11 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 09:08:11 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 09:08:11 INFO - Using env: {'DISPLAY': ':0', 09:08:11 INFO - 'HOME': '/home/cltbld', 09:08:11 INFO - 'LANG': 'en_US.UTF-8', 09:08:11 INFO - 'LANGUAGE': 'en_US:en', 09:08:11 INFO - 'LOGNAME': 'cltbld', 09:08:11 INFO - 'MAIL': '/var/mail/cltbld', 09:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:11 INFO - 'MOZ_NO_REMOTE': '1', 09:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:11 INFO - 'NO_EM_RESTART': '1', 09:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:11 INFO - 'PWD': '/builds/slave/test', 09:08:11 INFO - 'SHELL': '/bin/bash', 09:08:11 INFO - 'SHLVL': '1', 09:08:11 INFO - 'TERM': 'linux', 09:08:11 INFO - 'TMOUT': '86400', 09:08:11 INFO - 'USER': 'cltbld', 09:08:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', 09:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:11 INFO - '_': '/tools/buildbot/bin/python'} 09:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:08:11 INFO - Running setup.py (path:/tmp/pip-6YcZVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:08:11 INFO - Running setup.py (path:/tmp/pip-p_xCBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:08:11 INFO - Running setup.py (path:/tmp/pip-Hnrxvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:08:11 INFO - Running setup.py (path:/tmp/pip-dzqBsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:08:11 INFO - Running setup.py (path:/tmp/pip-CF8jCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:08:11 INFO - Running setup.py (path:/tmp/pip-fZlvL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:08:11 INFO - Running setup.py (path:/tmp/pip-LvW96k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:08:12 INFO - Running setup.py (path:/tmp/pip-CrL24S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:08:12 INFO - Running setup.py (path:/tmp/pip-xb13Qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:08:12 INFO - Running setup.py (path:/tmp/pip-zw0v9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:08:12 INFO - Running setup.py (path:/tmp/pip-rqkU_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:08:12 INFO - Running setup.py (path:/tmp/pip-TS4WXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:08:12 INFO - Running setup.py (path:/tmp/pip-GSfKeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:08:12 INFO - Running setup.py (path:/tmp/pip-0idXwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:12 INFO - Running setup.py (path:/tmp/pip-uBj5xY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:08:12 INFO - Running setup.py (path:/tmp/pip-bZOzAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:08:12 INFO - Running setup.py (path:/tmp/pip-CaDgde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:08:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:08:12 INFO - Running setup.py install for manifestparser 09:08:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Running setup.py install for mozcrash 09:08:12 INFO - Running setup.py install for mozdebug 09:08:13 INFO - Running setup.py install for mozdevice 09:08:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for mozfile 09:08:13 INFO - Running setup.py install for mozhttpd 09:08:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for mozinfo 09:08:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for mozInstall 09:08:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for mozleak 09:08:13 INFO - Running setup.py install for mozlog 09:08:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for moznetwork 09:08:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for mozprocess 09:08:13 INFO - Running setup.py install for mozprofile 09:08:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:08:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:08:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:08:14 INFO - Running setup.py install for mozrunner 09:08:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:08:14 INFO - Running setup.py install for mozscreenshot 09:08:14 INFO - Running setup.py install for moztest 09:08:14 INFO - Running setup.py install for mozversion 09:08:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:08:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:08:14 INFO - Cleaning up... 09:08:14 INFO - Return code: 0 09:08:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08: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')]} 09:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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')]} 09:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:14 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 0x7fc9234f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705760>, '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 0x2706660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706af0>, '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': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', '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 09:08:14 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 09:08:14 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 09:08:14 INFO - Using env: {'DISPLAY': ':0', 09:08:14 INFO - 'HOME': '/home/cltbld', 09:08:14 INFO - 'LANG': 'en_US.UTF-8', 09:08:14 INFO - 'LANGUAGE': 'en_US:en', 09:08:14 INFO - 'LOGNAME': 'cltbld', 09:08:14 INFO - 'MAIL': '/var/mail/cltbld', 09:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:14 INFO - 'MOZ_NO_REMOTE': '1', 09:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:14 INFO - 'NO_EM_RESTART': '1', 09:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:14 INFO - 'PWD': '/builds/slave/test', 09:08:14 INFO - 'SHELL': '/bin/bash', 09:08:14 INFO - 'SHLVL': '1', 09:08:14 INFO - 'TERM': 'linux', 09:08:14 INFO - 'TMOUT': '86400', 09:08:14 INFO - 'USER': 'cltbld', 09:08:14 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', 09:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:14 INFO - '_': '/tools/buildbot/bin/python'} 09:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:08:14 INFO - Running setup.py (path:/tmp/pip-omLrWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:08:14 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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:08:14 INFO - Running setup.py (path:/tmp/pip-INRpvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:08:14 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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:08:14 INFO - Running setup.py (path:/tmp/pip-4uC7KH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:08:14 INFO - Running setup.py (path:/tmp/pip-8oMR1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:08:15 INFO - Running setup.py (path:/tmp/pip-btoWUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:08:15 INFO - Running setup.py (path:/tmp/pip-eDD8Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:08:15 INFO - Running setup.py (path:/tmp/pip-mRehF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:08:15 INFO - Running setup.py (path:/tmp/pip-6QQ5Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:08:15 INFO - Running setup.py (path:/tmp/pip-nD9Ti4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:08:15 INFO - Running setup.py (path:/tmp/pip-UWbltV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:08:15 INFO - Running setup.py (path:/tmp/pip-6P4KwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:08:15 INFO - Running setup.py (path:/tmp/pip-o36XLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:08:15 INFO - Running setup.py (path:/tmp/pip-z4hw2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:08:15 INFO - Running setup.py (path:/tmp/pip-nC8EeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:15 INFO - Running setup.py (path:/tmp/pip-V_R4Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:08:15 INFO - Running setup.py (path:/tmp/pip-ecLTID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:08:15 INFO - Running setup.py (path:/tmp/pip-V9HIkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:08:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:08:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:08:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:08:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:08:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:08:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:08:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:17 INFO - Downloading blessings-1.6.tar.gz 09:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:08:17 INFO - Installing collected packages: blessings 09:08:17 INFO - Running setup.py install for blessings 09:08:18 INFO - Successfully installed blessings 09:08:18 INFO - Cleaning up... 09:08:18 INFO - Return code: 0 09:08:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:08:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:08:18 INFO - Reading from file tmpfile_stdout 09:08:18 INFO - Current package versions: 09:08:18 INFO - argparse == 1.2.1 09:08:18 INFO - blessings == 1.6 09:08:18 INFO - blobuploader == 1.2.4 09:08:18 INFO - docopt == 0.6.1 09:08:18 INFO - functools32 == 3.2.3-2 09:08:18 INFO - jsonschema == 2.5.1 09:08:18 INFO - manifestparser == 1.1 09:08:18 INFO - mozInstall == 1.12 09:08:18 INFO - mozcrash == 0.17 09:08:18 INFO - mozdebug == 0.1 09:08:18 INFO - mozdevice == 0.48 09:08:18 INFO - mozfile == 1.2 09:08:18 INFO - mozhttpd == 0.7 09:08:18 INFO - mozinfo == 0.9 09:08:18 INFO - mozleak == 0.1 09:08:18 INFO - mozlog == 3.3 09:08:18 INFO - moznetwork == 0.27 09:08:18 INFO - mozprocess == 0.23 09:08:18 INFO - mozprofile == 0.28 09:08:18 INFO - mozrunner == 6.12 09:08:18 INFO - mozscreenshot == 0.1 09:08:18 INFO - mozsystemmonitor == 0.3 09:08:18 INFO - moztest == 0.7 09:08:18 INFO - mozversion == 1.4 09:08:18 INFO - psutil == 3.1.1 09:08:18 INFO - requests == 1.2.3 09:08:18 INFO - wsgiref == 0.1.2 09:08:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:18 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 0x7fc9234f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705760>, '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 0x2706660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706af0>, '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': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', '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 09:08:18 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 09:08:18 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 09:08:18 INFO - Using env: {'DISPLAY': ':0', 09:08:18 INFO - 'HOME': '/home/cltbld', 09:08:18 INFO - 'LANG': 'en_US.UTF-8', 09:08:18 INFO - 'LANGUAGE': 'en_US:en', 09:08:18 INFO - 'LOGNAME': 'cltbld', 09:08:18 INFO - 'MAIL': '/var/mail/cltbld', 09:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:18 INFO - 'MOZ_NO_REMOTE': '1', 09:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:18 INFO - 'NO_EM_RESTART': '1', 09:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:18 INFO - 'PWD': '/builds/slave/test', 09:08:18 INFO - 'SHELL': '/bin/bash', 09:08:18 INFO - 'SHLVL': '1', 09:08:18 INFO - 'TERM': 'linux', 09:08:18 INFO - 'TMOUT': '86400', 09:08:18 INFO - 'USER': 'cltbld', 09:08:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', 09:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:18 INFO - '_': '/tools/buildbot/bin/python'} 09:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 INFO - Cleaning up... 09:08:18 INFO - Return code: 0 09:08:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9234f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705760>, '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 0x2706660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706af0>, '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': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', '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 09:08:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:08:18 INFO - Using env: {'DISPLAY': ':0', 09:08:18 INFO - 'HOME': '/home/cltbld', 09:08:18 INFO - 'LANG': 'en_US.UTF-8', 09:08:18 INFO - 'LANGUAGE': 'en_US:en', 09:08:18 INFO - 'LOGNAME': 'cltbld', 09:08:18 INFO - 'MAIL': '/var/mail/cltbld', 09:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:18 INFO - 'MOZ_NO_REMOTE': '1', 09:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:18 INFO - 'NO_EM_RESTART': '1', 09:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:18 INFO - 'PWD': '/builds/slave/test', 09:08:18 INFO - 'SHELL': '/bin/bash', 09:08:18 INFO - 'SHLVL': '1', 09:08:18 INFO - 'TERM': 'linux', 09:08:18 INFO - 'TMOUT': '86400', 09:08:18 INFO - 'USER': 'cltbld', 09:08:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', 09:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:18 INFO - '_': '/tools/buildbot/bin/python'} 09:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:08:18 INFO - Cleaning up... 09:08:18 INFO - Return code: 0 09:08:18 INFO - Running post-action listener: _resource_record_post_action 09:08:18 INFO - Running post-action listener: _start_resource_monitoring 09:08:18 INFO - Starting resource monitoring. 09:08:18 INFO - [mozharness: 2016-08-22 16:08:18.778627Z] Finished create-virtualenv step (success) 09:08:18 INFO - [mozharness: 2016-08-22 16:08:18.779147Z] Running install step. 09:08:18 INFO - Running pre-action listener: _resource_record_pre_action 09:08:18 INFO - Running main action method: install 09:08:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:08:18 INFO - Reading from file tmpfile_stdout 09:08:18 INFO - Detecting whether we're running mozinstall >=1.0... 09:08:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:08:19 INFO - Reading from file tmpfile_stdout 09:08:19 INFO - Output received: 09:08:19 INFO - Usage: mozinstall [options] installer 09:08:19 INFO - Options: 09:08:19 INFO - -h, --help show this help message and exit 09:08:19 INFO - -d DEST, --destination=DEST 09:08:19 INFO - Directory to install application into. [default: 09:08:19 INFO - "/builds/slave/test"] 09:08:19 INFO - --app=APP Application being installed. [default: firefox] 09:08:19 INFO - mkdir: /builds/slave/test/build/application 09:08:19 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'] 09:08:19 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 09:08:36 INFO - Reading from file tmpfile_stdout 09:08:36 INFO - Output received: 09:08:36 INFO - /builds/slave/test/build/application/firefox/firefox 09:08:36 INFO - Running post-action listener: _resource_record_post_action 09:08:36 INFO - [mozharness: 2016-08-22 16:08:36.075711Z] Finished install step (success) 09:08:36 INFO - [mozharness: 2016-08-22 16:08:36.075955Z] Running run-tests step. 09:08:36 INFO - Running pre-action listener: _resource_record_pre_action 09:08:36 INFO - Running main action method: run_tests 09:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:08:36 INFO - Python 2.7.3 09:08:36 INFO - Return code: 0 09:08:36 INFO - grabbing minidump binary from tooltool 09:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:36 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 0x2705760>, '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 0x2706660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:08:36 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 09:08:36 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 09:08:36 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 09:08:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:08:36 INFO - Return code: 0 09:08:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:08:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:08:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:08:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:08:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:08:36 INFO - Using env: {'DISPLAY': ':0', 09:08:36 INFO - 'HOME': '/home/cltbld', 09:08:36 INFO - 'LANG': 'en_US.UTF-8', 09:08:36 INFO - 'LANGUAGE': 'en_US:en', 09:08:36 INFO - 'LOGNAME': 'cltbld', 09:08:36 INFO - 'MAIL': '/var/mail/cltbld', 09:08:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:08:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:36 INFO - 'MOZ_NO_REMOTE': '1', 09:08:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:36 INFO - 'NO_EM_RESTART': '1', 09:08:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:36 INFO - 'PWD': '/builds/slave/test', 09:08:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:08:36 INFO - 'SHELL': '/bin/bash', 09:08:36 INFO - 'SHLVL': '1', 09:08:36 INFO - 'TERM': 'linux', 09:08:36 INFO - 'TMOUT': '86400', 09:08:36 INFO - 'USER': 'cltbld', 09:08:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737', 09:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:36 INFO - '_': '/tools/buildbot/bin/python'} 09:08:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:08:36 INFO - mozversion application_buildid: 20160822073008 09:08:36 INFO - mozversion application_changeset: 194fe275b4e60ded2af6b25173eec421f0dba8ad 09:08:36 INFO - mozversion application_display_name: Nightly 09:08:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:08:36 INFO - mozversion application_name: Firefox 09:08:36 INFO - mozversion application_remotingname: firefox 09:08:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:08:36 INFO - mozversion application_vendor: Mozilla 09:08:36 INFO - mozversion application_version: 51.0a1 09:08:36 INFO - mozversion platform_buildid: 20160822073008 09:08:36 INFO - mozversion platform_changeset: 194fe275b4e60ded2af6b25173eec421f0dba8ad 09:08:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:08:36 INFO - mozversion platform_version: 51.0a1 09:08:36 INFO - using testdate: 1471882116 09:08:36 INFO - actual date: 1471882116 09:08:36 INFO - starting webserver on 'localhost:35394' 09:08:36 INFO - SUITE-START | Running 2 tests 09:08:36 INFO - TEST-START | dromaeo_css 09:08:36 INFO - operating with platform_type : linux_ 09:08:36 INFO - Initialising browser for dromaeo_css test... 09:08:36 INFO - TEST-INFO | started process 22628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcsAyfP/profile http://localhost:35394/getInfo.html) 09:08:40 INFO - PROCESS | 22628 | __metrics Screen width/height:1600/1200 09:08:40 INFO - PROCESS | 22628 | colorDepth:24 09:08:40 INFO - PROCESS | 22628 | Browser inner width/height: 1024/697 09:08:40 INFO - PROCESS | 22628 | __metrics 09:08:40 INFO - PROCESS | 22628 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:08:40 INFO - PROCESS | 22628 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:08:41 INFO - PROCESS | 22628 | console.error: PushService: 09:08:41 INFO - PROCESS | 22628 | stateChangeProcessEnqueue: Error transitioning state 09:08:41 INFO - PROCESS | 22628 | UnknownError 09:08:42 INFO - TEST-INFO | 22628: exit 0 09:08:42 INFO - Browser initialized. 09:08:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:08:42 INFO - TEST-INFO | started process 22709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcsAyfP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:54 INFO - PROCESS | 22709 | RSS: Main: 174088192 09:08:54 INFO - PROCESS | 22709 | 09:09:46 INFO - PROCESS | 22709 | 1471882186107 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] 09:11:55 INFO - PROCESS | 22709 | Cycle 1(1): loaded http://localhost:35394/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35394/tests/dromaeo/cssquery-ext.html) 09:11:56 INFO - PROCESS | 22709 | RSS: Main: 285429760 09:11:56 INFO - PROCESS | 22709 | 09:14:59 INFO - PROCESS | 22709 | Cycle 1(1): loaded http://localhost:35394/tests/dromaeo/cssquery-ext.html (next: http://localhost:35394/tests/dromaeo/cssquery-jquery.html) 09:14:59 INFO - PROCESS | 22709 | RSS: Main: 278265856 09:14:59 INFO - PROCESS | 22709 | 09:18:01 INFO - PROCESS | 22709 | Cycle 1(1): loaded http://localhost:35394/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35394/tests/dromaeo/cssquery-mootools.html) 09:18:02 INFO - PROCESS | 22709 | RSS: Main: 244178944 09:18:02 INFO - PROCESS | 22709 | 09:21:04 INFO - PROCESS | 22709 | Cycle 1(1): loaded http://localhost:35394/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35394/tests/dromaeo/cssquery-prototype.html) 09:21:05 INFO - PROCESS | 22709 | RSS: Main: 215453696 09:21:05 INFO - PROCESS | 22709 | 09:24:08 INFO - PROCESS | 22709 | Cycle 1(1): loaded http://localhost:35394/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35394/tests/dromaeo/cssquery-yui.html) 09:24:08 INFO - PROCESS | 22709 | RSS: Main: 216109056 09:24:08 INFO - PROCESS | 22709 | 09:27:12 INFO - PROCESS | 22709 | Cycle 1(1): loaded http://localhost:35394/tests/dromaeo/cssquery-yui.html (next: http://localhost:35394/tests/dromaeo/cssquery-dojo.html) 09:27:12 INFO - PROCESS | 22709 | RSS: Main: 306360320 09:27:12 INFO - PROCESS | 22709 | 09:27:12 INFO - PROCESS | 22709 | __start_tp_report 09:27:12 INFO - PROCESS | 22709 | _x_x_mozilla_page_load 09:27:12 INFO - PROCESS | 22709 | _x_x_mozilla_page_load_details 09:27:12 INFO - PROCESS | 22709 | |i|pagename|runs| 09:27:12 INFO - PROCESS | 22709 | |0;dojo.html;3054.969450305497;3080.8921687740935;3091.1808370781746;3094.783365164438;3111.284404586945;5263.657862238962;5418.997485465186;5420;5512.4211957744465;5514.724263786809;5381.0852155133625;5437.13005919053;5470.452954704538;5562.694051827158;5565.026120428929;4815.374001379816;4885.169521181408;4947.109520286347;4959.132151873408;4974.751262436882;4967.056259310738;5010.148274793276;5011.348524691785;5019.4227663818765;5019.498050194988;4854.878628034292;4914.287428322909;4960.131976904027;4968.130577148984;5009.2486127080865;4938.1111399947995;4972.204447288416;4976.676516026447;4990.725510096943;5013.197888337885;4931.112399768041;4965;5000.7249601271915;5008.398992120969;5013.373328333958;5171.637985341028;5322.600804939606;5370.865728356784;5504.779808807683;5516.062269414209;5898.8230353089475;5907.6750778707155;5910.379410161957;5922;5923.555733320019;5959.374265702082;5961.254843144607;5967.522598192134;5977.1034344848185;5977.402259774031;5251.737413129328;5368.114261146945;5383.81156659515;5549.833504994856;5558.555315574785;5969.522438204933;5987.072003839412;6016.458518733335;6021.638701677914;6027;5775.942240577624;5788.421157884262;5790;5793.188953546507;5794.159846822187;5576.052071147915;5645.633033852787;5680.176374425685;5863.618864773776;5879.412058794172;5707.486326230659;5745.540356771448;5756.856078597984;5759.452851979056;5769.942300577024;5731.111677689964;5733.483986441241;5733.598648094593;5738.68437235956;5740.282464691913;4351.173277077345;4372.1692878353015;4409.140217657526;4432.335149727567;4436.201483732959;3951.3677811550015;3953.2686453005713;3956.802159891994;3957.841686332572;3992.500937382827;5468.28912241406;5477.3427188737605;5483.917741233885;5487.75305111271;5488.9725551372785;5659.377468478464;5714.685692286964;5735.77056917727;5791.971040144772;5809.2738407699035;5485.753141108659;5521.337439507204;5534.142207957773;5534.612577119563;5544.3346798384455;5067.087924173684;5074.416442109131;5087.287779710769;5088.338515992971;5089.618278629044;5768.336641286306;5866.472017518444;5886.470217680258;6019.097135429721;6048.092786082123;5791.160281759037;5804.506616937608;5807.186993820953;5807.738651760596;5809.651420914759;5983.401659833982;6012.398760124128;6025.6083354581815;6026.698665066641;6033.668148251888;5508.118701007819;5535.750891209825;5572.693501857437;5753.1945527627;5755.079187330007;5714.399988001366;5749.54003679713;5753;5771.797987070432;5772;5617.606767526234;5621.988042152452;5627.803026894039;5636.633618814764;5639.943600564106;5534.584906131976;5605.24329215567;5612.4387561245185;5622.578306626938;5623.775048997994;5736.541076713769;5750.654960702372;5759.539236861125;5760.337561180518;5765.827025189251;5751.252337196138;5787.826365209051;5796.159556864147;5815.592908496534;5818.069108942549;5501.532369748456;5510.311211098613;5529.253550770594;5698.971505142447;5702.885942281048 09:27:12 INFO - PROCESS | 22709 | |1;ext.html;568.604819650343;592.4312659846548;604.7429842317014;607.8541150123968;613.1416017575397;44159.55840441595;45399.77300113499;45439.77280113595;45485.09029819406;48445.515544844544;46751.76624116883;47217.29174062392;47308.290375644305;47313.52686473134;47438.76280618601;8021.759347219593;8872.245859101984;9034.418976679088;9036.231920286784;10572.418516981563;10509.316894401878;10958.397288149148;10963.83554246687;10965.83551246732;10968.341899486017;11033;11095.889041109567;11105.83341249882;11107.83338249927;11111.888881111166;8165.714200002972;10681.30571512857;10929.781404371948;11003.119750419946;11049.889501105006;10741.62404315853;10823.729406764814;10828.837567436494;10833.620823271227;10843.295185812896;43771.34342984858;44175.77912110451;44248;44285.114297714186;44368;3575.481555174485;3604.297162053401;3640.799756013418;3909.6872250219913;3956.624120708528;33380.499292510634;33805.49291760626;34113.71237458198;34729.13177170566;34839.65160348415;4217;4308.396824444549;4356.302991521341;4449.176902273058;4474.217012022883;345499;346749;348975;349799;350270;60581.39418605757;60975.695121524106;61033.694831526445;61039.389606103374;61071.38928610746;63333.366666332746;63768.68115659392;64078.67960660167;64400.35599643944;64413;16439.342426303054;16685.91657041707;16699.582510437336;16703;16705.081220532746;10821.891781082246;12303.200291980993;12343.13598048128;12668.36658167088;12677.809832852514;18298.176582053573;18396.540086497946;18565;18607.25570977173;18799.530011749543;6411.67941602918;6421.550491465646;6447.1618689571;6547.508936829757;6590.769323073765;1013.6502906497246;1023.3918128654864;1050.8003479338902;1092.1754075672816;1117.5027112934665;33686.326273474886;33737;33776.32447351088;33907.491387629205;34259.486107708406;1105.4693747001484;1143.2968724234536;1154.8152295632658;1177.7526719388852;1230.9569165079179;17524.82475175232;17564.38524651631;17697.734533982002;17720.55698607545;17765.111744412985;541659;546025;546138;546711;546728;61052.389476105556;61241.38758612357;61313.693431532556;61411.69294153501;61496.38503614996;1238.3684320996356;1330.1885849631717;1350.6218258887527;1360.4150215407271;1377.1530508737055;33111.83444082764;35448.113797155274;35455.64544354523;35462;35567;52407.21389179242;52698.736506317226;52859.471405287;53005;53032;369867;370365;370648;371803;373835;28704;29544.55683164711;29702.702972969993;31316.843415782776;44105.92781830131;49372.259416109504;50266;50578.747106264236;50667.23999140089;50897.23654145265;41676.79161604294;42385.5761442394;42996.57003430051;44663.330050049924;44901;42235.577644223165;42570;42595.3610695846;42662.14675706407;44223.55776442323;40919.79540102399;40996.38505422361;41148.38277425901;41863;43072.35391469068;34904.12739681528;37859.876685087205;38180.80909595434;38585.40704316319;39086.4137037939;29297.41405171927;29529.409411812074;29630.59248186486;29731.70268297376;29788 09:27:12 INFO - PROCESS | 22709 | |2;jquery.html;382.3633649972795;399.96800255979525;404.141199950106;404.7288316827725;426.8250017492829;13283.912747102933;19400.51498712533;19769.308074217406;19795.901020494894;19863.10616022279;13068.542601008967;13321.866781332184;13369.59891203263;13457.125286856372;13487.797683034762;4023.7988100595;5322.973385133078;5478.972605136969;5480.451954804507;5759.712014399284;5930.080837470199;5983.491403230709;6041.063635136539;6044.153818465418;6045.879082418349;5845.298564172284;5968.940310596882;6001.60989535681;6008.7296071676665;6046.697665116749;5965.254343207099;6001.399860014008;6030.065339872327;6034.668093254892;6035.849103772441;5621.297337832771;5843.298804143487;5843.8539036524;5847.502962248214;5849;15054.247287635684;15190;15221.771673424908;18435.170417331254;23750.762492375026;2284.1091974130104;2301.390131615123;2353.2469609724894;2511.660925775015;2716.9728302716917;10639.893601063968;10643.201759868041;10673.359598424042;10896.182786290981;11402.258853174517;1844.4651051195137;1871.3076161820077;1890.6765264315034;1921.1066853912857;1938.844892408604;80903;84721.99999999939;84765.57617211936;84843.15156848475;87272;11186.608468703556;11257.774844503228;11300.575723652693;11450.656480305604;11538.826917596243;16144.35422583107;16247.025178489328;16255.674886502204;16266.268017939221;16277.83722162787;7548.509346892544;7567.243275672388;7682.385409167253;7860.3318717909615;7863.685452581833;6903.1371078615175;6977.372036516738;6986.790396288119;7103.467239957024;7152.463565232524;4801.615870730333;4922.360093187863;4922.384701912261;4933.925991110136;5050.6464547482055;2039.479932617173;2062.9277975270793;2071.2084047299277;2086.634838903186;2099.5381016176416;904.2449554621965;978.5156347607838;984.2667212926273;1059.2585190366774;1082.7942690888706;19911.60176796456;20139.697904531444;20307;20592.27927022547;20933;977.310995747996;994.4480813148627;1035.3011717090933;1044.8955104489642;1045.2213101239472;10326.638567650247;11443.427828608703;11462.598809041643;11584.594539191088;11595.710107247218;473005;476394;483108;486106;486610;92463;93155;93760.53119734494;93803.53098234601;94281;973.2749101918974;975.6390135649855;982.6708052802392;984.7981163861391;992.6575331510618;16491.752623710894;17306.221220044878;17908.820911791237;17934.103294835466;18082.457526274233;43345.78327108344;43547.78226108976;43833.34249986317;43894.780526098446;45078.54921450744;57368.42631573631;58064.4193558059;58106.12840807476;58653.70673146607;59459.70270148622;8547.700830470903;8653.524056176971;8676.739697809076;8687.131286871263;8798.956005219932;12114.939425302817;12757.234565926074;12890.226586404846;13048.478060877458;13202;11469.483873225558;11679.649610511698;11701.76596468083;11768.70578235551;12125.75748485043;11133.665990020312;11545.826812597987;11561.075113990692;11699.42612625221;11904.345261010727;9536.904630953879;11447.656570302905;11721.648350549498;11817.172797904064;12086.335251561248;7805.102413222552;7811.257930496594;8096.878546821685;8515.40392172542;8601.82796344082;8919.955400222958;11010.50452729613;11414.201005929504;11424.371659558805;11840.703982400164 09:27:12 INFO - PROCESS | 22709 | |3;mootools.html;1337.3781191745836;1390.2701081931987;1458.4312118273874;1521.7108749337624;1728.5505768500186;8212.876806847902;8520.531370774605;8601.784955376119;8806.163414475615;8822.250108740765;8623.698170564032;8739.956300218506;8743.387962842604;8751.256143227818;8757;2353.835231533789;2370.288913326004;2380.47629521505;2382;2388.22382725614;2290.530441259546;2353.0587764894008;2353.7410884802657;2359.634256690207;2364.9054037838464;2304.72343318802;2328.860268383894;2329.895154718033;2339.0176126027022;2341.473168537074;2266.05958527211;2290.770922907721;2292.90828366866;2301.102569997702;2340.8361414700976;2253.954920901589;2258.6837842702034;2260.8869556522272;2266.897989590472;2270.0465804362207;8648;8662.393632445732;8711.128887111301;8771.605277762452;8846.823063538757;5291.603129765283;5428.972855135738;5443.727813609304;5444.237806707064;5468.589855760794;3404.42124838778;3417.4532074868152;3485.5817301923676;3488.180277634779;3503.316853213624;1108.3571528513444;1124.1175677093443;1143.7883991461606;1164.115272392979;1167.0546857045736;12403.193792403465;12433.62699119037;12442.937785311105;12544.372781360895;12556.372181390894;4432.091421258634;4538.52345503724;4665.04366604852;4700.811967521261;4718.174319494075;9780.55987480565;9789.706308810748;9857;9857.704268871945;9867.802643947225;5003.199488081889;5015.874603134878;5040.722760248222;5042.722650254272;5058.595312375001;4313.525512193656;4689;4694.741789201558;4854.466008739036;4878.829240976549;3774.377227757444;3792.2984247914223;3831.885043448701;3877.1470276539117;3917.764934103963;1136.1138312116561;1147.4951021550492;1157.1379322404862;1160.785254727878;1165.143619439711;989.2877128467492;996.9651062212788;1010.6513252927729;1012.731626119079;1028.1825948370913;6074.362191969868;6087.573869829158;6247.375262473807;6307.4954003679595;6491.67541622917;482.679018452732;488.14087206516785;495.17306098815067;499.557891266232;502.9673071250357;4146.150039241948;4377.299632058855;4418.138462999685;4461.643068554507;4491.775411229425;10909.509072091774;11287.49206285719;11361.14791390649;11371.260868043551;11393.829092563617;11006.559737610565;11089.39008354532;11286;11303.265287756434;11316.6039188628;8062.355011599058;8098.349894070962;8146.67413303473;8159.224873636995;8182.304504117098;6146.661933593517;6154.723037463415;6191.81424557264;6239.594426362272;6298.433141017331;10272.075513203847;10372.533236004247;10375.221858360805;10428.113610343205;10447.582096716047;10393.856675765508;10446.373217606968;10494.632687856194;10509.106725928075;10612.84080738805;6720.596764194164;7287.817804554928;7390.815229619303;7431.071116110486;7480.663370148465;8763.123687631441;8840.602172902107;8846.071162527842;8849.601767920587;8855.73432797017;7702.636840168332;7732.226777322223;7886;7918;8073.233042860918;7627.161012288755;7710.4217183710325;7782.221777822172;7811.4922530035365;7825.569593672175;6946.270641582763;7069.328413800681;7075.327843854826;7076.186238582629;7078.929210707827;5388.434214407431;5423;5534.335879694462;5563;5606.887862242814;5485.504095636396;5533.750981205775;5586.525145362527;5639.9566080273635;5697 09:27:12 INFO - PROCESS | 22709 | |4;prototype.html;337.2058801522415;340.13266171263285;341.3684683335828;350.9333226686931;351.1519679972864;5209.400918894324;5214.513863548885;5218.530332270095;5241.213817927312;5241.764120614572;5176.404713457953;5180.533751962323;5209.82778874753;5223.294855194547;5242.659227150232;4037.1723796621623;4097.201045796071;4129.690273229505;4140.358244472111;4143.896402589944;4138.379243113542;4145.834166633346;4163.396307535406;4166.541680415152;4186.529947331074;4107.116969851481;4115.1975364803875;4121.258173528764;4122.216778812031;4127.938080928789;3906.2968665640315;3984.402339649047;4096.3036283831525;4116.650084742771;4129.6283334499885;3657.926841463156;3670.743047986642;3672.2471893262086;3681.7238707097076;3687.3362794696945;5084.847454576368;5149.974250128763;5151.7074901668775;5153.56194723449;5166.61250406221;4518.909621807578;4560.179167749804;4742.241241401359;4749.4775574686755;4781.163296423147;5418.647787893774;5422.8915421691345;5425.674459532401;5432.592555558349;5447.673139611636;4028.436018957348;4046.534648515429;4055.71609987301;4057.1885622875247;4087.8364865405347;5402.8919421611745;5670.370962583949;5682.17608446777;5683.886322273532;5732.0255556555485;4024.3561030235023;4045.786264120752;4048.542524691109;4068.6948478864206;4071.572484889103;4135.545090040093;4142.171565686815;4145.689073319453;4149.149424367997;4155.522114956819;4456.888577785581;4641.95358046422;4690.202665546865;4730.668853180313;4732.95267047332;5463.732550991294;5466.278122391434;5467.781288748485;5486.259354987105;5513.476219759116;1420.7584710599224;1431.3272761801936;1437.7915202295608;1439.4098419647894;1442.7980082788417;879.846026945282;915.5605309451367;919.6664835987845;934.1172591900589;938.8263171313329;4624.583787459078;4682.789274482657;4700.388949436619;4715.646326525524;4717.603325605559;4919.958217339836;4955.975220123876;4965.8013679452415;5015.623828212899;5033.759976810285;4776.832810851603;4802.471728109905;4831.855044348676;4860.586850117709;4957.652964292537;2926.678065412803;2963.422132684149;2969.0944261999866;2971.15322133191;2987.865546050433;5732;5776;5779;5797.768089276466;5811.418858114239;5527.364353099445;5707.34365547959;5716;5737.282839645044;5763.838560539798;5765.84683063389;5767.307923049261;5775.682337471395;5779.508741756914;5807.332156801853;5392.272043274108;5588.6646801192055;5620.325560932714;5626.718664066699;5651.858703532444;5541.362743284412;5560.638558493685;5567.24842146305;5586.497215250647;5586.692731899784;5721.284839395075;5727.7422515986045;5747.821696552113;5771.567132465166;5792.797252096157;3931.76409415436;3980.7412518186225;4003.6596889263574;4005.8397664094277;4019.336809426529;5631.887362252814;5637.379888212376;5653.265075540318;5653.44530254167;5659.717014149193;5493.945060549343;5527.706002009121;5534.7786088556;5585.245991791218;5586.832395028156;5243.947560524499;5438.23864658956;5451.827857010761;5464.781408743765;5477.986572484103;5425.104857698436;5454.418218716686;5461.208124821958;5468.9179662304305;5472.50747432733;5257.710825904612;5362.946370536245;5388.515033646991;5389.919151212814;5502.0921547945745;4858.562729354234;5352.866178345573;5366.899785543876;5367.946320536745;5372.677639341652 09:27:12 INFO - PROCESS | 22709 | |5;yui.html;777.8599852026633;805.6737021506289;811.9269265766081;815.5840521334119;824.843279776842;13903;15098.698026039487;15118.773218401706;15127.697446051086;15204.239788010611;14241.78637320441;14345.42618295267;14435.42258309669;14448.494302699408;14448.5665430037;668.5286872754721;796.9721059762909;801.4710291207789;821.4619424277108;825.5253229393093;813.6379311206515;817.7301490508119;819.6680344460503;823.872299793533;824.5712229640583;871.0288028847821;878.6880657366606;879.7800549862534;880.9163129502687;881.1056777370974;701.0465766557478;846.327169899931;865.9567021648892;875.5972252763704;875.6147295190128;637.4836382530119;638.8083574927549;638.8498702804837;639.25526761323;639.3318981664172;14057.437702491889;14107.647308817259;14116.223607701573;14120.858791412056;14140.222287774168;14092.788608170886;14176.645583860383;14464.349104290332;14580.70838583233;14665.193414362206;13357.465701371933;13497;13571.253581053039;13975.79036314456;14420.423183072664;4443.888902777424;4543.5002149763495;4551.590356867898;4573.771311434415;4584.358189853423;83885;84262;84341;84421;85096;10749.62376316825;11047.889521104686;11061.008749664043;11634.88365116338;11951.521939122338;21515;21712;21724.131034758433;21724.674129888066;21776.346709598736;8004.199580041949;8049;8197.590120494071;8301.128381519853;8314.501129932223;4680.110778951988;4724.362211101526;4741.715497070187;4745.050989802054;4793.592544633675;3297.9835100824343;3406.1144102533026;3409.4203985322556;3804.31522325984;4009.69927255457;652.2548459953873;663.3068443476578;664.2792570061441;673.0879658063352;674.7065026713395;588.5174157191062;626.6208943589154;681.9693113809891;690.4200471603876;743.6281859070465;9776.315657903879;9968.252381071448;10336.431496267627;10671.25301228922;10729.988571314443;603.4508597176548;651.3356376495948;690.6098054599136;722.9011110891;724.5580196080386;4727.64542659302;4900.109333068255;4986.601071914238;5150.974245128826;5181.481851814864;127420;127514;127648;127805;129197;65338;67239;83746;84496.04263850859;85504;96505.51747241219;97489;98043.50978245206;100063.49968250112;102837;9135.588898499716;9697.127258546765;9702.70891873245;9760.951195243979;9943.801123977335;48350.5164948346;49068.75465622792;49385.50614493953;49916.50083499119;50051.499485004686;74535.62732186304;74550.62724686341;75349.62325188339;75513.62243188749;76623.61688191524;13355;13383;13393.464261429433;13661.795073073714;13750.931245343709;14786.852131478547;14900.090125528446;15322.218115341217;15652;15731.370745170523;14329.847433564599;14675.071199537933;14732.631684207981;15346.923265383602;15364.462243821412;13637.727245455233;13738.10702304347;14139.151650900978;14154.292285385896;14652.047616904867;13973.790393143907;14517.709645807236;14613.123212607277;15129.167895765839;15130;11547.249428787101;11715.589954351557;11749.494546090113;12040.879591203975;12092.455839487067;11106.61126860556;11852.348120853436;12184.20802647825;12396.752064958831;12437.689057773629 09:27:12 INFO - PROCESS | 22709 | __end_tp_report 09:27:12 INFO - PROCESS | 22709 | __start_cc_report 09:27:12 INFO - PROCESS | 22709 | _x_x_mozilla_cycle_collect,996 09:27:12 INFO - PROCESS | 22709 | __end_cc_report 09:27:12 INFO - PROCESS | 22709 | __startTimestamp1471883232317__endTimestamp 09:27:12 INFO - PROCESS | 22709 | 09:27:12 INFO - PROCESS | 22709 | ------- Summary: start ------- 09:27:12 INFO - PROCESS | 22709 | Number of tests: 6 09:27:12 INFO - PROCESS | 22709 | 09:27:12 INFO - PROCESS | 22709 | [#0] dojo.html Cycles:165 Average:5399.35 Median:5576.05 stddev:618.87 (11.1%) stddev-sans-first:592.81 09:27:12 INFO - PROCESS | 22709 | Values: 3055.0 3080.9 3091.2 3094.8 3111.3 5263.7 5419.0 5420.0 5512.4 5514.7 5381.1 5437.1 5470.5 5562.7 5565.0 4815.4 4885.2 4947.1 4959.1 4974.8 4967.1 5010.1 5011.3 5019.4 5019.5 4854.9 4914.3 4960.1 4968.1 5009.2 4938.1 4972.2 4976.7 4990.7 5013.2 4931.1 4965.0 5000.7 5008.4 5013.4 5171.6 5322.6 5370.9 5504.8 5516.1 5898.8 5907.7 5910.4 5922.0 5923.6 5959.4 5961.3 5967.5 5977.1 5977.4 5251.7 5368.1 5383.8 5549.8 5558.6 5969.5 5987.1 6016.5 6021.6 6027.0 5775.9 5788.4 5790.0 5793.2 5794.2 5576.1 5645.6 5680.2 5863.6 5879.4 5707.5 5745.5 5756.9 5759.5 5769.9 5731.1 5733.5 5733.6 5738.7 5740.3 4351.2 4372.2 4409.1 4432.3 4436.2 3951.4 3953.3 3956.8 3957.8 3992.5 5468.3 5477.3 5483.9 5487.8 5489.0 5659.4 5714.7 5735.8 5792.0 5809.3 5485.8 5521.3 5534.1 5534.6 5544.3 5067.1 5074.4 5087.3 5088.3 5089.6 5768.3 5866.5 5886.5 6019.1 6048.1 5791.2 5804.5 5807.2 5807.7 5809.7 5983.4 6012.4 6025.6 6026.7 6033.7 5508.1 5535.8 5572.7 5753.2 5755.1 5714.4 5749.5 5753.0 5771.8 5772.0 5617.6 5622.0 5627.8 5636.6 5639.9 5534.6 5605.2 5612.4 5622.6 5623.8 5736.5 5750.7 5759.5 5760.3 5765.8 5751.3 5787.8 5796.2 5815.6 5818.1 5501.5 5510.3 5529.3 5699.0 5702.9 09:27:12 INFO - PROCESS | 22709 | 09:27:12 INFO - PROCESS | 22709 | [#1] ext.html Cycles:180 Average:59955.22 Median:371225.50 stddev:113912.49 (30.7%) stddev-sans-first:114144.77 09:27:12 INFO - PROCESS | 22709 | Values: 568.6 592.4 604.7 607.9 613.1 44159.6 45399.8 45439.8 45485.1 48445.5 46751.8 47217.3 47308.3 47313.5 47438.8 8021.8 8872.2 9034.4 9036.2 10572.4 10509.3 10958.4 10963.8 10965.8 10968.3 11033.0 11095.9 11105.8 11107.8 11111.9 8165.7 10681.3 10929.8 11003.1 11049.9 10741.6 10823.7 10828.8 10833.6 10843.3 43771.3 44175.8 44248.0 44285.1 44368.0 3575.5 3604.3 3640.8 3909.7 3956.6 33380.5 33805.5 34113.7 34729.1 34839.7 4217.0 4308.4 4356.3 4449.2 4474.2 345499.0 346749.0 348975.0 349799.0 350270.0 60581.4 60975.7 61033.7 61039.4 61071.4 63333.4 63768.7 64078.7 64400.4 64413.0 16439.3 16685.9 16699.6 16703.0 16705.1 10821.9 12303.2 12343.1 12668.4 12677.8 18298.2 18396.5 18565.0 18607.3 18799.5 6411.7 6421.6 6447.2 6547.5 6590.8 1013.7 1023.4 1050.8 1092.2 1117.5 33686.3 33737.0 33776.3 33907.5 34259.5 1105.5 1143.3 1154.8 1177.8 1231.0 17524.8 17564.4 17697.7 17720.6 17765.1 541659.0 546025.0 546138.0 546711.0 546728.0 61052.4 61241.4 61313.7 61411.7 61496.4 1238.4 1330.2 1350.6 1360.4 1377.2 33111.8 35448.1 35455.6 35462.0 35567.0 52407.2 52698.7 52859.5 53005.0 53032.0 369867.0 370365.0 370648.0 371803.0 373835.0 28704.0 29544.6 29702.7 31316.8 44105.9 49372.3 50266.0 50578.7 50667.2 50897.2 41676.8 42385.6 42996.6 44663.3 44901.0 42235.6 42570.0 42595.4 42662.1 44223.6 40919.8 40996.4 41148.4 41863.0 43072.4 34904.1 37859.9 38180.8 38585.4 39086.4 29297.4 29529.4 29630.6 29731.7 29788.0 09:27:12 INFO - PROCESS | 22709 | 09:27:12 INFO - PROCESS | 22709 | [#2] jquery.html Cycles:180 Average:28664.38 Median:2213.97 stddev:79528.03 (3592.1%) stddev-sans-first:79722.77 09:27:12 INFO - PROCESS | 22709 | Values: 382.4 400.0 404.1 404.7 426.8 13283.9 19400.5 19769.3 19795.9 19863.1 13068.5 13321.9 13369.6 13457.1 13487.8 4023.8 5323.0 5479.0 5480.5 5759.7 5930.1 5983.5 6041.1 6044.2 6045.9 5845.3 5968.9 6001.6 6008.7 6046.7 5965.3 6001.4 6030.1 6034.7 6035.8 5621.3 5843.3 5843.9 5847.5 5849.0 15054.2 15190.0 15221.8 18435.2 23750.8 2284.1 2301.4 2353.2 2511.7 2717.0 10639.9 10643.2 10673.4 10896.2 11402.3 1844.5 1871.3 1890.7 1921.1 1938.8 80903.0 84722.0 84765.6 84843.2 87272.0 11186.6 11257.8 11300.6 11450.7 11538.8 16144.4 16247.0 16255.7 16266.3 16277.8 7548.5 7567.2 7682.4 7860.3 7863.7 6903.1 6977.4 6986.8 7103.5 7152.5 4801.6 4922.4 4922.4 4933.9 5050.6 2039.5 2062.9 2071.2 2086.6 2099.5 904.2 978.5 984.3 1059.3 1082.8 19911.6 20139.7 20307.0 20592.3 20933.0 977.3 994.4 1035.3 1044.9 1045.2 10326.6 11443.4 11462.6 11584.6 11595.7 473005.0 476394.0 483108.0 486106.0 486610.0 92463.0 93155.0 93760.5 93803.5 94281.0 973.3 975.6 982.7 984.8 992.7 16491.8 17306.2 17908.8 17934.1 18082.5 43345.8 43547.8 43833.3 43894.8 45078.5 57368.4 58064.4 58106.1 58653.7 59459.7 8547.7 8653.5 8676.7 8687.1 8799.0 12114.9 12757.2 12890.2 13048.5 13202.0 11469.5 11679.6 11701.8 11768.7 12125.8 11133.7 11545.8 11561.1 11699.4 11904.3 9536.9 11447.7 11721.6 11817.2 12086.3 7805.1 7811.3 8096.9 8515.4 8601.8 8920.0 11010.5 11414.2 11424.4 11840.7 09:27:12 INFO - PROCESS | 22709 | 09:27:12 INFO - PROCESS | 22709 | [#3] mootools.html Cycles:180 Average:5845.16 Median:2600.43 stddev:3355.75 (129.0%) stddev-sans-first:3348.07 09:27:12 INFO - PROCESS | 22709 | Values: 1337.4 1390.3 1458.4 1521.7 1728.6 8212.9 8520.5 8601.8 8806.2 8822.3 8623.7 8740.0 8743.4 8751.3 8757.0 2353.8 2370.3 2380.5 2382.0 2388.2 2290.5 2353.1 2353.7 2359.6 2364.9 2304.7 2328.9 2329.9 2339.0 2341.5 2266.1 2290.8 2292.9 2301.1 2340.8 2254.0 2258.7 2260.9 2266.9 2270.0 8648.0 8662.4 8711.1 8771.6 8846.8 5291.6 5429.0 5443.7 5444.2 5468.6 3404.4 3417.5 3485.6 3488.2 3503.3 1108.4 1124.1 1143.8 1164.1 1167.1 12403.2 12433.6 12442.9 12544.4 12556.4 4432.1 4538.5 4665.0 4700.8 4718.2 9780.6 9789.7 9857.0 9857.7 9867.8 5003.2 5015.9 5040.7 5042.7 5058.6 4313.5 4689.0 4694.7 4854.5 4878.8 3774.4 3792.3 3831.9 3877.1 3917.8 1136.1 1147.5 1157.1 1160.8 1165.1 989.3 997.0 1010.7 1012.7 1028.2 6074.4 6087.6 6247.4 6307.5 6491.7 482.7 488.1 495.2 499.6 503.0 4146.2 4377.3 4418.1 4461.6 4491.8 10909.5 11287.5 11361.1 11371.3 11393.8 11006.6 11089.4 11286.0 11303.3 11316.6 8062.4 8098.3 8146.7 8159.2 8182.3 6146.7 6154.7 6191.8 6239.6 6298.4 10272.1 10372.5 10375.2 10428.1 10447.6 10393.9 10446.4 10494.6 10509.1 10612.8 6720.6 7287.8 7390.8 7431.1 7480.7 8763.1 8840.6 8846.1 8849.6 8855.7 7702.6 7732.2 7886.0 7918.0 8073.2 7627.2 7710.4 7782.2 7811.5 7825.6 6946.3 7069.3 7075.3 7076.2 7078.9 5388.4 5423.0 5534.3 5563.0 5606.9 5485.5 5533.8 5586.5 5640.0 5697.0 09:27:12 INFO - PROCESS | 22709 | 09:27:12 INFO - PROCESS | 22709 | [#4] prototype.html Cycles:180 Average:4578.15 Median:5171.51 stddev:1325.73 (25.6%) stddev-sans-first:1290.67 09:27:12 INFO - PROCESS | 22709 | Values: 337.2 340.1 341.4 350.9 351.2 5209.4 5214.5 5218.5 5241.2 5241.8 5176.4 5180.5 5209.8 5223.3 5242.7 4037.2 4097.2 4129.7 4140.4 4143.9 4138.4 4145.8 4163.4 4166.5 4186.5 4107.1 4115.2 4121.3 4122.2 4127.9 3906.3 3984.4 4096.3 4116.7 4129.6 3657.9 3670.7 3672.2 3681.7 3687.3 5084.8 5150.0 5151.7 5153.6 5166.6 4518.9 4560.2 4742.2 4749.5 4781.2 5418.6 5422.9 5425.7 5432.6 5447.7 4028.4 4046.5 4055.7 4057.2 4087.8 5402.9 5670.4 5682.2 5683.9 5732.0 4024.4 4045.8 4048.5 4068.7 4071.6 4135.5 4142.2 4145.7 4149.1 4155.5 4456.9 4642.0 4690.2 4730.7 4733.0 5463.7 5466.3 5467.8 5486.3 5513.5 1420.8 1431.3 1437.8 1439.4 1442.8 879.8 915.6 919.7 934.1 938.8 4624.6 4682.8 4700.4 4715.6 4717.6 4920.0 4956.0 4965.8 5015.6 5033.8 4776.8 4802.5 4831.9 4860.6 4957.7 2926.7 2963.4 2969.1 2971.2 2987.9 5732.0 5776.0 5779.0 5797.8 5811.4 5527.4 5707.3 5716.0 5737.3 5763.8 5765.8 5767.3 5775.7 5779.5 5807.3 5392.3 5588.7 5620.3 5626.7 5651.9 5541.4 5560.6 5567.2 5586.5 5586.7 5721.3 5727.7 5747.8 5771.6 5792.8 3931.8 3980.7 4003.7 4005.8 4019.3 5631.9 5637.4 5653.3 5653.4 5659.7 5493.9 5527.7 5534.8 5585.2 5586.8 5243.9 5438.2 5451.8 5464.8 5478.0 5425.1 5454.4 5461.2 5468.9 5472.5 5257.7 5362.9 5388.5 5389.9 5502.1 4858.6 5352.9 5366.9 5367.9 5372.7 09:27:12 INFO - PROCESS | 22709 | 09:27:12 INFO - PROCESS | 22709 | [#5] yui.html Cycles:180 Average:21298.33 Median:4702.24 stddev:31012.13 (659.5%) stddev-sans-first:31060.85 09:27:12 INFO - PROCESS | 22709 | Values: 777.9 805.7 811.9 815.6 824.8 13903.0 15098.7 15118.8 15127.7 15204.2 14241.8 14345.4 14435.4 14448.5 14448.6 668.5 797.0 801.5 821.5 825.5 813.6 817.7 819.7 823.9 824.6 871.0 878.7 879.8 880.9 881.1 701.0 846.3 866.0 875.6 875.6 637.5 638.8 638.8 639.3 639.3 14057.4 14107.6 14116.2 14120.9 14140.2 14092.8 14176.6 14464.3 14580.7 14665.2 13357.5 13497.0 13571.3 13975.8 14420.4 4443.9 4543.5 4551.6 4573.8 4584.4 83885.0 84262.0 84341.0 84421.0 85096.0 10749.6 11047.9 11061.0 11634.9 11951.5 21515.0 21712.0 21724.1 21724.7 21776.3 8004.2 8049.0 8197.6 8301.1 8314.5 4680.1 4724.4 4741.7 4745.1 4793.6 3298.0 3406.1 3409.4 3804.3 4009.7 652.3 663.3 664.3 673.1 674.7 588.5 626.6 682.0 690.4 743.6 9776.3 9968.3 10336.4 10671.3 10730.0 603.5 651.3 690.6 722.9 724.6 4727.6 4900.1 4986.6 5151.0 5181.5 127420.0 127514.0 127648.0 127805.0 129197.0 65338.0 67239.0 83746.0 84496.0 85504.0 96505.5 97489.0 98043.5 100063.5 102837.0 9135.6 9697.1 9702.7 9761.0 9943.8 48350.5 49068.8 49385.5 49916.5 50051.5 74535.6 74550.6 75349.6 75513.6 76623.6 13355.0 13383.0 13393.5 13661.8 13750.9 14786.9 14900.1 15322.2 15652.0 15731.4 14329.8 14675.1 14732.6 15346.9 15364.5 13637.7 13738.1 14139.2 14154.3 14652.0 13973.8 14517.7 14613.1 15129.2 15130.0 11547.2 11715.6 11749.5 12040.9 12092.5 11106.6 11852.3 12184.2 12396.8 12437.7 09:27:12 INFO - PROCESS | 22709 | -------- Summary: end -------- 09:27:12 INFO - PROCESS | 22709 | 09:27:13 INFO - TEST-INFO | 22709: exit 0 09:27:13 INFO - TEST-OK | dromaeo_css | took 1116977ms 09:27:13 INFO - TEST-START | kraken 09:27:13 INFO - operating with platform_type : linux_ 09:27:13 INFO - Initialising browser for kraken test... 09:27:13 INFO - TEST-INFO | started process 23022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVWfBvo/profile http://localhost:35394/getInfo.html) 09:27:17 INFO - PROCESS | 23022 | __metrics Screen width/height:1600/1200 09:27:17 INFO - PROCESS | 23022 | colorDepth:24 09:27:17 INFO - PROCESS | 23022 | Browser inner width/height: 1024/697 09:27:17 INFO - PROCESS | 23022 | __metrics 09:27:17 INFO - PROCESS | 23022 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:27:17 INFO - PROCESS | 23022 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:27:18 INFO - PROCESS | 23022 | console.error: PushService: 09:27:18 INFO - PROCESS | 23022 | stateChangeProcessEnqueue: Error transitioning state 09:27:18 INFO - PROCESS | 23022 | UnknownError 09:27:19 INFO - TEST-INFO | 23022: exit 0 09:27:19 INFO - Browser initialized. 09:27:19 INFO - Running cycle 1/1 for kraken test... 09:27:19 INFO - TEST-INFO | started process 23101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVWfBvo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:27:31 INFO - PROCESS | 23101 | RSS: Main: 173690880 09:27:31 INFO - PROCESS | 23101 | 09:27:33 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35394/tests/kraken/driver.html?testName=audio-beat-detection) 09:27:34 INFO - PROCESS | 23101 | RSS: Main: 243032064 09:27:34 INFO - PROCESS | 23101 | 09:27:37 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35394/tests/kraken/driver.html?testName=audio-dft) 09:27:37 INFO - PROCESS | 23101 | RSS: Main: 224366592 09:27:37 INFO - PROCESS | 23101 | 09:27:40 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35394/tests/kraken/driver.html?testName=audio-fft) 09:27:41 INFO - PROCESS | 23101 | RSS: Main: 302366720 09:27:41 INFO - PROCESS | 23101 | 09:27:43 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35394/tests/kraken/driver.html?testName=audio-oscillator) 09:27:44 INFO - PROCESS | 23101 | RSS: Main: 209096704 09:27:44 INFO - PROCESS | 23101 | 09:27:46 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35394/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:27:46 INFO - PROCESS | 23101 | RSS: Main: 213467136 09:27:46 INFO - PROCESS | 23101 | 09:27:50 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35394/tests/kraken/driver.html?testName=imaging-darkroom) 09:27:50 INFO - PROCESS | 23101 | RSS: Main: 249741312 09:27:50 INFO - PROCESS | 23101 | 09:27:54 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35394/tests/kraken/driver.html?testName=imaging-desaturate) 09:27:54 INFO - PROCESS | 23101 | RSS: Main: 247975936 09:27:54 INFO - PROCESS | 23101 | 09:27:57 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35394/tests/kraken/driver.html?testName=json-parse-financial) 09:27:58 INFO - PROCESS | 23101 | RSS: Main: 248438784 09:27:58 INFO - PROCESS | 23101 | 09:27:59 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35394/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:28:00 INFO - PROCESS | 23101 | RSS: Main: 210984960 09:28:00 INFO - PROCESS | 23101 | 09:28:02 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35394/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:28:02 INFO - PROCESS | 23101 | RSS: Main: 217112576 09:28:02 INFO - PROCESS | 23101 | 09:28:04 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35394/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:28:05 INFO - PROCESS | 23101 | RSS: Main: 223526912 09:28:05 INFO - PROCESS | 23101 | 09:28:08 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35394/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:28:08 INFO - PROCESS | 23101 | RSS: Main: 217874432 09:28:08 INFO - PROCESS | 23101 | 09:28:11 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35394/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:28:12 INFO - PROCESS | 23101 | RSS: Main: 221138944 09:28:12 INFO - PROCESS | 23101 | 09:28:13 INFO - PROCESS | 23101 | Cycle 1(1): loaded http://localhost:35394/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35394/tests/kraken/driver.html?testName=ai-astar) 09:28:14 INFO - PROCESS | 23101 | RSS: Main: 272142336 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | __start_tp_report 09:28:14 INFO - PROCESS | 23101 | _x_x_mozilla_page_load 09:28:14 INFO - PROCESS | 23101 | _x_x_mozilla_page_load_details 09:28:14 INFO - PROCESS | 23101 | |i|pagename|runs| 09:28:14 INFO - PROCESS | 23101 | |0;ai-astar;100;111;108;110;110;112;117;112;111;110 09:28:14 INFO - PROCESS | 23101 | |1;audio-beat-detection;149;125;152;173;123;141;149;124;180;117 09:28:14 INFO - PROCESS | 23101 | |2;audio-dft;161;163;160;160;162;162;162;160;159;161 09:28:14 INFO - PROCESS | 23101 | |3;audio-fft;75;75;76;177;77;76;75;76;162;75 09:28:14 INFO - PROCESS | 23101 | |4;audio-oscillator;86;84;143;86;86;86;146;85;85;145 09:28:14 INFO - PROCESS | 23101 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;118;118;117 09:28:14 INFO - PROCESS | 23101 | |6;imaging-darkroom;146;146;146;146;145;146;146;146;146;146 09:28:14 INFO - PROCESS | 23101 | |7;imaging-desaturate;96;96;95;96;95;95;96;95;96;94 09:28:14 INFO - PROCESS | 23101 | |8;json-parse-financial;56;54;58;52;55;58;53;55;54;51 09:28:14 INFO - PROCESS | 23101 | |9;json-stringify-tinderbox;63;63;62;63;64;63;63;62;62;62 09:28:14 INFO - PROCESS | 23101 | |10;stanford-crypto-aes;80;79;88;82;87;81;85;79;79;80 09:28:14 INFO - PROCESS | 23101 | |11;stanford-crypto-ccm;127;125;140;132;124;123;126;124;143;126 09:28:14 INFO - PROCESS | 23101 | |12;stanford-crypto-pbkdf2;164;168;172;166;165;166;164;166;171;165 09:28:14 INFO - PROCESS | 23101 | |13;stanford-crypto-sha256-iterative;66;66;67;67;65;66;68;64;65;65 09:28:14 INFO - PROCESS | 23101 | __end_tp_report 09:28:14 INFO - PROCESS | 23101 | __start_cc_report 09:28:14 INFO - PROCESS | 23101 | _x_x_mozilla_cycle_collect,1697 09:28:14 INFO - PROCESS | 23101 | __end_cc_report 09:28:14 INFO - PROCESS | 23101 | __startTimestamp1471883294151__endTimestamp 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | ------- Summary: start ------- 09:28:14 INFO - PROCESS | 23101 | Number of tests: 14 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:4.25 (3.8%) stddev-sans-first:2.49 09:28:14 INFO - PROCESS | 23101 | Values: 100.0 111.0 108.0 110.0 110.0 112.0 117.0 112.0 111.0 110.0 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:149.00 stddev:21.57 (14.5%) stddev-sans-first:22.78 09:28:14 INFO - PROCESS | 23101 | Values: 149.0 125.0 152.0 173.0 123.0 141.0 149.0 124.0 180.0 117.0 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 09:28:14 INFO - PROCESS | 23101 | Values: 161.0 163.0 160.0 160.0 162.0 162.0 162.0 160.0 159.0 161.0 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#3] audio-fft Cycles:10 Average:94.40 Median:75.50 stddev:39.74 (52.6%) stddev-sans-first:41.53 09:28:14 INFO - PROCESS | 23101 | Values: 75.0 75.0 76.0 177.0 77.0 76.0 75.0 76.0 162.0 75.0 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:85.50 stddev:28.63 (33.5%) stddev-sans-first:29.68 09:28:14 INFO - PROCESS | 23101 | Values: 86.0 84.0 143.0 86.0 86.0 86.0 146.0 85.0 85.0 145.0 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:28:14 INFO - PROCESS | 23101 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 118.0 117.0 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 09:28:14 INFO - PROCESS | 23101 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 09:28:14 INFO - PROCESS | 23101 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 94.0 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:2.32 (4.2%) stddev-sans-first:2.40 09:28:14 INFO - PROCESS | 23101 | Values: 56.0 54.0 58.0 52.0 55.0 58.0 53.0 55.0 54.0 51.0 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 09:28:14 INFO - PROCESS | 23101 | Values: 63.0 63.0 62.0 63.0 64.0 63.0 63.0 62.0 62.0 62.0 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:3.43 (4.2%) stddev-sans-first:3.56 09:28:14 INFO - PROCESS | 23101 | Values: 80.0 79.0 88.0 82.0 87.0 81.0 85.0 79.0 79.0 80.0 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:126.50 stddev:7.07 (5.6%) stddev-sans-first:7.46 09:28:14 INFO - PROCESS | 23101 | Values: 127.0 125.0 140.0 132.0 124.0 123.0 126.0 124.0 143.0 126.0 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:166.00 stddev:2.79 (1.7%) stddev-sans-first:2.78 09:28:14 INFO - PROCESS | 23101 | Values: 164.0 168.0 172.0 166.0 165.0 166.0 164.0 166.0 171.0 165.0 09:28:14 INFO - PROCESS | 23101 | 09:28:14 INFO - PROCESS | 23101 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 09:28:14 INFO - PROCESS | 23101 | Values: 66.0 66.0 67.0 67.0 65.0 66.0 68.0 64.0 65.0 65.0 09:28:14 INFO - PROCESS | 23101 | -------- Summary: end -------- 09:28:14 INFO - PROCESS | 23101 | 09:28:15 INFO - TEST-INFO | 23101: exit 0 09:28:15 INFO - TEST-OK | kraken | took 61992ms 09:28:15 INFO - SUITE-END | took 1178s 09:28:15 INFO - Completed test suite (00:19:39) 09:28:15 INFO - javascript benchmark 09:28:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3054.969450305497, 3080.8921687740935, 3091.1808370781746, 3094.783365164438, 3111.284404586945, 5263.657862238962, 5418.997485465186, 5420.0, 5512.4211957744465, 5514.724263786809, 5381.0852155133625, 5437.13005919053, 5470.452954704538, 5562.694051827158, 5565.026120428929, 4815.374001379816, 4885.169521181408, 4947.109520286347, 4959.132151873408, 4974.751262436882, 4967.056259310738, 5010.148274793276, 5011.348524691785, 5019.4227663818765, 5019.498050194988, 4854.878628034292, 4914.287428322909, 4960.131976904027, 4968.130577148984, 5009.2486127080865, 4938.1111399947995, 4972.204447288416, 4976.676516026447, 4990.725510096943, 5013.197888337885, 4931.112399768041, 4965.0, 5000.7249601271915, 5008.398992120969, 5013.373328333958, 5171.637985341028, 5322.600804939606, 5370.865728356784, 5504.779808807683, 5516.062269414209, 5898.8230353089475, 5907.6750778707155, 5910.379410161957, 5922.0, 5923.555733320019, 5959.374265702082, 5961.254843144607, 5967.522598192134, 5977.1034344848185, 5977.402259774031, 5251.737413129328, 5368.114261146945, 5383.81156659515, 5549.833504994856, 5558.555315574785, 5969.522438204933, 5987.072003839412, 6016.458518733335, 6021.638701677914, 6027.0, 5775.942240577624, 5788.421157884262, 5790.0, 5793.188953546507, 5794.159846822187, 5576.052071147915, 5645.633033852787, 5680.176374425685, 5863.618864773776, 5879.412058794172, 5707.486326230659, 5745.540356771448, 5756.856078597984, 5759.452851979056, 5769.942300577024, 5731.111677689964, 5733.483986441241, 5733.598648094593, 5738.68437235956, 5740.282464691913, 4351.173277077345, 4372.1692878353015, 4409.140217657526, 4432.335149727567, 4436.201483732959, 3951.3677811550015, 3953.2686453005713, 3956.802159891994, 3957.841686332572, 3992.500937382827, 5468.28912241406, 5477.3427188737605, 5483.917741233885, 5487.75305111271, 5488.9725551372785, 5659.377468478464, 5714.685692286964, 5735.77056917727, 5791.971040144772, 5809.2738407699035, 5485.753141108659, 5521.337439507204, 5534.142207957773, 5534.612577119563, 5544.3346798384455, 5067.087924173684, 5074.416442109131, 5087.287779710769, 5088.338515992971, 5089.618278629044, 5768.336641286306, 5866.472017518444, 5886.470217680258, 6019.097135429721, 6048.092786082123, 5791.160281759037, 5804.506616937608, 5807.186993820953, 5807.738651760596, 5809.651420914759, 5983.401659833982, 6012.398760124128, 6025.6083354581815, 6026.698665066641, 6033.668148251888, 5508.118701007819, 5535.750891209825, 5572.693501857437, 5753.1945527627, 5755.079187330007, 5714.399988001366, 5749.54003679713, 5753.0, 5771.797987070432, 5772.0, 5617.606767526234, 5621.988042152452, 5627.803026894039, 5636.633618814764, 5639.943600564106, 5534.584906131976, 5605.24329215567, 5612.4387561245185, 5622.578306626938, 5623.775048997994, 5736.541076713769, 5750.654960702372, 5759.539236861125, 5760.337561180518, 5765.827025189251, 5751.252337196138, 5787.826365209051, 5796.159556864147, 5815.592908496534, 5818.069108942549, 5501.532369748456, 5510.311211098613, 5529.253550770594, 5698.971505142447, 5702.885942281048], "value": 5356.764526257771, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.604819650343, 592.4312659846548, 604.7429842317014, 607.8541150123968, 613.1416017575397, 44159.55840441595, 45399.77300113499, 45439.77280113595, 45485.09029819406, 48445.515544844544, 46751.76624116883, 47217.29174062392, 47308.290375644305, 47313.52686473134, 47438.76280618601, 8021.759347219593, 8872.245859101984, 9034.418976679088, 9036.231920286784, 10572.418516981563, 10509.316894401878, 10958.397288149148, 10963.83554246687, 10965.83551246732, 10968.341899486017, 11033.0, 11095.889041109567, 11105.83341249882, 11107.83338249927, 11111.888881111166, 8165.714200002972, 10681.30571512857, 10929.781404371948, 11003.119750419946, 11049.889501105006, 10741.62404315853, 10823.729406764814, 10828.837567436494, 10833.620823271227, 10843.295185812896, 43771.34342984858, 44175.77912110451, 44248.0, 44285.114297714186, 44368.0, 3575.481555174485, 3604.297162053401, 3640.799756013418, 3909.6872250219913, 3956.624120708528, 33380.499292510634, 33805.49291760626, 34113.71237458198, 34729.13177170566, 34839.65160348415, 4217.0, 4308.396824444549, 4356.302991521341, 4449.176902273058, 4474.217012022883, 345499.0, 346749.0, 348975.0, 349799.0, 350270.0, 60581.39418605757, 60975.695121524106, 61033.694831526445, 61039.389606103374, 61071.38928610746, 63333.366666332746, 63768.68115659392, 64078.67960660167, 64400.35599643944, 64413.0, 16439.342426303054, 16685.91657041707, 16699.582510437336, 16703.0, 16705.081220532746, 10821.891781082246, 12303.200291980993, 12343.13598048128, 12668.36658167088, 12677.809832852514, 18298.176582053573, 18396.540086497946, 18565.0, 18607.25570977173, 18799.530011749543, 6411.67941602918, 6421.550491465646, 6447.1618689571, 6547.508936829757, 6590.769323073765, 1013.6502906497246, 1023.3918128654864, 1050.8003479338902, 1092.1754075672816, 1117.5027112934665, 33686.326273474886, 33737.0, 33776.32447351088, 33907.491387629205, 34259.486107708406, 1105.4693747001484, 1143.2968724234536, 1154.8152295632658, 1177.7526719388852, 1230.9569165079179, 17524.82475175232, 17564.38524651631, 17697.734533982002, 17720.55698607545, 17765.111744412985, 541659.0, 546025.0, 546138.0, 546711.0, 546728.0, 61052.389476105556, 61241.38758612357, 61313.693431532556, 61411.69294153501, 61496.38503614996, 1238.3684320996356, 1330.1885849631717, 1350.6218258887527, 1360.4150215407271, 1377.1530508737055, 33111.83444082764, 35448.113797155274, 35455.64544354523, 35462.0, 35567.0, 52407.21389179242, 52698.736506317226, 52859.471405287, 53005.0, 53032.0, 369867.0, 370365.0, 370648.0, 371803.0, 373835.0, 28704.0, 29544.55683164711, 29702.702972969993, 31316.843415782776, 44105.92781830131, 49372.259416109504, 50266.0, 50578.747106264236, 50667.23999140089, 50897.23654145265, 41676.79161604294, 42385.5761442394, 42996.57003430051, 44663.330050049924, 44901.0, 42235.577644223165, 42570.0, 42595.3610695846, 42662.14675706407, 44223.55776442323, 40919.79540102399, 40996.38505422361, 41148.38277425901, 41863.0, 43072.35391469068, 34904.12739681528, 37859.876685087205, 38180.80909595434, 38585.40704316319, 39086.4137037939, 29297.41405171927, 29529.409411812074, 29630.59248186486, 29731.70268297376, 29788.0], "value": 21023.6172363979, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.3633649972795, 399.96800255979525, 404.141199950106, 404.7288316827725, 426.8250017492829, 13283.912747102933, 19400.51498712533, 19769.308074217406, 19795.901020494894, 19863.10616022279, 13068.542601008967, 13321.866781332184, 13369.59891203263, 13457.125286856372, 13487.797683034762, 4023.7988100595, 5322.973385133078, 5478.972605136969, 5480.451954804507, 5759.712014399284, 5930.080837470199, 5983.491403230709, 6041.063635136539, 6044.153818465418, 6045.879082418349, 5845.298564172284, 5968.940310596882, 6001.60989535681, 6008.7296071676665, 6046.697665116749, 5965.254343207099, 6001.399860014008, 6030.065339872327, 6034.668093254892, 6035.849103772441, 5621.297337832771, 5843.298804143487, 5843.8539036524, 5847.502962248214, 5849.0, 15054.247287635684, 15190.0, 15221.771673424908, 18435.170417331254, 23750.762492375026, 2284.1091974130104, 2301.390131615123, 2353.2469609724894, 2511.660925775015, 2716.9728302716917, 10639.893601063968, 10643.201759868041, 10673.359598424042, 10896.182786290981, 11402.258853174517, 1844.4651051195137, 1871.3076161820077, 1890.6765264315034, 1921.1066853912857, 1938.844892408604, 80903.0, 84721.99999999939, 84765.57617211936, 84843.15156848475, 87272.0, 11186.608468703556, 11257.774844503228, 11300.575723652693, 11450.656480305604, 11538.826917596243, 16144.35422583107, 16247.025178489328, 16255.674886502204, 16266.268017939221, 16277.83722162787, 7548.509346892544, 7567.243275672388, 7682.385409167253, 7860.3318717909615, 7863.685452581833, 6903.1371078615175, 6977.372036516738, 6986.790396288119, 7103.467239957024, 7152.463565232524, 4801.615870730333, 4922.360093187863, 4922.384701912261, 4933.925991110136, 5050.6464547482055, 2039.479932617173, 2062.9277975270793, 2071.2084047299277, 2086.634838903186, 2099.5381016176416, 904.2449554621965, 978.5156347607838, 984.2667212926273, 1059.2585190366774, 1082.7942690888706, 19911.60176796456, 20139.697904531444, 20307.0, 20592.27927022547, 20933.0, 977.310995747996, 994.4480813148627, 1035.3011717090933, 1044.8955104489642, 1045.2213101239472, 10326.638567650247, 11443.427828608703, 11462.598809041643, 11584.594539191088, 11595.710107247218, 473005.0, 476394.0, 483108.0, 486106.0, 486610.0, 92463.0, 93155.0, 93760.53119734494, 93803.53098234601, 94281.0, 973.2749101918974, 975.6390135649855, 982.6708052802392, 984.7981163861391, 992.6575331510618, 16491.752623710894, 17306.221220044878, 17908.820911791237, 17934.103294835466, 18082.457526274233, 43345.78327108344, 43547.78226108976, 43833.34249986317, 43894.780526098446, 45078.54921450744, 57368.42631573631, 58064.4193558059, 58106.12840807476, 58653.70673146607, 59459.70270148622, 8547.700830470903, 8653.524056176971, 8676.739697809076, 8687.131286871263, 8798.956005219932, 12114.939425302817, 12757.234565926074, 12890.226586404846, 13048.478060877458, 13202.0, 11469.483873225558, 11679.649610511698, 11701.76596468083, 11768.70578235551, 12125.75748485043, 11133.665990020312, 11545.826812597987, 11561.075113990692, 11699.42612625221, 11904.345261010727, 9536.904630953879, 11447.656570302905, 11721.648350549498, 11817.172797904064, 12086.335251561248, 7805.102413222552, 7811.257930496594, 8096.878546821685, 8515.40392172542, 8601.82796344082, 8919.955400222958, 11010.50452729613, 11414.201005929504, 11424.371659558805, 11840.703982400164], "value": 9109.939149052376, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.3781191745836, 1390.2701081931987, 1458.4312118273874, 1521.7108749337624, 1728.5505768500186, 8212.876806847902, 8520.531370774605, 8601.784955376119, 8806.163414475615, 8822.250108740765, 8623.698170564032, 8739.956300218506, 8743.387962842604, 8751.256143227818, 8757.0, 2353.835231533789, 2370.288913326004, 2380.47629521505, 2382.0, 2388.22382725614, 2290.530441259546, 2353.0587764894008, 2353.7410884802657, 2359.634256690207, 2364.9054037838464, 2304.72343318802, 2328.860268383894, 2329.895154718033, 2339.0176126027022, 2341.473168537074, 2266.05958527211, 2290.770922907721, 2292.90828366866, 2301.102569997702, 2340.8361414700976, 2253.954920901589, 2258.6837842702034, 2260.8869556522272, 2266.897989590472, 2270.0465804362207, 8648.0, 8662.393632445732, 8711.128887111301, 8771.605277762452, 8846.823063538757, 5291.603129765283, 5428.972855135738, 5443.727813609304, 5444.237806707064, 5468.589855760794, 3404.42124838778, 3417.4532074868152, 3485.5817301923676, 3488.180277634779, 3503.316853213624, 1108.3571528513444, 1124.1175677093443, 1143.7883991461606, 1164.115272392979, 1167.0546857045736, 12403.193792403465, 12433.62699119037, 12442.937785311105, 12544.372781360895, 12556.372181390894, 4432.091421258634, 4538.52345503724, 4665.04366604852, 4700.811967521261, 4718.174319494075, 9780.55987480565, 9789.706308810748, 9857.0, 9857.704268871945, 9867.802643947225, 5003.199488081889, 5015.874603134878, 5040.722760248222, 5042.722650254272, 5058.595312375001, 4313.525512193656, 4689.0, 4694.741789201558, 4854.466008739036, 4878.829240976549, 3774.377227757444, 3792.2984247914223, 3831.885043448701, 3877.1470276539117, 3917.764934103963, 1136.1138312116561, 1147.4951021550492, 1157.1379322404862, 1160.785254727878, 1165.143619439711, 989.2877128467492, 996.9651062212788, 1010.6513252927729, 1012.731626119079, 1028.1825948370913, 6074.362191969868, 6087.573869829158, 6247.375262473807, 6307.4954003679595, 6491.67541622917, 482.679018452732, 488.14087206516785, 495.17306098815067, 499.557891266232, 502.9673071250357, 4146.150039241948, 4377.299632058855, 4418.138462999685, 4461.643068554507, 4491.775411229425, 10909.509072091774, 11287.49206285719, 11361.14791390649, 11371.260868043551, 11393.829092563617, 11006.559737610565, 11089.39008354532, 11286.0, 11303.265287756434, 11316.6039188628, 8062.355011599058, 8098.349894070962, 8146.67413303473, 8159.224873636995, 8182.304504117098, 6146.661933593517, 6154.723037463415, 6191.81424557264, 6239.594426362272, 6298.433141017331, 10272.075513203847, 10372.533236004247, 10375.221858360805, 10428.113610343205, 10447.582096716047, 10393.856675765508, 10446.373217606968, 10494.632687856194, 10509.106725928075, 10612.84080738805, 6720.596764194164, 7287.817804554928, 7390.815229619303, 7431.071116110486, 7480.663370148465, 8763.123687631441, 8840.602172902107, 8846.071162527842, 8849.601767920587, 8855.73432797017, 7702.636840168332, 7732.226777322223, 7886.0, 7918.0, 8073.233042860918, 7627.161012288755, 7710.4217183710325, 7782.221777822172, 7811.4922530035365, 7825.569593672175, 6946.270641582763, 7069.328413800681, 7075.327843854826, 7076.186238582629, 7078.929210707827, 5388.434214407431, 5423.0, 5534.335879694462, 5563.0, 5606.887862242814, 5485.504095636396, 5533.750981205775, 5586.525145362527, 5639.9566080273635, 5697.0], "value": 4589.067687974161, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.2058801522415, 340.13266171263285, 341.3684683335828, 350.9333226686931, 351.1519679972864, 5209.400918894324, 5214.513863548885, 5218.530332270095, 5241.213817927312, 5241.764120614572, 5176.404713457953, 5180.533751962323, 5209.82778874753, 5223.294855194547, 5242.659227150232, 4037.1723796621623, 4097.201045796071, 4129.690273229505, 4140.358244472111, 4143.896402589944, 4138.379243113542, 4145.834166633346, 4163.396307535406, 4166.541680415152, 4186.529947331074, 4107.116969851481, 4115.1975364803875, 4121.258173528764, 4122.216778812031, 4127.938080928789, 3906.2968665640315, 3984.402339649047, 4096.3036283831525, 4116.650084742771, 4129.6283334499885, 3657.926841463156, 3670.743047986642, 3672.2471893262086, 3681.7238707097076, 3687.3362794696945, 5084.847454576368, 5149.974250128763, 5151.7074901668775, 5153.56194723449, 5166.61250406221, 4518.909621807578, 4560.179167749804, 4742.241241401359, 4749.4775574686755, 4781.163296423147, 5418.647787893774, 5422.8915421691345, 5425.674459532401, 5432.592555558349, 5447.673139611636, 4028.436018957348, 4046.534648515429, 4055.71609987301, 4057.1885622875247, 4087.8364865405347, 5402.8919421611745, 5670.370962583949, 5682.17608446777, 5683.886322273532, 5732.0255556555485, 4024.3561030235023, 4045.786264120752, 4048.542524691109, 4068.6948478864206, 4071.572484889103, 4135.545090040093, 4142.171565686815, 4145.689073319453, 4149.149424367997, 4155.522114956819, 4456.888577785581, 4641.95358046422, 4690.202665546865, 4730.668853180313, 4732.95267047332, 5463.732550991294, 5466.278122391434, 5467.781288748485, 5486.259354987105, 5513.476219759116, 1420.7584710599224, 1431.3272761801936, 1437.7915202295608, 1439.4098419647894, 1442.7980082788417, 879.846026945282, 915.5605309451367, 919.6664835987845, 934.1172591900589, 938.8263171313329, 4624.583787459078, 4682.789274482657, 4700.388949436619, 4715.646326525524, 4717.603325605559, 4919.958217339836, 4955.975220123876, 4965.8013679452415, 5015.623828212899, 5033.759976810285, 4776.832810851603, 4802.471728109905, 4831.855044348676, 4860.586850117709, 4957.652964292537, 2926.678065412803, 2963.422132684149, 2969.0944261999866, 2971.15322133191, 2987.865546050433, 5732.0, 5776.0, 5779.0, 5797.768089276466, 5811.418858114239, 5527.364353099445, 5707.34365547959, 5716.0, 5737.282839645044, 5763.838560539798, 5765.84683063389, 5767.307923049261, 5775.682337471395, 5779.508741756914, 5807.332156801853, 5392.272043274108, 5588.6646801192055, 5620.325560932714, 5626.718664066699, 5651.858703532444, 5541.362743284412, 5560.638558493685, 5567.24842146305, 5586.497215250647, 5586.692731899784, 5721.284839395075, 5727.7422515986045, 5747.821696552113, 5771.567132465166, 5792.797252096157, 3931.76409415436, 3980.7412518186225, 4003.6596889263574, 4005.8397664094277, 4019.336809426529, 5631.887362252814, 5637.379888212376, 5653.265075540318, 5653.44530254167, 5659.717014149193, 5493.945060549343, 5527.706002009121, 5534.7786088556, 5585.245991791218, 5586.832395028156, 5243.947560524499, 5438.23864658956, 5451.827857010761, 5464.781408743765, 5477.986572484103, 5425.104857698436, 5454.418218716686, 5461.208124821958, 5468.9179662304305, 5472.50747432733, 5257.710825904612, 5362.946370536245, 5388.515033646991, 5389.919151212814, 5502.0921547945745, 4858.562729354234, 5352.866178345573, 5366.899785543876, 5367.946320536745, 5372.677639341652], "value": 4161.417189827743, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.8599852026633, 805.6737021506289, 811.9269265766081, 815.5840521334119, 824.843279776842, 13903.0, 15098.698026039487, 15118.773218401706, 15127.697446051086, 15204.239788010611, 14241.78637320441, 14345.42618295267, 14435.42258309669, 14448.494302699408, 14448.5665430037, 668.5286872754721, 796.9721059762909, 801.4710291207789, 821.4619424277108, 825.5253229393093, 813.6379311206515, 817.7301490508119, 819.6680344460503, 823.872299793533, 824.5712229640583, 871.0288028847821, 878.6880657366606, 879.7800549862534, 880.9163129502687, 881.1056777370974, 701.0465766557478, 846.327169899931, 865.9567021648892, 875.5972252763704, 875.6147295190128, 637.4836382530119, 638.8083574927549, 638.8498702804837, 639.25526761323, 639.3318981664172, 14057.437702491889, 14107.647308817259, 14116.223607701573, 14120.858791412056, 14140.222287774168, 14092.788608170886, 14176.645583860383, 14464.349104290332, 14580.70838583233, 14665.193414362206, 13357.465701371933, 13497.0, 13571.253581053039, 13975.79036314456, 14420.423183072664, 4443.888902777424, 4543.5002149763495, 4551.590356867898, 4573.771311434415, 4584.358189853423, 83885.0, 84262.0, 84341.0, 84421.0, 85096.0, 10749.62376316825, 11047.889521104686, 11061.008749664043, 11634.88365116338, 11951.521939122338, 21515.0, 21712.0, 21724.131034758433, 21724.674129888066, 21776.346709598736, 8004.199580041949, 8049.0, 8197.590120494071, 8301.128381519853, 8314.501129932223, 4680.110778951988, 4724.362211101526, 4741.715497070187, 4745.050989802054, 4793.592544633675, 3297.9835100824343, 3406.1144102533026, 3409.4203985322556, 3804.31522325984, 4009.69927255457, 652.2548459953873, 663.3068443476578, 664.2792570061441, 673.0879658063352, 674.7065026713395, 588.5174157191062, 626.6208943589154, 681.9693113809891, 690.4200471603876, 743.6281859070465, 9776.315657903879, 9968.252381071448, 10336.431496267627, 10671.25301228922, 10729.988571314443, 603.4508597176548, 651.3356376495948, 690.6098054599136, 722.9011110891, 724.5580196080386, 4727.64542659302, 4900.109333068255, 4986.601071914238, 5150.974245128826, 5181.481851814864, 127420.0, 127514.0, 127648.0, 127805.0, 129197.0, 65338.0, 67239.0, 83746.0, 84496.04263850859, 85504.0, 96505.51747241219, 97489.0, 98043.50978245206, 100063.49968250112, 102837.0, 9135.588898499716, 9697.127258546765, 9702.70891873245, 9760.951195243979, 9943.801123977335, 48350.5164948346, 49068.75465622792, 49385.50614493953, 49916.50083499119, 50051.499485004686, 74535.62732186304, 74550.62724686341, 75349.62325188339, 75513.62243188749, 76623.61688191524, 13355.0, 13383.0, 13393.464261429433, 13661.795073073714, 13750.931245343709, 14786.852131478547, 14900.090125528446, 15322.218115341217, 15652.0, 15731.370745170523, 14329.847433564599, 14675.071199537933, 14732.631684207981, 15346.923265383602, 15364.462243821412, 13637.727245455233, 13738.10702304347, 14139.151650900978, 14154.292285385896, 14652.047616904867, 13973.790393143907, 14517.709645807236, 14613.123212607277, 15129.167895765839, 15130.0, 11547.249428787101, 11715.589954351557, 11749.494546090113, 12040.879591203975, 12092.455839487067, 11106.61126860556, 11852.348120853436, 12184.20802647825, 12396.752064958831, 12437.689057773629], "value": 7727.105567607014, "unit": "score"}], "name": "dromaeo_css", "value": 7300.612283678882, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 108.0, 110.0, 110.0, 112.0, 117.0, 112.0, 111.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 125.0, 152.0, 173.0, 123.0, 141.0, 149.0, 124.0, 180.0, 117.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 160.0, 162.0, 162.0, 162.0, 160.0, 159.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 177.0, 77.0, 76.0, 75.0, 76.0, 162.0, 75.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 143.0, 86.0, 86.0, 86.0, 146.0, 85.0, 85.0, 145.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 58.0, 52.0, 55.0, 58.0, 53.0, 55.0, 54.0, 51.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 63.0, 64.0, 63.0, 63.0, 62.0, 62.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 88.0, 82.0, 87.0, 81.0, 85.0, 79.0, 79.0, 80.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 125.0, 140.0, 132.0, 124.0, 123.0, 126.0, 124.0, 143.0, 126.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 172.0, 166.0, 165.0, 166.0, 164.0, 166.0, 171.0, 165.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 65.0, 66.0, 68.0, 64.0, 65.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1531.3000000000002, "alertThreshold": 2.0}]} 09:28:15 INFO - Return code: 0 09:28:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:28:15 INFO - # TBPL SUCCESS # 09:28:15 INFO - Running post-action listener: _resource_record_post_action 09:28:15 INFO - [mozharness: 2016-08-22 16:28:15.969396Z] Finished run-tests step (success) 09:28:15 INFO - Running post-run listener: _resource_record_post_run 09:28:16 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 417615872; Read time: 4; Write time: 305904 09:28:16 INFO - TinderboxPrint: CPU usage
13.3% 09:28:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 09:28:16 INFO - TinderboxPrint: I/O write bytes / time
417,615,872 / 305,904 09:28:16 INFO - TinderboxPrint: CPU idle
8,280.5 (86.7%) 09:28:16 INFO - TinderboxPrint: CPU user
1,204.6 (12.6%) 09:28:16 INFO - TinderboxPrint: Swap in / out
0 / 0 09:28:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128851968; Read time: 0; Write time: 85916 09:28:16 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288763904; Read time: 0; Write time: 219988 09:28:16 INFO - Running post-run listener: _upload_blobber_files 09:28:16 INFO - Blob upload gear active. 09:28:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:28:16 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 09:28:16 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:28:16 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:28:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:28:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:28:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:28:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:17 INFO - (blobuploader) - INFO - Done attempting. 09:28:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:28:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:28:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:21 INFO - (blobuploader) - INFO - Done attempting. 09:28:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:28:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:28:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:22 INFO - (blobuploader) - INFO - Done attempting. 09:28:22 INFO - (blobuploader) - INFO - Iteration through files over. 09:28:22 INFO - Return code: 0 09:28:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:28:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:28:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fc68b3544147bcf248789bdb3897d602a71804f13db3f0b0ff3f4f7963f9763102a100c5d4e9df37410643b3ca5b961f3f445f2f5dfc39741bfcca96bf7fc04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ab74e7f87321449968d9f4da3606575a80d98793090649f265edcc2cd244045b100451078ac9a9c058b71754080b1aafc0c8a60d28149b1d45212cee446da08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eefdd07d6b9a9b33445160722078b1d29a3b46b3390ffb9408cdcd843ba7f035912c0a4e96e0f4820c45fe15aa122c87e93453daaeb2797dd5cb5e9de799a112"} 09:28:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:28:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:28:22 INFO - Contents: 09:28:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fc68b3544147bcf248789bdb3897d602a71804f13db3f0b0ff3f4f7963f9763102a100c5d4e9df37410643b3ca5b961f3f445f2f5dfc39741bfcca96bf7fc04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ab74e7f87321449968d9f4da3606575a80d98793090649f265edcc2cd244045b100451078ac9a9c058b71754080b1aafc0c8a60d28149b1d45212cee446da08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eefdd07d6b9a9b33445160722078b1d29a3b46b3390ffb9408cdcd843ba7f035912c0a4e96e0f4820c45fe15aa122c87e93453daaeb2797dd5cb5e9de799a112"} 09:28:22 INFO - Running post-run listener: copy_logs_to_upload_dir 09:28:22 INFO - Copying logs to upload dir... 09:28:22 INFO - mkdir: /builds/slave/test/build/upload/logs 09:28:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.087988 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-22 09:28:21.976806) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 09:28:21.980509) ========= 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=31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fc68b3544147bcf248789bdb3897d602a71804f13db3f0b0ff3f4f7963f9763102a100c5d4e9df37410643b3ca5b961f3f445f2f5dfc39741bfcca96bf7fc04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ab74e7f87321449968d9f4da3606575a80d98793090649f265edcc2cd244045b100451078ac9a9c058b71754080b1aafc0c8a60d28149b1d45212cee446da08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eefdd07d6b9a9b33445160722078b1d29a3b46b3390ffb9408cdcd843ba7f035912c0a4e96e0f4820c45fe15aa122c87e93453daaeb2797dd5cb5e9de799a112"} build_url:https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/cy4VvHSJSD-MVyMuwJ8vZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fc68b3544147bcf248789bdb3897d602a71804f13db3f0b0ff3f4f7963f9763102a100c5d4e9df37410643b3ca5b961f3f445f2f5dfc39741bfcca96bf7fc04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ab74e7f87321449968d9f4da3606575a80d98793090649f265edcc2cd244045b100451078ac9a9c058b71754080b1aafc0c8a60d28149b1d45212cee446da08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eefdd07d6b9a9b33445160722078b1d29a3b46b3390ffb9408cdcd843ba7f035912c0a4e96e0f4820c45fe15aa122c87e93453daaeb2797dd5cb5e9de799a112"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 09:28:22.008148) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:28:22.008785) ========= 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=31acecf42b6a79ec49471d4a000001bb-1471881986.749614-2058945737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:28:22.092575) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 09:28:22.093297) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 09:28:22.093970) ========= ========= Total master_lag: 0.19 =========