builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1470330536.32 results: success (0) buildid: 20160804073001 builduid: 1d4fb0b0a96b4eacad6bf4a76ad4944d revision: 0ba72e8027cfcbcbf3426770ac264a7ade2af090 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:56.319853) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:56.320244) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:56.320527) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:56.352243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:56.352517) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 10:08:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-08-04 10:08:56 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:56.491991) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:56.492305) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014787 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:56.541892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:56.542222) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0ba72e8027cfcbcbf3426770ac264a7ade2af090 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0ba72e8027cfcbcbf3426770ac264a7ade2af090 --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=a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 10:08:56,694 truncating revision to first 12 chars 2016-08-04 10:08:56,694 Setting DEBUG logging. 2016-08-04 10:08:56,694 attempt 1/10 2016-08-04 10:08:56,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0ba72e8027cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 10:08:57,003 unpacking tar archive at: mozilla-central-0ba72e8027cf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.614380 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:57.170249) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:57.170543) ========= script_repo_revision: 0ba72e8027cfcbcbf3426770ac264a7ade2af090 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:57.170905) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:57.171169) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:08:57.180318) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-04 10:08:57.180605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:08:57 INFO - MultiFileLogger online at 20160804 10:08:57 in /builds/slave/test 10:08:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:08:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:08:57 INFO - {'append_to_log': False, 10:08:57 INFO - 'base_work_dir': '/builds/slave/test', 10:08:57 INFO - 'blob_upload_branch': 'Firefox', 10:08:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:08:57 INFO - 'branch': 'Firefox', 10:08:57 INFO - 'buildbot_json_path': 'buildprops.json', 10:08:57 INFO - 'config_files': ('talos/linux_config.py',), 10:08:57 INFO - 'default_actions': ('clobber', 10:08:57 INFO - 'read-buildbot-config', 10:08:57 INFO - 'download-and-extract', 10:08:57 INFO - 'populate-webroot', 10:08:57 INFO - 'create-virtualenv', 10:08:57 INFO - 'install', 10:08:57 INFO - 'run-tests'), 10:08:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:08:57 INFO - 'download_minidump_stackwalk': True, 10:08:57 INFO - 'download_symbols': 'ondemand', 10:08:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:08:57 INFO - 'tooltool.py': '/tools/tooltool.py', 10:08:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:08:57 INFO - '/tools/misc-python/virtualenv.py')}, 10:08:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:08:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:08:57 INFO - 'installer_path': 'installer.exe', 10:08:57 INFO - 'log_level': 'info', 10:08:57 INFO - 'log_name': 'talos', 10:08:57 INFO - 'log_to_console': True, 10:08:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:08:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:08:57 INFO - 'opt_config_files': (), 10:08:57 INFO - 'pip_index': False, 10:08:57 INFO - 'sps_profile': False, 10:08:57 INFO - 'sps_profile_interval': 0, 10:08:57 INFO - 'suite': 'dromaeojs', 10:08:57 INFO - 'system_bits': '32', 10:08:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:08:57 INFO - 'title': 'talos-linux64-ix-062', 10:08:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:08:57 INFO - 'use_talos_json': True, 10:08:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:08:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:08:57 INFO - 'work_dir': 'build'} 10:08:57 INFO - [mozharness: 2016-08-04 17:08:57.427923Z] Running clobber step. 10:08:57 INFO - Running pre-action listener: _resource_record_pre_action 10:08:57 INFO - Running main action method: clobber 10:08:57 INFO - rmtree: /builds/slave/test/build 10:08:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:08:57 INFO - Running post-action listener: _resource_record_post_action 10:08:57 INFO - [mozharness: 2016-08-04 17:08:57.880819Z] Finished clobber step (success) 10:08:57 INFO - [mozharness: 2016-08-04 17:08:57.880920Z] Running read-buildbot-config step. 10:08:57 INFO - Running pre-action listener: _resource_record_pre_action 10:08:57 INFO - Running main action method: read_buildbot_config 10:08:57 INFO - Using buildbot properties: 10:08:57 INFO - { 10:08:57 INFO - "project": "", 10:08:57 INFO - "product": "firefox", 10:08:57 INFO - "script_repo_revision": "production", 10:08:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:08:57 INFO - "repository": "", 10:08:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:08:57 INFO - "buildid": "20160804073001", 10:08:57 INFO - "pgo_build": "True", 10:08:57 INFO - "basedir": "/builds/slave/test", 10:08:57 INFO - "buildnumber": 823, 10:08:57 INFO - "slavename": "talos-linux64-ix-062", 10:08:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:08:57 INFO - "platform": "ubuntu64_hw", 10:08:57 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:08:57 INFO - "branch": "mozilla-central", 10:08:57 INFO - "repo_path": "mozilla-central", 10:08:57 INFO - "revision": "0ba72e8027cfcbcbf3426770ac264a7ade2af090", 10:08:57 INFO - "stage_platform": "linux64-pgo", 10:08:57 INFO - "builduid": "1d4fb0b0a96b4eacad6bf4a76ad4944d", 10:08:57 INFO - "slavebuilddir": "test" 10:08:57 INFO - } 10:08:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:08:57 INFO - Running post-action listener: _resource_record_post_action 10:08:57 INFO - [mozharness: 2016-08-04 17:08:57.883338Z] Finished read-buildbot-config step (success) 10:08:57 INFO - [mozharness: 2016-08-04 17:08:57.883426Z] Running download-and-extract step. 10:08:57 INFO - Running pre-action listener: _resource_record_pre_action 10:08:57 INFO - Running main action method: download_and_extract 10:08:57 INFO - mkdir: /builds/slave/test/build/tests 10:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:57 INFO - trying https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:08:57 INFO - Downloading https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/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 10:08:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/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 10:08:58 INFO - Downloaded 1361 bytes. 10:08:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:08:58 INFO - Using the following test package requirements: 10:08:58 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:08:58 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:08:58 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:08:58 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:58 INFO - u'jsshell-linux-x86_64.zip'], 10:08:58 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:08:58 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:08:58 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:08:58 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:08:58 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:08:58 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:08:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:08:58 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')]} 10:08:58 INFO - trying https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:08:58 INFO - Downloading https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/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 10:08:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/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 10:08:59 INFO - Downloaded 21820975 bytes. 10:08:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:08:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:09:00 INFO - Return code: 0 10:09: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 10:09: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')]} 10:09:00 INFO - trying https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:09:00 INFO - Downloading https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/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 10:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/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 10:09:01 INFO - Downloaded 21820975 bytes. 10:09:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:09:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:09:02 INFO - Return code: 0 10:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:02 INFO - trying https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:02 INFO - Downloading https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/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 10:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/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 10:09:04 INFO - Downloaded 14413723 bytes. 10:09:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:09:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:09:04 INFO - Return code: 0 10:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:04 INFO - trying https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:09:04 INFO - Downloading https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/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 10:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/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 10:09:06 INFO - Downloaded 59371755 bytes. 10:09:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:09:06 INFO - mkdir: /builds/slave/test/properties 10:09:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:09:06 INFO - Writing to file /builds/slave/test/properties/build_url 10:09:06 INFO - Contents: 10:09:06 INFO - build_url:https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:09:07 INFO - Running post-action listener: _resource_record_post_action 10:09:07 INFO - Running post-action listener: set_extra_try_arguments 10:09:07 INFO - [mozharness: 2016-08-04 17:09:07.541851Z] Finished download-and-extract step (success) 10:09:07 INFO - [mozharness: 2016-08-04 17:09:07.542085Z] Running populate-webroot step. 10:09:07 INFO - Running pre-action listener: _resource_record_pre_action 10:09:07 INFO - Running main action method: populate_webroot 10:09:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:09:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:09:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:09:07 INFO - '--tppagecycles', 10:09:07 INFO - '7'], 10:09:07 INFO - 'tests': ['tsvgm']}}, 10:09:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:09:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:09:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:09:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:09:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:09:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:09:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:07 INFO - 'talos_options': ['--disable-e10s'], 10:09:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:07 INFO - 'talos_options': ['--disable-e10s'], 10:09:07 INFO - 'tests': ['damp', 'tps']}, 10:09:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:07 INFO - 'tests': ['damp', 'tps']}, 10:09:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:09:07 INFO - 'tests': ['dromaeo_dom']}, 10:09:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:09:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:09:07 INFO - 'tests': ['basic_compositor_video']}, 10:09:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:09:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:09:07 INFO - 'tests': ['a11yr', 10:09:07 INFO - 'ts_paint', 10:09:07 INFO - 'tpaint', 10:09:07 INFO - 'sessionrestore', 10:09:07 INFO - 'sessionrestore_no_auto_restore', 10:09:07 INFO - 'tabpaint']}, 10:09:07 INFO - 'other-e10s': {'tests': ['a11yr', 10:09:07 INFO - 'ts_paint', 10:09:07 INFO - 'tpaint', 10:09:07 INFO - 'sessionrestore', 10:09:07 INFO - 'sessionrestore_no_auto_restore', 10:09:07 INFO - 'tabpaint']}, 10:09:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:09:07 INFO - 'ts_paint', 10:09:07 INFO - 'tpaint', 10:09:07 INFO - 'sessionrestore', 10:09:07 INFO - 'sessionrestore_no_auto_restore', 10:09:07 INFO - 'tabpaint']}, 10:09:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:09:07 INFO - 'ts_paint', 10:09:07 INFO - 'tpaint', 10:09:07 INFO - 'sessionrestore', 10:09:07 INFO - 'sessionrestore_no_auto_restore', 10:09:07 INFO - 'tabpaint']}, 10:09:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:09:07 INFO - 'tests': ['a11yr', 10:09:07 INFO - 'ts_paint', 10:09:07 INFO - 'tpaint', 10:09:07 INFO - 'sessionrestore', 10:09:07 INFO - 'sessionrestore_no_auto_restore', 10:09:07 INFO - 'tabpaint']}, 10:09:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:09:07 INFO - 'tests': ['a11yr', 10:09:07 INFO - 'ts_paint', 10:09:07 INFO - 'tpaint', 10:09:07 INFO - 'sessionrestore', 10:09:07 INFO - 'sessionrestore_no_auto_restore', 10:09:07 INFO - 'tabpaint']}, 10:09:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:09:07 INFO - 'tests': ['tsvgx', 10:09:07 INFO - 'tsvgr_opacity', 10:09:07 INFO - 'tart', 10:09:07 INFO - 'tscrollx', 10:09:07 INFO - 'cart']}, 10:09:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:09:07 INFO - 'tsvgr_opacity', 10:09:07 INFO - 'tart', 10:09:07 INFO - 'tscrollx', 10:09:07 INFO - 'cart']}, 10:09:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:07 INFO - 'talos_options': ['--disable-e10s'], 10:09:07 INFO - 'tests': ['tp5o']}, 10:09:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:07 INFO - 'tests': ['tp5o']}, 10:09:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:07 INFO - 'talos_options': ['--disable-e10s', 10:09:07 INFO - '--xperf_path', 10:09:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:07 INFO - 'tests': ['tp5n']}, 10:09:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:07 INFO - 'talos_options': ['--xperf_path', 10:09:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:07 INFO - 'tests': ['tp5n']}}, 10:09:07 INFO - 'talos.zip': {'path': '', 10:09:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:09:07 INFO - Running post-action listener: _resource_record_post_action 10:09:07 INFO - [mozharness: 2016-08-04 17:09:07.564570Z] Finished populate-webroot step (success) 10:09:07 INFO - [mozharness: 2016-08-04 17:09:07.564669Z] Running create-virtualenv step. 10:09:07 INFO - Running pre-action listener: _resource_record_pre_action 10:09:07 INFO - Running main action method: create_virtualenv 10:09:07 INFO - Creating virtualenv /builds/slave/test/build/venv 10:09:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:09:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:09:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:09:07 INFO - Using real prefix '/usr' 10:09:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:09:08 INFO - Installing distribute.............................................................................................................................................................................................done. 10:09:10 INFO - Installing pip.................done. 10:09:10 INFO - Return code: 0 10:09:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20403b0>, '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 0x20412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2041740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', '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 10:09:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:09:10 INFO - Using env: {'DISPLAY': ':0', 10:09:10 INFO - 'HOME': '/home/cltbld', 10:09:10 INFO - 'LANG': 'en_US.UTF-8', 10:09:10 INFO - 'LANGUAGE': 'en_US:en', 10:09:10 INFO - 'LOGNAME': 'cltbld', 10:09:10 INFO - 'MAIL': '/var/mail/cltbld', 10:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:10 INFO - 'MOZ_NO_REMOTE': '1', 10:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:10 INFO - 'NO_EM_RESTART': '1', 10:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:10 INFO - 'PWD': '/builds/slave/test', 10:09:10 INFO - 'SHELL': '/bin/bash', 10:09:10 INFO - 'SHLVL': '1', 10:09:10 INFO - 'TERM': 'linux', 10:09:10 INFO - 'TMOUT': '86400', 10:09:10 INFO - 'USER': 'cltbld', 10:09:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', 10:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:10 INFO - '_': '/tools/buildbot/bin/python'} 10:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:09:10 INFO - Cleaning up... 10:09:10 INFO - Return code: 0 10:09:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20403b0>, '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 0x20412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2041740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', '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 10:09:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:09:10 INFO - Using env: {'DISPLAY': ':0', 10:09:10 INFO - 'HOME': '/home/cltbld', 10:09:10 INFO - 'LANG': 'en_US.UTF-8', 10:09:10 INFO - 'LANGUAGE': 'en_US:en', 10:09:10 INFO - 'LOGNAME': 'cltbld', 10:09:10 INFO - 'MAIL': '/var/mail/cltbld', 10:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:10 INFO - 'MOZ_NO_REMOTE': '1', 10:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:10 INFO - 'NO_EM_RESTART': '1', 10:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:10 INFO - 'PWD': '/builds/slave/test', 10:09:10 INFO - 'SHELL': '/bin/bash', 10:09:10 INFO - 'SHLVL': '1', 10:09:10 INFO - 'TERM': 'linux', 10:09:10 INFO - 'TMOUT': '86400', 10:09:10 INFO - 'USER': 'cltbld', 10:09:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', 10:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:10 INFO - '_': '/tools/buildbot/bin/python'} 10:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:10 INFO - Downloading/unpacking psutil>=3.1.1 10:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:09:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:12 INFO - Installing collected packages: psutil 10:09:12 INFO - Running setup.py install for psutil 10:09:12 INFO - building 'psutil._psutil_linux' extension 10:09:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:09:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:09:12 INFO - building 'psutil._psutil_posix' extension 10:09:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:09:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:09:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:13 INFO - Successfully installed psutil 10:09:13 INFO - Cleaning up... 10:09:13 INFO - Return code: 0 10:09:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20403b0>, '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 0x20412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2041740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', '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 10:09:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:09:13 INFO - Using env: {'DISPLAY': ':0', 10:09:13 INFO - 'HOME': '/home/cltbld', 10:09:13 INFO - 'LANG': 'en_US.UTF-8', 10:09:13 INFO - 'LANGUAGE': 'en_US:en', 10:09:13 INFO - 'LOGNAME': 'cltbld', 10:09:13 INFO - 'MAIL': '/var/mail/cltbld', 10:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:13 INFO - 'MOZ_NO_REMOTE': '1', 10:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:13 INFO - 'NO_EM_RESTART': '1', 10:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:13 INFO - 'PWD': '/builds/slave/test', 10:09:13 INFO - 'SHELL': '/bin/bash', 10:09:13 INFO - 'SHLVL': '1', 10:09:13 INFO - 'TERM': 'linux', 10:09:13 INFO - 'TMOUT': '86400', 10:09:13 INFO - 'USER': 'cltbld', 10:09:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', 10:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:13 INFO - '_': '/tools/buildbot/bin/python'} 10:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:09:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:09:15 INFO - Installing collected packages: mozsystemmonitor 10:09:15 INFO - Running setup.py install for mozsystemmonitor 10:09:15 INFO - Successfully installed mozsystemmonitor 10:09:15 INFO - Cleaning up... 10:09:15 INFO - Return code: 0 10:09:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20403b0>, '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 0x20412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2041740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', '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 10:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:09:15 INFO - Using env: {'DISPLAY': ':0', 10:09:15 INFO - 'HOME': '/home/cltbld', 10:09:15 INFO - 'LANG': 'en_US.UTF-8', 10:09:15 INFO - 'LANGUAGE': 'en_US:en', 10:09:15 INFO - 'LOGNAME': 'cltbld', 10:09:15 INFO - 'MAIL': '/var/mail/cltbld', 10:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:15 INFO - 'MOZ_NO_REMOTE': '1', 10:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:15 INFO - 'NO_EM_RESTART': '1', 10:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:15 INFO - 'PWD': '/builds/slave/test', 10:09:15 INFO - 'SHELL': '/bin/bash', 10:09:15 INFO - 'SHLVL': '1', 10:09:15 INFO - 'TERM': 'linux', 10:09:15 INFO - 'TMOUT': '86400', 10:09:15 INFO - 'USER': 'cltbld', 10:09:15 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', 10:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:15 INFO - '_': '/tools/buildbot/bin/python'} 10:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:15 INFO - Downloading/unpacking jsonschema==2.5.1 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:09:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:17 INFO - Downloading functools32-3.2.3-2.tar.gz 10:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:09:18 INFO - warning: no files found matching '*.txt' 10:09:18 INFO - no previously-included directories found matching 'build' 10:09:18 INFO - no previously-included directories found matching 'dist' 10:09:18 INFO - no previously-included directories found matching '.git*' 10:09:18 INFO - Installing collected packages: jsonschema, functools32 10:09:18 INFO - Running setup.py install for functools32 10:09:18 INFO - warning: no files found matching '*.txt' 10:09:18 INFO - no previously-included directories found matching 'build' 10:09:18 INFO - no previously-included directories found matching 'dist' 10:09:18 INFO - no previously-included directories found matching '.git*' 10:09:18 INFO - Successfully installed jsonschema functools32 10:09:18 INFO - Cleaning up... 10:09:18 INFO - Return code: 0 10:09:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20403b0>, '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 0x20412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2041740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', '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 10:09:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:09:18 INFO - Using env: {'DISPLAY': ':0', 10:09:18 INFO - 'HOME': '/home/cltbld', 10:09:18 INFO - 'LANG': 'en_US.UTF-8', 10:09:18 INFO - 'LANGUAGE': 'en_US:en', 10:09:18 INFO - 'LOGNAME': 'cltbld', 10:09:18 INFO - 'MAIL': '/var/mail/cltbld', 10:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:18 INFO - 'MOZ_NO_REMOTE': '1', 10:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:18 INFO - 'NO_EM_RESTART': '1', 10:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:18 INFO - 'PWD': '/builds/slave/test', 10:09:18 INFO - 'SHELL': '/bin/bash', 10:09:18 INFO - 'SHLVL': '1', 10:09:18 INFO - 'TERM': 'linux', 10:09:18 INFO - 'TMOUT': '86400', 10:09:18 INFO - 'USER': 'cltbld', 10:09:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', 10:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:18 INFO - '_': '/tools/buildbot/bin/python'} 10:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:09:18 INFO - Cleaning up... 10:09:18 INFO - Return code: 0 10:09:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20403b0>, '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 0x20412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2041740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', '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 10:09:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:09:18 INFO - Using env: {'DISPLAY': ':0', 10:09:18 INFO - 'HOME': '/home/cltbld', 10:09:18 INFO - 'LANG': 'en_US.UTF-8', 10:09:18 INFO - 'LANGUAGE': 'en_US:en', 10:09:18 INFO - 'LOGNAME': 'cltbld', 10:09:18 INFO - 'MAIL': '/var/mail/cltbld', 10:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:18 INFO - 'MOZ_NO_REMOTE': '1', 10:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:18 INFO - 'NO_EM_RESTART': '1', 10:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:18 INFO - 'PWD': '/builds/slave/test', 10:09:18 INFO - 'SHELL': '/bin/bash', 10:09:18 INFO - 'SHLVL': '1', 10:09:18 INFO - 'TERM': 'linux', 10:09:18 INFO - 'TMOUT': '86400', 10:09:18 INFO - 'USER': 'cltbld', 10:09:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', 10:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:18 INFO - '_': '/tools/buildbot/bin/python'} 10:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:18 INFO - Downloading/unpacking blobuploader==1.2.4 10:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:21 INFO - Downloading blobuploader-1.2.4.tar.gz 10:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:09:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:09:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:22 INFO - Downloading docopt-0.6.1.tar.gz 10:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:09:22 INFO - Installing collected packages: blobuploader, requests, docopt 10:09:22 INFO - Running setup.py install for blobuploader 10:09:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:09:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:09:22 INFO - Running setup.py install for requests 10:09:23 INFO - Running setup.py install for docopt 10:09:23 INFO - Successfully installed blobuploader requests docopt 10:09:23 INFO - Cleaning up... 10:09:23 INFO - Return code: 0 10:09:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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 0x1d81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20403b0>, '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 0x20412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2041740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', '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 10:09: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 10:09: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 10:09:23 INFO - Using env: {'DISPLAY': ':0', 10:09:23 INFO - 'HOME': '/home/cltbld', 10:09:23 INFO - 'LANG': 'en_US.UTF-8', 10:09:23 INFO - 'LANGUAGE': 'en_US:en', 10:09:23 INFO - 'LOGNAME': 'cltbld', 10:09:23 INFO - 'MAIL': '/var/mail/cltbld', 10:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:23 INFO - 'MOZ_NO_REMOTE': '1', 10:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:23 INFO - 'NO_EM_RESTART': '1', 10:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:23 INFO - 'PWD': '/builds/slave/test', 10:09:23 INFO - 'SHELL': '/bin/bash', 10:09:23 INFO - 'SHLVL': '1', 10:09:23 INFO - 'TERM': 'linux', 10:09:23 INFO - 'TMOUT': '86400', 10:09:23 INFO - 'USER': 'cltbld', 10:09:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', 10:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:23 INFO - '_': '/tools/buildbot/bin/python'} 10:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:23 INFO - Running setup.py (path:/tmp/pip-QuKVxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:23 INFO - Running setup.py (path:/tmp/pip-8NDYCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:23 INFO - Running setup.py (path:/tmp/pip-71WKrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:23 INFO - Running setup.py (path:/tmp/pip-4faDgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:23 INFO - Running setup.py (path:/tmp/pip-vv2Oze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:24 INFO - Running setup.py (path:/tmp/pip-Q8MS96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:24 INFO - Running setup.py (path:/tmp/pip-Y1g9d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:24 INFO - Running setup.py (path:/tmp/pip-eCHwSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:24 INFO - Running setup.py (path:/tmp/pip-3U_Z5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:24 INFO - Running setup.py (path:/tmp/pip-xbuuiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:24 INFO - Running setup.py (path:/tmp/pip-Oe0CB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:24 INFO - Running setup.py (path:/tmp/pip-B5Pl3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:24 INFO - Running setup.py (path:/tmp/pip-dgC9LH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:24 INFO - Running setup.py (path:/tmp/pip-fikdou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:24 INFO - Running setup.py (path:/tmp/pip-4gLQOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:24 INFO - Running setup.py (path:/tmp/pip-M9hoMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:24 INFO - Running setup.py (path:/tmp/pip-2hV0Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:09:24 INFO - Running setup.py install for manifestparser 10:09:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:09:25 INFO - Running setup.py install for mozcrash 10:09:25 INFO - Running setup.py install for mozdebug 10:09:25 INFO - Running setup.py install for mozdevice 10:09:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:09:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:09:25 INFO - Running setup.py install for mozfile 10:09:25 INFO - Running setup.py install for mozhttpd 10:09:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:09:25 INFO - Running setup.py install for mozinfo 10:09:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:09:25 INFO - Running setup.py install for mozInstall 10:09:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:09:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:09:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:09:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:09:25 INFO - Running setup.py install for mozleak 10:09:25 INFO - Running setup.py install for mozlog 10:09:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:09:25 INFO - Running setup.py install for moznetwork 10:09:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:09:26 INFO - Running setup.py install for mozprocess 10:09:26 INFO - Running setup.py install for mozprofile 10:09:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:09:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:09:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:09:26 INFO - Running setup.py install for mozrunner 10:09:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:09:26 INFO - Running setup.py install for mozscreenshot 10:09:26 INFO - Running setup.py install for moztest 10:09:26 INFO - Running setup.py install for mozversion 10:09:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:09:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:09:26 INFO - Cleaning up... 10:09:26 INFO - Return code: 0 10:09:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:26 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 0x1d81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20403b0>, '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 0x20412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2041740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', '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 10:09:26 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 10:09:26 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 10:09:26 INFO - Using env: {'DISPLAY': ':0', 10:09:26 INFO - 'HOME': '/home/cltbld', 10:09:26 INFO - 'LANG': 'en_US.UTF-8', 10:09:26 INFO - 'LANGUAGE': 'en_US:en', 10:09:26 INFO - 'LOGNAME': 'cltbld', 10:09:26 INFO - 'MAIL': '/var/mail/cltbld', 10:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:26 INFO - 'MOZ_NO_REMOTE': '1', 10:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:26 INFO - 'NO_EM_RESTART': '1', 10:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:26 INFO - 'PWD': '/builds/slave/test', 10:09:26 INFO - 'SHELL': '/bin/bash', 10:09:26 INFO - 'SHLVL': '1', 10:09:26 INFO - 'TERM': 'linux', 10:09:26 INFO - 'TMOUT': '86400', 10:09:26 INFO - 'USER': 'cltbld', 10:09:26 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', 10:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:26 INFO - '_': '/tools/buildbot/bin/python'} 10:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:26 INFO - Running setup.py (path:/tmp/pip-2oUne8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:26 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)) 10:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:26 INFO - Running setup.py (path:/tmp/pip-JHEgOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09: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)) 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:27 INFO - Running setup.py (path:/tmp/pip-SlYBPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09: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)) 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:27 INFO - Running setup.py (path:/tmp/pip-aCLSAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09: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)) 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:27 INFO - Running setup.py (path:/tmp/pip-3OSgJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09: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)) 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:27 INFO - Running setup.py (path:/tmp/pip-0me3b5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09: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)) 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:27 INFO - Running setup.py (path:/tmp/pip-YmPZyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09: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)) 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:27 INFO - Running setup.py (path:/tmp/pip-CEuGnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09: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)) 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:27 INFO - Running setup.py (path:/tmp/pip-tQbOfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09: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)) 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:27 INFO - Running setup.py (path:/tmp/pip-F2_JG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:27 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)) 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:27 INFO - Running setup.py (path:/tmp/pip-9uI1Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:27 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)) 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:27 INFO - Running setup.py (path:/tmp/pip-8NXOai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:27 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)) 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:27 INFO - Running setup.py (path:/tmp/pip-QLVs0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:27 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)) 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:27 INFO - Running setup.py (path:/tmp/pip-k7pV0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:27 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)) 10:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:27 INFO - Running setup.py (path:/tmp/pip-atOAFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09: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)) 10:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:28 INFO - Running setup.py (path:/tmp/pip-X3ILbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09: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)) 10:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:28 INFO - Running setup.py (path:/tmp/pip-cGvmdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09: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)) 10:09: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)) 10:09: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)) 10:09: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)) 10:09: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)) 10:09: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)) 10:09:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:30 INFO - Downloading blessings-1.6.tar.gz 10:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:09:30 INFO - Installing collected packages: blessings 10:09:30 INFO - Running setup.py install for blessings 10:09:30 INFO - Successfully installed blessings 10:09:30 INFO - Cleaning up... 10:09:30 INFO - Return code: 0 10:09:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:09:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:30 INFO - Reading from file tmpfile_stdout 10:09:30 INFO - Current package versions: 10:09:30 INFO - argparse == 1.2.1 10:09:30 INFO - blessings == 1.6 10:09:30 INFO - blobuploader == 1.2.4 10:09:30 INFO - docopt == 0.6.1 10:09:30 INFO - functools32 == 3.2.3-2 10:09:30 INFO - jsonschema == 2.5.1 10:09:30 INFO - manifestparser == 1.1 10:09:30 INFO - mozInstall == 1.12 10:09:30 INFO - mozcrash == 0.17 10:09:30 INFO - mozdebug == 0.1 10:09:30 INFO - mozdevice == 0.48 10:09:30 INFO - mozfile == 1.2 10:09:30 INFO - mozhttpd == 0.7 10:09:30 INFO - mozinfo == 0.9 10:09:30 INFO - mozleak == 0.1 10:09:30 INFO - mozlog == 3.3 10:09:30 INFO - moznetwork == 0.27 10:09:30 INFO - mozprocess == 0.23 10:09:30 INFO - mozprofile == 0.28 10:09:30 INFO - mozrunner == 6.12 10:09:30 INFO - mozscreenshot == 0.1 10:09:30 INFO - mozsystemmonitor == 0.3 10:09:30 INFO - moztest == 0.7 10:09:30 INFO - mozversion == 1.4 10:09:30 INFO - psutil == 3.1.1 10:09:30 INFO - requests == 1.2.3 10:09:30 INFO - wsgiref == 0.1.2 10:09:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:30 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 0x1d81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20403b0>, '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 0x20412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2041740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', '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 10:09:30 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 10:09:30 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 10:09:30 INFO - Using env: {'DISPLAY': ':0', 10:09:30 INFO - 'HOME': '/home/cltbld', 10:09:30 INFO - 'LANG': 'en_US.UTF-8', 10:09:30 INFO - 'LANGUAGE': 'en_US:en', 10:09:30 INFO - 'LOGNAME': 'cltbld', 10:09:30 INFO - 'MAIL': '/var/mail/cltbld', 10:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:30 INFO - 'MOZ_NO_REMOTE': '1', 10:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:30 INFO - 'NO_EM_RESTART': '1', 10:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:30 INFO - 'PWD': '/builds/slave/test', 10:09:30 INFO - 'SHELL': '/bin/bash', 10:09:30 INFO - 'SHLVL': '1', 10:09:30 INFO - 'TERM': 'linux', 10:09:30 INFO - 'TMOUT': '86400', 10:09:30 INFO - 'USER': 'cltbld', 10:09:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', 10:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:30 INFO - '_': '/tools/buildbot/bin/python'} 10:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 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)) 10:09:30 INFO - Cleaning up... 10:09:30 INFO - Return code: 0 10:09:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:30 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 0x1d81030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20403b0>, '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 0x20412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2041740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', '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 10:09:30 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 10:09:30 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 10:09:30 INFO - Using env: {'DISPLAY': ':0', 10:09:30 INFO - 'HOME': '/home/cltbld', 10:09:30 INFO - 'LANG': 'en_US.UTF-8', 10:09:30 INFO - 'LANGUAGE': 'en_US:en', 10:09:30 INFO - 'LOGNAME': 'cltbld', 10:09:30 INFO - 'MAIL': '/var/mail/cltbld', 10:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:30 INFO - 'MOZ_NO_REMOTE': '1', 10:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:30 INFO - 'NO_EM_RESTART': '1', 10:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:30 INFO - 'PWD': '/builds/slave/test', 10:09:30 INFO - 'SHELL': '/bin/bash', 10:09:30 INFO - 'SHLVL': '1', 10:09:30 INFO - 'TERM': 'linux', 10:09:30 INFO - 'TMOUT': '86400', 10:09:30 INFO - 'USER': 'cltbld', 10:09:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', 10:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:30 INFO - '_': '/tools/buildbot/bin/python'} 10:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:09:30 INFO - Cleaning up... 10:09:30 INFO - Return code: 0 10:09:30 INFO - Running post-action listener: _resource_record_post_action 10:09:30 INFO - Running post-action listener: _start_resource_monitoring 10:09:31 INFO - Starting resource monitoring. 10:09:31 INFO - [mozharness: 2016-08-04 17:09:31.019262Z] Finished create-virtualenv step (success) 10:09:31 INFO - [mozharness: 2016-08-04 17:09:31.019698Z] Running install step. 10:09:31 INFO - Running pre-action listener: _resource_record_pre_action 10:09:31 INFO - Running main action method: install 10:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:31 INFO - Reading from file tmpfile_stdout 10:09:31 INFO - Detecting whether we're running mozinstall >=1.0... 10:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:09:31 INFO - Reading from file tmpfile_stdout 10:09:31 INFO - Output received: 10:09:31 INFO - Usage: mozinstall [options] installer 10:09:31 INFO - Options: 10:09:31 INFO - -h, --help show this help message and exit 10:09:31 INFO - -d DEST, --destination=DEST 10:09:31 INFO - Directory to install application into. [default: 10:09:31 INFO - "/builds/slave/test"] 10:09:31 INFO - --app=APP Application being installed. [default: firefox] 10:09:31 INFO - mkdir: /builds/slave/test/build/application 10:09: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'] 10:09: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 10:09:48 INFO - Reading from file tmpfile_stdout 10:09:48 INFO - Output received: 10:09:48 INFO - /builds/slave/test/build/application/firefox/firefox 10:09:48 INFO - Running post-action listener: _resource_record_post_action 10:09:48 INFO - [mozharness: 2016-08-04 17:09:48.184430Z] Finished install step (success) 10:09:48 INFO - [mozharness: 2016-08-04 17:09:48.184751Z] Running run-tests step. 10:09:48 INFO - Running pre-action listener: _resource_record_pre_action 10:09:48 INFO - Running main action method: run_tests 10:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:09:48 INFO - Python 2.7.3 10:09:48 INFO - Return code: 0 10:09:48 INFO - grabbing minidump binary from tooltool 10:09: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')]} 10:09: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 0x20403b0>, '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 0x20412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2041740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:09: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 10:09: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 10:09: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 10:09:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:48 INFO - Return code: 0 10:09:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:09:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:09:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:09:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:09:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 10:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 10:09:48 INFO - Using env: {'DISPLAY': ':0', 10:09:48 INFO - 'HOME': '/home/cltbld', 10:09:48 INFO - 'LANG': 'en_US.UTF-8', 10:09:48 INFO - 'LANGUAGE': 'en_US:en', 10:09:48 INFO - 'LOGNAME': 'cltbld', 10:09:48 INFO - 'MAIL': '/var/mail/cltbld', 10:09:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:09:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:48 INFO - 'MOZ_NO_REMOTE': '1', 10:09:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:48 INFO - 'NO_EM_RESTART': '1', 10:09:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:48 INFO - 'PWD': '/builds/slave/test', 10:09:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:09:48 INFO - 'SHELL': '/bin/bash', 10:09:48 INFO - 'SHLVL': '1', 10:09:48 INFO - 'TERM': 'linux', 10:09:48 INFO - 'TMOUT': '86400', 10:09:48 INFO - 'USER': 'cltbld', 10:09:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077', 10:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:48 INFO - '_': '/tools/buildbot/bin/python'} 10:09:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 10:09:48 INFO - mozversion application_buildid: 20160804073001 10:09:48 INFO - mozversion application_changeset: 0ba72e8027cfcbcbf3426770ac264a7ade2af090 10:09:48 INFO - mozversion application_display_name: Nightly 10:09:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:48 INFO - mozversion application_name: Firefox 10:09:48 INFO - mozversion application_remotingname: firefox 10:09:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:09:48 INFO - mozversion application_vendor: Mozilla 10:09:48 INFO - mozversion application_version: 51.0a1 10:09:48 INFO - mozversion platform_buildid: 20160804073001 10:09:48 INFO - mozversion platform_changeset: 0ba72e8027cfcbcbf3426770ac264a7ade2af090 10:09:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:09:48 INFO - mozversion platform_version: 51.0a1 10:09:48 INFO - using testdate: 1470330588 10:09:48 INFO - actual date: 1470330588 10:09:48 INFO - starting webserver on 'localhost:35192' 10:09:48 INFO - SUITE-START | Running 2 tests 10:09:48 INFO - TEST-START | dromaeo_css 10:09:48 INFO - operating with platform_type : linux_ 10:09:48 INFO - Initialising browser for dromaeo_css test... 10:09:48 INFO - TEST-INFO | started process 17863 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphUP_In/profile http://localhost:35192/getInfo.html) 10:09:52 INFO - PROCESS | 17863 | __metrics Screen width/height:1600/1200 10:09:52 INFO - PROCESS | 17863 | colorDepth:24 10:09:52 INFO - PROCESS | 17863 | Browser inner width/height: 1024/697 10:09:52 INFO - PROCESS | 17863 | __metrics 10:09:52 INFO - PROCESS | 17863 | 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" 10:09:52 INFO - PROCESS | 17863 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:09:53 INFO - TEST-INFO | 17863: exit 0 10:09:53 INFO - Browser initialized. 10:09:53 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:53 INFO - TEST-INFO | started process 17947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphUP_In/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:05 INFO - PROCESS | 17947 | RSS: Main: 156475392 10:10:05 INFO - PROCESS | 17947 | 10:10:57 INFO - PROCESS | 17947 | 1470330657194 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] 10:13:06 INFO - PROCESS | 17947 | Cycle 1(1): loaded http://localhost:35192/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35192/tests/dromaeo/cssquery-ext.html) 10:13:07 INFO - PROCESS | 17947 | RSS: Main: 264695808 10:13:07 INFO - PROCESS | 17947 | 10:16:09 INFO - PROCESS | 17947 | Cycle 1(1): loaded http://localhost:35192/tests/dromaeo/cssquery-ext.html (next: http://localhost:35192/tests/dromaeo/cssquery-jquery.html) 10:16:10 INFO - PROCESS | 17947 | RSS: Main: 251416576 10:16:10 INFO - PROCESS | 17947 | 10:19:12 INFO - PROCESS | 17947 | Cycle 1(1): loaded http://localhost:35192/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35192/tests/dromaeo/cssquery-mootools.html) 10:19:13 INFO - PROCESS | 17947 | RSS: Main: 217546752 10:19:13 INFO - PROCESS | 17947 | 10:22:15 INFO - PROCESS | 17947 | Cycle 1(1): loaded http://localhost:35192/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35192/tests/dromaeo/cssquery-prototype.html) 10:22:15 INFO - PROCESS | 17947 | RSS: Main: 222171136 10:22:15 INFO - PROCESS | 17947 | 10:25:18 INFO - PROCESS | 17947 | Cycle 1(1): loaded http://localhost:35192/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35192/tests/dromaeo/cssquery-yui.html) 10:25:19 INFO - PROCESS | 17947 | RSS: Main: 185475072 10:25:19 INFO - PROCESS | 17947 | 10:28:22 INFO - PROCESS | 17947 | Cycle 1(1): loaded http://localhost:35192/tests/dromaeo/cssquery-yui.html (next: http://localhost:35192/tests/dromaeo/cssquery-dojo.html) 10:28:22 INFO - PROCESS | 17947 | RSS: Main: 279826432 10:28:22 INFO - PROCESS | 17947 | 10:28:22 INFO - PROCESS | 17947 | __start_tp_report 10:28:22 INFO - PROCESS | 17947 | _x_x_mozilla_page_load 10:28:22 INFO - PROCESS | 17947 | _x_x_mozilla_page_load_details 10:28:22 INFO - PROCESS | 17947 | |i|pagename|runs| 10:28:22 INFO - PROCESS | 17947 | |0;dojo.html;3018.185090025693;3021.652509961354;3037.2558723112843;3059.4798884189686;3078.5382192671095;5086.593072554196;5148.948510514893;5176.016556854204;5229.529342359187;5237.3453318335205;5171.043356978961;5204.531592156705;5229.084910140729;5281.419043905167;5289.8942021159555;4667.486576476585;4734.573888350048;4744.691595046328;4753.762311884409;4857.53853383928;4832.782524786393;4842.44311904132;4849.830255941043;4876.780544875489;4888.902221955559;4652.767361631939;4726.125666751627;4807.014562014779;4844.442889067749;4851.762800485872;4602.033572949685;4610.492845786961;4623.722576645412;4665.2768820832825;4757.429108506966;4645.396098507206;4685.6485763567525;4701.224297990828;4728.598069164125;4747.548982846624;5121.7439128043825;5161.638685292031;5217.973910130425;5244.265802787575;5252.343457067866;5509;5528.06022976095;5581.7209139543265;5625.54995600351;5634.4365563443735;5570.721463926788;5585.4562851333585;5595.664260144405;5681.119426488901;5694.202811606378;5100.770465329032;5183.170692689152;5205.609579281569;5228.5555727763185;5286.04851126797;5724.771009159587;5731.799387021434;5763.596548241667;5794;5796.88406231873;5516.310461192351;5563.638363506359;5573.386927437979;5573.693446860461;5584.6090773646265;5430.864228394243;5440.782368705287;5553.500184983371;5606.21512988182;5648.8870222595315;5585.609007369527;5591.916121258185;5594.692291923983;5627.971860140673;5636.267285252891;5531.612787104945;5553.666779993213;5555.083411237181;5561.5272701820795;5562.915231529893;4298.570142985676;4350.934735978963;4369.2572262714775;4394.956050439455;4411.492678341968;3867.3038853006165;3886.6696330812197;3894.065424298148;3909.9022524436546;3922;5352.090144675414;5358.6248962572245;5368.194770784336;5371.4628537146755;5476.534494568006;5426.8914621707345;5455.509004189642;5475.4524547545725;5627.071533197059;5707.029804933171;5204.34945631796;5225.033368826779;5250.264962905197;5267.683938963598;5304;4811.422629284508;4827.444843843003;4829.541193586604;4831.0820944020525;4861.756912154449;5636.887262254732;5743.1385292206505;5750.079987202112;5817.7382017809305;5852.326982397079;5623.044082505902;5631.971840140773;5639.379668236573;5674.375818660027;5683.943160568341;5894.882102357843;5901.5868889177345;5903.852403689943;5904.852378690567;5910.556708246812;5394.973025134849;5500.642458240201;5516.172574113915;5517.2551705519245;5521.5306698931045;5659.801906933238;5660.660360378391;5666.546676265972;5690.231818704422;5707.800226992035;5460.689434535603;5515.696636685021;5527.53015993645;5529.612927095065;5533.889322213614;5327.3074500314715;5415.512603865671;5422.403535611158;5468.945310546844;5594.244776955222;5399.190121481809;5433.782648694008;5440.047991601533;5442.210879422382;5490.725463726718;5518.392976772471;5526.557875370041;5567.331920169444;5573.164025396223;5575.330960284792;5245.265662807286;5306.389765177054;5314.229436731575;5379;5386.919196212139 10:28:22 INFO - PROCESS | 17947 | |1;ext.html;578.9131630255462;605.7637521366667;620.987580248395;633.480545952319;645.7546132469661;32393.67606323936;44316;44987.550124498746;45066.0986780265;45129.323060154085;45917.54082459174;46439;46443.76778116113;46474.767626161905;46532.76733616336;8199.877001844978;9003.819923601524;9122.133397327243;9161.17549420552;10591.311564748305;10502.947485262563;10887.074598659085;10901.400422976732;10911.07255883247;10923;10994.230403871732;10995.725106872313;11025.44872756363;11043.226974111816;11051.392173430459;8139.79650508742;10392;10698.679039628823;10920.453977301142;10954.835677464804;10601.628942986958;10802.189835762349;10802.351858888493;10819.35083894961;10823.729406764895;43428.3485747714;43932.341014884805;43974.560254397365;44009.77995110004;44013.77993110046;3533.5406397168463;3590.299891521154;3902.31709450845;4260.659147268211;4266.637335826458;33606.6639333606;33990.490142647635;34324.6567534324;34355.14112147191;35011.82494087513;3635.763675361093;3737.9439308410397;3752.3996160614442;3884.7280690351686;3923.5880232575455;357645;358417;360184;360188;360511;59828.70085649544;59977.400225998055;60089.69955150284;60271.39728602658;60297.08068975503;63120.68439657772;63136.684316578125;63138.68430657817;63264.68367658132;63318.36681633125;14855.777163342558;15045.699086018438;15055.322510487054;15064.924675376773;15080.095194288378;10360.222983276284;10551.050405463546;11168.609098681669;11332.773344533063;11395.259308144945;17261.827381726274;17539.473815785546;17672;17709.7343539847;17747;6146.6335460847895;6171;6263.467605253513;6294.464970477469;6298.590591611531;1005.4922264256504;1060.1148041385375;1072.828347464402;1116.4640972333325;1170.011340417346;32829.17927051795;33119.172020699676;33243.833780831425;33357.3328533428;33466.49800252998;1095.8794532601407;1139.9487023083982;1151.8963293303643;1160.7678464307173;1174.2308787744041;16456.439714476273;17406.65186696259;17422.738658920127;17431.389901353392;17775;522969;525978;528606;528760;530241;60809.391906080375;60818.479538011015;60948;61174.38825611776;61568.38431615626;1144.016146114341;1187.485955406846;1276.3809552366909;1340.557615986722;1352.8579499152645;30174.195158472674;32448.675513244565;34942;34961.82519087388;35023.64976350204;53264.804111753416;54285.45714542804;54299.72850135724;54341;54420.3673889784;478212;491198;492179;492329;493173;44969.55030449785;45528;45905;46620.53379466297;48177.27734083922;49036.509634903196;49251.75374123106;49347.50652493573;49738.75130624323;50275.74862125666;40082.59917400789;45953;46024.539754602025;46500.767496162305;47650.52349476461;42549.78725106355;43392.34911476267;43984.34023489714;44297.33553996628;44545.77727111473;43102.56897431111;43679.56320436755;43730;43828.34257486076;43944.121117578106;34715.652843471245;38446.2310753789;38508.42237366498;38526.42210366791;39617;28477.572836407886;29054.51249770969;29212.70787292185;29385;29450 10:28:22 INFO - PROCESS | 17947 | |2;jquery.html;369.4513647233859;376.41091691502794;386.1369838411151;395.33386244178564;421.05893328411014;16815.663686726257;19180.424587262405;19192.808071919295;19306.71039934402;20385.694214586754;20018.09918553665;20308.796912030874;20484.69272960907;20528.589428211428;20658.48353791156;5342.545883599899;5679.318481782171;5856.970715146418;5901.822945311626;5921.348651648315;5757.337906140785;5818.389069147742;5858.062709966406;5863.032599621079;5864.472197502224;5442.319710036246;5707.315122185343;5727.885442291152;5737.741801618937;5739.454751798572;5654.190658989125;5656.91514627281;5697.971510142444;5755.856103597402;5757.510611598019;5059.544640982329;5157.149070403379;5185.248139019821;5186.559142472895;5187.870303242411;24348.39129021771;24596.877015614806;24778;24784.3803904902;24844.130455434155;2058.98970505148;2168.544605632819;2455.8526488410753;2497.773399210853;3047.344820863525;10046.095851373411;10060.39637621745;10465.215108866789;10569.207309451822;10754.56981720738;1873.9718904216447;1891.527118220445;1927.7204805303152;1931.8357939575153;2014.8287395571394;78988.60505697492;79449;80040.59979700122;83470.58264708698;85758.14241857626;11297.830532542019;11425.485853136628;11461.192007958103;11571.942140289413;11584.189106762446;15818.130002849954;15842.76235856463;15861.841381586268;15895.125768082635;15963.920180399256;7505.587192704454;7591.696332146652;7644.464887457936;7677.424193185533;7768.41736869737;7016.824579385556;7060.152781666233;7102.325279098477;7294.963525182447;7312.744053958192;4810.254410566298;4818.397700287464;4886.169351210232;4925.162722337212;5003.174476211384;1891.2056936086876;1954.3159894036974;1978.5647157625299;1987.4633848860726;2014.21445636202;902.2421166220406;952.1668540027476;1053.1206442620344;1069.6095924987324;1075.8977897099762;19297.710534341997;20371.796282037285;20426.38720838377;20469.89765051195;20991.895040525003;951.8239125761756;998.2313618513704;1007.0483393193362;1007.8840933292619;1037.99481002596;10608.522616482276;11224.494897729459;11376.203665743318;11394.601188958346;11490.310581365145;489640;495123;496353;498069;500672;89891.10108898827;93681;94244.52877735705;96244.51877740567;96368.51815740876;958.7507248115401;969.2197780786535;988.9109980101681;992.4541502173776;1015.2284263959592;17283.395081172603;17716;18093.728594070835;18364;18626.72059919075;43191;43246.78376608097;43347.34978975381;43785.78107109444;44848.77575612101;57321.42678573161;59975.70012150086;60021.19936401915;60871;62837;8452.957735211285;8460.407771455939;8536.061033286458;8766.211041006085;8931.508767017616;9724.285785511236;13107.14803537767;13688.589342319747;13751.381187846771;14270.571882843531;11738.178327516991;11873.881261187278;11958.222715523463;11961.940190298992;12114.273143611412;11695.181337306307;11776.587819426622;11968.46141923633;12004.639860804189;12395.62813115608;12237.0822188338;12237.877621223673;12243.938780306042;12267.202631828903;12542.561010364594;7756.3019328260725;8122.147174546824;8592.570371481275;8679.17547832955;8979.730608081769;11860.703482413008;12110.849469300403;12120.575779847662;12236.388180590757;12252.203606765532 10:28:22 INFO - PROCESS | 17947 | |3;mootools.html;1290.877366650168;1446.276861569215;1494.2528735632181;1632.2083789362157;1810.3120814090635;8092.5549094799835;8260.669573217072;8307.543085130315;8328.167183281676;8667.523286219255;8244.34045276378;8408.495490270589;8645.221930026297;8648.956755216232;8649.740507784776;2409.337432206144;2450.2649205238445;2451.154351748644;2453;2454.165583701541;2329.9767002329927;2377.8573285602833;2378.7502312257225;2378.9762102379013;2396.25716028031;2333.125078095714;2336.6027775278244;2340.1692399198296;2343.0979073056824;2344.22640528626;2256.3907744908865;2258.3225032490186;2273.170292843117;2274.033535747309;2320.872352020638;2240.316703405461;2257.5146343536217;2259.9774002260096;2262.604044292242;2264.784845439681;8377.371697122679;8557.315414766803;8568.700095496628;8586.87119693205;8598.87101693475;5012.423571289312;5206.583473322125;5207.244949482304;5220.164773636238;5255.395629502618;3320.8671653133847;3342.5153352763955;3354.1614596350914;3377.5778027746533;3387.0685561470546;1104.9226554141214;1125.1448898836861;1146.329397302579;1154.584349634131;1171.1509155861932;11804.763904721944;11949.044076473949;12033.157678962476;12089.153759236857;12174;4601.378813860086;4641.559051890065;4813.566778989838;4815.422149342101;4830.468648448667;10267.845982310271;10273.691789246335;10289.794204115875;10290.639827605997;10310.123639490577;5267.473252674702;5284.260203571503;5288.629795914326;5292.047431462297;5293.867653308621;4249.383839343278;4595.2188128018315;4667.439907211156;4701.905961880811;4758.428988521399;4121.859448962253;4154.1068670236045;4244.87265382039;4273.205253793414;4277.721948073366;1277.4060062070996;1301.9218846869028;1311.6458556189775;1321.8149459075737;1325.5360623781598;907.878769719396;916.8716379706847;918.6555041859302;984.2627216701666;1005.2962925951863;5949.286085669661;6023.879522409527;6039.4262545058145;6156.753729850756;6243.906341404882;965.1844191658038;986.4032260482305;1012.698682193378;1066.5787014129376;1069.9893001070045;4086.203190377907;4159.584041595876;4224.8732538023905;4317.8272869084885;4339.717918335298;10391.012853778879;10609.787804243872;10717.517711702993;10744.570217191382;10746.24776265654;10603.89396106029;10618.309809862334;10639.202059845387;10721.571137154426;10769;7683.116441609175;7935.9206407936335;7949.251164743747;8227.218414250636;8338.749837504885;6006.099085137264;6031.4270144336215;6159.969200153971;6171.691415429301;6186.257649082139;9909.058639429242;9977.301588888708;10006.349587276804;10007.449590272605;10100.343477673927;9545;9906;9907.504624768588;10196.38821670702;10202.489875506344;6932.826679333057;7123.323284287984;7123.715051397886;7659;7845;8114.797130071795;8423.241908228289;8429;8521.360897932804;8609.569521523774;7596.936428899848;7607.923920760722;7743.5353878767455;7879.684812607661;7951.006124234471;7397.482176247611;7461.328480436787;7550.811229719081;7609.809754756176;7653.846923061619;6980.685869135799;7051.753188638373;7053.823654408681;7106.893396599158;7132.108486439195;5246.685198888079;5294.788208471618;5338.599605029716;5369.818639899216;5603.971980140073;5227.764750586157;5268.315119034654;5278.9472105278455;5316.813911513079;5613.382527921844 10:28:22 INFO - PROCESS | 17947 | |4;prototype.html;312.5733373944565;320.73859804259524;325.47435891035985;328.87667124828187;330.43990436210623;5214.973925130374;5256.973715131424;5267.683938963655;5282.973585132069;5295.152775555912;4939.580135688462;4944.456109827925;5093.9235911461265;5108.233764935261;5213.357792295425;4042.504273418839;4047.494063242095;4065.227606754722;4071.796410179494;4079.8776036718796;4057.6812535925797;4062.1875624874997;4063.6545893599077;4079.2453396121664;4084.448599439082;3764.7929363884973;3843.961560384388;4037.394390841368;4040.656544193747;4054.878353649395;4027.959720402817;4054.3918412238104;4062.9593704063022;4067.1458993611377;4070.7761073141114;3604.080959355374;3604.333198358312;3617.403128483797;3619.059044648384;3620.855165793365;4823.9517604824205;5055.469175736532;5115.2327150927285;5117.385913690381;5133.358330208724;4580.770556757478;4582.243929751587;4583.747893865836;4596.310553416981;4624.445066591997;5354.812581559627;5356.866078348073;5358.383785864637;5362.35651721792;5388.137897936312;3806;3875.476810630557;3879.321118804198;3891.4746509221177;3891.8983748775627;5517.393086760453;5556.527695145917;5576.888462230773;5577.832665020056;5591.552675785968;3936.6850651947775;3940.704447166474;3942.42834788954;3946.131850992777;3950.308695978192;4010.7593544387432;4032.6169013943627;4045.3122969095325;4047.3894338151727;4048.959510404858;4395.516493185747;4599.908001840012;4600.35595016698;4610.792514336796;4622.560856718606;5442.836714898559;5452.236686863842;5455.454454554513;5462.453754624506;5502.532284755761;1382.8202333696756;1387.2439520461373;1390.2145287912297;1400.6988497473092;1401.5655146904492;853.7694822398042;875.4222213339166;924.8474001789764;942.236788201559;942.3686130292721;5223.13818219997;5230.34620672416;5237.6382140642945;5238.71187084714;5263.6578622389425;5443.809466668727;5484.451554844483;5484.945150548443;5485.862853428696;5506.256655351556;5035.949640503622;5192.9614077184715;5231.03836061477;5287.524122828964;5320.951433698054;2890.335222898745;2929.61914951055;2933.985330073336;2945.1164650604733;2952.6456825181117;5759.251297331404;5896.616719913192;5901.734421950937;5906.822795316148;5941.613795103304;5637.154426836008;5642.943570564242;5654.236678048493;5681.147827825776;5691.743871525791;5809.912851307318;5813.79651712188;5838.67887266196;5864.560157988168;5878.676672783038;5350.892982140257;5507.421720719267;5511.035568775528;5543.750531226024;5598.468145526169;5445.346558413015;5470.261514695465;5475.67145971243;5502.202180683858;5543.445655434424;5870.324912634931;5881.8826022208295;5885.61743486672;5900.43945825146;5956.136360227656;3734.178480734234;3907.277153726456;3909.6285852843935;4004.3593025115842;4005.839766409311;5347.208685090538;5438.075527160313;5574.219609254788;5583.274174357308;5621.325440947113;5368.865778355416;5376.301080859464;5384.030874442638;5412.377576578744;5419.647722897999;5228.790848366175;5359.544438722596;5408.296386638196;5419.647722897999;5430.456954304538;5310.734463276744;5328.786848526015;5367.704776237344;5374.543163831118;5374.973125134349;5374.435684253097;5419.861829015951;5457;5469.617126801086;5494.587905907153;5086.720230387365;5272.868178295574;5285.867853303698;5334.733263336895;5344.198370244494 10:28:22 INFO - PROCESS | 17947 | |5;yui.html;720.2941117704646;729.5330988167574;736.2159300345132;740.3300013487793;795.6618437164203;15684.45104421344;16104.11427371497;16228.83771162288;16350.83649163508;16367.508974730763;14847.480338188165;15114.697706045872;15170.924145379258;15192.696146077073;15226.390944362212;813.8738495533187;833.3333333333339;835.1606635331483;835.6699103853974;836.3560058754755;680.6528670378093;810.9189081091903;836.8117173635944;841.5455653946862;842.1031601344579;878.4465786554462;883.4566741453991;885.0308911741665;885.1856292211149;885.3138817416522;877.298161470824;878.3939082033409;878.5782824244399;880.018779061342;880.3089574683875;510.71910449253136;619.6344156947378;625.5589809184514;626.1265534579281;626.6115008694593;15004.324805383783;15093.622659433493;15137.243137843174;15138.545843624708;15206.923965380101;14129.222892740896;14334.72553699286;14389.280535973265;14631.780523292158;14966.17686027268;13496.607612138696;13566;13636.522721704792;13714.45142194321;14374;4187.874363769061;4262.7868606569855;4282.078451955354;4349.217140914634;4376.562343765598;76953.23046769573;77902;79132.60433697852;80139;82647.9999999994;10616.363018218932;10744.30162039465;10881.12950963921;11126;11411.885881141248;21970.670439943413;22071.227507037496;22081.116755329607;22092.226772062902;22099.779002209772;7806.453548251681;7878.803029924183;8039.437239393304;8096;8200.5489698066;4537.931931021038;4576.702514336557;4694.319323698045;4732.858014259577;4783.162946484351;3401.795892246473;3473.843677034489;3501.632328605511;3511.438169892805;3513.6837684607995;567.5402923631872;568.6133429268054;572.8510587247263;577.7515668262604;585.5520526797004;555.6166245290736;566.4250785452768;620.0420350558398;666.8899631560738;704.520925770481;9041.363890441618;9295.767605809773;9379.859302110473;9611;9696.854547181798;555.1866515554732;616.6300219868043;633.108921485581;658.1378394303478;664;4164.312888373384;4264.296391095435;4373.693841431133;4434.82260709568;4450.643948484114;120005.39997300132;121552;123548;130841.34579327232;131050;109677;109955;111021;111782;117235;55211;56644.43355566474;82432;88576.11423885936;91162.54418727863;8075.152109028702;8190.7952301192945;8316.5425901576;8422.157784221528;8427.410081294496;52254;54898;55760;56208.71895640659;56887.431125689865;78214;83492;83738.58130709307;86011.56994214989;87944.56027719821;11115.166362523005;11139.275947063416;11201.60794372193;11288.322700637988;11547.364894930859;12846.614601561969;13005.739885202433;13133.4392374903;13462.259575723428;13540;12372.690682733004;12397.256164630151;12646.957425440854;12696;13167.67080822987;11597.420128993685;12207.938960305142;12477.875221247672;12898.097133200587;12901.032422568158;12371.75256494847;12866.099373043797;12873.935630322163;13045.804312935503;13093.345332733135;10061.69814905554;10247.487625618838;10451.634192803216;10587.947060264649;10991.09436974593;9778.55996480146;9870.210383169186;10196.082352588302;10439.37363758177;10513.57945682164 10:28:22 INFO - PROCESS | 17947 | __end_tp_report 10:28:22 INFO - PROCESS | 17947 | __start_cc_report 10:28:22 INFO - PROCESS | 17947 | _x_x_mozilla_cycle_collect,934 10:28:22 INFO - PROCESS | 17947 | __end_cc_report 10:28:22 INFO - PROCESS | 17947 | __startTimestamp1470331702524__endTimestamp 10:28:22 INFO - PROCESS | 17947 | 10:28:22 INFO - PROCESS | 17947 | ------- Summary: start ------- 10:28:22 INFO - PROCESS | 17947 | Number of tests: 6 10:28:22 INFO - PROCESS | 17947 | 10:28:22 INFO - PROCESS | 17947 | [#0] dojo.html Cycles:165 Average:5207.37 Median:5415.51 stddev:587.35 (10.8%) stddev-sans-first:563.49 10:28:22 INFO - PROCESS | 17947 | Values: 3018.2 3021.7 3037.3 3059.5 3078.5 5086.6 5148.9 5176.0 5229.5 5237.3 5171.0 5204.5 5229.1 5281.4 5289.9 4667.5 4734.6 4744.7 4753.8 4857.5 4832.8 4842.4 4849.8 4876.8 4888.9 4652.8 4726.1 4807.0 4844.4 4851.8 4602.0 4610.5 4623.7 4665.3 4757.4 4645.4 4685.6 4701.2 4728.6 4747.5 5121.7 5161.6 5218.0 5244.3 5252.3 5509.0 5528.1 5581.7 5625.5 5634.4 5570.7 5585.5 5595.7 5681.1 5694.2 5100.8 5183.2 5205.6 5228.6 5286.0 5724.8 5731.8 5763.6 5794.0 5796.9 5516.3 5563.6 5573.4 5573.7 5584.6 5430.9 5440.8 5553.5 5606.2 5648.9 5585.6 5591.9 5594.7 5628.0 5636.3 5531.6 5553.7 5555.1 5561.5 5562.9 4298.6 4350.9 4369.3 4395.0 4411.5 3867.3 3886.7 3894.1 3909.9 3922.0 5352.1 5358.6 5368.2 5371.5 5476.5 5426.9 5455.5 5475.5 5627.1 5707.0 5204.3 5225.0 5250.3 5267.7 5304.0 4811.4 4827.4 4829.5 4831.1 4861.8 5636.9 5743.1 5750.1 5817.7 5852.3 5623.0 5632.0 5639.4 5674.4 5683.9 5894.9 5901.6 5903.9 5904.9 5910.6 5395.0 5500.6 5516.2 5517.3 5521.5 5659.8 5660.7 5666.5 5690.2 5707.8 5460.7 5515.7 5527.5 5529.6 5533.9 5327.3 5415.5 5422.4 5468.9 5594.2 5399.2 5433.8 5440.0 5442.2 5490.7 5518.4 5526.6 5567.3 5573.2 5575.3 5245.3 5306.4 5314.2 5379.0 5386.9 10:28:22 INFO - PROCESS | 17947 | 10:28:22 INFO - PROCESS | 17947 | [#1] ext.html Cycles:180 Average:63184.36 Median:3893.52 stddev:122925.23 (3157.2%) stddev-sans-first:123180.19 10:28:22 INFO - PROCESS | 17947 | Values: 578.9 605.8 621.0 633.5 645.8 32393.7 44316.0 44987.6 45066.1 45129.3 45917.5 46439.0 46443.8 46474.8 46532.8 8199.9 9003.8 9122.1 9161.2 10591.3 10502.9 10887.1 10901.4 10911.1 10923.0 10994.2 10995.7 11025.4 11043.2 11051.4 8139.8 10392.0 10698.7 10920.5 10954.8 10601.6 10802.2 10802.4 10819.4 10823.7 43428.3 43932.3 43974.6 44009.8 44013.8 3533.5 3590.3 3902.3 4260.7 4266.6 33606.7 33990.5 34324.7 34355.1 35011.8 3635.8 3737.9 3752.4 3884.7 3923.6 357645.0 358417.0 360184.0 360188.0 360511.0 59828.7 59977.4 60089.7 60271.4 60297.1 63120.7 63136.7 63138.7 63264.7 63318.4 14855.8 15045.7 15055.3 15064.9 15080.1 10360.2 10551.1 11168.6 11332.8 11395.3 17261.8 17539.5 17672.0 17709.7 17747.0 6146.6 6171.0 6263.5 6294.5 6298.6 1005.5 1060.1 1072.8 1116.5 1170.0 32829.2 33119.2 33243.8 33357.3 33466.5 1095.9 1139.9 1151.9 1160.8 1174.2 16456.4 17406.7 17422.7 17431.4 17775.0 522969.0 525978.0 528606.0 528760.0 530241.0 60809.4 60818.5 60948.0 61174.4 61568.4 1144.0 1187.5 1276.4 1340.6 1352.9 30174.2 32448.7 34942.0 34961.8 35023.6 53264.8 54285.5 54299.7 54341.0 54420.4 478212.0 491198.0 492179.0 492329.0 493173.0 44969.6 45528.0 45905.0 46620.5 48177.3 49036.5 49251.8 49347.5 49738.8 50275.7 40082.6 45953.0 46024.5 46500.8 47650.5 42549.8 43392.3 43984.3 44297.3 44545.8 43102.6 43679.6 43730.0 43828.3 43944.1 34715.7 38446.2 38508.4 38526.4 39617.0 28477.6 29054.5 29212.7 29385.0 29450.0 10:28:22 INFO - PROCESS | 17947 | 10:28:22 INFO - PROCESS | 17947 | [#2] jquery.html Cycles:180 Average:29516.66 Median:1708.40 stddev:81815.25 (4789.0%) stddev-sans-first:82015.49 10:28:22 INFO - PROCESS | 17947 | Values: 369.5 376.4 386.1 395.3 421.1 16815.7 19180.4 19192.8 19306.7 20385.7 20018.1 20308.8 20484.7 20528.6 20658.5 5342.5 5679.3 5857.0 5901.8 5921.3 5757.3 5818.4 5858.1 5863.0 5864.5 5442.3 5707.3 5727.9 5737.7 5739.5 5654.2 5656.9 5698.0 5755.9 5757.5 5059.5 5157.1 5185.2 5186.6 5187.9 24348.4 24596.9 24778.0 24784.4 24844.1 2059.0 2168.5 2455.9 2497.8 3047.3 10046.1 10060.4 10465.2 10569.2 10754.6 1874.0 1891.5 1927.7 1931.8 2014.8 78988.6 79449.0 80040.6 83470.6 85758.1 11297.8 11425.5 11461.2 11571.9 11584.2 15818.1 15842.8 15861.8 15895.1 15963.9 7505.6 7591.7 7644.5 7677.4 7768.4 7016.8 7060.2 7102.3 7295.0 7312.7 4810.3 4818.4 4886.2 4925.2 5003.2 1891.2 1954.3 1978.6 1987.5 2014.2 902.2 952.2 1053.1 1069.6 1075.9 19297.7 20371.8 20426.4 20469.9 20991.9 951.8 998.2 1007.0 1007.9 1038.0 10608.5 11224.5 11376.2 11394.6 11490.3 489640.0 495123.0 496353.0 498069.0 500672.0 89891.1 93681.0 94244.5 96244.5 96368.5 958.8 969.2 988.9 992.5 1015.2 17283.4 17716.0 18093.7 18364.0 18626.7 43191.0 43246.8 43347.3 43785.8 44848.8 57321.4 59975.7 60021.2 60871.0 62837.0 8453.0 8460.4 8536.1 8766.2 8931.5 9724.3 13107.1 13688.6 13751.4 14270.6 11738.2 11873.9 11958.2 11961.9 12114.3 11695.2 11776.6 11968.5 12004.6 12395.6 12237.1 12237.9 12243.9 12267.2 12542.6 7756.3 8122.1 8592.6 8679.2 8979.7 11860.7 12110.8 12120.6 12236.4 12252.2 10:28:22 INFO - PROCESS | 17947 | 10:28:22 INFO - PROCESS | 17947 | [#3] mootools.html Cycles:180 Average:5756.35 Median:4786.00 stddev:3198.90 (66.8%) stddev-sans-first:3190.27 10:28:22 INFO - PROCESS | 17947 | Values: 1290.9 1446.3 1494.3 1632.2 1810.3 8092.6 8260.7 8307.5 8328.2 8667.5 8244.3 8408.5 8645.2 8649.0 8649.7 2409.3 2450.3 2451.2 2453.0 2454.2 2330.0 2377.9 2378.8 2379.0 2396.3 2333.1 2336.6 2340.2 2343.1 2344.2 2256.4 2258.3 2273.2 2274.0 2320.9 2240.3 2257.5 2260.0 2262.6 2264.8 8377.4 8557.3 8568.7 8586.9 8598.9 5012.4 5206.6 5207.2 5220.2 5255.4 3320.9 3342.5 3354.2 3377.6 3387.1 1104.9 1125.1 1146.3 1154.6 1171.2 11804.8 11949.0 12033.2 12089.2 12174.0 4601.4 4641.6 4813.6 4815.4 4830.5 10267.8 10273.7 10289.8 10290.6 10310.1 5267.5 5284.3 5288.6 5292.0 5293.9 4249.4 4595.2 4667.4 4701.9 4758.4 4121.9 4154.1 4244.9 4273.2 4277.7 1277.4 1301.9 1311.6 1321.8 1325.5 907.9 916.9 918.7 984.3 1005.3 5949.3 6023.9 6039.4 6156.8 6243.9 965.2 986.4 1012.7 1066.6 1070.0 4086.2 4159.6 4224.9 4317.8 4339.7 10391.0 10609.8 10717.5 10744.6 10746.2 10603.9 10618.3 10639.2 10721.6 10769.0 7683.1 7935.9 7949.3 8227.2 8338.7 6006.1 6031.4 6160.0 6171.7 6186.3 9909.1 9977.3 10006.3 10007.4 10100.3 9545.0 9906.0 9907.5 10196.4 10202.5 6932.8 7123.3 7123.7 7659.0 7845.0 8114.8 8423.2 8429.0 8521.4 8609.6 7596.9 7607.9 7743.5 7879.7 7951.0 7397.5 7461.3 7550.8 7609.8 7653.8 6980.7 7051.8 7053.8 7106.9 7132.1 5246.7 5294.8 5338.6 5369.8 5604.0 5227.8 5268.3 5278.9 5316.8 5613.4 10:28:22 INFO - PROCESS | 17947 | 10:28:22 INFO - PROCESS | 17947 | [#4] prototype.html Cycles:180 Average:4570.20 Median:5260.32 stddev:1348.92 (25.6%) stddev-sans-first:1314.30 10:28:22 INFO - PROCESS | 17947 | Values: 312.6 320.7 325.5 328.9 330.4 5215.0 5257.0 5267.7 5283.0 5295.2 4939.6 4944.5 5093.9 5108.2 5213.4 4042.5 4047.5 4065.2 4071.8 4079.9 4057.7 4062.2 4063.7 4079.2 4084.4 3764.8 3844.0 4037.4 4040.7 4054.9 4028.0 4054.4 4063.0 4067.1 4070.8 3604.1 3604.3 3617.4 3619.1 3620.9 4824.0 5055.5 5115.2 5117.4 5133.4 4580.8 4582.2 4583.7 4596.3 4624.4 5354.8 5356.9 5358.4 5362.4 5388.1 3806.0 3875.5 3879.3 3891.5 3891.9 5517.4 5556.5 5576.9 5577.8 5591.6 3936.7 3940.7 3942.4 3946.1 3950.3 4010.8 4032.6 4045.3 4047.4 4049.0 4395.5 4599.9 4600.4 4610.8 4622.6 5442.8 5452.2 5455.5 5462.5 5502.5 1382.8 1387.2 1390.2 1400.7 1401.6 853.8 875.4 924.8 942.2 942.4 5223.1 5230.3 5237.6 5238.7 5263.7 5443.8 5484.5 5484.9 5485.9 5506.3 5035.9 5193.0 5231.0 5287.5 5321.0 2890.3 2929.6 2934.0 2945.1 2952.6 5759.3 5896.6 5901.7 5906.8 5941.6 5637.2 5642.9 5654.2 5681.1 5691.7 5809.9 5813.8 5838.7 5864.6 5878.7 5350.9 5507.4 5511.0 5543.8 5598.5 5445.3 5470.3 5475.7 5502.2 5543.4 5870.3 5881.9 5885.6 5900.4 5956.1 3734.2 3907.3 3909.6 4004.4 4005.8 5347.2 5438.1 5574.2 5583.3 5621.3 5368.9 5376.3 5384.0 5412.4 5419.6 5228.8 5359.5 5408.3 5419.6 5430.5 5310.7 5328.8 5367.7 5374.5 5375.0 5374.4 5419.9 5457.0 5469.6 5494.6 5086.7 5272.9 5285.9 5334.7 5344.2 10:28:22 INFO - PROCESS | 17947 | 10:28:22 INFO - PROCESS | 17947 | [#5] yui.html Cycles:180 Average:21396.02 Median:4405.69 stddev:32173.32 (730.3%) stddev-sans-first:32226.12 10:28:22 INFO - PROCESS | 17947 | Values: 720.3 729.5 736.2 740.3 795.7 15684.5 16104.1 16228.8 16350.8 16367.5 14847.5 15114.7 15170.9 15192.7 15226.4 813.9 833.3 835.2 835.7 836.4 680.7 810.9 836.8 841.5 842.1 878.4 883.5 885.0 885.2 885.3 877.3 878.4 878.6 880.0 880.3 510.7 619.6 625.6 626.1 626.6 15004.3 15093.6 15137.2 15138.5 15206.9 14129.2 14334.7 14389.3 14631.8 14966.2 13496.6 13566.0 13636.5 13714.5 14374.0 4187.9 4262.8 4282.1 4349.2 4376.6 76953.2 77902.0 79132.6 80139.0 82648.0 10616.4 10744.3 10881.1 11126.0 11411.9 21970.7 22071.2 22081.1 22092.2 22099.8 7806.5 7878.8 8039.4 8096.0 8200.5 4537.9 4576.7 4694.3 4732.9 4783.2 3401.8 3473.8 3501.6 3511.4 3513.7 567.5 568.6 572.9 577.8 585.6 555.6 566.4 620.0 666.9 704.5 9041.4 9295.8 9379.9 9611.0 9696.9 555.2 616.6 633.1 658.1 664.0 4164.3 4264.3 4373.7 4434.8 4450.6 120005.4 121552.0 123548.0 130841.3 131050.0 109677.0 109955.0 111021.0 111782.0 117235.0 55211.0 56644.4 82432.0 88576.1 91162.5 8075.2 8190.8 8316.5 8422.2 8427.4 52254.0 54898.0 55760.0 56208.7 56887.4 78214.0 83492.0 83738.6 86011.6 87944.6 11115.2 11139.3 11201.6 11288.3 11547.4 12846.6 13005.7 13133.4 13462.3 13540.0 12372.7 12397.3 12647.0 12696.0 13167.7 11597.4 12207.9 12477.9 12898.1 12901.0 12371.8 12866.1 12873.9 13045.8 13093.3 10061.7 10247.5 10451.6 10587.9 10991.1 9778.6 9870.2 10196.1 10439.4 10513.6 10:28:22 INFO - PROCESS | 17947 | -------- Summary: end -------- 10:28:22 INFO - PROCESS | 17947 | 10:28:23 INFO - TEST-INFO | 17947: exit 0 10:28:23 INFO - TEST-OK | dromaeo_css | took 1114839ms 10:28:23 INFO - TEST-START | kraken 10:28:23 INFO - operating with platform_type : linux_ 10:28:23 INFO - Initialising browser for kraken test... 10:28:23 INFO - TEST-INFO | started process 18141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn3vQWk/profile http://localhost:35192/getInfo.html) 10:28:27 INFO - PROCESS | 18141 | __metrics Screen width/height:1600/1200 10:28:27 INFO - PROCESS | 18141 | colorDepth:24 10:28:27 INFO - PROCESS | 18141 | Browser inner width/height: 1024/697 10:28:27 INFO - PROCESS | 18141 | __metrics 10:28:27 INFO - PROCESS | 18141 | 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" 10:28:27 INFO - PROCESS | 18141 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:28:28 INFO - TEST-INFO | 18141: exit 0 10:28:28 INFO - Browser initialized. 10:28:28 INFO - Running cycle 1/1 for kraken test... 10:28:28 INFO - TEST-INFO | started process 18221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn3vQWk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:40 INFO - PROCESS | 18221 | RSS: Main: 156581888 10:28:40 INFO - PROCESS | 18221 | 10:28:43 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35192/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:43 INFO - PROCESS | 18221 | RSS: Main: 213172224 10:28:43 INFO - PROCESS | 18221 | 10:28:46 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35192/tests/kraken/driver.html?testName=audio-dft) 10:28:47 INFO - PROCESS | 18221 | RSS: Main: 186617856 10:28:47 INFO - PROCESS | 18221 | 10:28:50 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35192/tests/kraken/driver.html?testName=audio-fft) 10:28:50 INFO - PROCESS | 18221 | RSS: Main: 270487552 10:28:50 INFO - PROCESS | 18221 | 10:28:53 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35192/tests/kraken/driver.html?testName=audio-oscillator) 10:28:53 INFO - PROCESS | 18221 | RSS: Main: 180285440 10:28:53 INFO - PROCESS | 18221 | 10:28:55 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35192/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:56 INFO - PROCESS | 18221 | RSS: Main: 184254464 10:28:56 INFO - PROCESS | 18221 | 10:28:59 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35192/tests/kraken/driver.html?testName=imaging-darkroom) 10:29:00 INFO - PROCESS | 18221 | RSS: Main: 220991488 10:29:00 INFO - PROCESS | 18221 | 10:29:03 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35192/tests/kraken/driver.html?testName=imaging-desaturate) 10:29:03 INFO - PROCESS | 18221 | RSS: Main: 219570176 10:29:03 INFO - PROCESS | 18221 | 10:29:06 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35192/tests/kraken/driver.html?testName=json-parse-financial) 10:29:07 INFO - PROCESS | 18221 | RSS: Main: 219684864 10:29:07 INFO - PROCESS | 18221 | 10:29:08 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35192/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:29:09 INFO - PROCESS | 18221 | RSS: Main: 183685120 10:29:09 INFO - PROCESS | 18221 | 10:29:11 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:29:11 INFO - PROCESS | 18221 | RSS: Main: 189583360 10:29:11 INFO - PROCESS | 18221 | 10:29:13 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:29:14 INFO - PROCESS | 18221 | RSS: Main: 194785280 10:29:14 INFO - PROCESS | 18221 | 10:29:17 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:29:17 INFO - PROCESS | 18221 | RSS: Main: 187867136 10:29:17 INFO - PROCESS | 18221 | 10:29:20 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:29:21 INFO - PROCESS | 18221 | RSS: Main: 193146880 10:29:21 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35192/tests/kraken/driver.html?testName=ai-astar) 10:29:22 INFO - PROCESS | 18221 | RSS: Main: 243568640 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | __start_tp_report 10:29:22 INFO - PROCESS | 18221 | _x_x_mozilla_page_load 10:29:22 INFO - PROCESS | 18221 | _x_x_mozilla_page_load_details 10:29:22 INFO - PROCESS | 18221 | |i|pagename|runs| 10:29:22 INFO - PROCESS | 18221 | |0;ai-astar;103;110;112;111;115;111;111;111;110;111 10:29:22 INFO - PROCESS | 18221 | |1;audio-beat-detection;141;119;118;176;122;119;144;117;165;124 10:29:22 INFO - PROCESS | 18221 | |2;audio-dft;162;160;163;162;165;163;163;162;162;160 10:29:22 INFO - PROCESS | 18221 | |3;audio-fft;75;76;76;118;75;77;75;74;103;76 10:29:22 INFO - PROCESS | 18221 | |4;audio-oscillator;84;84;126;83;83;85;119;84;84;129 10:29:22 INFO - PROCESS | 18221 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;117;118;117 10:29:22 INFO - PROCESS | 18221 | |6;imaging-darkroom;146;147;146;146;146;146;146;149;146;146 10:29:22 INFO - PROCESS | 18221 | |7;imaging-desaturate;95;95;96;95;95;95;95;106;95;95 10:29:22 INFO - PROCESS | 18221 | |8;json-parse-financial;52;49;49;50;49;51;50;50;49;50 10:29:22 INFO - PROCESS | 18221 | |9;json-stringify-tinderbox;59;60;60;61;60;60;60;60;61;62 10:29:22 INFO - PROCESS | 18221 | |10;stanford-crypto-aes;75;76;86;79;75;75;75;77;85;79 10:29:22 INFO - PROCESS | 18221 | |11;stanford-crypto-ccm;137;129;123;132;121;130;127;125;153;139 10:29:22 INFO - PROCESS | 18221 | |12;stanford-crypto-pbkdf2;160;161;158;157;158;160;164;157;161;160 10:29:22 INFO - PROCESS | 18221 | |13;stanford-crypto-sha256-iterative;64;64;65;63;63;65;64;66;62;66 10:29:22 INFO - PROCESS | 18221 | __end_tp_report 10:29:22 INFO - PROCESS | 18221 | __start_cc_report 10:29:22 INFO - PROCESS | 18221 | _x_x_mozilla_cycle_collect,1671 10:29:22 INFO - PROCESS | 18221 | __end_cc_report 10:29:22 INFO - PROCESS | 18221 | __startTimestamp1470331762939__endTimestamp 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | ------- Summary: start ------- 10:29:22 INFO - PROCESS | 18221 | Number of tests: 14 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.99 (2.7%) stddev-sans-first:1.50 10:29:22 INFO - PROCESS | 18221 | Values: 103.0 110.0 112.0 111.0 115.0 111.0 111.0 111.0 110.0 111.0 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:132.50 stddev:21.37 (16.1%) stddev-sans-first:22.54 10:29:22 INFO - PROCESS | 18221 | Values: 141.0 119.0 118.0 176.0 122.0 119.0 144.0 117.0 165.0 124.0 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.48 (0.9%) stddev-sans-first:1.56 10:29:22 INFO - PROCESS | 18221 | Values: 162.0 160.0 163.0 162.0 165.0 163.0 163.0 162.0 162.0 160.0 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.50 stddev:15.20 (20.1%) stddev-sans-first:15.87 10:29:22 INFO - PROCESS | 18221 | Values: 75.0 76.0 76.0 118.0 75.0 77.0 75.0 74.0 103.0 76.0 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:84.00 stddev:19.87 (23.7%) stddev-sans-first:20.59 10:29:22 INFO - PROCESS | 18221 | Values: 84.0 84.0 126.0 83.0 83.0 85.0 119.0 84.0 84.0 129.0 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 10:29:22 INFO - PROCESS | 18221 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 10:29:22 INFO - PROCESS | 18221 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 149.0 146.0 146.0 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:95.00 stddev:3.46 (3.6%) stddev-sans-first:3.64 10:29:22 INFO - PROCESS | 18221 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 106.0 95.0 95.0 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:0.99 (2.0%) stddev-sans-first:0.71 10:29:22 INFO - PROCESS | 18221 | Values: 52.0 49.0 49.0 50.0 49.0 51.0 50.0 50.0 49.0 50.0 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.73 10:29:22 INFO - PROCESS | 18221 | Values: 59.0 60.0 60.0 61.0 60.0 60.0 60.0 60.0 61.0 62.0 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:4.16 (5.3%) stddev-sans-first:4.25 10:29:22 INFO - PROCESS | 18221 | Values: 75.0 76.0 86.0 79.0 75.0 75.0 75.0 77.0 85.0 79.0 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:131.00 stddev:9.44 (7.2%) stddev-sans-first:9.81 10:29:22 INFO - PROCESS | 18221 | Values: 137.0 129.0 123.0 132.0 121.0 130.0 127.0 125.0 153.0 139.0 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:160.00 stddev:2.17 (1.4%) stddev-sans-first:2.30 10:29:22 INFO - PROCESS | 18221 | Values: 160.0 161.0 158.0 157.0 158.0 160.0 164.0 157.0 161.0 160.0 10:29:22 INFO - PROCESS | 18221 | 10:29:22 INFO - PROCESS | 18221 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.32 (2.0%) stddev-sans-first:1.39 10:29:22 INFO - PROCESS | 18221 | Values: 64.0 64.0 65.0 63.0 63.0 65.0 64.0 66.0 62.0 66.0 10:29:22 INFO - PROCESS | 18221 | -------- Summary: end -------- 10:29:22 INFO - PROCESS | 18221 | 10:29:23 INFO - TEST-INFO | 18221: exit 0 10:29:23 INFO - TEST-OK | kraken | took 60681ms 10:29:23 INFO - SUITE-END | took 1175s 10:29:24 INFO - Completed test suite (00:19:35) 10:29:24 INFO - javascript benchmark 10:29:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3018.185090025693, 3021.652509961354, 3037.2558723112843, 3059.4798884189686, 3078.5382192671095, 5086.593072554196, 5148.948510514893, 5176.016556854204, 5229.529342359187, 5237.3453318335205, 5171.043356978961, 5204.531592156705, 5229.084910140729, 5281.419043905167, 5289.8942021159555, 4667.486576476585, 4734.573888350048, 4744.691595046328, 4753.762311884409, 4857.53853383928, 4832.782524786393, 4842.44311904132, 4849.830255941043, 4876.780544875489, 4888.902221955559, 4652.767361631939, 4726.125666751627, 4807.014562014779, 4844.442889067749, 4851.762800485872, 4602.033572949685, 4610.492845786961, 4623.722576645412, 4665.2768820832825, 4757.429108506966, 4645.396098507206, 4685.6485763567525, 4701.224297990828, 4728.598069164125, 4747.548982846624, 5121.7439128043825, 5161.638685292031, 5217.973910130425, 5244.265802787575, 5252.343457067866, 5509.0, 5528.06022976095, 5581.7209139543265, 5625.54995600351, 5634.4365563443735, 5570.721463926788, 5585.4562851333585, 5595.664260144405, 5681.119426488901, 5694.202811606378, 5100.770465329032, 5183.170692689152, 5205.609579281569, 5228.5555727763185, 5286.04851126797, 5724.771009159587, 5731.799387021434, 5763.596548241667, 5794.0, 5796.88406231873, 5516.310461192351, 5563.638363506359, 5573.386927437979, 5573.693446860461, 5584.6090773646265, 5430.864228394243, 5440.782368705287, 5553.500184983371, 5606.21512988182, 5648.8870222595315, 5585.609007369527, 5591.916121258185, 5594.692291923983, 5627.971860140673, 5636.267285252891, 5531.612787104945, 5553.666779993213, 5555.083411237181, 5561.5272701820795, 5562.915231529893, 4298.570142985676, 4350.934735978963, 4369.2572262714775, 4394.956050439455, 4411.492678341968, 3867.3038853006165, 3886.6696330812197, 3894.065424298148, 3909.9022524436546, 3922.0, 5352.090144675414, 5358.6248962572245, 5368.194770784336, 5371.4628537146755, 5476.534494568006, 5426.8914621707345, 5455.509004189642, 5475.4524547545725, 5627.071533197059, 5707.029804933171, 5204.34945631796, 5225.033368826779, 5250.264962905197, 5267.683938963598, 5304.0, 4811.422629284508, 4827.444843843003, 4829.541193586604, 4831.0820944020525, 4861.756912154449, 5636.887262254732, 5743.1385292206505, 5750.079987202112, 5817.7382017809305, 5852.326982397079, 5623.044082505902, 5631.971840140773, 5639.379668236573, 5674.375818660027, 5683.943160568341, 5894.882102357843, 5901.5868889177345, 5903.852403689943, 5904.852378690567, 5910.556708246812, 5394.973025134849, 5500.642458240201, 5516.172574113915, 5517.2551705519245, 5521.5306698931045, 5659.801906933238, 5660.660360378391, 5666.546676265972, 5690.231818704422, 5707.800226992035, 5460.689434535603, 5515.696636685021, 5527.53015993645, 5529.612927095065, 5533.889322213614, 5327.3074500314715, 5415.512603865671, 5422.403535611158, 5468.945310546844, 5594.244776955222, 5399.190121481809, 5433.782648694008, 5440.047991601533, 5442.210879422382, 5490.725463726718, 5518.392976772471, 5526.557875370041, 5567.331920169444, 5573.164025396223, 5575.330960284792, 5245.265662807286, 5306.389765177054, 5314.229436731575, 5379.0, 5386.919196212139], "value": 5168.217499262236, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9131630255462, 605.7637521366667, 620.987580248395, 633.480545952319, 645.7546132469661, 32393.67606323936, 44316.0, 44987.550124498746, 45066.0986780265, 45129.323060154085, 45917.54082459174, 46439.0, 46443.76778116113, 46474.767626161905, 46532.76733616336, 8199.877001844978, 9003.819923601524, 9122.133397327243, 9161.17549420552, 10591.311564748305, 10502.947485262563, 10887.074598659085, 10901.400422976732, 10911.07255883247, 10923.0, 10994.230403871732, 10995.725106872313, 11025.44872756363, 11043.226974111816, 11051.392173430459, 8139.79650508742, 10392.0, 10698.679039628823, 10920.453977301142, 10954.835677464804, 10601.628942986958, 10802.189835762349, 10802.351858888493, 10819.35083894961, 10823.729406764895, 43428.3485747714, 43932.341014884805, 43974.560254397365, 44009.77995110004, 44013.77993110046, 3533.5406397168463, 3590.299891521154, 3902.31709450845, 4260.659147268211, 4266.637335826458, 33606.6639333606, 33990.490142647635, 34324.6567534324, 34355.14112147191, 35011.82494087513, 3635.763675361093, 3737.9439308410397, 3752.3996160614442, 3884.7280690351686, 3923.5880232575455, 357645.0, 358417.0, 360184.0, 360188.0, 360511.0, 59828.70085649544, 59977.400225998055, 60089.69955150284, 60271.39728602658, 60297.08068975503, 63120.68439657772, 63136.684316578125, 63138.68430657817, 63264.68367658132, 63318.36681633125, 14855.777163342558, 15045.699086018438, 15055.322510487054, 15064.924675376773, 15080.095194288378, 10360.222983276284, 10551.050405463546, 11168.609098681669, 11332.773344533063, 11395.259308144945, 17261.827381726274, 17539.473815785546, 17672.0, 17709.7343539847, 17747.0, 6146.6335460847895, 6171.0, 6263.467605253513, 6294.464970477469, 6298.590591611531, 1005.4922264256504, 1060.1148041385375, 1072.828347464402, 1116.4640972333325, 1170.011340417346, 32829.17927051795, 33119.172020699676, 33243.833780831425, 33357.3328533428, 33466.49800252998, 1095.8794532601407, 1139.9487023083982, 1151.8963293303643, 1160.7678464307173, 1174.2308787744041, 16456.439714476273, 17406.65186696259, 17422.738658920127, 17431.389901353392, 17775.0, 522969.0, 525978.0, 528606.0, 528760.0, 530241.0, 60809.391906080375, 60818.479538011015, 60948.0, 61174.38825611776, 61568.38431615626, 1144.016146114341, 1187.485955406846, 1276.3809552366909, 1340.557615986722, 1352.8579499152645, 30174.195158472674, 32448.675513244565, 34942.0, 34961.82519087388, 35023.64976350204, 53264.804111753416, 54285.45714542804, 54299.72850135724, 54341.0, 54420.3673889784, 478212.0, 491198.0, 492179.0, 492329.0, 493173.0, 44969.55030449785, 45528.0, 45905.0, 46620.53379466297, 48177.27734083922, 49036.509634903196, 49251.75374123106, 49347.50652493573, 49738.75130624323, 50275.74862125666, 40082.59917400789, 45953.0, 46024.539754602025, 46500.767496162305, 47650.52349476461, 42549.78725106355, 43392.34911476267, 43984.34023489714, 44297.33553996628, 44545.77727111473, 43102.56897431111, 43679.56320436755, 43730.0, 43828.34257486076, 43944.121117578106, 34715.652843471245, 38446.2310753789, 38508.42237366498, 38526.42210366791, 39617.0, 28477.572836407886, 29054.51249770969, 29212.70787292185, 29385.0, 29450.0], "value": 21077.196306932783, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.4513647233859, 376.41091691502794, 386.1369838411151, 395.33386244178564, 421.05893328411014, 16815.663686726257, 19180.424587262405, 19192.808071919295, 19306.71039934402, 20385.694214586754, 20018.09918553665, 20308.796912030874, 20484.69272960907, 20528.589428211428, 20658.48353791156, 5342.545883599899, 5679.318481782171, 5856.970715146418, 5901.822945311626, 5921.348651648315, 5757.337906140785, 5818.389069147742, 5858.062709966406, 5863.032599621079, 5864.472197502224, 5442.319710036246, 5707.315122185343, 5727.885442291152, 5737.741801618937, 5739.454751798572, 5654.190658989125, 5656.91514627281, 5697.971510142444, 5755.856103597402, 5757.510611598019, 5059.544640982329, 5157.149070403379, 5185.248139019821, 5186.559142472895, 5187.870303242411, 24348.39129021771, 24596.877015614806, 24778.0, 24784.3803904902, 24844.130455434155, 2058.98970505148, 2168.544605632819, 2455.8526488410753, 2497.773399210853, 3047.344820863525, 10046.095851373411, 10060.39637621745, 10465.215108866789, 10569.207309451822, 10754.56981720738, 1873.9718904216447, 1891.527118220445, 1927.7204805303152, 1931.8357939575153, 2014.8287395571394, 78988.60505697492, 79449.0, 80040.59979700122, 83470.58264708698, 85758.14241857626, 11297.830532542019, 11425.485853136628, 11461.192007958103, 11571.942140289413, 11584.189106762446, 15818.130002849954, 15842.76235856463, 15861.841381586268, 15895.125768082635, 15963.920180399256, 7505.587192704454, 7591.696332146652, 7644.464887457936, 7677.424193185533, 7768.41736869737, 7016.824579385556, 7060.152781666233, 7102.325279098477, 7294.963525182447, 7312.744053958192, 4810.254410566298, 4818.397700287464, 4886.169351210232, 4925.162722337212, 5003.174476211384, 1891.2056936086876, 1954.3159894036974, 1978.5647157625299, 1987.4633848860726, 2014.21445636202, 902.2421166220406, 952.1668540027476, 1053.1206442620344, 1069.6095924987324, 1075.8977897099762, 19297.710534341997, 20371.796282037285, 20426.38720838377, 20469.89765051195, 20991.895040525003, 951.8239125761756, 998.2313618513704, 1007.0483393193362, 1007.8840933292619, 1037.99481002596, 10608.522616482276, 11224.494897729459, 11376.203665743318, 11394.601188958346, 11490.310581365145, 489640.0, 495123.0, 496353.0, 498069.0, 500672.0, 89891.10108898827, 93681.0, 94244.52877735705, 96244.51877740567, 96368.51815740876, 958.7507248115401, 969.2197780786535, 988.9109980101681, 992.4541502173776, 1015.2284263959592, 17283.395081172603, 17716.0, 18093.728594070835, 18364.0, 18626.72059919075, 43191.0, 43246.78376608097, 43347.34978975381, 43785.78107109444, 44848.77575612101, 57321.42678573161, 59975.70012150086, 60021.19936401915, 60871.0, 62837.0, 8452.957735211285, 8460.407771455939, 8536.061033286458, 8766.211041006085, 8931.508767017616, 9724.285785511236, 13107.14803537767, 13688.589342319747, 13751.381187846771, 14270.571882843531, 11738.178327516991, 11873.881261187278, 11958.222715523463, 11961.940190298992, 12114.273143611412, 11695.181337306307, 11776.587819426622, 11968.46141923633, 12004.639860804189, 12395.62813115608, 12237.0822188338, 12237.877621223673, 12243.938780306042, 12267.202631828903, 12542.561010364594, 7756.3019328260725, 8122.147174546824, 8592.570371481275, 8679.17547832955, 8979.730608081769, 11860.703482413008, 12110.849469300403, 12120.575779847662, 12236.388180590757, 12252.203606765532], "value": 9322.308987159102, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.877366650168, 1446.276861569215, 1494.2528735632181, 1632.2083789362157, 1810.3120814090635, 8092.5549094799835, 8260.669573217072, 8307.543085130315, 8328.167183281676, 8667.523286219255, 8244.34045276378, 8408.495490270589, 8645.221930026297, 8648.956755216232, 8649.740507784776, 2409.337432206144, 2450.2649205238445, 2451.154351748644, 2453.0, 2454.165583701541, 2329.9767002329927, 2377.8573285602833, 2378.7502312257225, 2378.9762102379013, 2396.25716028031, 2333.125078095714, 2336.6027775278244, 2340.1692399198296, 2343.0979073056824, 2344.22640528626, 2256.3907744908865, 2258.3225032490186, 2273.170292843117, 2274.033535747309, 2320.872352020638, 2240.316703405461, 2257.5146343536217, 2259.9774002260096, 2262.604044292242, 2264.784845439681, 8377.371697122679, 8557.315414766803, 8568.700095496628, 8586.87119693205, 8598.87101693475, 5012.423571289312, 5206.583473322125, 5207.244949482304, 5220.164773636238, 5255.395629502618, 3320.8671653133847, 3342.5153352763955, 3354.1614596350914, 3377.5778027746533, 3387.0685561470546, 1104.9226554141214, 1125.1448898836861, 1146.329397302579, 1154.584349634131, 1171.1509155861932, 11804.763904721944, 11949.044076473949, 12033.157678962476, 12089.153759236857, 12174.0, 4601.378813860086, 4641.559051890065, 4813.566778989838, 4815.422149342101, 4830.468648448667, 10267.845982310271, 10273.691789246335, 10289.794204115875, 10290.639827605997, 10310.123639490577, 5267.473252674702, 5284.260203571503, 5288.629795914326, 5292.047431462297, 5293.867653308621, 4249.383839343278, 4595.2188128018315, 4667.439907211156, 4701.905961880811, 4758.428988521399, 4121.859448962253, 4154.1068670236045, 4244.87265382039, 4273.205253793414, 4277.721948073366, 1277.4060062070996, 1301.9218846869028, 1311.6458556189775, 1321.8149459075737, 1325.5360623781598, 907.878769719396, 916.8716379706847, 918.6555041859302, 984.2627216701666, 1005.2962925951863, 5949.286085669661, 6023.879522409527, 6039.4262545058145, 6156.753729850756, 6243.906341404882, 965.1844191658038, 986.4032260482305, 1012.698682193378, 1066.5787014129376, 1069.9893001070045, 4086.203190377907, 4159.584041595876, 4224.8732538023905, 4317.8272869084885, 4339.717918335298, 10391.012853778879, 10609.787804243872, 10717.517711702993, 10744.570217191382, 10746.24776265654, 10603.89396106029, 10618.309809862334, 10639.202059845387, 10721.571137154426, 10769.0, 7683.116441609175, 7935.9206407936335, 7949.251164743747, 8227.218414250636, 8338.749837504885, 6006.099085137264, 6031.4270144336215, 6159.969200153971, 6171.691415429301, 6186.257649082139, 9909.058639429242, 9977.301588888708, 10006.349587276804, 10007.449590272605, 10100.343477673927, 9545.0, 9906.0, 9907.504624768588, 10196.38821670702, 10202.489875506344, 6932.826679333057, 7123.323284287984, 7123.715051397886, 7659.0, 7845.0, 8114.797130071795, 8423.241908228289, 8429.0, 8521.360897932804, 8609.569521523774, 7596.936428899848, 7607.923920760722, 7743.5353878767455, 7879.684812607661, 7951.006124234471, 7397.482176247611, 7461.328480436787, 7550.811229719081, 7609.809754756176, 7653.846923061619, 6980.685869135799, 7051.753188638373, 7053.823654408681, 7106.893396599158, 7132.108486439195, 5246.685198888079, 5294.788208471618, 5338.599605029716, 5369.818639899216, 5603.971980140073, 5227.764750586157, 5268.315119034654, 5278.9472105278455, 5316.813911513079, 5613.382527921844], "value": 4643.707176655347, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.5733373944565, 320.73859804259524, 325.47435891035985, 328.87667124828187, 330.43990436210623, 5214.973925130374, 5256.973715131424, 5267.683938963655, 5282.973585132069, 5295.152775555912, 4939.580135688462, 4944.456109827925, 5093.9235911461265, 5108.233764935261, 5213.357792295425, 4042.504273418839, 4047.494063242095, 4065.227606754722, 4071.796410179494, 4079.8776036718796, 4057.6812535925797, 4062.1875624874997, 4063.6545893599077, 4079.2453396121664, 4084.448599439082, 3764.7929363884973, 3843.961560384388, 4037.394390841368, 4040.656544193747, 4054.878353649395, 4027.959720402817, 4054.3918412238104, 4062.9593704063022, 4067.1458993611377, 4070.7761073141114, 3604.080959355374, 3604.333198358312, 3617.403128483797, 3619.059044648384, 3620.855165793365, 4823.9517604824205, 5055.469175736532, 5115.2327150927285, 5117.385913690381, 5133.358330208724, 4580.770556757478, 4582.243929751587, 4583.747893865836, 4596.310553416981, 4624.445066591997, 5354.812581559627, 5356.866078348073, 5358.383785864637, 5362.35651721792, 5388.137897936312, 3806.0, 3875.476810630557, 3879.321118804198, 3891.4746509221177, 3891.8983748775627, 5517.393086760453, 5556.527695145917, 5576.888462230773, 5577.832665020056, 5591.552675785968, 3936.6850651947775, 3940.704447166474, 3942.42834788954, 3946.131850992777, 3950.308695978192, 4010.7593544387432, 4032.6169013943627, 4045.3122969095325, 4047.3894338151727, 4048.959510404858, 4395.516493185747, 4599.908001840012, 4600.35595016698, 4610.792514336796, 4622.560856718606, 5442.836714898559, 5452.236686863842, 5455.454454554513, 5462.453754624506, 5502.532284755761, 1382.8202333696756, 1387.2439520461373, 1390.2145287912297, 1400.6988497473092, 1401.5655146904492, 853.7694822398042, 875.4222213339166, 924.8474001789764, 942.236788201559, 942.3686130292721, 5223.13818219997, 5230.34620672416, 5237.6382140642945, 5238.71187084714, 5263.6578622389425, 5443.809466668727, 5484.451554844483, 5484.945150548443, 5485.862853428696, 5506.256655351556, 5035.949640503622, 5192.9614077184715, 5231.03836061477, 5287.524122828964, 5320.951433698054, 2890.335222898745, 2929.61914951055, 2933.985330073336, 2945.1164650604733, 2952.6456825181117, 5759.251297331404, 5896.616719913192, 5901.734421950937, 5906.822795316148, 5941.613795103304, 5637.154426836008, 5642.943570564242, 5654.236678048493, 5681.147827825776, 5691.743871525791, 5809.912851307318, 5813.79651712188, 5838.67887266196, 5864.560157988168, 5878.676672783038, 5350.892982140257, 5507.421720719267, 5511.035568775528, 5543.750531226024, 5598.468145526169, 5445.346558413015, 5470.261514695465, 5475.67145971243, 5502.202180683858, 5543.445655434424, 5870.324912634931, 5881.8826022208295, 5885.61743486672, 5900.43945825146, 5956.136360227656, 3734.178480734234, 3907.277153726456, 3909.6285852843935, 4004.3593025115842, 4005.839766409311, 5347.208685090538, 5438.075527160313, 5574.219609254788, 5583.274174357308, 5621.325440947113, 5368.865778355416, 5376.301080859464, 5384.030874442638, 5412.377576578744, 5419.647722897999, 5228.790848366175, 5359.544438722596, 5408.296386638196, 5419.647722897999, 5430.456954304538, 5310.734463276744, 5328.786848526015, 5367.704776237344, 5374.543163831118, 5374.973125134349, 5374.435684253097, 5419.861829015951, 5457.0, 5469.617126801086, 5494.587905907153, 5086.720230387365, 5272.868178295574, 5285.867853303698, 5334.733263336895, 5344.198370244494], "value": 4139.164780639554, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.2941117704646, 729.5330988167574, 736.2159300345132, 740.3300013487793, 795.6618437164203, 15684.45104421344, 16104.11427371497, 16228.83771162288, 16350.83649163508, 16367.508974730763, 14847.480338188165, 15114.697706045872, 15170.924145379258, 15192.696146077073, 15226.390944362212, 813.8738495533187, 833.3333333333339, 835.1606635331483, 835.6699103853974, 836.3560058754755, 680.6528670378093, 810.9189081091903, 836.8117173635944, 841.5455653946862, 842.1031601344579, 878.4465786554462, 883.4566741453991, 885.0308911741665, 885.1856292211149, 885.3138817416522, 877.298161470824, 878.3939082033409, 878.5782824244399, 880.018779061342, 880.3089574683875, 510.71910449253136, 619.6344156947378, 625.5589809184514, 626.1265534579281, 626.6115008694593, 15004.324805383783, 15093.622659433493, 15137.243137843174, 15138.545843624708, 15206.923965380101, 14129.222892740896, 14334.72553699286, 14389.280535973265, 14631.780523292158, 14966.17686027268, 13496.607612138696, 13566.0, 13636.522721704792, 13714.45142194321, 14374.0, 4187.874363769061, 4262.7868606569855, 4282.078451955354, 4349.217140914634, 4376.562343765598, 76953.23046769573, 77902.0, 79132.60433697852, 80139.0, 82647.9999999994, 10616.363018218932, 10744.30162039465, 10881.12950963921, 11126.0, 11411.885881141248, 21970.670439943413, 22071.227507037496, 22081.116755329607, 22092.226772062902, 22099.779002209772, 7806.453548251681, 7878.803029924183, 8039.437239393304, 8096.0, 8200.5489698066, 4537.931931021038, 4576.702514336557, 4694.319323698045, 4732.858014259577, 4783.162946484351, 3401.795892246473, 3473.843677034489, 3501.632328605511, 3511.438169892805, 3513.6837684607995, 567.5402923631872, 568.6133429268054, 572.8510587247263, 577.7515668262604, 585.5520526797004, 555.6166245290736, 566.4250785452768, 620.0420350558398, 666.8899631560738, 704.520925770481, 9041.363890441618, 9295.767605809773, 9379.859302110473, 9611.0, 9696.854547181798, 555.1866515554732, 616.6300219868043, 633.108921485581, 658.1378394303478, 664.0, 4164.312888373384, 4264.296391095435, 4373.693841431133, 4434.82260709568, 4450.643948484114, 120005.39997300132, 121552.0, 123548.0, 130841.34579327232, 131050.0, 109677.0, 109955.0, 111021.0, 111782.0, 117235.0, 55211.0, 56644.43355566474, 82432.0, 88576.11423885936, 91162.54418727863, 8075.152109028702, 8190.7952301192945, 8316.5425901576, 8422.157784221528, 8427.410081294496, 52254.0, 54898.0, 55760.0, 56208.71895640659, 56887.431125689865, 78214.0, 83492.0, 83738.58130709307, 86011.56994214989, 87944.56027719821, 11115.166362523005, 11139.275947063416, 11201.60794372193, 11288.322700637988, 11547.364894930859, 12846.614601561969, 13005.739885202433, 13133.4392374903, 13462.259575723428, 13540.0, 12372.690682733004, 12397.256164630151, 12646.957425440854, 12696.0, 13167.67080822987, 11597.420128993685, 12207.938960305142, 12477.875221247672, 12898.097133200587, 12901.032422568158, 12371.75256494847, 12866.099373043797, 12873.935630322163, 13045.804312935503, 13093.345332733135, 10061.69814905554, 10247.487625618838, 10451.634192803216, 10587.947060264649, 10991.09436974593, 9778.55996480146, 9870.210383169186, 10196.082352588302, 10439.37363758177, 10513.57945682164], "value": 7420.171141144037, "unit": "score"}], "name": "dromaeo_css", "value": 7246.90997180445, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 112.0, 111.0, 115.0, 111.0, 111.0, 111.0, 110.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 119.0, 118.0, 176.0, 122.0, 119.0, 144.0, 117.0, 165.0, 124.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 162.0, 165.0, 163.0, 163.0, 162.0, 162.0, 160.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 118.0, 75.0, 77.0, 75.0, 74.0, 103.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 126.0, 83.0, 83.0, 85.0, 119.0, 84.0, 84.0, 129.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 149.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 106.0, 95.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 49.0, 50.0, 49.0, 51.0, 50.0, 50.0, 49.0, 50.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0, 62.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 86.0, 79.0, 75.0, 75.0, 75.0, 77.0, 85.0, 79.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 129.0, 123.0, 132.0, 121.0, 130.0, 127.0, 125.0, 153.0, 139.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 158.0, 157.0, 158.0, 160.0, 164.0, 157.0, 161.0, 160.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 63.0, 63.0, 65.0, 64.0, 66.0, 62.0, 66.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1488.9999999999998, "alertThreshold": 2.0}]} 10:29:24 INFO - Return code: 0 10:29:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:29:24 INFO - # TBPL SUCCESS # 10:29:24 INFO - Running post-action listener: _resource_record_post_action 10:29:24 INFO - [mozharness: 2016-08-04 17:29:24.239760Z] Finished run-tests step (success) 10:29:24 INFO - Running post-run listener: _resource_record_post_run 10:29:24 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 551645184; Read time: 456; Write time: 687712 10:29:24 INFO - TinderboxPrint: CPU usage
13.0% 10:29:24 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 456 10:29:24 INFO - TinderboxPrint: I/O write bytes / time
551,645,184 / 687,712 10:29:24 INFO - TinderboxPrint: CPU idle
8,277.2 (86.9%) 10:29:24 INFO - TinderboxPrint: CPU user
1,195.6 (12.6%) 10:29:24 INFO - TinderboxPrint: Swap in / out
0 / 0 10:29:24 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 254693376; Read time: 172; Write time: 361560 10:29:24 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292700160; Read time: 252; Write time: 325332 10:29:24 INFO - Running post-run listener: _upload_blobber_files 10:29:24 INFO - Blob upload gear active. 10:29:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:29:24 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 10:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:29:25 INFO - (blobuploader) - INFO - Open directory for files ... 10:29:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:29:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:29:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:31 INFO - (blobuploader) - INFO - Done attempting. 10:29:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:29:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:29:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:32 INFO - (blobuploader) - INFO - Done attempting. 10:29:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:29:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:29:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:32 INFO - (blobuploader) - INFO - Done attempting. 10:29:32 INFO - (blobuploader) - INFO - Iteration through files over. 10:29:32 INFO - Return code: 0 10:29:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:29:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:29:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f103c90a3081d81e31b6d3b2064ddd861fdc30ffde163ab6640c2f32fd2fc973f4b393756322600b30b229cf69a338e07ff9852104a1acef74c4dd8bfc365906", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b9b2ad50544648c0f9a44e7a976c9c7acafcede2589f51a4d52f93426dbf1c83069f55732ea37ed2cdf073958eb814398bdf78c0cdb1d9319d9bc60e9152acb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25e859003a63ced6f085d7a46013d104dc8115f5b7b4395e5e9e55d02b79c58c00f273fc471f146445a5d362b9b2e76f2f835f51868ad02486bc31f47e485343"} 10:29:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:29:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:29:32 INFO - Contents: 10:29:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f103c90a3081d81e31b6d3b2064ddd861fdc30ffde163ab6640c2f32fd2fc973f4b393756322600b30b229cf69a338e07ff9852104a1acef74c4dd8bfc365906", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b9b2ad50544648c0f9a44e7a976c9c7acafcede2589f51a4d52f93426dbf1c83069f55732ea37ed2cdf073958eb814398bdf78c0cdb1d9319d9bc60e9152acb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25e859003a63ced6f085d7a46013d104dc8115f5b7b4395e5e9e55d02b79c58c00f273fc471f146445a5d362b9b2e76f2f835f51868ad02486bc31f47e485343"} 10:29:32 INFO - Running post-run listener: copy_logs_to_upload_dir 10:29:32 INFO - Copying logs to upload dir... 10:29:32 INFO - mkdir: /builds/slave/test/build/upload/logs 10:29:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.478194 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-04 10:29:32.674429) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 10:29:32.677862) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f103c90a3081d81e31b6d3b2064ddd861fdc30ffde163ab6640c2f32fd2fc973f4b393756322600b30b229cf69a338e07ff9852104a1acef74c4dd8bfc365906", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b9b2ad50544648c0f9a44e7a976c9c7acafcede2589f51a4d52f93426dbf1c83069f55732ea37ed2cdf073958eb814398bdf78c0cdb1d9319d9bc60e9152acb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25e859003a63ced6f085d7a46013d104dc8115f5b7b4395e5e9e55d02b79c58c00f273fc471f146445a5d362b9b2e76f2f835f51868ad02486bc31f47e485343"} build_url:https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/J2SF412ISxKXVCAjlGYFLw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f103c90a3081d81e31b6d3b2064ddd861fdc30ffde163ab6640c2f32fd2fc973f4b393756322600b30b229cf69a338e07ff9852104a1acef74c4dd8bfc365906", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b9b2ad50544648c0f9a44e7a976c9c7acafcede2589f51a4d52f93426dbf1c83069f55732ea37ed2cdf073958eb814398bdf78c0cdb1d9319d9bc60e9152acb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25e859003a63ced6f085d7a46013d104dc8115f5b7b4395e5e9e55d02b79c58c00f273fc471f146445a5d362b9b2e76f2f835f51868ad02486bc31f47e485343"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 10:29:32.703750) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:29:32.704077) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470329781.32917-671884077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:29:32.788625) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 10:29:32.788946) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 10:29:32.789248) ========= ========= Total master_lag: 0.18 =========