builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1452167749.67 results: success (0) buildid: 20160107013027 builduid: c6f47164fffa4dbea6ea2a0fdefffde3 revision: cb2aea4df00597cc86ea1bc998f3f52c155879f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.670184) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.670727) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.671034) ========= 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=0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006312 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.694700) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.695016) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.724842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.725130) ========= 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=0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.774700) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.775012) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.775382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.775771) ========= 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=0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 03:55:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.8M=0.001s 2016-01-07 03:55:50 (22.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103175 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.894165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.894469) ========= 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=0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021493 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.944517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:49.944890) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev cb2aea4df00597cc86ea1bc998f3f52c155879f5 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev cb2aea4df00597cc86ea1bc998f3f52c155879f5 --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=0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 03:55:50,863 truncating revision to first 12 chars 2016-01-07 03:55:50,864 Setting DEBUG logging. 2016-01-07 03:55:50,864 attempt 1/10 2016-01-07 03:55:50,864 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/cb2aea4df005?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 03:55:51,507 unpacking tar archive at: mozilla-inbound-cb2aea4df005/testing/mozharness/ program finished with exit code 0 elapsedTime=0.905491 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:50.860574) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:50.860875) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:50.868901) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:50.869182) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 03:55:50.869585) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-07 03:55:50.869867) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:55:51 INFO - MultiFileLogger online at 20160107 03:55:51 in /builds/slave/test-pgo 03:55:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:55:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:55:51 INFO - {'append_to_log': False, 03:55:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:55:51 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:55:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:55:51 INFO - 'branch': 'Mozilla-Inbound', 03:55:51 INFO - 'buildbot_json_path': 'buildprops.json', 03:55:51 INFO - 'config_files': ('talos/linux_config.py',), 03:55:51 INFO - 'default_actions': ('clobber', 03:55:51 INFO - 'read-buildbot-config', 03:55:51 INFO - 'download-and-extract', 03:55:51 INFO - 'populate-webroot', 03:55:51 INFO - 'create-virtualenv', 03:55:51 INFO - 'install', 03:55:51 INFO - 'run-tests'), 03:55:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:55:51 INFO - 'download_minidump_stackwalk': True, 03:55:51 INFO - 'download_symbols': 'ondemand', 03:55:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:55:51 INFO - 'tooltool.py': '/tools/tooltool.py', 03:55:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:55:51 INFO - '/tools/misc-python/virtualenv.py')}, 03:55:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:55:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:55:51 INFO - 'installer_path': 'installer.exe', 03:55:51 INFO - 'log_level': 'info', 03:55:51 INFO - 'log_name': 'talos', 03:55:51 INFO - 'log_to_console': True, 03:55:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:55:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:55:51 INFO - 'opt_config_files': (), 03:55:51 INFO - 'pip_index': False, 03:55:51 INFO - 'sps_profile': False, 03:55:51 INFO - 'sps_profile_interval': 0, 03:55:51 INFO - 'suite': 'dromaeojs', 03:55:51 INFO - 'system_bits': '32', 03:55:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:55:51 INFO - 'title': 'talos-linux64-ix-017', 03:55:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:55:51 INFO - 'use_talos_json': True, 03:55:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:55:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:55:51 INFO - 'work_dir': 'build'} 03:55:51 INFO - ##### 03:55:51 INFO - ##### Running clobber step. 03:55:51 INFO - ##### 03:55:51 INFO - Running pre-action listener: _resource_record_pre_action 03:55:51 INFO - Running main action method: clobber 03:55:51 INFO - rmtree: /builds/slave/test-pgo/build 03:55:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:55:52 INFO - Running post-action listener: _resource_record_post_action 03:55:52 INFO - ##### 03:55:52 INFO - ##### Running read-buildbot-config step. 03:55:52 INFO - ##### 03:55:52 INFO - Running pre-action listener: _resource_record_pre_action 03:55:52 INFO - Running main action method: read_buildbot_config 03:55:52 INFO - Using buildbot properties: 03:55:52 INFO - { 03:55:52 INFO - "project": "", 03:55:52 INFO - "product": "firefox", 03:55:52 INFO - "script_repo_revision": "production", 03:55:52 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:55:52 INFO - "repository": "", 03:55:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:55:52 INFO - "buildid": "20160107013027", 03:55:52 INFO - "pgo_build": "True", 03:55:52 INFO - "basedir": "/builds/slave/test-pgo", 03:55:52 INFO - "buildnumber": 601, 03:55:52 INFO - "slavename": "talos-linux64-ix-017", 03:55:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:55:52 INFO - "platform": "ubuntu64_hw", 03:55:52 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:55:52 INFO - "branch": "mozilla-inbound", 03:55:52 INFO - "repo_path": "integration/mozilla-inbound", 03:55:52 INFO - "revision": "cb2aea4df00597cc86ea1bc998f3f52c155879f5", 03:55:52 INFO - "stage_platform": "linux64-pgo", 03:55:52 INFO - "builduid": "c6f47164fffa4dbea6ea2a0fdefffde3", 03:55:52 INFO - "slavebuilddir": "test" 03:55:52 INFO - } 03:55:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:55:52 INFO - Running post-action listener: _resource_record_post_action 03:55:52 INFO - ##### 03:55:52 INFO - ##### Running download-and-extract step. 03:55:52 INFO - ##### 03:55:52 INFO - Running pre-action listener: _resource_record_pre_action 03:55:52 INFO - Running main action method: download_and_extract 03:55:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:55:52 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')]} 03:55:52 INFO - https://queue.taskcluster.net/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:55:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/test_packages.json 03:55:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/test_packages.json 03:55:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:55:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:55:54 INFO - Downloaded 1302 bytes. 03:55:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:55:54 INFO - Using the following test package requirements: 03:55:54 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:55:54 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:55:54 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:54 INFO - u'jsshell-linux-x86_64.zip'], 03:55:54 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:55:54 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:55:54 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:55:54 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:55:54 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:55:54 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:55:54 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:55:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:55:54 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:55:54 INFO - https://queue.taskcluster.net/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:55:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/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 03:55:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/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 03:55:56 INFO - Downloaded 24056664 bytes. 03:55:56 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 03:55:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55:56 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 03:55:57 INFO - Return code: 0 03:55: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 03:55: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')]} 03:55:57 INFO - https://queue.taskcluster.net/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:55:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/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 03:55:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/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 03:55:59 INFO - Downloaded 24056664 bytes. 03:55: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 03:55:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:55: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 03:56:00 INFO - Return code: 0 03:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:00 INFO - https://queue.taskcluster.net/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:56:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:56:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:56:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/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 03:56:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/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 03:56:02 INFO - Downloaded 11132285 bytes. 03:56: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 03:56:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:56: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 03:56:02 INFO - Return code: 0 03:56: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')]} 03:56:02 INFO - https://queue.taskcluster.net/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:56:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:56:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:56:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/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 03:56:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/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 03:56:03 INFO - Downloaded 55940769 bytes. 03:56:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:56:03 INFO - mkdir: /builds/slave/test-pgo/properties 03:56:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:56:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:56:03 INFO - Contents: 03:56:03 INFO - build_url:https://queue.taskcluster.net/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:56:03 INFO - Running post-action listener: _resource_record_post_action 03:56:03 INFO - Running post-action listener: set_extra_try_arguments 03:56:03 INFO - ##### 03:56:03 INFO - ##### Running populate-webroot step. 03:56:03 INFO - ##### 03:56:03 INFO - Running pre-action listener: _resource_record_pre_action 03:56:03 INFO - Running main action method: populate_webroot 03:56:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:56:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:56:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:56:03 INFO - '--tppagecycles', 03:56:03 INFO - '7'], 03:56:03 INFO - 'tests': ['tsvgm']}}, 03:56:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:56:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:56:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:56:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:56:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:56:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:56:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:03 INFO - 'talos_options': ['--e10s'], 03:56:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:03 INFO - 'tests': ['damp', 'tps']}, 03:56:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:03 INFO - 'talos_options': ['--e10s'], 03:56:03 INFO - 'tests': ['damp', 'tps']}, 03:56:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:56:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:56:03 INFO - 'other': {'tests': ['a11yr', 03:56:03 INFO - 'ts_paint', 03:56:03 INFO - 'tpaint', 03:56:03 INFO - 'sessionrestore', 03:56:03 INFO - 'sessionrestore_no_auto_restore']}, 03:56:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:56:03 INFO - 'tests': ['a11yr', 03:56:03 INFO - 'ts_paint', 03:56:03 INFO - 'tpaint', 03:56:03 INFO - 'sessionrestore', 03:56:03 INFO - 'sessionrestore_no_auto_restore']}, 03:56:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:56:03 INFO - 'tests': ['a11yr', 03:56:03 INFO - 'ts_paint', 03:56:03 INFO - 'tpaint', 03:56:03 INFO - 'sessionrestore', 03:56:03 INFO - 'sessionrestore_no_auto_restore']}, 03:56:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:56:03 INFO - 'tests': ['a11yr', 03:56:03 INFO - 'ts_paint', 03:56:03 INFO - 'tpaint', 03:56:03 INFO - 'sessionrestore', 03:56:03 INFO - 'sessionrestore_no_auto_restore']}, 03:56:03 INFO - 'other_l64': {'tests': ['a11yr', 03:56:03 INFO - 'ts_paint', 03:56:03 INFO - 'tpaint', 03:56:03 INFO - 'sessionrestore', 03:56:03 INFO - 'sessionrestore_no_auto_restore']}, 03:56:03 INFO - 'other_nol64': {'tests': ['a11yr', 03:56:03 INFO - 'ts_paint', 03:56:03 INFO - 'tpaint', 03:56:03 INFO - 'sessionrestore', 03:56:03 INFO - 'sessionrestore_no_auto_restore']}, 03:56:03 INFO - 'svgr': {'tests': ['tsvgx', 03:56:03 INFO - 'tsvgr_opacity', 03:56:03 INFO - 'tart', 03:56:03 INFO - 'tscrollx', 03:56:03 INFO - 'cart']}, 03:56:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:56:03 INFO - 'tests': ['tsvgx', 03:56:03 INFO - 'tsvgr_opacity', 03:56:03 INFO - 'tart', 03:56:03 INFO - 'tscrollx', 03:56:03 INFO - 'cart']}, 03:56:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:03 INFO - 'tests': ['tp5o']}, 03:56:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:03 INFO - 'talos_options': ['--e10s'], 03:56:03 INFO - 'tests': ['tp5o']}, 03:56:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:03 INFO - 'talos_options': ['--xperf_path', 03:56:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:03 INFO - 'tests': ['tp5n']}, 03:56:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:03 INFO - 'talos_options': ['--e10s', 03:56:03 INFO - '--xperf_path', 03:56:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:03 INFO - 'tests': ['tp5n']}}, 03:56:03 INFO - 'talos.zip': {'path': '', 03:56:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:56:03 INFO - Running post-action listener: _resource_record_post_action 03:56:03 INFO - ##### 03:56:03 INFO - ##### Running create-virtualenv step. 03:56:03 INFO - ##### 03:56:03 INFO - Running pre-action listener: _resource_record_pre_action 03:56:03 INFO - Running main action method: create_virtualenv 03:56:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:56:03 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 03:56:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:56:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:56:04 INFO - Using real prefix '/usr' 03:56:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:56:04 INFO - Installing distribute.............................................................................................................................................................................................done. 03:56:06 INFO - Installing pip.................done. 03:56:06 INFO - Return code: 0 03:56:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:06 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 0x7f8343797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e9540>, '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 0x18ea440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8f0>, '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': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', '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 03:56:06 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 03:56:06 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 03:56:06 INFO - Using env: {'DISPLAY': ':0', 03:56:06 INFO - 'HOME': '/home/cltbld', 03:56:06 INFO - 'LANG': 'en_US.UTF-8', 03:56:06 INFO - 'LANGUAGE': 'en_US:en', 03:56:06 INFO - 'LOGNAME': 'cltbld', 03:56:06 INFO - 'MAIL': '/var/mail/cltbld', 03:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:06 INFO - 'MOZ_NO_REMOTE': '1', 03:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:06 INFO - 'NO_EM_RESTART': '1', 03:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:06 INFO - 'SHELL': '/bin/bash', 03:56:06 INFO - 'SHLVL': '1', 03:56:06 INFO - 'TERM': 'linux', 03:56:06 INFO - 'TMOUT': '86400', 03:56:06 INFO - 'USER': 'cltbld', 03:56:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', 03:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:06 INFO - '_': '/tools/buildbot/bin/python'} 03:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:06 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 03:56:06 INFO - Cleaning up... 03:56:06 INFO - Return code: 0 03:56:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:06 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 0x7f8343797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e9540>, '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 0x18ea440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8f0>, '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': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', '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 03:56:06 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 03:56:06 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 03:56:06 INFO - Using env: {'DISPLAY': ':0', 03:56:06 INFO - 'HOME': '/home/cltbld', 03:56:06 INFO - 'LANG': 'en_US.UTF-8', 03:56:06 INFO - 'LANGUAGE': 'en_US:en', 03:56:06 INFO - 'LOGNAME': 'cltbld', 03:56:06 INFO - 'MAIL': '/var/mail/cltbld', 03:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:06 INFO - 'MOZ_NO_REMOTE': '1', 03:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:06 INFO - 'NO_EM_RESTART': '1', 03:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:06 INFO - 'SHELL': '/bin/bash', 03:56:06 INFO - 'SHLVL': '1', 03:56:06 INFO - 'TERM': 'linux', 03:56:06 INFO - 'TMOUT': '86400', 03:56:06 INFO - 'USER': 'cltbld', 03:56:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', 03:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:06 INFO - '_': '/tools/buildbot/bin/python'} 03:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:06 INFO - Downloading/unpacking psutil>=0.7.1 03:56:06 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 03:56:06 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 03:56:06 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 03:56:06 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 03:56:06 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 03:56:06 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 03:56:08 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:56:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:56:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:56:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:08 INFO - Installing collected packages: psutil 03:56:08 INFO - Running setup.py install for psutil 03:56:08 INFO - building 'psutil._psutil_linux' extension 03:56:08 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 03:56:08 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 03:56:08 INFO - building 'psutil._psutil_posix' extension 03:56:08 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 03:56:09 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 03:56:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:09 INFO - Successfully installed psutil 03:56:09 INFO - Cleaning up... 03:56:09 INFO - Return code: 0 03:56:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:09 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 0x7f8343797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e9540>, '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 0x18ea440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8f0>, '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': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', '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 03:56:09 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 03:56:09 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 03:56:09 INFO - Using env: {'DISPLAY': ':0', 03:56:09 INFO - 'HOME': '/home/cltbld', 03:56:09 INFO - 'LANG': 'en_US.UTF-8', 03:56:09 INFO - 'LANGUAGE': 'en_US:en', 03:56:09 INFO - 'LOGNAME': 'cltbld', 03:56:09 INFO - 'MAIL': '/var/mail/cltbld', 03:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:09 INFO - 'MOZ_NO_REMOTE': '1', 03:56:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:09 INFO - 'NO_EM_RESTART': '1', 03:56:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:09 INFO - 'SHELL': '/bin/bash', 03:56:09 INFO - 'SHLVL': '1', 03:56:09 INFO - 'TERM': 'linux', 03:56:09 INFO - 'TMOUT': '86400', 03:56:09 INFO - 'USER': 'cltbld', 03:56:09 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', 03:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:09 INFO - '_': '/tools/buildbot/bin/python'} 03:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:56:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:56:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:56:11 INFO - Installing collected packages: mozsystemmonitor 03:56:11 INFO - Running setup.py install for mozsystemmonitor 03:56:11 INFO - Successfully installed mozsystemmonitor 03:56:11 INFO - Cleaning up... 03:56:11 INFO - Return code: 0 03:56:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:11 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 0x7f8343797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e9540>, '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 0x18ea440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8f0>, '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': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', '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 03:56:11 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 03:56:11 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 03:56:11 INFO - Using env: {'DISPLAY': ':0', 03:56:11 INFO - 'HOME': '/home/cltbld', 03:56:11 INFO - 'LANG': 'en_US.UTF-8', 03:56:11 INFO - 'LANGUAGE': 'en_US:en', 03:56:11 INFO - 'LOGNAME': 'cltbld', 03:56:11 INFO - 'MAIL': '/var/mail/cltbld', 03:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:11 INFO - 'MOZ_NO_REMOTE': '1', 03:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:11 INFO - 'NO_EM_RESTART': '1', 03:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:11 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:11 INFO - 'SHELL': '/bin/bash', 03:56:11 INFO - 'SHLVL': '1', 03:56:11 INFO - 'TERM': 'linux', 03:56:11 INFO - 'TMOUT': '86400', 03:56:11 INFO - 'USER': 'cltbld', 03:56:11 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', 03:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:11 INFO - '_': '/tools/buildbot/bin/python'} 03:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:11 INFO - Downloading/unpacking blobuploader==1.2.4 03:56:11 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 03:56:11 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 03:56:11 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 03:56:11 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 03:56:11 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 03:56:11 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 03:56:13 INFO - Downloading blobuploader-1.2.4.tar.gz 03:56:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:56:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:56:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:56:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:56:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56:13 INFO - Downloading docopt-0.6.1.tar.gz 03:56:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:56:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:56:14 INFO - Installing collected packages: blobuploader, requests, docopt 03:56:14 INFO - Running setup.py install for blobuploader 03:56:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:56:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:56:14 INFO - Running setup.py install for requests 03:56:14 INFO - Running setup.py install for docopt 03:56:14 INFO - Successfully installed blobuploader requests docopt 03:56:14 INFO - Cleaning up... 03:56:14 INFO - Return code: 0 03:56:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:14 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 0x7f8343797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e9540>, '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 0x18ea440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8f0>, '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': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', '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 03:56:14 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 03:56:14 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 03:56:14 INFO - Using env: {'DISPLAY': ':0', 03:56:14 INFO - 'HOME': '/home/cltbld', 03:56:14 INFO - 'LANG': 'en_US.UTF-8', 03:56:14 INFO - 'LANGUAGE': 'en_US:en', 03:56:14 INFO - 'LOGNAME': 'cltbld', 03:56:14 INFO - 'MAIL': '/var/mail/cltbld', 03:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:14 INFO - 'MOZ_NO_REMOTE': '1', 03:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:14 INFO - 'NO_EM_RESTART': '1', 03:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:14 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:14 INFO - 'SHELL': '/bin/bash', 03:56:14 INFO - 'SHLVL': '1', 03:56:14 INFO - 'TERM': 'linux', 03:56:14 INFO - 'TMOUT': '86400', 03:56:14 INFO - 'USER': 'cltbld', 03:56:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', 03:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:14 INFO - '_': '/tools/buildbot/bin/python'} 03:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:56:14 INFO - Running setup.py (path:/tmp/pip-TPLLa9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:56:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:56:14 INFO - Running setup.py (path:/tmp/pip-gV81ME-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:56:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:56:14 INFO - Running setup.py (path:/tmp/pip-_JXdZN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:56:15 INFO - Running setup.py (path:/tmp/pip-LqgDTz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:56:15 INFO - Running setup.py (path:/tmp/pip-3u9f4z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:56:15 INFO - Running setup.py (path:/tmp/pip-cesbHa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:56:15 INFO - Running setup.py (path:/tmp/pip-P9xWhs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:56:15 INFO - Running setup.py (path:/tmp/pip-t3BuYP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:56:15 INFO - Running setup.py (path:/tmp/pip-nTcfYz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:56:15 INFO - Running setup.py (path:/tmp/pip-3CQojn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:56:15 INFO - Running setup.py (path:/tmp/pip-JOIhyW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:56:15 INFO - Running setup.py (path:/tmp/pip-hgvI1l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:56:15 INFO - Running setup.py (path:/tmp/pip-EPbaX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:56:15 INFO - Running setup.py (path:/tmp/pip-HrgzHx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:56:15 INFO - Running setup.py (path:/tmp/pip-MrsmaX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:56:15 INFO - Running setup.py (path:/tmp/pip-0Rbah6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:56:15 INFO - Running setup.py (path:/tmp/pip-58jelO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:56:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:56:16 INFO - Running setup.py install for manifestparser 03:56:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:56:16 INFO - Running setup.py install for mozcrash 03:56:16 INFO - Running setup.py install for mozdebug 03:56:16 INFO - Running setup.py install for mozdevice 03:56:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:56:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:56:16 INFO - Running setup.py install for mozfile 03:56:16 INFO - Running setup.py install for mozhttpd 03:56:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:56:16 INFO - Running setup.py install for mozinfo 03:56:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:56:16 INFO - Running setup.py install for mozInstall 03:56:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:56:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:56:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:56:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:56:16 INFO - Running setup.py install for mozleak 03:56:16 INFO - Running setup.py install for mozlog 03:56:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:56:17 INFO - Running setup.py install for moznetwork 03:56:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:56:17 INFO - Running setup.py install for mozprocess 03:56:17 INFO - Running setup.py install for mozprofile 03:56:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:56:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:56:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:56:17 INFO - Running setup.py install for mozrunner 03:56:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:56:17 INFO - Running setup.py install for mozscreenshot 03:56:17 INFO - Running setup.py install for moztest 03:56:17 INFO - Running setup.py install for mozversion 03:56:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:56:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:56:17 INFO - Cleaning up... 03:56:17 INFO - Return code: 0 03:56:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:17 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 0x7f8343797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e9540>, '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 0x18ea440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8f0>, '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': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', '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 03:56:17 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 03:56:17 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 03:56:17 INFO - Using env: {'DISPLAY': ':0', 03:56:17 INFO - 'HOME': '/home/cltbld', 03:56:17 INFO - 'LANG': 'en_US.UTF-8', 03:56:17 INFO - 'LANGUAGE': 'en_US:en', 03:56:17 INFO - 'LOGNAME': 'cltbld', 03:56:17 INFO - 'MAIL': '/var/mail/cltbld', 03:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:17 INFO - 'MOZ_NO_REMOTE': '1', 03:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:17 INFO - 'NO_EM_RESTART': '1', 03:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:17 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:17 INFO - 'SHELL': '/bin/bash', 03:56:17 INFO - 'SHLVL': '1', 03:56:17 INFO - 'TERM': 'linux', 03:56:17 INFO - 'TMOUT': '86400', 03:56:17 INFO - 'USER': 'cltbld', 03:56:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', 03:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:17 INFO - '_': '/tools/buildbot/bin/python'} 03:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:56:18 INFO - Running setup.py (path:/tmp/pip-iuumSP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:56:18 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)) 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:56:18 INFO - Running setup.py (path:/tmp/pip-VhJTLn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:56:18 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)) 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:56:18 INFO - Running setup.py (path:/tmp/pip-hZ57cs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:56:18 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)) 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:56:18 INFO - Running setup.py (path:/tmp/pip-JJvzUF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:56:18 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)) 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:56:18 INFO - Running setup.py (path:/tmp/pip-1MkCNv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:56:18 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)) 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:56:18 INFO - Running setup.py (path:/tmp/pip-oLNzNP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:56:18 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)) 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:56:18 INFO - Running setup.py (path:/tmp/pip-l6Glzj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:56:18 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)) 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:56:18 INFO - Running setup.py (path:/tmp/pip-gnXdpN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:56:18 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)) 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:56:18 INFO - Running setup.py (path:/tmp/pip-KuuCMI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:56:18 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)) 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:56:18 INFO - Running setup.py (path:/tmp/pip-29x5y8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:56:18 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)) 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:56:18 INFO - Running setup.py (path:/tmp/pip-AnBQAd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:56:18 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)) 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:56:18 INFO - Running setup.py (path:/tmp/pip-VHia13-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:56:18 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)) 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:56:18 INFO - Running setup.py (path:/tmp/pip-CXgin5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:56:18 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)) 03:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:56:19 INFO - Running setup.py (path:/tmp/pip-EXTgDT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:56:19 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)) 03:56:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:56:19 INFO - Running setup.py (path:/tmp/pip-QIwkUu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:56:19 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)) 03:56:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:56:19 INFO - Running setup.py (path:/tmp/pip-H2OBtq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:56:19 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)) 03:56:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:56:19 INFO - Running setup.py (path:/tmp/pip-PTJj56-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:56:19 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)) 03:56:19 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)) 03:56:19 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)) 03:56:19 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)) 03:56:19 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)) 03:56:19 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)) 03:56:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:20 INFO - Downloading blessings-1.5.1.tar.gz 03:56:20 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 03:56:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:56:21 INFO - Installing collected packages: blessings 03:56:21 INFO - Running setup.py install for blessings 03:56:21 INFO - Successfully installed blessings 03:56:21 INFO - Cleaning up... 03:56:21 INFO - Return code: 0 03:56:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:56:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:56:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:56:21 INFO - Reading from file tmpfile_stdout 03:56:21 INFO - Current package versions: 03:56:21 INFO - argparse == 1.2.1 03:56:21 INFO - blessings == 1.5.1 03:56:21 INFO - blobuploader == 1.2.4 03:56:21 INFO - docopt == 0.6.1 03:56:21 INFO - manifestparser == 1.1 03:56:21 INFO - mozInstall == 1.12 03:56:21 INFO - mozcrash == 0.16 03:56:21 INFO - mozdebug == 0.1 03:56:21 INFO - mozdevice == 0.47 03:56:21 INFO - mozfile == 1.2 03:56:21 INFO - mozhttpd == 0.7 03:56:21 INFO - mozinfo == 0.9 03:56:21 INFO - mozleak == 0.1 03:56:21 INFO - mozlog == 3.1 03:56:21 INFO - moznetwork == 0.27 03:56:21 INFO - mozprocess == 0.22 03:56:21 INFO - mozprofile == 0.28 03:56:21 INFO - mozrunner == 6.11 03:56:21 INFO - mozscreenshot == 0.1 03:56:21 INFO - mozsystemmonitor == 0.0 03:56:21 INFO - moztest == 0.7 03:56:21 INFO - mozversion == 1.4 03:56:21 INFO - psutil == 3.1.1 03:56:21 INFO - requests == 1.2.3 03:56:21 INFO - wsgiref == 0.1.2 03:56:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:56: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')]} 03:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56: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')]} 03:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:21 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 0x7f8343797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e9540>, '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 0x18ea440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8f0>, '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': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', '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 03:56:21 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 03:56:21 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 03:56:21 INFO - Using env: {'DISPLAY': ':0', 03:56:21 INFO - 'HOME': '/home/cltbld', 03:56:21 INFO - 'LANG': 'en_US.UTF-8', 03:56:21 INFO - 'LANGUAGE': 'en_US:en', 03:56:21 INFO - 'LOGNAME': 'cltbld', 03:56:21 INFO - 'MAIL': '/var/mail/cltbld', 03:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:21 INFO - 'MOZ_NO_REMOTE': '1', 03:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:21 INFO - 'NO_EM_RESTART': '1', 03:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:21 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:21 INFO - 'SHELL': '/bin/bash', 03:56:21 INFO - 'SHLVL': '1', 03:56:21 INFO - 'TERM': 'linux', 03:56:21 INFO - 'TMOUT': '86400', 03:56:21 INFO - 'USER': 'cltbld', 03:56:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', 03:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:21 INFO - '_': '/tools/buildbot/bin/python'} 03:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:21 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)) 03:56:21 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)) 03:56:21 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)) 03:56:21 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)) 03:56:21 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)) 03:56:21 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)) 03:56:21 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)) 03:56:21 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)) 03:56:21 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)) 03:56:21 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)) 03:56:21 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)) 03:56:21 INFO - Cleaning up... 03:56:21 INFO - Return code: 0 03:56:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:56: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')]} 03:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56: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')]} 03:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:21 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 0x7f8343797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e9540>, '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 0x18ea440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8f0>, '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': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', '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 03:56:21 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 03:56:21 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 03:56:21 INFO - Using env: {'DISPLAY': ':0', 03:56:21 INFO - 'HOME': '/home/cltbld', 03:56:21 INFO - 'LANG': 'en_US.UTF-8', 03:56:21 INFO - 'LANGUAGE': 'en_US:en', 03:56:21 INFO - 'LOGNAME': 'cltbld', 03:56:21 INFO - 'MAIL': '/var/mail/cltbld', 03:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:21 INFO - 'MOZ_NO_REMOTE': '1', 03:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:21 INFO - 'NO_EM_RESTART': '1', 03:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:21 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:21 INFO - 'SHELL': '/bin/bash', 03:56:21 INFO - 'SHLVL': '1', 03:56:21 INFO - 'TERM': 'linux', 03:56:21 INFO - 'TMOUT': '86400', 03:56:21 INFO - 'USER': 'cltbld', 03:56:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', 03:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:21 INFO - '_': '/tools/buildbot/bin/python'} 03:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:21 INFO - Downloading/unpacking jsonschema 03:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:56:23 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 03:56:23 INFO - Downloading/unpacking functools32 (from jsonschema) 03:56:23 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 03:56:23 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 03:56:23 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 03:56:23 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 03:56:23 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 03:56:23 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 03:56:24 INFO - Downloading functools32-3.2.3-2.tar.gz 03:56:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:56:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:56:24 INFO - warning: no files found matching '*.txt' 03:56:24 INFO - no previously-included directories found matching 'build' 03:56:24 INFO - no previously-included directories found matching 'dist' 03:56:24 INFO - no previously-included directories found matching '.git*' 03:56:24 INFO - Installing collected packages: jsonschema, functools32 03:56:24 INFO - Running setup.py install for functools32 03:56:24 INFO - warning: no files found matching '*.txt' 03:56:24 INFO - no previously-included directories found matching 'build' 03:56:24 INFO - no previously-included directories found matching 'dist' 03:56:24 INFO - no previously-included directories found matching '.git*' 03:56:24 INFO - Successfully installed jsonschema functools32 03:56:24 INFO - Cleaning up... 03:56:24 INFO - Return code: 0 03:56:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:56: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')]} 03:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56: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')]} 03:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56: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', '--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 0x7f8343797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e9540>, '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 0x18ea440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8f0>, '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': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', '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 03:56:24 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 03:56:24 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 03:56:24 INFO - Using env: {'DISPLAY': ':0', 03:56:24 INFO - 'HOME': '/home/cltbld', 03:56:24 INFO - 'LANG': 'en_US.UTF-8', 03:56:24 INFO - 'LANGUAGE': 'en_US:en', 03:56:24 INFO - 'LOGNAME': 'cltbld', 03:56:24 INFO - 'MAIL': '/var/mail/cltbld', 03:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:24 INFO - 'MOZ_NO_REMOTE': '1', 03:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:24 INFO - 'NO_EM_RESTART': '1', 03:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:24 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:24 INFO - 'SHELL': '/bin/bash', 03:56:24 INFO - 'SHLVL': '1', 03:56:24 INFO - 'TERM': 'linux', 03:56:24 INFO - 'TMOUT': '86400', 03:56:24 INFO - 'USER': 'cltbld', 03:56:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', 03:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:24 INFO - '_': '/tools/buildbot/bin/python'} 03:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:24 INFO - Downloading/unpacking flake8 03:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:56:26 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 03:56:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:56:26 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 03:56:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56:26 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 03:56:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:56:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:56:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:56:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:56:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:56:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:56:26 INFO - no previously-included directories found matching 'docs/_build' 03:56:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:56:26 INFO - Running setup.py install for pep8 03:56:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:56:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:56:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:56:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:56:27 INFO - no previously-included directories found matching 'docs/_build' 03:56:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:56:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:56:27 INFO - Cleaning up... 03:56:27 INFO - Return code: 0 03:56:27 INFO - Running post-action listener: _resource_record_post_action 03:56:27 INFO - Running post-action listener: _start_resource_monitoring 03:56:27 INFO - Starting resource monitoring. 03:56:27 INFO - ##### 03:56:27 INFO - ##### Running install step. 03:56:27 INFO - ##### 03:56:27 INFO - Running pre-action listener: _resource_record_pre_action 03:56:27 INFO - Running main action method: install 03:56:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:56:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:56:27 INFO - Reading from file tmpfile_stdout 03:56:27 INFO - Detecting whether we're running mozinstall >=1.0... 03:56:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:56:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:56:27 INFO - Reading from file tmpfile_stdout 03:56:27 INFO - Output received: 03:56:27 INFO - Usage: mozinstall [options] installer 03:56:27 INFO - Options: 03:56:27 INFO - -h, --help show this help message and exit 03:56:27 INFO - -d DEST, --destination=DEST 03:56:27 INFO - Directory to install application into. [default: 03:56:27 INFO - "/builds/slave/test-pgo"] 03:56:27 INFO - --app=APP Application being installed. [default: firefox] 03:56:27 INFO - mkdir: /builds/slave/test-pgo/build/application 03:56:27 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'] 03:56:27 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 03:56:43 INFO - Reading from file tmpfile_stdout 03:56:43 INFO - Output received: 03:56:43 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:56:43 INFO - Running post-action listener: _resource_record_post_action 03:56:43 INFO - ##### 03:56:43 INFO - ##### Running run-tests step. 03:56:43 INFO - ##### 03:56:43 INFO - Running pre-action listener: _resource_record_pre_action 03:56:43 INFO - Running main action method: run_tests 03:56:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:56:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:56:43 INFO - Python 2.7.3 03:56:43 INFO - Return code: 0 03:56:43 INFO - grabbing minidump binary from tooltool 03:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:56:43 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 0x18e9540>, '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 0x18ea440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:56:43 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 03:56:43 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 03:56:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:56:43 INFO - Return code: 0 03:56:43 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:56:43 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:56:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:56:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:56:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:56:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:56:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:56:44 INFO - Return code: 0 03:56:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 03:56:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 03:56:44 INFO - Using env: {'DISPLAY': ':0', 03:56:44 INFO - 'HOME': '/home/cltbld', 03:56:44 INFO - 'LANG': 'en_US.UTF-8', 03:56:44 INFO - 'LANGUAGE': 'en_US:en', 03:56:44 INFO - 'LOGNAME': 'cltbld', 03:56:44 INFO - 'MAIL': '/var/mail/cltbld', 03:56:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:56:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:44 INFO - 'MOZ_NO_REMOTE': '1', 03:56:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:44 INFO - 'NO_EM_RESTART': '1', 03:56:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:56:44 INFO - 'PWD': '/builds/slave/test-pgo', 03:56:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:56:44 INFO - 'SHELL': '/bin/bash', 03:56:44 INFO - 'SHLVL': '1', 03:56:44 INFO - 'TERM': 'linux', 03:56:44 INFO - 'TMOUT': '86400', 03:56:44 INFO - 'USER': 'cltbld', 03:56:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514', 03:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:44 INFO - '_': '/tools/buildbot/bin/python'} 03:56:44 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 03:56:44 INFO - mozversion application_buildid: 20160107013027 03:56:44 INFO - mozversion application_changeset: cb2aea4df00597cc86ea1bc998f3f52c155879f5 03:56:44 INFO - mozversion application_display_name: Nightly 03:56:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:56:44 INFO - mozversion application_name: Firefox 03:56:44 INFO - mozversion application_remotingname: firefox 03:56:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:56:44 INFO - mozversion application_vendor: Mozilla 03:56:44 INFO - mozversion application_version: 46.0a1 03:56:44 INFO - mozversion platform_buildid: 20160107013027 03:56:44 INFO - mozversion platform_changeset: cb2aea4df00597cc86ea1bc998f3f52c155879f5 03:56:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:56:44 INFO - mozversion platform_version: 46.0a1 03:56:44 INFO - using testdate: 1452167804 03:56:44 INFO - actual date: 1452167804 03:56:44 INFO - starting webserver on 'localhost:43066' 03:56:44 INFO - SUITE-START | Running 3 tests 03:56:44 INFO - TEST-START | dromaeo_css 03:56:44 INFO - operating with platform_type : linux_ 03:56:44 INFO - Initialising browser for dromaeo_css test... 03:56:44 INFO - TEST-INFO | started process 24493 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp15bx10/profile http://localhost:43066/getInfo.html) 03:56:48 INFO - PROCESS | 24493 | __metrics Screen width/height:1600/1200 03:56:48 INFO - PROCESS | 24493 | colorDepth:24 03:56:48 INFO - PROCESS | 24493 | Browser inner width/height: 1024/697 03:56:48 INFO - PROCESS | 24493 | __metrics 03:56:48 INFO - PROCESS | 24493 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:56:48 INFO - PROCESS | 24493 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:56:49 INFO - TEST-INFO | 24493: exit 0 03:56:49 INFO - Browser initialized. 03:56:49 INFO - Running cycle 1/1 for dromaeo_css test... 03:56:49 INFO - TEST-INFO | started process 24585 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp15bx10/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:57:01 INFO - PROCESS | 24585 | RSS: Main: 150351872 03:57:01 INFO - PROCESS | 24585 | 03:57:52 INFO - PROCESS | 24585 | 1452167872905 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:00:01 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:43066/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43066/tests/dromaeo/cssquery-ext.html) 04:00:02 INFO - PROCESS | 24585 | RSS: Main: 278196224 04:00:02 INFO - PROCESS | 24585 | 04:03:05 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:43066/tests/dromaeo/cssquery-ext.html (next: http://localhost:43066/tests/dromaeo/cssquery-jquery.html) 04:03:05 INFO - PROCESS | 24585 | RSS: Main: 233725952 04:03:05 INFO - PROCESS | 24585 | 04:06:07 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:43066/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43066/tests/dromaeo/cssquery-mootools.html) 04:06:08 INFO - PROCESS | 24585 | RSS: Main: 234184704 04:06:08 INFO - PROCESS | 24585 | 04:09:10 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:43066/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43066/tests/dromaeo/cssquery-prototype.html) 04:09:10 INFO - PROCESS | 24585 | RSS: Main: 214626304 04:09:10 INFO - PROCESS | 24585 | 04:12:13 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:43066/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43066/tests/dromaeo/cssquery-yui.html) 04:12:14 INFO - PROCESS | 24585 | RSS: Main: 217837568 04:12:14 INFO - PROCESS | 24585 | 04:15:16 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:43066/tests/dromaeo/cssquery-yui.html (next: http://localhost:43066/tests/dromaeo/cssquery-dojo.html) 04:15:16 INFO - PROCESS | 24585 | RSS: Main: 274612224 04:15:16 INFO - PROCESS | 24585 | 04:15:16 INFO - PROCESS | 24585 | __start_tp_report 04:15:16 INFO - PROCESS | 24585 | _x_x_mozilla_page_load 04:15:16 INFO - PROCESS | 24585 | _x_x_mozilla_page_load_details 04:15:16 INFO - PROCESS | 24585 | |i|pagename|runs| 04:15:16 INFO - PROCESS | 24585 | |0;dojo.html;3180.9840950795246;3255.251292202795;3296.9670303296975;3299.9340013199735;3320.2363456405033;5124.180131179012;5219.973900130503;5329.786808527659;5374.381946076202;5444.863878403042;5204.843854684365;5217.660852044624;5257.737113144337;5330.706811125397;5380.946190538103;4753.405824271966;4753.595944344726;4763.90472190556;4808.302796094564;4813.253945638432;4810.663253572251;4857.6113910887225;4860.392450943632;4943.579795717368;4973.850784476472;4720.480747117797;4810.6151507879285;4830.347903033081;4848.903021939559;4877.6829506081995;4793.041391721669;4814.181589129857;4824.98675278192;4831.4685384607665;4866.9513304867205;4782.904341913177;4797.904041919142;4800.927986080212;4805.687630304019;4872.415310162768;4944.060628480614;4995.275685025651;5045.243213517965;5099.15863882459;5200.2979597754575;5624.353199382042;5625.8593535161535;5631.521320687746;5634.098544232903;5651.095824668033;5638.774449022034;5654.236678048452;5661.547076233891;5665.490105890449;5667.716614169275;5145.562627176694;5229.973850130763;5238.476152384807;5265.6840589564745;5287.4448182941005;5829.067349224104;5885.705714714333;5888.705564721832;5901.675407852524;5945;5621.775128994795;5642.23829782974;5645.435456454322;5678.602497825195;5704.3154821421695;5499.835004949858;5613.578981576398;5690.459406356389;5727.799527016535;5742.971285143548;5550.5282051026115;5581.944180558143;5612.691301978349;5656.066748986454;5704.572157088152;5594.272744543184;5596.58025648078;5617.297837770278;5619.297587801525;5627.5779316551425;4285.228658841376;4366.061296821199;4372.0818628088455;4374.693771436033;4430.490493593214;3963.365861462152;3990.980045099756;4023.4769479968004;4037.2934736421007;4038.3740520218826;5285.867853303621;5287.867803304871;5325.4142044375085;5326.760295786699;5381.596380271495;5642.351129620064;5719.456651618089;5727.77088916447;5728.169415434739;5734.05388110957;5319.494648008433;5323.2015197719875;5335;5339.065663508871;5384.515393614593;4737.59730422911;4841.104395686809;4893.510648935078;4894.853154405374;4904.117258893362;5859.501942334864;5860.150278209636;5862.296524417097;5867.70661466925;5906.26171728534;5622.184783206494;5626.887462250814;5629.043062679272;5633.2113504110275;5651.943480565306;5762.567807414377;5786.768529258782;5796.956547821264;5907.763689452546;5919.704014799329;5609.943900561106;5650.180723795109;5713.314402271754;5722.828315150552;5727.627704199213;5701.657900525982;5728.513076388387;5729.1119876419225;5731.3408957968695;5742.397048309867;5423.457654234545;5526.944730552643;5531.9723401382735;5589.329280486368;5608.158776183605;5458.836234912959;5588;5589.301337332833;5598.272224610774;5642.181883626933;5500.477454641803;5521.199426083276;5524.281843360337;5525.806596769094;5527.50252477279;5500.81732427514;5557.3331200256225;5582.637128586629;5629.638478653639;5635.887282254414;5492.286002819608;5557.694326812064;5559.749811258423;5564.165375193753;5614.101743720985 04:15:16 INFO - PROCESS | 24585 | |1;ext.html;533.7171299211415;536.6699479819912;541.4233840959378;564.9661020338779;576.7837061102086;27664.999999999975;28387.574186387195;34783;34851;34932.650673493255;37414;37837.24325513495;37944;37945.81027094868;37980.24039519215;8334.999999999985;8541.231289183972;8551.102134275905;8552.486850788973;8553.486790792573;7411.7035318587195;7607.885881711779;9859.605615775396;10133.94933025334;10147.898521014806;9807.215422766198;9898.455584942825;9903.45530995795;9907.801843963116;9912.207023438144;7414.555126692416;7601.39188864895;9781.217502599811;9886.110250077527;9890.653827116052;9765.365251258645;10035.498225088717;10036.24728145392;10051.095401413908;10052.798944021151;35511;36049.45925811115;36088.63911360879;36225.63774362249;36249.81875090607;3284.26104126572;3860.415806003652;3864.439656249828;3864.671502922255;3927.509061367329;27034.729652703616;27522.724772752415;28153;29497.852510737524;29977.400451991056;3426.3318652862704;3454.809985450799;3502.6497350265026;3531.2231309111953;3579.928401431957;259313;261185;261390.69304653545;261415;265151;50585.747071264406;51390.48609513857;56122;56571;57017.71491142601;51405.22892156621;51883.48116518862;52077.47922520802;52099.739501302254;52131;12654.367281635881;12730.490780368682;12730.936345318214;12734.68163295925;12775.936120319338;10444.582216711398;10496.527656255334;10520.421376824348;10524.736881578021;10529.736756581147;18103;18709.532261693294;18835.71746423805;18838.434846954613;18894.244230230637;7469.290417410337;7745.845083098419;7840.490368126054;7869.563262716678;7869.763907082796;929.3215952354819;961.2166084640995;978.7797745507346;1026.9678972632457;1034.177828626244;27368.863155684096;27414;27776.58335124975;28155;28205.576916346272;1013.6300250408696;1021.3616489693941;1098.9175811814146;1115.6876074698935;1137.6188976692736;14287;14469.710605788036;14573.854261457462;14730.189839558712;14773.704525909636;311811;313696;314379;317230;317453;50545.49454505481;50571.74714126406;50881;51111.488885111416;51208.74395628073;1245.483124503321;1294.411042975444;1298.4092238031674;1298.9610311690665;1325.9204447733166;22247.44381390478;27678.723212767614;28098.438031239668;28158.2960425991;28559.42881142407;44275;44825;44903.550964489936;44966.325505118104;45143;194456;195628;195957;195964;196075;26969.865150674123;27275.86362068177;29017.56473652939;30327.545086823273;30427;34865.47701784526;35756.10609734777;35809.46285805767;35985.100372490895;36503.45244821383;28490.715092849634;28678.283042924093;28812.85593572019;28852;29033.85483072571;29150.416991660473;31287.515750414113;31637.209069772518;32570;33083.195432525565;34541.82729086339;34607.82696086504;34849.12877178091;35137.121571959884;35530.822345888104;25859;25909.740902590733;28050.859745701142;28536.85731571329;28896.7110328894;22492.88753556222;22692.20577279787;22877.42806429786;22954.54090918206;23960.28119156428 04:15:16 INFO - PROCESS | 24585 | |2;jquery.html;353.93275277697234;354.55857457465453;356.31765169700026;356.65048252712324;357.36567592523284;13312.40094195761;13760.655983600414;16050.1172435516;16533.66932661346;17909.641807163865;16088.678226435493;16098.75851862223;16420.425285115023;16586.25361858716;16617.08606026668;4540.614047805941;4767.213409787399;4768.856934291976;4770.117528257283;4773.928391074137;3791.4312853072124;4200.642945349649;4714.292856071583;5524.530414914737;5543;5506.614536982413;5522.806701765439;5547.1679248112905;5550.972245138769;5564.4991950724625;5830.183774271605;5872.17789509469;5888.057910734284;5892.086726557391;5893.55798315126;4994.925076123861;5165.328507294028;5196.870078248036;5207;5210.609204309654;12089.39553022354;12288.385580720927;13948.790768138486;19146.425607231806;19148.521286967938;2003.0885946894127;2050.0877109686194;2097.7099084063343;2104.063691657213;2238.1271304191214;9286.349955503118;9448.716538503855;9466.535228291605;11535.423228838608;12489.18820276679;1782.2336395349994;1791.7939436964787;1792.8744987850855;1793.2199493220492;1878.5961018380976;50939.490605093844;51013.744931275105;51846;53798.46201538013;57582.424175758126;9147.54262286883;9506;9810.509474526389;9897.455639939728;9900.158486528726;12818.80771788424;12833.935830320976;12841.678958026125;12848.421821018077;12851.421686024152;6691.130153080068;6902.516823822385;6975.965120174366;7005.439564834801;7062.611556364449;6737.09049278351;6747.257801641816;6747.493937954575;6788.422984046411;6805.115335006418;3986.461827653288;4014.41790940312;4030.5163380394542;4137.379393091061;4334.718243314174;1719.6835941786208;1722.2680360846591;1829.5974885525163;1835.9156616883763;1838.9172487238106;897.096319033589;901.9368644194843;907.5462268865567;1029.2743615750878;1065.8081545321916;13746.725065498835;15863.603409914844;16590;16890.155492225585;17448.91275543614;855.482433127961;921.2445794448488;923.1276443760715;940.9153176214173;982.4547376206132;8839.381243313035;8960.283177345797;9086.36395452312;9118;9199.126083022102;531357;533448;535102;536290;537885;68993.7659846553;71123.64438177776;72509.6374518124;72582;74687;1008.6620981971122;1020.642775028734;1110.2838669058413;1133.2067552713133;1193.8686744458103;14508.839292856757;14656.70686586241;14834.554963351116;15002.399904003718;15077.170755608107;30306.393872122873;30493.54259686151;31694.683053169174;33342.83328583342;34077.318453631284;37952.43071353987;39741;40432.3935140979;40990.38514422346;41428;6855.731689637433;7012.754553590804;7111.395531379891;7281.745138920112;7437.330640242404;10785.298955567863;11293.153013523854;11523.423828808358;11688.064954803425;11793.11551633648;9588.76028099303;9960;9979.550920208752;10132.594696212363;10423.374597524173;9603.951980240334;9766.267529935141;9869.753256168653;9985.550650220612;10368.274220804471;9999.500024998866;10323.380597164194;10338.793224135325;10411.47942602882;10419.426931518536;7284.599347035964;7287.635618219174;7336.596487193042;7367;7589.316961473494;9137.177654011171;9393.29550283745;10021.248406369697;10287.43419111956;10300 04:15:16 INFO - PROCESS | 24585 | |3;mootools.html;1334.4662135145934;1470.7058588282343;1482.9777553336698;1604.5988502874281;1761.1458442655303;6479.222493300805;7130.429565634749;7206.099237595301;7215.6031418272105;7222.494425390225;7174.641267936595;7336.633168341588;7337.523061001045;7339.376153026999;7348.816279593013;1972.1914015253749;2019.1418647075009;2019.2629690163058;2240.6190947538958;2269.171752310403;2029.725986991752;2232.799048085672;2277.8974946127464;2285.1887579909144;2286.314105768271;2227.7549469558335;2263.8302127340435;2267.5238199978025;2267.7505474397885;2303.665968434576;2222.355516900097;2236.1726161320335;2242.3273018094587;2246.1689175005354;2246.84272100953;2193.6599827026675;2254.8534345267667;2260.6835043093815;2261.6155253606926;2263.7736226377397;7395.223501532316;7414.295641914009;7438.925610743878;7442.702291908317;7485.663145158481;4528.750918699503;4561.726296422192;4593.448786145684;4606.101810147023;4610.9077818443775;2910.359720861407;3113.097201811472;3115.1433355827103;3125.9374812503625;3141.387429451258;965.4255717847869;978.1587834462357;986.5609803637384;1006.2955930848435;1017.6692574913183;10012.59949602015;10018.89981100187;10026.548805303779;10032.548535315927;10033.648822291185;4158.521769996489;4219.451471308772;4238.936415953764;4280.871573852789;4287.399764033038;8668.523231222218;8671.089535598798;8673.869891951626;8676.436031658048;8689.913100868911;4646.79089440976;4666.183417901853;4673.906521869543;4674.415698037746;4680.368150299734;4188.790560471964;4258.127083947783;4259.169461954889;4259.382389553497;4259.74441533509;3332.916677083044;3554.3424466473266;3558.964410355915;3578.7673801202836;3611.3499570077115;1106.7122548137543;1196.353968856825;1201.7055821323656;1207.613563659638;1217.2757209460358;1285.0683254640498;1292.6703690558847;1319.33373646308;1343.5902049874687;1347.5755137131773;6696.296888826603;6811.284815094443;6812.795616131524;6815.148106486689;6833.453323734188;1085.8154113800672;1100.6973082402244;1104.5692180049787;1116.0290547223967;1122.1471681522103;5587.888242235133;5603.411641777555;5624.987502249634;5626.549876009909;5631.662100273997;8644.265237454887;8686.218240358397;8820.779480513038;8935.687250946186;8968.506732129665;8834.160754728418;8834.469931804113;8838;8845.69040083594;8846.380753347205;6863.897041544281;7036.401905837959;7055.153381594241;7089;7105.786826395217;6834.214065382345;6836.623985680835;6858.3827455529245;6864.691088900911;6872.209695884837;7423.517471364344;7719.112302085107;7742.729004484816;7752.108507521481;8074.313683336982;7771.650275737718;7869.842603148019;8037.919620803717;8176.427650064438;8185.918140818754;6672.633005184762;6707.429868461236;6780.457563395015;6784.491163162881;6805.04729337903;6194.946859034065;6338.239411270492;6824.829379265558;6832;6886.208086070166;6586.50601204902;6626.97281921303;6636;6709.630970296681;6769.052332673331;6567.835804104936;6572.718484338003;6622.10601568782;6685.933140668726;6690.0633911253435;6700.597964122168;6720.563163394364;6743.15710536183;6772.288909664414;6775.695093720696;6199.132121503083;6210.813675589739;6216.129741836237;6217.751289948352;6238.251409830667;6032.939670603238;6107.725152368243;6111.663858487826;6349;6383.265924418565 04:15:16 INFO - PROCESS | 24585 | |4;prototype.html;333.075714891177;337.6353538178767;340.93863104641156;342.8902751119641;344.2254926415565;5744.7414866330955;5792.015357389243;5807.564432667551;5857;5862.0913758367415;5547.9736248794;5600.635958662684;5671.7731290748425;5743.3108027036815;5782.971085144579;4466.642668586522;4492.8876778080485;4497.775111244433;4508;4523.728576285417;4295.892602684942;4498.775061246941;4502.527234640364;4502.797374118156;4509.413776209089;4329.415528903589;4365.388845561624;4421.646268298528;4428.6014258716705;4453;4414.911701765979;4415.955840441603;4418.094290670405;4426;4435.445569303837;3919.431682406064;3962.980185099085;3966.186931678999;3966.206758648253;3970.68234541236;5449.945500544984;5508.504234618864;5526.447355264441;5546.750396232179;5562.721863906829;5189.55888749453;5197.168453047494;5197.818076367347;5202.869928251824;5207.218917162456;6082.9695851520455;6099.603525770811;6110.297315808694;6121.969390153065;6130.080487926802;4392.428984232061;4398.296272596402;4402.3396490526675;4411.492678341968;4414.3378493225955;6214.161088253073;6334.398232167937;6402.359764023607;6407.647579383132;6415.262244841856;4486.798094085774;4486.820527178941;4491.595756381876;4497.617702495325;4499.167653984024;4557.043020965634;4559.065391594715;4562.840300589463;4564.018735971716;4570.702904311275;5184.922226166535;5194.844154675366;5200.193969934666;5202.7918883245;5208.296879921162;5948.434898684618;6140.416660417253;6166.260048794084;6184.628922264678;6184.938150618526;1547.8993865398713;1566.843315668424;1569.050724311775;1569.0585648610743;1570.1442713721049;1037.4864442101057;1038.9636362727267;1052.8157572424948;1055.5935964653663;1057.4924036462542;5846.269216347957;5854.5901786875365;5862.413758624103;5866.765329386777;5867.559933005042;6298.433141017331;6323.114763933053;6331.113644089831;6333.493320534346;6335.778247761306;5680.602357834912;5789.507891829242;5790.826275211751;5901.911471327933;5952.404759524013;3423.3837909176586;3451.0682115828586;3453.0849324928913;3453.5165076889257;3463.7575369723877;6697.062411262427;6709.127813384229;6712.765053223114;6716.496262780213;6726.159230096238;6341.524385671001;6563.048357988065;6580.703868325937;6583.637899915455;6598.868022639616;6688.33116688337;6694.665266736643;6706.26231114577;6708.865822683519;6717.664116794239;6435.1312572803945;6436.742530298736;6436.871262574628;6440.742370305323;6448.226212854487;6265.102933721762;6307.653079080695;6350.7777227796805;6351.333110023381;6352.0789485525265;6669.733210671713;6677.432418244503;6689.364510371507;6689.632070236184;6771.119754431892;4403.801828917771;4429.68992170545;4435.356873253425;4435.556444355539;4441.244988352052;6227.750889964351;6407.9038814418755;6423.486121110206;6431.774887878902;6432.935670643234;6261.311255761953;6262.686865656608;6270.278917924315;6271.62370257786;6273.435390814849;6180.907286390798;6241.157443745036;6255.24937007562;6256.874862502816;6257.5932564383165;5990.7903223386975;6087.512998960161;6100.023996160593;6138.600990935575;6179.62922224668;6252.062190671254;6252.124702541557;6254.8123556293385;6254.906176407267;6257.812265632038;6090.969545152246;6105.6947152641305;6126.019836826086;6137.1101190328045;6137.171481850071 04:15:16 INFO - PROCESS | 24585 | |5;yui.html;766.6205228411937;824.8267863748613;829.759369782763;833.9999999999997;848.4951453884936;12382.504699812009;12482.37588120595;12487.250764954098;12507.124501284914;12518.749625007506;12600.621981340551;12630.81053784194;12644.810327845067;12649.557265495709;12659.240445573272;655.6983787457763;667.6027763480746;789.1516619633887;810.3881569415083;810.6797814863125;806.5765473126597;810.4772421787943;812.5815205169342;814.4339683919678;816.9869361991148;688.0917189310113;833.6665333866472;833.9791505212388;834.1241696218976;834.2200042959821;690.1717938473827;817.7873752824279;830.0330115415534;831.1729828820302;832.4048305461624;613.2518327640272;616.9136320915076;617.2099712368176;617.3764497857196;617.6973283091253;12857.485700571966;12890.291033993126;12967.805482917764;12978.675533111653;12999.415026323839;11472.71318217043;11948.163628546004;12046.759064818742;12177.33024683642;12437.512497500446;9827.164691001273;9866.80266394668;9941.789062733957;10049.648262310857;10101.040401161878;3579.2304654499408;3600.6039335673054;3684.1342284563107;3690.538682664667;3777.263433630443;42880.571194288284;42939.57060429387;43009.13981720348;43572;45476.545234547564;9755.951220243995;9927.702168934944;9945.104940555384;10037.749056273506;10127.898721012696;16366.836331636769;16379.918100409423;16426.507204783877;16445.177741113137;16473.505794826175;7271.966360429649;7330.266973302733;7388.852222955511;7442.479026468095;7451.180370159278;3822.140018495816;3865.40086286626;3882.1265215326325;3912.726109172331;3933.3903244997073;2914.111196085172;2951.099914526047;2959.05310300706;2973.9553906691417;2978.791484596101;539.9838004859782;549.7974299704239;559.7900787204799;564.9858753531113;565.2087078090624;541.8239072301518;573.9655620662774;583.6177303865975;583.9358067847743;616.0881894795638;7997.6800927963395;8022.719204827803;8053.296659491331;8056.436049476481;8319.792005199919;467.7357293129371;486.3750081145711;518.4659800405589;549.8982688202695;573.8135106090538;3366.73066154707;3378.290558982592;3430.9313813723584;3443.6556344365363;3458.8443520041155;50606.746966265666;51883;52007.47992520102;52231.47768522342;52356;46310.305345419845;47027.29459058117;47194;47345;47803.5219647806;41517.1696566067;41667.1666566673;41895.37156942648;42117;42720.78639606782;6792.76225332111;6851.8972215415815;6867.3476019778045;6960.79117626472;7057.964710176417;31957.36085278328;32950.83524582362;33722;33722.49416258709;33823.83088084544;43232.13535729205;44426;45168.77415613033;47005;48151.27773083337;10190;10474.371537707762;10616;10620.734481638021;10781.514831832743;10698.572057117628;10816.242862999829;10817.080548153495;11195;11993.880061199276;10495.895041049493;10767.6231331903;10882.891171088504;10936.12510999134;11277.661670149908;10764.40268936279;10870.29343092728;11113.944430278121;11195.552177912792;11417.029552488131;10021.749456263651;10049;10079.546420410952;10172.643957461454;10380.32527885685;8891.422057566237;9070.637174512945;9138.771530711785;9219.677311294072;9277.443353398818;8493.447925884797;8810.207081362709;8997.190252877272;9511.19154871816;9667.806643867223 04:15:16 INFO - PROCESS | 24585 | __end_tp_report 04:15:16 INFO - PROCESS | 24585 | __start_cc_report 04:15:16 INFO - PROCESS | 24585 | _x_x_mozilla_cycle_collect,1042 04:15:16 INFO - PROCESS | 24585 | __end_cc_report 04:15:16 INFO - PROCESS | 24585 | __startTimestamp1452168916824__endTimestamp 04:15:16 INFO - PROCESS | 24585 | 04:15:16 INFO - PROCESS | 24585 | ------- Summary: start ------- 04:15:16 INFO - PROCESS | 24585 | Number of tests: 6 04:15:16 INFO - PROCESS | 24585 | 04:15:16 INFO - PROCESS | 24585 | [#0] dojo.html Cycles:165 Average:5276.08 Median:5524.28 stddev:571.29 (10.3%) stddev-sans-first:548.89 04:15:16 INFO - PROCESS | 24585 | Values: 3181.0 3255.3 3297.0 3299.9 3320.2 5124.2 5220.0 5329.8 5374.4 5444.9 5204.8 5217.7 5257.7 5330.7 5380.9 4753.4 4753.6 4763.9 4808.3 4813.3 4810.7 4857.6 4860.4 4943.6 4973.9 4720.5 4810.6 4830.3 4848.9 4877.7 4793.0 4814.2 4825.0 4831.5 4867.0 4782.9 4797.9 4800.9 4805.7 4872.4 4944.1 4995.3 5045.2 5099.2 5200.3 5624.4 5625.9 5631.5 5634.1 5651.1 5638.8 5654.2 5661.5 5665.5 5667.7 5145.6 5230.0 5238.5 5265.7 5287.4 5829.1 5885.7 5888.7 5901.7 5945.0 5621.8 5642.2 5645.4 5678.6 5704.3 5499.8 5613.6 5690.5 5727.8 5743.0 5550.5 5581.9 5612.7 5656.1 5704.6 5594.3 5596.6 5617.3 5619.3 5627.6 4285.2 4366.1 4372.1 4374.7 4430.5 3963.4 3991.0 4023.5 4037.3 4038.4 5285.9 5287.9 5325.4 5326.8 5381.6 5642.4 5719.5 5727.8 5728.2 5734.1 5319.5 5323.2 5335.0 5339.1 5384.5 4737.6 4841.1 4893.5 4894.9 4904.1 5859.5 5860.2 5862.3 5867.7 5906.3 5622.2 5626.9 5629.0 5633.2 5651.9 5762.6 5786.8 5797.0 5907.8 5919.7 5609.9 5650.2 5713.3 5722.8 5727.6 5701.7 5728.5 5729.1 5731.3 5742.4 5423.5 5526.9 5532.0 5589.3 5608.2 5458.8 5588.0 5589.3 5598.3 5642.2 5500.5 5521.2 5524.3 5525.8 5527.5 5500.8 5557.3 5582.6 5629.6 5635.9 5492.3 5557.7 5559.7 5564.2 5614.1 04:15:16 INFO - PROCESS | 24585 | 04:15:16 INFO - PROCESS | 24585 | [#1] ext.html Cycles:180 Average:41536.58 Median:174433.60 stddev:68494.33 (39.3%) stddev-sans-first:68617.29 04:15:16 INFO - PROCESS | 24585 | Values: 533.7 536.7 541.4 565.0 576.8 27665.0 28387.6 34783.0 34851.0 34932.7 37414.0 37837.2 37944.0 37945.8 37980.2 8335.0 8541.2 8551.1 8552.5 8553.5 7411.7 7607.9 9859.6 10133.9 10147.9 9807.2 9898.5 9903.5 9907.8 9912.2 7414.6 7601.4 9781.2 9886.1 9890.7 9765.4 10035.5 10036.2 10051.1 10052.8 35511.0 36049.5 36088.6 36225.6 36249.8 3284.3 3860.4 3864.4 3864.7 3927.5 27034.7 27522.7 28153.0 29497.9 29977.4 3426.3 3454.8 3502.6 3531.2 3579.9 259313.0 261185.0 261390.7 261415.0 265151.0 50585.7 51390.5 56122.0 56571.0 57017.7 51405.2 51883.5 52077.5 52099.7 52131.0 12654.4 12730.5 12730.9 12734.7 12775.9 10444.6 10496.5 10520.4 10524.7 10529.7 18103.0 18709.5 18835.7 18838.4 18894.2 7469.3 7745.8 7840.5 7869.6 7869.8 929.3 961.2 978.8 1027.0 1034.2 27368.9 27414.0 27776.6 28155.0 28205.6 1013.6 1021.4 1098.9 1115.7 1137.6 14287.0 14469.7 14573.9 14730.2 14773.7 311811.0 313696.0 314379.0 317230.0 317453.0 50545.5 50571.7 50881.0 51111.5 51208.7 1245.5 1294.4 1298.4 1299.0 1325.9 22247.4 27678.7 28098.4 28158.3 28559.4 44275.0 44825.0 44903.6 44966.3 45143.0 194456.0 195628.0 195957.0 195964.0 196075.0 26969.9 27275.9 29017.6 30327.5 30427.0 34865.5 35756.1 35809.5 35985.1 36503.5 28490.7 28678.3 28812.9 28852.0 29033.9 29150.4 31287.5 31637.2 32570.0 33083.2 34541.8 34607.8 34849.1 35137.1 35530.8 25859.0 25909.7 28050.9 28536.9 28896.7 22492.9 22692.2 22877.4 22954.5 23960.3 04:15:16 INFO - PROCESS | 24585 | 04:15:16 INFO - PROCESS | 24585 | [#2] jquery.html Cycles:180 Average:26969.06 Median:4437.67 stddev:87337.39 (1968.1%) stddev-sans-first:87559.53 04:15:16 INFO - PROCESS | 24585 | Values: 353.9 354.6 356.3 356.7 357.4 13312.4 13760.7 16050.1 16533.7 17909.6 16088.7 16098.8 16420.4 16586.3 16617.1 4540.6 4767.2 4768.9 4770.1 4773.9 3791.4 4200.6 4714.3 5524.5 5543.0 5506.6 5522.8 5547.2 5551.0 5564.5 5830.2 5872.2 5888.1 5892.1 5893.6 4994.9 5165.3 5196.9 5207.0 5210.6 12089.4 12288.4 13948.8 19146.4 19148.5 2003.1 2050.1 2097.7 2104.1 2238.1 9286.3 9448.7 9466.5 11535.4 12489.2 1782.2 1791.8 1792.9 1793.2 1878.6 50939.5 51013.7 51846.0 53798.5 57582.4 9147.5 9506.0 9810.5 9897.5 9900.2 12818.8 12833.9 12841.7 12848.4 12851.4 6691.1 6902.5 6976.0 7005.4 7062.6 6737.1 6747.3 6747.5 6788.4 6805.1 3986.5 4014.4 4030.5 4137.4 4334.7 1719.7 1722.3 1829.6 1835.9 1838.9 897.1 901.9 907.5 1029.3 1065.8 13746.7 15863.6 16590.0 16890.2 17448.9 855.5 921.2 923.1 940.9 982.5 8839.4 8960.3 9086.4 9118.0 9199.1 531357.0 533448.0 535102.0 536290.0 537885.0 68993.8 71123.6 72509.6 72582.0 74687.0 1008.7 1020.6 1110.3 1133.2 1193.9 14508.8 14656.7 14834.6 15002.4 15077.2 30306.4 30493.5 31694.7 33342.8 34077.3 37952.4 39741.0 40432.4 40990.4 41428.0 6855.7 7012.8 7111.4 7281.7 7437.3 10785.3 11293.2 11523.4 11688.1 11793.1 9588.8 9960.0 9979.6 10132.6 10423.4 9604.0 9766.3 9869.8 9985.6 10368.3 9999.5 10323.4 10338.8 10411.5 10419.4 7284.6 7287.6 7336.6 7367.0 7589.3 9137.2 9393.3 10021.2 10287.4 10300.0 04:15:16 INFO - PROCESS | 24585 | 04:15:16 INFO - PROCESS | 24585 | [#3] mootools.html Cycles:180 Average:5209.74 Median:6197.04 stddev:2613.31 (42.2%) stddev-sans-first:2604.40 04:15:16 INFO - PROCESS | 24585 | Values: 1334.5 1470.7 1483.0 1604.6 1761.1 6479.2 7130.4 7206.1 7215.6 7222.5 7174.6 7336.6 7337.5 7339.4 7348.8 1972.2 2019.1 2019.3 2240.6 2269.2 2029.7 2232.8 2277.9 2285.2 2286.3 2227.8 2263.8 2267.5 2267.8 2303.7 2222.4 2236.2 2242.3 2246.2 2246.8 2193.7 2254.9 2260.7 2261.6 2263.8 7395.2 7414.3 7438.9 7442.7 7485.7 4528.8 4561.7 4593.4 4606.1 4610.9 2910.4 3113.1 3115.1 3125.9 3141.4 965.4 978.2 986.6 1006.3 1017.7 10012.6 10018.9 10026.5 10032.5 10033.6 4158.5 4219.5 4238.9 4280.9 4287.4 8668.5 8671.1 8673.9 8676.4 8689.9 4646.8 4666.2 4673.9 4674.4 4680.4 4188.8 4258.1 4259.2 4259.4 4259.7 3332.9 3554.3 3559.0 3578.8 3611.3 1106.7 1196.4 1201.7 1207.6 1217.3 1285.1 1292.7 1319.3 1343.6 1347.6 6696.3 6811.3 6812.8 6815.1 6833.5 1085.8 1100.7 1104.6 1116.0 1122.1 5587.9 5603.4 5625.0 5626.5 5631.7 8644.3 8686.2 8820.8 8935.7 8968.5 8834.2 8834.5 8838.0 8845.7 8846.4 6863.9 7036.4 7055.2 7089.0 7105.8 6834.2 6836.6 6858.4 6864.7 6872.2 7423.5 7719.1 7742.7 7752.1 8074.3 7771.7 7869.8 8037.9 8176.4 8185.9 6672.6 6707.4 6780.5 6784.5 6805.0 6194.9 6338.2 6824.8 6832.0 6886.2 6586.5 6627.0 6636.0 6709.6 6769.1 6567.8 6572.7 6622.1 6685.9 6690.1 6700.6 6720.6 6743.2 6772.3 6775.7 6199.1 6210.8 6216.1 6217.8 6238.3 6032.9 6107.7 6111.7 6349.0 6383.3 04:15:16 INFO - PROCESS | 24585 | 04:15:16 INFO - PROCESS | 24585 | [#4] prototype.html Cycles:180 Average:5188.87 Median:5826.92 stddev:1556.49 (26.7%) stddev-sans-first:1517.58 04:15:16 INFO - PROCESS | 24585 | Values: 333.1 337.6 340.9 342.9 344.2 5744.7 5792.0 5807.6 5857.0 5862.1 5548.0 5600.6 5671.8 5743.3 5783.0 4466.6 4492.9 4497.8 4508.0 4523.7 4295.9 4498.8 4502.5 4502.8 4509.4 4329.4 4365.4 4421.6 4428.6 4453.0 4414.9 4416.0 4418.1 4426.0 4435.4 3919.4 3963.0 3966.2 3966.2 3970.7 5449.9 5508.5 5526.4 5546.8 5562.7 5189.6 5197.2 5197.8 5202.9 5207.2 6083.0 6099.6 6110.3 6122.0 6130.1 4392.4 4398.3 4402.3 4411.5 4414.3 6214.2 6334.4 6402.4 6407.6 6415.3 4486.8 4486.8 4491.6 4497.6 4499.2 4557.0 4559.1 4562.8 4564.0 4570.7 5184.9 5194.8 5200.2 5202.8 5208.3 5948.4 6140.4 6166.3 6184.6 6184.9 1547.9 1566.8 1569.1 1569.1 1570.1 1037.5 1039.0 1052.8 1055.6 1057.5 5846.3 5854.6 5862.4 5866.8 5867.6 6298.4 6323.1 6331.1 6333.5 6335.8 5680.6 5789.5 5790.8 5901.9 5952.4 3423.4 3451.1 3453.1 3453.5 3463.8 6697.1 6709.1 6712.8 6716.5 6726.2 6341.5 6563.0 6580.7 6583.6 6598.9 6688.3 6694.7 6706.3 6708.9 6717.7 6435.1 6436.7 6436.9 6440.7 6448.2 6265.1 6307.7 6350.8 6351.3 6352.1 6669.7 6677.4 6689.4 6689.6 6771.1 4403.8 4429.7 4435.4 4435.6 4441.2 6227.8 6407.9 6423.5 6431.8 6432.9 6261.3 6262.7 6270.3 6271.6 6273.4 6180.9 6241.2 6255.2 6256.9 6257.6 5990.8 6087.5 6100.0 6138.6 6179.6 6252.1 6252.1 6254.8 6254.9 6257.8 6091.0 6105.7 6126.0 6137.1 6137.2 04:15:16 INFO - PROCESS | 24585 | 04:15:16 INFO - PROCESS | 24585 | [#5] yui.html Cycles:180 Average:12895.49 Median:45322.66 stddev:14790.30 (32.6%) stddev-sans-first:14803.75 04:15:16 INFO - PROCESS | 24585 | Values: 766.6 824.8 829.8 834.0 848.5 12382.5 12482.4 12487.3 12507.1 12518.7 12600.6 12630.8 12644.8 12649.6 12659.2 655.7 667.6 789.2 810.4 810.7 806.6 810.5 812.6 814.4 817.0 688.1 833.7 834.0 834.1 834.2 690.2 817.8 830.0 831.2 832.4 613.3 616.9 617.2 617.4 617.7 12857.5 12890.3 12967.8 12978.7 12999.4 11472.7 11948.2 12046.8 12177.3 12437.5 9827.2 9866.8 9941.8 10049.6 10101.0 3579.2 3600.6 3684.1 3690.5 3777.3 42880.6 42939.6 43009.1 43572.0 45476.5 9756.0 9927.7 9945.1 10037.7 10127.9 16366.8 16379.9 16426.5 16445.2 16473.5 7272.0 7330.3 7388.9 7442.5 7451.2 3822.1 3865.4 3882.1 3912.7 3933.4 2914.1 2951.1 2959.1 2974.0 2978.8 540.0 549.8 559.8 565.0 565.2 541.8 574.0 583.6 583.9 616.1 7997.7 8022.7 8053.3 8056.4 8319.8 467.7 486.4 518.5 549.9 573.8 3366.7 3378.3 3430.9 3443.7 3458.8 50606.7 51883.0 52007.5 52231.5 52356.0 46310.3 47027.3 47194.0 47345.0 47803.5 41517.2 41667.2 41895.4 42117.0 42720.8 6792.8 6851.9 6867.3 6960.8 7058.0 31957.4 32950.8 33722.0 33722.5 33823.8 43232.1 44426.0 45168.8 47005.0 48151.3 10190.0 10474.4 10616.0 10620.7 10781.5 10698.6 10816.2 10817.1 11195.0 11993.9 10495.9 10767.6 10882.9 10936.1 11277.7 10764.4 10870.3 11113.9 11195.6 11417.0 10021.7 10049.0 10079.5 10172.6 10380.3 8891.4 9070.6 9138.8 9219.7 9277.4 8493.4 8810.2 8997.2 9511.2 9667.8 04:15:16 INFO - PROCESS | 24585 | -------- Summary: end -------- 04:15:16 INFO - PROCESS | 24585 | 04:15:17 INFO - TEST-INFO | 24585: exit 0 04:15:17 INFO - TEST-OK | dromaeo_css | took 1112828ms 04:15:17 INFO - TEST-START | kraken 04:15:17 INFO - operating with platform_type : linux_ 04:15:17 INFO - Initialising browser for kraken test... 04:15:17 INFO - TEST-INFO | started process 24778 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVBWpNp/profile http://localhost:43066/getInfo.html) 04:15:21 INFO - PROCESS | 24778 | __metrics Screen width/height:1600/1200 04:15:21 INFO - PROCESS | 24778 | colorDepth:24 04:15:21 INFO - PROCESS | 24778 | Browser inner width/height: 1024/697 04:15:21 INFO - PROCESS | 24778 | __metrics 04:15:21 INFO - PROCESS | 24778 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:15:21 INFO - PROCESS | 24778 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:15:22 INFO - TEST-INFO | 24778: exit 0 04:15:22 INFO - Browser initialized. 04:15:22 INFO - Running cycle 1/1 for kraken test... 04:15:22 INFO - TEST-INFO | started process 24861 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVBWpNp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:33 INFO - PROCESS | 24861 | RSS: Main: 150343680 04:15:33 INFO - PROCESS | 24861 | 04:15:36 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43066/tests/kraken/driver.html?testName=audio-beat-detection) 04:15:37 INFO - PROCESS | 24861 | RSS: Main: 187756544 04:15:37 INFO - PROCESS | 24861 | 04:15:39 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43066/tests/kraken/driver.html?testName=audio-dft) 04:15:40 INFO - PROCESS | 24861 | RSS: Main: 176869376 04:15:40 INFO - PROCESS | 24861 | 04:15:43 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43066/tests/kraken/driver.html?testName=audio-fft) 04:15:43 INFO - PROCESS | 24861 | RSS: Main: 162586624 04:15:43 INFO - PROCESS | 24861 | 04:15:45 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43066/tests/kraken/driver.html?testName=audio-oscillator) 04:15:46 INFO - PROCESS | 24861 | RSS: Main: 164900864 04:15:46 INFO - PROCESS | 24861 | 04:15:48 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43066/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:15:49 INFO - PROCESS | 24861 | RSS: Main: 164290560 04:15:49 INFO - PROCESS | 24861 | 04:15:52 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43066/tests/kraken/driver.html?testName=imaging-darkroom) 04:15:52 INFO - PROCESS | 24861 | RSS: Main: 164835328 04:15:52 INFO - PROCESS | 24861 | 04:15:55 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43066/tests/kraken/driver.html?testName=imaging-desaturate) 04:15:56 INFO - PROCESS | 24861 | RSS: Main: 167469056 04:15:56 INFO - PROCESS | 24861 | 04:15:59 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43066/tests/kraken/driver.html?testName=json-parse-financial) 04:15:59 INFO - PROCESS | 24861 | RSS: Main: 167432192 04:15:59 INFO - PROCESS | 24861 | 04:16:01 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43066/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:16:01 INFO - PROCESS | 24861 | RSS: Main: 177922048 04:16:01 INFO - PROCESS | 24861 | 04:16:03 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:16:04 INFO - PROCESS | 24861 | RSS: Main: 174956544 04:16:04 INFO - PROCESS | 24861 | 04:16:06 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:16:06 INFO - PROCESS | 24861 | RSS: Main: 183382016 04:16:06 INFO - PROCESS | 24861 | 04:16:09 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:16:09 INFO - PROCESS | 24861 | RSS: Main: 190844928 04:16:09 INFO - PROCESS | 24861 | 04:16:12 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:16:13 INFO - PROCESS | 24861 | RSS: Main: 190529536 04:16:13 INFO - PROCESS | 24861 | 04:16:14 INFO - PROCESS | 24861 | Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43066/tests/kraken/driver.html?testName=ai-astar) 04:16:15 INFO - PROCESS | 24861 | RSS: Main: 248004608 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | __start_tp_report 04:16:15 INFO - PROCESS | 24861 | _x_x_mozilla_page_load 04:16:15 INFO - PROCESS | 24861 | _x_x_mozilla_page_load_details 04:16:15 INFO - PROCESS | 24861 | |i|pagename|runs| 04:16:15 INFO - PROCESS | 24861 | |0;ai-astar;109;110;104;111;111;112;100;111;111;111 04:16:15 INFO - PROCESS | 24861 | |1;audio-beat-detection;153;129;151;162;124;165;153;128;166;125 04:16:15 INFO - PROCESS | 24861 | |2;audio-dft;161;162;162;161;162;162;161;163;163;162 04:16:15 INFO - PROCESS | 24861 | |3;audio-fft;75;71;83;97;71;73;74;102;91;72 04:16:15 INFO - PROCESS | 24861 | |4;audio-oscillator;97;96;137;96;96;96;149;96;97;150 04:16:15 INFO - PROCESS | 24861 | |5;imaging-gaussian-blur;109;109;110;110;110;110;109;110;109;109 04:16:15 INFO - PROCESS | 24861 | |6;imaging-darkroom;146;146;147;148;144;145;145;145;146;145 04:16:15 INFO - PROCESS | 24861 | |7;imaging-desaturate;96;95;96;95;96;95;96;95;95;96 04:16:15 INFO - PROCESS | 24861 | |8;json-parse-financial;56;57;57;57;58;57;58;66;54;55 04:16:15 INFO - PROCESS | 24861 | |9;json-stringify-tinderbox;68;67;67;67;67;68;68;67;67;67 04:16:15 INFO - PROCESS | 24861 | |10;stanford-crypto-aes;84;84;83;85;85;85;86;93;84;85 04:16:15 INFO - PROCESS | 24861 | |11;stanford-crypto-ccm;125;116;118;114;120;119;127;116;121;120 04:16:15 INFO - PROCESS | 24861 | |12;stanford-crypto-pbkdf2;146;148;155;151;152;141;151;154;150;140 04:16:15 INFO - PROCESS | 24861 | |13;stanford-crypto-sha256-iterative;70;72;70;71;67;68;68;69;67;68 04:16:15 INFO - PROCESS | 24861 | __end_tp_report 04:16:15 INFO - PROCESS | 24861 | __start_cc_report 04:16:15 INFO - PROCESS | 24861 | _x_x_mozilla_cycle_collect,924 04:16:15 INFO - PROCESS | 24861 | __end_cc_report 04:16:15 INFO - PROCESS | 24861 | __startTimestamp1452168975131__endTimestamp 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | ------- Summary: start ------- 04:16:15 INFO - PROCESS | 24861 | Number of tests: 14 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:3.89 (3.5%) stddev-sans-first:4.12 04:16:15 INFO - PROCESS | 24861 | Values: 109.0 110.0 104.0 111.0 111.0 112.0 100.0 111.0 111.0 111.0 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:153.00 stddev:17.24 (11.3%) stddev-sans-first:18.08 04:16:15 INFO - PROCESS | 24861 | Values: 153.0 129.0 151.0 162.0 124.0 165.0 153.0 128.0 166.0 125.0 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 04:16:15 INFO - PROCESS | 24861 | Values: 161.0 162.0 162.0 161.0 162.0 162.0 161.0 163.0 163.0 162.0 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#3] audio-fft Cycles:10 Average:80.90 Median:74.50 stddev:11.69 (15.7%) stddev-sans-first:12.21 04:16:15 INFO - PROCESS | 24861 | Values: 75.0 71.0 83.0 97.0 71.0 73.0 74.0 102.0 91.0 72.0 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:96.00 stddev:23.94 (24.9%) stddev-sans-first:24.85 04:16:15 INFO - PROCESS | 24861 | Values: 97.0 96.0 137.0 96.0 96.0 96.0 149.0 96.0 97.0 150.0 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:16:15 INFO - PROCESS | 24861 | Values: 109.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 04:16:15 INFO - PROCESS | 24861 | Values: 146.0 146.0 147.0 148.0 144.0 145.0 145.0 145.0 146.0 145.0 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:16:15 INFO - PROCESS | 24861 | Values: 96.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:3.24 (5.7%) stddev-sans-first:3.39 04:16:15 INFO - PROCESS | 24861 | Values: 56.0 57.0 57.0 57.0 58.0 57.0 58.0 66.0 54.0 55.0 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 04:16:15 INFO - PROCESS | 24861 | Values: 68.0 67.0 67.0 67.0 67.0 68.0 68.0 67.0 67.0 67.0 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:2.80 (3.3%) stddev-sans-first:2.92 04:16:15 INFO - PROCESS | 24861 | Values: 84.0 84.0 83.0 85.0 85.0 85.0 86.0 93.0 84.0 85.0 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:120.00 stddev:4.03 (3.4%) stddev-sans-first:3.77 04:16:15 INFO - PROCESS | 24861 | Values: 125.0 116.0 118.0 114.0 120.0 119.0 127.0 116.0 121.0 120.0 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:151.00 stddev:5.09 (3.4%) stddev-sans-first:5.30 04:16:15 INFO - PROCESS | 24861 | Values: 146.0 148.0 155.0 151.0 152.0 141.0 151.0 154.0 150.0 140.0 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - PROCESS | 24861 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.70 (2.4%) stddev-sans-first:1.76 04:16:15 INFO - PROCESS | 24861 | Values: 70.0 72.0 70.0 71.0 67.0 68.0 68.0 69.0 67.0 68.0 04:16:15 INFO - PROCESS | 24861 | -------- Summary: end -------- 04:16:15 INFO - PROCESS | 24861 | 04:16:15 INFO - TEST-INFO | 24861: exit 0 04:16:15 INFO - TEST-OK | kraken | took 58409ms 04:16:15 INFO - TEST-START | v8_7 04:16:15 INFO - operating with platform_type : linux_ 04:16:15 INFO - Initialising browser for v8_7 test... 04:16:15 INFO - TEST-INFO | started process 25112 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNuYjBt/profile http://localhost:43066/getInfo.html) 04:16:19 INFO - PROCESS | 25112 | __metrics Screen width/height:1600/1200 04:16:19 INFO - PROCESS | 25112 | colorDepth:24 04:16:19 INFO - PROCESS | 25112 | Browser inner width/height: 1024/697 04:16:19 INFO - PROCESS | 25112 | __metrics 04:16:19 INFO - PROCESS | 25112 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:16:19 INFO - PROCESS | 25112 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:16:20 INFO - PROCESS | 25112 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:16:20 INFO - TEST-INFO | 25112: exit 0 04:16:20 INFO - Browser initialized. 04:16:20 INFO - Running cycle 1/1 for v8_7 test... 04:16:20 INFO - TEST-INFO | started process 25197 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNuYjBt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:32 INFO - PROCESS | 25197 | RSS: Main: 147611648 04:16:32 INFO - PROCESS | 25197 | 04:16:55 INFO - PROCESS | 25197 | Cycle 1(1): loaded http://localhost:43066/tests/v8_7/run.html (next: http://localhost:43066/tests/v8_7/run.html) 04:16:55 INFO - PROCESS | 25197 | RSS: Main: 565743616 04:16:55 INFO - PROCESS | 25197 | 04:16:55 INFO - PROCESS | 25197 | __start_tp_report 04:16:55 INFO - PROCESS | 25197 | _x_x_mozilla_page_load 04:16:55 INFO - PROCESS | 25197 | _x_x_mozilla_page_load_details 04:16:55 INFO - PROCESS | 25197 | |i|pagename|runs| 04:16:55 INFO - PROCESS | 25197 | |0;Richards;168.12373907195695 04:16:55 INFO - PROCESS | 25197 | |1;DeltaBlue;190.3311762466692 04:16:55 INFO - PROCESS | 25197 | |2;Encrypt;284.9002849002849 04:16:55 INFO - PROCESS | 25197 | |3;Decrypt;5159.79381443299 04:16:55 INFO - PROCESS | 25197 | |4;RayTrace;1960.7843137254902 04:16:55 INFO - PROCESS | 25197 | |5;Earley;805.8017727639001 04:16:55 INFO - PROCESS | 25197 | |6;Boyer;12345.67901234568 04:16:55 INFO - PROCESS | 25197 | |7;RegExp;41653.06122448979 04:16:55 INFO - PROCESS | 25197 | |8;Splay;562.7462014631401 04:16:55 INFO - PROCESS | 25197 | |9;NavierStokes;4835.748792270531 04:16:55 INFO - PROCESS | 25197 | __end_tp_report 04:16:55 INFO - PROCESS | 25197 | __startTimestamp1452169015272__endTimestamp 04:16:55 INFO - PROCESS | 25197 | 04:16:55 INFO - PROCESS | 25197 | ------- Summary: start ------- 04:16:55 INFO - PROCESS | 25197 | Number of tests: 10 04:16:55 INFO - PROCESS | 25197 | 04:16:55 INFO - PROCESS | 25197 | [#0] Richards Cycles:1 Average:168.12 Median:168.12 stddev:0.00 (0.0%) 04:16:55 INFO - PROCESS | 25197 | Values: 168.1 04:16:55 INFO - PROCESS | 25197 | 04:16:55 INFO - PROCESS | 25197 | [#1] DeltaBlue Cycles:1 Average:190.33 Median:190.33 stddev:0.00 (0.0%) 04:16:55 INFO - PROCESS | 25197 | Values: 190.3 04:16:55 INFO - PROCESS | 25197 | 04:16:55 INFO - PROCESS | 25197 | [#2] Encrypt Cycles:1 Average:284.90 Median:284.90 stddev:0.00 (0.0%) 04:16:55 INFO - PROCESS | 25197 | Values: 284.9 04:16:55 INFO - PROCESS | 25197 | 04:16:55 INFO - PROCESS | 25197 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 04:16:55 INFO - PROCESS | 25197 | Values: 5159.8 04:16:55 INFO - PROCESS | 25197 | 04:16:55 INFO - PROCESS | 25197 | [#4] RayTrace Cycles:1 Average:1960.78 Median:1960.78 stddev:0.00 (0.0%) 04:16:55 INFO - PROCESS | 25197 | Values: 1960.8 04:16:55 INFO - PROCESS | 25197 | 04:16:55 INFO - PROCESS | 25197 | [#5] Earley Cycles:1 Average:805.80 Median:805.80 stddev:0.00 (0.0%) 04:16:55 INFO - PROCESS | 25197 | Values: 805.8 04:16:55 INFO - PROCESS | 25197 | 04:16:55 INFO - PROCESS | 25197 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 04:16:55 INFO - PROCESS | 25197 | Values: 12345.7 04:16:55 INFO - PROCESS | 25197 | 04:16:55 INFO - PROCESS | 25197 | [#7] RegExp Cycles:1 Average:41653.06 Median:41653.06 stddev:0.00 (0.0%) 04:16:55 INFO - PROCESS | 25197 | Values: 41653.1 04:16:55 INFO - PROCESS | 25197 | 04:16:55 INFO - PROCESS | 25197 | [#8] Splay Cycles:1 Average:562.75 Median:562.75 stddev:0.00 (0.0%) 04:16:55 INFO - PROCESS | 25197 | Values: 562.7 04:16:55 INFO - PROCESS | 25197 | 04:16:55 INFO - PROCESS | 25197 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 04:16:55 INFO - PROCESS | 25197 | Values: 4835.7 04:16:55 INFO - PROCESS | 25197 | -------- Summary: end -------- 04:16:55 INFO - PROCESS | 25197 | 04:16:56 INFO - TEST-INFO | 25197: exit 0 04:16:56 INFO - TEST-OK | v8_7 | took 40141ms 04:16:56 INFO - SUITE-END | took 1211s 04:16:56 INFO - Completed test suite (00:20:11) 04:16:56 INFO - Working with test: dromaeo_css 04:16:56 INFO - Generating results file: dromaeo_css 04:16:56 INFO - Working with test: kraken 04:16:56 INFO - Generating results file: kraken 04:16:56 INFO - javascript benchmark 04:16:56 INFO - Working with test: v8_7 04:16:56 INFO - Generating results file: v8_7 04:16:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:16:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 04:16:56 INFO - process_Request line: dromaeo_css 6658.14 graph.html#tests=[[72,63,35]] 04:16:56 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:16:56 INFO - process_Request line: kraken 1506.70 graph.html#tests=[[232,63,35]] 04:16:56 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:16:56 INFO - process_Request line: v8_7 18980.17 graph.html#tests=[[230,63,35]] 04:16:56 INFO - RETURN: dromaeo_css: 6658.14 04:16:56 INFO - RETURN: kraken: 1506.70 04:16:56 INFO - RETURN: v8_7: 18980.17 04:16:56 INFO - javascript benchmark 04:16:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3180.9840950795246, 3255.251292202795, 3296.9670303296975, 3299.9340013199735, 3320.2363456405033, 5124.180131179012, 5219.973900130503, 5329.786808527659, 5374.381946076202, 5444.863878403042, 5204.843854684365, 5217.660852044624, 5257.737113144337, 5330.706811125397, 5380.946190538103, 4753.405824271966, 4753.595944344726, 4763.90472190556, 4808.302796094564, 4813.253945638432, 4810.663253572251, 4857.6113910887225, 4860.392450943632, 4943.579795717368, 4973.850784476472, 4720.480747117797, 4810.6151507879285, 4830.347903033081, 4848.903021939559, 4877.6829506081995, 4793.041391721669, 4814.181589129857, 4824.98675278192, 4831.4685384607665, 4866.9513304867205, 4782.904341913177, 4797.904041919142, 4800.927986080212, 4805.687630304019, 4872.415310162768, 4944.060628480614, 4995.275685025651, 5045.243213517965, 5099.15863882459, 5200.2979597754575, 5624.353199382042, 5625.8593535161535, 5631.521320687746, 5634.098544232903, 5651.095824668033, 5638.774449022034, 5654.236678048452, 5661.547076233891, 5665.490105890449, 5667.716614169275, 5145.562627176694, 5229.973850130763, 5238.476152384807, 5265.6840589564745, 5287.4448182941005, 5829.067349224104, 5885.705714714333, 5888.705564721832, 5901.675407852524, 5945.0, 5621.775128994795, 5642.23829782974, 5645.435456454322, 5678.602497825195, 5704.3154821421695, 5499.835004949858, 5613.578981576398, 5690.459406356389, 5727.799527016535, 5742.971285143548, 5550.5282051026115, 5581.944180558143, 5612.691301978349, 5656.066748986454, 5704.572157088152, 5594.272744543184, 5596.58025648078, 5617.297837770278, 5619.297587801525, 5627.5779316551425, 4285.228658841376, 4366.061296821199, 4372.0818628088455, 4374.693771436033, 4430.490493593214, 3963.365861462152, 3990.980045099756, 4023.4769479968004, 4037.2934736421007, 4038.3740520218826, 5285.867853303621, 5287.867803304871, 5325.4142044375085, 5326.760295786699, 5381.596380271495, 5642.351129620064, 5719.456651618089, 5727.77088916447, 5728.169415434739, 5734.05388110957, 5319.494648008433, 5323.2015197719875, 5335.0, 5339.065663508871, 5384.515393614593, 4737.59730422911, 4841.104395686809, 4893.510648935078, 4894.853154405374, 4904.117258893362, 5859.501942334864, 5860.150278209636, 5862.296524417097, 5867.70661466925, 5906.26171728534, 5622.184783206494, 5626.887462250814, 5629.043062679272, 5633.2113504110275, 5651.943480565306, 5762.567807414377, 5786.768529258782, 5796.956547821264, 5907.763689452546, 5919.704014799329, 5609.943900561106, 5650.180723795109, 5713.314402271754, 5722.828315150552, 5727.627704199213, 5701.657900525982, 5728.513076388387, 5729.1119876419225, 5731.3408957968695, 5742.397048309867, 5423.457654234545, 5526.944730552643, 5531.9723401382735, 5589.329280486368, 5608.158776183605, 5458.836234912959, 5588.0, 5589.301337332833, 5598.272224610774, 5642.181883626933, 5500.477454641803, 5521.199426083276, 5524.281843360337, 5525.806596769094, 5527.50252477279, 5500.81732427514, 5557.3331200256225, 5582.637128586629, 5629.638478653639, 5635.887282254414, 5492.286002819608, 5557.694326812064, 5559.749811258423, 5564.165375193753, 5614.101743720985], "unit": "score", "name": "dojo.html", "value": 5240.579367416241}, {"lowerIsBetter": false, "replicates": [533.7171299211415, 536.6699479819912, 541.4233840959378, 564.9661020338779, 576.7837061102086, 27664.999999999975, 28387.574186387195, 34783.0, 34851.0, 34932.650673493255, 37414.0, 37837.24325513495, 37944.0, 37945.81027094868, 37980.24039519215, 8334.999999999985, 8541.231289183972, 8551.102134275905, 8552.486850788973, 8553.486790792573, 7411.7035318587195, 7607.885881711779, 9859.605615775396, 10133.94933025334, 10147.898521014806, 9807.215422766198, 9898.455584942825, 9903.45530995795, 9907.801843963116, 9912.207023438144, 7414.555126692416, 7601.39188864895, 9781.217502599811, 9886.110250077527, 9890.653827116052, 9765.365251258645, 10035.498225088717, 10036.24728145392, 10051.095401413908, 10052.798944021151, 35511.0, 36049.45925811115, 36088.63911360879, 36225.63774362249, 36249.81875090607, 3284.26104126572, 3860.415806003652, 3864.439656249828, 3864.671502922255, 3927.509061367329, 27034.729652703616, 27522.724772752415, 28153.0, 29497.852510737524, 29977.400451991056, 3426.3318652862704, 3454.809985450799, 3502.6497350265026, 3531.2231309111953, 3579.928401431957, 259313.0, 261185.0, 261390.69304653545, 261415.0, 265151.0, 50585.747071264406, 51390.48609513857, 56122.0, 56571.0, 57017.71491142601, 51405.22892156621, 51883.48116518862, 52077.47922520802, 52099.739501302254, 52131.0, 12654.367281635881, 12730.490780368682, 12730.936345318214, 12734.68163295925, 12775.936120319338, 10444.582216711398, 10496.527656255334, 10520.421376824348, 10524.736881578021, 10529.736756581147, 18103.0, 18709.532261693294, 18835.71746423805, 18838.434846954613, 18894.244230230637, 7469.290417410337, 7745.845083098419, 7840.490368126054, 7869.563262716678, 7869.763907082796, 929.3215952354819, 961.2166084640995, 978.7797745507346, 1026.9678972632457, 1034.177828626244, 27368.863155684096, 27414.0, 27776.58335124975, 28155.0, 28205.576916346272, 1013.6300250408696, 1021.3616489693941, 1098.9175811814146, 1115.6876074698935, 1137.6188976692736, 14287.0, 14469.710605788036, 14573.854261457462, 14730.189839558712, 14773.704525909636, 311811.0, 313696.0, 314379.0, 317230.0, 317453.0, 50545.49454505481, 50571.74714126406, 50881.0, 51111.488885111416, 51208.74395628073, 1245.483124503321, 1294.411042975444, 1298.4092238031674, 1298.9610311690665, 1325.9204447733166, 22247.44381390478, 27678.723212767614, 28098.438031239668, 28158.2960425991, 28559.42881142407, 44275.0, 44825.0, 44903.550964489936, 44966.325505118104, 45143.0, 194456.0, 195628.0, 195957.0, 195964.0, 196075.0, 26969.865150674123, 27275.86362068177, 29017.56473652939, 30327.545086823273, 30427.0, 34865.47701784526, 35756.10609734777, 35809.46285805767, 35985.100372490895, 36503.45244821383, 28490.715092849634, 28678.283042924093, 28812.85593572019, 28852.0, 29033.85483072571, 29150.416991660473, 31287.515750414113, 31637.209069772518, 32570.0, 33083.195432525565, 34541.82729086339, 34607.82696086504, 34849.12877178091, 35137.121571959884, 35530.822345888104, 25859.0, 25909.740902590733, 28050.859745701142, 28536.85731571329, 28896.7110328894, 22492.88753556222, 22692.20577279787, 22877.42806429786, 22954.54090918206, 23960.28119156428], "unit": "score", "name": "ext.html", "value": 17311.526409406073}, {"lowerIsBetter": false, "replicates": [353.93275277697234, 354.55857457465453, 356.31765169700026, 356.65048252712324, 357.36567592523284, 13312.40094195761, 13760.655983600414, 16050.1172435516, 16533.66932661346, 17909.641807163865, 16088.678226435493, 16098.75851862223, 16420.425285115023, 16586.25361858716, 16617.08606026668, 4540.614047805941, 4767.213409787399, 4768.856934291976, 4770.117528257283, 4773.928391074137, 3791.4312853072124, 4200.642945349649, 4714.292856071583, 5524.530414914737, 5543.0, 5506.614536982413, 5522.806701765439, 5547.1679248112905, 5550.972245138769, 5564.4991950724625, 5830.183774271605, 5872.17789509469, 5888.057910734284, 5892.086726557391, 5893.55798315126, 4994.925076123861, 5165.328507294028, 5196.870078248036, 5207.0, 5210.609204309654, 12089.39553022354, 12288.385580720927, 13948.790768138486, 19146.425607231806, 19148.521286967938, 2003.0885946894127, 2050.0877109686194, 2097.7099084063343, 2104.063691657213, 2238.1271304191214, 9286.349955503118, 9448.716538503855, 9466.535228291605, 11535.423228838608, 12489.18820276679, 1782.2336395349994, 1791.7939436964787, 1792.8744987850855, 1793.2199493220492, 1878.5961018380976, 50939.490605093844, 51013.744931275105, 51846.0, 53798.46201538013, 57582.424175758126, 9147.54262286883, 9506.0, 9810.509474526389, 9897.455639939728, 9900.158486528726, 12818.80771788424, 12833.935830320976, 12841.678958026125, 12848.421821018077, 12851.421686024152, 6691.130153080068, 6902.516823822385, 6975.965120174366, 7005.439564834801, 7062.611556364449, 6737.09049278351, 6747.257801641816, 6747.493937954575, 6788.422984046411, 6805.115335006418, 3986.461827653288, 4014.41790940312, 4030.5163380394542, 4137.379393091061, 4334.718243314174, 1719.6835941786208, 1722.2680360846591, 1829.5974885525163, 1835.9156616883763, 1838.9172487238106, 897.096319033589, 901.9368644194843, 907.5462268865567, 1029.2743615750878, 1065.8081545321916, 13746.725065498835, 15863.603409914844, 16590.0, 16890.155492225585, 17448.91275543614, 855.482433127961, 921.2445794448488, 923.1276443760715, 940.9153176214173, 982.4547376206132, 8839.381243313035, 8960.283177345797, 9086.36395452312, 9118.0, 9199.126083022102, 531357.0, 533448.0, 535102.0, 536290.0, 537885.0, 68993.7659846553, 71123.64438177776, 72509.6374518124, 72582.0, 74687.0, 1008.6620981971122, 1020.642775028734, 1110.2838669058413, 1133.2067552713133, 1193.8686744458103, 14508.839292856757, 14656.70686586241, 14834.554963351116, 15002.399904003718, 15077.170755608107, 30306.393872122873, 30493.54259686151, 31694.683053169174, 33342.83328583342, 34077.318453631284, 37952.43071353987, 39741.0, 40432.3935140979, 40990.38514422346, 41428.0, 6855.731689637433, 7012.754553590804, 7111.395531379891, 7281.745138920112, 7437.330640242404, 10785.298955567863, 11293.153013523854, 11523.423828808358, 11688.064954803425, 11793.11551633648, 9588.76028099303, 9960.0, 9979.550920208752, 10132.594696212363, 10423.374597524173, 9603.951980240334, 9766.267529935141, 9869.753256168653, 9985.550650220612, 10368.274220804471, 9999.500024998866, 10323.380597164194, 10338.793224135325, 10411.47942602882, 10419.426931518536, 7284.599347035964, 7287.635618219174, 7336.596487193042, 7367.0, 7589.316961473494, 9137.177654011171, 9393.29550283745, 10021.248406369697, 10287.43419111956, 10300.0], "unit": "score", "name": "jquery.html", "value": 7977.831951966147}, {"lowerIsBetter": false, "replicates": [1334.4662135145934, 1470.7058588282343, 1482.9777553336698, 1604.5988502874281, 1761.1458442655303, 6479.222493300805, 7130.429565634749, 7206.099237595301, 7215.6031418272105, 7222.494425390225, 7174.641267936595, 7336.633168341588, 7337.523061001045, 7339.376153026999, 7348.816279593013, 1972.1914015253749, 2019.1418647075009, 2019.2629690163058, 2240.6190947538958, 2269.171752310403, 2029.725986991752, 2232.799048085672, 2277.8974946127464, 2285.1887579909144, 2286.314105768271, 2227.7549469558335, 2263.8302127340435, 2267.5238199978025, 2267.7505474397885, 2303.665968434576, 2222.355516900097, 2236.1726161320335, 2242.3273018094587, 2246.1689175005354, 2246.84272100953, 2193.6599827026675, 2254.8534345267667, 2260.6835043093815, 2261.6155253606926, 2263.7736226377397, 7395.223501532316, 7414.295641914009, 7438.925610743878, 7442.702291908317, 7485.663145158481, 4528.750918699503, 4561.726296422192, 4593.448786145684, 4606.101810147023, 4610.9077818443775, 2910.359720861407, 3113.097201811472, 3115.1433355827103, 3125.9374812503625, 3141.387429451258, 965.4255717847869, 978.1587834462357, 986.5609803637384, 1006.2955930848435, 1017.6692574913183, 10012.59949602015, 10018.89981100187, 10026.548805303779, 10032.548535315927, 10033.648822291185, 4158.521769996489, 4219.451471308772, 4238.936415953764, 4280.871573852789, 4287.399764033038, 8668.523231222218, 8671.089535598798, 8673.869891951626, 8676.436031658048, 8689.913100868911, 4646.79089440976, 4666.183417901853, 4673.906521869543, 4674.415698037746, 4680.368150299734, 4188.790560471964, 4258.127083947783, 4259.169461954889, 4259.382389553497, 4259.74441533509, 3332.916677083044, 3554.3424466473266, 3558.964410355915, 3578.7673801202836, 3611.3499570077115, 1106.7122548137543, 1196.353968856825, 1201.7055821323656, 1207.613563659638, 1217.2757209460358, 1285.0683254640498, 1292.6703690558847, 1319.33373646308, 1343.5902049874687, 1347.5755137131773, 6696.296888826603, 6811.284815094443, 6812.795616131524, 6815.148106486689, 6833.453323734188, 1085.8154113800672, 1100.6973082402244, 1104.5692180049787, 1116.0290547223967, 1122.1471681522103, 5587.888242235133, 5603.411641777555, 5624.987502249634, 5626.549876009909, 5631.662100273997, 8644.265237454887, 8686.218240358397, 8820.779480513038, 8935.687250946186, 8968.506732129665, 8834.160754728418, 8834.469931804113, 8838.0, 8845.69040083594, 8846.380753347205, 6863.897041544281, 7036.401905837959, 7055.153381594241, 7089.0, 7105.786826395217, 6834.214065382345, 6836.623985680835, 6858.3827455529245, 6864.691088900911, 6872.209695884837, 7423.517471364344, 7719.112302085107, 7742.729004484816, 7752.108507521481, 8074.313683336982, 7771.650275737718, 7869.842603148019, 8037.919620803717, 8176.427650064438, 8185.918140818754, 6672.633005184762, 6707.429868461236, 6780.457563395015, 6784.491163162881, 6805.04729337903, 6194.946859034065, 6338.239411270492, 6824.829379265558, 6832.0, 6886.208086070166, 6586.50601204902, 6626.97281921303, 6636.0, 6709.630970296681, 6769.052332673331, 6567.835804104936, 6572.718484338003, 6622.10601568782, 6685.933140668726, 6690.0633911253435, 6700.597964122168, 6720.563163394364, 6743.15710536183, 6772.288909664414, 6775.695093720696, 6199.132121503083, 6210.813675589739, 6216.129741836237, 6217.751289948352, 6238.251409830667, 6032.939670603238, 6107.725152368243, 6111.663858487826, 6349.0, 6383.265924418565], "unit": "score", "name": "mootools.html", "value": 4339.521595690912}, {"lowerIsBetter": false, "replicates": [333.075714891177, 337.6353538178767, 340.93863104641156, 342.8902751119641, 344.2254926415565, 5744.7414866330955, 5792.015357389243, 5807.564432667551, 5857.0, 5862.0913758367415, 5547.9736248794, 5600.635958662684, 5671.7731290748425, 5743.3108027036815, 5782.971085144579, 4466.642668586522, 4492.8876778080485, 4497.775111244433, 4508.0, 4523.728576285417, 4295.892602684942, 4498.775061246941, 4502.527234640364, 4502.797374118156, 4509.413776209089, 4329.415528903589, 4365.388845561624, 4421.646268298528, 4428.6014258716705, 4453.0, 4414.911701765979, 4415.955840441603, 4418.094290670405, 4426.0, 4435.445569303837, 3919.431682406064, 3962.980185099085, 3966.186931678999, 3966.206758648253, 3970.68234541236, 5449.945500544984, 5508.504234618864, 5526.447355264441, 5546.750396232179, 5562.721863906829, 5189.55888749453, 5197.168453047494, 5197.818076367347, 5202.869928251824, 5207.218917162456, 6082.9695851520455, 6099.603525770811, 6110.297315808694, 6121.969390153065, 6130.080487926802, 4392.428984232061, 4398.296272596402, 4402.3396490526675, 4411.492678341968, 4414.3378493225955, 6214.161088253073, 6334.398232167937, 6402.359764023607, 6407.647579383132, 6415.262244841856, 4486.798094085774, 4486.820527178941, 4491.595756381876, 4497.617702495325, 4499.167653984024, 4557.043020965634, 4559.065391594715, 4562.840300589463, 4564.018735971716, 4570.702904311275, 5184.922226166535, 5194.844154675366, 5200.193969934666, 5202.7918883245, 5208.296879921162, 5948.434898684618, 6140.416660417253, 6166.260048794084, 6184.628922264678, 6184.938150618526, 1547.8993865398713, 1566.843315668424, 1569.050724311775, 1569.0585648610743, 1570.1442713721049, 1037.4864442101057, 1038.9636362727267, 1052.8157572424948, 1055.5935964653663, 1057.4924036462542, 5846.269216347957, 5854.5901786875365, 5862.413758624103, 5866.765329386777, 5867.559933005042, 6298.433141017331, 6323.114763933053, 6331.113644089831, 6333.493320534346, 6335.778247761306, 5680.602357834912, 5789.507891829242, 5790.826275211751, 5901.911471327933, 5952.404759524013, 3423.3837909176586, 3451.0682115828586, 3453.0849324928913, 3453.5165076889257, 3463.7575369723877, 6697.062411262427, 6709.127813384229, 6712.765053223114, 6716.496262780213, 6726.159230096238, 6341.524385671001, 6563.048357988065, 6580.703868325937, 6583.637899915455, 6598.868022639616, 6688.33116688337, 6694.665266736643, 6706.26231114577, 6708.865822683519, 6717.664116794239, 6435.1312572803945, 6436.742530298736, 6436.871262574628, 6440.742370305323, 6448.226212854487, 6265.102933721762, 6307.653079080695, 6350.7777227796805, 6351.333110023381, 6352.0789485525265, 6669.733210671713, 6677.432418244503, 6689.364510371507, 6689.632070236184, 6771.119754431892, 4403.801828917771, 4429.68992170545, 4435.356873253425, 4435.556444355539, 4441.244988352052, 6227.750889964351, 6407.9038814418755, 6423.486121110206, 6431.774887878902, 6432.935670643234, 6261.311255761953, 6262.686865656608, 6270.278917924315, 6271.62370257786, 6273.435390814849, 6180.907286390798, 6241.157443745036, 6255.24937007562, 6256.874862502816, 6257.5932564383165, 5990.7903223386975, 6087.512998960161, 6100.023996160593, 6138.600990935575, 6179.62922224668, 6252.062190671254, 6252.124702541557, 6254.8123556293385, 6254.906176407267, 6257.812265632038, 6090.969545152246, 6105.6947152641305, 6126.019836826086, 6137.1101190328045, 6137.171481850071], "unit": "score", "name": "prototype.html", "value": 4685.555509826072}, {"lowerIsBetter": false, "replicates": [766.6205228411937, 824.8267863748613, 829.759369782763, 833.9999999999997, 848.4951453884936, 12382.504699812009, 12482.37588120595, 12487.250764954098, 12507.124501284914, 12518.749625007506, 12600.621981340551, 12630.81053784194, 12644.810327845067, 12649.557265495709, 12659.240445573272, 655.6983787457763, 667.6027763480746, 789.1516619633887, 810.3881569415083, 810.6797814863125, 806.5765473126597, 810.4772421787943, 812.5815205169342, 814.4339683919678, 816.9869361991148, 688.0917189310113, 833.6665333866472, 833.9791505212388, 834.1241696218976, 834.2200042959821, 690.1717938473827, 817.7873752824279, 830.0330115415534, 831.1729828820302, 832.4048305461624, 613.2518327640272, 616.9136320915076, 617.2099712368176, 617.3764497857196, 617.6973283091253, 12857.485700571966, 12890.291033993126, 12967.805482917764, 12978.675533111653, 12999.415026323839, 11472.71318217043, 11948.163628546004, 12046.759064818742, 12177.33024683642, 12437.512497500446, 9827.164691001273, 9866.80266394668, 9941.789062733957, 10049.648262310857, 10101.040401161878, 3579.2304654499408, 3600.6039335673054, 3684.1342284563107, 3690.538682664667, 3777.263433630443, 42880.571194288284, 42939.57060429387, 43009.13981720348, 43572.0, 45476.545234547564, 9755.951220243995, 9927.702168934944, 9945.104940555384, 10037.749056273506, 10127.898721012696, 16366.836331636769, 16379.918100409423, 16426.507204783877, 16445.177741113137, 16473.505794826175, 7271.966360429649, 7330.266973302733, 7388.852222955511, 7442.479026468095, 7451.180370159278, 3822.140018495816, 3865.40086286626, 3882.1265215326325, 3912.726109172331, 3933.3903244997073, 2914.111196085172, 2951.099914526047, 2959.05310300706, 2973.9553906691417, 2978.791484596101, 539.9838004859782, 549.7974299704239, 559.7900787204799, 564.9858753531113, 565.2087078090624, 541.8239072301518, 573.9655620662774, 583.6177303865975, 583.9358067847743, 616.0881894795638, 7997.6800927963395, 8022.719204827803, 8053.296659491331, 8056.436049476481, 8319.792005199919, 467.7357293129371, 486.3750081145711, 518.4659800405589, 549.8982688202695, 573.8135106090538, 3366.73066154707, 3378.290558982592, 3430.9313813723584, 3443.6556344365363, 3458.8443520041155, 50606.746966265666, 51883.0, 52007.47992520102, 52231.47768522342, 52356.0, 46310.305345419845, 47027.29459058117, 47194.0, 47345.0, 47803.5219647806, 41517.1696566067, 41667.1666566673, 41895.37156942648, 42117.0, 42720.78639606782, 6792.76225332111, 6851.8972215415815, 6867.3476019778045, 6960.79117626472, 7057.964710176417, 31957.36085278328, 32950.83524582362, 33722.0, 33722.49416258709, 33823.83088084544, 43232.13535729205, 44426.0, 45168.77415613033, 47005.0, 48151.27773083337, 10190.0, 10474.371537707762, 10616.0, 10620.734481638021, 10781.514831832743, 10698.572057117628, 10816.242862999829, 10817.080548153495, 11195.0, 11993.880061199276, 10495.895041049493, 10767.6231331903, 10882.891171088504, 10936.12510999134, 11277.661670149908, 10764.40268936279, 10870.29343092728, 11113.944430278121, 11195.552177912792, 11417.029552488131, 10021.749456263651, 10049.0, 10079.546420410952, 10172.643957461454, 10380.32527885685, 8891.422057566237, 9070.637174512945, 9138.771530711785, 9219.677311294072, 9277.443353398818, 8493.447925884797, 8810.207081362709, 8997.190252877272, 9511.19154871816, 9667.806643867223], "unit": "score", "name": "yui.html", "value": 5919.4184318201615}], "name": "dromaeo_css", "value": 6658.14293673986}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 111.0, 111.0, 112.0, 100.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [153.0, 129.0, 151.0, 162.0, 124.0, 165.0, 153.0, 128.0, 166.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 161.0, 162.0, 162.0, 161.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 83.0, 97.0, 71.0, 73.0, 74.0, 102.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 137.0, 96.0, 96.0, 96.0, 149.0, 96.0, 97.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 111.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 148.0, 144.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 57.0, 57.0, 58.0, 57.0, 58.0, 66.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 83.0, 85.0, 85.0, 85.0, 86.0, 93.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [125.0, 116.0, 118.0, 114.0, 120.0, 119.0, 127.0, 116.0, 121.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 155.0, 151.0, 152.0, 141.0, 151.0, 154.0, 150.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 70.0, 71.0, 67.0, 68.0, 68.0, 69.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1506.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.12373907195695], "unit": "score", "name": "Richards", "value": 209.97629600000008}, {"lowerIsBetter": false, "replicates": [190.3311762466692], "unit": "score", "name": "DeltaBlue", "value": 347.3839720000001}, {"lowerIsBetter": false, "replicates": [284.9002849002849], "unit": "score", "name": "Encrypt", "value": 934.2953100000001}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1960.7843137254902], "unit": "score", "name": "RayTrace", "value": 377.39439}, {"lowerIsBetter": false, "replicates": [805.8017727639001], "unit": "score", "name": "Earley", "value": 827.0805830000004}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [41653.06122448979], "unit": "score", "name": "RegExp", "value": 21.870781479666846}, {"lowerIsBetter": false, "replicates": [562.7462014631401], "unit": "score", "name": "Splay", "value": 144.80950700000002}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 18980.17232526143}]} 04:16:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "18980.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1506.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6658.14"}}} 04:16:56 INFO - Return code: 0 04:16:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:16:56 INFO - # TBPL SUCCESS # 04:16:56 INFO - Running post-action listener: _resource_record_post_action 04:16:56 INFO - Running post-run listener: _resource_record_post_run 04:16:57 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 565346304; Read time: 60; Write time: 449012 04:16:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252846080; Read time: 0; Write time: 256236 04:16:57 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 312500224; Read time: 60; Write time: 192776 04:16:57 INFO - Running post-run listener: _upload_blobber_files 04:16:57 INFO - Blob upload gear active. 04:16:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:16:57 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 04:16:57 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:16:57 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:16:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:16:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:16:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:16:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:58 INFO - (blobuploader) - INFO - Done attempting. 04:16:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 04:16:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:16:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:59 INFO - (blobuploader) - INFO - Done attempting. 04:16:59 INFO - (blobuploader) - INFO - Iteration through files over. 04:16:59 INFO - Return code: 0 04:16:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:16:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:16:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c7a8333b4e9fa25d53b421f6076e749d0cc03a797f4edbb0b7ee2e698bea60421b314ce41935a1e85f8dcf3ecabb17d1be1cd9fc19b0c7b5f09ee37289568aec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/000462f6c713b4b5bc91d2aa03542218332d7a20612e57c40ded5f3f746c79cfb0c2cc44246c8be9b3ae9b0865891c7c9e67c3cc83acbf0a28074b8aa0039f6b"} 04:16:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:16:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:16:59 INFO - Contents: 04:16:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c7a8333b4e9fa25d53b421f6076e749d0cc03a797f4edbb0b7ee2e698bea60421b314ce41935a1e85f8dcf3ecabb17d1be1cd9fc19b0c7b5f09ee37289568aec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/000462f6c713b4b5bc91d2aa03542218332d7a20612e57c40ded5f3f746c79cfb0c2cc44246c8be9b3ae9b0865891c7c9e67c3cc83acbf0a28074b8aa0039f6b"} 04:16:59 INFO - Copying logs to upload dir... 04:16:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.864716 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-07 04:16:58.748831) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 04:16:58.751925) ========= 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=0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c7a8333b4e9fa25d53b421f6076e749d0cc03a797f4edbb0b7ee2e698bea60421b314ce41935a1e85f8dcf3ecabb17d1be1cd9fc19b0c7b5f09ee37289568aec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/000462f6c713b4b5bc91d2aa03542218332d7a20612e57c40ded5f3f746c79cfb0c2cc44246c8be9b3ae9b0865891c7c9e67c3cc83acbf0a28074b8aa0039f6b"} build_url:https://queue.taskcluster.net/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/TUCA2ydgRa-Ci6aYoZw7LA/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/Mozilla-Inbound/sha512/c7a8333b4e9fa25d53b421f6076e749d0cc03a797f4edbb0b7ee2e698bea60421b314ce41935a1e85f8dcf3ecabb17d1be1cd9fc19b0c7b5f09ee37289568aec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/000462f6c713b4b5bc91d2aa03542218332d7a20612e57c40ded5f3f746c79cfb0c2cc44246c8be9b3ae9b0865891c7c9e67c3cc83acbf0a28074b8aa0039f6b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 04:16:58.776205) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 04:16:58.776485) ========= 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=0333a256a5e4f052382dd180000001b1-1452149759.22170-384445514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 04:16:58.858987) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 04:16:58.859274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 04:16:58.859546) ========= ========= Total master_lag: 0.22 =========