builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1472296191.47 results: success (0) buildid: 20160827013002 builduid: e7abeb676f3e43d2897b9c602a711120 revision: 88248d124b9a88885740b78114be1b11576b4dbc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 04:09:51.475309) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 04:09:51.475751) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-08-27 04:09:51.476172) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-08-27 04:09:52.589317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:09:52.589618) ========= 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=41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-27 04:09:53-- 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% 213M=0s 2016-08-27 04:09:53 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111385 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:09:52.972482) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:09:52.972799) ========= 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=41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017828 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:09:53.015399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:09:53.015701) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 88248d124b9a88885740b78114be1b11576b4dbc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 88248d124b9a88885740b78114be1b11576b4dbc --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=41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-27 04:09:53,480 truncating revision to first 12 chars 2016-08-27 04:09:53,480 Setting DEBUG logging. 2016-08-27 04:09:53,481 attempt 1/10 2016-08-27 04:09:53,481 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/88248d124b9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-27 04:09:53,717 unpacking tar archive at: mozilla-inbound-88248d124b9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.503972 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:09:53.535424) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 04:09:53.535710) ========= script_repo_revision: 88248d124b9a88885740b78114be1b11576b4dbc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 04:09:53.536079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 04:09:53.536342) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 04:09:53.546864) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-27 04:09:53.547133) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:09:54 INFO - MultiFileLogger online at 20160827 04:09:54 in /builds/slave/test 04:09:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:09:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:09:54 INFO - {'append_to_log': False, 04:09:54 INFO - 'base_work_dir': '/builds/slave/test', 04:09:54 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:09:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:09:54 INFO - 'branch': 'Mozilla-Inbound', 04:09:54 INFO - 'buildbot_json_path': 'buildprops.json', 04:09:54 INFO - 'config_files': ('talos/linux_config.py',), 04:09:54 INFO - 'default_actions': ('clobber', 04:09:54 INFO - 'read-buildbot-config', 04:09:54 INFO - 'download-and-extract', 04:09:54 INFO - 'populate-webroot', 04:09:54 INFO - 'create-virtualenv', 04:09:54 INFO - 'install', 04:09:54 INFO - 'run-tests'), 04:09:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:09:54 INFO - 'download_minidump_stackwalk': True, 04:09:54 INFO - 'download_symbols': 'ondemand', 04:09:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:09:54 INFO - 'tooltool.py': '/tools/tooltool.py', 04:09:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:09:54 INFO - '/tools/misc-python/virtualenv.py')}, 04:09:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:09:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:09:54 INFO - 'installer_path': 'installer.exe', 04:09:54 INFO - 'log_level': 'info', 04:09:54 INFO - 'log_name': 'talos', 04:09:54 INFO - 'log_to_console': True, 04:09:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:09:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:09:54 INFO - 'opt_config_files': (), 04:09:54 INFO - 'pip_index': False, 04:09:54 INFO - 'sps_profile': False, 04:09:54 INFO - 'sps_profile_interval': 0, 04:09:54 INFO - 'suite': 'dromaeojs', 04:09:54 INFO - 'system_bits': '32', 04:09:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:09:54 INFO - 'title': 'talos-linux64-ix-026', 04:09:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:09:54 INFO - 'use_talos_json': True, 04:09:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:09:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:09:54 INFO - 'work_dir': 'build'} 04:09:54 INFO - [mozharness: 2016-08-27 11:09:54.101210Z] Running clobber step. 04:09:54 INFO - Running pre-action listener: _resource_record_pre_action 04:09:54 INFO - Running main action method: clobber 04:09:54 INFO - rmtree: /builds/slave/test/build 04:09:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:09:54 INFO - Running post-action listener: _resource_record_post_action 04:09:54 INFO - [mozharness: 2016-08-27 11:09:54.564540Z] Finished clobber step (success) 04:09:54 INFO - [mozharness: 2016-08-27 11:09:54.564644Z] Running read-buildbot-config step. 04:09:54 INFO - Running pre-action listener: _resource_record_pre_action 04:09:54 INFO - Running main action method: read_buildbot_config 04:09:54 INFO - Using buildbot properties: 04:09:54 INFO - { 04:09:54 INFO - "project": "", 04:09:54 INFO - "product": "firefox", 04:09:54 INFO - "script_repo_revision": "production", 04:09:54 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:09:54 INFO - "repository": "", 04:09:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:09:54 INFO - "buildid": "20160827013002", 04:09:54 INFO - "pgo_build": "True", 04:09:54 INFO - "basedir": "/builds/slave/test", 04:09:54 INFO - "buildnumber": 1611, 04:09:54 INFO - "slavename": "talos-linux64-ix-026", 04:09:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:09:54 INFO - "platform": "ubuntu64_hw", 04:09:54 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:09:54 INFO - "branch": "mozilla-inbound", 04:09:54 INFO - "repo_path": "integration/mozilla-inbound", 04:09:54 INFO - "revision": "88248d124b9a88885740b78114be1b11576b4dbc", 04:09:54 INFO - "stage_platform": "linux64-pgo", 04:09:54 INFO - "builduid": "e7abeb676f3e43d2897b9c602a711120", 04:09:54 INFO - "slavebuilddir": "test" 04:09:54 INFO - } 04:09:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 04:09:54 INFO - Running post-action listener: _resource_record_post_action 04:09:54 INFO - [mozharness: 2016-08-27 11:09:54.567114Z] Finished read-buildbot-config step (success) 04:09:54 INFO - [mozharness: 2016-08-27 11:09:54.567210Z] Running download-and-extract step. 04:09:54 INFO - Running pre-action listener: _resource_record_pre_action 04:09:54 INFO - Running main action method: download_and_extract 04:09:54 INFO - mkdir: /builds/slave/test/build/tests 04:09: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')]} 04:09:54 INFO - trying https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:09:54 INFO - Downloading https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/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 04:09:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/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 04:09:55 INFO - Downloaded 1361 bytes. 04:09:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:09:55 INFO - Using the following test package requirements: 04:09:55 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:55 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:09:55 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:09:55 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:55 INFO - u'jsshell-linux-x86_64.zip'], 04:09:55 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:09:55 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:55 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:09:55 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:09:55 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:09:55 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:09:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:09: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')]} 04:09:55 INFO - trying https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:09:55 INFO - Downloading https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/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 04:09:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/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 04:09:55 INFO - Downloaded 21876671 bytes. 04:09:55 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 04:10:00 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 04:10:00 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')]} 04:10:00 INFO - trying https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:10:00 INFO - Downloading https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/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 04:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/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 04:10:01 INFO - Downloaded 21876671 bytes. 04:10:01 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 04:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:06 INFO - trying https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:10:06 INFO - Downloading https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/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 04:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/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 04:10:06 INFO - Downloaded 14413998 bytes. 04:10:06 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 04:10: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')]} 04:10:07 INFO - trying https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:10:07 INFO - Downloading https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/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 04:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/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 04:10:08 INFO - Downloaded 59697424 bytes. 04:10:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:10:08 INFO - mkdir: /builds/slave/test/properties 04:10:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:10:08 INFO - Writing to file /builds/slave/test/properties/build_url 04:10:08 INFO - Contents: 04:10:08 INFO - build_url:https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:10:09 INFO - Running post-action listener: _resource_record_post_action 04:10:09 INFO - Running post-action listener: set_extra_try_arguments 04:10:09 INFO - [mozharness: 2016-08-27 11:10:09.782591Z] Finished download-and-extract step (success) 04:10:09 INFO - [mozharness: 2016-08-27 11:10:09.782820Z] Running populate-webroot step. 04:10:09 INFO - Running pre-action listener: _resource_record_pre_action 04:10:09 INFO - Running main action method: populate_webroot 04:10:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:10:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:10:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:10:09 INFO - '--tppagecycles', 04:10:09 INFO - '7'], 04:10:09 INFO - 'tests': ['tsvgm']}}, 04:10:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:10:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:10:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:10:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:10:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:10:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:10:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:09 INFO - 'talos_options': ['--disable-e10s'], 04:10:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:09 INFO - 'talos_options': ['--disable-e10s'], 04:10:09 INFO - 'tests': ['damp', 'tps']}, 04:10:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:09 INFO - 'tests': ['damp', 'tps']}, 04:10:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:10:09 INFO - 'tests': ['dromaeo_dom']}, 04:10:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:10:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:10:09 INFO - 'tests': ['basic_compositor_video']}, 04:10:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:10:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:10:09 INFO - 'tests': ['a11yr', 04:10:09 INFO - 'ts_paint', 04:10:09 INFO - 'tpaint', 04:10:09 INFO - 'sessionrestore', 04:10:09 INFO - 'sessionrestore_no_auto_restore', 04:10:09 INFO - 'tabpaint']}, 04:10:09 INFO - 'other-e10s': {'tests': ['a11yr', 04:10:09 INFO - 'ts_paint', 04:10:09 INFO - 'tpaint', 04:10:09 INFO - 'sessionrestore', 04:10:09 INFO - 'sessionrestore_no_auto_restore', 04:10:09 INFO - 'tabpaint']}, 04:10:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:10:09 INFO - 'ts_paint', 04:10:09 INFO - 'tpaint', 04:10:09 INFO - 'sessionrestore', 04:10:09 INFO - 'sessionrestore_no_auto_restore', 04:10:09 INFO - 'tabpaint']}, 04:10:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:10:09 INFO - 'ts_paint', 04:10:09 INFO - 'tpaint', 04:10:09 INFO - 'sessionrestore', 04:10:09 INFO - 'sessionrestore_no_auto_restore', 04:10:09 INFO - 'tabpaint']}, 04:10:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:10:09 INFO - 'tests': ['a11yr', 04:10:09 INFO - 'ts_paint', 04:10:09 INFO - 'tpaint', 04:10:09 INFO - 'sessionrestore', 04:10:09 INFO - 'sessionrestore_no_auto_restore', 04:10:09 INFO - 'tabpaint']}, 04:10:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:10:09 INFO - 'tests': ['a11yr', 04:10:09 INFO - 'ts_paint', 04:10:09 INFO - 'tpaint', 04:10:09 INFO - 'sessionrestore', 04:10:09 INFO - 'sessionrestore_no_auto_restore', 04:10:09 INFO - 'tabpaint']}, 04:10:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:10:09 INFO - 'tests': ['tsvgx', 04:10:09 INFO - 'tsvgr_opacity', 04:10:09 INFO - 'tart', 04:10:09 INFO - 'tscrollx', 04:10:09 INFO - 'cart']}, 04:10:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:10:09 INFO - 'tsvgr_opacity', 04:10:09 INFO - 'tart', 04:10:09 INFO - 'tscrollx', 04:10:09 INFO - 'cart']}, 04:10:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:09 INFO - 'talos_options': ['--disable-e10s'], 04:10:09 INFO - 'tests': ['tp5o']}, 04:10:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:09 INFO - 'tests': ['tp5o']}, 04:10:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:09 INFO - 'talos_options': ['--disable-e10s', 04:10:09 INFO - '--xperf_path', 04:10:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:09 INFO - 'tests': ['tp5n']}, 04:10:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:09 INFO - 'talos_options': ['--xperf_path', 04:10:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:09 INFO - 'tests': ['tp5n']}}, 04:10:09 INFO - 'talos.zip': {'path': '', 04:10:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:10:09 INFO - Running post-action listener: _resource_record_post_action 04:10:09 INFO - [mozharness: 2016-08-27 11:10:09.804205Z] Finished populate-webroot step (success) 04:10:09 INFO - [mozharness: 2016-08-27 11:10:09.804295Z] Running create-virtualenv step. 04:10:09 INFO - Running pre-action listener: _resource_record_pre_action 04:10:09 INFO - Running main action method: create_virtualenv 04:10:09 INFO - Creating virtualenv /builds/slave/test/build/venv 04:10:09 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 04:10:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:10:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:10:09 INFO - Using real prefix '/usr' 04:10:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:10:10 INFO - Installing distribute.............................................................................................................................................................................................done. 04:10:12 INFO - Installing pip.................done. 04:10:12 INFO - Return code: 0 04:10:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:10:12 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')]} 04:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:12 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')]} 04:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:12 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 0x7f9106999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6090>, '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 0x13a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a9e40>, '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': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', '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 04:10:12 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 04:10:12 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 04:10:12 INFO - Using env: {'DISPLAY': ':0', 04:10:12 INFO - 'HOME': '/home/cltbld', 04:10:12 INFO - 'LANG': 'en_US.UTF-8', 04:10:12 INFO - 'LANGUAGE': 'en_US:en', 04:10:12 INFO - 'LOGNAME': 'cltbld', 04:10:12 INFO - 'MAIL': '/var/mail/cltbld', 04:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:12 INFO - 'MOZ_NO_REMOTE': '1', 04:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:12 INFO - 'NO_EM_RESTART': '1', 04:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:12 INFO - 'PWD': '/builds/slave/test', 04:10:12 INFO - 'SHELL': '/bin/bash', 04:10:12 INFO - 'SHLVL': '1', 04:10:12 INFO - 'TERM': 'linux', 04:10:12 INFO - 'TMOUT': '86400', 04:10:12 INFO - 'USER': 'cltbld', 04:10:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', 04:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:12 INFO - '_': '/tools/buildbot/bin/python'} 04:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:12 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 04:10:12 INFO - Cleaning up... 04:10:12 INFO - Return code: 0 04:10:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:10:12 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')]} 04:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:12 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')]} 04:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:12 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 0x7f9106999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6090>, '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 0x13a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a9e40>, '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': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', '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 04:10:12 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 04:10:12 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 04:10:12 INFO - Using env: {'DISPLAY': ':0', 04:10:12 INFO - 'HOME': '/home/cltbld', 04:10:12 INFO - 'LANG': 'en_US.UTF-8', 04:10:12 INFO - 'LANGUAGE': 'en_US:en', 04:10:12 INFO - 'LOGNAME': 'cltbld', 04:10:12 INFO - 'MAIL': '/var/mail/cltbld', 04:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:12 INFO - 'MOZ_NO_REMOTE': '1', 04:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:12 INFO - 'NO_EM_RESTART': '1', 04:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:12 INFO - 'PWD': '/builds/slave/test', 04:10:12 INFO - 'SHELL': '/bin/bash', 04:10:12 INFO - 'SHLVL': '1', 04:10:12 INFO - 'TERM': 'linux', 04:10:12 INFO - 'TMOUT': '86400', 04:10:12 INFO - 'USER': 'cltbld', 04:10:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', 04:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:12 INFO - '_': '/tools/buildbot/bin/python'} 04:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:12 INFO - Downloading/unpacking psutil>=3.1.1 04:10:12 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 04:10:12 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 04:10:12 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 04:10:12 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 04:10:12 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 04:10:12 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 04:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:10:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:14 INFO - Installing collected packages: psutil 04:10:14 INFO - Running setup.py install for psutil 04:10:14 INFO - building 'psutil._psutil_linux' extension 04:10:14 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 04:10:15 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 04:10:15 INFO - building 'psutil._psutil_posix' extension 04:10:15 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 04:10:15 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 04:10:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:15 INFO - Successfully installed psutil 04:10:15 INFO - Cleaning up... 04:10:15 INFO - Return code: 0 04:10:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9106999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6090>, '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 0x13a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a9e40>, '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': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', '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 04:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:10:15 INFO - Using env: {'DISPLAY': ':0', 04:10:15 INFO - 'HOME': '/home/cltbld', 04:10:15 INFO - 'LANG': 'en_US.UTF-8', 04:10:15 INFO - 'LANGUAGE': 'en_US:en', 04:10:15 INFO - 'LOGNAME': 'cltbld', 04:10:15 INFO - 'MAIL': '/var/mail/cltbld', 04:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:15 INFO - 'MOZ_NO_REMOTE': '1', 04:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:15 INFO - 'NO_EM_RESTART': '1', 04:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:15 INFO - 'PWD': '/builds/slave/test', 04:10:15 INFO - 'SHELL': '/bin/bash', 04:10:15 INFO - 'SHLVL': '1', 04:10:15 INFO - 'TERM': 'linux', 04:10:15 INFO - 'TMOUT': '86400', 04:10:15 INFO - 'USER': 'cltbld', 04:10:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', 04:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:15 INFO - '_': '/tools/buildbot/bin/python'} 04:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:10:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:10:17 INFO - Installing collected packages: mozsystemmonitor 04:10:17 INFO - Running setup.py install for mozsystemmonitor 04:10:17 INFO - Successfully installed mozsystemmonitor 04:10:17 INFO - Cleaning up... 04:10:17 INFO - Return code: 0 04:10:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9106999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6090>, '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 0x13a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a9e40>, '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': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', '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 04:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:10:17 INFO - Using env: {'DISPLAY': ':0', 04:10:17 INFO - 'HOME': '/home/cltbld', 04:10:17 INFO - 'LANG': 'en_US.UTF-8', 04:10:17 INFO - 'LANGUAGE': 'en_US:en', 04:10:17 INFO - 'LOGNAME': 'cltbld', 04:10:17 INFO - 'MAIL': '/var/mail/cltbld', 04:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:17 INFO - 'MOZ_NO_REMOTE': '1', 04:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:17 INFO - 'NO_EM_RESTART': '1', 04:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:17 INFO - 'PWD': '/builds/slave/test', 04:10:17 INFO - 'SHELL': '/bin/bash', 04:10:17 INFO - 'SHLVL': '1', 04:10:17 INFO - 'TERM': 'linux', 04:10:17 INFO - 'TMOUT': '86400', 04:10:17 INFO - 'USER': 'cltbld', 04:10:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', 04:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:17 INFO - '_': '/tools/buildbot/bin/python'} 04:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:17 INFO - Downloading/unpacking jsonschema==2.5.1 04:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:10:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:19 INFO - Downloading functools32-3.2.3-2.tar.gz 04:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:10:19 INFO - warning: no files found matching '*.txt' 04:10:19 INFO - no previously-included directories found matching 'build' 04:10:19 INFO - no previously-included directories found matching 'dist' 04:10:19 INFO - no previously-included directories found matching '.git*' 04:10:20 INFO - Installing collected packages: jsonschema, functools32 04:10:20 INFO - Running setup.py install for functools32 04:10:20 INFO - warning: no files found matching '*.txt' 04:10:20 INFO - no previously-included directories found matching 'build' 04:10:20 INFO - no previously-included directories found matching 'dist' 04:10:20 INFO - no previously-included directories found matching '.git*' 04:10:20 INFO - Successfully installed jsonschema functools32 04:10:20 INFO - Cleaning up... 04:10:20 INFO - Return code: 0 04:10:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:10:20 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')]} 04:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:20 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')]} 04:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:20 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 0x7f9106999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6090>, '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 0x13a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a9e40>, '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': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', '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 04:10:20 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 04:10:20 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 04:10:20 INFO - Using env: {'DISPLAY': ':0', 04:10:20 INFO - 'HOME': '/home/cltbld', 04:10:20 INFO - 'LANG': 'en_US.UTF-8', 04:10:20 INFO - 'LANGUAGE': 'en_US:en', 04:10:20 INFO - 'LOGNAME': 'cltbld', 04:10:20 INFO - 'MAIL': '/var/mail/cltbld', 04:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:20 INFO - 'MOZ_NO_REMOTE': '1', 04:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:20 INFO - 'NO_EM_RESTART': '1', 04:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:20 INFO - 'PWD': '/builds/slave/test', 04:10:20 INFO - 'SHELL': '/bin/bash', 04:10:20 INFO - 'SHLVL': '1', 04:10:20 INFO - 'TERM': 'linux', 04:10:20 INFO - 'TMOUT': '86400', 04:10:20 INFO - 'USER': 'cltbld', 04:10:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', 04:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:20 INFO - '_': '/tools/buildbot/bin/python'} 04:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:10:20 INFO - Cleaning up... 04:10:20 INFO - Return code: 0 04:10:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:10:20 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')]} 04:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:20 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')]} 04:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:20 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 0x7f9106999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6090>, '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 0x13a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a9e40>, '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': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', '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 04:10:20 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 04:10:20 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 04:10:20 INFO - Using env: {'DISPLAY': ':0', 04:10:20 INFO - 'HOME': '/home/cltbld', 04:10:20 INFO - 'LANG': 'en_US.UTF-8', 04:10:20 INFO - 'LANGUAGE': 'en_US:en', 04:10:20 INFO - 'LOGNAME': 'cltbld', 04:10:20 INFO - 'MAIL': '/var/mail/cltbld', 04:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:20 INFO - 'MOZ_NO_REMOTE': '1', 04:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:20 INFO - 'NO_EM_RESTART': '1', 04:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:20 INFO - 'PWD': '/builds/slave/test', 04:10:20 INFO - 'SHELL': '/bin/bash', 04:10:20 INFO - 'SHLVL': '1', 04:10:20 INFO - 'TERM': 'linux', 04:10:20 INFO - 'TMOUT': '86400', 04:10:20 INFO - 'USER': 'cltbld', 04:10:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', 04:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:20 INFO - '_': '/tools/buildbot/bin/python'} 04:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:20 INFO - Downloading/unpacking blobuploader==1.2.4 04:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:22 INFO - Downloading blobuploader-1.2.4.tar.gz 04:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:10:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:10:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:23 INFO - Downloading docopt-0.6.1.tar.gz 04:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:10:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:10:23 INFO - Running setup.py install for blobuploader 04:10:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:10:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:10:23 INFO - Running setup.py install for requests 04:10:23 INFO - Running setup.py install for docopt 04:10:23 INFO - Successfully installed blobuploader requests docopt 04:10:23 INFO - Cleaning up... 04:10:23 INFO - Return code: 0 04:10:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:23 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')]} 04:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:23 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')]} 04:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:23 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 0x7f9106999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6090>, '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 0x13a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a9e40>, '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': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', '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 04:10:23 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 04:10:23 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 04:10:23 INFO - Using env: {'DISPLAY': ':0', 04:10:23 INFO - 'HOME': '/home/cltbld', 04:10:23 INFO - 'LANG': 'en_US.UTF-8', 04:10:23 INFO - 'LANGUAGE': 'en_US:en', 04:10:23 INFO - 'LOGNAME': 'cltbld', 04:10:23 INFO - 'MAIL': '/var/mail/cltbld', 04:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:23 INFO - 'MOZ_NO_REMOTE': '1', 04:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:23 INFO - 'NO_EM_RESTART': '1', 04:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:23 INFO - 'PWD': '/builds/slave/test', 04:10:23 INFO - 'SHELL': '/bin/bash', 04:10:23 INFO - 'SHLVL': '1', 04:10:23 INFO - 'TERM': 'linux', 04:10:23 INFO - 'TMOUT': '86400', 04:10:23 INFO - 'USER': 'cltbld', 04:10:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', 04:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:23 INFO - '_': '/tools/buildbot/bin/python'} 04:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:10:24 INFO - Running setup.py (path:/tmp/pip-71Q7xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:10:24 INFO - Running setup.py (path:/tmp/pip-bqudo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:10:24 INFO - Running setup.py (path:/tmp/pip-gEwsT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:10:24 INFO - Running setup.py (path:/tmp/pip-f3aXtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:10:24 INFO - Running setup.py (path:/tmp/pip-LFe0Qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:10:24 INFO - Running setup.py (path:/tmp/pip-owFT5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:10:24 INFO - Running setup.py (path:/tmp/pip-EVs5hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:10:24 INFO - Running setup.py (path:/tmp/pip-zKNKno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:10:24 INFO - Running setup.py (path:/tmp/pip-7RYMLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:10:24 INFO - Running setup.py (path:/tmp/pip-AK8omE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:10:24 INFO - Running setup.py (path:/tmp/pip-BmF5Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:24 INFO - Running setup.py (path:/tmp/pip-7QwQtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:24 INFO - Running setup.py (path:/tmp/pip-IZYQuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:25 INFO - Running setup.py (path:/tmp/pip-a_tMY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:25 INFO - Running setup.py (path:/tmp/pip-erU4Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:25 INFO - Running setup.py (path:/tmp/pip-1LEZeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:25 INFO - Running setup.py (path:/tmp/pip-o5ZgEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:10:25 INFO - Running setup.py install for manifestparser 04:10:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Running setup.py install for mozcrash 04:10:25 INFO - Running setup.py install for mozdebug 04:10:25 INFO - Running setup.py install for mozdevice 04:10:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Running setup.py install for mozfile 04:10:25 INFO - Running setup.py install for mozhttpd 04:10:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Running setup.py install for mozinfo 04:10:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:10:26 INFO - Running setup.py install for mozInstall 04:10:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:10:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:10:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:10:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:10:26 INFO - Running setup.py install for mozleak 04:10:26 INFO - Running setup.py install for mozlog 04:10:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:10:26 INFO - Running setup.py install for moznetwork 04:10:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:10:26 INFO - Running setup.py install for mozprocess 04:10:26 INFO - Running setup.py install for mozprofile 04:10:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:10:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:10:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:10:26 INFO - Running setup.py install for mozrunner 04:10:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:10:26 INFO - Running setup.py install for mozscreenshot 04:10:26 INFO - Running setup.py install for moztest 04:10:26 INFO - Running setup.py install for mozversion 04:10:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:10:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:10:27 INFO - Cleaning up... 04:10:27 INFO - Return code: 0 04:10:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:27 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')]} 04:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:27 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')]} 04:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:27 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 0x7f9106999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6090>, '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 0x13a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a9e40>, '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': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', '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 04:10:27 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 04:10:27 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 04:10:27 INFO - Using env: {'DISPLAY': ':0', 04:10:27 INFO - 'HOME': '/home/cltbld', 04:10:27 INFO - 'LANG': 'en_US.UTF-8', 04:10:27 INFO - 'LANGUAGE': 'en_US:en', 04:10:27 INFO - 'LOGNAME': 'cltbld', 04:10:27 INFO - 'MAIL': '/var/mail/cltbld', 04:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:27 INFO - 'MOZ_NO_REMOTE': '1', 04:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:27 INFO - 'NO_EM_RESTART': '1', 04:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:27 INFO - 'PWD': '/builds/slave/test', 04:10:27 INFO - 'SHELL': '/bin/bash', 04:10:27 INFO - 'SHLVL': '1', 04:10:27 INFO - 'TERM': 'linux', 04:10:27 INFO - 'TMOUT': '86400', 04:10:27 INFO - 'USER': 'cltbld', 04:10:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', 04:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:27 INFO - '_': '/tools/buildbot/bin/python'} 04:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:10:27 INFO - Running setup.py (path:/tmp/pip-DlnYdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:10:27 INFO - Running setup.py (path:/tmp/pip-KAInhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:10:27 INFO - Running setup.py (path:/tmp/pip-xdtH8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:10:27 INFO - Running setup.py (path:/tmp/pip-TiglAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:10:27 INFO - Running setup.py (path:/tmp/pip-9JkOEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:10:27 INFO - Running setup.py (path:/tmp/pip-33ZneT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:10:27 INFO - Running setup.py (path:/tmp/pip-KomngF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:10:27 INFO - Running setup.py (path:/tmp/pip-hEYMti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:10:27 INFO - Running setup.py (path:/tmp/pip-mdWoBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:10:27 INFO - Running setup.py (path:/tmp/pip-gNnVMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:10:28 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)) 04:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:10:28 INFO - Running setup.py (path:/tmp/pip-ZLiFfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:28 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)) 04:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:28 INFO - Running setup.py (path:/tmp/pip-qIEsj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:28 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)) 04:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:28 INFO - Running setup.py (path:/tmp/pip-vpfpuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:28 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)) 04:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:28 INFO - Running setup.py (path:/tmp/pip-q4zOff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:28 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)) 04:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:28 INFO - Running setup.py (path:/tmp/pip-NrmyDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:28 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)) 04:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:28 INFO - Running setup.py (path:/tmp/pip-HXFhT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10:28 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)) 04:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:28 INFO - Running setup.py (path:/tmp/pip-magcnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10:28 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)) 04:10:28 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)) 04:10:28 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)) 04:10:28 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)) 04:10:28 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)) 04:10:28 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)) 04:10:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:10:28 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 04:10:28 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 04:10:28 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 04:10:28 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 04:10:28 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 04:10:28 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 04:10:30 INFO - Downloading blessings-1.6.tar.gz 04:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:10:30 INFO - Installing collected packages: blessings 04:10:30 INFO - Running setup.py install for blessings 04:10:30 INFO - Successfully installed blessings 04:10:30 INFO - Cleaning up... 04:10:30 INFO - Return code: 0 04:10:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:10:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:31 INFO - Reading from file tmpfile_stdout 04:10:31 INFO - Current package versions: 04:10:31 INFO - argparse == 1.2.1 04:10:31 INFO - blessings == 1.6 04:10:31 INFO - blobuploader == 1.2.4 04:10:31 INFO - docopt == 0.6.1 04:10:31 INFO - functools32 == 3.2.3-2 04:10:31 INFO - jsonschema == 2.5.1 04:10:31 INFO - manifestparser == 1.1 04:10:31 INFO - mozInstall == 1.12 04:10:31 INFO - mozcrash == 0.17 04:10:31 INFO - mozdebug == 0.1 04:10:31 INFO - mozdevice == 0.48 04:10:31 INFO - mozfile == 1.2 04:10:31 INFO - mozhttpd == 0.7 04:10:31 INFO - mozinfo == 0.9 04:10:31 INFO - mozleak == 0.1 04:10:31 INFO - mozlog == 3.3 04:10:31 INFO - moznetwork == 0.27 04:10:31 INFO - mozprocess == 0.23 04:10:31 INFO - mozprofile == 0.28 04:10:31 INFO - mozrunner == 6.12 04:10:31 INFO - mozscreenshot == 0.1 04:10:31 INFO - mozsystemmonitor == 0.3 04:10:31 INFO - moztest == 0.7 04:10:31 INFO - mozversion == 1.4 04:10:31 INFO - psutil == 3.1.1 04:10:31 INFO - requests == 1.2.3 04:10:31 INFO - wsgiref == 0.1.2 04:10:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:31 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 0x7f9106999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6090>, '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 0x13a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a9e40>, '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': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', '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 04:10:31 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 04:10:31 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 04:10:31 INFO - Using env: {'DISPLAY': ':0', 04:10:31 INFO - 'HOME': '/home/cltbld', 04:10:31 INFO - 'LANG': 'en_US.UTF-8', 04:10:31 INFO - 'LANGUAGE': 'en_US:en', 04:10:31 INFO - 'LOGNAME': 'cltbld', 04:10:31 INFO - 'MAIL': '/var/mail/cltbld', 04:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:31 INFO - 'MOZ_NO_REMOTE': '1', 04:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:31 INFO - 'NO_EM_RESTART': '1', 04:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:31 INFO - 'PWD': '/builds/slave/test', 04:10:31 INFO - 'SHELL': '/bin/bash', 04:10:31 INFO - 'SHLVL': '1', 04:10:31 INFO - 'TERM': 'linux', 04:10:31 INFO - 'TMOUT': '86400', 04:10:31 INFO - 'USER': 'cltbld', 04:10:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', 04:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:31 INFO - '_': '/tools/buildbot/bin/python'} 04:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:31 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)) 04:10:31 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)) 04:10:31 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)) 04:10:31 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)) 04:10:31 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)) 04:10:31 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)) 04:10:31 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)) 04:10:31 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)) 04:10:31 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)) 04:10:31 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)) 04:10:31 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)) 04:10:31 INFO - Cleaning up... 04:10:31 INFO - Return code: 0 04:10:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:31 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 0x7f9106999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ac230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a6090>, '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 0x13a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a9e40>, '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': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', '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 04:10:31 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 04:10:31 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 04:10:31 INFO - Using env: {'DISPLAY': ':0', 04:10:31 INFO - 'HOME': '/home/cltbld', 04:10:31 INFO - 'LANG': 'en_US.UTF-8', 04:10:31 INFO - 'LANGUAGE': 'en_US:en', 04:10:31 INFO - 'LOGNAME': 'cltbld', 04:10:31 INFO - 'MAIL': '/var/mail/cltbld', 04:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:31 INFO - 'MOZ_NO_REMOTE': '1', 04:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:31 INFO - 'NO_EM_RESTART': '1', 04:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:31 INFO - 'PWD': '/builds/slave/test', 04:10:31 INFO - 'SHELL': '/bin/bash', 04:10:31 INFO - 'SHLVL': '1', 04:10:31 INFO - 'TERM': 'linux', 04:10:31 INFO - 'TMOUT': '86400', 04:10:31 INFO - 'USER': 'cltbld', 04:10:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', 04:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:31 INFO - '_': '/tools/buildbot/bin/python'} 04:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:10:31 INFO - Cleaning up... 04:10:31 INFO - Return code: 0 04:10:31 INFO - Running post-action listener: _resource_record_post_action 04:10:31 INFO - Running post-action listener: _start_resource_monitoring 04:10:31 INFO - Starting resource monitoring. 04:10:31 INFO - [mozharness: 2016-08-27 11:10:31.566597Z] Finished create-virtualenv step (success) 04:10:31 INFO - [mozharness: 2016-08-27 11:10:31.567062Z] Running install step. 04:10:31 INFO - Running pre-action listener: _resource_record_pre_action 04:10:31 INFO - Running main action method: install 04:10:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:31 INFO - Reading from file tmpfile_stdout 04:10:31 INFO - Detecting whether we're running mozinstall >=1.0... 04:10:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:10:31 INFO - Reading from file tmpfile_stdout 04:10:31 INFO - Output received: 04:10:31 INFO - Usage: mozinstall [options] installer 04:10:31 INFO - Options: 04:10:31 INFO - -h, --help show this help message and exit 04:10:31 INFO - -d DEST, --destination=DEST 04:10:31 INFO - Directory to install application into. [default: 04:10:31 INFO - "/builds/slave/test"] 04:10:31 INFO - --app=APP Application being installed. [default: firefox] 04:10:31 INFO - mkdir: /builds/slave/test/build/application 04:10:31 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'] 04:10:31 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 04:10:48 INFO - Reading from file tmpfile_stdout 04:10:48 INFO - Output received: 04:10:48 INFO - /builds/slave/test/build/application/firefox/firefox 04:10:48 INFO - Running post-action listener: _resource_record_post_action 04:10:48 INFO - [mozharness: 2016-08-27 11:10:48.874688Z] Finished install step (success) 04:10:48 INFO - [mozharness: 2016-08-27 11:10:48.874970Z] Running run-tests step. 04:10:48 INFO - Running pre-action listener: _resource_record_pre_action 04:10:48 INFO - Running main action method: run_tests 04:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:10:48 INFO - Python 2.7.3 04:10:48 INFO - Return code: 0 04:10:48 INFO - grabbing minidump binary from tooltool 04:10: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')]} 04:10:48 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 0x13a6090>, '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 0x13a99b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a9e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:10:48 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 04:10:48 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 04:10:48 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 04:10:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:10:48 INFO - Return code: 0 04:10:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:10:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:10:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:10:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:10:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 04:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 04:10:48 INFO - Using env: {'DISPLAY': ':0', 04:10:48 INFO - 'HOME': '/home/cltbld', 04:10:48 INFO - 'LANG': 'en_US.UTF-8', 04:10:48 INFO - 'LANGUAGE': 'en_US:en', 04:10:48 INFO - 'LOGNAME': 'cltbld', 04:10:48 INFO - 'MAIL': '/var/mail/cltbld', 04:10:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:48 INFO - 'MOZ_NO_REMOTE': '1', 04:10:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:48 INFO - 'NO_EM_RESTART': '1', 04:10:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:48 INFO - 'PWD': '/builds/slave/test', 04:10:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:48 INFO - 'SHELL': '/bin/bash', 04:10:48 INFO - 'SHLVL': '1', 04:10:48 INFO - 'TERM': 'linux', 04:10:48 INFO - 'TMOUT': '86400', 04:10:48 INFO - 'USER': 'cltbld', 04:10:48 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543', 04:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:48 INFO - '_': '/tools/buildbot/bin/python'} 04:10:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 04:10:49 INFO - mozversion application_buildid: 20160827013002 04:10:49 INFO - mozversion application_changeset: 88248d124b9a88885740b78114be1b11576b4dbc 04:10:49 INFO - mozversion application_display_name: Nightly 04:10:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:10:49 INFO - mozversion application_name: Firefox 04:10:49 INFO - mozversion application_remotingname: firefox 04:10:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:10:49 INFO - mozversion application_vendor: Mozilla 04:10:49 INFO - mozversion application_version: 51.0a1 04:10:49 INFO - mozversion platform_buildid: 20160827013002 04:10:49 INFO - mozversion platform_changeset: 88248d124b9a88885740b78114be1b11576b4dbc 04:10:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:10:49 INFO - mozversion platform_version: 51.0a1 04:10:49 INFO - using testdate: 1472296249 04:10:49 INFO - actual date: 1472296249 04:10:49 INFO - starting webserver on 'localhost:38385' 04:10:49 INFO - SUITE-START | Running 2 tests 04:10:49 INFO - TEST-START | dromaeo_css 04:10:49 INFO - operating with platform_type : linux_ 04:10:49 INFO - Initialising browser for dromaeo_css test... 04:10:49 INFO - TEST-INFO | started process 23348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3DOhJg/profile http://localhost:38385/getInfo.html) 04:10:53 INFO - PROCESS | 23348 | __metrics Screen width/height:1600/1200 04:10:53 INFO - PROCESS | 23348 | colorDepth:24 04:10:53 INFO - PROCESS | 23348 | Browser inner width/height: 1024/697 04:10:53 INFO - PROCESS | 23348 | __metrics 04:10:53 INFO - PROCESS | 23348 | 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" 04:10:53 INFO - PROCESS | 23348 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:10:54 INFO - PROCESS | 23348 | console.error: PushService: 04:10:54 INFO - PROCESS | 23348 | stateChangeProcessEnqueue: Error transitioning state 04:10:54 INFO - PROCESS | 23348 | UnknownError 04:10:54 INFO - TEST-INFO | 23348: exit 0 04:10:54 INFO - Browser initialized. 04:10:54 INFO - Running cycle 1/1 for dromaeo_css test... 04:10:54 INFO - TEST-INFO | started process 23428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3DOhJg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:06 INFO - PROCESS | 23428 | RSS: Main: 178847744 04:11:06 INFO - PROCESS | 23428 | 04:11:57 INFO - PROCESS | 23428 | 1472296317830 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] 04:14:08 INFO - PROCESS | 23428 | Cycle 1(1): loaded http://localhost:38385/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38385/tests/dromaeo/cssquery-ext.html) 04:14:09 INFO - PROCESS | 23428 | RSS: Main: 296452096 04:14:09 INFO - PROCESS | 23428 | 04:17:12 INFO - PROCESS | 23428 | Cycle 1(1): loaded http://localhost:38385/tests/dromaeo/cssquery-ext.html (next: http://localhost:38385/tests/dromaeo/cssquery-jquery.html) 04:17:12 INFO - PROCESS | 23428 | RSS: Main: 280281088 04:17:12 INFO - PROCESS | 23428 | 04:20:14 INFO - PROCESS | 23428 | Cycle 1(1): loaded http://localhost:38385/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38385/tests/dromaeo/cssquery-mootools.html) 04:20:15 INFO - PROCESS | 23428 | RSS: Main: 256671744 04:20:15 INFO - PROCESS | 23428 | 04:23:17 INFO - PROCESS | 23428 | Cycle 1(1): loaded http://localhost:38385/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38385/tests/dromaeo/cssquery-prototype.html) 04:23:17 INFO - PROCESS | 23428 | RSS: Main: 254746624 04:23:17 INFO - PROCESS | 23428 | 04:26:20 INFO - PROCESS | 23428 | Cycle 1(1): loaded http://localhost:38385/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38385/tests/dromaeo/cssquery-yui.html) 04:26:21 INFO - PROCESS | 23428 | RSS: Main: 215117824 04:26:21 INFO - PROCESS | 23428 | 04:29:24 INFO - PROCESS | 23428 | Cycle 1(1): loaded http://localhost:38385/tests/dromaeo/cssquery-yui.html (next: http://localhost:38385/tests/dromaeo/cssquery-dojo.html) 04:29:24 INFO - PROCESS | 23428 | RSS: Main: 304287744 04:29:24 INFO - PROCESS | 23428 | 04:29:24 INFO - PROCESS | 23428 | __start_tp_report 04:29:24 INFO - PROCESS | 23428 | _x_x_mozilla_page_load 04:29:24 INFO - PROCESS | 23428 | _x_x_mozilla_page_load_details 04:29:24 INFO - PROCESS | 23428 | |i|pagename|runs| 04:29:24 INFO - PROCESS | 23428 | |0;dojo.html;2995.385945881095;3054.0532434945153;3054.9847250763746;3086.1513083901937;3111.782175247732;5236.1098613235745;5299.735013249337;5320.042392369372;5344.251804747339;5352.678839269642;5315.202719592054;5347.0909945309295;5395.109806881869;5457.481539253775;5512.39363669996;4833.637477189207;4852.660313778037;4863.319135321058;4870.050340183666;5024.9748751256375;4910.975445122769;4970.875728106808;4981.1532039553185;4985.825496107637;4990.600751939836;4762.214234651278;4793.343854251982;4848.903021939576;4877.414710234794;4941.629377796662;4782.569568738831;4811.735354555498;4816.927746083811;4818.445878723956;4929.482404347564;4808.831690890837;4840.709557426566;4853.805847766085;4856.927146092811;4901.387326584177;5251.422343542207;5288;5329.706866122362;5354.839354819362;5358.437364076754;5700.344460387067;5713.228714123623;5725.856853578653;5726.284214473191;5739.139129130622;5774.335951365605;5778.6243894147165;5782.421757824226;5785;5791.768329266824;5275.604329675251;5315.468453154731;5318.70747108905;5335.413104558495;5412.350517937873;5833.82498525045;5860.765569377178;5864.648121112747;5866.061430171152;5875.41245875409;5602.859928501739;5605.943940560624;5614.578906582023;5616.85957851057;5651.717414129359;5495.670259784426;5660.716964151776;5723.341815691166;5743.684097374601;5805;5724.370319264877;5725.8568535786935;5731.025725626653;5731.742071606787;5732.77068917247;5679.375268720438;5720.885582288331;5735.856603584861;5752.884942301131;5755.654660720286;4307.5477074906685;4387.012922092567;4388.824447022147;4389.868303950822;4417.2269852775635;3935.665468435158;3974.880753577397;3975.920481590352;4011.3180759270995;4032.213718324957;5410.945890541123;5419;5421;5423.186522021729;5424.918626220609;5554.777808887599;5688.146777983336;5734.856628584235;5744.971275143597;5745.425457454221;5387.865303367447;5434.8913021739345;5440.591955603346;5494.587905907073;5503.174523821459;4944.752762361867;4948.925766113512;4961.50384961501;4963.429205641325;4969.204927211629;5777.277840269966;5900.409959004237;5957.106434034929;5965.164876917148;5966.701664916737;5758.395368486249;5758.683272420057;5764.481196692318;5816.331121921034;5838.532917366516;5916.437938395846;5939.821805345847;5958.612690175125;5960.254968128984;5967.731452084579;5559.082751345983;5593.300837395325;5663.85840353978;5665.688387138582;5680.204771331934;5698.857528561653;5750.338711048283;5750.568707347049;5808.361080281081;5817.069268916953;5581.6371935824045;5628.380878103487;5628.971855140698;5633.464820842013;5638.013347664224;5499.917501237404;5562.415946325577;5584.776608935597;5591.6365436246515;5591.692456914746;5590.860228494157;5611.186377975089;5623.971880140573;5684.658920464785;5685.687287199244;5616.943830561642;5622.072358061037;5623.522000629829;5629.408912064175;5644.238027866186;5387.2727181831515;5402.702851343057;5520.861978450571;5530.253415788817;5530.5022547970875 04:29:24 INFO - PROCESS | 23428 | |1;ext.html;554.8474169603359;597.1967703438875;616.1527899138684;616.5714828194407;623.2645478335568;31505.68494315056;32472.512912306305;34819.47770783434;34854.128646783814;42633;41672.37491437623;44043.3393499097;45062;45203.32195017077;46186.690665466675;8987.955060224705;9124.908750912506;9125.178733913946;9132.543372831331;9134.36059475837;8138;8985.505797181153;9086.091390860927;9088.227500662451;10536.683899483029;10631.468426578678;11042.116630669567;11042.3374597524;11042.779144417107;11071.72320691981;10918.945405272963;10976.902309769039;10996.725081872977;10999.285046472034;11004.504797284062;10772.78454430907;10841.512131954081;10847.728806779814;10856.185786065998;10858.23992320538;43258.567414326084;43450.782746086064;43527.56472435267;43547.379208638675;43692.563074369165;3475.669811367916;3592.3892938200306;3688.8708895188806;3858.672012878909;4161.646260067898;32449;32929.835350823094;32987.34025319504;33072.6692733072;34032.829835850665;4459.197344477992;4531.660125490602;4541.159885421174;4605.0559635274685;4672.299155126724;344720;345694;346978.9999999975;348481;349105;56839.14741278884;57070.7146464265;57137.71431142901;57169.714151429805;57265.71367143221;59472;59947.100793488135;60033;60254.69872650609;60331.396686033455;16599.170041498117;17159.28407159299;17200.053997030034;17202.827971720373;17204.569885752706;13135.408906599227;13206.405711742995;13313.534026309033;13339;13351.799723004162;15578.766318505232;16142.677146457005;16165.35338586467;16193.433229836899;16216.10811405384;6372.58578192416;6629.436497897636;6671.86656266872;6678.766243181465;6721.5967041976655;873.8208667223204;953;969.709087273815;1000.7748256642197;1028.6091285311684;29604.851975739984;29784.702152978625;30512.694873050987;31129.377412451624;31395;998.55065220651;1014.1177175857051;1018.5976539266948;1070.8607880975424;1073.1575713065206;16006.279717412745;16125.919370403073;16147.596310092107;16422.507324780276;16503.91748041252;481778;486553;488676;488810;490162;57261;57439;57653;57756.4224357751;58092.12861807076;1201.0991756182864;1321.8876395506297;1349.878510934001;1350.2438634364983;1362.768329384007;30041.849790750908;31352.843235783675;32779;32811.67188328086;33323;48945;49645;49664.50335496743;49829.50170498394;49849;397045;401006;401852;402215;402342;33869;39070.218595628496;39855.2028959425;40621.390679139244;42594.361084583135;47007.52992470031;47272.7636361816;47334.52665473439;47444;47532;39777.80111099426;40953;40968.79515602403;41516.79241603773;42686.78656606697;39971.40042899417;40462.39306410465;40827.10030886556;42016.36975445432;42024.36963445612;39928.60071399365;40534.39198412085;40973.79513102535;41023.7948810254;41043.58956410517;33786;36229;36869.81565092158;36952.26095478129;37466.43800342942;27198.320041999108;27540.862295688392;27617.171484855488;27749.722502775523;27853.86073069622 04:29:24 INFO - PROCESS | 23428 | |2;jquery.html;383.19146600672593;400.2655127840413;401.93769965655315;409.5719972628603;414.1489239612597;15776.211189440524;19114.33099841506;19136.617267654656;19331.42005739828;20129.798702012977;11900.46447909844;12596.93701531491;12720.55478058268;12879.162854414457;12884.613461596167;5223.6343455958095;5468.890622187554;5469.386530973353;5469.535089517376;5470.124780035195;5358.437364076774;5441.129419292914;5678.233438485813;5914.822555323347;5928.88142237155;5996.580239383245;6004.96997515014;6007.038873780196;6011;6011.519078473733;5867.88264234715;5941.910871336933;5959.225300710923;5977.163197152402;5983.042713165873;5643.125315576092;5780.16187652788;5783.739731712083;5792.131180322943;5793.217915581385;12327.69180770479;12548.74902501954;12554.874451255462;12565.371731413485;12629;2284.3191523011224;2304.0221502558784;2310.318456055468;2327.8719670418122;2365.633326834326;10104.94947525265;10109.191264698806;10168.694939151837;10349.793004139876;10365.118964887994;1833.6791061564172;1863.7018077107598;1892.9399536259739;1951.687729963199;1970.5369238229005;57626.135607965916;75342.24657753407;82668.9999999994;85448.57275713644;87736;10886.836697449544;11072.667819965414;11178.807947019868;11279.379634120038;11286.209965302514;15687.215639218222;15747.370105195663;15756.133412662184;15771.763423548657;15819.05085694862;7982.600869956479;8436.873446898302;8461.576921153917;8537.402381833212;8666.133386661284;8042.597870106471;8087.069986951576;8124.918750812534;8314.251717345467;8339.249467547828;4656.650751193606;4788.257820037899;4803.855884323476;4920.72935988524;4929.285253638274;1974.5261137327225;2002.7196192533056;2019.858609897293;2024.3399216577295;2029.1274751856843;948.2887834124407;974.7660561465198;992.6624947517879;1011.9494025298706;1024.2318261304022;19347.226110955406;19552.90223548873;19834.801651983296;19882.70175947362;20085;949.943003419797;967.1827305926621;996.6561536269975;1003.6437064842022;1067.9466026698633;10300.424903748311;10865.972690281771;10867.130629549618;10874.72813179661;10907.345559266469;455360;456295;463176;466585;469980.95028574596;91790.54104729433;92537;93042.53478732563;93052.53473732588;94356;1008.5612758450097;1009.3237530854345;1010.8989101089979;1025.8307379282335;1030.4538594544904;16411;16962.575935601708;17236.655266894842;17577.29690812353;17924.820751792315;42121.34136060181;42183.83621228359;42344.57655423407;43206.99999999874;43461.348079778196;56632.71683641555;58237.70881145567;58710;59736.402635973085;59877;8173;8213.54825484604;8336.291415229773;8341.874871876806;8430.40987130895;10931.289466184673;11165.72085697864;11555.537778488766;12291.446884890023;12400.875991239973;10673.092787113183;10742.355458672504;10764.461776910966;10783.568657253621;10881.347119172875;10008.39949603026;10469.162467002468;10738.677839664822;10981.670549883516;11402.94298528502;10036.447995360326;10375.27373083877;10418.374897506174;10484.318519296221;10812.5134368952;8066.637001334837;8103.594820259082;8234.505929644241;8275.83448331018;8318.70884519039;10409.375437473776;10427.791444170922;10517.947410263207;10637.468126593794;10810.18923580719 04:29:24 INFO - PROCESS | 23428 | |3;mootools.html;1357.151780137414;1474.262868565717;1498.2358996911576;1618.5791694159516;1783.9464816055515;8274.586270686472;8601.440906341091;8690.261327787146;8958;8991.460512369262;8795.120487951202;8918.643254269839;8918.821623567525;8927.41971771836;8982.37123401362;2065.039756513221;2344.613138832099;2405.1341517053847;2434.123715462441;2434.2818868433765;2371.1700904683307;2382.7855493005627;2384.582698027847;2389.904403823845;2399.4121440247077;2346.77705617966;2350.788429041386;2361.067378385537;2391.449966507704;2392.9880350598223;2300.700908881843;2316.3745788637057;2337.8480398774027;2406.470576473173;2410.8191885608476;2382.2376839411395;2413.734489206186;2426.478307163968;2430.538197742423;2432.5013372258645;8554.05905350411;8691.521966291852;8694.739157825212;8701;8708.259797917184;5250.737463126867;5397.3523177218985;5403.891922161574;5405.243265942771;5410.1073322901675;3236.514522821572;3375.6118046424485;3430.879919202841;3433.9656603433896;3437.673421024999;1118.927269727465;1150.1833698074377;1160.7388337623968;1169.6783384569226;1198.1433275208267;12191.573294934724;12452.81320780189;12459.06557008228;12474;12482.375881205904;4355.869323920288;4522.3668686383935;4707.7175369477945;4727.581725482341;4742.217534106834;10516.053555180071;10516.158707303397;10521.473926303654;10525.789484210272;10530.262881598368;5283.788648454096;5345.9732701337025;5348.3849357323625;5348.545373643206;5387.488188622153;4401.911961760811;4798.448178459522;4844.515548445127;4888.584470319992;4892.730899800474;4017.116234428421;4045.1707399982934;4130.772807495617;4135.110951145458;4178.101708132766;1352.9729405411836;1362.6033315851332;1364.7543442180504;1379.3930670504947;1379.8965077619218;941.5104145844259;952.828490871636;956.7464621875208;965.946872921996;992.2607657295217;5570.442955704397;5602.411746766531;5687.77248910039;5766.682832444172;6002.609830361012;449.6200710399707;450.8782628690301;451.93672885796013;453.11416181365354;458.63996762541245;3720.795356255378;3792.412176112707;3855.556610989716;3877.6703980161437;3959.5644479107277;10816.891831081588;11054.668359949215;11141.108711303077;11142.944285278683;11153.163512736415;10415.791684166274;10729.9463502682;10858.294210876267;11004.064654504456;11280.09759219277;8021.7994550135545;8104.203999980106;8113.5131892086665;8188.7952801180445;8192.221738934792;5830.591858569859;5875.794347197828;5944.167816505779;5975.223220981245;5995.280566332068;9799.608015679292;9877.703668889944;9953.701388958343;10163.23775716839;10229.48852557384;10193.84709229377;10349.9482502587;10363.378197308186;10430.58277668915;10547.57809687604;6946.4095551876635;7738.187490313436;7893.052833659997;7979.361651068017;8115.066767321833;8683.782905427415;8738.082501337269;8752.69365572202;8809.383343165917;8810.779730506789;7671.808204794925;7676.385889128745;7778.338841198562;7923.6830526778285;7952.52284862887;7637.809054773675;7639.197884222299;7716.2669546393;7745.302922736755;7771.883421748791;6964.721411143498;7059.647017649199;7103.964480177566;7134.964325178341;7150.463715221275;5137.614678899172;5200.5059519345605;5254.894902102013;5298.3906850712665;5483.917741233805;5103.8468845934685;5116.718580478109;5167.509086636764;5172.948270517397;5355.758990845499 04:29:24 INFO - PROCESS | 23428 | |4;prototype.html;314.24424259655535;325.7719596282602;329.5764942049467;331.40181971541375;334.3079824762741;5106.489351064892;5162.6644268122545;5280.260763493114;5309.30978972733;5342.572594192465;5214.296070030545;5247.973760131204;5258.395284542279;5288.92066619001;5344.4922732340465;4207.368894665794;4208.873733787991;4211.1998720243055;4219.607529515268;4220.894477638053;3984.9203015939665;4138.8344466221315;4195.433616461784;4200.075983283673;4201.264778663737;4089.3457046872504;4090.1615168890453;4127.752334859903;4132.690048246379;4136.400221967813;4071.1450595375154;4094.1197642506854;4100.753954762724;4109.506859176888;4132.648724858391;3656.725745569093;3657.738080362271;3662.212624285765;3676.209614932802;3691.53855768029;5128.410232823236;5139.8458046258675;5148.742562871841;5150.227465880148;5176.844694659167;4656.068786242765;4667.436408803055;4672.486026537078;4682.578567928868;4690.0854333405;5357.1696387060065;5499.340079190482;5500.80747173851;5522.199281104217;5531.529819965308;3899.317619416619;3924.9803750981346;3933.7836418996944;3937.3503371943593;3949.2101579684177;5668.773249070032;5672.773089076432;5686.232358631614;5698.831739493394;5708.372079071258;4005.559388467266;4048.7975601219823;4057.655099316532;4067.389891516237;4070;3884.8640297590014;4051.6353528182603;4055.797210139481;4066.3290557058344;4113;4611.118051217989;4612.7001744886475;4618.376519169869;4623.930641040387;4626.1441633297945;5484.8354549363585;5507.504324610804;5510.531604813636;5521.1442226454965;5552.41699621542;1322.578228404469;1339.9933000334936;1368.2269517722455;1383.2323060701206;1395.9790603140962;947.7251597036782;953.8351709367834;962.3167551038841;971.1939090554822;977.4819345746765;5325.162818827498;5327.360716714019;5327.946720532745;5331.653442526223;5360.490753378423;5585.69278689676;5586.51957231334;5589.496945274945;5594.412586678422;5602.719864006784;5178.352705911761;5276.81531146408;5318.627696061316;5327.280817089721;5334.733263336818;2617.3718307606036;2619.188051703978;2622.763951244397;2634.6970098438924;2662.9067982620513;5079.161938280143;5092.9236061459105;5125.538701516882;5144.459831717691;5171.224316352502;4816.566509014206;5059.822906198266;5060.9119039406705;5065.316182315414;5101.438841727407;5069.670471419346;5102.719350435687;5141.742912854417;5145.588352931832;5157.484251574888;4955.380577427822;4957.900841983213;4966;4982.55157035854;5038.622103342191;4612.423447069116;4833.830815921426;4920.335754673073;4941.43173535048;4950.752462376939;5088.44027157005;5126.256692779601;5129.769160387867;5135.845924622267;5136.606563108646;3698.981505092565;3703.203811180609;3711.183539621279;3726.552813662378;3752.793596352227;5084.51697088776;5091.345312773437;5280.920786188287;5449.7002664852225;5691.8861622768145;5491.75287112073;5543.25166102571;5560.888782224252;5579.13523403873;5600.691961942132;5457.645253058538;5544.556435485232;5545.916811247916;5580.693061881636;5615.939313074303;5331.9466805333;5464.426235245242;5505.807296744595;5562.747087429598;5564.860878478071;5545.972270138624;5581.944180558143;5601.103823388401;5607.719614019201;5620.718964051863;5483.4516548344845;5503;5503.449655034625;5524.315083899449;5535.667859928417 04:29:24 INFO - PROCESS | 23428 | |5;yui.html;765.2768134113259;801.9117897031325;807.9111297757246;810.7486679129474;837.3385025829593;15022.173780442072;15426.228688565583;15536.68926621467;15590.220488975549;15620.453284135072;15131.470398536054;15312.540623781304;15330.616734581641;15342.309596068177;15353.462628807994;657.6350125680245;788.1724189600925;828.7140936376941;830.4062595244399;831.2477208126655;820.0978923184479;820.4666966471782;822.8025273934243;827.896512935883;829.929455996241;871.9694810681627;875.4965894610592;879.0242830458186;879.1867522541655;879.4855009819263;690.1200968764815;846.9872951905726;855.6106971328031;861.961211745473;870.9608067636908;637.4708991537013;638.3999040901584;638.7540796793221;639.0701529274894;639.3031595560815;14931.40274389034;14936.775948360782;15102.54692359231;15129.697406051817;15135.772963405558;14892.404303827834;14924.25378731059;14931.328090235966;15166.393344266216;15306;13773.655658608515;13806.65483362924;13871.514496992557;14020.789688154686;14113.153210807384;4371.431713877208;4458.3535387368975;4488.4165058542185;4581.518940511231;4618;81281;82456.58771706103;83017.58491207505;84247.15752842455;84928.57535712281;11682.240654357609;11704.531818727326;11800.232984855957;11964.102692298113;12073;18935.81064189368;19095.52261193481;19108.522286942938;19344.70982935257;19453.610927781367;8667.913320866837;8683.609237584324;8705.91294087051;8727.825443491094;8838.160374764388;4676.111538807616;4680.110778951988;4704.847312408413;4779.808807647655;4871.098846713369;3386.492026196041;3492.9126771830906;3495.7552971291766;3498.5626796650417;3499.2476617527354;532.7176596403912;575.077001412735;585.2274997003999;585.9677717725481;640.1677818835495;689.6551724137931;709.4359983812881;709.9964500177466;716.6058667732726;721.5490318550906;8352.707655232038;9122.589483473259;9268.314477335507;9518.190953769008;9670.661526846667;657.3754932813846;704.0530486495655;741.5983790635703;755.3004847007082;758.2531206761336;4361.476622805284;4471;4534.2971839364955;4569.1547063793305;4618.891466048124;119559.40220298842;123258.38370808268;124301.37849310695;130897;131032.3448382752;103681;107940;109746;110593.44703276432;113369.4331528337;57653.423465764805;89086;92118.53940730388;92183;93127;8265.132161123236;8318.251357377865;8323.958380208302;8546.529940853065;8761.956190219009;39793.80103099582;52047;54486.7275663635;55506.72246638902;56322.71838640945;76644.61677691576;77769;79957;80492;82494;12351;12832.358382081045;12965.351732413154;13050.34748262602;13342.466301348226;13561.864381356454;13669.453221871412;13927;14415.33316336481;15419.61450963735;13161.736765264832;13435.261060641758;13567.38946747379;13918.721625567634;13977.301134943009;12574.182678125893;12795.104342695922;12807.61577152687;13261.867381326449;14284.35720392564;12002.879971200176;12105.273683579013;12282.447289872156;12928.806067908801;13786.862131378959;12324.876751232372;12464.127511074501;12678.492860285485;12778;13131.439369323272;12120.393980301125;12326.50693972231;12341.444634991267;12655;12724.109312348046 04:29:24 INFO - PROCESS | 23428 | __end_tp_report 04:29:24 INFO - PROCESS | 23428 | __start_cc_report 04:29:24 INFO - PROCESS | 23428 | _x_x_mozilla_cycle_collect,983 04:29:24 INFO - PROCESS | 23428 | __end_cc_report 04:29:24 INFO - PROCESS | 23428 | __startTimestamp1472297364307__endTimestamp 04:29:24 INFO - PROCESS | 23428 | 04:29:24 INFO - PROCESS | 23428 | ------- Summary: start ------- 04:29:24 INFO - PROCESS | 23428 | Number of tests: 6 04:29:24 INFO - PROCESS | 23428 | 04:29:24 INFO - PROCESS | 23428 | [#0] dojo.html Cycles:165 Average:5327.24 Median:5554.78 stddev:604.65 (10.9%) stddev-sans-first:578.17 04:29:24 INFO - PROCESS | 23428 | Values: 2995.4 3054.1 3055.0 3086.2 3111.8 5236.1 5299.7 5320.0 5344.3 5352.7 5315.2 5347.1 5395.1 5457.5 5512.4 4833.6 4852.7 4863.3 4870.1 5025.0 4911.0 4970.9 4981.2 4985.8 4990.6 4762.2 4793.3 4848.9 4877.4 4941.6 4782.6 4811.7 4816.9 4818.4 4929.5 4808.8 4840.7 4853.8 4856.9 4901.4 5251.4 5288.0 5329.7 5354.8 5358.4 5700.3 5713.2 5725.9 5726.3 5739.1 5774.3 5778.6 5782.4 5785.0 5791.8 5275.6 5315.5 5318.7 5335.4 5412.4 5833.8 5860.8 5864.6 5866.1 5875.4 5602.9 5605.9 5614.6 5616.9 5651.7 5495.7 5660.7 5723.3 5743.7 5805.0 5724.4 5725.9 5731.0 5731.7 5732.8 5679.4 5720.9 5735.9 5752.9 5755.7 4307.5 4387.0 4388.8 4389.9 4417.2 3935.7 3974.9 3975.9 4011.3 4032.2 5410.9 5419.0 5421.0 5423.2 5424.9 5554.8 5688.1 5734.9 5745.0 5745.4 5387.9 5434.9 5440.6 5494.6 5503.2 4944.8 4948.9 4961.5 4963.4 4969.2 5777.3 5900.4 5957.1 5965.2 5966.7 5758.4 5758.7 5764.5 5816.3 5838.5 5916.4 5939.8 5958.6 5960.3 5967.7 5559.1 5593.3 5663.9 5665.7 5680.2 5698.9 5750.3 5750.6 5808.4 5817.1 5581.6 5628.4 5629.0 5633.5 5638.0 5499.9 5562.4 5584.8 5591.6 5591.7 5590.9 5611.2 5624.0 5684.7 5685.7 5616.9 5622.1 5623.5 5629.4 5644.2 5387.3 5402.7 5520.9 5530.3 5530.5 04:29:24 INFO - PROCESS | 23428 | 04:29:24 INFO - PROCESS | 23428 | [#1] ext.html Cycles:180 Average:57891.65 Median:39950.00 stddev:109744.25 (274.7%) stddev-sans-first:109967.67 04:29:24 INFO - PROCESS | 23428 | Values: 554.8 597.2 616.2 616.6 623.3 31505.7 32472.5 34819.5 34854.1 42633.0 41672.4 44043.3 45062.0 45203.3 46186.7 8988.0 9124.9 9125.2 9132.5 9134.4 8138.0 8985.5 9086.1 9088.2 10536.7 10631.5 11042.1 11042.3 11042.8 11071.7 10918.9 10976.9 10996.7 10999.3 11004.5 10772.8 10841.5 10847.7 10856.2 10858.2 43258.6 43450.8 43527.6 43547.4 43692.6 3475.7 3592.4 3688.9 3858.7 4161.6 32449.0 32929.8 32987.3 33072.7 34032.8 4459.2 4531.7 4541.2 4605.1 4672.3 344720.0 345694.0 346979.0 348481.0 349105.0 56839.1 57070.7 57137.7 57169.7 57265.7 59472.0 59947.1 60033.0 60254.7 60331.4 16599.2 17159.3 17200.1 17202.8 17204.6 13135.4 13206.4 13313.5 13339.0 13351.8 15578.8 16142.7 16165.4 16193.4 16216.1 6372.6 6629.4 6671.9 6678.8 6721.6 873.8 953.0 969.7 1000.8 1028.6 29604.9 29784.7 30512.7 31129.4 31395.0 998.6 1014.1 1018.6 1070.9 1073.2 16006.3 16125.9 16147.6 16422.5 16503.9 481778.0 486553.0 488676.0 488810.0 490162.0 57261.0 57439.0 57653.0 57756.4 58092.1 1201.1 1321.9 1349.9 1350.2 1362.8 30041.8 31352.8 32779.0 32811.7 33323.0 48945.0 49645.0 49664.5 49829.5 49849.0 397045.0 401006.0 401852.0 402215.0 402342.0 33869.0 39070.2 39855.2 40621.4 42594.4 47007.5 47272.8 47334.5 47444.0 47532.0 39777.8 40953.0 40968.8 41516.8 42686.8 39971.4 40462.4 40827.1 42016.4 42024.4 39928.6 40534.4 40973.8 41023.8 41043.6 33786.0 36229.0 36869.8 36952.3 37466.4 27198.3 27540.9 27617.2 27749.7 27853.9 04:29:24 INFO - PROCESS | 23428 | 04:29:24 INFO - PROCESS | 23428 | [#2] jquery.html Cycles:180 Average:27596.04 Median:2307.17 stddev:76480.11 (3314.9%) stddev-sans-first:76667.36 04:29:24 INFO - PROCESS | 23428 | Values: 383.2 400.3 401.9 409.6 414.1 15776.2 19114.3 19136.6 19331.4 20129.8 11900.5 12596.9 12720.6 12879.2 12884.6 5223.6 5468.9 5469.4 5469.5 5470.1 5358.4 5441.1 5678.2 5914.8 5928.9 5996.6 6005.0 6007.0 6011.0 6011.5 5867.9 5941.9 5959.2 5977.2 5983.0 5643.1 5780.2 5783.7 5792.1 5793.2 12327.7 12548.7 12554.9 12565.4 12629.0 2284.3 2304.0 2310.3 2327.9 2365.6 10104.9 10109.2 10168.7 10349.8 10365.1 1833.7 1863.7 1892.9 1951.7 1970.5 57626.1 75342.2 82669.0 85448.6 87736.0 10886.8 11072.7 11178.8 11279.4 11286.2 15687.2 15747.4 15756.1 15771.8 15819.1 7982.6 8436.9 8461.6 8537.4 8666.1 8042.6 8087.1 8124.9 8314.3 8339.2 4656.7 4788.3 4803.9 4920.7 4929.3 1974.5 2002.7 2019.9 2024.3 2029.1 948.3 974.8 992.7 1011.9 1024.2 19347.2 19552.9 19834.8 19882.7 20085.0 949.9 967.2 996.7 1003.6 1067.9 10300.4 10866.0 10867.1 10874.7 10907.3 455360.0 456295.0 463176.0 466585.0 469981.0 91790.5 92537.0 93042.5 93052.5 94356.0 1008.6 1009.3 1010.9 1025.8 1030.5 16411.0 16962.6 17236.7 17577.3 17924.8 42121.3 42183.8 42344.6 43207.0 43461.3 56632.7 58237.7 58710.0 59736.4 59877.0 8173.0 8213.5 8336.3 8341.9 8430.4 10931.3 11165.7 11555.5 12291.4 12400.9 10673.1 10742.4 10764.5 10783.6 10881.3 10008.4 10469.2 10738.7 10981.7 11402.9 10036.4 10375.3 10418.4 10484.3 10812.5 8066.6 8103.6 8234.5 8275.8 8318.7 10409.4 10427.8 10517.9 10637.5 10810.2 04:29:24 INFO - PROCESS | 23428 | 04:29:24 INFO - PROCESS | 23428 | [#3] mootools.html Cycles:180 Average:5822.14 Median:4717.65 stddev:3334.73 (70.7%) stddev-sans-first:3327.20 04:29:24 INFO - PROCESS | 23428 | Values: 1357.2 1474.3 1498.2 1618.6 1783.9 8274.6 8601.4 8690.3 8958.0 8991.5 8795.1 8918.6 8918.8 8927.4 8982.4 2065.0 2344.6 2405.1 2434.1 2434.3 2371.2 2382.8 2384.6 2389.9 2399.4 2346.8 2350.8 2361.1 2391.4 2393.0 2300.7 2316.4 2337.8 2406.5 2410.8 2382.2 2413.7 2426.5 2430.5 2432.5 8554.1 8691.5 8694.7 8701.0 8708.3 5250.7 5397.4 5403.9 5405.2 5410.1 3236.5 3375.6 3430.9 3434.0 3437.7 1118.9 1150.2 1160.7 1169.7 1198.1 12191.6 12452.8 12459.1 12474.0 12482.4 4355.9 4522.4 4707.7 4727.6 4742.2 10516.1 10516.2 10521.5 10525.8 10530.3 5283.8 5346.0 5348.4 5348.5 5387.5 4401.9 4798.4 4844.5 4888.6 4892.7 4017.1 4045.2 4130.8 4135.1 4178.1 1353.0 1362.6 1364.8 1379.4 1379.9 941.5 952.8 956.7 965.9 992.3 5570.4 5602.4 5687.8 5766.7 6002.6 449.6 450.9 451.9 453.1 458.6 3720.8 3792.4 3855.6 3877.7 3959.6 10816.9 11054.7 11141.1 11142.9 11153.2 10415.8 10729.9 10858.3 11004.1 11280.1 8021.8 8104.2 8113.5 8188.8 8192.2 5830.6 5875.8 5944.2 5975.2 5995.3 9799.6 9877.7 9953.7 10163.2 10229.5 10193.8 10349.9 10363.4 10430.6 10547.6 6946.4 7738.2 7893.1 7979.4 8115.1 8683.8 8738.1 8752.7 8809.4 8810.8 7671.8 7676.4 7778.3 7923.7 7952.5 7637.8 7639.2 7716.3 7745.3 7771.9 6964.7 7059.6 7104.0 7135.0 7150.5 5137.6 5200.5 5254.9 5298.4 5483.9 5103.8 5116.7 5167.5 5172.9 5355.8 04:29:24 INFO - PROCESS | 23428 | 04:29:24 INFO - PROCESS | 23428 | [#4] prototype.html Cycles:180 Average:4509.49 Median:5102.08 stddev:1308.92 (25.7%) stddev-sans-first:1274.15 04:29:24 INFO - PROCESS | 23428 | Values: 314.2 325.8 329.6 331.4 334.3 5106.5 5162.7 5280.3 5309.3 5342.6 5214.3 5248.0 5258.4 5288.9 5344.5 4207.4 4208.9 4211.2 4219.6 4220.9 3984.9 4138.8 4195.4 4200.1 4201.3 4089.3 4090.2 4127.8 4132.7 4136.4 4071.1 4094.1 4100.8 4109.5 4132.6 3656.7 3657.7 3662.2 3676.2 3691.5 5128.4 5139.8 5148.7 5150.2 5176.8 4656.1 4667.4 4672.5 4682.6 4690.1 5357.2 5499.3 5500.8 5522.2 5531.5 3899.3 3925.0 3933.8 3937.4 3949.2 5668.8 5672.8 5686.2 5698.8 5708.4 4005.6 4048.8 4057.7 4067.4 4070.0 3884.9 4051.6 4055.8 4066.3 4113.0 4611.1 4612.7 4618.4 4623.9 4626.1 5484.8 5507.5 5510.5 5521.1 5552.4 1322.6 1340.0 1368.2 1383.2 1396.0 947.7 953.8 962.3 971.2 977.5 5325.2 5327.4 5327.9 5331.7 5360.5 5585.7 5586.5 5589.5 5594.4 5602.7 5178.4 5276.8 5318.6 5327.3 5334.7 2617.4 2619.2 2622.8 2634.7 2662.9 5079.2 5092.9 5125.5 5144.5 5171.2 4816.6 5059.8 5060.9 5065.3 5101.4 5069.7 5102.7 5141.7 5145.6 5157.5 4955.4 4957.9 4966.0 4982.6 5038.6 4612.4 4833.8 4920.3 4941.4 4950.8 5088.4 5126.3 5129.8 5135.8 5136.6 3699.0 3703.2 3711.2 3726.6 3752.8 5084.5 5091.3 5280.9 5449.7 5691.9 5491.8 5543.3 5560.9 5579.1 5600.7 5457.6 5544.6 5545.9 5580.7 5615.9 5331.9 5464.4 5505.8 5562.7 5564.9 5546.0 5581.9 5601.1 5607.7 5620.7 5483.5 5503.0 5503.4 5524.3 5535.7 04:29:24 INFO - PROCESS | 23428 | 04:29:24 INFO - PROCESS | 23428 | [#5] yui.html Cycles:180 Average:21714.60 Median:4511.36 stddev:32256.44 (715.0%) stddev-sans-first:32308.58 04:29:24 INFO - PROCESS | 23428 | Values: 765.3 801.9 807.9 810.7 837.3 15022.2 15426.2 15536.7 15590.2 15620.5 15131.5 15312.5 15330.6 15342.3 15353.5 657.6 788.2 828.7 830.4 831.2 820.1 820.5 822.8 827.9 829.9 872.0 875.5 879.0 879.2 879.5 690.1 847.0 855.6 862.0 871.0 637.5 638.4 638.8 639.1 639.3 14931.4 14936.8 15102.5 15129.7 15135.8 14892.4 14924.3 14931.3 15166.4 15306.0 13773.7 13806.7 13871.5 14020.8 14113.2 4371.4 4458.4 4488.4 4581.5 4618.0 81281.0 82456.6 83017.6 84247.2 84928.6 11682.2 11704.5 11800.2 11964.1 12073.0 18935.8 19095.5 19108.5 19344.7 19453.6 8667.9 8683.6 8705.9 8727.8 8838.2 4676.1 4680.1 4704.8 4779.8 4871.1 3386.5 3492.9 3495.8 3498.6 3499.2 532.7 575.1 585.2 586.0 640.2 689.7 709.4 710.0 716.6 721.5 8352.7 9122.6 9268.3 9518.2 9670.7 657.4 704.1 741.6 755.3 758.3 4361.5 4471.0 4534.3 4569.2 4618.9 119559.4 123258.4 124301.4 130897.0 131032.3 103681.0 107940.0 109746.0 110593.4 113369.4 57653.4 89086.0 92118.5 92183.0 93127.0 8265.1 8318.3 8324.0 8546.5 8762.0 39793.8 52047.0 54486.7 55506.7 56322.7 76644.6 77769.0 79957.0 80492.0 82494.0 12351.0 12832.4 12965.4 13050.3 13342.5 13561.9 13669.5 13927.0 14415.3 15419.6 13161.7 13435.3 13567.4 13918.7 13977.3 12574.2 12795.1 12807.6 13261.9 14284.4 12002.9 12105.3 12282.4 12928.8 13786.9 12324.9 12464.1 12678.5 12778.0 13131.4 12120.4 12326.5 12341.4 12655.0 12724.1 04:29:24 INFO - PROCESS | 23428 | -------- Summary: end -------- 04:29:24 INFO - PROCESS | 23428 | 04:29:25 INFO - TEST-INFO | 23428: exit 0 04:29:25 INFO - TEST-OK | dromaeo_css | took 1116088ms 04:29:25 INFO - TEST-START | kraken 04:29:25 INFO - operating with platform_type : linux_ 04:29:25 INFO - Initialising browser for kraken test... 04:29:25 INFO - TEST-INFO | started process 23747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1flJPH/profile http://localhost:38385/getInfo.html) 04:29:29 INFO - PROCESS | 23747 | __metrics Screen width/height:1600/1200 04:29:29 INFO - PROCESS | 23747 | colorDepth:24 04:29:29 INFO - PROCESS | 23747 | Browser inner width/height: 1024/697 04:29:29 INFO - PROCESS | 23747 | __metrics 04:29:29 INFO - PROCESS | 23747 | 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" 04:29:29 INFO - PROCESS | 23747 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:29:30 INFO - PROCESS | 23747 | console.error: PushService: 04:29:30 INFO - PROCESS | 23747 | stateChangeProcessEnqueue: Error transitioning state 04:29:30 INFO - PROCESS | 23747 | UnknownError 04:29:31 INFO - TEST-INFO | 23747: exit 0 04:29:31 INFO - Browser initialized. 04:29:31 INFO - Running cycle 1/1 for kraken test... 04:29:31 INFO - TEST-INFO | started process 23827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1flJPH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:43 INFO - PROCESS | 23827 | RSS: Main: 179040256 04:29:43 INFO - PROCESS | 23827 | 04:29:45 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38385/tests/kraken/driver.html?testName=audio-beat-detection) 04:29:46 INFO - PROCESS | 23827 | RSS: Main: 241405952 04:29:46 INFO - PROCESS | 23827 | 04:29:49 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38385/tests/kraken/driver.html?testName=audio-dft) 04:29:49 INFO - PROCESS | 23827 | RSS: Main: 223006720 04:29:49 INFO - PROCESS | 23827 | 04:29:52 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38385/tests/kraken/driver.html?testName=audio-fft) 04:29:53 INFO - PROCESS | 23827 | RSS: Main: 300732416 04:29:53 INFO - PROCESS | 23827 | 04:29:55 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38385/tests/kraken/driver.html?testName=audio-oscillator) 04:29:56 INFO - PROCESS | 23827 | RSS: Main: 212156416 04:29:56 INFO - PROCESS | 23827 | 04:29:58 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38385/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:29:58 INFO - PROCESS | 23827 | RSS: Main: 214040576 04:29:58 INFO - PROCESS | 23827 | 04:30:01 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38385/tests/kraken/driver.html?testName=imaging-darkroom) 04:30:02 INFO - PROCESS | 23827 | RSS: Main: 252522496 04:30:02 INFO - PROCESS | 23827 | 04:30:05 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38385/tests/kraken/driver.html?testName=imaging-desaturate) 04:30:06 INFO - PROCESS | 23827 | RSS: Main: 250699776 04:30:06 INFO - PROCESS | 23827 | 04:30:09 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38385/tests/kraken/driver.html?testName=json-parse-financial) 04:30:09 INFO - PROCESS | 23827 | RSS: Main: 250867712 04:30:09 INFO - PROCESS | 23827 | 04:30:11 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38385/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:30:12 INFO - PROCESS | 23827 | RSS: Main: 213676032 04:30:12 INFO - PROCESS | 23827 | 04:30:13 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38385/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:30:14 INFO - PROCESS | 23827 | RSS: Main: 221097984 04:30:14 INFO - PROCESS | 23827 | 04:30:16 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38385/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:30:17 INFO - PROCESS | 23827 | RSS: Main: 221425664 04:30:17 INFO - PROCESS | 23827 | 04:30:19 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:30:20 INFO - PROCESS | 23827 | RSS: Main: 223285248 04:30:20 INFO - PROCESS | 23827 | 04:30:23 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:30:23 INFO - PROCESS | 23827 | RSS: Main: 220852224 04:30:23 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | Cycle 1(1): loaded http://localhost:38385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38385/tests/kraken/driver.html?testName=ai-astar) 04:30:25 INFO - PROCESS | 23827 | RSS: Main: 271978496 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | __start_tp_report 04:30:25 INFO - PROCESS | 23827 | _x_x_mozilla_page_load 04:30:25 INFO - PROCESS | 23827 | _x_x_mozilla_page_load_details 04:30:25 INFO - PROCESS | 23827 | |i|pagename|runs| 04:30:25 INFO - PROCESS | 23827 | |0;ai-astar;114;114;129;113;114;113;113;111;111;111 04:30:25 INFO - PROCESS | 23827 | |1;audio-beat-detection;155;115;144;173;118;153;151;119;182;121 04:30:25 INFO - PROCESS | 23827 | |2;audio-dft;162;159;160;161;160;161;163;162;160;161 04:30:25 INFO - PROCESS | 23827 | |3;audio-fft;75;77;74;176;76;77;75;77;166;77 04:30:25 INFO - PROCESS | 23827 | |4;audio-oscillator;83;83;142;82;83;83;140;84;84;148 04:30:25 INFO - PROCESS | 23827 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 04:30:25 INFO - PROCESS | 23827 | |6;imaging-darkroom;148;147;147;147;147;147;147;147;147;146 04:30:25 INFO - PROCESS | 23827 | |7;imaging-desaturate;94;95;95;95;95;95;94;94;97;96 04:30:25 INFO - PROCESS | 23827 | |8;json-parse-financial;54;51;59;51;51;53;52;52;51;53 04:30:25 INFO - PROCESS | 23827 | |9;json-stringify-tinderbox;62;62;62;61;62;62;62;62;63;63 04:30:25 INFO - PROCESS | 23827 | |10;stanford-crypto-aes;89;84;78;79;79;78;79;87;84;77 04:30:25 INFO - PROCESS | 23827 | |11;stanford-crypto-ccm;136;132;130;129;127;124;125;126;166;133 04:30:25 INFO - PROCESS | 23827 | |12;stanford-crypto-pbkdf2;167;163;166;172;166;165;163;164;159;163 04:30:25 INFO - PROCESS | 23827 | |13;stanford-crypto-sha256-iterative;64;65;66;65;65;66;64;64;68;64 04:30:25 INFO - PROCESS | 23827 | __end_tp_report 04:30:25 INFO - PROCESS | 23827 | __start_cc_report 04:30:25 INFO - PROCESS | 23827 | _x_x_mozilla_cycle_collect,1710 04:30:25 INFO - PROCESS | 23827 | __end_cc_report 04:30:25 INFO - PROCESS | 23827 | __startTimestamp1472297425653__endTimestamp 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | ------- Summary: start ------- 04:30:25 INFO - PROCESS | 23827 | Number of tests: 14 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#0] ai-astar Cycles:10 Average:114.30 Median:113.50 stddev:5.31 (4.7%) stddev-sans-first:5.63 04:30:25 INFO - PROCESS | 23827 | Values: 114.0 114.0 129.0 113.0 114.0 113.0 113.0 111.0 111.0 111.0 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:152.00 stddev:24.03 (15.8%) stddev-sans-first:25.10 04:30:25 INFO - PROCESS | 23827 | Values: 155.0 115.0 144.0 173.0 118.0 153.0 151.0 119.0 182.0 121.0 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 04:30:25 INFO - PROCESS | 23827 | Values: 162.0 159.0 160.0 161.0 160.0 161.0 163.0 162.0 160.0 161.0 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.50 stddev:40.14 (52.5%) stddev-sans-first:41.92 04:30:25 INFO - PROCESS | 23827 | Values: 75.0 77.0 74.0 176.0 76.0 77.0 75.0 77.0 166.0 77.0 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:83.00 stddev:29.15 (35.1%) stddev-sans-first:30.16 04:30:25 INFO - PROCESS | 23827 | Values: 83.0 83.0 142.0 82.0 83.0 83.0 140.0 84.0 84.0 148.0 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:30:25 INFO - PROCESS | 23827 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 04:30:25 INFO - PROCESS | 23827 | Values: 148.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.94 (1.0%) stddev-sans-first:0.93 04:30:25 INFO - PROCESS | 23827 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 97.0 96.0 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.50 stddev:2.45 (4.7%) stddev-sans-first:2.55 04:30:25 INFO - PROCESS | 23827 | Values: 54.0 51.0 59.0 51.0 51.0 53.0 52.0 52.0 51.0 53.0 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 04:30:25 INFO - PROCESS | 23827 | Values: 62.0 62.0 62.0 61.0 62.0 62.0 62.0 62.0 63.0 63.0 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.50 stddev:4.25 (5.2%) stddev-sans-first:3.50 04:30:25 INFO - PROCESS | 23827 | Values: 89.0 84.0 78.0 79.0 79.0 78.0 79.0 87.0 84.0 77.0 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:131.00 stddev:12.26 (9.4%) stddev-sans-first:12.95 04:30:25 INFO - PROCESS | 23827 | Values: 136.0 132.0 130.0 129.0 127.0 124.0 125.0 126.0 166.0 133.0 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.50 stddev:3.39 (2.1%) stddev-sans-first:3.50 04:30:25 INFO - PROCESS | 23827 | Values: 167.0 163.0 166.0 172.0 166.0 165.0 163.0 164.0 159.0 163.0 04:30:25 INFO - PROCESS | 23827 | 04:30:25 INFO - PROCESS | 23827 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.29 (2.0%) stddev-sans-first:1.30 04:30:25 INFO - PROCESS | 23827 | Values: 64.0 65.0 66.0 65.0 65.0 66.0 64.0 64.0 68.0 64.0 04:30:25 INFO - PROCESS | 23827 | -------- Summary: end -------- 04:30:25 INFO - PROCESS | 23827 | 04:30:26 INFO - TEST-INFO | 23827: exit 0 04:30:26 INFO - TEST-OK | kraken | took 61630ms 04:30:26 INFO - SUITE-END | took 1177s 04:30:27 INFO - Completed test suite (00:19:38) 04:30:27 INFO - javascript benchmark 04:30:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2995.385945881095, 3054.0532434945153, 3054.9847250763746, 3086.1513083901937, 3111.782175247732, 5236.1098613235745, 5299.735013249337, 5320.042392369372, 5344.251804747339, 5352.678839269642, 5315.202719592054, 5347.0909945309295, 5395.109806881869, 5457.481539253775, 5512.39363669996, 4833.637477189207, 4852.660313778037, 4863.319135321058, 4870.050340183666, 5024.9748751256375, 4910.975445122769, 4970.875728106808, 4981.1532039553185, 4985.825496107637, 4990.600751939836, 4762.214234651278, 4793.343854251982, 4848.903021939576, 4877.414710234794, 4941.629377796662, 4782.569568738831, 4811.735354555498, 4816.927746083811, 4818.445878723956, 4929.482404347564, 4808.831690890837, 4840.709557426566, 4853.805847766085, 4856.927146092811, 4901.387326584177, 5251.422343542207, 5288.0, 5329.706866122362, 5354.839354819362, 5358.437364076754, 5700.344460387067, 5713.228714123623, 5725.856853578653, 5726.284214473191, 5739.139129130622, 5774.335951365605, 5778.6243894147165, 5782.421757824226, 5785.0, 5791.768329266824, 5275.604329675251, 5315.468453154731, 5318.70747108905, 5335.413104558495, 5412.350517937873, 5833.82498525045, 5860.765569377178, 5864.648121112747, 5866.061430171152, 5875.41245875409, 5602.859928501739, 5605.943940560624, 5614.578906582023, 5616.85957851057, 5651.717414129359, 5495.670259784426, 5660.716964151776, 5723.341815691166, 5743.684097374601, 5805.0, 5724.370319264877, 5725.8568535786935, 5731.025725626653, 5731.742071606787, 5732.77068917247, 5679.375268720438, 5720.885582288331, 5735.856603584861, 5752.884942301131, 5755.654660720286, 4307.5477074906685, 4387.012922092567, 4388.824447022147, 4389.868303950822, 4417.2269852775635, 3935.665468435158, 3974.880753577397, 3975.920481590352, 4011.3180759270995, 4032.213718324957, 5410.945890541123, 5419.0, 5421.0, 5423.186522021729, 5424.918626220609, 5554.777808887599, 5688.146777983336, 5734.856628584235, 5744.971275143597, 5745.425457454221, 5387.865303367447, 5434.8913021739345, 5440.591955603346, 5494.587905907073, 5503.174523821459, 4944.752762361867, 4948.925766113512, 4961.50384961501, 4963.429205641325, 4969.204927211629, 5777.277840269966, 5900.409959004237, 5957.106434034929, 5965.164876917148, 5966.701664916737, 5758.395368486249, 5758.683272420057, 5764.481196692318, 5816.331121921034, 5838.532917366516, 5916.437938395846, 5939.821805345847, 5958.612690175125, 5960.254968128984, 5967.731452084579, 5559.082751345983, 5593.300837395325, 5663.85840353978, 5665.688387138582, 5680.204771331934, 5698.857528561653, 5750.338711048283, 5750.568707347049, 5808.361080281081, 5817.069268916953, 5581.6371935824045, 5628.380878103487, 5628.971855140698, 5633.464820842013, 5638.013347664224, 5499.917501237404, 5562.415946325577, 5584.776608935597, 5591.6365436246515, 5591.692456914746, 5590.860228494157, 5611.186377975089, 5623.971880140573, 5684.658920464785, 5685.687287199244, 5616.943830561642, 5622.072358061037, 5623.522000629829, 5629.408912064175, 5644.238027866186, 5387.2727181831515, 5402.702851343057, 5520.861978450571, 5530.253415788817, 5530.5022547970875], "value": 5286.1400163894905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.8474169603359, 597.1967703438875, 616.1527899138684, 616.5714828194407, 623.2645478335568, 31505.68494315056, 32472.512912306305, 34819.47770783434, 34854.128646783814, 42633.0, 41672.37491437623, 44043.3393499097, 45062.0, 45203.32195017077, 46186.690665466675, 8987.955060224705, 9124.908750912506, 9125.178733913946, 9132.543372831331, 9134.36059475837, 8138.0, 8985.505797181153, 9086.091390860927, 9088.227500662451, 10536.683899483029, 10631.468426578678, 11042.116630669567, 11042.3374597524, 11042.779144417107, 11071.72320691981, 10918.945405272963, 10976.902309769039, 10996.725081872977, 10999.285046472034, 11004.504797284062, 10772.78454430907, 10841.512131954081, 10847.728806779814, 10856.185786065998, 10858.23992320538, 43258.567414326084, 43450.782746086064, 43527.56472435267, 43547.379208638675, 43692.563074369165, 3475.669811367916, 3592.3892938200306, 3688.8708895188806, 3858.672012878909, 4161.646260067898, 32449.0, 32929.835350823094, 32987.34025319504, 33072.6692733072, 34032.829835850665, 4459.197344477992, 4531.660125490602, 4541.159885421174, 4605.0559635274685, 4672.299155126724, 344720.0, 345694.0, 346978.9999999975, 348481.0, 349105.0, 56839.14741278884, 57070.7146464265, 57137.71431142901, 57169.714151429805, 57265.71367143221, 59472.0, 59947.100793488135, 60033.0, 60254.69872650609, 60331.396686033455, 16599.170041498117, 17159.28407159299, 17200.053997030034, 17202.827971720373, 17204.569885752706, 13135.408906599227, 13206.405711742995, 13313.534026309033, 13339.0, 13351.799723004162, 15578.766318505232, 16142.677146457005, 16165.35338586467, 16193.433229836899, 16216.10811405384, 6372.58578192416, 6629.436497897636, 6671.86656266872, 6678.766243181465, 6721.5967041976655, 873.8208667223204, 953.0, 969.709087273815, 1000.7748256642197, 1028.6091285311684, 29604.851975739984, 29784.702152978625, 30512.694873050987, 31129.377412451624, 31395.0, 998.55065220651, 1014.1177175857051, 1018.5976539266948, 1070.8607880975424, 1073.1575713065206, 16006.279717412745, 16125.919370403073, 16147.596310092107, 16422.507324780276, 16503.91748041252, 481778.0, 486553.0, 488676.0, 488810.0, 490162.0, 57261.0, 57439.0, 57653.0, 57756.4224357751, 58092.12861807076, 1201.0991756182864, 1321.8876395506297, 1349.878510934001, 1350.2438634364983, 1362.768329384007, 30041.849790750908, 31352.843235783675, 32779.0, 32811.67188328086, 33323.0, 48945.0, 49645.0, 49664.50335496743, 49829.50170498394, 49849.0, 397045.0, 401006.0, 401852.0, 402215.0, 402342.0, 33869.0, 39070.218595628496, 39855.2028959425, 40621.390679139244, 42594.361084583135, 47007.52992470031, 47272.7636361816, 47334.52665473439, 47444.0, 47532.0, 39777.80111099426, 40953.0, 40968.79515602403, 41516.79241603773, 42686.78656606697, 39971.40042899417, 40462.39306410465, 40827.10030886556, 42016.36975445432, 42024.36963445612, 39928.60071399365, 40534.39198412085, 40973.79513102535, 41023.7948810254, 41043.58956410517, 33786.0, 36229.0, 36869.81565092158, 36952.26095478129, 37466.43800342942, 27198.320041999108, 27540.862295688392, 27617.171484855488, 27749.722502775523, 27853.86073069622], "value": 20254.19814434207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.19146600672593, 400.2655127840413, 401.93769965655315, 409.5719972628603, 414.1489239612597, 15776.211189440524, 19114.33099841506, 19136.617267654656, 19331.42005739828, 20129.798702012977, 11900.46447909844, 12596.93701531491, 12720.55478058268, 12879.162854414457, 12884.613461596167, 5223.6343455958095, 5468.890622187554, 5469.386530973353, 5469.535089517376, 5470.124780035195, 5358.437364076774, 5441.129419292914, 5678.233438485813, 5914.822555323347, 5928.88142237155, 5996.580239383245, 6004.96997515014, 6007.038873780196, 6011.0, 6011.519078473733, 5867.88264234715, 5941.910871336933, 5959.225300710923, 5977.163197152402, 5983.042713165873, 5643.125315576092, 5780.16187652788, 5783.739731712083, 5792.131180322943, 5793.217915581385, 12327.69180770479, 12548.74902501954, 12554.874451255462, 12565.371731413485, 12629.0, 2284.3191523011224, 2304.0221502558784, 2310.318456055468, 2327.8719670418122, 2365.633326834326, 10104.94947525265, 10109.191264698806, 10168.694939151837, 10349.793004139876, 10365.118964887994, 1833.6791061564172, 1863.7018077107598, 1892.9399536259739, 1951.687729963199, 1970.5369238229005, 57626.135607965916, 75342.24657753407, 82668.9999999994, 85448.57275713644, 87736.0, 10886.836697449544, 11072.667819965414, 11178.807947019868, 11279.379634120038, 11286.209965302514, 15687.215639218222, 15747.370105195663, 15756.133412662184, 15771.763423548657, 15819.05085694862, 7982.600869956479, 8436.873446898302, 8461.576921153917, 8537.402381833212, 8666.133386661284, 8042.597870106471, 8087.069986951576, 8124.918750812534, 8314.251717345467, 8339.249467547828, 4656.650751193606, 4788.257820037899, 4803.855884323476, 4920.72935988524, 4929.285253638274, 1974.5261137327225, 2002.7196192533056, 2019.858609897293, 2024.3399216577295, 2029.1274751856843, 948.2887834124407, 974.7660561465198, 992.6624947517879, 1011.9494025298706, 1024.2318261304022, 19347.226110955406, 19552.90223548873, 19834.801651983296, 19882.70175947362, 20085.0, 949.943003419797, 967.1827305926621, 996.6561536269975, 1003.6437064842022, 1067.9466026698633, 10300.424903748311, 10865.972690281771, 10867.130629549618, 10874.72813179661, 10907.345559266469, 455360.0, 456295.0, 463176.0, 466585.0, 469980.95028574596, 91790.54104729433, 92537.0, 93042.53478732563, 93052.53473732588, 94356.0, 1008.5612758450097, 1009.3237530854345, 1010.8989101089979, 1025.8307379282335, 1030.4538594544904, 16411.0, 16962.575935601708, 17236.655266894842, 17577.29690812353, 17924.820751792315, 42121.34136060181, 42183.83621228359, 42344.57655423407, 43206.99999999874, 43461.348079778196, 56632.71683641555, 58237.70881145567, 58710.0, 59736.402635973085, 59877.0, 8173.0, 8213.54825484604, 8336.291415229773, 8341.874871876806, 8430.40987130895, 10931.289466184673, 11165.72085697864, 11555.537778488766, 12291.446884890023, 12400.875991239973, 10673.092787113183, 10742.355458672504, 10764.461776910966, 10783.568657253621, 10881.347119172875, 10008.39949603026, 10469.162467002468, 10738.677839664822, 10981.670549883516, 11402.94298528502, 10036.447995360326, 10375.27373083877, 10418.374897506174, 10484.318519296221, 10812.5134368952, 8066.637001334837, 8103.594820259082, 8234.505929644241, 8275.83448331018, 8318.70884519039, 10409.375437473776, 10427.791444170922, 10517.947410263207, 10637.468126593794, 10810.18923580719], "value": 8850.373795889394, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.151780137414, 1474.262868565717, 1498.2358996911576, 1618.5791694159516, 1783.9464816055515, 8274.586270686472, 8601.440906341091, 8690.261327787146, 8958.0, 8991.460512369262, 8795.120487951202, 8918.643254269839, 8918.821623567525, 8927.41971771836, 8982.37123401362, 2065.039756513221, 2344.613138832099, 2405.1341517053847, 2434.123715462441, 2434.2818868433765, 2371.1700904683307, 2382.7855493005627, 2384.582698027847, 2389.904403823845, 2399.4121440247077, 2346.77705617966, 2350.788429041386, 2361.067378385537, 2391.449966507704, 2392.9880350598223, 2300.700908881843, 2316.3745788637057, 2337.8480398774027, 2406.470576473173, 2410.8191885608476, 2382.2376839411395, 2413.734489206186, 2426.478307163968, 2430.538197742423, 2432.5013372258645, 8554.05905350411, 8691.521966291852, 8694.739157825212, 8701.0, 8708.259797917184, 5250.737463126867, 5397.3523177218985, 5403.891922161574, 5405.243265942771, 5410.1073322901675, 3236.514522821572, 3375.6118046424485, 3430.879919202841, 3433.9656603433896, 3437.673421024999, 1118.927269727465, 1150.1833698074377, 1160.7388337623968, 1169.6783384569226, 1198.1433275208267, 12191.573294934724, 12452.81320780189, 12459.06557008228, 12474.0, 12482.375881205904, 4355.869323920288, 4522.3668686383935, 4707.7175369477945, 4727.581725482341, 4742.217534106834, 10516.053555180071, 10516.158707303397, 10521.473926303654, 10525.789484210272, 10530.262881598368, 5283.788648454096, 5345.9732701337025, 5348.3849357323625, 5348.545373643206, 5387.488188622153, 4401.911961760811, 4798.448178459522, 4844.515548445127, 4888.584470319992, 4892.730899800474, 4017.116234428421, 4045.1707399982934, 4130.772807495617, 4135.110951145458, 4178.101708132766, 1352.9729405411836, 1362.6033315851332, 1364.7543442180504, 1379.3930670504947, 1379.8965077619218, 941.5104145844259, 952.828490871636, 956.7464621875208, 965.946872921996, 992.2607657295217, 5570.442955704397, 5602.411746766531, 5687.77248910039, 5766.682832444172, 6002.609830361012, 449.6200710399707, 450.8782628690301, 451.93672885796013, 453.11416181365354, 458.63996762541245, 3720.795356255378, 3792.412176112707, 3855.556610989716, 3877.6703980161437, 3959.5644479107277, 10816.891831081588, 11054.668359949215, 11141.108711303077, 11142.944285278683, 11153.163512736415, 10415.791684166274, 10729.9463502682, 10858.294210876267, 11004.064654504456, 11280.09759219277, 8021.7994550135545, 8104.203999980106, 8113.5131892086665, 8188.7952801180445, 8192.221738934792, 5830.591858569859, 5875.794347197828, 5944.167816505779, 5975.223220981245, 5995.280566332068, 9799.608015679292, 9877.703668889944, 9953.701388958343, 10163.23775716839, 10229.48852557384, 10193.84709229377, 10349.9482502587, 10363.378197308186, 10430.58277668915, 10547.57809687604, 6946.4095551876635, 7738.187490313436, 7893.052833659997, 7979.361651068017, 8115.066767321833, 8683.782905427415, 8738.082501337269, 8752.69365572202, 8809.383343165917, 8810.779730506789, 7671.808204794925, 7676.385889128745, 7778.338841198562, 7923.6830526778285, 7952.52284862887, 7637.809054773675, 7639.197884222299, 7716.2669546393, 7745.302922736755, 7771.883421748791, 6964.721411143498, 7059.647017649199, 7103.964480177566, 7134.964325178341, 7150.463715221275, 5137.614678899172, 5200.5059519345605, 5254.894902102013, 5298.3906850712665, 5483.917741233805, 5103.8468845934685, 5116.718580478109, 5167.509086636764, 5172.948270517397, 5355.758990845499], "value": 4585.226955509114, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.24424259655535, 325.7719596282602, 329.5764942049467, 331.40181971541375, 334.3079824762741, 5106.489351064892, 5162.6644268122545, 5280.260763493114, 5309.30978972733, 5342.572594192465, 5214.296070030545, 5247.973760131204, 5258.395284542279, 5288.92066619001, 5344.4922732340465, 4207.368894665794, 4208.873733787991, 4211.1998720243055, 4219.607529515268, 4220.894477638053, 3984.9203015939665, 4138.8344466221315, 4195.433616461784, 4200.075983283673, 4201.264778663737, 4089.3457046872504, 4090.1615168890453, 4127.752334859903, 4132.690048246379, 4136.400221967813, 4071.1450595375154, 4094.1197642506854, 4100.753954762724, 4109.506859176888, 4132.648724858391, 3656.725745569093, 3657.738080362271, 3662.212624285765, 3676.209614932802, 3691.53855768029, 5128.410232823236, 5139.8458046258675, 5148.742562871841, 5150.227465880148, 5176.844694659167, 4656.068786242765, 4667.436408803055, 4672.486026537078, 4682.578567928868, 4690.0854333405, 5357.1696387060065, 5499.340079190482, 5500.80747173851, 5522.199281104217, 5531.529819965308, 3899.317619416619, 3924.9803750981346, 3933.7836418996944, 3937.3503371943593, 3949.2101579684177, 5668.773249070032, 5672.773089076432, 5686.232358631614, 5698.831739493394, 5708.372079071258, 4005.559388467266, 4048.7975601219823, 4057.655099316532, 4067.389891516237, 4070.0, 3884.8640297590014, 4051.6353528182603, 4055.797210139481, 4066.3290557058344, 4113.0, 4611.118051217989, 4612.7001744886475, 4618.376519169869, 4623.930641040387, 4626.1441633297945, 5484.8354549363585, 5507.504324610804, 5510.531604813636, 5521.1442226454965, 5552.41699621542, 1322.578228404469, 1339.9933000334936, 1368.2269517722455, 1383.2323060701206, 1395.9790603140962, 947.7251597036782, 953.8351709367834, 962.3167551038841, 971.1939090554822, 977.4819345746765, 5325.162818827498, 5327.360716714019, 5327.946720532745, 5331.653442526223, 5360.490753378423, 5585.69278689676, 5586.51957231334, 5589.496945274945, 5594.412586678422, 5602.719864006784, 5178.352705911761, 5276.81531146408, 5318.627696061316, 5327.280817089721, 5334.733263336818, 2617.3718307606036, 2619.188051703978, 2622.763951244397, 2634.6970098438924, 2662.9067982620513, 5079.161938280143, 5092.9236061459105, 5125.538701516882, 5144.459831717691, 5171.224316352502, 4816.566509014206, 5059.822906198266, 5060.9119039406705, 5065.316182315414, 5101.438841727407, 5069.670471419346, 5102.719350435687, 5141.742912854417, 5145.588352931832, 5157.484251574888, 4955.380577427822, 4957.900841983213, 4966.0, 4982.55157035854, 5038.622103342191, 4612.423447069116, 4833.830815921426, 4920.335754673073, 4941.43173535048, 4950.752462376939, 5088.44027157005, 5126.256692779601, 5129.769160387867, 5135.845924622267, 5136.606563108646, 3698.981505092565, 3703.203811180609, 3711.183539621279, 3726.552813662378, 3752.793596352227, 5084.51697088776, 5091.345312773437, 5280.920786188287, 5449.7002664852225, 5691.8861622768145, 5491.75287112073, 5543.25166102571, 5560.888782224252, 5579.13523403873, 5600.691961942132, 5457.645253058538, 5544.556435485232, 5545.916811247916, 5580.693061881636, 5615.939313074303, 5331.9466805333, 5464.426235245242, 5505.807296744595, 5562.747087429598, 5564.860878478071, 5545.972270138624, 5581.944180558143, 5601.103823388401, 5607.719614019201, 5620.718964051863, 5483.4516548344845, 5503.0, 5503.449655034625, 5524.315083899449, 5535.667859928417], "value": 4095.008191233168, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.2768134113259, 801.9117897031325, 807.9111297757246, 810.7486679129474, 837.3385025829593, 15022.173780442072, 15426.228688565583, 15536.68926621467, 15590.220488975549, 15620.453284135072, 15131.470398536054, 15312.540623781304, 15330.616734581641, 15342.309596068177, 15353.462628807994, 657.6350125680245, 788.1724189600925, 828.7140936376941, 830.4062595244399, 831.2477208126655, 820.0978923184479, 820.4666966471782, 822.8025273934243, 827.896512935883, 829.929455996241, 871.9694810681627, 875.4965894610592, 879.0242830458186, 879.1867522541655, 879.4855009819263, 690.1200968764815, 846.9872951905726, 855.6106971328031, 861.961211745473, 870.9608067636908, 637.4708991537013, 638.3999040901584, 638.7540796793221, 639.0701529274894, 639.3031595560815, 14931.40274389034, 14936.775948360782, 15102.54692359231, 15129.697406051817, 15135.772963405558, 14892.404303827834, 14924.25378731059, 14931.328090235966, 15166.393344266216, 15306.0, 13773.655658608515, 13806.65483362924, 13871.514496992557, 14020.789688154686, 14113.153210807384, 4371.431713877208, 4458.3535387368975, 4488.4165058542185, 4581.518940511231, 4618.0, 81281.0, 82456.58771706103, 83017.58491207505, 84247.15752842455, 84928.57535712281, 11682.240654357609, 11704.531818727326, 11800.232984855957, 11964.102692298113, 12073.0, 18935.81064189368, 19095.52261193481, 19108.522286942938, 19344.70982935257, 19453.610927781367, 8667.913320866837, 8683.609237584324, 8705.91294087051, 8727.825443491094, 8838.160374764388, 4676.111538807616, 4680.110778951988, 4704.847312408413, 4779.808807647655, 4871.098846713369, 3386.492026196041, 3492.9126771830906, 3495.7552971291766, 3498.5626796650417, 3499.2476617527354, 532.7176596403912, 575.077001412735, 585.2274997003999, 585.9677717725481, 640.1677818835495, 689.6551724137931, 709.4359983812881, 709.9964500177466, 716.6058667732726, 721.5490318550906, 8352.707655232038, 9122.589483473259, 9268.314477335507, 9518.190953769008, 9670.661526846667, 657.3754932813846, 704.0530486495655, 741.5983790635703, 755.3004847007082, 758.2531206761336, 4361.476622805284, 4471.0, 4534.2971839364955, 4569.1547063793305, 4618.891466048124, 119559.40220298842, 123258.38370808268, 124301.37849310695, 130897.0, 131032.3448382752, 103681.0, 107940.0, 109746.0, 110593.44703276432, 113369.4331528337, 57653.423465764805, 89086.0, 92118.53940730388, 92183.0, 93127.0, 8265.132161123236, 8318.251357377865, 8323.958380208302, 8546.529940853065, 8761.956190219009, 39793.80103099582, 52047.0, 54486.7275663635, 55506.72246638902, 56322.71838640945, 76644.61677691576, 77769.0, 79957.0, 80492.0, 82494.0, 12351.0, 12832.358382081045, 12965.351732413154, 13050.34748262602, 13342.466301348226, 13561.864381356454, 13669.453221871412, 13927.0, 14415.33316336481, 15419.61450963735, 13161.736765264832, 13435.261060641758, 13567.38946747379, 13918.721625567634, 13977.301134943009, 12574.182678125893, 12795.104342695922, 12807.61577152687, 13261.867381326449, 14284.35720392564, 12002.879971200176, 12105.273683579013, 12282.447289872156, 12928.806067908801, 13786.862131378959, 12324.876751232372, 12464.127511074501, 12678.492860285485, 12778.0, 13131.439369323272, 12120.393980301125, 12326.50693972231, 12341.444634991267, 12655.0, 12724.109312348046], "value": 7673.671280691941, "unit": "score"}], "name": "dromaeo_css", "value": 7175.962690240364, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 129.0, 113.0, 114.0, 113.0, 113.0, 111.0, 111.0, 111.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 115.0, 144.0, 173.0, 118.0, 153.0, 151.0, 119.0, 182.0, 121.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 160.0, 161.0, 160.0, 161.0, 163.0, 162.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 176.0, 76.0, 77.0, 75.0, 77.0, 166.0, 77.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 142.0, 82.0, 83.0, 83.0, 140.0, 84.0, 84.0, 148.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 97.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 59.0, 51.0, 51.0, 53.0, 52.0, 52.0, 51.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 78.0, 79.0, 79.0, 78.0, 79.0, 87.0, 84.0, 77.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 130.0, 129.0, 127.0, 124.0, 125.0, 126.0, 166.0, 133.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 166.0, 172.0, 166.0, 165.0, 163.0, 164.0, 159.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 65.0, 65.0, 66.0, 64.0, 64.0, 68.0, 64.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1532.3999999999999, "alertThreshold": 2.0}]} 04:30:27 INFO - Return code: 0 04:30:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:30:27 INFO - # TBPL SUCCESS # 04:30:27 INFO - Running post-action listener: _resource_record_post_action 04:30:27 INFO - [mozharness: 2016-08-27 11:30:27.473435Z] Finished run-tests step (success) 04:30:27 INFO - Running post-run listener: _resource_record_post_run 04:30:27 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406929408; Read time: 8; Write time: 315428 04:30:27 INFO - TinderboxPrint: CPU usage
13.0% 04:30:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:30:27 INFO - TinderboxPrint: I/O write bytes / time
406,929,408 / 315,428 04:30:27 INFO - TinderboxPrint: CPU idle
8,289.1 (86.9%) 04:30:27 INFO - TinderboxPrint: CPU user
1,195.1 (12.5%) 04:30:27 INFO - TinderboxPrint: Swap in / out
0 / 0 04:30:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118255616; Read time: 0; Write time: 132380 04:30:27 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288673792; Read time: 0; Write time: 183048 04:30:28 INFO - Running post-run listener: _upload_blobber_files 04:30:28 INFO - Blob upload gear active. 04:30:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:30:28 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 04:30:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:30:28 INFO - (blobuploader) - INFO - Open directory for files ... 04:30:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:30:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:30:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:29 INFO - (blobuploader) - INFO - Done attempting. 04:30:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:30:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:30:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:30 INFO - (blobuploader) - INFO - Done attempting. 04:30:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:30:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:30:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:34 INFO - (blobuploader) - INFO - Done attempting. 04:30:34 INFO - (blobuploader) - INFO - Iteration through files over. 04:30:34 INFO - Return code: 0 04:30:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:30:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:30:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e4c9a24e7846125f465d269f94dabf6ca347d761316ff21f8229cfc76aac04ac7861ae5afa1a3f059db5e90e99e9a7ce9fd7bab6bf03b36313c78794ff3ea499", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc8b8124ffb4831bdb724343ed3578a7fad492147af6953c3513c313f4eb8a82330672ac05021cee0a80ebb5b4aac91d9775cdc8c6c954d0edafe4b60f39cf45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e622e47272fa57c58a4fde802e766c8f4ddbd81f6b712ca4a4d80dcc6bb5181ec877c32fa4bcb97679a1444b25c3f7a8b39ae09c6aed16148e5c6ba01a291dae"} 04:30:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:30:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:30:34 INFO - Contents: 04:30:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e4c9a24e7846125f465d269f94dabf6ca347d761316ff21f8229cfc76aac04ac7861ae5afa1a3f059db5e90e99e9a7ce9fd7bab6bf03b36313c78794ff3ea499", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc8b8124ffb4831bdb724343ed3578a7fad492147af6953c3513c313f4eb8a82330672ac05021cee0a80ebb5b4aac91d9775cdc8c6c954d0edafe4b60f39cf45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e622e47272fa57c58a4fde802e766c8f4ddbd81f6b712ca4a4d80dcc6bb5181ec877c32fa4bcb97679a1444b25c3f7a8b39ae09c6aed16148e5c6ba01a291dae"} 04:30:34 INFO - Running post-run listener: copy_logs_to_upload_dir 04:30:34 INFO - Copying logs to upload dir... 04:30:34 INFO - mkdir: /builds/slave/test/build/upload/logs 04:30:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.585630 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-27 04:30:34.147580) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 04:30:34.151583) ========= 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=41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e4c9a24e7846125f465d269f94dabf6ca347d761316ff21f8229cfc76aac04ac7861ae5afa1a3f059db5e90e99e9a7ce9fd7bab6bf03b36313c78794ff3ea499", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc8b8124ffb4831bdb724343ed3578a7fad492147af6953c3513c313f4eb8a82330672ac05021cee0a80ebb5b4aac91d9775cdc8c6c954d0edafe4b60f39cf45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e622e47272fa57c58a4fde802e766c8f4ddbd81f6b712ca4a4d80dcc6bb5181ec877c32fa4bcb97679a1444b25c3f7a8b39ae09c6aed16148e5c6ba01a291dae"} build_url:https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011136 build_url: 'https://queue.taskcluster.net/v1/task/cqoEC9LuSZW6Cks27vwCyQ/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/Mozilla-Inbound/sha512/e4c9a24e7846125f465d269f94dabf6ca347d761316ff21f8229cfc76aac04ac7861ae5afa1a3f059db5e90e99e9a7ce9fd7bab6bf03b36313c78794ff3ea499", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc8b8124ffb4831bdb724343ed3578a7fad492147af6953c3513c313f4eb8a82330672ac05021cee0a80ebb5b4aac91d9775cdc8c6c954d0edafe4b60f39cf45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e622e47272fa57c58a4fde802e766c8f4ddbd81f6b712ca4a4d80dcc6bb5181ec877c32fa4bcb97679a1444b25c3f7a8b39ae09c6aed16148e5c6ba01a291dae"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 04:30:34.176650) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:30:34.176962) ========= 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=41bf3e9aed84707956354da8000001c5-1472294878.612995-2117862543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 04:30:34.258798) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 04:30:34.259115) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 04:30:34.259407) ========= ========= Total master_lag: 0.42 =========