builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1450807648.03 results: success (0) buildid: 20151222073200 builduid: c55beda6bf3f4b7f83d72a5a32360e71 revision: 16b693debb2bbe27943595bef7c76e0479655529 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.027157) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.027760) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.028115) ========= 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=820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004263 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.046322) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.046674) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.059399) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.059796) ========= 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=820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004700 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.109772) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.110130) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.110634) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.110982) ========= 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=820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 10:07:29-- 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% 66.3M=0s 2015-12-22 10:07:29 (66.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095800 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.219820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.220177) ========= 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=820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018403 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.272115) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.272605) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 16b693debb2bbe27943595bef7c76e0479655529 --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 16b693debb2bbe27943595bef7c76e0479655529 --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=820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 10:07:29,425 truncating revision to first 12 chars 2015-12-22 10:07:29,425 Setting DEBUG logging. 2015-12-22 10:07:29,425 attempt 1/10 2015-12-22 10:07:29,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/16b693debb2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 10:07:29,672 unpacking tar archive at: mozilla-inbound-16b693debb2b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.520873 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.850613) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.850973) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.861118) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.861476) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 10:07:28.861964) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-22 10:07:28.862297) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--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=820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:07:30 INFO - MultiFileLogger online at 20151222 10:07:30 in /builds/slave/test-pgo 10:07:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:07:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:07:30 INFO - {'append_to_log': False, 10:07:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:07:30 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:07:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:07:30 INFO - 'branch': 'Mozilla-Inbound', 10:07:30 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:30 INFO - 'config_files': ('talos/linux_config.py',), 10:07:30 INFO - 'default_actions': ('clobber', 10:07:30 INFO - 'read-buildbot-config', 10:07:30 INFO - 'download-and-extract', 10:07:30 INFO - 'populate-webroot', 10:07:30 INFO - 'create-virtualenv', 10:07:30 INFO - 'install', 10:07:30 INFO - 'run-tests'), 10:07:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:30 INFO - 'download_minidump_stackwalk': True, 10:07:30 INFO - 'download_symbols': 'ondemand', 10:07:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:30 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:30 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:30 INFO - 'installer_path': 'installer.exe', 10:07:30 INFO - 'log_level': 'info', 10:07:30 INFO - 'log_name': 'talos', 10:07:30 INFO - 'log_to_console': True, 10:07:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:07:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:07:30 INFO - 'opt_config_files': (), 10:07:30 INFO - 'pip_index': False, 10:07:30 INFO - 'sps_profile': False, 10:07:30 INFO - 'sps_profile_interval': 0, 10:07:30 INFO - 'suite': 'dromaeojs-e10s', 10:07:30 INFO - 'system_bits': '64', 10:07:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:30 INFO - 'title': 'talos-linux64-ix-055', 10:07:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:30 INFO - 'use_talos_json': True, 10:07:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:07:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:30 INFO - 'work_dir': 'build'} 10:07:30 INFO - ##### 10:07:30 INFO - ##### Running clobber step. 10:07:30 INFO - ##### 10:07:30 INFO - Running pre-action listener: _resource_record_pre_action 10:07:30 INFO - Running main action method: clobber 10:07:30 INFO - rmtree: /builds/slave/test-pgo/build 10:07:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:07:30 INFO - Running post-action listener: _resource_record_post_action 10:07:30 INFO - ##### 10:07:30 INFO - ##### Running read-buildbot-config step. 10:07:30 INFO - ##### 10:07:30 INFO - Running pre-action listener: _resource_record_pre_action 10:07:30 INFO - Running main action method: read_buildbot_config 10:07:30 INFO - Using buildbot properties: 10:07:30 INFO - { 10:07:30 INFO - "project": "", 10:07:30 INFO - "product": "firefox", 10:07:30 INFO - "script_repo_revision": "production", 10:07:30 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 10:07:30 INFO - "repository": "", 10:07:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 10:07:30 INFO - "buildid": "20151222073200", 10:07:30 INFO - "pgo_build": "True", 10:07:30 INFO - "basedir": "/builds/slave/test-pgo", 10:07:30 INFO - "buildnumber": 263, 10:07:30 INFO - "slavename": "talos-linux64-ix-055", 10:07:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:07:30 INFO - "platform": "ubuntu64_hw", 10:07:30 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:07:30 INFO - "branch": "mozilla-inbound", 10:07:30 INFO - "repo_path": "integration/mozilla-inbound", 10:07:30 INFO - "revision": "16b693debb2bbe27943595bef7c76e0479655529", 10:07:30 INFO - "stage_platform": "linux64-pgo", 10:07:30 INFO - "builduid": "c55beda6bf3f4b7f83d72a5a32360e71", 10:07:30 INFO - "slavebuilddir": "test" 10:07:30 INFO - } 10:07:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:07:30 INFO - Running post-action listener: _resource_record_post_action 10:07:30 INFO - ##### 10:07:30 INFO - ##### Running download-and-extract step. 10:07:30 INFO - ##### 10:07:30 INFO - Running pre-action listener: _resource_record_pre_action 10:07:30 INFO - Running main action method: download_and_extract 10:07:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:07:30 INFO - https://queue.taskcluster.net/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/test_packages.json 10:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/test_packages.json 10:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:07:31 INFO - Downloaded 1302 bytes. 10:07:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:07:31 INFO - Using the following test package requirements: 10:07:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:07:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:31 INFO - u'jsshell-linux-x86_64.zip'], 10:07:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:07:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:07:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:07:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:07:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:07:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:31 INFO - https://queue.taskcluster.net/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:07:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:07:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/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 10:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/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 10:07:32 INFO - Downloaded 23176376 bytes. 10:07:32 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 10:07:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:07:32 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 10:07:33 INFO - Return code: 0 10:07:33 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 10:07:33 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')]} 10:07:33 INFO - https://queue.taskcluster.net/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:07:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:07:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/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 10:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/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 10:07:34 INFO - Downloaded 23176376 bytes. 10:07:34 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 10:07:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:07:34 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 10:07:35 INFO - Return code: 0 10:07:35 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')]} 10:07:35 INFO - https://queue.taskcluster.net/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/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 10:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/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 10:07:36 INFO - Downloaded 11132277 bytes. 10:07:36 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 10:07:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:36 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 10:07:36 INFO - Return code: 0 10:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:07:36 INFO - https://queue.taskcluster.net/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:07:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:07:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:07:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/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 10:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EA4PyyQHRYqkYUuUUYE98w/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 10:07:38 INFO - Downloaded 54828146 bytes. 10:07:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:07:38 INFO - mkdir: /builds/slave/test-pgo/properties 10:07:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:07:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:07:38 INFO - Contents: 10:07:38 INFO - build_url:https://queue.taskcluster.net/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:07:38 INFO - Running post-action listener: _resource_record_post_action 10:07:38 INFO - Running post-action listener: set_extra_try_arguments 10:07:38 INFO - ##### 10:07:38 INFO - ##### Running populate-webroot step. 10:07:38 INFO - ##### 10:07:38 INFO - Running pre-action listener: _resource_record_pre_action 10:07:38 INFO - Running main action method: populate_webroot 10:07:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:38 INFO - '--tppagecycles', 10:07:38 INFO - '7'], 10:07:38 INFO - 'tests': ['tsvgm']}}, 10:07:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:07:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:07:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:07:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:07:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:07:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:38 INFO - 'talos_options': ['--e10s'], 10:07:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:38 INFO - 'tests': ['damp', 'tps']}, 10:07:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:38 INFO - 'talos_options': ['--e10s'], 10:07:38 INFO - 'tests': ['damp', 'tps']}, 10:07:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:07:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:38 INFO - 'other': {'tests': ['a11yr', 10:07:38 INFO - 'ts_paint', 10:07:38 INFO - 'tpaint', 10:07:38 INFO - 'sessionrestore', 10:07:38 INFO - 'sessionrestore_no_auto_restore']}, 10:07:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:07:38 INFO - 'tests': ['a11yr', 10:07:38 INFO - 'ts_paint', 10:07:38 INFO - 'tpaint', 10:07:38 INFO - 'sessionrestore', 10:07:38 INFO - 'sessionrestore_no_auto_restore']}, 10:07:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:07:38 INFO - 'tests': ['a11yr', 10:07:38 INFO - 'ts_paint', 10:07:38 INFO - 'tpaint', 10:07:38 INFO - 'sessionrestore', 10:07:38 INFO - 'sessionrestore_no_auto_restore']}, 10:07:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:07:38 INFO - 'tests': ['a11yr', 10:07:38 INFO - 'ts_paint', 10:07:38 INFO - 'tpaint', 10:07:38 INFO - 'sessionrestore', 10:07:38 INFO - 'sessionrestore_no_auto_restore']}, 10:07:38 INFO - 'other_l64': {'tests': ['a11yr', 10:07:38 INFO - 'ts_paint', 10:07:38 INFO - 'tpaint', 10:07:38 INFO - 'sessionrestore', 10:07:38 INFO - 'sessionrestore_no_auto_restore']}, 10:07:38 INFO - 'other_nol64': {'tests': ['a11yr', 10:07:38 INFO - 'ts_paint', 10:07:38 INFO - 'tpaint', 10:07:38 INFO - 'sessionrestore', 10:07:38 INFO - 'sessionrestore_no_auto_restore']}, 10:07:38 INFO - 'svgr': {'tests': ['tsvgx', 10:07:38 INFO - 'tsvgr_opacity', 10:07:38 INFO - 'tart', 10:07:38 INFO - 'tscrollx', 10:07:38 INFO - 'cart']}, 10:07:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:07:38 INFO - 'tests': ['tsvgx', 10:07:38 INFO - 'tsvgr_opacity', 10:07:38 INFO - 'tart', 10:07:38 INFO - 'tscrollx', 10:07:38 INFO - 'cart']}, 10:07:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:38 INFO - 'tests': ['tp5o']}, 10:07:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:38 INFO - 'talos_options': ['--e10s'], 10:07:38 INFO - 'tests': ['tp5o']}, 10:07:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:38 INFO - 'talos_options': ['--xperf_path', 10:07:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:38 INFO - 'tests': ['tp5n']}, 10:07:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:38 INFO - 'talos_options': ['--e10s', 10:07:38 INFO - '--xperf_path', 10:07:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:38 INFO - 'tests': ['tp5n']}}, 10:07:38 INFO - 'talos.zip': {'path': '', 10:07:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:38 INFO - Running post-action listener: _resource_record_post_action 10:07:38 INFO - ##### 10:07:38 INFO - ##### Running create-virtualenv step. 10:07:38 INFO - ##### 10:07:38 INFO - Running pre-action listener: _resource_record_pre_action 10:07:38 INFO - Running main action method: create_virtualenv 10:07:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:07:38 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 10:07:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:07:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:38 INFO - Using real prefix '/usr' 10:07:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:07:38 INFO - Installing distribute.............................................................................................................................................................................................done. 10:07:40 INFO - Installing pip.................done. 10:07:40 INFO - Return code: 0 10:07:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:07:40 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')]} 10:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:40 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')]} 10:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:40 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 0x7f5bc27aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20937f0>, '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 0x1fff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fff760>, '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': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', '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 10:07:40 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 10:07:40 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 10:07:40 INFO - Using env: {'DISPLAY': ':0', 10:07:40 INFO - 'HOME': '/home/cltbld', 10:07:40 INFO - 'LANG': 'en_US.UTF-8', 10:07:40 INFO - 'LANGUAGE': 'en_US:en', 10:07:40 INFO - 'LOGNAME': 'cltbld', 10:07:40 INFO - 'MAIL': '/var/mail/cltbld', 10:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:40 INFO - 'MOZ_NO_REMOTE': '1', 10:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:40 INFO - 'NO_EM_RESTART': '1', 10:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:40 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:40 INFO - 'SHELL': '/bin/bash', 10:07:40 INFO - 'SHLVL': '1', 10:07:40 INFO - 'TERM': 'linux', 10:07:40 INFO - 'TMOUT': '86400', 10:07:40 INFO - 'USER': 'cltbld', 10:07:40 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', 10:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:40 INFO - '_': '/tools/buildbot/bin/python'} 10:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:07:41 INFO - Cleaning up... 10:07:41 INFO - Return code: 0 10:07:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:07:41 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')]} 10:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:41 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')]} 10:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:41 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 0x7f5bc27aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20937f0>, '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 0x1fff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fff760>, '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': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', '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 10:07:41 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 10:07:41 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 10:07:41 INFO - Using env: {'DISPLAY': ':0', 10:07:41 INFO - 'HOME': '/home/cltbld', 10:07:41 INFO - 'LANG': 'en_US.UTF-8', 10:07:41 INFO - 'LANGUAGE': 'en_US:en', 10:07:41 INFO - 'LOGNAME': 'cltbld', 10:07:41 INFO - 'MAIL': '/var/mail/cltbld', 10:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:41 INFO - 'MOZ_NO_REMOTE': '1', 10:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:41 INFO - 'NO_EM_RESTART': '1', 10:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:41 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:41 INFO - 'SHELL': '/bin/bash', 10:07:41 INFO - 'SHLVL': '1', 10:07:41 INFO - 'TERM': 'linux', 10:07:41 INFO - 'TMOUT': '86400', 10:07:41 INFO - 'USER': 'cltbld', 10:07:41 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', 10:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:41 INFO - '_': '/tools/buildbot/bin/python'} 10:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:41 INFO - Downloading/unpacking psutil>=0.7.1 10:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:07:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:07:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:07:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:43 INFO - Installing collected packages: psutil 10:07:43 INFO - Running setup.py install for psutil 10:07:43 INFO - building 'psutil._psutil_linux' extension 10:07:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:07:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:07:43 INFO - building 'psutil._psutil_posix' extension 10:07:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:07:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:07:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:43 INFO - Successfully installed psutil 10:07:43 INFO - Cleaning up... 10:07:43 INFO - Return code: 0 10:07:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:43 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 0x7f5bc27aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20937f0>, '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 0x1fff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fff760>, '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': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', '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 10:07:43 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 10:07:43 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 10:07:43 INFO - Using env: {'DISPLAY': ':0', 10:07:43 INFO - 'HOME': '/home/cltbld', 10:07:43 INFO - 'LANG': 'en_US.UTF-8', 10:07:43 INFO - 'LANGUAGE': 'en_US:en', 10:07:43 INFO - 'LOGNAME': 'cltbld', 10:07:43 INFO - 'MAIL': '/var/mail/cltbld', 10:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:43 INFO - 'MOZ_NO_REMOTE': '1', 10:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:43 INFO - 'NO_EM_RESTART': '1', 10:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:43 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:43 INFO - 'SHELL': '/bin/bash', 10:07:43 INFO - 'SHLVL': '1', 10:07:43 INFO - 'TERM': 'linux', 10:07:43 INFO - 'TMOUT': '86400', 10:07:43 INFO - 'USER': 'cltbld', 10:07:43 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', 10:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:43 INFO - '_': '/tools/buildbot/bin/python'} 10:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:07:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:07:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:07:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:07:45 INFO - Installing collected packages: mozsystemmonitor 10:07:45 INFO - Running setup.py install for mozsystemmonitor 10:07:45 INFO - Successfully installed mozsystemmonitor 10:07:45 INFO - Cleaning up... 10:07:45 INFO - Return code: 0 10:07:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:45 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 0x7f5bc27aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20937f0>, '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 0x1fff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fff760>, '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': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', '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 10:07:45 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 10:07:45 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 10:07:45 INFO - Using env: {'DISPLAY': ':0', 10:07:45 INFO - 'HOME': '/home/cltbld', 10:07:45 INFO - 'LANG': 'en_US.UTF-8', 10:07:45 INFO - 'LANGUAGE': 'en_US:en', 10:07:45 INFO - 'LOGNAME': 'cltbld', 10:07:45 INFO - 'MAIL': '/var/mail/cltbld', 10:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:45 INFO - 'MOZ_NO_REMOTE': '1', 10:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:45 INFO - 'NO_EM_RESTART': '1', 10:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:45 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:45 INFO - 'SHELL': '/bin/bash', 10:07:45 INFO - 'SHLVL': '1', 10:07:45 INFO - 'TERM': 'linux', 10:07:45 INFO - 'TMOUT': '86400', 10:07:45 INFO - 'USER': 'cltbld', 10:07:45 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', 10:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:45 INFO - '_': '/tools/buildbot/bin/python'} 10:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:46 INFO - Downloading/unpacking blobuploader==1.2.4 10:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:47 INFO - Downloading blobuploader-1.2.4.tar.gz 10:07:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:07:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:07:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:07:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:07:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:48 INFO - Downloading docopt-0.6.1.tar.gz 10:07:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:07:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:07:48 INFO - Installing collected packages: blobuploader, requests, docopt 10:07:48 INFO - Running setup.py install for blobuploader 10:07:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:07:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:07:48 INFO - Running setup.py install for requests 10:07:48 INFO - Running setup.py install for docopt 10:07:49 INFO - Successfully installed blobuploader requests docopt 10:07:49 INFO - Cleaning up... 10:07:49 INFO - Return code: 0 10:07:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:07:49 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')]} 10:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:49 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')]} 10:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:49 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 0x7f5bc27aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20937f0>, '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 0x1fff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fff760>, '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': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', '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 10:07:49 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 10:07:49 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 10:07:49 INFO - Using env: {'DISPLAY': ':0', 10:07:49 INFO - 'HOME': '/home/cltbld', 10:07:49 INFO - 'LANG': 'en_US.UTF-8', 10:07:49 INFO - 'LANGUAGE': 'en_US:en', 10:07:49 INFO - 'LOGNAME': 'cltbld', 10:07:49 INFO - 'MAIL': '/var/mail/cltbld', 10:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:49 INFO - 'MOZ_NO_REMOTE': '1', 10:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:49 INFO - 'NO_EM_RESTART': '1', 10:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:49 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:49 INFO - 'SHELL': '/bin/bash', 10:07:49 INFO - 'SHLVL': '1', 10:07:49 INFO - 'TERM': 'linux', 10:07:49 INFO - 'TMOUT': '86400', 10:07:49 INFO - 'USER': 'cltbld', 10:07:49 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', 10:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:49 INFO - '_': '/tools/buildbot/bin/python'} 10:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:07:49 INFO - Running setup.py (path:/tmp/pip-wJj_g5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:07:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:07:49 INFO - Running setup.py (path:/tmp/pip-Snuei3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:07:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:07:49 INFO - Running setup.py (path:/tmp/pip-rCLmUo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:07:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:07:49 INFO - Running setup.py (path:/tmp/pip-LbiNek-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:07:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:07:49 INFO - Running setup.py (path:/tmp/pip-ADhM31-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:07:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:07:49 INFO - Running setup.py (path:/tmp/pip-9GpPjf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:07:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:07:49 INFO - Running setup.py (path:/tmp/pip-2dfeTf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:07:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:07:49 INFO - Running setup.py (path:/tmp/pip-m7UO3g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:07:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:07:49 INFO - Running setup.py (path:/tmp/pip-DmcVMe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:07:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:07:49 INFO - Running setup.py (path:/tmp/pip-tKHoJ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:07:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:07:50 INFO - Running setup.py (path:/tmp/pip-toZRIJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:07:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:07:50 INFO - Running setup.py (path:/tmp/pip-dRAlUN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:07:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:07:50 INFO - Running setup.py (path:/tmp/pip-M3cGLw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:07:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:07:50 INFO - Running setup.py (path:/tmp/pip-FTHy4F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:07:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:07:50 INFO - Running setup.py (path:/tmp/pip-Qm0C9E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:07:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:07:50 INFO - Running setup.py (path:/tmp/pip-ombrim-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:07:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:07:50 INFO - Running setup.py (path:/tmp/pip-RwX6aC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:07:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:07:50 INFO - Running setup.py install for manifestparser 10:07:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:07:50 INFO - Running setup.py install for mozcrash 10:07:50 INFO - Running setup.py install for mozdebug 10:07:50 INFO - Running setup.py install for mozdevice 10:07:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:07:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:07:51 INFO - Running setup.py install for mozfile 10:07:51 INFO - Running setup.py install for mozhttpd 10:07:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:07:51 INFO - Running setup.py install for mozinfo 10:07:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:07:51 INFO - Running setup.py install for mozInstall 10:07:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:07:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:07:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:07:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:07:51 INFO - Running setup.py install for mozleak 10:07:51 INFO - Running setup.py install for mozlog 10:07:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:07:51 INFO - Running setup.py install for moznetwork 10:07:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:07:51 INFO - Running setup.py install for mozprocess 10:07:51 INFO - Running setup.py install for mozprofile 10:07:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:07:51 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:07:51 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:07:51 INFO - Running setup.py install for mozrunner 10:07:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:07:52 INFO - Running setup.py install for mozscreenshot 10:07:52 INFO - Running setup.py install for moztest 10:07:52 INFO - Running setup.py install for mozversion 10:07:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:07:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:07:52 INFO - Cleaning up... 10:07:52 INFO - Return code: 0 10:07:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:07: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')]} 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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')]} 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:52 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 0x7f5bc27aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20937f0>, '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 0x1fff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fff760>, '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': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', '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 10:07:52 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 10:07:52 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 10:07:52 INFO - Using env: {'DISPLAY': ':0', 10:07:52 INFO - 'HOME': '/home/cltbld', 10:07:52 INFO - 'LANG': 'en_US.UTF-8', 10:07:52 INFO - 'LANGUAGE': 'en_US:en', 10:07:52 INFO - 'LOGNAME': 'cltbld', 10:07:52 INFO - 'MAIL': '/var/mail/cltbld', 10:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:52 INFO - 'MOZ_NO_REMOTE': '1', 10:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:52 INFO - 'NO_EM_RESTART': '1', 10:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:52 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:52 INFO - 'SHELL': '/bin/bash', 10:07:52 INFO - 'SHLVL': '1', 10:07:52 INFO - 'TERM': 'linux', 10:07:52 INFO - 'TMOUT': '86400', 10:07:52 INFO - 'USER': 'cltbld', 10:07:52 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', 10:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:52 INFO - '_': '/tools/buildbot/bin/python'} 10:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:07:52 INFO - Running setup.py (path:/tmp/pip-YtQOqr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:07:52 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)) 10:07:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:07:52 INFO - Running setup.py (path:/tmp/pip-6xMkw9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:07:52 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)) 10:07:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:07:52 INFO - Running setup.py (path:/tmp/pip-_LqzNw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:07:52 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)) 10:07:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:07:52 INFO - Running setup.py (path:/tmp/pip-tAsosH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:07:52 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)) 10:07:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:07:52 INFO - Running setup.py (path:/tmp/pip-bJzHRc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:07:52 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)) 10:07:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:07:52 INFO - Running setup.py (path:/tmp/pip-jPGGaO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:07:53 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)) 10:07:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:07:53 INFO - Running setup.py (path:/tmp/pip-wNdlhq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:07:53 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)) 10:07:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:07:53 INFO - Running setup.py (path:/tmp/pip-1POhMT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:07:53 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)) 10:07:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:07:53 INFO - Running setup.py (path:/tmp/pip-N63NHk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:07:53 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)) 10:07:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:07:53 INFO - Running setup.py (path:/tmp/pip-y3l3fn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:07:53 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)) 10:07:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:07:53 INFO - Running setup.py (path:/tmp/pip-LzGxmr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:07:53 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)) 10:07:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:07:53 INFO - Running setup.py (path:/tmp/pip-10y_M8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:07:53 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)) 10:07:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:07:53 INFO - Running setup.py (path:/tmp/pip-aNluKI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:07:53 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)) 10:07:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:07:53 INFO - Running setup.py (path:/tmp/pip-brdkaW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:07:53 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)) 10:07:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:07:53 INFO - Running setup.py (path:/tmp/pip-3dDgzd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:07:53 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)) 10:07:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:07:53 INFO - Running setup.py (path:/tmp/pip-S6ujHs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:07:53 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)) 10:07:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:07:53 INFO - Running setup.py (path:/tmp/pip-houLUb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:07:53 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)) 10:07:53 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)) 10:07:53 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)) 10:07:53 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)) 10:07:53 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)) 10:07:53 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)) 10:07:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:55 INFO - Downloading blessings-1.5.1.tar.gz 10:07:55 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 10:07:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:07:55 INFO - Installing collected packages: blessings 10:07:55 INFO - Running setup.py install for blessings 10:07:55 INFO - Successfully installed blessings 10:07:55 INFO - Cleaning up... 10:07:55 INFO - Return code: 0 10:07:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:07:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:07:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:07:55 INFO - Reading from file tmpfile_stdout 10:07:55 INFO - Current package versions: 10:07:55 INFO - argparse == 1.2.1 10:07:55 INFO - blessings == 1.5.1 10:07:55 INFO - blobuploader == 1.2.4 10:07:55 INFO - docopt == 0.6.1 10:07:55 INFO - manifestparser == 1.1 10:07:55 INFO - mozInstall == 1.12 10:07:55 INFO - mozcrash == 0.16 10:07:55 INFO - mozdebug == 0.1 10:07:55 INFO - mozdevice == 0.47 10:07:55 INFO - mozfile == 1.2 10:07:55 INFO - mozhttpd == 0.7 10:07:55 INFO - mozinfo == 0.9 10:07:55 INFO - mozleak == 0.1 10:07:55 INFO - mozlog == 3.1 10:07:55 INFO - moznetwork == 0.27 10:07:55 INFO - mozprocess == 0.22 10:07:55 INFO - mozprofile == 0.28 10:07:55 INFO - mozrunner == 6.11 10:07:55 INFO - mozscreenshot == 0.1 10:07:55 INFO - mozsystemmonitor == 0.0 10:07:55 INFO - moztest == 0.7 10:07:55 INFO - mozversion == 1.4 10:07:55 INFO - psutil == 3.1.1 10:07:55 INFO - requests == 1.2.3 10:07:55 INFO - wsgiref == 0.1.2 10:07:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:55 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 0x7f5bc27aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20937f0>, '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 0x1fff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fff760>, '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': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', '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 10:07:55 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 10:07:55 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 10:07:55 INFO - Using env: {'DISPLAY': ':0', 10:07:55 INFO - 'HOME': '/home/cltbld', 10:07:55 INFO - 'LANG': 'en_US.UTF-8', 10:07:55 INFO - 'LANGUAGE': 'en_US:en', 10:07:55 INFO - 'LOGNAME': 'cltbld', 10:07:55 INFO - 'MAIL': '/var/mail/cltbld', 10:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:55 INFO - 'MOZ_NO_REMOTE': '1', 10:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:55 INFO - 'NO_EM_RESTART': '1', 10:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:55 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:55 INFO - 'SHELL': '/bin/bash', 10:07:55 INFO - 'SHLVL': '1', 10:07:55 INFO - 'TERM': 'linux', 10:07:55 INFO - 'TMOUT': '86400', 10:07:55 INFO - 'USER': 'cltbld', 10:07:55 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', 10:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:55 INFO - '_': '/tools/buildbot/bin/python'} 10:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 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)) 10:07:56 INFO - Cleaning up... 10:07:56 INFO - Return code: 0 10:07:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:07:56 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')]} 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:56 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')]} 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:56 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 0x7f5bc27aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20937f0>, '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 0x1fff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fff760>, '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': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', '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 10:07:56 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 10:07:56 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 10:07:56 INFO - Using env: {'DISPLAY': ':0', 10:07:56 INFO - 'HOME': '/home/cltbld', 10:07:56 INFO - 'LANG': 'en_US.UTF-8', 10:07:56 INFO - 'LANGUAGE': 'en_US:en', 10:07:56 INFO - 'LOGNAME': 'cltbld', 10:07:56 INFO - 'MAIL': '/var/mail/cltbld', 10:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:56 INFO - 'MOZ_NO_REMOTE': '1', 10:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:56 INFO - 'NO_EM_RESTART': '1', 10:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:56 INFO - 'SHELL': '/bin/bash', 10:07:56 INFO - 'SHLVL': '1', 10:07:56 INFO - 'TERM': 'linux', 10:07:56 INFO - 'TMOUT': '86400', 10:07:56 INFO - 'USER': 'cltbld', 10:07:56 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', 10:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:56 INFO - '_': '/tools/buildbot/bin/python'} 10:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:56 INFO - Downloading/unpacking jsonschema 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:58 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 10:07:58 INFO - Downloading/unpacking functools32 (from jsonschema) 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:58 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:07:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:07:58 INFO - warning: no files found matching '*.txt' 10:07:58 INFO - no previously-included directories found matching 'build' 10:07:58 INFO - no previously-included directories found matching 'dist' 10:07:58 INFO - no previously-included directories found matching '.git*' 10:07:58 INFO - Installing collected packages: jsonschema, functools32 10:07:58 INFO - Running setup.py install for functools32 10:07:58 INFO - warning: no files found matching '*.txt' 10:07:58 INFO - no previously-included directories found matching 'build' 10:07:58 INFO - no previously-included directories found matching 'dist' 10:07:58 INFO - no previously-included directories found matching '.git*' 10:07:58 INFO - Successfully installed jsonschema functools32 10:07:58 INFO - Cleaning up... 10:07:58 INFO - Return code: 0 10:07:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:58 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 0x7f5bc27aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2001230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20937f0>, '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 0x1fff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fff760>, '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': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', '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 10:07:58 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 10:07:58 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 10:07:58 INFO - Using env: {'DISPLAY': ':0', 10:07:58 INFO - 'HOME': '/home/cltbld', 10:07:58 INFO - 'LANG': 'en_US.UTF-8', 10:07:58 INFO - 'LANGUAGE': 'en_US:en', 10:07:58 INFO - 'LOGNAME': 'cltbld', 10:07:58 INFO - 'MAIL': '/var/mail/cltbld', 10:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:58 INFO - 'MOZ_NO_REMOTE': '1', 10:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:58 INFO - 'NO_EM_RESTART': '1', 10:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:07:58 INFO - 'PWD': '/builds/slave/test-pgo', 10:07:58 INFO - 'SHELL': '/bin/bash', 10:07:58 INFO - 'SHLVL': '1', 10:07:58 INFO - 'TERM': 'linux', 10:07:58 INFO - 'TMOUT': '86400', 10:07:58 INFO - 'USER': 'cltbld', 10:07:58 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', 10:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:58 INFO - '_': '/tools/buildbot/bin/python'} 10:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:58 INFO - Downloading/unpacking flake8 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:08:00 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 10:08:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:08:00 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 10:08:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:01 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 10:08:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:08:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:08:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:08:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:08:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:08:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:08:01 INFO - no previously-included directories found matching 'docs/_build' 10:08:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:08:01 INFO - Running setup.py install for pep8 10:08:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:08:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:08:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:08:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:08:01 INFO - no previously-included directories found matching 'docs/_build' 10:08:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:08:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:08:01 INFO - Cleaning up... 10:08:01 INFO - Return code: 0 10:08:01 INFO - Running post-action listener: _resource_record_post_action 10:08:01 INFO - Running post-action listener: _start_resource_monitoring 10:08:01 INFO - Starting resource monitoring. 10:08:01 INFO - ##### 10:08:01 INFO - ##### Running install step. 10:08:01 INFO - ##### 10:08:01 INFO - Running pre-action listener: _resource_record_pre_action 10:08:01 INFO - Running main action method: install 10:08:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:08:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:08:01 INFO - Reading from file tmpfile_stdout 10:08:01 INFO - Detecting whether we're running mozinstall >=1.0... 10:08:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:08:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:08:01 INFO - Reading from file tmpfile_stdout 10:08:01 INFO - Output received: 10:08:01 INFO - Usage: mozinstall [options] installer 10:08:01 INFO - Options: 10:08:01 INFO - -h, --help show this help message and exit 10:08:01 INFO - -d DEST, --destination=DEST 10:08:01 INFO - Directory to install application into. [default: 10:08:01 INFO - "/builds/slave/test-pgo"] 10:08:01 INFO - --app=APP Application being installed. [default: firefox] 10:08:01 INFO - mkdir: /builds/slave/test-pgo/build/application 10:08:01 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'] 10:08:01 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 10:08:17 INFO - Reading from file tmpfile_stdout 10:08:17 INFO - Output received: 10:08:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:08:17 INFO - Running post-action listener: _resource_record_post_action 10:08:17 INFO - ##### 10:08:17 INFO - ##### Running run-tests step. 10:08:17 INFO - ##### 10:08:17 INFO - Running pre-action listener: _resource_record_pre_action 10:08:17 INFO - Running main action method: run_tests 10:08:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:08:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:08:17 INFO - Python 2.7.3 10:08:17 INFO - Return code: 0 10:08:17 INFO - grabbing minidump binary from tooltool 10:08: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')]} 10:08:17 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 0x20937f0>, '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 0x1fff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fff760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:08:17 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 10:08:17 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 10:08:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:08:17 INFO - Return code: 0 10:08:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:08:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:08:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:08:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:08:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:08:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:08:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:08:18 INFO - Return code: 0 10:08:18 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 10:08:18 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:08:18 INFO - Using env: {'DISPLAY': ':0', 10:08:18 INFO - 'HOME': '/home/cltbld', 10:08:18 INFO - 'LANG': 'en_US.UTF-8', 10:08:18 INFO - 'LANGUAGE': 'en_US:en', 10:08:18 INFO - 'LOGNAME': 'cltbld', 10:08:18 INFO - 'MAIL': '/var/mail/cltbld', 10:08:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:08:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:18 INFO - 'MOZ_NO_REMOTE': '1', 10:08:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:18 INFO - 'NO_EM_RESTART': '1', 10:08:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:08:18 INFO - 'PWD': '/builds/slave/test-pgo', 10:08:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:08:18 INFO - 'SHELL': '/bin/bash', 10:08:18 INFO - 'SHLVL': '1', 10:08:18 INFO - 'TERM': 'linux', 10:08:18 INFO - 'TMOUT': '86400', 10:08:18 INFO - 'USER': 'cltbld', 10:08:18 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708', 10:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:18 INFO - '_': '/tools/buildbot/bin/python'} 10:08:18 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:08:18 INFO - mozversion application_buildid: 20151222073200 10:08:18 INFO - mozversion application_changeset: 16b693debb2bbe27943595bef7c76e0479655529 10:08:18 INFO - mozversion application_display_name: Nightly 10:08:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:08:18 INFO - mozversion application_name: Firefox 10:08:18 INFO - mozversion application_remotingname: firefox 10:08:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:08:18 INFO - mozversion application_vendor: Mozilla 10:08:18 INFO - mozversion application_version: 46.0a1 10:08:18 INFO - mozversion platform_buildid: 20151222073200 10:08:18 INFO - mozversion platform_changeset: 16b693debb2bbe27943595bef7c76e0479655529 10:08:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:08:18 INFO - mozversion platform_version: 46.0a1 10:08:18 INFO - using testdate: 1450807698 10:08:18 INFO - actual date: 1450807698 10:08:18 INFO - starting webserver on 'localhost:42430' 10:08:18 INFO - SUITE-START | Running 3 tests 10:08:18 INFO - TEST-START | dromaeo_css 10:08:18 INFO - operating with platform_type : linux_ 10:08:18 INFO - Initialising browser for dromaeo_css test... 10:08:18 INFO - TEST-INFO | started process 14524 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpItkdLt/profile http://localhost:42430/getInfo.html) 10:08:23 INFO - PROCESS | 14524 | __metrics Screen width/height:1600/1200 10:08:23 INFO - PROCESS | 14524 | colorDepth:24 10:08:23 INFO - PROCESS | 14524 | Browser inner width/height: 1024/697 10:08:23 INFO - PROCESS | 14524 | __metrics 10:08:23 INFO - PROCESS | 14524 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:08:24 INFO - TEST-INFO | 14524: exit 0 10:08:24 INFO - Browser initialized. 10:08:24 INFO - Running cycle 1/1 for dromaeo_css test... 10:08:24 INFO - TEST-INFO | started process 14659 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpItkdLt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:36 INFO - PROCESS | 14659 | RSS: Main: 150712320 10:08:36 INFO - PROCESS | 14659 | 10:09:25 INFO - PROCESS | 14659 | 1450807765869 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:11:34 INFO - PROCESS | 14659 | Cycle 1(1): loaded http://localhost:42430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42430/tests/dromaeo/cssquery-ext.html) 10:11:35 INFO - PROCESS | 14659 | RSS: Main: 157564928 10:11:35 INFO - PROCESS | 14659 | 10:14:37 INFO - PROCESS | 14659 | Cycle 1(1): loaded http://localhost:42430/tests/dromaeo/cssquery-ext.html (next: http://localhost:42430/tests/dromaeo/cssquery-jquery.html) 10:14:38 INFO - PROCESS | 14659 | RSS: Main: 154017792 10:14:38 INFO - PROCESS | 14659 | 10:17:40 INFO - PROCESS | 14659 | Cycle 1(1): loaded http://localhost:42430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42430/tests/dromaeo/cssquery-mootools.html) 10:17:40 INFO - PROCESS | 14659 | RSS: Main: 154963968 10:17:40 INFO - PROCESS | 14659 | 10:20:42 INFO - PROCESS | 14659 | Cycle 1(1): loaded http://localhost:42430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42430/tests/dromaeo/cssquery-prototype.html) 10:20:42 INFO - PROCESS | 14659 | RSS: Main: 151846912 10:20:42 INFO - PROCESS | 14659 | 10:23:45 INFO - PROCESS | 14659 | Cycle 1(1): loaded http://localhost:42430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42430/tests/dromaeo/cssquery-yui.html) 10:23:45 INFO - PROCESS | 14659 | RSS: Main: 152375296 10:23:45 INFO - PROCESS | 14659 | 10:26:48 INFO - PROCESS | 14659 | Cycle 1(1): loaded http://localhost:42430/tests/dromaeo/cssquery-yui.html (next: http://localhost:42430/tests/dromaeo/cssquery-dojo.html) 10:26:48 INFO - PROCESS | 14659 | RSS: Main: 155308032 10:26:48 INFO - PROCESS | 14659 | 10:26:48 INFO - PROCESS | 14659 | __start_tp_report 10:26:48 INFO - PROCESS | 14659 | _x_x_mozilla_page_load 10:26:48 INFO - PROCESS | 14659 | _x_x_mozilla_page_load_details 10:26:48 INFO - PROCESS | 14659 | |i|pagename|runs| 10:26:48 INFO - PROCESS | 14659 | |0;dojo.html;3183.7771356005082;3214.3089235814296;3234.3207926335467;3256.218507558186;3260.6250281217654;5227.242049902762;5356.758945847437;5374.355077390709;5378.623496355257;5408.621396502242;5275.683458992454;5304.814331498398;5317.760700768465;5336.493033161853;5338.733063346836;4591.954080459186;4859.27110933361;5019.824306149286;5035.697858128506;5044.772985215655;4790.7604619769045;4964.925526117093;4973.254011898208;5011.398632164145;5043.924341134886;4850.151223535867;4851.660383773137;4865.732384718839;4945.678530895516;4968.801247950078;4965.230389289666;4965.528274813887;4972.129877271463;4975.900481990376;5018.172001619765;4877.219644856806;4916.70499770015;4946.530079642464;4958.157113290749;5023.020511000356;5204.869878253036;5213.843584692428;5220.3735551734035;5227.6079294052715;5286.9471305287225;5806.44838740319;5843.29880414353;5864.970675146597;5889.587728858982;5890.145928840337;5790.971045144789;5877.265341832271;5880.529557635379;5898.793542226002;5909.054551271819;5388.353397592275;5401;5463.043967305705;5466.781328746845;5503.532199762985;5883.61756485827;5933.317668468181;5941.257342832146;5965.164876917235;5971.4924231439945;5676.858078548069;5679.949209396193;5736.6558006519745;5753.1370294456165;5754.827355179351;5760.423957604206;5825.854353641193;5859.501942334864;5892.234009578728;5966.880662386815;5738.713064346766;5770.682612456271;5775.624584402;5782.942170578324;5814.680192589363;5614.943850561442;5764.164196191613;5767.250257466502;5785.71071446426;5791.739371728282;4405.163019026375;4430.158269928703;4512.548745125527;4516.412866327357;4525.886852828706;4000.119973605802;4009.2382447334912;4012.8996775080855;4029.194161167778;4055.1889622075705;5220.738963051832;5344.839654810362;5423.918641220384;5430.15832545956;5433.402325744165;5755.9424405756245;5848.415158484203;5858.882822343529;5859.267591551056;5912.9113063304085;5414.7834086636885;5417.133258678671;5423.132298832168;5435.782568697208;5442.727863606804;4908.460069392364;4989.625778066659;5010.849674509771;5034;5055.266986287042;5840.678762668009;5889.087191485327;5929.822105336761;5930.733117009745;5932.762689492372;5815.9709201453725;5828.825135245949;5828.970855145697;5833.883322333614;5859.589828711949;5774.48029677331;5805.245318108618;5849.64902105875;5904.291485021825;5928.229330187048;5674.404187560247;5723.7996670116345;5741.397153299011;5787.189793428839;5796.594238403271;5735.483806457439;5775.104858746901;5812.273465816773;5841.737121829443;5858.5898987070495;5546.195801608825;5559.388467268678;5564;5679.659220446786;5702.37273899879;5634.887302254014;5648.915266271091;5654.971725141348;5673.319201695823;5769.59612827098;5504.284443022381;5528.115501519737;5531.917021244765;5537.501624853782;5538.695371754431;5541.445855414427;5626.803061892814;5627.0434026214825;5658.462446067617;5694.715264236855;5645.1532270159805;5666.886662266814;5666.914996275142;5678.943210568007;5689.687067211343 10:26:48 INFO - PROCESS | 14659 | |1;ext.html;555.7722308892356;582.8746819433821;594.3313772006494;595.6336852835504;600.9669468179248;38221.808890955544;38585.42121868167;38618.22763544731;38698.8065059675;38737.418938715906;41611.37582936259;41809.7909510452;42121.57878421222;42274.57725422745;42475.57524424755;8879.778005549864;8974.730758077236;8976.730698079067;8986.910130898672;8987.820243595124;8692.565371731389;8758.2993360531;8854.601542930584;8864.113588641148;8867.423617464876;8766.56167191641;8830.735077947671;8848.911510884906;8896.243819275369;8902.777430564223;8482.448640838325;8488.618012189436;8543.530105844176;8558.78603034926;8596.140385961417;8728.825423491558;8818.470891746516;8849.734507964771;8855.645774169025;8902.777430564223;38925.41611875824;39556.802215989024;39586.802065989774;39632.405513917314;39723;3264.853081611333;3337.516060171286;3352.7485438591957;3466.2374277658873;3739.0091625719206;29822.10533683993;30096.24759381033;30303.545446818316;30362;30585.38829223403;3830.291396091704;3915.569287378386;4025.2352053109817;4028.47629808126;4038.2327357801923;267113;267677;267694;268377;269133;57216.141757873665;57378.426215738145;57436;57490;57526;58184.4181558179;60605.39394606086;60773;67651;71135;14521.709565808625;14766;14825.77761333581;14871.925640371945;14872.925635371754;9958.203343732628;10091.091801737732;10116.645917393003;10121.1903047756;10122.493875306205;19762.802371976097;20293.59412811765;20298;20325.085371158333;20352.898235509023;7508.2867127622785;7600.225917540058;7609.201033891472;7658.770236892902;7713.3443657288635;916.3860213656733;970.3983530211173;1018.4245901065874;1063.1388575254068;1079.871919865775;28023.299417514318;28409.43181136366;28449.57325640117;28692.995745149237;28699.856500717782;1033.6278939581744;1079.2067830144838;1124.5907186433283;1127.3517727306833;1187.9346635935105;14644;14726.852731472762;14758.63103422423;14898.329575169144;15033.624159396102;311006;316234;317113;319998;320119;50652.240216396785;51484.227736583984;51607.225891611655;51621;51677.48322516727;1338.7791014482696;1355.898307626932;1364.351932831877;1372.0532832345848;1374.271636032904;26569.468610628064;27487.89591234073;27655.30861728473;27919.44161116807;28087.578686319313;45856;46106.76946615245;46494.535054650376;46523.76738116288;46535.069298614515;287325;288061;288315;289764;290893;31778.523322149726;32130;32407.675923241408;32409.18977025499;32758.34483310368;37624.811875940446;37875.431868522544;38224;38712.80643596764;39021.6097839018;33136.834315828266;35365;36608;36617;36912.261754764215;33638.49542256917;33655;33681.663183367855;33754.831225843714;34821.82589087039;34970.30059398747;35097.122571935906;35109.47335789914;35249.1187720309;35590.46614300736;30341;30380.240493986945;32006.35987280288;32117;32262.677373225968;24144.51710965806;24212.51574968526;24481.3879653003;24491.51016979686;24635.753642463347 10:26:48 INFO - PROCESS | 14659 | |2;jquery.html;360.6591770776615;362.85848519077564;363.54193715917967;365.222076976041;368.74188068352163;16271;16709.749353759704;17222.3111075557;17421.91289043553;18081.63836723265;16087.356505739786;16650.83349166508;16905.15474226287;17162.056086915214;17239.91380043098;4957.107720610297;5097.209932460474;5101.183810590306;5107.8467645970495;5110.923336149961;5053.216751403538;5058.671186372892;5070.112730272188;5100.183970564711;5480.616356855022;5084.3644544431945;5272.6836389816735;5458.918116228259;5461.563074953994;5462.8361149165585;5278.604104692164;5285.286486324336;5303.814366497154;5305.549028332596;5311.256424100629;5132.974335128338;5332.733363331857;5375.865603359908;5402.270693456372;5422.620416570841;11805.822912656316;12083.395830208454;13967.511137110254;18962.577806664416;19028.904855475772;2077.6364136276243;2086.7182930304366;2135.6476181430044;2139.9514238023257;2201.328594778592;9057.547122643842;9231.353805233637;9499.38254013487;9542.618295268181;9888.060634239735;1747.6679430908214;1779.232016230896;1800.8199180082017;1828.4606041217874;1910.5605710686482;60258;62119.068213977276;62872.68563657152;63568.36431635671;64108.679456602884;10410.68767936963;10496.107830834311;10536.104431123287;10552.525136368882;10573.365598064142;13743.931280343535;13766.449342026206;13780.793288100687;13784.724305514033;13821.239831809347;7213.89179162313;7281.381082607932;7347.926520734724;7368.447366447431;7404.111506619132;6941.757038503628;6978.092847929736;6994.61529615876;7034.6834392452465;7052.118485189351;4508.143452743968;4534.863954081383;4571.862844114682;4583.72497650142;4615.192341340319;1817.3457555280088;1855.7030875059925;1858.6840237159715;1862.469196279054;1883.4914573065196;892.3976315986813;925.153484561632;940.5485367023867;1043.0664555223034;1070.2561719604955;15584.610384740472;16279.186040697918;16407.753883691756;16711.665766684597;16722.080285584165;900.5722281916169;910.0671811393374;918.7611221082567;924.4961495984704;972.5817898303798;9160.541972901461;9607.663731769495;9652.324337296463;9656.95171524152;9723.46520941355;390206;392730;396409;569897;575447;70316.64841675758;73369.63315183496;73480.3259837006;74806.62596686982;75363.62318188374;1054.9947250263854;1081.0270756319376;1081.2431298091367;1137.3346592243465;1178.4402408855897;15457.613559661098;15629.609259768597;15670.373185072469;15803.920980395484;15970.9201453992;35118.824405878826;35325.293494130485;35509.82245088758;36183.09542261464;36972;46613.30080048734;46736.29895551637;46988.295175573076;47837;49492.50507494879;9603.231741460806;9775.315727898978;10028.34815737004;10048.397096174253;10134;17830.643387131924;18207.726884097014;18306.725399118757;18421.723674144632;18450.16974236136;14194.361253743813;14501.78247326312;14798.408063677332;15132.243387830784;15232.857535684647;9524.95237523808;9565.330426870052;9990.500474976367;14293.785593216318;14372.49696260626;10339.121174700234;10489.055984961391;10597.62908298206;10661.733456663645;10674.62638807638;15335.61660958485;15378.461753838563;15610.765838512658;15717.921410393332;15808.209589520708;16309.755353669942;16358.918205408896;16549.50351489457;16763.1618419081;16942 10:26:48 INFO - PROCESS | 14659 | |3;mootools.html;1512.2514355394082;1674.5060207238866;1745.0489483231645;1760.6038641305709;1772.3885259585447;7304.415646748261;7326.560406375621;7511.06111736033;7512.286332798389;7555.735549255777;7492.363149132317;7510.2114278000845;7517.060367454068;7562.962185189066;7608.505447145932;2247.5841969235703;2265.4336415896028;2269.602819506588;2269.965950510744;2283.577538155438;2236.686863839064;2247.4718441166315;2287.794098531132;2304.6543018547186;2308.849924754894;2115.428834214769;2183.825293976478;2186.0709198590616;2195.0232146694725;2208.315422219109;2214.8449608527408;2216.0581752755097;2268.3988742983124;2268.455570663037;2269.7843704848096;2208.2602328220064;2241.4396400899777;2251.167068184766;2251.549690061994;2254.661800729887;7352.11774587053;7439.4048476122325;7439.739609113709;7443.702251909971;7444.404447644176;4521.321801729734;4607.539246075399;4617;4622.884427889296;4629.65277604181;2907.6946920573246;3058.4189004089153;3062.1579065756873;3074.123874695701;3078.9538156927665;962.4273557233505;972.4165500699523;983;1001.0340021878922;1021.5352014833308;9957.850632240523;9997.650082247159;10005;10006.44964526958;10039.347442416292;3839.5392552893272;3908.726389152732;3916.1971795781797;3946.7039972002217;4022.7988600569856;8138.796530086795;8139.38954578409;8172.264496195371;8193.057798353146;8204.220599043081;4421.513633500313;4435.489918659331;4451;4479.328100784843;4483;4066.3087275163293;4077.510698716173;4088.7546747195265;4107;4128.483939507561;3288.704016638514;3291.6274272389314;3300.339932013607;3305.6033276007033;3327.900162995114;1018.0582960761266;1020.6835880876952;1021.7649940513724;1036.7459972306833;1037.4034929915329;892.4511425473287;961.711486554031;1010.1161483701761;1086.8315411111291;1315.1977293850744;6768.661566921634;6825.419839313714;6825.624590647462;6831.931680683229;6853.520253582301;628.0641843652925;647.9611223326616;653.6470306034784;655.2333769489709;775.7302967989837;5472;5511.035568775448;5512.91730624041;5528.226048353234;5549.556035517149;8373.157905260832;8490;8650.697225597074;8709.91290087091;8770.91229087701;8487.193716596914;8601.35489838252;8617.138286171332;8623.611937462829;8693.782655433539;6841.076454678555;6990.895136572955;7029.0862187915245;7038.542494737826;7063.470239732041;6766.18805743314;6829.556078854858;6851.794446166623;6889.931100688929;6913.723451061901;7496.55020698738;7647.961760191386;7681.807954801175;7689.730859420118;7844.4901081429525;7718.498297610638;7851.293383595504;7870.331021863206;7871;7900.3284720799375;6148.985417406078;6313.43179113882;6319.368063193828;6364.395382438661;6486.481081513562;6962.268961758942;6978.127734033246;7004.964975175091;7021.262767409348;7043.049188359506;6269.717862696099;6409.35906409374;6661.966690166518;6750.797476075725;6758.459323254029;6453.9354606453335;6525.836854078686;6584.703688333941;6632.4694024478895;6698.162729658793;6610.867782644416;6630.436412904764;6697.162854643169;6789.796306110825;6804.523683342317;5833.591648584558;5855.590108692521;5858.238429004202;5860.970695146497;5861.853453663693;6015.639061656315;6026.156338112755;6040.577159598786;6041.697915104315;6053.75784968614 10:26:48 INFO - PROCESS | 14659 | |4;prototype.html;336.5557464147326;348.1036331446525;348.7192809788121;351.0819207771678;353.4362691507047;6251.09359142924;6287.648155646535;6383.329750376213;6389.872202555946;6490.026496025598;6267.153934218891;6316.431521163095;6355.841103972403;6361.141245931798;6364.268109167447;4804.447488538828;4826.372571565692;4842.15262329091;4842.467328593852;4845.248986407095;4846.7818948147415;4851.248056551241;4852.17513022787;4855.441624213207;4860.076585448754;4701.271302948048;4788.545088216614;4789.712617242976;4792.257200133985;4809.879753006167;4758.119747846642;4779.450363208223;4782.641301902371;4799.760011999421;4804.303376010459;4180.707350485467;4183.267928112568;4183.811728472226;4191.287481128215;4200.558941311149;5955.155349722848;6025.126356678301;6060.696965151725;6062.151298818169;6069.635821850703;5572.9411411831625;5623.409541998113;5628.831135065954;5629.887402251973;5631.971840140773;6745.0556922030955;6746;6754.088198093244;6769.323067693241;6775.254721980578;4623.214053610895;4637.5826175644015;4640.280756482751;4645.070985802853;4645.767711614406;6878.27778083299;6932.861342773167;6984.301569842975;7015.333543313377;7017.9649101755185;4591.150637132141;4595.563421474954;4598.563136502027;4612.630989520831;4612.838550650711;4679.64902632304;4685.976570117127;4689.6717229793585;4690.6951048182445;4697.6711630185555;5486.91769623456;5490.533304669068;5496.285482887279;5504.779808807602;5510.118381059092;6582;6711.530192886548;6728.9906514022305;6729.461643068543;6740.494462915203;1653.3717187468685;1665.8500734933914;1704.8465638092632;1711.5549957011267;1711.9144042797811;1129.5312445335258;1132.1226049811462;1139.4359791902896;1148.7128217945515;1149.0807354116673;6284.214473190851;6286.874262514724;6286.968565157145;6295.653739044396;6296.590721603173;6840.452763778886;6879.415249703731;6898.172219333712;6902.102726645504;6908.758193463305;6211.472024877936;6212.347703491158;6284.057391391328;6296.118543403927;6302.1177035215105;3790.77255364679;3815.5802861685193;3831.674307683878;3833.8083095845095;3835.7890316032326;7135;7164.713411463587;7182.928170718331;7188.353048225685;7201.495895287384;7072.151341839012;7239.276072392824;7239.565626062453;7250.528715633467;7261.059270995255;7180;7196.96401517989;7203.243659415791;7204.4956853019785;7213.855722885618;6995.475339349671;7003.544769590164;7003.649817509002;7007.929920700728;7011.579305241497;6751.93248067513;6912.619805910723;6931.202911665223;6937.132858392701;6943.375096241362;7186.856262874609;7188.28117188277;7189.856202876018;7196.460265480215;7203.531770434905;4736.407949006374;4776.9761151194025;4777.641676874179;4781.880452988703;4793;6853.143357080365;6868.313168683291;7014.789556313319;7024.683889225099;7064.858702826017;6785.219699734396;6813.523053386215;6815.352541508549;6832.965835170792;6841.281665425058;6782.728690852311;6802.6598670065305;6807.3873351398615;6817.965910170417;6834.692438840165;6576.671166441563;6657.1345725055435;6678.098456708282;6700.396964273239;6705.0612914193025;6842.692078856364;6866.141732283465;6874.862502749817;6882.483813714091;6895.931040689729;6684.933150668626;6714.060031595678;6720.663966801738;6727;6731.596104233761 10:26:48 INFO - PROCESS | 14659 | |5;yui.html;792.4532072869721;864.4899509289522;865.2040123086764;875.7460336502413;895.8566629339307;12513.061520385972;12715.745685086316;12756.170848894815;12789.360531973387;12819.551315703951;12818.487260509592;13274;13435.395407206675;13472.25902575358;13493.190408575469;815.8898548695939;835.4903508859607;838.4843321357351;843.3295530053622;844.3287586368851;829.8340331933638;833.017039892926;840.3529282452508;842.7176895739934;843.5444859775745;853.6457370191363;863.568215892054;869.9826003479926;871.5250188647202;876.1807709791334;863.9611217495259;865.3034307382554;868.2793281576277;868.5309932636369;869.7999460124207;634.5209366927986;636.4876274598946;637.8883695353295;638.2500561839867;638.9488840892717;13126.343682815916;13482.19106853592;13532.458701651922;13534.255615941218;13550.051496395256;12287.447064882102;12425.813612795815;12553.93723031379;12606.184503016828;12666.87333126666;9971.601135954554;10104;10172.643957461527;10349.430781307025;10576.153907687367;3649.434337677664;3684.5025921500524;3744.719146064056;3794.582595914475;3830.751001184914;49394.01211975776;49422.50577494215;49930.500694992945;50004;50207.74896125496;9816.263780216512;9871.210303175729;9901.356411833207;10145.543450544743;10182.18542516597;16450.506484805475;16456;16528.504144875675;16547.83452165487;16665.3333866644;7799.883001754978;7829.491083079695;7936.523808571505;7982.880256796153;8018.198180181935;3970.2059588082498;3982.8605998789903;4033.899152521152;4061.7766022868436;4071.633552980246;2864.1837076433117;2864.7421732044218;2870.2537340291674;2879.280179955011;2885.7402833745064;503.86647538402354;507.58124547248667;524.2738806752599;525.876419041525;526.1108726252621;630.4672551693811;632.5793347423912;640.4044238857907;641.2273210780997;680.9761658341935;7993.560354180459;8175.509469431853;8191.098979112293;8244.917550824535;8336.291415229653;605.5609682979805;637.7927173668484;661.0810972747885;679.9082123913307;703.711478293897;3945.546262179829;3999.7400168989507;4079.523889954176;4095.1809638072505;4117.547069822317;56122.71938640281;56323;56424.717876411174;56803;57276.14085788716;50682.493175068514;50976;51102;51217.74391128095;51801;46699.29951050737;46778.76610616925;46898.29652555214;47306.76346618314;48307;7928.603569821601;8157.877631835646;8162.6734930602115;8202.343812495106;8248.13394593559;37078.6292137086;38157.618423816515;38352.616473836024;38682.419763703;39096.2180756389;43855;44104.33843492286;44323.55676443323;46376.53623463722;46707.29939050985;10192.337498062601;10212.489375531342;10378.27352085377;10686.038256556947;10879.347239165676;11995.580154694893;12121.151519393557;12124.575639852563;12251.142420030512;12320.691982700504;10833.783324333312;10921.945390273315;10996.945015274872;11043.72390690207;11506;10363.378197308186;10369;10427.582896684351;10482.52828622729;10878.782424351626;10317.380957142595;10703.732406689895;10807.081398080936;10894.836577451186;10895;9146.496942668216;9329.253659707072;9688.079632434907;9818.705438836847;9933.155681766842;8897.955510222666;9251.352405331561;9676.951615241878;9718.271129665445;9730.95134524323 10:26:48 INFO - PROCESS | 14659 | __end_tp_report 10:26:48 INFO - PROCESS | 14659 | __start_cc_report 10:26:48 INFO - PROCESS | 14659 | _x_x_mozilla_cycle_collect,320 10:26:48 INFO - PROCESS | 14659 | __end_cc_report 10:26:48 INFO - PROCESS | 14659 | __startTimestamp1450808808513__endTimestamp 10:26:48 INFO - PROCESS | 14659 | 10:26:48 INFO - PROCESS | 14659 | ------- Summary: start ------- 10:26:48 INFO - PROCESS | 14659 | Number of tests: 6 10:26:48 INFO - PROCESS | 14659 | 10:26:48 INFO - PROCESS | 14659 | [#0] dojo.html Cycles:165 Average:5376.52 Median:5559.39 stddev:592.35 (10.7%) stddev-sans-first:568.64 10:26:48 INFO - PROCESS | 14659 | Values: 3183.8 3214.3 3234.3 3256.2 3260.6 5227.2 5356.8 5374.4 5378.6 5408.6 5275.7 5304.8 5317.8 5336.5 5338.7 4592.0 4859.3 5019.8 5035.7 5044.8 4790.8 4964.9 4973.3 5011.4 5043.9 4850.2 4851.7 4865.7 4945.7 4968.8 4965.2 4965.5 4972.1 4975.9 5018.2 4877.2 4916.7 4946.5 4958.2 5023.0 5204.9 5213.8 5220.4 5227.6 5286.9 5806.4 5843.3 5865.0 5889.6 5890.1 5791.0 5877.3 5880.5 5898.8 5909.1 5388.4 5401.0 5463.0 5466.8 5503.5 5883.6 5933.3 5941.3 5965.2 5971.5 5676.9 5679.9 5736.7 5753.1 5754.8 5760.4 5825.9 5859.5 5892.2 5966.9 5738.7 5770.7 5775.6 5782.9 5814.7 5614.9 5764.2 5767.3 5785.7 5791.7 4405.2 4430.2 4512.5 4516.4 4525.9 4000.1 4009.2 4012.9 4029.2 4055.2 5220.7 5344.8 5423.9 5430.2 5433.4 5755.9 5848.4 5858.9 5859.3 5912.9 5414.8 5417.1 5423.1 5435.8 5442.7 4908.5 4989.6 5010.8 5034.0 5055.3 5840.7 5889.1 5929.8 5930.7 5932.8 5816.0 5828.8 5829.0 5833.9 5859.6 5774.5 5805.2 5849.6 5904.3 5928.2 5674.4 5723.8 5741.4 5787.2 5796.6 5735.5 5775.1 5812.3 5841.7 5858.6 5546.2 5559.4 5564.0 5679.7 5702.4 5634.9 5648.9 5655.0 5673.3 5769.6 5504.3 5528.1 5531.9 5537.5 5538.7 5541.4 5626.8 5627.0 5658.5 5694.7 5645.2 5666.9 5666.9 5678.9 5689.7 10:26:48 INFO - PROCESS | 14659 | 10:26:48 INFO - PROCESS | 14659 | [#1] ext.html Cycles:180 Average:45919.11 Median:35307.06 stddev:76304.61 (216.1%) stddev-sans-first:76442.65 10:26:48 INFO - PROCESS | 14659 | Values: 555.8 582.9 594.3 595.6 601.0 38221.8 38585.4 38618.2 38698.8 38737.4 41611.4 41809.8 42121.6 42274.6 42475.6 8879.8 8974.7 8976.7 8986.9 8987.8 8692.6 8758.3 8854.6 8864.1 8867.4 8766.6 8830.7 8848.9 8896.2 8902.8 8482.4 8488.6 8543.5 8558.8 8596.1 8728.8 8818.5 8849.7 8855.6 8902.8 38925.4 39556.8 39586.8 39632.4 39723.0 3264.9 3337.5 3352.7 3466.2 3739.0 29822.1 30096.2 30303.5 30362.0 30585.4 3830.3 3915.6 4025.2 4028.5 4038.2 267113.0 267677.0 267694.0 268377.0 269133.0 57216.1 57378.4 57436.0 57490.0 57526.0 58184.4 60605.4 60773.0 67651.0 71135.0 14521.7 14766.0 14825.8 14871.9 14872.9 9958.2 10091.1 10116.6 10121.2 10122.5 19762.8 20293.6 20298.0 20325.1 20352.9 7508.3 7600.2 7609.2 7658.8 7713.3 916.4 970.4 1018.4 1063.1 1079.9 28023.3 28409.4 28449.6 28693.0 28699.9 1033.6 1079.2 1124.6 1127.4 1187.9 14644.0 14726.9 14758.6 14898.3 15033.6 311006.0 316234.0 317113.0 319998.0 320119.0 50652.2 51484.2 51607.2 51621.0 51677.5 1338.8 1355.9 1364.4 1372.1 1374.3 26569.5 27487.9 27655.3 27919.4 28087.6 45856.0 46106.8 46494.5 46523.8 46535.1 287325.0 288061.0 288315.0 289764.0 290893.0 31778.5 32130.0 32407.7 32409.2 32758.3 37624.8 37875.4 38224.0 38712.8 39021.6 33136.8 35365.0 36608.0 36617.0 36912.3 33638.5 33655.0 33681.7 33754.8 34821.8 34970.3 35097.1 35109.5 35249.1 35590.5 30341.0 30380.2 32006.4 32117.0 32262.7 24144.5 24212.5 24481.4 24491.5 24635.8 10:26:48 INFO - PROCESS | 14659 | 10:26:48 INFO - PROCESS | 14659 | [#2] jquery.html Cycles:180 Average:26673.88 Median:18271.88 stddev:77435.58 (423.8%) stddev-sans-first:77627.60 10:26:48 INFO - PROCESS | 14659 | Values: 360.7 362.9 363.5 365.2 368.7 16271.0 16709.7 17222.3 17421.9 18081.6 16087.4 16650.8 16905.2 17162.1 17239.9 4957.1 5097.2 5101.2 5107.8 5110.9 5053.2 5058.7 5070.1 5100.2 5480.6 5084.4 5272.7 5458.9 5461.6 5462.8 5278.6 5285.3 5303.8 5305.5 5311.3 5133.0 5332.7 5375.9 5402.3 5422.6 11805.8 12083.4 13967.5 18962.6 19028.9 2077.6 2086.7 2135.6 2140.0 2201.3 9057.5 9231.4 9499.4 9542.6 9888.1 1747.7 1779.2 1800.8 1828.5 1910.6 60258.0 62119.1 62872.7 63568.4 64108.7 10410.7 10496.1 10536.1 10552.5 10573.4 13743.9 13766.4 13780.8 13784.7 13821.2 7213.9 7281.4 7347.9 7368.4 7404.1 6941.8 6978.1 6994.6 7034.7 7052.1 4508.1 4534.9 4571.9 4583.7 4615.2 1817.3 1855.7 1858.7 1862.5 1883.5 892.4 925.2 940.5 1043.1 1070.3 15584.6 16279.2 16407.8 16711.7 16722.1 900.6 910.1 918.8 924.5 972.6 9160.5 9607.7 9652.3 9657.0 9723.5 390206.0 392730.0 396409.0 569897.0 575447.0 70316.6 73369.6 73480.3 74806.6 75363.6 1055.0 1081.0 1081.2 1137.3 1178.4 15457.6 15629.6 15670.4 15803.9 15970.9 35118.8 35325.3 35509.8 36183.1 36972.0 46613.3 46736.3 46988.3 47837.0 49492.5 9603.2 9775.3 10028.3 10048.4 10134.0 17830.6 18207.7 18306.7 18421.7 18450.2 14194.4 14501.8 14798.4 15132.2 15232.9 9525.0 9565.3 9990.5 14293.8 14372.5 10339.1 10489.1 10597.6 10661.7 10674.6 15335.6 15378.5 15610.8 15717.9 15808.2 16309.8 16358.9 16549.5 16763.2 16942.0 10:26:48 INFO - PROCESS | 14659 | 10:26:48 INFO - PROCESS | 14659 | [#3] mootools.html Cycles:180 Average:5127.86 Median:3470.75 stddev:2615.15 (75.3%) stddev-sans-first:2608.37 10:26:48 INFO - PROCESS | 14659 | Values: 1512.3 1674.5 1745.0 1760.6 1772.4 7304.4 7326.6 7511.1 7512.3 7555.7 7492.4 7510.2 7517.1 7563.0 7608.5 2247.6 2265.4 2269.6 2270.0 2283.6 2236.7 2247.5 2287.8 2304.7 2308.8 2115.4 2183.8 2186.1 2195.0 2208.3 2214.8 2216.1 2268.4 2268.5 2269.8 2208.3 2241.4 2251.2 2251.5 2254.7 7352.1 7439.4 7439.7 7443.7 7444.4 4521.3 4607.5 4617.0 4622.9 4629.7 2907.7 3058.4 3062.2 3074.1 3079.0 962.4 972.4 983.0 1001.0 1021.5 9957.9 9997.7 10005.0 10006.4 10039.3 3839.5 3908.7 3916.2 3946.7 4022.8 8138.8 8139.4 8172.3 8193.1 8204.2 4421.5 4435.5 4451.0 4479.3 4483.0 4066.3 4077.5 4088.8 4107.0 4128.5 3288.7 3291.6 3300.3 3305.6 3327.9 1018.1 1020.7 1021.8 1036.7 1037.4 892.5 961.7 1010.1 1086.8 1315.2 6768.7 6825.4 6825.6 6831.9 6853.5 628.1 648.0 653.6 655.2 775.7 5472.0 5511.0 5512.9 5528.2 5549.6 8373.2 8490.0 8650.7 8709.9 8770.9 8487.2 8601.4 8617.1 8623.6 8693.8 6841.1 6990.9 7029.1 7038.5 7063.5 6766.2 6829.6 6851.8 6889.9 6913.7 7496.6 7648.0 7681.8 7689.7 7844.5 7718.5 7851.3 7870.3 7871.0 7900.3 6149.0 6313.4 6319.4 6364.4 6486.5 6962.3 6978.1 7005.0 7021.3 7043.0 6269.7 6409.4 6662.0 6750.8 6758.5 6453.9 6525.8 6584.7 6632.5 6698.2 6610.9 6630.4 6697.2 6789.8 6804.5 5833.6 5855.6 5858.2 5861.0 5861.9 6015.6 6026.2 6040.6 6041.7 6053.8 10:26:48 INFO - PROCESS | 14659 | 10:26:48 INFO - PROCESS | 14659 | [#4] prototype.html Cycles:180 Average:5621.12 Median:6296.35 stddev:1711.02 (27.2%) stddev-sans-first:1669.21 10:26:48 INFO - PROCESS | 14659 | Values: 336.6 348.1 348.7 351.1 353.4 6251.1 6287.6 6383.3 6389.9 6490.0 6267.2 6316.4 6355.8 6361.1 6364.3 4804.4 4826.4 4842.2 4842.5 4845.2 4846.8 4851.2 4852.2 4855.4 4860.1 4701.3 4788.5 4789.7 4792.3 4809.9 4758.1 4779.5 4782.6 4799.8 4804.3 4180.7 4183.3 4183.8 4191.3 4200.6 5955.2 6025.1 6060.7 6062.2 6069.6 5572.9 5623.4 5628.8 5629.9 5632.0 6745.1 6746.0 6754.1 6769.3 6775.3 4623.2 4637.6 4640.3 4645.1 4645.8 6878.3 6932.9 6984.3 7015.3 7018.0 4591.2 4595.6 4598.6 4612.6 4612.8 4679.6 4686.0 4689.7 4690.7 4697.7 5486.9 5490.5 5496.3 5504.8 5510.1 6582.0 6711.5 6729.0 6729.5 6740.5 1653.4 1665.9 1704.8 1711.6 1711.9 1129.5 1132.1 1139.4 1148.7 1149.1 6284.2 6286.9 6287.0 6295.7 6296.6 6840.5 6879.4 6898.2 6902.1 6908.8 6211.5 6212.3 6284.1 6296.1 6302.1 3790.8 3815.6 3831.7 3833.8 3835.8 7135.0 7164.7 7182.9 7188.4 7201.5 7072.2 7239.3 7239.6 7250.5 7261.1 7180.0 7197.0 7203.2 7204.5 7213.9 6995.5 7003.5 7003.6 7007.9 7011.6 6751.9 6912.6 6931.2 6937.1 6943.4 7186.9 7188.3 7189.9 7196.5 7203.5 4736.4 4777.0 4777.6 4781.9 4793.0 6853.1 6868.3 7014.8 7024.7 7064.9 6785.2 6813.5 6815.4 6833.0 6841.3 6782.7 6802.7 6807.4 6818.0 6834.7 6576.7 6657.1 6678.1 6700.4 6705.1 6842.7 6866.1 6874.9 6882.5 6895.9 6684.9 6714.1 6720.7 6727.0 6731.6 10:26:48 INFO - PROCESS | 14659 | 10:26:48 INFO - PROCESS | 14659 | [#5] yui.html Cycles:180 Average:13789.17 Median:48850.51 stddev:16183.99 (33.1%) stddev-sans-first:16199.96 10:26:48 INFO - PROCESS | 14659 | Values: 792.5 864.5 865.2 875.7 895.9 12513.1 12715.7 12756.2 12789.4 12819.6 12818.5 13274.0 13435.4 13472.3 13493.2 815.9 835.5 838.5 843.3 844.3 829.8 833.0 840.4 842.7 843.5 853.6 863.6 870.0 871.5 876.2 864.0 865.3 868.3 868.5 869.8 634.5 636.5 637.9 638.3 638.9 13126.3 13482.2 13532.5 13534.3 13550.1 12287.4 12425.8 12553.9 12606.2 12666.9 9971.6 10104.0 10172.6 10349.4 10576.2 3649.4 3684.5 3744.7 3794.6 3830.8 49394.0 49422.5 49930.5 50004.0 50207.7 9816.3 9871.2 9901.4 10145.5 10182.2 16450.5 16456.0 16528.5 16547.8 16665.3 7799.9 7829.5 7936.5 7982.9 8018.2 3970.2 3982.9 4033.9 4061.8 4071.6 2864.2 2864.7 2870.3 2879.3 2885.7 503.9 507.6 524.3 525.9 526.1 630.5 632.6 640.4 641.2 681.0 7993.6 8175.5 8191.1 8244.9 8336.3 605.6 637.8 661.1 679.9 703.7 3945.5 3999.7 4079.5 4095.2 4117.5 56122.7 56323.0 56424.7 56803.0 57276.1 50682.5 50976.0 51102.0 51217.7 51801.0 46699.3 46778.8 46898.3 47306.8 48307.0 7928.6 8157.9 8162.7 8202.3 8248.1 37078.6 38157.6 38352.6 38682.4 39096.2 43855.0 44104.3 44323.6 46376.5 46707.3 10192.3 10212.5 10378.3 10686.0 10879.3 11995.6 12121.2 12124.6 12251.1 12320.7 10833.8 10921.9 10996.9 11043.7 11506.0 10363.4 10369.0 10427.6 10482.5 10878.8 10317.4 10703.7 10807.1 10894.8 10895.0 9146.5 9329.3 9688.1 9818.7 9933.2 8898.0 9251.4 9677.0 9718.3 9731.0 10:26:48 INFO - PROCESS | 14659 | -------- Summary: end -------- 10:26:48 INFO - PROCESS | 14659 | 10:26:49 INFO - TEST-INFO | 14659: exit 0 10:26:49 INFO - TEST-OK | dromaeo_css | took 1110303ms 10:26:49 INFO - TEST-START | kraken 10:26:49 INFO - operating with platform_type : linux_ 10:26:49 INFO - Initialising browser for kraken test... 10:26:49 INFO - TEST-INFO | started process 14903 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpa8eDsC/profile http://localhost:42430/getInfo.html) 10:26:53 INFO - PROCESS | 14903 | __metrics Screen width/height:1600/1200 10:26:53 INFO - PROCESS | 14903 | colorDepth:24 10:26:53 INFO - PROCESS | 14903 | Browser inner width/height: 1024/697 10:26:53 INFO - PROCESS | 14903 | __metrics 10:26:53 INFO - PROCESS | 14903 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:26:54 INFO - TEST-INFO | 14903: exit 0 10:26:54 INFO - Browser initialized. 10:26:54 INFO - Running cycle 1/1 for kraken test... 10:26:54 INFO - TEST-INFO | started process 15028 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpa8eDsC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:06 INFO - PROCESS | 15028 | RSS: Main: 150478848 10:27:06 INFO - PROCESS | 15028 | 10:27:09 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42430/tests/kraken/driver.html?testName=audio-beat-detection) 10:27:09 INFO - PROCESS | 15028 | RSS: Main: 151085056 10:27:09 INFO - PROCESS | 15028 | 10:27:12 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42430/tests/kraken/driver.html?testName=audio-dft) 10:27:12 INFO - PROCESS | 15028 | RSS: Main: 151887872 10:27:12 INFO - PROCESS | 15028 | 10:27:15 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42430/tests/kraken/driver.html?testName=audio-fft) 10:27:16 INFO - PROCESS | 15028 | RSS: Main: 145666048 10:27:16 INFO - PROCESS | 15028 | 10:27:18 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42430/tests/kraken/driver.html?testName=audio-oscillator) 10:27:19 INFO - PROCESS | 15028 | RSS: Main: 146481152 10:27:19 INFO - PROCESS | 15028 | 10:27:21 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:27:21 INFO - PROCESS | 15028 | RSS: Main: 146800640 10:27:21 INFO - PROCESS | 15028 | 10:27:24 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42430/tests/kraken/driver.html?testName=imaging-darkroom) 10:27:25 INFO - PROCESS | 15028 | RSS: Main: 147095552 10:27:25 INFO - PROCESS | 15028 | 10:27:28 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42430/tests/kraken/driver.html?testName=imaging-desaturate) 10:27:29 INFO - PROCESS | 15028 | RSS: Main: 148316160 10:27:29 INFO - PROCESS | 15028 | 10:27:32 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42430/tests/kraken/driver.html?testName=json-parse-financial) 10:27:32 INFO - PROCESS | 15028 | RSS: Main: 148668416 10:27:32 INFO - PROCESS | 15028 | 10:27:34 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:27:35 INFO - PROCESS | 15028 | RSS: Main: 146735104 10:27:35 INFO - PROCESS | 15028 | 10:27:36 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42430/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:27:37 INFO - PROCESS | 15028 | RSS: Main: 148287488 10:27:37 INFO - PROCESS | 15028 | 10:27:39 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:27:40 INFO - PROCESS | 15028 | RSS: Main: 148733952 10:27:40 INFO - PROCESS | 15028 | 10:27:42 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:27:43 INFO - PROCESS | 15028 | RSS: Main: 149770240 10:27:43 INFO - PROCESS | 15028 | 10:27:45 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:27:46 INFO - PROCESS | 15028 | RSS: Main: 149032960 10:27:46 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | Cycle 1(1): loaded http://localhost:42430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42430/tests/kraken/driver.html?testName=ai-astar) 10:27:48 INFO - PROCESS | 15028 | RSS: Main: 149454848 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | __start_tp_report 10:27:48 INFO - PROCESS | 15028 | _x_x_mozilla_page_load 10:27:48 INFO - PROCESS | 15028 | _x_x_mozilla_page_load_details 10:27:48 INFO - PROCESS | 15028 | |i|pagename|runs| 10:27:48 INFO - PROCESS | 15028 | |0;ai-astar;115;107;110;112;112;122;110;110;109;110 10:27:48 INFO - PROCESS | 15028 | |1;audio-beat-detection;153;123;146;163;125;149;152;127;165;125 10:27:48 INFO - PROCESS | 15028 | |2;audio-dft;163;162;164;162;170;162;161;165;168;162 10:27:48 INFO - PROCESS | 15028 | |3;audio-fft;72;72;71;72;73;143;71;76;72;72 10:27:48 INFO - PROCESS | 15028 | |4;audio-oscillator;93;94;141;93;94;93;138;94;94;133 10:27:48 INFO - PROCESS | 15028 | |5;imaging-gaussian-blur;110;110;110;111;109;110;111;110;110;110 10:27:48 INFO - PROCESS | 15028 | |6;imaging-darkroom;150;148;146;147;147;147;147;146;146;147 10:27:48 INFO - PROCESS | 15028 | |7;imaging-desaturate;96;97;96;96;98;96;96;96;96;96 10:27:48 INFO - PROCESS | 15028 | |8;json-parse-financial;63;62;62;60;61;66;59;60;60;57 10:27:48 INFO - PROCESS | 15028 | |9;json-stringify-tinderbox;67;75;67;68;68;68;68;68;69;68 10:27:48 INFO - PROCESS | 15028 | |10;stanford-crypto-aes;84;84;84;85;84;85;84;83;85;85 10:27:48 INFO - PROCESS | 15028 | |11;stanford-crypto-ccm;120;129;131;123;121;123;121;120;128;119 10:27:48 INFO - PROCESS | 15028 | |12;stanford-crypto-pbkdf2;144;151;151;150;152;151;152;166;149;141 10:27:48 INFO - PROCESS | 15028 | |13;stanford-crypto-sha256-iterative;67;73;69;69;68;68;68;67;68;67 10:27:48 INFO - PROCESS | 15028 | __end_tp_report 10:27:48 INFO - PROCESS | 15028 | __start_cc_report 10:27:48 INFO - PROCESS | 15028 | _x_x_mozilla_cycle_collect,735 10:27:48 INFO - PROCESS | 15028 | __end_cc_report 10:27:48 INFO - PROCESS | 15028 | __startTimestamp1450808868320__endTimestamp 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | ------- Summary: start ------- 10:27:48 INFO - PROCESS | 15028 | Number of tests: 14 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.00 stddev:4.19 (3.8%) stddev-sans-first:4.27 10:27:48 INFO - PROCESS | 15028 | Values: 115.0 107.0 110.0 112.0 112.0 122.0 110.0 110.0 109.0 110.0 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:150.50 stddev:16.38 (10.9%) stddev-sans-first:16.95 10:27:48 INFO - PROCESS | 15028 | Values: 153.0 123.0 146.0 163.0 125.0 149.0 152.0 127.0 165.0 125.0 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.96 (1.8%) stddev-sans-first:3.12 10:27:48 INFO - PROCESS | 15028 | Values: 163.0 162.0 164.0 162.0 170.0 162.0 161.0 165.0 168.0 162.0 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#3] audio-fft Cycles:10 Average:79.40 Median:72.00 stddev:22.39 (31.1%) stddev-sans-first:23.59 10:27:48 INFO - PROCESS | 15028 | Values: 72.0 72.0 71.0 72.0 73.0 143.0 71.0 76.0 72.0 72.0 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#4] audio-oscillator Cycles:10 Average:106.70 Median:93.50 stddev:21.23 (22.7%) stddev-sans-first:21.93 10:27:48 INFO - PROCESS | 15028 | Values: 93.0 94.0 141.0 93.0 94.0 93.0 138.0 94.0 94.0 133.0 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:27:48 INFO - PROCESS | 15028 | Values: 110.0 110.0 110.0 111.0 109.0 110.0 111.0 110.0 110.0 110.0 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:0.67 10:27:48 INFO - PROCESS | 15028 | Values: 150.0 148.0 146.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:27:48 INFO - PROCESS | 15028 | Values: 96.0 97.0 96.0 96.0 98.0 96.0 96.0 96.0 96.0 96.0 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:61.50 stddev:2.45 (4.0%) stddev-sans-first:2.49 10:27:48 INFO - PROCESS | 15028 | Values: 63.0 62.0 62.0 60.0 61.0 66.0 59.0 60.0 60.0 57.0 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.00 stddev:2.32 (3.4%) stddev-sans-first:2.39 10:27:48 INFO - PROCESS | 15028 | Values: 67.0 75.0 67.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.50 stddev:0.67 (0.8%) stddev-sans-first:0.71 10:27:48 INFO - PROCESS | 15028 | Values: 84.0 84.0 84.0 85.0 84.0 85.0 84.0 83.0 85.0 85.0 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:123.00 stddev:4.28 (3.5%) stddev-sans-first:4.34 10:27:48 INFO - PROCESS | 15028 | Values: 120.0 129.0 131.0 123.0 121.0 123.0 121.0 120.0 128.0 119.0 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:151.00 stddev:6.50 (4.3%) stddev-sans-first:6.42 10:27:48 INFO - PROCESS | 15028 | Values: 144.0 151.0 151.0 150.0 152.0 151.0 152.0 166.0 149.0 141.0 10:27:48 INFO - PROCESS | 15028 | 10:27:48 INFO - PROCESS | 15028 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:1.78 (2.6%) stddev-sans-first:1.81 10:27:48 INFO - PROCESS | 15028 | Values: 67.0 73.0 69.0 69.0 68.0 68.0 68.0 67.0 68.0 67.0 10:27:48 INFO - PROCESS | 15028 | -------- Summary: end -------- 10:27:48 INFO - PROCESS | 15028 | 10:27:49 INFO - TEST-INFO | 15028: exit 0 10:27:49 INFO - TEST-OK | kraken | took 59984ms 10:27:49 INFO - TEST-START | v8_7 10:27:49 INFO - operating with platform_type : linux_ 10:27:49 INFO - Initialising browser for v8_7 test... 10:27:49 INFO - TEST-INFO | started process 15314 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkAkiGl/profile http://localhost:42430/getInfo.html) 10:27:53 INFO - PROCESS | 15314 | __metrics Screen width/height:1600/1200 10:27:53 INFO - PROCESS | 15314 | colorDepth:24 10:27:53 INFO - PROCESS | 15314 | Browser inner width/height: 1024/697 10:27:53 INFO - PROCESS | 15314 | __metrics 10:27:53 INFO - PROCESS | 15314 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:27:54 INFO - TEST-INFO | 15314: exit 0 10:27:54 INFO - Browser initialized. 10:27:54 INFO - Running cycle 1/1 for v8_7 test... 10:27:54 INFO - TEST-INFO | started process 15434 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkAkiGl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:06 INFO - PROCESS | 15434 | RSS: Main: 150822912 10:28:06 INFO - PROCESS | 15434 | 10:28:27 INFO - PROCESS | 15434 | Cycle 1(1): loaded http://localhost:42430/tests/v8_7/run.html (next: http://localhost:42430/tests/v8_7/run.html) 10:28:28 INFO - PROCESS | 15434 | RSS: Main: 146673664 10:28:28 INFO - PROCESS | 15434 | 10:28:28 INFO - PROCESS | 15434 | __start_tp_report 10:28:28 INFO - PROCESS | 15434 | _x_x_mozilla_page_load 10:28:28 INFO - PROCESS | 15434 | _x_x_mozilla_page_load_details 10:28:28 INFO - PROCESS | 15434 | |i|pagename|runs| 10:28:28 INFO - PROCESS | 15434 | |0;Richards;166.11295681063123 10:28:28 INFO - PROCESS | 15434 | |1;DeltaBlue;188.11136192626034 10:28:28 INFO - PROCESS | 15434 | |2;Encrypt;279.56388034665923 10:28:28 INFO - PROCESS | 15434 | |3;Decrypt;5159.79381443299 10:28:28 INFO - PROCESS | 15434 | |4;RayTrace;1025.6410256410256 10:28:28 INFO - PROCESS | 15434 | |5;Earley;709.2198581560284 10:28:28 INFO - PROCESS | 15434 | |6;Boyer;12207.317073170732 10:28:28 INFO - PROCESS | 15434 | |7;RegExp;25050 10:28:28 INFO - PROCESS | 15434 | |8;Splay;861.3264427217915 10:28:28 INFO - PROCESS | 15434 | |9;NavierStokes;4840.579710144928 10:28:28 INFO - PROCESS | 15434 | __end_tp_report 10:28:28 INFO - PROCESS | 15434 | __startTimestamp1450808908134__endTimestamp 10:28:28 INFO - PROCESS | 15434 | 10:28:28 INFO - PROCESS | 15434 | ------- Summary: start ------- 10:28:28 INFO - PROCESS | 15434 | Number of tests: 10 10:28:28 INFO - PROCESS | 15434 | 10:28:28 INFO - PROCESS | 15434 | [#0] Richards Cycles:1 Average:166.11 Median:166.11 stddev:0.00 (0.0%) 10:28:28 INFO - PROCESS | 15434 | Values: 166.1 10:28:28 INFO - PROCESS | 15434 | 10:28:28 INFO - PROCESS | 15434 | [#1] DeltaBlue Cycles:1 Average:188.11 Median:188.11 stddev:0.00 (0.0%) 10:28:28 INFO - PROCESS | 15434 | Values: 188.1 10:28:28 INFO - PROCESS | 15434 | 10:28:28 INFO - PROCESS | 15434 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 10:28:28 INFO - PROCESS | 15434 | Values: 279.6 10:28:28 INFO - PROCESS | 15434 | 10:28:28 INFO - PROCESS | 15434 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 10:28:28 INFO - PROCESS | 15434 | Values: 5159.8 10:28:28 INFO - PROCESS | 15434 | 10:28:28 INFO - PROCESS | 15434 | [#4] RayTrace Cycles:1 Average:1025.64 Median:1025.64 stddev:0.00 (0.0%) 10:28:28 INFO - PROCESS | 15434 | Values: 1025.6 10:28:28 INFO - PROCESS | 15434 | 10:28:28 INFO - PROCESS | 15434 | [#5] Earley Cycles:1 Average:709.22 Median:709.22 stddev:0.00 (0.0%) 10:28:28 INFO - PROCESS | 15434 | Values: 709.2 10:28:28 INFO - PROCESS | 15434 | 10:28:28 INFO - PROCESS | 15434 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 10:28:28 INFO - PROCESS | 15434 | Values: 12207.3 10:28:28 INFO - PROCESS | 15434 | 10:28:28 INFO - PROCESS | 15434 | [#7] RegExp Cycles:1 Average:25050.00 Median:25050.00 stddev:0.00 (0.0%) 10:28:28 INFO - PROCESS | 15434 | Values: 25050.0 10:28:28 INFO - PROCESS | 15434 | 10:28:28 INFO - PROCESS | 15434 | [#8] Splay Cycles:1 Average:861.33 Median:861.33 stddev:0.00 (0.0%) 10:28:28 INFO - PROCESS | 15434 | Values: 861.3 10:28:28 INFO - PROCESS | 15434 | 10:28:28 INFO - PROCESS | 15434 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 10:28:28 INFO - PROCESS | 15434 | Values: 4840.6 10:28:28 INFO - PROCESS | 15434 | -------- Summary: end -------- 10:28:28 INFO - PROCESS | 15434 | 10:28:28 INFO - TEST-INFO | 15434: exit 0 10:28:29 INFO - TEST-OK | v8_7 | took 39791ms 10:28:29 INFO - SUITE-END | took 1210s 10:28:29 INFO - Completed test suite (00:20:10) 10:28:29 INFO - Working with test: dromaeo_css 10:28:29 INFO - Generating results file: dromaeo_css 10:28:29 INFO - Working with test: kraken 10:28:29 INFO - Generating results file: kraken 10:28:29 INFO - javascript benchmark 10:28:29 INFO - Working with test: v8_7 10:28:29 INFO - Generating results file: v8_7 10:28:29 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:28:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 10:28:29 INFO - process_Request line: dromaeo_css 6972.21 graph.html#tests=[[72,63,43]] 10:28:29 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:28:29 INFO - process_Request line: kraken 1514.50 graph.html#tests=[[232,63,43]] 10:28:29 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:28:29 INFO - process_Request line: v8_7 20768.34 graph.html#tests=[[230,63,43]] 10:28:29 INFO - RETURN: dromaeo_css: 6972.21 10:28:29 INFO - RETURN: kraken: 1514.50 10:28:29 INFO - RETURN: v8_7: 20768.34 10:28:29 INFO - javascript benchmark 10:28:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3183.7771356005082, 3214.3089235814296, 3234.3207926335467, 3256.218507558186, 3260.6250281217654, 5227.242049902762, 5356.758945847437, 5374.355077390709, 5378.623496355257, 5408.621396502242, 5275.683458992454, 5304.814331498398, 5317.760700768465, 5336.493033161853, 5338.733063346836, 4591.954080459186, 4859.27110933361, 5019.824306149286, 5035.697858128506, 5044.772985215655, 4790.7604619769045, 4964.925526117093, 4973.254011898208, 5011.398632164145, 5043.924341134886, 4850.151223535867, 4851.660383773137, 4865.732384718839, 4945.678530895516, 4968.801247950078, 4965.230389289666, 4965.528274813887, 4972.129877271463, 4975.900481990376, 5018.172001619765, 4877.219644856806, 4916.70499770015, 4946.530079642464, 4958.157113290749, 5023.020511000356, 5204.869878253036, 5213.843584692428, 5220.3735551734035, 5227.6079294052715, 5286.9471305287225, 5806.44838740319, 5843.29880414353, 5864.970675146597, 5889.587728858982, 5890.145928840337, 5790.971045144789, 5877.265341832271, 5880.529557635379, 5898.793542226002, 5909.054551271819, 5388.353397592275, 5401.0, 5463.043967305705, 5466.781328746845, 5503.532199762985, 5883.61756485827, 5933.317668468181, 5941.257342832146, 5965.164876917235, 5971.4924231439945, 5676.858078548069, 5679.949209396193, 5736.6558006519745, 5753.1370294456165, 5754.827355179351, 5760.423957604206, 5825.854353641193, 5859.501942334864, 5892.234009578728, 5966.880662386815, 5738.713064346766, 5770.682612456271, 5775.624584402, 5782.942170578324, 5814.680192589363, 5614.943850561442, 5764.164196191613, 5767.250257466502, 5785.71071446426, 5791.739371728282, 4405.163019026375, 4430.158269928703, 4512.548745125527, 4516.412866327357, 4525.886852828706, 4000.119973605802, 4009.2382447334912, 4012.8996775080855, 4029.194161167778, 4055.1889622075705, 5220.738963051832, 5344.839654810362, 5423.918641220384, 5430.15832545956, 5433.402325744165, 5755.9424405756245, 5848.415158484203, 5858.882822343529, 5859.267591551056, 5912.9113063304085, 5414.7834086636885, 5417.133258678671, 5423.132298832168, 5435.782568697208, 5442.727863606804, 4908.460069392364, 4989.625778066659, 5010.849674509771, 5034.0, 5055.266986287042, 5840.678762668009, 5889.087191485327, 5929.822105336761, 5930.733117009745, 5932.762689492372, 5815.9709201453725, 5828.825135245949, 5828.970855145697, 5833.883322333614, 5859.589828711949, 5774.48029677331, 5805.245318108618, 5849.64902105875, 5904.291485021825, 5928.229330187048, 5674.404187560247, 5723.7996670116345, 5741.397153299011, 5787.189793428839, 5796.594238403271, 5735.483806457439, 5775.104858746901, 5812.273465816773, 5841.737121829443, 5858.5898987070495, 5546.195801608825, 5559.388467268678, 5564.0, 5679.659220446786, 5702.37273899879, 5634.887302254014, 5648.915266271091, 5654.971725141348, 5673.319201695823, 5769.59612827098, 5504.284443022381, 5528.115501519737, 5531.917021244765, 5537.501624853782, 5538.695371754431, 5541.445855414427, 5626.803061892814, 5627.0434026214825, 5658.462446067617, 5694.715264236855, 5645.1532270159805, 5666.886662266814, 5666.914996275142, 5678.943210568007, 5689.687067211343], "unit": "score", "name": "dojo.html", "value": 5338.4136214740165}, {"lowerIsBetter": false, "replicates": [555.7722308892356, 582.8746819433821, 594.3313772006494, 595.6336852835504, 600.9669468179248, 38221.808890955544, 38585.42121868167, 38618.22763544731, 38698.8065059675, 38737.418938715906, 41611.37582936259, 41809.7909510452, 42121.57878421222, 42274.57725422745, 42475.57524424755, 8879.778005549864, 8974.730758077236, 8976.730698079067, 8986.910130898672, 8987.820243595124, 8692.565371731389, 8758.2993360531, 8854.601542930584, 8864.113588641148, 8867.423617464876, 8766.56167191641, 8830.735077947671, 8848.911510884906, 8896.243819275369, 8902.777430564223, 8482.448640838325, 8488.618012189436, 8543.530105844176, 8558.78603034926, 8596.140385961417, 8728.825423491558, 8818.470891746516, 8849.734507964771, 8855.645774169025, 8902.777430564223, 38925.41611875824, 39556.802215989024, 39586.802065989774, 39632.405513917314, 39723.0, 3264.853081611333, 3337.516060171286, 3352.7485438591957, 3466.2374277658873, 3739.0091625719206, 29822.10533683993, 30096.24759381033, 30303.545446818316, 30362.0, 30585.38829223403, 3830.291396091704, 3915.569287378386, 4025.2352053109817, 4028.47629808126, 4038.2327357801923, 267113.0, 267677.0, 267694.0, 268377.0, 269133.0, 57216.141757873665, 57378.426215738145, 57436.0, 57490.0, 57526.0, 58184.4181558179, 60605.39394606086, 60773.0, 67651.0, 71135.0, 14521.709565808625, 14766.0, 14825.77761333581, 14871.925640371945, 14872.925635371754, 9958.203343732628, 10091.091801737732, 10116.645917393003, 10121.1903047756, 10122.493875306205, 19762.802371976097, 20293.59412811765, 20298.0, 20325.085371158333, 20352.898235509023, 7508.2867127622785, 7600.225917540058, 7609.201033891472, 7658.770236892902, 7713.3443657288635, 916.3860213656733, 970.3983530211173, 1018.4245901065874, 1063.1388575254068, 1079.871919865775, 28023.299417514318, 28409.43181136366, 28449.57325640117, 28692.995745149237, 28699.856500717782, 1033.6278939581744, 1079.2067830144838, 1124.5907186433283, 1127.3517727306833, 1187.9346635935105, 14644.0, 14726.852731472762, 14758.63103422423, 14898.329575169144, 15033.624159396102, 311006.0, 316234.0, 317113.0, 319998.0, 320119.0, 50652.240216396785, 51484.227736583984, 51607.225891611655, 51621.0, 51677.48322516727, 1338.7791014482696, 1355.898307626932, 1364.351932831877, 1372.0532832345848, 1374.271636032904, 26569.468610628064, 27487.89591234073, 27655.30861728473, 27919.44161116807, 28087.578686319313, 45856.0, 46106.76946615245, 46494.535054650376, 46523.76738116288, 46535.069298614515, 287325.0, 288061.0, 288315.0, 289764.0, 290893.0, 31778.523322149726, 32130.0, 32407.675923241408, 32409.18977025499, 32758.34483310368, 37624.811875940446, 37875.431868522544, 38224.0, 38712.80643596764, 39021.6097839018, 33136.834315828266, 35365.0, 36608.0, 36617.0, 36912.261754764215, 33638.49542256917, 33655.0, 33681.663183367855, 33754.831225843714, 34821.82589087039, 34970.30059398747, 35097.122571935906, 35109.47335789914, 35249.1187720309, 35590.46614300736, 30341.0, 30380.240493986945, 32006.35987280288, 32117.0, 32262.677373225968, 24144.51710965806, 24212.51574968526, 24481.3879653003, 24491.51016979686, 24635.753642463347], "unit": "score", "name": "ext.html", "value": 18310.055180999407}, {"lowerIsBetter": false, "replicates": [360.6591770776615, 362.85848519077564, 363.54193715917967, 365.222076976041, 368.74188068352163, 16271.0, 16709.749353759704, 17222.3111075557, 17421.91289043553, 18081.63836723265, 16087.356505739786, 16650.83349166508, 16905.15474226287, 17162.056086915214, 17239.91380043098, 4957.107720610297, 5097.209932460474, 5101.183810590306, 5107.8467645970495, 5110.923336149961, 5053.216751403538, 5058.671186372892, 5070.112730272188, 5100.183970564711, 5480.616356855022, 5084.3644544431945, 5272.6836389816735, 5458.918116228259, 5461.563074953994, 5462.8361149165585, 5278.604104692164, 5285.286486324336, 5303.814366497154, 5305.549028332596, 5311.256424100629, 5132.974335128338, 5332.733363331857, 5375.865603359908, 5402.270693456372, 5422.620416570841, 11805.822912656316, 12083.395830208454, 13967.511137110254, 18962.577806664416, 19028.904855475772, 2077.6364136276243, 2086.7182930304366, 2135.6476181430044, 2139.9514238023257, 2201.328594778592, 9057.547122643842, 9231.353805233637, 9499.38254013487, 9542.618295268181, 9888.060634239735, 1747.6679430908214, 1779.232016230896, 1800.8199180082017, 1828.4606041217874, 1910.5605710686482, 60258.0, 62119.068213977276, 62872.68563657152, 63568.36431635671, 64108.679456602884, 10410.68767936963, 10496.107830834311, 10536.104431123287, 10552.525136368882, 10573.365598064142, 13743.931280343535, 13766.449342026206, 13780.793288100687, 13784.724305514033, 13821.239831809347, 7213.89179162313, 7281.381082607932, 7347.926520734724, 7368.447366447431, 7404.111506619132, 6941.757038503628, 6978.092847929736, 6994.61529615876, 7034.6834392452465, 7052.118485189351, 4508.143452743968, 4534.863954081383, 4571.862844114682, 4583.72497650142, 4615.192341340319, 1817.3457555280088, 1855.7030875059925, 1858.6840237159715, 1862.469196279054, 1883.4914573065196, 892.3976315986813, 925.153484561632, 940.5485367023867, 1043.0664555223034, 1070.2561719604955, 15584.610384740472, 16279.186040697918, 16407.753883691756, 16711.665766684597, 16722.080285584165, 900.5722281916169, 910.0671811393374, 918.7611221082567, 924.4961495984704, 972.5817898303798, 9160.541972901461, 9607.663731769495, 9652.324337296463, 9656.95171524152, 9723.46520941355, 390206.0, 392730.0, 396409.0, 569897.0, 575447.0, 70316.64841675758, 73369.63315183496, 73480.3259837006, 74806.62596686982, 75363.62318188374, 1054.9947250263854, 1081.0270756319376, 1081.2431298091367, 1137.3346592243465, 1178.4402408855897, 15457.613559661098, 15629.609259768597, 15670.373185072469, 15803.920980395484, 15970.9201453992, 35118.824405878826, 35325.293494130485, 35509.82245088758, 36183.09542261464, 36972.0, 46613.30080048734, 46736.29895551637, 46988.295175573076, 47837.0, 49492.50507494879, 9603.231741460806, 9775.315727898978, 10028.34815737004, 10048.397096174253, 10134.0, 17830.643387131924, 18207.726884097014, 18306.725399118757, 18421.723674144632, 18450.16974236136, 14194.361253743813, 14501.78247326312, 14798.408063677332, 15132.243387830784, 15232.857535684647, 9524.95237523808, 9565.330426870052, 9990.500474976367, 14293.785593216318, 14372.49696260626, 10339.121174700234, 10489.055984961391, 10597.62908298206, 10661.733456663645, 10674.62638807638, 15335.61660958485, 15378.461753838563, 15610.765838512658, 15717.921410393332, 15808.209589520708, 16309.755353669942, 16358.918205408896, 16549.50351489457, 16763.1618419081, 16942.0], "unit": "score", "name": "jquery.html", "value": 8819.558274700064}, {"lowerIsBetter": false, "replicates": [1512.2514355394082, 1674.5060207238866, 1745.0489483231645, 1760.6038641305709, 1772.3885259585447, 7304.415646748261, 7326.560406375621, 7511.06111736033, 7512.286332798389, 7555.735549255777, 7492.363149132317, 7510.2114278000845, 7517.060367454068, 7562.962185189066, 7608.505447145932, 2247.5841969235703, 2265.4336415896028, 2269.602819506588, 2269.965950510744, 2283.577538155438, 2236.686863839064, 2247.4718441166315, 2287.794098531132, 2304.6543018547186, 2308.849924754894, 2115.428834214769, 2183.825293976478, 2186.0709198590616, 2195.0232146694725, 2208.315422219109, 2214.8449608527408, 2216.0581752755097, 2268.3988742983124, 2268.455570663037, 2269.7843704848096, 2208.2602328220064, 2241.4396400899777, 2251.167068184766, 2251.549690061994, 2254.661800729887, 7352.11774587053, 7439.4048476122325, 7439.739609113709, 7443.702251909971, 7444.404447644176, 4521.321801729734, 4607.539246075399, 4617.0, 4622.884427889296, 4629.65277604181, 2907.6946920573246, 3058.4189004089153, 3062.1579065756873, 3074.123874695701, 3078.9538156927665, 962.4273557233505, 972.4165500699523, 983.0, 1001.0340021878922, 1021.5352014833308, 9957.850632240523, 9997.650082247159, 10005.0, 10006.44964526958, 10039.347442416292, 3839.5392552893272, 3908.726389152732, 3916.1971795781797, 3946.7039972002217, 4022.7988600569856, 8138.796530086795, 8139.38954578409, 8172.264496195371, 8193.057798353146, 8204.220599043081, 4421.513633500313, 4435.489918659331, 4451.0, 4479.328100784843, 4483.0, 4066.3087275163293, 4077.510698716173, 4088.7546747195265, 4107.0, 4128.483939507561, 3288.704016638514, 3291.6274272389314, 3300.339932013607, 3305.6033276007033, 3327.900162995114, 1018.0582960761266, 1020.6835880876952, 1021.7649940513724, 1036.7459972306833, 1037.4034929915329, 892.4511425473287, 961.711486554031, 1010.1161483701761, 1086.8315411111291, 1315.1977293850744, 6768.661566921634, 6825.419839313714, 6825.624590647462, 6831.931680683229, 6853.520253582301, 628.0641843652925, 647.9611223326616, 653.6470306034784, 655.2333769489709, 775.7302967989837, 5472.0, 5511.035568775448, 5512.91730624041, 5528.226048353234, 5549.556035517149, 8373.157905260832, 8490.0, 8650.697225597074, 8709.91290087091, 8770.91229087701, 8487.193716596914, 8601.35489838252, 8617.138286171332, 8623.611937462829, 8693.782655433539, 6841.076454678555, 6990.895136572955, 7029.0862187915245, 7038.542494737826, 7063.470239732041, 6766.18805743314, 6829.556078854858, 6851.794446166623, 6889.931100688929, 6913.723451061901, 7496.55020698738, 7647.961760191386, 7681.807954801175, 7689.730859420118, 7844.4901081429525, 7718.498297610638, 7851.293383595504, 7870.331021863206, 7871.0, 7900.3284720799375, 6148.985417406078, 6313.43179113882, 6319.368063193828, 6364.395382438661, 6486.481081513562, 6962.268961758942, 6978.127734033246, 7004.964975175091, 7021.262767409348, 7043.049188359506, 6269.717862696099, 6409.35906409374, 6661.966690166518, 6750.797476075725, 6758.459323254029, 6453.9354606453335, 6525.836854078686, 6584.703688333941, 6632.4694024478895, 6698.162729658793, 6610.867782644416, 6630.436412904764, 6697.162854643169, 6789.796306110825, 6804.523683342317, 5833.591648584558, 5855.590108692521, 5858.238429004202, 5860.970695146497, 5861.853453663693, 6015.639061656315, 6026.156338112755, 6040.577159598786, 6041.697915104315, 6053.75784968614], "unit": "score", "name": "mootools.html", "value": 4203.809843735454}, {"lowerIsBetter": false, "replicates": [336.5557464147326, 348.1036331446525, 348.7192809788121, 351.0819207771678, 353.4362691507047, 6251.09359142924, 6287.648155646535, 6383.329750376213, 6389.872202555946, 6490.026496025598, 6267.153934218891, 6316.431521163095, 6355.841103972403, 6361.141245931798, 6364.268109167447, 4804.447488538828, 4826.372571565692, 4842.15262329091, 4842.467328593852, 4845.248986407095, 4846.7818948147415, 4851.248056551241, 4852.17513022787, 4855.441624213207, 4860.076585448754, 4701.271302948048, 4788.545088216614, 4789.712617242976, 4792.257200133985, 4809.879753006167, 4758.119747846642, 4779.450363208223, 4782.641301902371, 4799.760011999421, 4804.303376010459, 4180.707350485467, 4183.267928112568, 4183.811728472226, 4191.287481128215, 4200.558941311149, 5955.155349722848, 6025.126356678301, 6060.696965151725, 6062.151298818169, 6069.635821850703, 5572.9411411831625, 5623.409541998113, 5628.831135065954, 5629.887402251973, 5631.971840140773, 6745.0556922030955, 6746.0, 6754.088198093244, 6769.323067693241, 6775.254721980578, 4623.214053610895, 4637.5826175644015, 4640.280756482751, 4645.070985802853, 4645.767711614406, 6878.27778083299, 6932.861342773167, 6984.301569842975, 7015.333543313377, 7017.9649101755185, 4591.150637132141, 4595.563421474954, 4598.563136502027, 4612.630989520831, 4612.838550650711, 4679.64902632304, 4685.976570117127, 4689.6717229793585, 4690.6951048182445, 4697.6711630185555, 5486.91769623456, 5490.533304669068, 5496.285482887279, 5504.779808807602, 5510.118381059092, 6582.0, 6711.530192886548, 6728.9906514022305, 6729.461643068543, 6740.494462915203, 1653.3717187468685, 1665.8500734933914, 1704.8465638092632, 1711.5549957011267, 1711.9144042797811, 1129.5312445335258, 1132.1226049811462, 1139.4359791902896, 1148.7128217945515, 1149.0807354116673, 6284.214473190851, 6286.874262514724, 6286.968565157145, 6295.653739044396, 6296.590721603173, 6840.452763778886, 6879.415249703731, 6898.172219333712, 6902.102726645504, 6908.758193463305, 6211.472024877936, 6212.347703491158, 6284.057391391328, 6296.118543403927, 6302.1177035215105, 3790.77255364679, 3815.5802861685193, 3831.674307683878, 3833.8083095845095, 3835.7890316032326, 7135.0, 7164.713411463587, 7182.928170718331, 7188.353048225685, 7201.495895287384, 7072.151341839012, 7239.276072392824, 7239.565626062453, 7250.528715633467, 7261.059270995255, 7180.0, 7196.96401517989, 7203.243659415791, 7204.4956853019785, 7213.855722885618, 6995.475339349671, 7003.544769590164, 7003.649817509002, 7007.929920700728, 7011.579305241497, 6751.93248067513, 6912.619805910723, 6931.202911665223, 6937.132858392701, 6943.375096241362, 7186.856262874609, 7188.28117188277, 7189.856202876018, 7196.460265480215, 7203.531770434905, 4736.407949006374, 4776.9761151194025, 4777.641676874179, 4781.880452988703, 4793.0, 6853.143357080365, 6868.313168683291, 7014.789556313319, 7024.683889225099, 7064.858702826017, 6785.219699734396, 6813.523053386215, 6815.352541508549, 6832.965835170792, 6841.281665425058, 6782.728690852311, 6802.6598670065305, 6807.3873351398615, 6817.965910170417, 6834.692438840165, 6576.671166441563, 6657.1345725055435, 6678.098456708282, 6700.396964273239, 6705.0612914193025, 6842.692078856364, 6866.141732283465, 6874.862502749817, 6882.483813714091, 6895.931040689729, 6684.933150668626, 6714.060031595678, 6720.663966801738, 6727.0, 6731.596104233761], "unit": "score", "name": "prototype.html", "value": 5062.293670359081}, {"lowerIsBetter": false, "replicates": [792.4532072869721, 864.4899509289522, 865.2040123086764, 875.7460336502413, 895.8566629339307, 12513.061520385972, 12715.745685086316, 12756.170848894815, 12789.360531973387, 12819.551315703951, 12818.487260509592, 13274.0, 13435.395407206675, 13472.25902575358, 13493.190408575469, 815.8898548695939, 835.4903508859607, 838.4843321357351, 843.3295530053622, 844.3287586368851, 829.8340331933638, 833.017039892926, 840.3529282452508, 842.7176895739934, 843.5444859775745, 853.6457370191363, 863.568215892054, 869.9826003479926, 871.5250188647202, 876.1807709791334, 863.9611217495259, 865.3034307382554, 868.2793281576277, 868.5309932636369, 869.7999460124207, 634.5209366927986, 636.4876274598946, 637.8883695353295, 638.2500561839867, 638.9488840892717, 13126.343682815916, 13482.19106853592, 13532.458701651922, 13534.255615941218, 13550.051496395256, 12287.447064882102, 12425.813612795815, 12553.93723031379, 12606.184503016828, 12666.87333126666, 9971.601135954554, 10104.0, 10172.643957461527, 10349.430781307025, 10576.153907687367, 3649.434337677664, 3684.5025921500524, 3744.719146064056, 3794.582595914475, 3830.751001184914, 49394.01211975776, 49422.50577494215, 49930.500694992945, 50004.0, 50207.74896125496, 9816.263780216512, 9871.210303175729, 9901.356411833207, 10145.543450544743, 10182.18542516597, 16450.506484805475, 16456.0, 16528.504144875675, 16547.83452165487, 16665.3333866644, 7799.883001754978, 7829.491083079695, 7936.523808571505, 7982.880256796153, 8018.198180181935, 3970.2059588082498, 3982.8605998789903, 4033.899152521152, 4061.7766022868436, 4071.633552980246, 2864.1837076433117, 2864.7421732044218, 2870.2537340291674, 2879.280179955011, 2885.7402833745064, 503.86647538402354, 507.58124547248667, 524.2738806752599, 525.876419041525, 526.1108726252621, 630.4672551693811, 632.5793347423912, 640.4044238857907, 641.2273210780997, 680.9761658341935, 7993.560354180459, 8175.509469431853, 8191.098979112293, 8244.917550824535, 8336.291415229653, 605.5609682979805, 637.7927173668484, 661.0810972747885, 679.9082123913307, 703.711478293897, 3945.546262179829, 3999.7400168989507, 4079.523889954176, 4095.1809638072505, 4117.547069822317, 56122.71938640281, 56323.0, 56424.717876411174, 56803.0, 57276.14085788716, 50682.493175068514, 50976.0, 51102.0, 51217.74391128095, 51801.0, 46699.29951050737, 46778.76610616925, 46898.29652555214, 47306.76346618314, 48307.0, 7928.603569821601, 8157.877631835646, 8162.6734930602115, 8202.343812495106, 8248.13394593559, 37078.6292137086, 38157.618423816515, 38352.616473836024, 38682.419763703, 39096.2180756389, 43855.0, 44104.33843492286, 44323.55676443323, 46376.53623463722, 46707.29939050985, 10192.337498062601, 10212.489375531342, 10378.27352085377, 10686.038256556947, 10879.347239165676, 11995.580154694893, 12121.151519393557, 12124.575639852563, 12251.142420030512, 12320.691982700504, 10833.783324333312, 10921.945390273315, 10996.945015274872, 11043.72390690207, 11506.0, 10363.378197308186, 10369.0, 10427.582896684351, 10482.52828622729, 10878.782424351626, 10317.380957142595, 10703.732406689895, 10807.081398080936, 10894.836577451186, 10895.0, 9146.496942668216, 9329.253659707072, 9688.079632434907, 9818.705438836847, 9933.155681766842, 8897.955510222666, 9251.352405331561, 9676.951615241878, 9718.271129665445, 9730.95134524323], "unit": "score", "name": "yui.html", "value": 6261.002919148371}], "name": "dromaeo_css", "value": 6972.208093123794}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 107.0, 110.0, 112.0, 112.0, 122.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [153.0, 123.0, 146.0, 163.0, 125.0, 149.0, 152.0, 127.0, 165.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 142.8}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 164.0, 162.0, 170.0, 162.0, 161.0, 165.0, 168.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 72.0, 73.0, 143.0, 71.0, 76.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 141.0, 93.0, 94.0, 93.0, 138.0, 94.0, 94.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [150.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 62.0, 60.0, 61.0, 66.0, 59.0, 60.0, 60.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 61.0}, {"lowerIsBetter": true, "replicates": [67.0, 75.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 83.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [120.0, 129.0, 131.0, 123.0, 121.0, 123.0, 121.0, 120.0, 128.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [144.0, 151.0, 151.0, 150.0, 152.0, 151.0, 152.0, 166.0, 149.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [67.0, 73.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1514.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.11295681063123], "unit": "score", "name": "Richards", "value": 212.51804000000004}, {"lowerIsBetter": false, "replicates": [188.11136192626034], "unit": "score", "name": "DeltaBlue", "value": 351.483288}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1025.6410256410256], "unit": "score", "name": "RayTrace", "value": 721.489275}, {"lowerIsBetter": false, "replicates": [709.2198581560284], "unit": "score", "name": "Earley", "value": 939.71283}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25050.0], "unit": "score", "name": "RegExp", "value": 36.36666666666668}, {"lowerIsBetter": false, "replicates": [861.3264427217915], "unit": "score", "name": "Splay", "value": 94.61105099999997}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20768.335509657398}]} 10:28:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20768.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1514.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6972.21"}}} 10:28:29 INFO - Return code: 0 10:28:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:28:29 INFO - # TBPL SUCCESS # 10:28:29 INFO - Running post-action listener: _resource_record_post_action 10:28:29 INFO - Running post-run listener: _resource_record_post_run 10:28:30 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 8192; Write bytes: 559751168; Read time: 164; Write time: 586596 10:28:30 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 240283648; Read time: 28; Write time: 367992 10:28:30 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318427136; Read time: 136; Write time: 215212 10:28:30 INFO - Running post-run listener: _upload_blobber_files 10:28:30 INFO - Blob upload gear active. 10:28:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:28:30 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 10:28:30 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'] 10:28:30 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 10:28:31 INFO - (blobuploader) - INFO - Open directory for files ... 10:28:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:28:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:28:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:31 INFO - (blobuploader) - INFO - Done attempting. 10:28:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:28:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:28:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:32 INFO - (blobuploader) - INFO - Done attempting. 10:28:32 INFO - (blobuploader) - INFO - Iteration through files over. 10:28:32 INFO - Return code: 0 10:28:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:28:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:28:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e04ee3909665d4a6062354d4c714bb3cf015279e33475c803fb2147d2607fd6ee50ab1326d8482bdff5686bb8484d324b75f68d58caee6af02565d7c8d0ce6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef8a694cf9817d92ea5130574c361a1950851f5aaf252ee0e998bc788fd8fdc7ae07dda2894596231999636ffdac3f66c39599cec12f51eeca0d618ae23d499b"} 10:28:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:28:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:28:32 INFO - Contents: 10:28:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e04ee3909665d4a6062354d4c714bb3cf015279e33475c803fb2147d2607fd6ee50ab1326d8482bdff5686bb8484d324b75f68d58caee6af02565d7c8d0ce6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef8a694cf9817d92ea5130574c361a1950851f5aaf252ee0e998bc788fd8fdc7ae07dda2894596231999636ffdac3f66c39599cec12f51eeca0d618ae23d499b"} 10:28:32 INFO - Copying logs to upload dir... 10:28:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.678813 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-22 10:28:31.558348) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 10:28:31.561906) ========= 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=820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e04ee3909665d4a6062354d4c714bb3cf015279e33475c803fb2147d2607fd6ee50ab1326d8482bdff5686bb8484d324b75f68d58caee6af02565d7c8d0ce6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef8a694cf9817d92ea5130574c361a1950851f5aaf252ee0e998bc788fd8fdc7ae07dda2894596231999636ffdac3f66c39599cec12f51eeca0d618ae23d499b"} build_url:https://queue.taskcluster.net/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011505 build_url: 'https://queue.taskcluster.net/v1/task/EA4PyyQHRYqkYUuUUYE98w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e04ee3909665d4a6062354d4c714bb3cf015279e33475c803fb2147d2607fd6ee50ab1326d8482bdff5686bb8484d324b75f68d58caee6af02565d7c8d0ce6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef8a694cf9817d92ea5130574c361a1950851f5aaf252ee0e998bc788fd8fdc7ae07dda2894596231999636ffdac3f66c39599cec12f51eeca0d618ae23d499b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 10:28:31.587653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:28:31.588028) ========= 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=820bb6602ddf640013a48df2000001a9-1450807648.430845-1048388708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:28:31.672728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 10:28:31.673097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 10:28:31.673458) ========= ========= Total master_lag: 0.27 =========