builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1452243162.38 results: success (0) buildid: 20160107223006 builduid: 7a18aa57cac947b0bbbfccd3d9bb72a7 revision: d4213241bb796fdfa7a5ad4f1989e97b44474364 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.380635) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.381097) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.381404) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006357 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.409645) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.409918) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.431496) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.431778) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.479944) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.480199) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.480506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.480784) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 00:52:43-- 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% 40.4M=0s 2016-01-08 00:52:43 (40.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140017 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.632411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.632693) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019645 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.681900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:42.682199) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d4213241bb796fdfa7a5ad4f1989e97b44474364 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d4213241bb796fdfa7a5ad4f1989e97b44474364 --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 00:52:43,670 truncating revision to first 12 chars 2016-01-08 00:52:43,670 Setting DEBUG logging. 2016-01-08 00:52:43,670 attempt 1/10 2016-01-08 00:52:43,670 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d4213241bb79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 00:52:43,928 unpacking tar archive at: mozilla-central-d4213241bb79/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561151 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:43.255573) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:43.255842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:43.265400) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:43.265660) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:43.266012) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-01-08 00:52:43.266290) ========= /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-pgo/. (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-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:52:44 INFO - MultiFileLogger online at 20160108 00:52:44 in /builds/slave/test-pgo 00:52:44 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 00:52:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:52:44 INFO - {'append_to_log': False, 00:52:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:52:44 INFO - 'blob_upload_branch': 'Firefox', 00:52:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:52:44 INFO - 'branch': 'Firefox', 00:52:44 INFO - 'buildbot_json_path': 'buildprops.json', 00:52:44 INFO - 'config_files': ('talos/linux_config.py',), 00:52:44 INFO - 'default_actions': ('clobber', 00:52:44 INFO - 'read-buildbot-config', 00:52:44 INFO - 'download-and-extract', 00:52:44 INFO - 'populate-webroot', 00:52:44 INFO - 'create-virtualenv', 00:52:44 INFO - 'install', 00:52:44 INFO - 'run-tests'), 00:52:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:52:44 INFO - 'download_minidump_stackwalk': True, 00:52:44 INFO - 'download_symbols': 'ondemand', 00:52:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:52:44 INFO - 'tooltool.py': '/tools/tooltool.py', 00:52:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:52:44 INFO - '/tools/misc-python/virtualenv.py')}, 00:52:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:52:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:52:44 INFO - 'installer_path': 'installer.exe', 00:52:44 INFO - 'log_level': 'info', 00:52:44 INFO - 'log_name': 'talos', 00:52:44 INFO - 'log_to_console': True, 00:52:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:52:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:52:44 INFO - 'opt_config_files': (), 00:52:44 INFO - 'pip_index': False, 00:52:44 INFO - 'sps_profile': False, 00:52:44 INFO - 'sps_profile_interval': 0, 00:52:44 INFO - 'suite': 'dromaeojs', 00:52:44 INFO - 'system_bits': '32', 00:52:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:52:44 INFO - 'title': 'talos-linux64-ix-048', 00:52:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:52:44 INFO - 'use_talos_json': True, 00:52:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:52:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:52:44 INFO - 'work_dir': 'build'} 00:52:44 INFO - ##### 00:52:44 INFO - ##### Running clobber step. 00:52:44 INFO - ##### 00:52:44 INFO - Running pre-action listener: _resource_record_pre_action 00:52:44 INFO - Running main action method: clobber 00:52:44 INFO - rmtree: /builds/slave/test-pgo/build 00:52:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:52:45 INFO - Running post-action listener: _resource_record_post_action 00:52:45 INFO - ##### 00:52:45 INFO - ##### Running read-buildbot-config step. 00:52:45 INFO - ##### 00:52:45 INFO - Running pre-action listener: _resource_record_pre_action 00:52:45 INFO - Running main action method: read_buildbot_config 00:52:45 INFO - Using buildbot properties: 00:52:45 INFO - { 00:52:45 INFO - "project": "", 00:52:45 INFO - "product": "firefox", 00:52:45 INFO - "script_repo_revision": "production", 00:52:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 00:52:45 INFO - "repository": "", 00:52:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 00:52:45 INFO - "buildid": "20160107223006", 00:52:45 INFO - "pgo_build": "True", 00:52:45 INFO - "basedir": "/builds/slave/test-pgo", 00:52:45 INFO - "buildnumber": 155, 00:52:45 INFO - "slavename": "talos-linux64-ix-048", 00:52:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:52:45 INFO - "platform": "ubuntu64_hw", 00:52:45 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 00:52:45 INFO - "branch": "mozilla-central", 00:52:45 INFO - "repo_path": "mozilla-central", 00:52:45 INFO - "revision": "d4213241bb796fdfa7a5ad4f1989e97b44474364", 00:52:45 INFO - "stage_platform": "linux64-pgo", 00:52:45 INFO - "builduid": "7a18aa57cac947b0bbbfccd3d9bb72a7", 00:52:45 INFO - "slavebuilddir": "test" 00:52:45 INFO - } 00:52:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 00:52:45 INFO - Running post-action listener: _resource_record_post_action 00:52:45 INFO - ##### 00:52:45 INFO - ##### Running download-and-extract step. 00:52:45 INFO - ##### 00:52:45 INFO - Running pre-action listener: _resource_record_pre_action 00:52:45 INFO - Running main action method: download_and_extract 00:52:45 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:52:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:45 INFO - https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:52:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/test_packages.json 00:52:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/test_packages.json 00:52:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:52:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:52:51 INFO - Downloaded 1302 bytes. 00:52:51 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:52:51 INFO - Using the following test package requirements: 00:52:51 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:51 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:52:51 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:51 INFO - u'jsshell-linux-x86_64.zip'], 00:52:51 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:52:51 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:51 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:52:51 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:52:51 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:52:51 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:51 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:52:51 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:52:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:51 INFO - https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:52:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:52:55 INFO - Downloaded 24019195 bytes. 00:52:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 00:52:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:52:57 INFO - Return code: 0 00:52:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:52: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:57 INFO - https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:52:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:52:59 INFO - Downloaded 24019195 bytes. 00:52:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 00:52:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:53:01 INFO - Return code: 0 00:53:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:01 INFO - https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:53:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:53:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:53:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:53:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:53:02 INFO - Downloaded 11132285 bytes. 00:53:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 00:53:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:53:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 00:53:02 INFO - Return code: 0 00:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:02 INFO - https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:53:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:53:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:53:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:53:10 INFO - Downloaded 55877422 bytes. 00:53:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:53:10 INFO - mkdir: /builds/slave/test-pgo/properties 00:53:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:53:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:53:10 INFO - Contents: 00:53:10 INFO - build_url:https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:53:10 INFO - Running post-action listener: _resource_record_post_action 00:53:10 INFO - Running post-action listener: set_extra_try_arguments 00:53:10 INFO - ##### 00:53:10 INFO - ##### Running populate-webroot step. 00:53:10 INFO - ##### 00:53:10 INFO - Running pre-action listener: _resource_record_pre_action 00:53:10 INFO - Running main action method: populate_webroot 00:53:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:53:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:53:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:53:10 INFO - '--tppagecycles', 00:53:10 INFO - '7'], 00:53:10 INFO - 'tests': ['tsvgm']}}, 00:53:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:53:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:53:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:53:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:53:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:53:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:53:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:53:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:10 INFO - 'talos_options': ['--e10s'], 00:53:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:53:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:10 INFO - 'tests': ['damp', 'tps']}, 00:53:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:10 INFO - 'talos_options': ['--e10s'], 00:53:10 INFO - 'tests': ['damp', 'tps']}, 00:53:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:53:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:53:10 INFO - 'other': {'tests': ['a11yr', 00:53:10 INFO - 'ts_paint', 00:53:10 INFO - 'tpaint', 00:53:10 INFO - 'sessionrestore', 00:53:10 INFO - 'sessionrestore_no_auto_restore']}, 00:53:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:53:10 INFO - 'tests': ['a11yr', 00:53:10 INFO - 'ts_paint', 00:53:10 INFO - 'tpaint', 00:53:10 INFO - 'sessionrestore', 00:53:10 INFO - 'sessionrestore_no_auto_restore']}, 00:53:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:53:10 INFO - 'tests': ['a11yr', 00:53:10 INFO - 'ts_paint', 00:53:10 INFO - 'tpaint', 00:53:10 INFO - 'sessionrestore', 00:53:10 INFO - 'sessionrestore_no_auto_restore']}, 00:53:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:53:10 INFO - 'tests': ['a11yr', 00:53:10 INFO - 'ts_paint', 00:53:10 INFO - 'tpaint', 00:53:10 INFO - 'sessionrestore', 00:53:10 INFO - 'sessionrestore_no_auto_restore']}, 00:53:10 INFO - 'other_l64': {'tests': ['a11yr', 00:53:10 INFO - 'ts_paint', 00:53:10 INFO - 'tpaint', 00:53:10 INFO - 'sessionrestore', 00:53:10 INFO - 'sessionrestore_no_auto_restore']}, 00:53:10 INFO - 'other_nol64': {'tests': ['a11yr', 00:53:10 INFO - 'ts_paint', 00:53:10 INFO - 'tpaint', 00:53:10 INFO - 'sessionrestore', 00:53:10 INFO - 'sessionrestore_no_auto_restore']}, 00:53:10 INFO - 'svgr': {'tests': ['tsvgx', 00:53:10 INFO - 'tsvgr_opacity', 00:53:10 INFO - 'tart', 00:53:10 INFO - 'tscrollx', 00:53:10 INFO - 'cart']}, 00:53:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:53:10 INFO - 'tests': ['tsvgx', 00:53:10 INFO - 'tsvgr_opacity', 00:53:10 INFO - 'tart', 00:53:10 INFO - 'tscrollx', 00:53:10 INFO - 'cart']}, 00:53:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:10 INFO - 'tests': ['tp5o']}, 00:53:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:10 INFO - 'talos_options': ['--e10s'], 00:53:10 INFO - 'tests': ['tp5o']}, 00:53:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:10 INFO - 'talos_options': ['--xperf_path', 00:53:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:53:10 INFO - 'tests': ['tp5n']}, 00:53:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:10 INFO - 'talos_options': ['--e10s', 00:53:10 INFO - '--xperf_path', 00:53:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:53:10 INFO - 'tests': ['tp5n']}}, 00:53:10 INFO - 'talos.zip': {'path': '', 00:53:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:53:10 INFO - Running post-action listener: _resource_record_post_action 00:53:10 INFO - ##### 00:53:10 INFO - ##### Running create-virtualenv step. 00:53:10 INFO - ##### 00:53:10 INFO - Running pre-action listener: _resource_record_pre_action 00:53:10 INFO - Running main action method: create_virtualenv 00:53:10 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:53:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 00:53:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:53:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:53:10 INFO - Using real prefix '/usr' 00:53:10 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:53:11 INFO - Installing distribute.............................................................................................................................................................................................done. 00:53:13 INFO - Installing pip.................done. 00:53:13 INFO - Return code: 0 00:53:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f5c87706f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8660>, '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 0x1de9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:53:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 00:53:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 00:53:13 INFO - Using env: {'DISPLAY': ':0', 00:53:13 INFO - 'HOME': '/home/cltbld', 00:53:13 INFO - 'LANG': 'en_US.UTF-8', 00:53:13 INFO - 'LANGUAGE': 'en_US:en', 00:53:13 INFO - 'LOGNAME': 'cltbld', 00:53:13 INFO - 'MAIL': '/var/mail/cltbld', 00:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:13 INFO - 'MOZ_NO_REMOTE': '1', 00:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:13 INFO - 'NO_EM_RESTART': '1', 00:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:13 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:13 INFO - 'SHELL': '/bin/bash', 00:53:13 INFO - 'SHLVL': '1', 00:53:13 INFO - 'TERM': 'linux', 00:53:13 INFO - 'TMOUT': '86400', 00:53:13 INFO - 'USER': 'cltbld', 00:53:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', 00:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:13 INFO - '_': '/tools/buildbot/bin/python'} 00:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:13 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 00:53:13 INFO - Cleaning up... 00:53:13 INFO - Return code: 0 00:53:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c87706f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8660>, '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 0x1de9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:53:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test-pgo/build 00:53:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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>=0.7.1 00:53:13 INFO - Using env: {'DISPLAY': ':0', 00:53:13 INFO - 'HOME': '/home/cltbld', 00:53:13 INFO - 'LANG': 'en_US.UTF-8', 00:53:13 INFO - 'LANGUAGE': 'en_US:en', 00:53:13 INFO - 'LOGNAME': 'cltbld', 00:53:13 INFO - 'MAIL': '/var/mail/cltbld', 00:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:13 INFO - 'MOZ_NO_REMOTE': '1', 00:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:13 INFO - 'NO_EM_RESTART': '1', 00:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:13 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:13 INFO - 'SHELL': '/bin/bash', 00:53:13 INFO - 'SHLVL': '1', 00:53:13 INFO - 'TERM': 'linux', 00:53:13 INFO - 'TMOUT': '86400', 00:53:13 INFO - 'USER': 'cltbld', 00:53:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', 00:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:13 INFO - '_': '/tools/buildbot/bin/python'} 00:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:13 INFO - Downloading/unpacking psutil>=0.7.1 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53:15 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:53:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:53:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:53:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:53:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:53:15 INFO - Installing collected packages: psutil 00:53:15 INFO - Running setup.py install for psutil 00:53:15 INFO - building 'psutil._psutil_linux' extension 00:53:15 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 00:53:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:53:15 INFO - building 'psutil._psutil_posix' extension 00:53:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:53:16 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 00:53:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:53:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:53:16 INFO - Successfully installed psutil 00:53:16 INFO - Cleaning up... 00:53:16 INFO - Return code: 0 00:53:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:53:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c87706f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8660>, '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 0x1de9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:53:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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.0.0'] in /builds/slave/test-pgo/build 00:53:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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.0.0 00:53:16 INFO - Using env: {'DISPLAY': ':0', 00:53:16 INFO - 'HOME': '/home/cltbld', 00:53:16 INFO - 'LANG': 'en_US.UTF-8', 00:53:16 INFO - 'LANGUAGE': 'en_US:en', 00:53:16 INFO - 'LOGNAME': 'cltbld', 00:53:16 INFO - 'MAIL': '/var/mail/cltbld', 00:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:16 INFO - 'MOZ_NO_REMOTE': '1', 00:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:16 INFO - 'NO_EM_RESTART': '1', 00:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:16 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:16 INFO - 'SHELL': '/bin/bash', 00:53:16 INFO - 'SHLVL': '1', 00:53:16 INFO - 'TERM': 'linux', 00:53:16 INFO - 'TMOUT': '86400', 00:53:16 INFO - 'USER': 'cltbld', 00:53:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', 00:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:16 INFO - '_': '/tools/buildbot/bin/python'} 00:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:53:16 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 00:53:16 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 00:53:16 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 00:53:16 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 00:53:16 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 00:53:16 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 00:53:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:53:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:53:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:53:18 INFO - Installing collected packages: mozsystemmonitor 00:53:18 INFO - Running setup.py install for mozsystemmonitor 00:53:18 INFO - Successfully installed mozsystemmonitor 00:53:18 INFO - Cleaning up... 00:53:18 INFO - Return code: 0 00:53:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f5c87706f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8660>, '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 0x1de9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:53:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 00:53:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 00:53:18 INFO - Using env: {'DISPLAY': ':0', 00:53:18 INFO - 'HOME': '/home/cltbld', 00:53:18 INFO - 'LANG': 'en_US.UTF-8', 00:53:18 INFO - 'LANGUAGE': 'en_US:en', 00:53:18 INFO - 'LOGNAME': 'cltbld', 00:53:18 INFO - 'MAIL': '/var/mail/cltbld', 00:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:18 INFO - 'MOZ_NO_REMOTE': '1', 00:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:18 INFO - 'NO_EM_RESTART': '1', 00:53:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:18 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:18 INFO - 'SHELL': '/bin/bash', 00:53:18 INFO - 'SHLVL': '1', 00:53:18 INFO - 'TERM': 'linux', 00:53:18 INFO - 'TMOUT': '86400', 00:53:18 INFO - 'USER': 'cltbld', 00:53:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', 00:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:18 INFO - '_': '/tools/buildbot/bin/python'} 00:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:18 INFO - Downloading/unpacking blobuploader==1.2.4 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53:20 INFO - Downloading blobuploader-1.2.4.tar.gz 00:53:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:53:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:53:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:53:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:53:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:20 INFO - Downloading docopt-0.6.1.tar.gz 00:53:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:53:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:53:20 INFO - Installing collected packages: blobuploader, requests, docopt 00:53:20 INFO - Running setup.py install for blobuploader 00:53:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:53:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:53:21 INFO - Running setup.py install for requests 00:53:21 INFO - Running setup.py install for docopt 00:53:21 INFO - Successfully installed blobuploader requests docopt 00:53:21 INFO - Cleaning up... 00:53:21 INFO - Return code: 0 00:53:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f5c87706f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8660>, '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 0x1de9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:53:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 00:53:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 00:53:21 INFO - Using env: {'DISPLAY': ':0', 00:53:21 INFO - 'HOME': '/home/cltbld', 00:53:21 INFO - 'LANG': 'en_US.UTF-8', 00:53:21 INFO - 'LANGUAGE': 'en_US:en', 00:53:21 INFO - 'LOGNAME': 'cltbld', 00:53:21 INFO - 'MAIL': '/var/mail/cltbld', 00:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:21 INFO - 'MOZ_NO_REMOTE': '1', 00:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:21 INFO - 'NO_EM_RESTART': '1', 00:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:21 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:21 INFO - 'SHELL': '/bin/bash', 00:53:21 INFO - 'SHLVL': '1', 00:53:21 INFO - 'TERM': 'linux', 00:53:21 INFO - 'TMOUT': '86400', 00:53:21 INFO - 'USER': 'cltbld', 00:53:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', 00:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:21 INFO - '_': '/tools/buildbot/bin/python'} 00:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:21 INFO - Running setup.py (path:/tmp/pip-xDiwdy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:21 INFO - Running setup.py (path:/tmp/pip-mQhZUu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:21 INFO - Running setup.py (path:/tmp/pip-b4tZec-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:22 INFO - Running setup.py (path:/tmp/pip-QIqDO5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:22 INFO - Running setup.py (path:/tmp/pip-BkhKZp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:22 INFO - Running setup.py (path:/tmp/pip-0NGZQC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:22 INFO - Running setup.py (path:/tmp/pip-Hzm0lX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:22 INFO - Running setup.py (path:/tmp/pip-tkoxHZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:22 INFO - Running setup.py (path:/tmp/pip-4_Rhkk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:22 INFO - Running setup.py (path:/tmp/pip-r0BJwu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:22 INFO - Running setup.py (path:/tmp/pip-7J2HfZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:22 INFO - Running setup.py (path:/tmp/pip-5yzvjv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:22 INFO - Running setup.py (path:/tmp/pip-A9WCB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:22 INFO - Running setup.py (path:/tmp/pip-Sqa3DK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:22 INFO - Running setup.py (path:/tmp/pip-ymJDbh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:22 INFO - Running setup.py (path:/tmp/pip-W5sKhu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:22 INFO - Running setup.py (path:/tmp/pip-TQ6c8E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:53:22 INFO - Running setup.py install for manifestparser 00:53:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:53:23 INFO - Running setup.py install for mozcrash 00:53:23 INFO - Running setup.py install for mozdebug 00:53:23 INFO - Running setup.py install for mozdevice 00:53:23 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:53:23 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:53:23 INFO - Running setup.py install for mozfile 00:53:23 INFO - Running setup.py install for mozhttpd 00:53:23 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:53:23 INFO - Running setup.py install for mozinfo 00:53:23 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:53:23 INFO - Running setup.py install for mozInstall 00:53:23 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:53:23 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:53:23 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:53:23 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:53:23 INFO - Running setup.py install for mozleak 00:53:23 INFO - Running setup.py install for mozlog 00:53:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:53:24 INFO - Running setup.py install for moznetwork 00:53:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:53:24 INFO - Running setup.py install for mozprocess 00:53:24 INFO - Running setup.py install for mozprofile 00:53:24 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:53:24 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:53:24 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:53:24 INFO - Running setup.py install for mozrunner 00:53:24 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:53:24 INFO - Running setup.py install for mozscreenshot 00:53:24 INFO - Running setup.py install for moztest 00:53:24 INFO - Running setup.py install for mozversion 00:53:24 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:53:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:53:24 INFO - Cleaning up... 00:53:24 INFO - Return code: 0 00:53:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:53:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f5c87706f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8660>, '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 0x1de9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:53:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 00:53:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 00:53:24 INFO - Using env: {'DISPLAY': ':0', 00:53:24 INFO - 'HOME': '/home/cltbld', 00:53:24 INFO - 'LANG': 'en_US.UTF-8', 00:53:24 INFO - 'LANGUAGE': 'en_US:en', 00:53:24 INFO - 'LOGNAME': 'cltbld', 00:53:24 INFO - 'MAIL': '/var/mail/cltbld', 00:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:24 INFO - 'MOZ_NO_REMOTE': '1', 00:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:24 INFO - 'NO_EM_RESTART': '1', 00:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:24 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:24 INFO - 'SHELL': '/bin/bash', 00:53:24 INFO - 'SHLVL': '1', 00:53:24 INFO - 'TERM': 'linux', 00:53:24 INFO - 'TMOUT': '86400', 00:53:24 INFO - 'USER': 'cltbld', 00:53:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', 00:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:24 INFO - '_': '/tools/buildbot/bin/python'} 00:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:25 INFO - Running setup.py (path:/tmp/pip-QVH9lk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 00:53:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:25 INFO - Running setup.py (path:/tmp/pip-xAU5j7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:53:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:25 INFO - Running setup.py (path:/tmp/pip-qWIjXt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 00:53:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:25 INFO - Running setup.py (path:/tmp/pip-keG6x6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:53:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:25 INFO - Running setup.py (path:/tmp/pip-PZed8O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 00:53:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:25 INFO - Running setup.py (path:/tmp/pip-rWirrj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 00:53:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:25 INFO - Running setup.py (path:/tmp/pip-0Cm19j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 00:53:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:25 INFO - Running setup.py (path:/tmp/pip-Eghihe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 00:53:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:25 INFO - Running setup.py (path:/tmp/pip-xp_KD6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 00:53:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:25 INFO - Running setup.py (path:/tmp/pip-1NSqlz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:53:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:25 INFO - Running setup.py (path:/tmp/pip-ONQLtH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 00:53:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:25 INFO - Running setup.py (path:/tmp/pip-wEXW7d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 00:53:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:25 INFO - Running setup.py (path:/tmp/pip-pA8xM4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 00:53:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:26 INFO - Running setup.py (path:/tmp/pip-Av85ii-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 00:53:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:26 INFO - Running setup.py (path:/tmp/pip-dQfhTp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 00:53:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:26 INFO - Running setup.py (path:/tmp/pip-68ftuf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 00:53:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:26 INFO - Running setup.py (path:/tmp/pip-bJOwpT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 00:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 00:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:53:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:28 INFO - Downloading blessings-1.5.1.tar.gz 00:53:28 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 00:53:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:53:28 INFO - Installing collected packages: blessings 00:53:28 INFO - Running setup.py install for blessings 00:53:28 INFO - Successfully installed blessings 00:53:28 INFO - Cleaning up... 00:53:28 INFO - Return code: 0 00:53:28 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:53:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:53:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:53:28 INFO - Reading from file tmpfile_stdout 00:53:28 INFO - Current package versions: 00:53:28 INFO - argparse == 1.2.1 00:53:28 INFO - blessings == 1.5.1 00:53:28 INFO - blobuploader == 1.2.4 00:53:28 INFO - docopt == 0.6.1 00:53:28 INFO - manifestparser == 1.1 00:53:28 INFO - mozInstall == 1.12 00:53:28 INFO - mozcrash == 0.16 00:53:28 INFO - mozdebug == 0.1 00:53:28 INFO - mozdevice == 0.47 00:53:28 INFO - mozfile == 1.2 00:53:28 INFO - mozhttpd == 0.7 00:53:28 INFO - mozinfo == 0.9 00:53:28 INFO - mozleak == 0.1 00:53:28 INFO - mozlog == 3.1 00:53:28 INFO - moznetwork == 0.27 00:53:28 INFO - mozprocess == 0.22 00:53:28 INFO - mozprofile == 0.28 00:53:28 INFO - mozrunner == 6.11 00:53:28 INFO - mozscreenshot == 0.1 00:53:28 INFO - mozsystemmonitor == 0.0 00:53:28 INFO - moztest == 0.7 00:53:28 INFO - mozversion == 1.4 00:53:28 INFO - psutil == 3.1.1 00:53:28 INFO - requests == 1.2.3 00:53:28 INFO - wsgiref == 0.1.2 00:53:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:53:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f5c87706f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8660>, '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 0x1de9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:53:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 00:53:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 00:53:28 INFO - Using env: {'DISPLAY': ':0', 00:53:28 INFO - 'HOME': '/home/cltbld', 00:53:28 INFO - 'LANG': 'en_US.UTF-8', 00:53:28 INFO - 'LANGUAGE': 'en_US:en', 00:53:28 INFO - 'LOGNAME': 'cltbld', 00:53:28 INFO - 'MAIL': '/var/mail/cltbld', 00:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:28 INFO - 'MOZ_NO_REMOTE': '1', 00:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:28 INFO - 'NO_EM_RESTART': '1', 00:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:28 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:28 INFO - 'SHELL': '/bin/bash', 00:53:28 INFO - 'SHLVL': '1', 00:53:28 INFO - 'TERM': 'linux', 00:53:28 INFO - 'TMOUT': '86400', 00:53:28 INFO - 'USER': 'cltbld', 00:53:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', 00:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:28 INFO - '_': '/tools/buildbot/bin/python'} 00:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 00:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 00:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 00:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 00:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 00:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 00:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 00:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 00:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 00:53:28 INFO - Cleaning up... 00:53:28 INFO - Return code: 0 00:53:28 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 00:53:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f5c87706f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8660>, '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 0x1de9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:53:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 00:53:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 00:53:28 INFO - Using env: {'DISPLAY': ':0', 00:53:28 INFO - 'HOME': '/home/cltbld', 00:53:28 INFO - 'LANG': 'en_US.UTF-8', 00:53:28 INFO - 'LANGUAGE': 'en_US:en', 00:53:28 INFO - 'LOGNAME': 'cltbld', 00:53:28 INFO - 'MAIL': '/var/mail/cltbld', 00:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:28 INFO - 'MOZ_NO_REMOTE': '1', 00:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:28 INFO - 'NO_EM_RESTART': '1', 00:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:28 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:28 INFO - 'SHELL': '/bin/bash', 00:53:28 INFO - 'SHLVL': '1', 00:53:28 INFO - 'TERM': 'linux', 00:53:28 INFO - 'TMOUT': '86400', 00:53:28 INFO - 'USER': 'cltbld', 00:53:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', 00:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:28 INFO - '_': '/tools/buildbot/bin/python'} 00:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:28 INFO - Downloading/unpacking jsonschema 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:53:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 00:53:30 INFO - Downloading/unpacking functools32 (from jsonschema) 00:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:30 INFO - Downloading functools32-3.2.3-2.tar.gz 00:53:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:53:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 00:53:30 INFO - warning: no files found matching '*.txt' 00:53:30 INFO - no previously-included directories found matching 'build' 00:53:30 INFO - no previously-included directories found matching 'dist' 00:53:30 INFO - no previously-included directories found matching '.git*' 00:53:30 INFO - Installing collected packages: jsonschema, functools32 00:53:30 INFO - Running setup.py install for functools32 00:53:31 INFO - warning: no files found matching '*.txt' 00:53:31 INFO - no previously-included directories found matching 'build' 00:53:31 INFO - no previously-included directories found matching 'dist' 00:53:31 INFO - no previously-included directories found matching '.git*' 00:53:31 INFO - Successfully installed jsonschema functools32 00:53:31 INFO - Cleaning up... 00:53:31 INFO - Return code: 0 00:53:31 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 00:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c87706f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d59480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8660>, '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 0x1de9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:53:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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', 'flake8'] in /builds/slave/test-pgo/build 00:53:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 flake8 00:53:31 INFO - Using env: {'DISPLAY': ':0', 00:53:31 INFO - 'HOME': '/home/cltbld', 00:53:31 INFO - 'LANG': 'en_US.UTF-8', 00:53:31 INFO - 'LANGUAGE': 'en_US:en', 00:53:31 INFO - 'LOGNAME': 'cltbld', 00:53:31 INFO - 'MAIL': '/var/mail/cltbld', 00:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:31 INFO - 'MOZ_NO_REMOTE': '1', 00:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:31 INFO - 'NO_EM_RESTART': '1', 00:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:31 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:31 INFO - 'SHELL': '/bin/bash', 00:53:31 INFO - 'SHLVL': '1', 00:53:31 INFO - 'TERM': 'linux', 00:53:31 INFO - 'TMOUT': '86400', 00:53:31 INFO - 'USER': 'cltbld', 00:53:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', 00:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:31 INFO - '_': '/tools/buildbot/bin/python'} 00:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:31 INFO - Downloading/unpacking flake8 00:53:31 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 00:53:31 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 00:53:31 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 00:53:31 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 00:53:31 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 00:53:31 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 00:53:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:53:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 00:53:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:53:32 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 00:53:32 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 00:53:32 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 00:53:32 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 00:53:32 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 00:53:32 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 00:53:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:53:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 00:53:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:53:33 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 00:53:33 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 00:53:33 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 00:53:33 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 00:53:33 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 00:53:33 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 00:53:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 00:53:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:53:33 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 00:53:33 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 00:53:33 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 00:53:33 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 00:53:33 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 00:53:33 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 00:53:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 00:53:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 00:53:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:53:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:53:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:53:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:53:33 INFO - no previously-included directories found matching 'docs/_build' 00:53:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:53:33 INFO - Running setup.py install for pep8 00:53:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:53:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:53:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:53:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:53:33 INFO - no previously-included directories found matching 'docs/_build' 00:53:33 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 00:53:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:53:33 INFO - Cleaning up... 00:53:34 INFO - Return code: 0 00:53:34 INFO - Running post-action listener: _resource_record_post_action 00:53:34 INFO - Running post-action listener: _start_resource_monitoring 00:53:34 INFO - Starting resource monitoring. 00:53:34 INFO - ##### 00:53:34 INFO - ##### Running install step. 00:53:34 INFO - ##### 00:53:34 INFO - Running pre-action listener: _resource_record_pre_action 00:53:34 INFO - Running main action method: install 00:53:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:53:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:53:35 INFO - Reading from file tmpfile_stdout 00:53:35 INFO - Detecting whether we're running mozinstall >=1.0... 00:53:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:53:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:53:35 INFO - Reading from file tmpfile_stdout 00:53:35 INFO - Output received: 00:53:35 INFO - Usage: mozinstall [options] installer 00:53:35 INFO - Options: 00:53:35 INFO - -h, --help show this help message and exit 00:53:35 INFO - -d DEST, --destination=DEST 00:53:35 INFO - Directory to install application into. [default: 00:53:35 INFO - "/builds/slave/test-pgo"] 00:53:35 INFO - --app=APP Application being installed. [default: firefox] 00:53:35 INFO - mkdir: /builds/slave/test-pgo/build/application 00:53:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 00:53:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 00:53:51 INFO - Reading from file tmpfile_stdout 00:53:51 INFO - Output received: 00:53:51 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:53:51 INFO - Running post-action listener: _resource_record_post_action 00:53:51 INFO - ##### 00:53:51 INFO - ##### Running run-tests step. 00:53:51 INFO - ##### 00:53:51 INFO - Running pre-action listener: _resource_record_pre_action 00:53:51 INFO - Running main action method: run_tests 00:53:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:53:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:53:51 INFO - Python 2.7.3 00:53:51 INFO - Return code: 0 00:53:51 INFO - grabbing minidump binary from tooltool 00:53:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:51 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-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de8660>, '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 0x1de9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:53:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 00:53:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:53:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:53:51 INFO - Return code: 0 00:53:51 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:53:51 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:53:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:53:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:53:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:53:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 00:53:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 00:53:52 INFO - Return code: 0 00:53:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 00:53:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 00:53:52 INFO - Using env: {'DISPLAY': ':0', 00:53:52 INFO - 'HOME': '/home/cltbld', 00:53:52 INFO - 'LANG': 'en_US.UTF-8', 00:53:52 INFO - 'LANGUAGE': 'en_US:en', 00:53:52 INFO - 'LOGNAME': 'cltbld', 00:53:52 INFO - 'MAIL': '/var/mail/cltbld', 00:53:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:53:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:52 INFO - 'MOZ_NO_REMOTE': '1', 00:53:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:52 INFO - 'NO_EM_RESTART': '1', 00:53:52 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:52 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:52 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:53:52 INFO - 'SHELL': '/bin/bash', 00:53:52 INFO - 'SHLVL': '1', 00:53:52 INFO - 'TERM': 'linux', 00:53:52 INFO - 'TMOUT': '86400', 00:53:52 INFO - 'USER': 'cltbld', 00:53:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930', 00:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:52 INFO - '_': '/tools/buildbot/bin/python'} 00:53:52 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:53:52 INFO - mozversion application_buildid: 20160107223006 00:53:52 INFO - mozversion application_changeset: d4213241bb796fdfa7a5ad4f1989e97b44474364 00:53:52 INFO - mozversion application_display_name: Nightly 00:53:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:53:52 INFO - mozversion application_name: Firefox 00:53:52 INFO - mozversion application_remotingname: firefox 00:53:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:53:52 INFO - mozversion application_vendor: Mozilla 00:53:52 INFO - mozversion application_version: 46.0a1 00:53:52 INFO - mozversion platform_buildid: 20160107223006 00:53:52 INFO - mozversion platform_changeset: d4213241bb796fdfa7a5ad4f1989e97b44474364 00:53:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:53:52 INFO - mozversion platform_version: 46.0a1 00:53:52 INFO - using testdate: 1452243232 00:53:52 INFO - actual date: 1452243232 00:53:52 INFO - starting webserver on 'localhost:56313' 00:53:52 INFO - SUITE-START | Running 3 tests 00:53:52 INFO - TEST-START | dromaeo_css 00:53:52 INFO - operating with platform_type : linux_ 00:53:52 INFO - Initialising browser for dromaeo_css test... 00:53:52 INFO - TEST-INFO | started process 2932 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFSKP_K/profile http://localhost:56313/getInfo.html) 00:53:57 INFO - PROCESS | 2932 | __metrics Screen width/height:1600/1200 00:53:57 INFO - PROCESS | 2932 | colorDepth:24 00:53:57 INFO - PROCESS | 2932 | Browser inner width/height: 1024/697 00:53:57 INFO - PROCESS | 2932 | __metrics 00:53:57 INFO - PROCESS | 2932 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:53:57 INFO - PROCESS | 2932 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:53:58 INFO - TEST-INFO | 2932: exit 0 00:53:58 INFO - Browser initialized. 00:53:58 INFO - Running cycle 1/1 for dromaeo_css test... 00:53:58 INFO - TEST-INFO | started process 3028 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFSKP_K/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:54:09 INFO - PROCESS | 3028 | RSS: Main: 150466560 00:54:09 INFO - PROCESS | 3028 | 00:55:01 INFO - PROCESS | 3028 | 1452243301072 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] 00:57:09 INFO - PROCESS | 3028 | Cycle 1(1): loaded http://localhost:56313/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56313/tests/dromaeo/cssquery-ext.html) 00:57:10 INFO - PROCESS | 3028 | RSS: Main: 231165952 00:57:10 INFO - PROCESS | 3028 | 01:00:13 INFO - PROCESS | 3028 | Cycle 1(1): loaded http://localhost:56313/tests/dromaeo/cssquery-ext.html (next: http://localhost:56313/tests/dromaeo/cssquery-jquery.html) 01:00:13 INFO - PROCESS | 3028 | RSS: Main: 240205824 01:00:13 INFO - PROCESS | 3028 | 01:03:15 INFO - PROCESS | 3028 | Cycle 1(1): loaded http://localhost:56313/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56313/tests/dromaeo/cssquery-mootools.html) 01:03:16 INFO - PROCESS | 3028 | RSS: Main: 244625408 01:03:16 INFO - PROCESS | 3028 | 01:06:18 INFO - PROCESS | 3028 | Cycle 1(1): loaded http://localhost:56313/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56313/tests/dromaeo/cssquery-prototype.html) 01:06:18 INFO - PROCESS | 3028 | RSS: Main: 216064000 01:06:18 INFO - PROCESS | 3028 | 01:09:21 INFO - PROCESS | 3028 | Cycle 1(1): loaded http://localhost:56313/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56313/tests/dromaeo/cssquery-yui.html) 01:09:21 INFO - PROCESS | 3028 | RSS: Main: 219787264 01:09:21 INFO - PROCESS | 3028 | 01:12:24 INFO - PROCESS | 3028 | Cycle 1(1): loaded http://localhost:56313/tests/dromaeo/cssquery-yui.html (next: http://localhost:56313/tests/dromaeo/cssquery-dojo.html) 01:12:24 INFO - PROCESS | 3028 | RSS: Main: 275644416 01:12:24 INFO - PROCESS | 3028 | 01:12:24 INFO - PROCESS | 3028 | __start_tp_report 01:12:24 INFO - PROCESS | 3028 | _x_x_mozilla_page_load 01:12:24 INFO - PROCESS | 3028 | _x_x_mozilla_page_load_details 01:12:24 INFO - PROCESS | 3028 | |i|pagename|runs| 01:12:24 INFO - PROCESS | 3028 | |0;dojo.html;2983.4331477019364;3064.7241748242654;3095.2416657918807;3097.7521798256143;3101.9763478052246;4871.342368780213;4961.702297862131;5073.036123136601;5078.568321692661;5120.487951204877;4892.486288939664;5000.324956130921;5006.148954677705;5011.373578302712;5018.096742586342;4351.347297905324;4511.774411279439;4622.699524530912;4647.883802904929;4739.644526660497;4547.15877562652;4636.304554316863;4664.813407463697;4700.341952126705;4791.041791641668;4627.444706635191;4686.390769200017;4691.179043667345;4695.5539223773685;4718.221493453576;4599.540045995407;4607.815687372501;4623.653226008063;4631.907361852744;4650.837220697294;4524.8190072397065;4571.977140114312;4575.816967321303;4604.930926036112;4613.6078433333205;4928.162212423897;4947.752612369403;4953.702777833306;4962.87592810179;4967.180415231519;5429.972850135763;5434.918476222821;5440.700761458118;5454.10007348787;5466.098093814516;5321.068812957717;5383.650062745909;5412.269343638598;5413.593980451443;5444.727763611803;4957.3059771632;4959.231319145538;4966.056449274663;4973.5772459341;5012.27322038306;5401.7299135043095;5408.810691625774;5422.154913018413;5450.91823622646;5456.127019676833;5203.32356793622;5237.214417837355;5300.44345343741;5302.151655735064;5309.814156504581;5388.299521062237;5401.459854014567;5435.130379139318;5444.237806707064;5448.427915068861;5369.301990741179;5376.354837419534;5377.354717433933;5383.16560933056;5383.703896285663;5268.051750684914;5326.334208223972;5366.356037275552;5387.326584176978;5418.647787893853;4176.2900306947895;4185.351270553069;4189.2668782962855;4190.685698572558;4192.664586833046;3782.0922978485514;3793.412021136728;3813.7902415366866;3818.84724611018;3819.52255968004;5026.170681837456;5088.262201980692;5102.897942041139;5131.692098474104;5139.074966506065;5397.946020539823;5422.674639521641;5423.566114710814;5430.728463576806;5477.67133971955;4866.9513304867205;4960.181570040975;5018.498150185025;5025.271335656309;5028.5977121830165;4581.679282450264;4622;4672.275797251364;4672.766361681903;4702.811887524529;5600.887982240332;5600.971995139998;5602.467765562265;5608.46719561641;5665.065264231438;5077.162268225701;5146.279520867007;5430.592705547021;5430.592705547178;5448.155535891864;5459.508644222039;5606.943930560806;5676.744546495335;5702.885942281048;5718.8570285741525;5297.947020529899;5320.068987927175;5328.547073498796;5332.920006199833;5338.225957236256;5386.434424385383;5405.675659460445;5412.269343638558;5415.187721841755;5463.508284254436;5218.295530103539;5312.1766126250495;5318.867028324323;5332.5467335276935;5411.134218525017;5314.1497360422145;5325.307709997675;5332.70670113132;5335.199720042025;5336.0661884170895;5199.74001299941;5227.059129356752;5252.343457067866;5254.500822421864;5303.814366497154;5125.615578831528;5234.162533994542;5282.920756188737;5343.305370301836;5379.865503362447;5162.922556161736;5169.715665638426;5170.612204084784;5172.508611681884;5211.55701765339 01:12:24 INFO - PROCESS | 3028 | |1;ext.html;534.6230907210416;537.1164434505239;540.0414264680195;557.1114073053479;562.9577781666371;27427.588586171223;28085.43829123419;28102.578461323097;28140.296492587695;28150.577741333895;28587;29018.709812901863;29046.564301535494;38527.42208866862;38949.41575876357;8597.4411663242;8768.736937891841;8769.210771030606;8773.64905403783;8779.868301975444;7562.319391254786;8516.914830851674;8667.263282620954;8677.088905664908;8682.609282582267;7552.546847189186;10227.795444091114;10420.791584168312;10423.73940651486;10442.530086146104;9802;9954.452505112216;9957.601695932226;9958.999999999964;9974.301798874081;7544.207858174922;7741.8838717419285;9793.608255669764;9936.552855121538;10099.39403635777;36255;36477.270454591024;36959;36984.63015369839;37036.62963370386;2905.1586141273256;3047.040182342555;3233.110894504007;3332.683395077464;3647.9420967919536;27491.17526474209;28118;28164.436711265866;28320;28356.858215708788;3678.429843374281;3688.0964163780045;3735.831887565066;3770.6606405423368;3826.081740382316;260893;261423;262384;263026.9999999981;263092;57075.714621426625;57262.71368643214;57264.42735572591;57369;57700.422995769506;59900.40099598948;60226;60278;60286.39713602808;60304.698476507336;14343.139411635335;14569.344379502947;14570.85429145695;14579.927100364643;14590.051646642934;11148.665540033811;11219.439028048564;11241.494132764044;11251.437428128724;11256;17377.127169291685;19109.522261943563;19144.234230630896;19206.903965480084;19375.4187374379;7263.0921134858145;7521.623918804038;7628.160902300742;7670.7698769037015;7747.535147891144;917.3395155488038;937.9343445958854;1012.6658202793061;1044.4151275285865;1120.6301920366259;26901.284813662227;27319.72680273172;27788.166355009384;27847.86076069607;28081.43837123246;904.1448214462282;964.8195079121097;1021.1371391174446;1021.2646894236138;1062.1768129699544;13213;13645.727085458235;13895.096818706752;13995.86004139966;14015.719685606231;418725;430093;430147;430784;430962;43289.13421731611;43572.346414803804;46227.537724623;48703.75648121808;48813.75593122012;1305.8432988041495;1335.692790658154;1336.8395792504962;1340.4035204333977;1348.3393137362818;24137.758622413552;24517.632235516838;24633.384165396008;25113.121040763486;25201;39592.40611390774;39798.801005994785;39899.60100398959;39924;39961.80019099886;197686;198092;199023;199626;199893;29556.408871822874;29900;29949.700502994692;29968.250793729458;29975;39266.60733392744;39692.801535992134;40224;40513.59486405216;41090.1781964365;34825;34877.82561087178;34976.30047398987;35235.29529409449;35322.1169470755;33852.153696157795;34929.30141397208;34952.12619684528;34983.65016349804;35334.29331413409;31432.842835785676;31520;31799.046028619177;34212;34703.826480867436;27261.86369068142;28884;30831.2292192697;31121.221969450944;31399.68600314059;23976.88011559931;23983.880080599487;24104.87947560251;24113.51772964496;24124.51750965006 01:12:24 INFO - PROCESS | 3028 | |2;jquery.html;334.7606461380113;340.4008944258106;343.3339321715869;349.84257084312065;354.277274360305;13571.117877337967;14086.78869816951;15641.217939103042;15659;16716.91641541792;15549.689006219869;15559.611009724762;15946.202689865519;15947.122908240042;15986.280617372217;4820.999999999991;5454.4545545445335;5456.672599644015;5456.781728730846;5463.644863083907;3954.2882281189372;4092.4679791627045;5330.1205301125465;5575.442455754433;5739;5644.989576576249;5696.08862581987;5766.509846663039;5770.04794208955;5856.443637854397;5817.912731309013;5838.532917366621;5840.8247752567495;5847.678377689225;5847.941520584783;4792.832250871237;4981.427135879348;4985.825496107655;4989.625778066623;5135.255387968761;12326.445309961073;12846;18262;18708.532286692807;18798;1904.2858927902037;1997.2310660395708;2071.0369678099755;2239.317008312464;2368.8223383246327;9111.134442227978;9419.105185007413;9477.336586438953;9610.183134433582;9610.423374597547;1793.4888556761261;1805.2959345855127;1836.6143109946927;1837.3201915291295;1864.2263460663808;54007.189892151255;54267.72866135644;54324;55495.44504554903;55596.44403555953;10045.949770251102;10097.798044039078;10103.393796372242;10107.494625268708;10186.643467478603;13001.284929328978;13005.479780808662;13051.673708157183;13119.540816071392;13132.409041593151;7414.592197429085;7420.5176663516695;7420.888686669704;7463.328300452985;7473.775786726298;7037.366637002592;7040.119985001875;7087;7140.57156570597;7158.427325813923;4082.8775136745944;4358.150160718693;4430.446194225722;4434.977825110854;4457.487388950248;1726.464795913271;1739.2868923741205;1836.540864783804;1853.9165737541844;1866.3561071430336;830.8546004449197;862.7325529086004;905.8143080668447;954.7040417470606;1031.7626945802508;13125.934370328087;14486.637834054021;15710.607234819221;15816.446424375092;15965.521034368987;897.3090720145582;899.1278459893892;915.3455279475207;920.545992655425;928.9163975242261;9312.161905428544;9331.34680572367;9365.62537498506;9416.387934784218;9560.76098097553;467123.9794209269;501332;501993;503181;530510;64650;68471;73026.63486682638;75159.24840751632;79427.60286198648;490.03707714342204;491.2017970797454;503.7884088682762;504.36953807740326;504.8334049763569;10003.936595891002;10111.494425278559;10169;10327.380357178594;10370.948145259226;21309.46726331792;31315.747370104942;32212.677873220968;32467.35065298728;32749.34501309913;40272.590459333784;40468.39297410482;42290;42884.57115428806;43932.560674394124;6705.497087718343;7032.437405007689;7138.179109402485;7175.706547221172;7467.738629148171;9646.276529260474;10397.636082737068;10853.674389768319;11076.889231107585;11100.444977751242;9333.25333973294;9420.905790942003;9570.425774453555;9706.854397183906;9935.354201976848;7631.351335136354;9209.907900920905;9616.75958101053;9860.26048046385;10132.949335253277;9251.213646840093;9341.082001220722;9682.080202380763;10037.949810250902;10089.949550252202;6984;7026.473014524034;7082.929170708227;7183.784486465205;7254.093238345207;7036;7966.800829979297;7978.361731061617;7987.520748755093;8039.557824319719 01:12:24 INFO - PROCESS | 3028 | |3;mootools.html;1284.261549608975;1453.6438572549728;1473.2633683158422;1603.7754714339994;1760.2255007796568;6276.811695649127;7081.61051142187;7133.500654954155;7193.8201544961275;7249.057622509066;7152;7307.963460182692;7316.158641756187;7352.0442342495535;7360.631968401585;1894.943151705451;1939.3018513335187;2187.0814258011674;2193.254293540196;2219.4562332228625;2212.7676593957644;2214.3689048621145;2219.034719896842;2219.7891200335944;2228.1198926424054;2158.6330323844986;2229.554089182162;2229.7993180613744;2231.1856172497082;2232.854864433815;2170.9565808683897;2183.257692384589;2188.4419473034354;2211.966820497678;2233;2181.9127234910743;2191.594555007329;2194.264921251383;2207;2212.5243072739277;7253.963730181368;7268.927310726878;7270.818229544251;7303;7324.30419110189;4422.314541246112;4563.520830312836;4572.679912406133;4575.428071491064;4576.153411618861;2843.5876797864403;2943.0876428307292;2953.1288269960414;2967.540031295153;2967.896123635684;887.2502735188755;906;910.5629297936961;930.2976252929063;943.5989704375681;10115.342502737298;10116.89883101167;10120.949395252977;10126.189904807597;10152.543135558844;4010.578889216649;4040.4343391925154;4083.1221287423346;4098.098418347959;4098.979505102456;8609.397342185986;8611.827763444697;8614.956925215334;8621.439606425562;8634.784130396665;4539.7049191802425;4548.95451045492;4579.610733087658;4586.014006988514;4586.518415566385;4207.684423668237;4215.346621273708;4217.072244106292;4222.683298752606;4225.68307376948;3055.434744572261;3095.1488340706037;3430.433978393537;3487.372272990886;3517.419625761772;1115.5203262597;1135.2507345152326;1135.2904434728296;1138.2089447833841;1141.960031398897;1243.9004879609608;1259.9181053231512;1298.1302527306727;1299.5841330774251;1299.8245236893088;6831.521793474509;6950.513464057467;6999.0551275577145;7015.684294206773;7019.508634395544;1074.382230217628;1091.8744344400336;1099.455769394155;1103.150574057971;1107.9667609971714;5593.244911936918;5601.29983752031;5610.663360198401;5627.155926611041;5628.521575666033;8214.13751556078;8283.668653253802;8297.917020829835;8824.3381746368;9086.681966131153;8209;8278.254957053894;8300.2114799094;8305.46014509055;8310.044344900292;6820.181578210647;6820.658967051628;6941.68762405693;6944.236134025253;7010.754623588252;6893.655317234218;6970.302969703192;6985.511014228955;6990.790276291719;6993.965030174817;7846.0976987647155;8004;8168.305694015838;8171.101178870438;8186.713465028695;7795.883061753965;7806.41451891099;7917.7624671259955;7925.326347260317;8172.264496195371;6613.074169616161;6620.735170593122;6633.237177724431;6721.462283017249;6724.025016372696;6084.847878802888;6231.875362492816;6790.66046697673;7030.402415794715;7064.399526040344;6552.443042341454;6557.475401967736;6654.733810647714;6681.198256209286;6719.361660642231;6483.351664833479;6528.934710652833;6544.247411547733;6650.90023649636;6675;6526.608403495616;6539.411452969255;6546.410823025951;6553.672316384257;6569.441597464078;6129.540284478593;6181.289151747606;6243.750249989949;6244.750209991549;6249.187605611241;6313.463355614824;6315.242170939517;6320.08358787964;6327.557071004985;6343.841403964938 01:12:24 INFO - PROCESS | 3028 | |4;prototype.html;323.41784787382704;327.23100713323686;328.1451818014073;328.24012411267927;334.8894864694651;5882.147088672145;5890.469857712805;5893.469587737103;5914.733836977335;5916.970415147929;5533.253010843535;5649.12438572022;5690.345610254822;5844.970775146129;5859.121131830228;4508;4510.14307281617;4518.344839998198;4527.479339875924;4531.297648864423;4274.401583778274;4520.954790452102;4528.524504926984;4529.365888775557;4539.682222244444;4321.941124424505;4373.693841431101;4443.333499974998;4463.665225108113;4464.73211607303;4404.207242696313;4409.735415875058;4414.779261036935;4442.2892337225885;4446.333050042504;3924.646781789653;3924.8822535323984;3927.8821635350987;3935.05558665921;3936.193080418536;5466.34403871534;5551.583631227633;5554.611177217596;5555.638883472602;5571.359293681238;5160.948390516084;5189.792408303663;5190.844274671766;5197.350331208599;5199.844004679866;6083.087536869505;6102.633841969496;6105.450509454126;6121.3572574879445;6138.048602466625;4324.17840610283;4324.978375108104;4326.351047342924;4331.285337919239;4333.025069359401;6289.37106289372;6414.775482858125;6418.876696578127;6424.775132870373;6461.483081353434;4349.760763158057;4397.494288156903;4397.8240870364825;4399.36209249657;4403.339499075164;4437.489688685842;4443.089166720814;4444.2444784386735;4457.977710111429;4458.261278101543;5168.2764412982215;5172.043172013189;5180.766865490987;5182.067227898939;5182.274481572583;6087.239095113111;6240.65676387794;6248.125262463259;6249.968750156311;6250.74997000124;1550.178405445116;1570.7329753941628;1584.8573628373501;1585.0014490870908;1585.2153184173678;1032.8277405145213;1048.7535429174138;1050.4747626186906;1059.3855563772993;1072.0512346573182;5858.970705146532;5860.912086318709;5863.355030946593;5866.5893387462465;5871.941280587225;6355.713992870332;6381;6390.488760899117;6390.712417941204;6398.744050238031;5717.2281741965135;5793.594448388572;5815.098659707752;5836.737346819404;5846.532277417797;3452.171478845059;3482.5820901491984;3483.512308276843;3486.3027394521196;3488.720902327808;6660.23407308156;6693.464522838259;6694.59832410057;6697.631630260383;6699.062131301622;6465.935340646627;6614.735410583619;6620.172478440195;6634;6635.402813746786;6674.299198584175;6679.833004174838;6687.331266873371;6693.665316734144;6717.5297729159465;6419.550631455753;6464.191976003;6473;6474.320196379501;6480.254770701241;6304;6352.396522330371;6393.041043843461;6400.295967443484;6403.775867844603;6689;6689.531732778853;6691.43122834545;6695.263521012782;6698.296678848846;4379.868603941887;4419.580139886705;4424.535423780457;4425.933610995773;4427.490838553607;6275.215598050244;6445.452136568444;6451.48388128958;6462;6496.0580715795;6327.209098862642;6331.746730130743;6338.58799178052;6342.365763423621;6343;6295.811125666238;6315.147455093504;6318.988961766096;6373.171487706569;6385.712642931172;6078.878422431615;6174.907376389448;6175.320714721287;6193.411625895533;6210.658413787285;6329.367063293634;6332.398422149889;6334.113224148531;6337.8732425352155;6347;6156.722947467464;6166.845828854314;6173.259208894781;6175.2589689237575;6184.907226391698 01:12:24 INFO - PROCESS | 3028 | |5;yui.html;793.1434051224676;794.4359504751626;796.390761067783;807.6890397197077;811.37524106438;12698.492060317587;12895.290759008263;12941.611751647442;12945.482180712785;12951.287679177653;12701.110922235448;12755.17091389059;12763.361831908414;12778.233306001646;12778.616641500746;660.0462331930363;664.5979182594533;799.6841247707152;811.0875265326507;829.1335554345724;819.0826274572487;821.8027673358381;826.1036775098995;826.7478419082178;827.1397746343795;704.7709494414311;854.8290341931638;855.3969451536652;856.0839901305606;856.1310270075846;701.2496628607392;849.9702510412137;860.6127242740729;865.476386785998;866.3459088388289;634.0520921222756;638.7668500997149;638.987220255597;639.4117411980942;639.9680015999181;12441.75116497674;12684.365781710878;12722.300273484954;12756.936215318863;12786.296753678544;12473.625791226277;12852.293123878277;12960.222386656831;13051.804222936664;13107.47570097195;10193.847092293621;10257.076863082359;10428.582856685724;10943.56225750969;11174.329540227613;3621.5908246426766;3677.889663310105;3678.393065144248;3680.723945704083;3789.2800367930004;42758.358624620654;43357.09786119265;43876;44053.33919991203;44384.55615443869;9645.324827262024;9708.223342132613;9714.61141554344;9791.657291994747;9871.753206169904;17245.22396492161;17482.737758933625;17489.300427982736;17567.560810979572;17580.648387032186;7529.171791102975;7563.092428908566;7563.697452101965;7612.7716168515035;7741.651625676858;4407.735535867858;4413.426254586883;4416.492103408085;4419.160359531678;4430.269005614102;2825.2089414963843;2848.886044558236;2853.52916768735;2858.7855910806775;2859;522.4044589168351;537.6317222702461;538.5825984861685;566.9348024977098;568.6758547627895;425.59781006948754;599.1043390131781;613.9715975740617;638.6998110887876;641.1184621145925;7894.921050789419;8040.597970101471;8161.836763264821;8349.499030058216;8407.537585432738;507.69538277033485;559.443353862909;564.2157401212318;621.3537920562565;636.9076483909807;3601.9099522511624;3702.4816525686424;3708.8516459341863;3712.424574191005;3757.680597149218;51171.48828511742;51633.7418312906;51966.74016629893;51977.220341694905;51998;47208.29187562189;47361.763191183825;47830.28254576184;48384;48463;43628.345574816405;43803.12393752107;44232;44490.33264501035;45244.773776131566;7306.890396643948;7350.301721336678;7497.475176737576;7506.662200200894;7528.134264559427;30760;31336.373272533965;31872.521912170872;32001.359972800878;32666.673333266364;37329;37516;39546.2090758189;41921.58078419177;42160.57839421566;10163.186945044527;10178.592856285963;10218.080372766486;10295.794084118126;10559.472026398496;10922.180836437457;10986.811643988927;11081.5567377304;11150.944245279046;11492.195546311677;9035.186833185046;9530.95234523823;9671.419714816851;9784.119429251401;9911.058449447291;9951.651692190739;10284.434356110485;10484.056434920894;10599.046085852311;10615.09771669386;9518.714438566854;9979.700608981742;10056.597736090767;10270.178385729274;10284.640037598649;8575.571221438779;8595;8669.739907802523;8760.824783504167;8918.509481978554;7629.351505122127;7985.560794156378;8136.349092072502;8410.579471026547;8649.481031138152 01:12:24 INFO - PROCESS | 3028 | __end_tp_report 01:12:24 INFO - PROCESS | 3028 | __start_cc_report 01:12:24 INFO - PROCESS | 3028 | _x_x_mozilla_cycle_collect,945 01:12:24 INFO - PROCESS | 3028 | __end_cc_report 01:12:24 INFO - PROCESS | 3028 | __startTimestamp1452244344779__endTimestamp 01:12:24 INFO - PROCESS | 3028 | 01:12:24 INFO - PROCESS | 3028 | ------- Summary: start ------- 01:12:24 INFO - PROCESS | 3028 | Number of tests: 6 01:12:24 INFO - PROCESS | 3028 | 01:12:24 INFO - PROCESS | 3028 | [#0] dojo.html Cycles:165 Average:5018.59 Median:5199.74 stddev:539.04 (10.4%) stddev-sans-first:516.51 01:12:24 INFO - PROCESS | 3028 | Values: 2983.4 3064.7 3095.2 3097.8 3102.0 4871.3 4961.7 5073.0 5078.6 5120.5 4892.5 5000.3 5006.1 5011.4 5018.1 4351.3 4511.8 4622.7 4647.9 4739.6 4547.2 4636.3 4664.8 4700.3 4791.0 4627.4 4686.4 4691.2 4695.6 4718.2 4599.5 4607.8 4623.7 4631.9 4650.8 4524.8 4572.0 4575.8 4604.9 4613.6 4928.2 4947.8 4953.7 4962.9 4967.2 5430.0 5434.9 5440.7 5454.1 5466.1 5321.1 5383.7 5412.3 5413.6 5444.7 4957.3 4959.2 4966.1 4973.6 5012.3 5401.7 5408.8 5422.2 5450.9 5456.1 5203.3 5237.2 5300.4 5302.2 5309.8 5388.3 5401.5 5435.1 5444.2 5448.4 5369.3 5376.4 5377.4 5383.2 5383.7 5268.1 5326.3 5366.4 5387.3 5418.6 4176.3 4185.4 4189.3 4190.7 4192.7 3782.1 3793.4 3813.8 3818.8 3819.5 5026.2 5088.3 5102.9 5131.7 5139.1 5397.9 5422.7 5423.6 5430.7 5477.7 4867.0 4960.2 5018.5 5025.3 5028.6 4581.7 4622.0 4672.3 4672.8 4702.8 5600.9 5601.0 5602.5 5608.5 5665.1 5077.2 5146.3 5430.6 5430.6 5448.2 5459.5 5606.9 5676.7 5702.9 5718.9 5297.9 5320.1 5328.5 5332.9 5338.2 5386.4 5405.7 5412.3 5415.2 5463.5 5218.3 5312.2 5318.9 5332.5 5411.1 5314.1 5325.3 5332.7 5335.2 5336.1 5199.7 5227.1 5252.3 5254.5 5303.8 5125.6 5234.2 5282.9 5343.3 5379.9 5162.9 5169.7 5170.6 5172.5 5211.6 01:12:24 INFO - PROCESS | 3028 | 01:12:24 INFO - PROCESS | 3028 | [#1] ext.html Cycles:180 Average:44996.73 Median:18592.42 stddev:82494.67 (443.7%) stddev-sans-first:82658.54 01:12:24 INFO - PROCESS | 3028 | Values: 534.6 537.1 540.0 557.1 563.0 27427.6 28085.4 28102.6 28140.3 28150.6 28587.0 29018.7 29046.6 38527.4 38949.4 8597.4 8768.7 8769.2 8773.6 8779.9 7562.3 8516.9 8667.3 8677.1 8682.6 7552.5 10227.8 10420.8 10423.7 10442.5 9802.0 9954.5 9957.6 9959.0 9974.3 7544.2 7741.9 9793.6 9936.6 10099.4 36255.0 36477.3 36959.0 36984.6 37036.6 2905.2 3047.0 3233.1 3332.7 3647.9 27491.2 28118.0 28164.4 28320.0 28356.9 3678.4 3688.1 3735.8 3770.7 3826.1 260893.0 261423.0 262384.0 263027.0 263092.0 57075.7 57262.7 57264.4 57369.0 57700.4 59900.4 60226.0 60278.0 60286.4 60304.7 14343.1 14569.3 14570.9 14579.9 14590.1 11148.7 11219.4 11241.5 11251.4 11256.0 17377.1 19109.5 19144.2 19206.9 19375.4 7263.1 7521.6 7628.2 7670.8 7747.5 917.3 937.9 1012.7 1044.4 1120.6 26901.3 27319.7 27788.2 27847.9 28081.4 904.1 964.8 1021.1 1021.3 1062.2 13213.0 13645.7 13895.1 13995.9 14015.7 418725.0 430093.0 430147.0 430784.0 430962.0 43289.1 43572.3 46227.5 48703.8 48813.8 1305.8 1335.7 1336.8 1340.4 1348.3 24137.8 24517.6 24633.4 25113.1 25201.0 39592.4 39798.8 39899.6 39924.0 39961.8 197686.0 198092.0 199023.0 199626.0 199893.0 29556.4 29900.0 29949.7 29968.3 29975.0 39266.6 39692.8 40224.0 40513.6 41090.2 34825.0 34877.8 34976.3 35235.3 35322.1 33852.2 34929.3 34952.1 34983.7 35334.3 31432.8 31520.0 31799.0 34212.0 34703.8 27261.9 28884.0 30831.2 31121.2 31399.7 23976.9 23983.9 24104.9 24113.5 24124.5 01:12:24 INFO - PROCESS | 3028 | 01:12:24 INFO - PROCESS | 3028 | [#2] jquery.html Cycles:180 Average:25815.90 Median:251842.39 stddev:81965.32 (32.5%) stddev-sans-first:82172.92 01:12:24 INFO - PROCESS | 3028 | Values: 334.8 340.4 343.3 349.8 354.3 13571.1 14086.8 15641.2 15659.0 16716.9 15549.7 15559.6 15946.2 15947.1 15986.3 4821.0 5454.5 5456.7 5456.8 5463.6 3954.3 4092.5 5330.1 5575.4 5739.0 5645.0 5696.1 5766.5 5770.0 5856.4 5817.9 5838.5 5840.8 5847.7 5847.9 4792.8 4981.4 4985.8 4989.6 5135.3 12326.4 12846.0 18262.0 18708.5 18798.0 1904.3 1997.2 2071.0 2239.3 2368.8 9111.1 9419.1 9477.3 9610.2 9610.4 1793.5 1805.3 1836.6 1837.3 1864.2 54007.2 54267.7 54324.0 55495.4 55596.4 10045.9 10097.8 10103.4 10107.5 10186.6 13001.3 13005.5 13051.7 13119.5 13132.4 7414.6 7420.5 7420.9 7463.3 7473.8 7037.4 7040.1 7087.0 7140.6 7158.4 4082.9 4358.2 4430.4 4435.0 4457.5 1726.5 1739.3 1836.5 1853.9 1866.4 830.9 862.7 905.8 954.7 1031.8 13125.9 14486.6 15710.6 15816.4 15965.5 897.3 899.1 915.3 920.5 928.9 9312.2 9331.3 9365.6 9416.4 9560.8 467124.0 501332.0 501993.0 503181.0 530510.0 64650.0 68471.0 73026.6 75159.2 79427.6 490.0 491.2 503.8 504.4 504.8 10003.9 10111.5 10169.0 10327.4 10370.9 21309.5 31315.7 32212.7 32467.4 32749.3 40272.6 40468.4 42290.0 42884.6 43932.6 6705.5 7032.4 7138.2 7175.7 7467.7 9646.3 10397.6 10853.7 11076.9 11100.4 9333.3 9420.9 9570.4 9706.9 9935.4 7631.4 9209.9 9616.8 9860.3 10132.9 9251.2 9341.1 9682.1 10037.9 10089.9 6984.0 7026.5 7082.9 7183.8 7254.1 7036.0 7966.8 7978.4 7987.5 8039.6 01:12:24 INFO - PROCESS | 3028 | 01:12:24 INFO - PROCESS | 3028 | [#3] mootools.html Cycles:180 Average:5157.79 Median:6246.97 stddev:2612.19 (41.8%) stddev-sans-first:2603.29 01:12:24 INFO - PROCESS | 3028 | Values: 1284.3 1453.6 1473.3 1603.8 1760.2 6276.8 7081.6 7133.5 7193.8 7249.1 7152.0 7308.0 7316.2 7352.0 7360.6 1894.9 1939.3 2187.1 2193.3 2219.5 2212.8 2214.4 2219.0 2219.8 2228.1 2158.6 2229.6 2229.8 2231.2 2232.9 2171.0 2183.3 2188.4 2212.0 2233.0 2181.9 2191.6 2194.3 2207.0 2212.5 7254.0 7268.9 7270.8 7303.0 7324.3 4422.3 4563.5 4572.7 4575.4 4576.2 2843.6 2943.1 2953.1 2967.5 2967.9 887.3 906.0 910.6 930.3 943.6 10115.3 10116.9 10120.9 10126.2 10152.5 4010.6 4040.4 4083.1 4098.1 4099.0 8609.4 8611.8 8615.0 8621.4 8634.8 4539.7 4549.0 4579.6 4586.0 4586.5 4207.7 4215.3 4217.1 4222.7 4225.7 3055.4 3095.1 3430.4 3487.4 3517.4 1115.5 1135.3 1135.3 1138.2 1142.0 1243.9 1259.9 1298.1 1299.6 1299.8 6831.5 6950.5 6999.1 7015.7 7019.5 1074.4 1091.9 1099.5 1103.2 1108.0 5593.2 5601.3 5610.7 5627.2 5628.5 8214.1 8283.7 8297.9 8824.3 9086.7 8209.0 8278.3 8300.2 8305.5 8310.0 6820.2 6820.7 6941.7 6944.2 7010.8 6893.7 6970.3 6985.5 6990.8 6994.0 7846.1 8004.0 8168.3 8171.1 8186.7 7795.9 7806.4 7917.8 7925.3 8172.3 6613.1 6620.7 6633.2 6721.5 6724.0 6084.8 6231.9 6790.7 7030.4 7064.4 6552.4 6557.5 6654.7 6681.2 6719.4 6483.4 6528.9 6544.2 6650.9 6675.0 6526.6 6539.4 6546.4 6553.7 6569.4 6129.5 6181.3 6243.8 6244.8 6249.2 6313.5 6315.2 6320.1 6327.6 6343.8 01:12:24 INFO - PROCESS | 3028 | 01:12:24 INFO - PROCESS | 3028 | [#4] prototype.html Cycles:180 Average:5204.19 Median:5860.02 stddev:1574.25 (26.9%) stddev-sans-first:1535.45 01:12:24 INFO - PROCESS | 3028 | Values: 323.4 327.2 328.1 328.2 334.9 5882.1 5890.5 5893.5 5914.7 5917.0 5533.3 5649.1 5690.3 5845.0 5859.1 4508.0 4510.1 4518.3 4527.5 4531.3 4274.4 4521.0 4528.5 4529.4 4539.7 4321.9 4373.7 4443.3 4463.7 4464.7 4404.2 4409.7 4414.8 4442.3 4446.3 3924.6 3924.9 3927.9 3935.1 3936.2 5466.3 5551.6 5554.6 5555.6 5571.4 5160.9 5189.8 5190.8 5197.4 5199.8 6083.1 6102.6 6105.5 6121.4 6138.0 4324.2 4325.0 4326.4 4331.3 4333.0 6289.4 6414.8 6418.9 6424.8 6461.5 4349.8 4397.5 4397.8 4399.4 4403.3 4437.5 4443.1 4444.2 4458.0 4458.3 5168.3 5172.0 5180.8 5182.1 5182.3 6087.2 6240.7 6248.1 6250.0 6250.7 1550.2 1570.7 1584.9 1585.0 1585.2 1032.8 1048.8 1050.5 1059.4 1072.1 5859.0 5860.9 5863.4 5866.6 5871.9 6355.7 6381.0 6390.5 6390.7 6398.7 5717.2 5793.6 5815.1 5836.7 5846.5 3452.2 3482.6 3483.5 3486.3 3488.7 6660.2 6693.5 6694.6 6697.6 6699.1 6465.9 6614.7 6620.2 6634.0 6635.4 6674.3 6679.8 6687.3 6693.7 6717.5 6419.6 6464.2 6473.0 6474.3 6480.3 6304.0 6352.4 6393.0 6400.3 6403.8 6689.0 6689.5 6691.4 6695.3 6698.3 4379.9 4419.6 4424.5 4425.9 4427.5 6275.2 6445.5 6451.5 6462.0 6496.1 6327.2 6331.7 6338.6 6342.4 6343.0 6295.8 6315.1 6319.0 6373.2 6385.7 6078.9 6174.9 6175.3 6193.4 6210.7 6329.4 6332.4 6334.1 6337.9 6347.0 6156.7 6166.8 6173.3 6175.3 6184.9 01:12:24 INFO - PROCESS | 3028 | 01:12:24 INFO - PROCESS | 3028 | [#5] yui.html Cycles:180 Average:12792.45 Median:48107.14 stddev:14583.66 (30.3%) stddev-sans-first:14596.73 01:12:24 INFO - PROCESS | 3028 | Values: 793.1 794.4 796.4 807.7 811.4 12698.5 12895.3 12941.6 12945.5 12951.3 12701.1 12755.2 12763.4 12778.2 12778.6 660.0 664.6 799.7 811.1 829.1 819.1 821.8 826.1 826.7 827.1 704.8 854.8 855.4 856.1 856.1 701.2 850.0 860.6 865.5 866.3 634.1 638.8 639.0 639.4 640.0 12441.8 12684.4 12722.3 12756.9 12786.3 12473.6 12852.3 12960.2 13051.8 13107.5 10193.8 10257.1 10428.6 10943.6 11174.3 3621.6 3677.9 3678.4 3680.7 3789.3 42758.4 43357.1 43876.0 44053.3 44384.6 9645.3 9708.2 9714.6 9791.7 9871.8 17245.2 17482.7 17489.3 17567.6 17580.6 7529.2 7563.1 7563.7 7612.8 7741.7 4407.7 4413.4 4416.5 4419.2 4430.3 2825.2 2848.9 2853.5 2858.8 2859.0 522.4 537.6 538.6 566.9 568.7 425.6 599.1 614.0 638.7 641.1 7894.9 8040.6 8161.8 8349.5 8407.5 507.7 559.4 564.2 621.4 636.9 3601.9 3702.5 3708.9 3712.4 3757.7 51171.5 51633.7 51966.7 51977.2 51998.0 47208.3 47361.8 47830.3 48384.0 48463.0 43628.3 43803.1 44232.0 44490.3 45244.8 7306.9 7350.3 7497.5 7506.7 7528.1 30760.0 31336.4 31872.5 32001.4 32666.7 37329.0 37516.0 39546.2 41921.6 42160.6 10163.2 10178.6 10218.1 10295.8 10559.5 10922.2 10986.8 11081.6 11150.9 11492.2 9035.2 9531.0 9671.4 9784.1 9911.1 9951.7 10284.4 10484.1 10599.0 10615.1 9518.7 9979.7 10056.6 10270.2 10284.6 8575.6 8595.0 8669.7 8760.8 8918.5 7629.4 7985.6 8136.3 8410.6 8649.5 01:12:24 INFO - PROCESS | 3028 | -------- Summary: end -------- 01:12:24 INFO - PROCESS | 3028 | 01:12:25 INFO - TEST-INFO | 3028: exit 0 01:12:25 INFO - TEST-OK | dromaeo_css | took 1113138ms 01:12:25 INFO - TEST-START | kraken 01:12:25 INFO - operating with platform_type : linux_ 01:12:25 INFO - Initialising browser for kraken test... 01:12:25 INFO - TEST-INFO | started process 3218 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP971iE/profile http://localhost:56313/getInfo.html) 01:12:29 INFO - PROCESS | 3218 | __metrics Screen width/height:1600/1200 01:12:29 INFO - PROCESS | 3218 | colorDepth:24 01:12:29 INFO - PROCESS | 3218 | Browser inner width/height: 1024/697 01:12:29 INFO - PROCESS | 3218 | __metrics 01:12:30 INFO - PROCESS | 3218 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:12:30 INFO - PROCESS | 3218 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:12:30 INFO - TEST-INFO | 3218: exit 0 01:12:30 INFO - Browser initialized. 01:12:30 INFO - Running cycle 1/1 for kraken test... 01:12:30 INFO - TEST-INFO | started process 3304 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP971iE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:12:42 INFO - PROCESS | 3304 | RSS: Main: 150441984 01:12:42 INFO - PROCESS | 3304 | 01:12:45 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56313/tests/kraken/driver.html?testName=audio-beat-detection) 01:12:45 INFO - PROCESS | 3304 | RSS: Main: 186417152 01:12:45 INFO - PROCESS | 3304 | 01:12:48 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56313/tests/kraken/driver.html?testName=audio-dft) 01:12:49 INFO - PROCESS | 3304 | RSS: Main: 178057216 01:12:49 INFO - PROCESS | 3304 | 01:12:51 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56313/tests/kraken/driver.html?testName=audio-fft) 01:12:52 INFO - PROCESS | 3304 | RSS: Main: 160735232 01:12:52 INFO - PROCESS | 3304 | 01:12:54 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56313/tests/kraken/driver.html?testName=audio-oscillator) 01:12:55 INFO - PROCESS | 3304 | RSS: Main: 163160064 01:12:55 INFO - PROCESS | 3304 | 01:12:57 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56313/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:12:57 INFO - PROCESS | 3304 | RSS: Main: 166985728 01:12:57 INFO - PROCESS | 3304 | 01:13:00 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56313/tests/kraken/driver.html?testName=imaging-darkroom) 01:13:01 INFO - PROCESS | 3304 | RSS: Main: 166879232 01:13:01 INFO - PROCESS | 3304 | 01:13:04 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56313/tests/kraken/driver.html?testName=imaging-desaturate) 01:13:05 INFO - PROCESS | 3304 | RSS: Main: 166252544 01:13:05 INFO - PROCESS | 3304 | 01:13:08 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56313/tests/kraken/driver.html?testName=json-parse-financial) 01:13:08 INFO - PROCESS | 3304 | RSS: Main: 166670336 01:13:08 INFO - PROCESS | 3304 | 01:13:10 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56313/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:13:10 INFO - PROCESS | 3304 | RSS: Main: 176947200 01:13:10 INFO - PROCESS | 3304 | 01:13:12 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:13:13 INFO - PROCESS | 3304 | RSS: Main: 176074752 01:13:13 INFO - PROCESS | 3304 | 01:13:15 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:13:15 INFO - PROCESS | 3304 | RSS: Main: 185626624 01:13:15 INFO - PROCESS | 3304 | 01:13:18 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:13:18 INFO - PROCESS | 3304 | RSS: Main: 191156224 01:13:18 INFO - PROCESS | 3304 | 01:13:21 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:13:22 INFO - PROCESS | 3304 | RSS: Main: 191209472 01:13:22 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56313/tests/kraken/driver.html?testName=ai-astar) 01:13:23 INFO - PROCESS | 3304 | RSS: Main: 249077760 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | __start_tp_report 01:13:23 INFO - PROCESS | 3304 | _x_x_mozilla_page_load 01:13:23 INFO - PROCESS | 3304 | _x_x_mozilla_page_load_details 01:13:23 INFO - PROCESS | 3304 | |i|pagename|runs| 01:13:23 INFO - PROCESS | 3304 | |0;ai-astar;108;110;106;110;110;110;99;110;110;110 01:13:23 INFO - PROCESS | 3304 | |1;audio-beat-detection;151;131;153;166;126;149;158;126;170;131 01:13:23 INFO - PROCESS | 3304 | |2;audio-dft;161;162;161;162;161;162;161;165;163;162 01:13:23 INFO - PROCESS | 3304 | |3;audio-fft;73;72;84;91;75;72;72;100;98;72 01:13:23 INFO - PROCESS | 3304 | |4;audio-oscillator;96;97;146;95;96;95;142;95;96;138 01:13:23 INFO - PROCESS | 3304 | |5;imaging-gaussian-blur;109;110;110;110;110;110;110;110;110;110 01:13:23 INFO - PROCESS | 3304 | |6;imaging-darkroom;146;147;145;145;146;146;146;146;145;146 01:13:23 INFO - PROCESS | 3304 | |7;imaging-desaturate;95;96;96;96;95;95;96;96;96;96 01:13:23 INFO - PROCESS | 3304 | |8;json-parse-financial;59;57;58;57;58;58;58;67;55;57 01:13:23 INFO - PROCESS | 3304 | |9;json-stringify-tinderbox;66;66;66;67;66;67;67;66;66;67 01:13:23 INFO - PROCESS | 3304 | |10;stanford-crypto-aes;83;85;85;86;86;86;87;85;87;88 01:13:23 INFO - PROCESS | 3304 | |11;stanford-crypto-ccm;119;116;127;119;125;118;127;117;129;126 01:13:23 INFO - PROCESS | 3304 | |12;stanford-crypto-pbkdf2;154;147;153;152;143;143;153;155;153;139 01:13:23 INFO - PROCESS | 3304 | |13;stanford-crypto-sha256-iterative;70;67;69;68;69;67;70;70;69;66 01:13:23 INFO - PROCESS | 3304 | __end_tp_report 01:13:23 INFO - PROCESS | 3304 | __start_cc_report 01:13:23 INFO - PROCESS | 3304 | _x_x_mozilla_cycle_collect,955 01:13:23 INFO - PROCESS | 3304 | __end_cc_report 01:13:23 INFO - PROCESS | 3304 | __startTimestamp1452244403945__endTimestamp 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | ------- Summary: start ------- 01:13:23 INFO - PROCESS | 3304 | Number of tests: 14 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.53 (3.2%) stddev-sans-first:3.74 01:13:23 INFO - PROCESS | 3304 | Values: 108.0 110.0 106.0 110.0 110.0 110.0 99.0 110.0 110.0 110.0 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:152.00 stddev:16.51 (10.9%) stddev-sans-first:17.41 01:13:23 INFO - PROCESS | 3304 | Values: 151.0 131.0 153.0 166.0 126.0 149.0 158.0 126.0 170.0 131.0 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 01:13:23 INFO - PROCESS | 3304 | Values: 161.0 162.0 161.0 162.0 161.0 162.0 161.0 165.0 163.0 162.0 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#3] audio-fft Cycles:10 Average:80.90 Median:74.00 stddev:11.46 (15.5%) stddev-sans-first:11.80 01:13:23 INFO - PROCESS | 3304 | Values: 73.0 72.0 84.0 91.0 75.0 72.0 72.0 100.0 98.0 72.0 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:95.50 stddev:22.45 (23.5%) stddev-sans-first:23.26 01:13:23 INFO - PROCESS | 3304 | Values: 96.0 97.0 146.0 95.0 96.0 95.0 142.0 95.0 96.0 138.0 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 01:13:23 INFO - PROCESS | 3304 | Values: 109.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 01:13:23 INFO - PROCESS | 3304 | Values: 146.0 147.0 145.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 01:13:23 INFO - PROCESS | 3304 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.00 stddev:3.20 (5.5%) stddev-sans-first:3.39 01:13:23 INFO - PROCESS | 3304 | Values: 59.0 57.0 58.0 57.0 58.0 58.0 58.0 67.0 55.0 57.0 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 01:13:23 INFO - PROCESS | 3304 | Values: 66.0 66.0 66.0 67.0 66.0 67.0 67.0 66.0 66.0 67.0 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:1.40 (1.6%) stddev-sans-first:1.05 01:13:23 INFO - PROCESS | 3304 | Values: 83.0 85.0 85.0 86.0 86.0 86.0 87.0 85.0 87.0 88.0 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:125.50 stddev:4.92 (3.9%) stddev-sans-first:5.07 01:13:23 INFO - PROCESS | 3304 | Values: 119.0 116.0 127.0 119.0 125.0 118.0 127.0 117.0 129.0 126.0 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:153.00 stddev:5.71 (3.7%) stddev-sans-first:5.79 01:13:23 INFO - PROCESS | 3304 | Values: 154.0 147.0 153.0 152.0 143.0 143.0 153.0 155.0 153.0 139.0 01:13:23 INFO - PROCESS | 3304 | 01:13:23 INFO - PROCESS | 3304 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.43 (2.1%) stddev-sans-first:1.41 01:13:23 INFO - PROCESS | 3304 | Values: 70.0 67.0 69.0 68.0 69.0 67.0 70.0 70.0 69.0 66.0 01:13:23 INFO - PROCESS | 3304 | -------- Summary: end -------- 01:13:23 INFO - PROCESS | 3304 | 01:13:24 INFO - TEST-INFO | 3304: exit 0 01:13:24 INFO - TEST-OK | kraken | took 59327ms 01:13:24 INFO - TEST-START | v8_7 01:13:24 INFO - operating with platform_type : linux_ 01:13:24 INFO - Initialising browser for v8_7 test... 01:13:24 INFO - TEST-INFO | started process 3553 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTH0by4/profile http://localhost:56313/getInfo.html) 01:13:28 INFO - PROCESS | 3553 | __metrics Screen width/height:1600/1200 01:13:28 INFO - PROCESS | 3553 | colorDepth:24 01:13:28 INFO - PROCESS | 3553 | Browser inner width/height: 1024/697 01:13:28 INFO - PROCESS | 3553 | __metrics 01:13:28 INFO - PROCESS | 3553 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:13:29 INFO - PROCESS | 3553 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:13:30 INFO - TEST-INFO | 3553: exit 0 01:13:30 INFO - Browser initialized. 01:13:30 INFO - Running cycle 1/1 for v8_7 test... 01:13:30 INFO - TEST-INFO | started process 3637 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTH0by4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:13:41 INFO - PROCESS | 3637 | RSS: Main: 149811200 01:13:41 INFO - PROCESS | 3637 | 01:14:04 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:56313/tests/v8_7/run.html (next: http://localhost:56313/tests/v8_7/run.html) 01:14:04 INFO - PROCESS | 3637 | RSS: Main: 539353088 01:14:04 INFO - PROCESS | 3637 | 01:14:04 INFO - PROCESS | 3637 | __start_tp_report 01:14:04 INFO - PROCESS | 3637 | _x_x_mozilla_page_load 01:14:04 INFO - PROCESS | 3637 | _x_x_mozilla_page_load_details 01:14:04 INFO - PROCESS | 3637 | |i|pagename|runs| 01:14:04 INFO - PROCESS | 3637 | |0;Richards;166.80567139282735 01:14:04 INFO - PROCESS | 3637 | |1;DeltaBlue;190.7304978065993 01:14:04 INFO - PROCESS | 3637 | |2;Encrypt;283.2058906825262 01:14:04 INFO - PROCESS | 3637 | |3;Decrypt;5202.072538860104 01:14:04 INFO - PROCESS | 3637 | |4;RayTrace;1112.3470522803113 01:14:04 INFO - PROCESS | 3637 | |5;Earley;784.9293563579278 01:14:04 INFO - PROCESS | 3637 | |6;Boyer;12537.5 01:14:04 INFO - PROCESS | 3637 | |7;RegExp;42354.166666666664 01:14:04 INFO - PROCESS | 3637 | |8;Splay;555.5555555555555 01:14:04 INFO - PROCESS | 3637 | |9;NavierStokes;4831.7307692307695 01:14:04 INFO - PROCESS | 3637 | __end_tp_report 01:14:04 INFO - PROCESS | 3637 | __startTimestamp1452244444593__endTimestamp 01:14:04 INFO - PROCESS | 3637 | 01:14:04 INFO - PROCESS | 3637 | ------- Summary: start ------- 01:14:04 INFO - PROCESS | 3637 | Number of tests: 10 01:14:04 INFO - PROCESS | 3637 | 01:14:04 INFO - PROCESS | 3637 | [#0] Richards Cycles:1 Average:166.81 Median:166.81 stddev:0.00 (0.0%) 01:14:04 INFO - PROCESS | 3637 | Values: 166.8 01:14:04 INFO - PROCESS | 3637 | 01:14:04 INFO - PROCESS | 3637 | [#1] DeltaBlue Cycles:1 Average:190.73 Median:190.73 stddev:0.00 (0.0%) 01:14:04 INFO - PROCESS | 3637 | Values: 190.7 01:14:04 INFO - PROCESS | 3637 | 01:14:04 INFO - PROCESS | 3637 | [#2] Encrypt Cycles:1 Average:283.21 Median:283.21 stddev:0.00 (0.0%) 01:14:04 INFO - PROCESS | 3637 | Values: 283.2 01:14:04 INFO - PROCESS | 3637 | 01:14:04 INFO - PROCESS | 3637 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 01:14:04 INFO - PROCESS | 3637 | Values: 5202.1 01:14:04 INFO - PROCESS | 3637 | 01:14:04 INFO - PROCESS | 3637 | [#4] RayTrace Cycles:1 Average:1112.35 Median:1112.35 stddev:0.00 (0.0%) 01:14:04 INFO - PROCESS | 3637 | Values: 1112.3 01:14:04 INFO - PROCESS | 3637 | 01:14:04 INFO - PROCESS | 3637 | [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 01:14:04 INFO - PROCESS | 3637 | Values: 784.9 01:14:04 INFO - PROCESS | 3637 | 01:14:04 INFO - PROCESS | 3637 | [#6] Boyer Cycles:1 Average:12537.50 Median:12537.50 stddev:0.00 (0.0%) 01:14:04 INFO - PROCESS | 3637 | Values: 12537.5 01:14:04 INFO - PROCESS | 3637 | 01:14:04 INFO - PROCESS | 3637 | [#7] RegExp Cycles:1 Average:42354.17 Median:42354.17 stddev:0.00 (0.0%) 01:14:04 INFO - PROCESS | 3637 | Values: 42354.2 01:14:04 INFO - PROCESS | 3637 | 01:14:04 INFO - PROCESS | 3637 | [#8] Splay Cycles:1 Average:555.56 Median:555.56 stddev:0.00 (0.0%) 01:14:04 INFO - PROCESS | 3637 | Values: 555.6 01:14:04 INFO - PROCESS | 3637 | 01:14:04 INFO - PROCESS | 3637 | [#9] NavierStokes Cycles:1 Average:4831.73 Median:4831.73 stddev:0.00 (0.0%) 01:14:04 INFO - PROCESS | 3637 | Values: 4831.7 01:14:04 INFO - PROCESS | 3637 | -------- Summary: end -------- 01:14:04 INFO - PROCESS | 3637 | 01:14:05 INFO - TEST-INFO | 3637: exit 0 01:14:05 INFO - TEST-OK | v8_7 | took 40658ms 01:14:05 INFO - SUITE-END | took 1213s 01:14:05 INFO - Completed test suite (00:20:13) 01:14:05 INFO - Working with test: dromaeo_css 01:14:05 INFO - Generating results file: dromaeo_css 01:14:05 INFO - Working with test: kraken 01:14:05 INFO - Generating results file: kraken 01:14:05 INFO - javascript benchmark 01:14:05 INFO - Working with test: v8_7 01:14:05 INFO - Generating results file: v8_7 01:14:05 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:14:05 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 01:14:05 INFO - process_Request line: dromaeo_css 6559.86 graph.html#tests=[[72,1,35]] 01:14:05 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:14:05 INFO - process_Request line: kraken 1508.90 graph.html#tests=[[232,1,35]] 01:14:05 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:14:05 INFO - process_Request line: v8_7 20115.80 graph.html#tests=[[230,1,35]] 01:14:05 INFO - RETURN: dromaeo_css: 6559.86 01:14:05 INFO - RETURN: kraken: 1508.90 01:14:05 INFO - RETURN: v8_7: 20115.80 01:14:05 INFO - javascript benchmark 01:14:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2983.4331477019364, 3064.7241748242654, 3095.2416657918807, 3097.7521798256143, 3101.9763478052246, 4871.342368780213, 4961.702297862131, 5073.036123136601, 5078.568321692661, 5120.487951204877, 4892.486288939664, 5000.324956130921, 5006.148954677705, 5011.373578302712, 5018.096742586342, 4351.347297905324, 4511.774411279439, 4622.699524530912, 4647.883802904929, 4739.644526660497, 4547.15877562652, 4636.304554316863, 4664.813407463697, 4700.341952126705, 4791.041791641668, 4627.444706635191, 4686.390769200017, 4691.179043667345, 4695.5539223773685, 4718.221493453576, 4599.540045995407, 4607.815687372501, 4623.653226008063, 4631.907361852744, 4650.837220697294, 4524.8190072397065, 4571.977140114312, 4575.816967321303, 4604.930926036112, 4613.6078433333205, 4928.162212423897, 4947.752612369403, 4953.702777833306, 4962.87592810179, 4967.180415231519, 5429.972850135763, 5434.918476222821, 5440.700761458118, 5454.10007348787, 5466.098093814516, 5321.068812957717, 5383.650062745909, 5412.269343638598, 5413.593980451443, 5444.727763611803, 4957.3059771632, 4959.231319145538, 4966.056449274663, 4973.5772459341, 5012.27322038306, 5401.7299135043095, 5408.810691625774, 5422.154913018413, 5450.91823622646, 5456.127019676833, 5203.32356793622, 5237.214417837355, 5300.44345343741, 5302.151655735064, 5309.814156504581, 5388.299521062237, 5401.459854014567, 5435.130379139318, 5444.237806707064, 5448.427915068861, 5369.301990741179, 5376.354837419534, 5377.354717433933, 5383.16560933056, 5383.703896285663, 5268.051750684914, 5326.334208223972, 5366.356037275552, 5387.326584176978, 5418.647787893853, 4176.2900306947895, 4185.351270553069, 4189.2668782962855, 4190.685698572558, 4192.664586833046, 3782.0922978485514, 3793.412021136728, 3813.7902415366866, 3818.84724611018, 3819.52255968004, 5026.170681837456, 5088.262201980692, 5102.897942041139, 5131.692098474104, 5139.074966506065, 5397.946020539823, 5422.674639521641, 5423.566114710814, 5430.728463576806, 5477.67133971955, 4866.9513304867205, 4960.181570040975, 5018.498150185025, 5025.271335656309, 5028.5977121830165, 4581.679282450264, 4622.0, 4672.275797251364, 4672.766361681903, 4702.811887524529, 5600.887982240332, 5600.971995139998, 5602.467765562265, 5608.46719561641, 5665.065264231438, 5077.162268225701, 5146.279520867007, 5430.592705547021, 5430.592705547178, 5448.155535891864, 5459.508644222039, 5606.943930560806, 5676.744546495335, 5702.885942281048, 5718.8570285741525, 5297.947020529899, 5320.068987927175, 5328.547073498796, 5332.920006199833, 5338.225957236256, 5386.434424385383, 5405.675659460445, 5412.269343638558, 5415.187721841755, 5463.508284254436, 5218.295530103539, 5312.1766126250495, 5318.867028324323, 5332.5467335276935, 5411.134218525017, 5314.1497360422145, 5325.307709997675, 5332.70670113132, 5335.199720042025, 5336.0661884170895, 5199.74001299941, 5227.059129356752, 5252.343457067866, 5254.500822421864, 5303.814366497154, 5125.615578831528, 5234.162533994542, 5282.920756188737, 5343.305370301836, 5379.865503362447, 5162.922556161736, 5169.715665638426, 5170.612204084784, 5172.508611681884, 5211.55701765339], "unit": "score", "name": "dojo.html", "value": 4985.11748066339}, {"lowerIsBetter": false, "replicates": [534.6230907210416, 537.1164434505239, 540.0414264680195, 557.1114073053479, 562.9577781666371, 27427.588586171223, 28085.43829123419, 28102.578461323097, 28140.296492587695, 28150.577741333895, 28587.0, 29018.709812901863, 29046.564301535494, 38527.42208866862, 38949.41575876357, 8597.4411663242, 8768.736937891841, 8769.210771030606, 8773.64905403783, 8779.868301975444, 7562.319391254786, 8516.914830851674, 8667.263282620954, 8677.088905664908, 8682.609282582267, 7552.546847189186, 10227.795444091114, 10420.791584168312, 10423.73940651486, 10442.530086146104, 9802.0, 9954.452505112216, 9957.601695932226, 9958.999999999964, 9974.301798874081, 7544.207858174922, 7741.8838717419285, 9793.608255669764, 9936.552855121538, 10099.39403635777, 36255.0, 36477.270454591024, 36959.0, 36984.63015369839, 37036.62963370386, 2905.1586141273256, 3047.040182342555, 3233.110894504007, 3332.683395077464, 3647.9420967919536, 27491.17526474209, 28118.0, 28164.436711265866, 28320.0, 28356.858215708788, 3678.429843374281, 3688.0964163780045, 3735.831887565066, 3770.6606405423368, 3826.081740382316, 260893.0, 261423.0, 262384.0, 263026.9999999981, 263092.0, 57075.714621426625, 57262.71368643214, 57264.42735572591, 57369.0, 57700.422995769506, 59900.40099598948, 60226.0, 60278.0, 60286.39713602808, 60304.698476507336, 14343.139411635335, 14569.344379502947, 14570.85429145695, 14579.927100364643, 14590.051646642934, 11148.665540033811, 11219.439028048564, 11241.494132764044, 11251.437428128724, 11256.0, 17377.127169291685, 19109.522261943563, 19144.234230630896, 19206.903965480084, 19375.4187374379, 7263.0921134858145, 7521.623918804038, 7628.160902300742, 7670.7698769037015, 7747.535147891144, 917.3395155488038, 937.9343445958854, 1012.6658202793061, 1044.4151275285865, 1120.6301920366259, 26901.284813662227, 27319.72680273172, 27788.166355009384, 27847.86076069607, 28081.43837123246, 904.1448214462282, 964.8195079121097, 1021.1371391174446, 1021.2646894236138, 1062.1768129699544, 13213.0, 13645.727085458235, 13895.096818706752, 13995.86004139966, 14015.719685606231, 418725.0, 430093.0, 430147.0, 430784.0, 430962.0, 43289.13421731611, 43572.346414803804, 46227.537724623, 48703.75648121808, 48813.75593122012, 1305.8432988041495, 1335.692790658154, 1336.8395792504962, 1340.4035204333977, 1348.3393137362818, 24137.758622413552, 24517.632235516838, 24633.384165396008, 25113.121040763486, 25201.0, 39592.40611390774, 39798.801005994785, 39899.60100398959, 39924.0, 39961.80019099886, 197686.0, 198092.0, 199023.0, 199626.0, 199893.0, 29556.408871822874, 29900.0, 29949.700502994692, 29968.250793729458, 29975.0, 39266.60733392744, 39692.801535992134, 40224.0, 40513.59486405216, 41090.1781964365, 34825.0, 34877.82561087178, 34976.30047398987, 35235.29529409449, 35322.1169470755, 33852.153696157795, 34929.30141397208, 34952.12619684528, 34983.65016349804, 35334.29331413409, 31432.842835785676, 31520.0, 31799.046028619177, 34212.0, 34703.826480867436, 27261.86369068142, 28884.0, 30831.2292192697, 31121.221969450944, 31399.68600314059, 23976.88011559931, 23983.880080599487, 24104.87947560251, 24113.51772964496, 24124.51750965006], "unit": "score", "name": "ext.html", "value": 17514.135116082765}, {"lowerIsBetter": false, "replicates": [334.7606461380113, 340.4008944258106, 343.3339321715869, 349.84257084312065, 354.277274360305, 13571.117877337967, 14086.78869816951, 15641.217939103042, 15659.0, 16716.91641541792, 15549.689006219869, 15559.611009724762, 15946.202689865519, 15947.122908240042, 15986.280617372217, 4820.999999999991, 5454.4545545445335, 5456.672599644015, 5456.781728730846, 5463.644863083907, 3954.2882281189372, 4092.4679791627045, 5330.1205301125465, 5575.442455754433, 5739.0, 5644.989576576249, 5696.08862581987, 5766.509846663039, 5770.04794208955, 5856.443637854397, 5817.912731309013, 5838.532917366621, 5840.8247752567495, 5847.678377689225, 5847.941520584783, 4792.832250871237, 4981.427135879348, 4985.825496107655, 4989.625778066623, 5135.255387968761, 12326.445309961073, 12846.0, 18262.0, 18708.532286692807, 18798.0, 1904.2858927902037, 1997.2310660395708, 2071.0369678099755, 2239.317008312464, 2368.8223383246327, 9111.134442227978, 9419.105185007413, 9477.336586438953, 9610.183134433582, 9610.423374597547, 1793.4888556761261, 1805.2959345855127, 1836.6143109946927, 1837.3201915291295, 1864.2263460663808, 54007.189892151255, 54267.72866135644, 54324.0, 55495.44504554903, 55596.44403555953, 10045.949770251102, 10097.798044039078, 10103.393796372242, 10107.494625268708, 10186.643467478603, 13001.284929328978, 13005.479780808662, 13051.673708157183, 13119.540816071392, 13132.409041593151, 7414.592197429085, 7420.5176663516695, 7420.888686669704, 7463.328300452985, 7473.775786726298, 7037.366637002592, 7040.119985001875, 7087.0, 7140.57156570597, 7158.427325813923, 4082.8775136745944, 4358.150160718693, 4430.446194225722, 4434.977825110854, 4457.487388950248, 1726.464795913271, 1739.2868923741205, 1836.540864783804, 1853.9165737541844, 1866.3561071430336, 830.8546004449197, 862.7325529086004, 905.8143080668447, 954.7040417470606, 1031.7626945802508, 13125.934370328087, 14486.637834054021, 15710.607234819221, 15816.446424375092, 15965.521034368987, 897.3090720145582, 899.1278459893892, 915.3455279475207, 920.545992655425, 928.9163975242261, 9312.161905428544, 9331.34680572367, 9365.62537498506, 9416.387934784218, 9560.76098097553, 467123.9794209269, 501332.0, 501993.0, 503181.0, 530510.0, 64650.0, 68471.0, 73026.63486682638, 75159.24840751632, 79427.60286198648, 490.03707714342204, 491.2017970797454, 503.7884088682762, 504.36953807740326, 504.8334049763569, 10003.936595891002, 10111.494425278559, 10169.0, 10327.380357178594, 10370.948145259226, 21309.46726331792, 31315.747370104942, 32212.677873220968, 32467.35065298728, 32749.34501309913, 40272.590459333784, 40468.39297410482, 42290.0, 42884.57115428806, 43932.560674394124, 6705.497087718343, 7032.437405007689, 7138.179109402485, 7175.706547221172, 7467.738629148171, 9646.276529260474, 10397.636082737068, 10853.674389768319, 11076.889231107585, 11100.444977751242, 9333.25333973294, 9420.905790942003, 9570.425774453555, 9706.854397183906, 9935.354201976848, 7631.351335136354, 9209.907900920905, 9616.75958101053, 9860.26048046385, 10132.949335253277, 9251.213646840093, 9341.082001220722, 9682.080202380763, 10037.949810250902, 10089.949550252202, 6984.0, 7026.473014524034, 7082.929170708227, 7183.784486465205, 7254.093238345207, 7036.0, 7966.800829979297, 7978.361731061617, 7987.520748755093, 8039.557824319719], "unit": "score", "name": "jquery.html", "value": 7646.20851227396}, {"lowerIsBetter": false, "replicates": [1284.261549608975, 1453.6438572549728, 1473.2633683158422, 1603.7754714339994, 1760.2255007796568, 6276.811695649127, 7081.61051142187, 7133.500654954155, 7193.8201544961275, 7249.057622509066, 7152.0, 7307.963460182692, 7316.158641756187, 7352.0442342495535, 7360.631968401585, 1894.943151705451, 1939.3018513335187, 2187.0814258011674, 2193.254293540196, 2219.4562332228625, 2212.7676593957644, 2214.3689048621145, 2219.034719896842, 2219.7891200335944, 2228.1198926424054, 2158.6330323844986, 2229.554089182162, 2229.7993180613744, 2231.1856172497082, 2232.854864433815, 2170.9565808683897, 2183.257692384589, 2188.4419473034354, 2211.966820497678, 2233.0, 2181.9127234910743, 2191.594555007329, 2194.264921251383, 2207.0, 2212.5243072739277, 7253.963730181368, 7268.927310726878, 7270.818229544251, 7303.0, 7324.30419110189, 4422.314541246112, 4563.520830312836, 4572.679912406133, 4575.428071491064, 4576.153411618861, 2843.5876797864403, 2943.0876428307292, 2953.1288269960414, 2967.540031295153, 2967.896123635684, 887.2502735188755, 906.0, 910.5629297936961, 930.2976252929063, 943.5989704375681, 10115.342502737298, 10116.89883101167, 10120.949395252977, 10126.189904807597, 10152.543135558844, 4010.578889216649, 4040.4343391925154, 4083.1221287423346, 4098.098418347959, 4098.979505102456, 8609.397342185986, 8611.827763444697, 8614.956925215334, 8621.439606425562, 8634.784130396665, 4539.7049191802425, 4548.95451045492, 4579.610733087658, 4586.014006988514, 4586.518415566385, 4207.684423668237, 4215.346621273708, 4217.072244106292, 4222.683298752606, 4225.68307376948, 3055.434744572261, 3095.1488340706037, 3430.433978393537, 3487.372272990886, 3517.419625761772, 1115.5203262597, 1135.2507345152326, 1135.2904434728296, 1138.2089447833841, 1141.960031398897, 1243.9004879609608, 1259.9181053231512, 1298.1302527306727, 1299.5841330774251, 1299.8245236893088, 6831.521793474509, 6950.513464057467, 6999.0551275577145, 7015.684294206773, 7019.508634395544, 1074.382230217628, 1091.8744344400336, 1099.455769394155, 1103.150574057971, 1107.9667609971714, 5593.244911936918, 5601.29983752031, 5610.663360198401, 5627.155926611041, 5628.521575666033, 8214.13751556078, 8283.668653253802, 8297.917020829835, 8824.3381746368, 9086.681966131153, 8209.0, 8278.254957053894, 8300.2114799094, 8305.46014509055, 8310.044344900292, 6820.181578210647, 6820.658967051628, 6941.68762405693, 6944.236134025253, 7010.754623588252, 6893.655317234218, 6970.302969703192, 6985.511014228955, 6990.790276291719, 6993.965030174817, 7846.0976987647155, 8004.0, 8168.305694015838, 8171.101178870438, 8186.713465028695, 7795.883061753965, 7806.41451891099, 7917.7624671259955, 7925.326347260317, 8172.264496195371, 6613.074169616161, 6620.735170593122, 6633.237177724431, 6721.462283017249, 6724.025016372696, 6084.847878802888, 6231.875362492816, 6790.66046697673, 7030.402415794715, 7064.399526040344, 6552.443042341454, 6557.475401967736, 6654.733810647714, 6681.198256209286, 6719.361660642231, 6483.351664833479, 6528.934710652833, 6544.247411547733, 6650.90023649636, 6675.0, 6526.608403495616, 6539.411452969255, 6546.410823025951, 6553.672316384257, 6569.441597464078, 6129.540284478593, 6181.289151747606, 6243.750249989949, 6244.750209991549, 6249.187605611241, 6313.463355614824, 6315.242170939517, 6320.08358787964, 6327.557071004985, 6343.841403964938], "unit": "score", "name": "mootools.html", "value": 4275.495869649937}, {"lowerIsBetter": false, "replicates": [323.41784787382704, 327.23100713323686, 328.1451818014073, 328.24012411267927, 334.8894864694651, 5882.147088672145, 5890.469857712805, 5893.469587737103, 5914.733836977335, 5916.970415147929, 5533.253010843535, 5649.12438572022, 5690.345610254822, 5844.970775146129, 5859.121131830228, 4508.0, 4510.14307281617, 4518.344839998198, 4527.479339875924, 4531.297648864423, 4274.401583778274, 4520.954790452102, 4528.524504926984, 4529.365888775557, 4539.682222244444, 4321.941124424505, 4373.693841431101, 4443.333499974998, 4463.665225108113, 4464.73211607303, 4404.207242696313, 4409.735415875058, 4414.779261036935, 4442.2892337225885, 4446.333050042504, 3924.646781789653, 3924.8822535323984, 3927.8821635350987, 3935.05558665921, 3936.193080418536, 5466.34403871534, 5551.583631227633, 5554.611177217596, 5555.638883472602, 5571.359293681238, 5160.948390516084, 5189.792408303663, 5190.844274671766, 5197.350331208599, 5199.844004679866, 6083.087536869505, 6102.633841969496, 6105.450509454126, 6121.3572574879445, 6138.048602466625, 4324.17840610283, 4324.978375108104, 4326.351047342924, 4331.285337919239, 4333.025069359401, 6289.37106289372, 6414.775482858125, 6418.876696578127, 6424.775132870373, 6461.483081353434, 4349.760763158057, 4397.494288156903, 4397.8240870364825, 4399.36209249657, 4403.339499075164, 4437.489688685842, 4443.089166720814, 4444.2444784386735, 4457.977710111429, 4458.261278101543, 5168.2764412982215, 5172.043172013189, 5180.766865490987, 5182.067227898939, 5182.274481572583, 6087.239095113111, 6240.65676387794, 6248.125262463259, 6249.968750156311, 6250.74997000124, 1550.178405445116, 1570.7329753941628, 1584.8573628373501, 1585.0014490870908, 1585.2153184173678, 1032.8277405145213, 1048.7535429174138, 1050.4747626186906, 1059.3855563772993, 1072.0512346573182, 5858.970705146532, 5860.912086318709, 5863.355030946593, 5866.5893387462465, 5871.941280587225, 6355.713992870332, 6381.0, 6390.488760899117, 6390.712417941204, 6398.744050238031, 5717.2281741965135, 5793.594448388572, 5815.098659707752, 5836.737346819404, 5846.532277417797, 3452.171478845059, 3482.5820901491984, 3483.512308276843, 3486.3027394521196, 3488.720902327808, 6660.23407308156, 6693.464522838259, 6694.59832410057, 6697.631630260383, 6699.062131301622, 6465.935340646627, 6614.735410583619, 6620.172478440195, 6634.0, 6635.402813746786, 6674.299198584175, 6679.833004174838, 6687.331266873371, 6693.665316734144, 6717.5297729159465, 6419.550631455753, 6464.191976003, 6473.0, 6474.320196379501, 6480.254770701241, 6304.0, 6352.396522330371, 6393.041043843461, 6400.295967443484, 6403.775867844603, 6689.0, 6689.531732778853, 6691.43122834545, 6695.263521012782, 6698.296678848846, 4379.868603941887, 4419.580139886705, 4424.535423780457, 4425.933610995773, 4427.490838553607, 6275.215598050244, 6445.452136568444, 6451.48388128958, 6462.0, 6496.0580715795, 6327.209098862642, 6331.746730130743, 6338.58799178052, 6342.365763423621, 6343.0, 6295.811125666238, 6315.147455093504, 6318.988961766096, 6373.171487706569, 6385.712642931172, 6078.878422431615, 6174.907376389448, 6175.320714721287, 6193.411625895533, 6210.658413787285, 6329.367063293634, 6332.398422149889, 6334.113224148531, 6337.8732425352155, 6347.0, 6156.722947467464, 6166.845828854314, 6173.259208894781, 6175.2589689237575, 6184.907226391698], "unit": "score", "name": "prototype.html", "value": 4692.018124670387}, {"lowerIsBetter": false, "replicates": [793.1434051224676, 794.4359504751626, 796.390761067783, 807.6890397197077, 811.37524106438, 12698.492060317587, 12895.290759008263, 12941.611751647442, 12945.482180712785, 12951.287679177653, 12701.110922235448, 12755.17091389059, 12763.361831908414, 12778.233306001646, 12778.616641500746, 660.0462331930363, 664.5979182594533, 799.6841247707152, 811.0875265326507, 829.1335554345724, 819.0826274572487, 821.8027673358381, 826.1036775098995, 826.7478419082178, 827.1397746343795, 704.7709494414311, 854.8290341931638, 855.3969451536652, 856.0839901305606, 856.1310270075846, 701.2496628607392, 849.9702510412137, 860.6127242740729, 865.476386785998, 866.3459088388289, 634.0520921222756, 638.7668500997149, 638.987220255597, 639.4117411980942, 639.9680015999181, 12441.75116497674, 12684.365781710878, 12722.300273484954, 12756.936215318863, 12786.296753678544, 12473.625791226277, 12852.293123878277, 12960.222386656831, 13051.804222936664, 13107.47570097195, 10193.847092293621, 10257.076863082359, 10428.582856685724, 10943.56225750969, 11174.329540227613, 3621.5908246426766, 3677.889663310105, 3678.393065144248, 3680.723945704083, 3789.2800367930004, 42758.358624620654, 43357.09786119265, 43876.0, 44053.33919991203, 44384.55615443869, 9645.324827262024, 9708.223342132613, 9714.61141554344, 9791.657291994747, 9871.753206169904, 17245.22396492161, 17482.737758933625, 17489.300427982736, 17567.560810979572, 17580.648387032186, 7529.171791102975, 7563.092428908566, 7563.697452101965, 7612.7716168515035, 7741.651625676858, 4407.735535867858, 4413.426254586883, 4416.492103408085, 4419.160359531678, 4430.269005614102, 2825.2089414963843, 2848.886044558236, 2853.52916768735, 2858.7855910806775, 2859.0, 522.4044589168351, 537.6317222702461, 538.5825984861685, 566.9348024977098, 568.6758547627895, 425.59781006948754, 599.1043390131781, 613.9715975740617, 638.6998110887876, 641.1184621145925, 7894.921050789419, 8040.597970101471, 8161.836763264821, 8349.499030058216, 8407.537585432738, 507.69538277033485, 559.443353862909, 564.2157401212318, 621.3537920562565, 636.9076483909807, 3601.9099522511624, 3702.4816525686424, 3708.8516459341863, 3712.424574191005, 3757.680597149218, 51171.48828511742, 51633.7418312906, 51966.74016629893, 51977.220341694905, 51998.0, 47208.29187562189, 47361.763191183825, 47830.28254576184, 48384.0, 48463.0, 43628.345574816405, 43803.12393752107, 44232.0, 44490.33264501035, 45244.773776131566, 7306.890396643948, 7350.301721336678, 7497.475176737576, 7506.662200200894, 7528.134264559427, 30760.0, 31336.373272533965, 31872.521912170872, 32001.359972800878, 32666.673333266364, 37329.0, 37516.0, 39546.2090758189, 41921.58078419177, 42160.57839421566, 10163.186945044527, 10178.592856285963, 10218.080372766486, 10295.794084118126, 10559.472026398496, 10922.180836437457, 10986.811643988927, 11081.5567377304, 11150.944245279046, 11492.195546311677, 9035.186833185046, 9530.95234523823, 9671.419714816851, 9784.119429251401, 9911.058449447291, 9951.651692190739, 10284.434356110485, 10484.056434920894, 10599.046085852311, 10615.09771669386, 9518.714438566854, 9979.700608981742, 10056.597736090767, 10270.178385729274, 10284.640037598649, 8575.571221438779, 8595.0, 8669.739907802523, 8760.824783504167, 8918.509481978554, 7629.351505122127, 7985.560794156378, 8136.349092072502, 8410.579471026547, 8649.481031138152], "unit": "score", "name": "yui.html", "value": 5949.39559078654}], "name": "dromaeo_css", "value": 6559.861095091725}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 106.0, 110.0, 110.0, 110.0, 99.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [151.0, 131.0, 153.0, 166.0, 126.0, 149.0, 158.0, 126.0, 170.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 165.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 84.0, 91.0, 75.0, 72.0, 72.0, 100.0, 98.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 146.0, 95.0, 96.0, 95.0, 142.0, 95.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 58.0, 57.0, 58.0, 58.0, 58.0, 67.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 86.0, 86.0, 86.0, 87.0, 85.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 127.0, 119.0, 125.0, 118.0, 127.0, 117.0, 129.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [154.0, 147.0, 153.0, 152.0, 143.0, 143.0, 153.0, 155.0, 153.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 69.0, 68.0, 69.0, 67.0, 70.0, 70.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1508.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.80567139282735], "unit": "score", "name": "Richards", "value": 211.6354900000001}, {"lowerIsBetter": false, "replicates": [190.7304978065993], "unit": "score", "name": "DeltaBlue", "value": 346.65667399999995}, {"lowerIsBetter": false, "replicates": [283.2058906825262], "unit": "score", "name": "Encrypt", "value": 939.8851109999996}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1112.3470522803113], "unit": "score", "name": "RayTrace", "value": 665.2501110000002}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Earley", "value": 849.0738620000004}, {"lowerIsBetter": false, "replicates": [12537.5], "unit": "score", "name": "Boyer", "value": 53.15756729810566}, {"lowerIsBetter": false, "replicates": [42354.166666666664], "unit": "score", "name": "RegExp", "value": 21.508745696015737}, {"lowerIsBetter": false, "replicates": [555.5555555555555], "unit": "score", "name": "Splay", "value": 146.68380000000002}, {"lowerIsBetter": false, "replicates": [4831.7307692307695], "unit": "score", "name": "NavierStokes", "value": 307.13631840796046}], "name": "v8_7", "value": 20115.800441428113}]} 01:14:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20115.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1508.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6559.86"}}} 01:14:05 INFO - Return code: 0 01:14:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:14:05 INFO - # TBPL SUCCESS # 01:14:05 INFO - Running post-action listener: _resource_record_post_action 01:14:05 INFO - Running post-run listener: _resource_record_post_run 01:14:06 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 419074048; Read time: 0; Write time: 491068 01:14:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 32858112; Read time: 0; Write time: 35552 01:14:06 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 323108864; Read time: 0; Write time: 334260 01:14:06 INFO - Running post-run listener: _upload_blobber_files 01:14:06 INFO - Blob upload gear active. 01:14:06 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 01:14:06 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:14:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 01:14:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 01:14:07 INFO - (blobuploader) - INFO - Open directory for files ... 01:14:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 01:14:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:14:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:14:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:14:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:14:08 INFO - (blobuploader) - INFO - Done attempting. 01:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:14:09 INFO - (blobuploader) - INFO - Done attempting. 01:14:09 INFO - (blobuploader) - INFO - Iteration through files over. 01:14:09 INFO - Return code: 0 01:14:09 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 01:14:09 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 01:14:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97133bd7962ba73c1559c36241bba30b3878fdd0f7bf8a358dea2a15dd98fa3555639805f7517a689a665b8796a5504f064b3b7aacb5cc2ceef26643ec0308dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e9a2e4c1e4cc55f549818ebae3155215215577efa43d6c5834d4d78b96c86fea48e209a4b249fbcf33c1397f8fc014720d07b4e9126fb153c02ee95bf4528ec"} 01:14:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 01:14:09 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 01:14:09 INFO - Contents: 01:14:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97133bd7962ba73c1559c36241bba30b3878fdd0f7bf8a358dea2a15dd98fa3555639805f7517a689a665b8796a5504f064b3b7aacb5cc2ceef26643ec0308dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e9a2e4c1e4cc55f549818ebae3155215215577efa43d6c5834d4d78b96c86fea48e209a4b249fbcf33c1397f8fc014720d07b4e9126fb153c02ee95bf4528ec"} 01:14:09 INFO - Copying logs to upload dir... 01:14:09 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1285.374509 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-01-08 01:14:08.644110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 01:14:08.647966) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930 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/97133bd7962ba73c1559c36241bba30b3878fdd0f7bf8a358dea2a15dd98fa3555639805f7517a689a665b8796a5504f064b3b7aacb5cc2ceef26643ec0308dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e9a2e4c1e4cc55f549818ebae3155215215577efa43d6c5834d4d78b96c86fea48e209a4b249fbcf33c1397f8fc014720d07b4e9126fb153c02ee95bf4528ec"} build_url:https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97133bd7962ba73c1559c36241bba30b3878fdd0f7bf8a358dea2a15dd98fa3555639805f7517a689a665b8796a5504f064b3b7aacb5cc2ceef26643ec0308dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e9a2e4c1e4cc55f549818ebae3155215215577efa43d6c5834d4d78b96c86fea48e209a4b249fbcf33c1397f8fc014720d07b4e9126fb153c02ee95bf4528ec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 01:14:08.672467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:14:08.672801) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1452242960.668429-441643930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:14:08.756471) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 01:14:08.756789) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 01:14:08.757122) ========= ========= Total master_lag: 0.21 =========