builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1451976649.68 results: success (0) buildid: 20160104203108 builduid: dec117debe16424e93092e8680e72dca revision: 740ebb163d6fd390ab0d6ad0fcf2301706dd9bfb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:49.679173) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:49.679711) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:49.680006) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006479 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:49.703735) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:49.704034) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:49.728576) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:49.728902) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:49.782811) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:49.783084) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:49.783477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:49.783754) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 22:50:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-01-04 22:50:51 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162423 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:49.959372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:49.959736) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022430 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:50.010460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:50.010880) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 740ebb163d6fd390ab0d6ad0fcf2301706dd9bfb --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/b2g-inbound --rev 740ebb163d6fd390ab0d6ad0fcf2301706dd9bfb --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=97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 22:50:51,406 truncating revision to first 12 chars 2016-01-04 22:50:51,406 Setting DEBUG logging. 2016-01-04 22:50:51,406 attempt 1/10 2016-01-04 22:50:51,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/740ebb163d6f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 22:50:51,640 unpacking tar archive at: b2g-inbound-740ebb163d6f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528893 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:50.552699) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:50.553037) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:50.608503) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:50.608784) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 22:50:50.609144) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-04 22:50:50.609456) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:50:52 INFO - MultiFileLogger online at 20160104 22:50:52 in /builds/slave/test-pgo 22:50:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 22:50:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:50:52 INFO - {'append_to_log': False, 22:50:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:50:52 INFO - 'blob_upload_branch': 'B2G-Inbound', 22:50:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:50:52 INFO - 'branch': 'B2G-Inbound', 22:50:52 INFO - 'buildbot_json_path': 'buildprops.json', 22:50:52 INFO - 'config_files': ('talos/linux_config.py',), 22:50:52 INFO - 'default_actions': ('clobber', 22:50:52 INFO - 'read-buildbot-config', 22:50:52 INFO - 'download-and-extract', 22:50:52 INFO - 'populate-webroot', 22:50:52 INFO - 'create-virtualenv', 22:50:52 INFO - 'install', 22:50:52 INFO - 'run-tests'), 22:50:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:50:52 INFO - 'download_minidump_stackwalk': True, 22:50:52 INFO - 'download_symbols': 'ondemand', 22:50:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:50:52 INFO - 'tooltool.py': '/tools/tooltool.py', 22:50:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:50:52 INFO - '/tools/misc-python/virtualenv.py')}, 22:50:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:50:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:50:52 INFO - 'installer_path': 'installer.exe', 22:50:52 INFO - 'log_level': 'info', 22:50:52 INFO - 'log_name': 'talos', 22:50:52 INFO - 'log_to_console': True, 22:50:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:50:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:50:52 INFO - 'opt_config_files': (), 22:50:52 INFO - 'pip_index': False, 22:50:52 INFO - 'sps_profile': False, 22:50:52 INFO - 'sps_profile_interval': 0, 22:50:52 INFO - 'suite': 'dromaeojs', 22:50:52 INFO - 'system_bits': '32', 22:50:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:50:52 INFO - 'title': 'talos-linux64-ix-068', 22:50:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:50:52 INFO - 'use_talos_json': True, 22:50:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:50:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:50:52 INFO - 'work_dir': 'build'} 22:50:52 INFO - ##### 22:50:52 INFO - ##### Running clobber step. 22:50:52 INFO - ##### 22:50:52 INFO - Running pre-action listener: _resource_record_pre_action 22:50:52 INFO - Running main action method: clobber 22:50:52 INFO - rmtree: /builds/slave/test-pgo/build 22:50:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:50:52 INFO - Running post-action listener: _resource_record_post_action 22:50:52 INFO - ##### 22:50:52 INFO - ##### Running read-buildbot-config step. 22:50:52 INFO - ##### 22:50:52 INFO - Running pre-action listener: _resource_record_pre_action 22:50:52 INFO - Running main action method: read_buildbot_config 22:50:52 INFO - Using buildbot properties: 22:50:52 INFO - { 22:50:52 INFO - "project": "", 22:50:52 INFO - "product": "firefox", 22:50:52 INFO - "script_repo_revision": "production", 22:50:52 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 22:50:52 INFO - "repository": "", 22:50:52 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 22:50:52 INFO - "buildid": "20160104203108", 22:50:52 INFO - "pgo_build": "True", 22:50:52 INFO - "basedir": "/builds/slave/test-pgo", 22:50:52 INFO - "buildnumber": 8, 22:50:52 INFO - "slavename": "talos-linux64-ix-068", 22:50:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:50:52 INFO - "platform": "ubuntu64_hw", 22:50:52 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 22:50:52 INFO - "branch": "b2g-inbound", 22:50:52 INFO - "repo_path": "integration/b2g-inbound", 22:50:52 INFO - "revision": "740ebb163d6fd390ab0d6ad0fcf2301706dd9bfb", 22:50:52 INFO - "stage_platform": "linux64-pgo", 22:50:52 INFO - "builduid": "dec117debe16424e93092e8680e72dca", 22:50:52 INFO - "slavebuilddir": "test" 22:50:52 INFO - } 22:50:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:50:52 INFO - Running post-action listener: _resource_record_post_action 22:50:52 INFO - ##### 22:50:52 INFO - ##### Running download-and-extract step. 22:50:52 INFO - ##### 22:50:52 INFO - Running pre-action listener: _resource_record_pre_action 22:50:52 INFO - Running main action method: download_and_extract 22:50:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:50: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')]} 22:50:52 INFO - https://queue.taskcluster.net/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:50:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/test_packages.json 22:50:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/test_packages.json 22:50:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:50:55 INFO - Downloaded 1302 bytes. 22:50:55 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:50:55 INFO - Using the following test package requirements: 22:50:55 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:50:55 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:50:55 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:55 INFO - u'jsshell-linux-x86_64.zip'], 22:50:55 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:50:55 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:50:55 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:50:55 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:50:55 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:50:55 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:50:55 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:50:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:50: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')]} 22:50:55 INFO - https://queue.taskcluster.net/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:50:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/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 22:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/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 22:50:58 INFO - Downloaded 23198035 bytes. 22:50:58 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 22:50:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:58 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 22:50:59 INFO - Return code: 0 22:50:59 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 22:50:59 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')]} 22:50:59 INFO - https://queue.taskcluster.net/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:50:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/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 22:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/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 22:51:01 INFO - Downloaded 23198035 bytes. 22:51:01 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 22:51:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:51:01 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 22:51:02 INFO - Return code: 0 22:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:02 INFO - https://queue.taskcluster.net/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:51:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:51:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:51:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/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 22:51:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/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 22:51:04 INFO - Downloaded 11132285 bytes. 22:51:04 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 22:51:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:51:04 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 22:51:04 INFO - Return code: 0 22:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:51:04 INFO - https://queue.taskcluster.net/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:51:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:51:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:51:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/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 22:51:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CselPyI5SbCpGUf8hU8Ieg/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 22:51:06 INFO - Downloaded 54981858 bytes. 22:51:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:51:06 INFO - mkdir: /builds/slave/test-pgo/properties 22:51:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:51:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:51:06 INFO - Contents: 22:51:06 INFO - build_url:https://queue.taskcluster.net/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:51:06 INFO - Running post-action listener: _resource_record_post_action 22:51:06 INFO - Running post-action listener: set_extra_try_arguments 22:51:06 INFO - ##### 22:51:06 INFO - ##### Running populate-webroot step. 22:51:06 INFO - ##### 22:51:06 INFO - Running pre-action listener: _resource_record_pre_action 22:51:06 INFO - Running main action method: populate_webroot 22:51:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:51:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:51:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:51:06 INFO - '--tppagecycles', 22:51:06 INFO - '7'], 22:51:06 INFO - 'tests': ['tsvgm']}}, 22:51:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:51:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:51:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:51:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:51:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:51:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:51:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:51:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:06 INFO - 'talos_options': ['--e10s'], 22:51:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:51:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:06 INFO - 'tests': ['damp', 'tps']}, 22:51:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:06 INFO - 'talos_options': ['--e10s'], 22:51:06 INFO - 'tests': ['damp', 'tps']}, 22:51:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:51:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:51:06 INFO - 'other': {'tests': ['a11yr', 22:51:06 INFO - 'ts_paint', 22:51:06 INFO - 'tpaint', 22:51:06 INFO - 'sessionrestore', 22:51:06 INFO - 'sessionrestore_no_auto_restore']}, 22:51:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:51:06 INFO - 'tests': ['a11yr', 22:51:06 INFO - 'ts_paint', 22:51:06 INFO - 'tpaint', 22:51:06 INFO - 'sessionrestore', 22:51:06 INFO - 'sessionrestore_no_auto_restore']}, 22:51:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:51:06 INFO - 'tests': ['a11yr', 22:51:06 INFO - 'ts_paint', 22:51:06 INFO - 'tpaint', 22:51:06 INFO - 'sessionrestore', 22:51:06 INFO - 'sessionrestore_no_auto_restore']}, 22:51:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:51:06 INFO - 'tests': ['a11yr', 22:51:06 INFO - 'ts_paint', 22:51:06 INFO - 'tpaint', 22:51:06 INFO - 'sessionrestore', 22:51:06 INFO - 'sessionrestore_no_auto_restore']}, 22:51:06 INFO - 'other_l64': {'tests': ['a11yr', 22:51:06 INFO - 'ts_paint', 22:51:06 INFO - 'tpaint', 22:51:06 INFO - 'sessionrestore', 22:51:06 INFO - 'sessionrestore_no_auto_restore']}, 22:51:06 INFO - 'other_nol64': {'tests': ['a11yr', 22:51:06 INFO - 'ts_paint', 22:51:06 INFO - 'tpaint', 22:51:06 INFO - 'sessionrestore', 22:51:06 INFO - 'sessionrestore_no_auto_restore']}, 22:51:06 INFO - 'svgr': {'tests': ['tsvgx', 22:51:06 INFO - 'tsvgr_opacity', 22:51:06 INFO - 'tart', 22:51:06 INFO - 'tscrollx', 22:51:06 INFO - 'cart']}, 22:51:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:51:06 INFO - 'tests': ['tsvgx', 22:51:06 INFO - 'tsvgr_opacity', 22:51:06 INFO - 'tart', 22:51:06 INFO - 'tscrollx', 22:51:06 INFO - 'cart']}, 22:51:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:06 INFO - 'tests': ['tp5o']}, 22:51:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:06 INFO - 'talos_options': ['--e10s'], 22:51:06 INFO - 'tests': ['tp5o']}, 22:51:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:06 INFO - 'talos_options': ['--xperf_path', 22:51:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:51:06 INFO - 'tests': ['tp5n']}, 22:51:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:06 INFO - 'talos_options': ['--e10s', 22:51:06 INFO - '--xperf_path', 22:51:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:51:06 INFO - 'tests': ['tp5n']}}, 22:51:06 INFO - 'talos.zip': {'path': '', 22:51:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:51:06 INFO - Running post-action listener: _resource_record_post_action 22:51:06 INFO - ##### 22:51:06 INFO - ##### Running create-virtualenv step. 22:51:06 INFO - ##### 22:51:06 INFO - Running pre-action listener: _resource_record_pre_action 22:51:06 INFO - Running main action method: create_virtualenv 22:51:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:51:06 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 22:51:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:51:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:51:06 INFO - Using real prefix '/usr' 22:51:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:51:06 INFO - Installing distribute.............................................................................................................................................................................................done. 22:51:08 INFO - Installing pip.................done. 22:51:08 INFO - Return code: 0 22:51:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:51:08 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')]} 22:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:08 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')]} 22:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:08 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 0x7f837bf81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1147360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6540>, '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 0x11d7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d78f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', '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 22:51:08 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 22:51:08 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 22:51:08 INFO - Using env: {'DISPLAY': ':0', 22:51:08 INFO - 'HOME': '/home/cltbld', 22:51:08 INFO - 'LANG': 'en_US.UTF-8', 22:51:08 INFO - 'LANGUAGE': 'en_US:en', 22:51:08 INFO - 'LOGNAME': 'cltbld', 22:51:08 INFO - 'MAIL': '/var/mail/cltbld', 22:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:08 INFO - 'MOZ_NO_REMOTE': '1', 22:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:08 INFO - 'NO_EM_RESTART': '1', 22:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:08 INFO - 'SHELL': '/bin/bash', 22:51:08 INFO - 'SHLVL': '1', 22:51:08 INFO - 'TERM': 'linux', 22:51:08 INFO - 'TMOUT': '86400', 22:51:08 INFO - 'USER': 'cltbld', 22:51:08 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', 22:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:08 INFO - '_': '/tools/buildbot/bin/python'} 22:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:08 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 22:51:08 INFO - Cleaning up... 22:51:08 INFO - Return code: 0 22:51:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:51:08 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')]} 22:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:08 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')]} 22:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:08 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 0x7f837bf81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1147360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6540>, '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 0x11d7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d78f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', '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 22:51:08 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 22:51:08 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 22:51:08 INFO - Using env: {'DISPLAY': ':0', 22:51:08 INFO - 'HOME': '/home/cltbld', 22:51:08 INFO - 'LANG': 'en_US.UTF-8', 22:51:08 INFO - 'LANGUAGE': 'en_US:en', 22:51:08 INFO - 'LOGNAME': 'cltbld', 22:51:08 INFO - 'MAIL': '/var/mail/cltbld', 22:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:08 INFO - 'MOZ_NO_REMOTE': '1', 22:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:08 INFO - 'NO_EM_RESTART': '1', 22:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:08 INFO - 'SHELL': '/bin/bash', 22:51:08 INFO - 'SHLVL': '1', 22:51:08 INFO - 'TERM': 'linux', 22:51:08 INFO - 'TMOUT': '86400', 22:51:08 INFO - 'USER': 'cltbld', 22:51:08 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', 22:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:08 INFO - '_': '/tools/buildbot/bin/python'} 22:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:09 INFO - Downloading/unpacking psutil>=0.7.1 22:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:11 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:51:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:51:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:51:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:51:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:51:11 INFO - Installing collected packages: psutil 22:51:11 INFO - Running setup.py install for psutil 22:51:11 INFO - building 'psutil._psutil_linux' extension 22:51:11 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 22:51:11 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 22:51:11 INFO - building 'psutil._psutil_posix' extension 22:51:11 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 22:51:11 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 22:51:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:51:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:51:11 INFO - Successfully installed psutil 22:51:11 INFO - Cleaning up... 22:51:11 INFO - Return code: 0 22:51:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f837bf81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1147360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6540>, '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 0x11d7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d78f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', '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 22:51:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:51:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:51:11 INFO - Using env: {'DISPLAY': ':0', 22:51:11 INFO - 'HOME': '/home/cltbld', 22:51:11 INFO - 'LANG': 'en_US.UTF-8', 22:51:11 INFO - 'LANGUAGE': 'en_US:en', 22:51:11 INFO - 'LOGNAME': 'cltbld', 22:51:11 INFO - 'MAIL': '/var/mail/cltbld', 22:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:11 INFO - 'MOZ_NO_REMOTE': '1', 22:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:11 INFO - 'NO_EM_RESTART': '1', 22:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:11 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:11 INFO - 'SHELL': '/bin/bash', 22:51:11 INFO - 'SHLVL': '1', 22:51:11 INFO - 'TERM': 'linux', 22:51:11 INFO - 'TMOUT': '86400', 22:51:11 INFO - 'USER': 'cltbld', 22:51:11 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', 22:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:11 INFO - '_': '/tools/buildbot/bin/python'} 22:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:51:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:51:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:51:13 INFO - Installing collected packages: mozsystemmonitor 22:51:13 INFO - Running setup.py install for mozsystemmonitor 22:51:13 INFO - Successfully installed mozsystemmonitor 22:51:13 INFO - Cleaning up... 22:51:13 INFO - Return code: 0 22:51:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f837bf81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1147360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6540>, '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 0x11d7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d78f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', '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 22:51:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:51:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:51:13 INFO - Using env: {'DISPLAY': ':0', 22:51:13 INFO - 'HOME': '/home/cltbld', 22:51:13 INFO - 'LANG': 'en_US.UTF-8', 22:51:13 INFO - 'LANGUAGE': 'en_US:en', 22:51:13 INFO - 'LOGNAME': 'cltbld', 22:51:13 INFO - 'MAIL': '/var/mail/cltbld', 22:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:13 INFO - 'MOZ_NO_REMOTE': '1', 22:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:13 INFO - 'NO_EM_RESTART': '1', 22:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:13 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:13 INFO - 'SHELL': '/bin/bash', 22:51:13 INFO - 'SHLVL': '1', 22:51:13 INFO - 'TERM': 'linux', 22:51:13 INFO - 'TMOUT': '86400', 22:51:13 INFO - 'USER': 'cltbld', 22:51:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', 22:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:13 INFO - '_': '/tools/buildbot/bin/python'} 22:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:14 INFO - Downloading/unpacking blobuploader==1.2.4 22:51:14 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 22:51:14 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 22:51:14 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 22:51:14 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 22:51:14 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 22:51:14 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 22:51:15 INFO - Downloading blobuploader-1.2.4.tar.gz 22:51:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:51:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:51:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:51:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:51:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:16 INFO - Downloading docopt-0.6.1.tar.gz 22:51:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:51:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:51:16 INFO - Installing collected packages: blobuploader, requests, docopt 22:51:16 INFO - Running setup.py install for blobuploader 22:51:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:51:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:51:16 INFO - Running setup.py install for requests 22:51:16 INFO - Running setup.py install for docopt 22:51:17 INFO - Successfully installed blobuploader requests docopt 22:51:17 INFO - Cleaning up... 22:51:17 INFO - Return code: 0 22:51:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:51: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')]} 22:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:17 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 0x7f837bf81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1147360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6540>, '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 0x11d7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d78f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', '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 22:51:17 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 22:51:17 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 22:51:17 INFO - Using env: {'DISPLAY': ':0', 22:51:17 INFO - 'HOME': '/home/cltbld', 22:51:17 INFO - 'LANG': 'en_US.UTF-8', 22:51:17 INFO - 'LANGUAGE': 'en_US:en', 22:51:17 INFO - 'LOGNAME': 'cltbld', 22:51:17 INFO - 'MAIL': '/var/mail/cltbld', 22:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:17 INFO - 'MOZ_NO_REMOTE': '1', 22:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:17 INFO - 'NO_EM_RESTART': '1', 22:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:17 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:17 INFO - 'SHELL': '/bin/bash', 22:51:17 INFO - 'SHLVL': '1', 22:51:17 INFO - 'TERM': 'linux', 22:51:17 INFO - 'TMOUT': '86400', 22:51:17 INFO - 'USER': 'cltbld', 22:51:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', 22:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:17 INFO - '_': '/tools/buildbot/bin/python'} 22:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:51:17 INFO - Running setup.py (path:/tmp/pip-mioWqj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:51:17 INFO - Running setup.py (path:/tmp/pip-c7XqVy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:51:17 INFO - Running setup.py (path:/tmp/pip-14w9Ps-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:51:17 INFO - Running setup.py (path:/tmp/pip-WDAnY_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:51:17 INFO - Running setup.py (path:/tmp/pip-bEYtpZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:51:17 INFO - Running setup.py (path:/tmp/pip-GsLqYI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:51:17 INFO - Running setup.py (path:/tmp/pip-ZXuEB8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:51:17 INFO - Running setup.py (path:/tmp/pip-fVl5nz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:51:17 INFO - Running setup.py (path:/tmp/pip-iUqQIN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:17 INFO - Running setup.py (path:/tmp/pip-XW82hK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:17 INFO - Running setup.py (path:/tmp/pip-vXnuRt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:18 INFO - Running setup.py (path:/tmp/pip-oSTPda-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:18 INFO - Running setup.py (path:/tmp/pip-Qy9jQ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:18 INFO - Running setup.py (path:/tmp/pip-OhjZI6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:18 INFO - Running setup.py (path:/tmp/pip-eQ2Gxy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:18 INFO - Running setup.py (path:/tmp/pip-zcAxO2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:18 INFO - Running setup.py (path:/tmp/pip-H6XJ8x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:51:18 INFO - Running setup.py install for manifestparser 22:51:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:51:18 INFO - Running setup.py install for mozcrash 22:51:18 INFO - Running setup.py install for mozdebug 22:51:18 INFO - Running setup.py install for mozdevice 22:51:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:51:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:51:18 INFO - Running setup.py install for mozfile 22:51:19 INFO - Running setup.py install for mozhttpd 22:51:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:51:19 INFO - Running setup.py install for mozinfo 22:51:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:51:19 INFO - Running setup.py install for mozInstall 22:51:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:51:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:51:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:51:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:51:19 INFO - Running setup.py install for mozleak 22:51:19 INFO - Running setup.py install for mozlog 22:51:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:51:19 INFO - Running setup.py install for moznetwork 22:51:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:51:19 INFO - Running setup.py install for mozprocess 22:51:19 INFO - Running setup.py install for mozprofile 22:51:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:51:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:51:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:51:19 INFO - Running setup.py install for mozrunner 22:51:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:51:19 INFO - Running setup.py install for mozscreenshot 22:51:20 INFO - Running setup.py install for moztest 22:51:20 INFO - Running setup.py install for mozversion 22:51:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:51:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:51:20 INFO - Cleaning up... 22:51:20 INFO - Return code: 0 22:51:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:20 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 0x7f837bf81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1147360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6540>, '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 0x11d7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d78f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', '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 22:51:20 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 22:51:20 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 22:51:20 INFO - Using env: {'DISPLAY': ':0', 22:51:20 INFO - 'HOME': '/home/cltbld', 22:51:20 INFO - 'LANG': 'en_US.UTF-8', 22:51:20 INFO - 'LANGUAGE': 'en_US:en', 22:51:20 INFO - 'LOGNAME': 'cltbld', 22:51:20 INFO - 'MAIL': '/var/mail/cltbld', 22:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:20 INFO - 'MOZ_NO_REMOTE': '1', 22:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:20 INFO - 'NO_EM_RESTART': '1', 22:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:20 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:20 INFO - 'SHELL': '/bin/bash', 22:51:20 INFO - 'SHLVL': '1', 22:51:20 INFO - 'TERM': 'linux', 22:51:20 INFO - 'TMOUT': '86400', 22:51:20 INFO - 'USER': 'cltbld', 22:51:20 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', 22:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:20 INFO - '_': '/tools/buildbot/bin/python'} 22:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:51:20 INFO - Running setup.py (path:/tmp/pip-7nDGCP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:51:20 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)) 22:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:51:20 INFO - Running setup.py (path:/tmp/pip-s8MJlv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:51:20 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)) 22:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:51:20 INFO - Running setup.py (path:/tmp/pip-z0nPk0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:51:20 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)) 22:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:51:20 INFO - Running setup.py (path:/tmp/pip-RRnqyo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:51:20 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)) 22:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:51:20 INFO - Running setup.py (path:/tmp/pip-SKwtEE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:51:20 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)) 22:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:51:20 INFO - Running setup.py (path:/tmp/pip-KEBxD9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:51:20 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)) 22:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:51:20 INFO - Running setup.py (path:/tmp/pip-KaRMwr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:51:21 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)) 22:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:51:21 INFO - Running setup.py (path:/tmp/pip-1qQwr8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:51:21 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)) 22:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:51:21 INFO - Running setup.py (path:/tmp/pip-lOBZWo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:51:21 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)) 22:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:21 INFO - Running setup.py (path:/tmp/pip-AFzmoj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:21 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)) 22:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:21 INFO - Running setup.py (path:/tmp/pip-R9O2_t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:21 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)) 22:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:21 INFO - Running setup.py (path:/tmp/pip-eIPNkK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:21 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)) 22:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:21 INFO - Running setup.py (path:/tmp/pip-FXDxuF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:21 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)) 22:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:21 INFO - Running setup.py (path:/tmp/pip-wbtvVQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:21 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)) 22:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:21 INFO - Running setup.py (path:/tmp/pip-jLPk1f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:21 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)) 22:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:21 INFO - Running setup.py (path:/tmp/pip-LMK6YM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:21 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)) 22:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:21 INFO - Running setup.py (path:/tmp/pip-jZ2VZ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:21 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)) 22:51:21 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)) 22:51:21 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)) 22:51:21 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)) 22:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:51:21 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)) 22:51:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:23 INFO - Downloading blessings-1.5.1.tar.gz 22:51:23 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 22:51:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:51:23 INFO - Installing collected packages: blessings 22:51:23 INFO - Running setup.py install for blessings 22:51:23 INFO - Successfully installed blessings 22:51:23 INFO - Cleaning up... 22:51:23 INFO - Return code: 0 22:51:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:51:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:51:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:51:24 INFO - Reading from file tmpfile_stdout 22:51:24 INFO - Current package versions: 22:51:24 INFO - argparse == 1.2.1 22:51:24 INFO - blessings == 1.5.1 22:51:24 INFO - blobuploader == 1.2.4 22:51:24 INFO - docopt == 0.6.1 22:51:24 INFO - manifestparser == 1.1 22:51:24 INFO - mozInstall == 1.12 22:51:24 INFO - mozcrash == 0.16 22:51:24 INFO - mozdebug == 0.1 22:51:24 INFO - mozdevice == 0.47 22:51:24 INFO - mozfile == 1.2 22:51:24 INFO - mozhttpd == 0.7 22:51:24 INFO - mozinfo == 0.9 22:51:24 INFO - mozleak == 0.1 22:51:24 INFO - mozlog == 3.1 22:51:24 INFO - moznetwork == 0.27 22:51:24 INFO - mozprocess == 0.22 22:51:24 INFO - mozprofile == 0.28 22:51:24 INFO - mozrunner == 6.11 22:51:24 INFO - mozscreenshot == 0.1 22:51:24 INFO - mozsystemmonitor == 0.0 22:51:24 INFO - moztest == 0.7 22:51:24 INFO - mozversion == 1.4 22:51:24 INFO - psutil == 3.1.1 22:51:24 INFO - requests == 1.2.3 22:51:24 INFO - wsgiref == 0.1.2 22:51:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f837bf81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1147360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6540>, '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 0x11d7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d78f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', '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 22:51:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 22:51:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 22:51:24 INFO - Using env: {'DISPLAY': ':0', 22:51:24 INFO - 'HOME': '/home/cltbld', 22:51:24 INFO - 'LANG': 'en_US.UTF-8', 22:51:24 INFO - 'LANGUAGE': 'en_US:en', 22:51:24 INFO - 'LOGNAME': 'cltbld', 22:51:24 INFO - 'MAIL': '/var/mail/cltbld', 22:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:24 INFO - 'MOZ_NO_REMOTE': '1', 22:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:24 INFO - 'NO_EM_RESTART': '1', 22:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:24 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:24 INFO - 'SHELL': '/bin/bash', 22:51:24 INFO - 'SHLVL': '1', 22:51:24 INFO - 'TERM': 'linux', 22:51:24 INFO - 'TMOUT': '86400', 22:51:24 INFO - 'USER': 'cltbld', 22:51:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', 22:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:24 INFO - '_': '/tools/buildbot/bin/python'} 22:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:24 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)) 22:51:24 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)) 22:51:24 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)) 22:51:24 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)) 22:51:24 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)) 22:51:24 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)) 22:51:24 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)) 22:51:24 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)) 22:51:24 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)) 22:51:24 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)) 22:51:24 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)) 22:51:24 INFO - Cleaning up... 22:51:24 INFO - Return code: 0 22:51:24 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f837bf81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1147360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6540>, '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 0x11d7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d78f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', '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 22:51:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:51:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:51:24 INFO - Using env: {'DISPLAY': ':0', 22:51:24 INFO - 'HOME': '/home/cltbld', 22:51:24 INFO - 'LANG': 'en_US.UTF-8', 22:51:24 INFO - 'LANGUAGE': 'en_US:en', 22:51:24 INFO - 'LOGNAME': 'cltbld', 22:51:24 INFO - 'MAIL': '/var/mail/cltbld', 22:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:24 INFO - 'MOZ_NO_REMOTE': '1', 22:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:24 INFO - 'NO_EM_RESTART': '1', 22:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:24 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:24 INFO - 'SHELL': '/bin/bash', 22:51:24 INFO - 'SHLVL': '1', 22:51:24 INFO - 'TERM': 'linux', 22:51:24 INFO - 'TMOUT': '86400', 22:51:24 INFO - 'USER': 'cltbld', 22:51:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', 22:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:24 INFO - '_': '/tools/buildbot/bin/python'} 22:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:24 INFO - Downloading/unpacking jsonschema 22:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:51:26 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 22:51:26 INFO - Downloading/unpacking functools32 (from jsonschema) 22:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:26 INFO - Downloading functools32-3.2.3-2.tar.gz 22:51:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:51:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:51:26 INFO - warning: no files found matching '*.txt' 22:51:26 INFO - no previously-included directories found matching 'build' 22:51:26 INFO - no previously-included directories found matching 'dist' 22:51:26 INFO - no previously-included directories found matching '.git*' 22:51:26 INFO - Installing collected packages: jsonschema, functools32 22:51:26 INFO - Running setup.py install for functools32 22:51:26 INFO - warning: no files found matching '*.txt' 22:51:26 INFO - no previously-included directories found matching 'build' 22:51:26 INFO - no previously-included directories found matching 'dist' 22:51:26 INFO - no previously-included directories found matching '.git*' 22:51:26 INFO - Successfully installed jsonschema functools32 22:51:26 INFO - Cleaning up... 22:51:26 INFO - Return code: 0 22:51:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:26 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 0x7f837bf81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1147360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6540>, '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 0x11d7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d78f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', '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 22:51:26 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 22:51:26 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 22:51:26 INFO - Using env: {'DISPLAY': ':0', 22:51:26 INFO - 'HOME': '/home/cltbld', 22:51:26 INFO - 'LANG': 'en_US.UTF-8', 22:51:26 INFO - 'LANGUAGE': 'en_US:en', 22:51:26 INFO - 'LOGNAME': 'cltbld', 22:51:26 INFO - 'MAIL': '/var/mail/cltbld', 22:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:26 INFO - 'MOZ_NO_REMOTE': '1', 22:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:26 INFO - 'NO_EM_RESTART': '1', 22:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:26 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:26 INFO - 'SHELL': '/bin/bash', 22:51:26 INFO - 'SHLVL': '1', 22:51:26 INFO - 'TERM': 'linux', 22:51:26 INFO - 'TMOUT': '86400', 22:51:26 INFO - 'USER': 'cltbld', 22:51:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', 22:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:26 INFO - '_': '/tools/buildbot/bin/python'} 22:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:26 INFO - Downloading/unpacking flake8 22:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:51:28 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 22:51:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:51:28 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 22:51:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:29 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 22:51:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:51:29 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 22:51:29 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 22:51:29 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 22:51:29 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 22:51:29 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 22:51:29 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 22:51:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:51:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:51:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:51:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:51:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:51:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:51:29 INFO - no previously-included directories found matching 'docs/_build' 22:51:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:51:29 INFO - Running setup.py install for pep8 22:51:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:51:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:51:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:51:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:51:29 INFO - no previously-included directories found matching 'docs/_build' 22:51:29 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:51:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:51:29 INFO - Cleaning up... 22:51:29 INFO - Return code: 0 22:51:29 INFO - Running post-action listener: _resource_record_post_action 22:51:29 INFO - Running post-action listener: _start_resource_monitoring 22:51:29 INFO - Starting resource monitoring. 22:51:29 INFO - ##### 22:51:29 INFO - ##### Running install step. 22:51:29 INFO - ##### 22:51:29 INFO - Running pre-action listener: _resource_record_pre_action 22:51:29 INFO - Running main action method: install 22:51:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:51:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:51:29 INFO - Reading from file tmpfile_stdout 22:51:29 INFO - Detecting whether we're running mozinstall >=1.0... 22:51:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:51:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:51:29 INFO - Reading from file tmpfile_stdout 22:51:29 INFO - Output received: 22:51:29 INFO - Usage: mozinstall [options] installer 22:51:29 INFO - Options: 22:51:29 INFO - -h, --help show this help message and exit 22:51:29 INFO - -d DEST, --destination=DEST 22:51:29 INFO - Directory to install application into. [default: 22:51:29 INFO - "/builds/slave/test-pgo"] 22:51:29 INFO - --app=APP Application being installed. [default: firefox] 22:51:29 INFO - mkdir: /builds/slave/test-pgo/build/application 22:51:29 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'] 22:51:29 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 22:51:45 INFO - Reading from file tmpfile_stdout 22:51:45 INFO - Output received: 22:51:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:51:45 INFO - Running post-action listener: _resource_record_post_action 22:51:45 INFO - ##### 22:51:45 INFO - ##### Running run-tests step. 22:51:45 INFO - ##### 22:51:45 INFO - Running pre-action listener: _resource_record_pre_action 22:51:45 INFO - Running main action method: run_tests 22:51:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:51:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:51:45 INFO - Python 2.7.3 22:51:45 INFO - Return code: 0 22:51:45 INFO - grabbing minidump binary from tooltool 22:51: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')]} 22:51:45 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 0x11d6540>, '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 0x11d7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d78f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:51:45 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 22:51:45 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 22:51:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:51:45 INFO - Return code: 0 22:51:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:51:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:51:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:51:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:51:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:51:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:51:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:51:46 INFO - Return code: 0 22:51:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:51:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:51:46 INFO - Using env: {'DISPLAY': ':0', 22:51:46 INFO - 'HOME': '/home/cltbld', 22:51:46 INFO - 'LANG': 'en_US.UTF-8', 22:51:46 INFO - 'LANGUAGE': 'en_US:en', 22:51:46 INFO - 'LOGNAME': 'cltbld', 22:51:46 INFO - 'MAIL': '/var/mail/cltbld', 22:51:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:51:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:46 INFO - 'MOZ_NO_REMOTE': '1', 22:51:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:46 INFO - 'NO_EM_RESTART': '1', 22:51:46 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:46 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:51:46 INFO - 'SHELL': '/bin/bash', 22:51:46 INFO - 'SHLVL': '1', 22:51:46 INFO - 'TERM': 'linux', 22:51:46 INFO - 'TMOUT': '86400', 22:51:46 INFO - 'USER': 'cltbld', 22:51:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600', 22:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:46 INFO - '_': '/tools/buildbot/bin/python'} 22:51:46 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:51:46 INFO - mozversion application_buildid: 20160104203108 22:51:46 INFO - mozversion application_changeset: 740ebb163d6fd390ab0d6ad0fcf2301706dd9bfb 22:51:46 INFO - mozversion application_display_name: Nightly 22:51:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:51:46 INFO - mozversion application_name: Firefox 22:51:46 INFO - mozversion application_remotingname: firefox 22:51:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 22:51:46 INFO - mozversion application_vendor: Mozilla 22:51:46 INFO - mozversion application_version: 46.0a1 22:51:46 INFO - mozversion platform_buildid: 20160104203108 22:51:46 INFO - mozversion platform_changeset: 740ebb163d6fd390ab0d6ad0fcf2301706dd9bfb 22:51:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 22:51:46 INFO - mozversion platform_version: 46.0a1 22:51:46 INFO - using testdate: 1451976706 22:51:46 INFO - actual date: 1451976706 22:51:47 INFO - starting webserver on 'localhost:38482' 22:51:47 INFO - SUITE-START | Running 3 tests 22:51:47 INFO - TEST-START | dromaeo_css 22:51:47 INFO - operating with platform_type : linux_ 22:51:47 INFO - Initialising browser for dromaeo_css test... 22:51:47 INFO - TEST-INFO | started process 13440 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiIH_KT/profile http://localhost:38482/getInfo.html) 22:51:51 INFO - PROCESS | 13440 | __metrics Screen width/height:1600/1200 22:51:51 INFO - PROCESS | 13440 | colorDepth:24 22:51:51 INFO - PROCESS | 13440 | Browser inner width/height: 1024/697 22:51:51 INFO - PROCESS | 13440 | __metrics 22:51:51 INFO - PROCESS | 13440 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:51:51 INFO - PROCESS | 13440 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:51:52 INFO - TEST-INFO | 13440: exit 0 22:51:52 INFO - Browser initialized. 22:51:52 INFO - Running cycle 1/1 for dromaeo_css test... 22:51:52 INFO - TEST-INFO | started process 13536 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiIH_KT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:52:04 INFO - PROCESS | 13536 | RSS: Main: 150310912 22:52:04 INFO - PROCESS | 13536 | 22:52:55 INFO - PROCESS | 13536 | 1451976775824 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] 22:55:04 INFO - PROCESS | 13536 | Cycle 1(1): loaded http://localhost:38482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38482/tests/dromaeo/cssquery-ext.html) 22:55:05 INFO - PROCESS | 13536 | RSS: Main: 271073280 22:55:05 INFO - PROCESS | 13536 | 22:58:08 INFO - PROCESS | 13536 | Cycle 1(1): loaded http://localhost:38482/tests/dromaeo/cssquery-ext.html (next: http://localhost:38482/tests/dromaeo/cssquery-jquery.html) 22:58:08 INFO - PROCESS | 13536 | RSS: Main: 241192960 22:58:08 INFO - PROCESS | 13536 | 23:01:10 INFO - PROCESS | 13536 | Cycle 1(1): loaded http://localhost:38482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38482/tests/dromaeo/cssquery-mootools.html) 23:01:11 INFO - PROCESS | 13536 | RSS: Main: 223014912 23:01:11 INFO - PROCESS | 13536 | 23:04:12 INFO - PROCESS | 13536 | Cycle 1(1): loaded http://localhost:38482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38482/tests/dromaeo/cssquery-prototype.html) 23:04:13 INFO - PROCESS | 13536 | RSS: Main: 213114880 23:04:13 INFO - PROCESS | 13536 | 23:07:16 INFO - PROCESS | 13536 | Cycle 1(1): loaded http://localhost:38482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38482/tests/dromaeo/cssquery-yui.html) 23:07:16 INFO - PROCESS | 13536 | RSS: Main: 218411008 23:07:16 INFO - PROCESS | 13536 | 23:10:19 INFO - PROCESS | 13536 | Cycle 1(1): loaded http://localhost:38482/tests/dromaeo/cssquery-yui.html (next: http://localhost:38482/tests/dromaeo/cssquery-dojo.html) 23:10:19 INFO - PROCESS | 13536 | RSS: Main: 297279488 23:10:19 INFO - PROCESS | 13536 | 23:10:19 INFO - PROCESS | 13536 | __start_tp_report 23:10:19 INFO - PROCESS | 13536 | _x_x_mozilla_page_load 23:10:19 INFO - PROCESS | 13536 | _x_x_mozilla_page_load_details 23:10:19 INFO - PROCESS | 13536 | |i|pagename|runs| 23:10:19 INFO - PROCESS | 13536 | |0;dojo.html;3057.694230576942;3111.471049921513;3159.241781972326;3159.5576619273306;3174.7460203183746;4944.283078953549;5097.490250974901;5195.272661827343;5244.160934250525;5269.5520880725135;5192.818251361203;5210.843674689756;5238.345206849144;5258.894822103555;5343.946560534394;4689.413823272091;4700.506446823086;4768.260919557474;4804.927926081112;4827.63792715546;4753.429588449391;4769.523047695237;4812.350332705075;4812.87967800806;4824.662273640846;4654.4647365553055;4681.438227412698;4728.645351598644;4760.333553302523;4766.976165119187;4699.0836786826585;4721.881952951204;4740.691855029447;4743.549362810528;4755.453122890877;4718.764061796931;4729.432468103815;4757.26262429324;4766.428028636551;4779.115863565252;4894.143524883167;4975.253711943201;5015.52352526513;5051.2423136529815;5076.340075790161;5455.563554915637;5485.945140548623;5492.313460817398;5498.285222921035;5510.889782204334;5507.173923911405;5522.282103326542;5523.226748255248;5559.16612508127;5563.471470210364;5102.821401250975;5148.58811295103;5156.407013193456;5185.688858668492;5195.818146364934;5713.8285851424525;5721.828345149652;5726.77092916287;5728.914066289009;5740.68426236561;5494.615376923577;5495.670259784426;5499.532539734168;5501.807436739775;5523.171524271392;5434.184872269191;5462.7268636568015;5494.230807686927;5551.056320425538;5592.916106258409;5514.28314319144;5518.668879867221;5543.168524721244;5548.195511650869;5550.583706221969;5520.227168196376;5538.556915446755;5542.5565954723525;5544.750486228129;5601.6358936668985;4206.810693518799;4275.294576394922;4279.786010699452;4319;4346.913061738747;3826.0626146594263;3846.1346197105427;3849.7882616456363;3881.165549406891;3881.3207688654375;5073.949260507421;5126.154184559506;5180.870478237999;5181.922271165936;5230.581553475713;5533.335999680065;5564;5571.637843540157;5626.85932851682;5673.1490276458035;5211.973940130275;5269.71016594091;5286.682799032071;5286.762095705702;5295.12630415977;4713.2458806590785;4810.013947140827;4817.5182481752245;4823.155947709137;4826.975865120722;5713.457221563945;5725.08398656213;5741.081426971665;5765.07758758605;5848.093545500455;5495.395506494362;5531.363893152339;5545.1682247663175;5549.750261238173;5559.360673522435;5665.461781130786;5730.942690573041;5734.082546792493;5742.626729262584;5790.276215473066;5473.808416705396;5488.56091512686;5513.814529876096;5522.840203557298;5564.527015203753;5515.503604675599;5523.895220955745;5524.696141712245;5593.524550413261;5599.60802743804;5276.314079169683;5346.839594812006;5380.838574842604;5392.5416339611575;5443.673379597237;5346.358436987431;5375.1399776037215;5434.456554344534;5443.918341224806;5564.471375219509;5332.466753324637;5415.539679127318;5421.241026256406;5427.728613569227;5427.918581221364;5304.761285742228;5351.3043304370185;5516.668999860021;5551.555875529867;5576.804811831566;5308.442613525524;5355.357357117171;5365.892682146257;5375.623706340519;5397.055515284731 23:10:19 INFO - PROCESS | 13536 | |1;ext.html;541.591098720466;543.9728013599319;563.7068724263382;566.3684991234775;575.4102045403461;27424.177274681766;27909;39240;39316.410253846145;39423.211535769304;41228.17543649133;41392.586074139246;41714.37428438568;41909.16181676365;41957.58042419575;8422.83154336913;8569.35729820266;8571.22858942695;8582.184692454206;8588;7327.596982165979;7462.925370746305;9836.262280328969;9942.154916832078;9990.50047497626;9855.113039826414;9949.801003979916;9963.302568820185;9967.900320996807;9972;7234.674439650228;7358.742444014488;9848.507574621277;9936.056074672895;9971.20230381575;7388.076490438695;9877.25920555954;10096.848547271797;10101.343412678227;10110.241731870066;35844;36420.81789591035;36487.27025459502;36493.62076550804;36526;2865.5271880139753;3000.969990300113;3124.3126512167287;3741.4387841823673;3914.628110329514;27347.863260683767;28166.718332816614;28226.29434264139;28381.290467738472;28449.146525604265;3752.249550089966;3859.4210868369687;3875.5930627284292;3923.431102490123;3965.504311961005;267777;268207;269012;270599.6470017657;270767;59804.70097649484;59838.401615984156;60100.69949650224;60117.39882601205;60124.69937650371;63310.366896330444;63587.36412635907;63593.36406635874;63614;63618.6819065911;14409.13545187292;14410.42358305677;14414.567562973127;14494.927525362516;14565;11836.349000805038;11863.16957812962;11884.227525210834;11906.464209110438;11909.464074116686;19504.70742938857;19799;19977.900110499355;20014.69977950332;20016.199352025757;6179.084483810033;7279.818004549928;7484.176740558534;7555.13115991657;7571.053618297713;889.7642124836923;918.5131880103556;945.3807755919884;1045.6810672744887;1079.379356869803;26809.463810723675;27574.724252757616;27576.812924728805;27976.86011569929;28000.43999120047;967.811276801017;1000.0799264676515;1016.3190662256306;1030.3251370352432;1117.8486159255979;14907.776383354258;15076.623084422758;15082.396704131712;15167.317470713624;15228.314725837365;346112;353437;354072;455857;463923;56300.43699562952;56428.435715643136;56633.43366566364;56644;57000.71499642475;1360.7754720471012;1377.638561908939;1392.5195807446414;1395.2186775405805;1395.7348103860234;26255.343616409744;26340.473190536464;29529;30113.247168820955;31109;48724.26913596228;49681.50318496769;49741.51809373309;49792.75518112076;49834;287492;288137;289377;290213;290214;31827.68172318247;32119.197020074684;32333.51499727553;32477.35045299128;32546.67453325531;41777.373339399324;42113;42462.78768606137;42574;42740.78629606832;35775.82112089423;36829;37274.25451490901;37326.25347493089;37634.24731505409;31561.89533366321;31615.36769264648;31617.367652647277;31696.36607267888;32000.35999279955;37726.811365942995;38326.2334753309;38642.6135738639;38831.41752873766;38909.221815564095;30296.54555181718;30989;32809.343813124084;33464.498032529045;33479;24921.25236242843;25619.743802561738;26676.866615666797;26898.462030758885;27236.727632723418 23:10:19 INFO - PROCESS | 13536 | |2;jquery.html;361.79558549419573;362.1561761096645;365.36426617685237;365.8810886461899;366.58758896241727;14062.507812226575;14172.645683857909;16080.597985050365;16220.675586488263;16986.83013169868;16160.919195404007;17052.573685657866;17246.223919923603;17270.654586908255;17446.214920328584;5352.304200453946;5463.644863083887;5475.370332411764;5475.561955043587;5478.424765399635;4051.0075031617293;4129.091599848029;5323.9467605324035;5350.170723537838;5921.674307913063;5949.345571987078;5991.610545314541;6000.2199714037115;6009.969950150265;6016.037434010537;4916.115099282128;5078.339815823919;5083.440821509649;5086.898262034775;5963.55273354498;4793;4840.322354870321;4853.9029219415415;4948.158813001798;5144.048351055067;11841.467133978991;11884.881151188463;12078.335691536962;12083.033357331393;12109.212901161396;1983.652860749363;1992.163291417608;2072.0986370928695;2108.5888251790907;2134.402367337148;8905.243054340388;9208.677696280598;9260.073992600754;9417.811643767087;9468.195203407719;1620.0684606351394;1632.159437889476;1660.900345979233;1661.1860188507665;1744.6249056452796;55584.44415555873;55797.16304255439;56480.717596411756;56484.71757641186;59015.704921475546;9529.618815247313;9783.36408133469;9886.950565247127;9899.059589339002;9949.602015919427;12862.421191046426;12920.870791292155;12926.41831117602;12947;12959.352032398343;7421.740239091606;7451.850962980819;7476.5514069156025;7549.112721819545;7628.427867909929;7410.407167426701;7494.587797671072;7502.774916752506;7531.8117047074265;7546.5094768840945;4345.283028300295;4352.956470435319;4355.607995280377;4425.668074894395;4451.109778044404;1723.1039859273108;1757.244384914499;1757.613325068483;1767.4874286456784;1791.5073354827528;814.3892080939296;870.6822009966317;930.8789857318505;932.2076235200161;948.6015873333216;15409.691806163813;15833.604159896095;15996.280167392262;16751.91624041872;16867.578310542336;875.1205038935828;896.3680605173337;902.566767951387;941.3128416256035;941.4586612697726;9279.67521136757;9302.813943721088;9397.342186046912;9433.25484785317;9485.715428537154;548421;556145;558096;565284;566127;70264;75333.24666753372;76958;78938;79669.60165199137;1098.23123813331;1125.3585456289836;1133.7165708572693;1154.0940361815933;1154.255505199142;13847.238401887993;13896.930515347358;13941.790873137114;14110.717785644025;14229.359678814686;18273.543161420537;18533.166007529424;30124.698753012188;31072;31618.26099564546;45756.54243457656;46175;48724.652722336745;48794.26808597803;50125;9081.68214112503;9085.22775564058;9166.770830729285;9205.125513076247;9436.292278079034;11249.943750281196;11322.094232461219;11349.092072634005;12185.756284874431;16206.513804585882;10679.19906007037;11061.391623460788;12812.61562153137;13229.206247625174;13440.731185376433;13353.53262635803;13637.79543306871;13779.586612401645;13931.651708707363;14122.223277719824;12162;12330.75338493243;12424.56514022005;13128.868711312765;13144.737105257651;9459.006804285451;9580;9598.712038638852;9659;9774.657886973922;9334.71995840126;12975.351232438152;12997.4403071632;13477.663058423617;14158.079724817853 23:10:19 INFO - PROCESS | 13536 | |3;mootools.html;1280.2894393611552;1460.401235493448;1460.824701035876;1611.355457816873;1788.4098247578293;6730.360615741502;7346.338829505344;7442.292982166699;7454.5899975501325;7462.179160292363;7435.851282974338;7587.430942679293;7610.54336739796;7626.885596716053;7632.580208088553;2222.688823564702;2271.613825649635;2272.091163534583;2272.329662749493;2274.3177046885867;2211.8783466909313;2229.520653059592;2281.041962375806;2285.4514916420108;2285.5771682238756;2115.851890367675;2163.805257526822;2166.620841352757;2188.89055547222;2194.3087927302927;2178.36827320077;2195.9451013724706;2228.0308065991267;2231.564844855262;2232.1294695068937;2249.5275992041693;2249.6850440938283;2274.749777524471;2275.0899640143907;2281.3498153026308;7509.849803003964;7579.962100189519;7599.620018999028;7605.80985475362;7608.35328997036;4492.168948744493;4574.473935497427;4588.2888152336445;4589.5410458954175;4596.333531637927;2973.3458639099363;3019.3659331540402;3028.2278019105206;3048.1465189746905;3048.923776905573;1019.4545917933943;1039.8544203811473;1047.089032541686;1052.899974502421;1121.9887801122047;10405.47972601367;10422.843657345145;10434.999999999924;10436.32163909351;10460.52927618259;3995.680345572347;4058.857939972087;4075.2053349597136;4083.7345572538284;4099.877003689894;8944.105589441135;8947.507887066275;8955.238804701543;8962.372633915693;8967.058458861857;4505.752183629932;4510.548945105529;4546.04533048057;4582.495925448198;4585.656075794329;3728.3475391806323;3742.232842267383;4053.7365071270274;4122.690798190088;4136.91726165475;3524.2599054198395;3552.6802587767224;3556.928861422757;3558.768680035789;3610.29599228148;1134.0700625487023;1150.3147888343617;1154.2785758900686;1165.650304908524;1171.1918776044672;964.8842138943372;980.2403137568299;980.6616717232686;1066.903978641926;1306.8627794081674;7254.600996945113;7269;7269.600171990592;7276.63616819157;7297.197308296083;461.7737308718704;462.6853739457134;469.55157824277734;470.4848191230597;470.5741304119777;5577.832665020056;5659.236003139606;5681.517071048925;5688.658680479184;5689.601727879091;8845.601947912359;8860.113988601088;8959;8994.460332379947;9087.091290870992;8857.955710221408;8977.057408972094;8981.14679105484;8998.100189980949;9033.187013168847;6723.495737819683;6855.622940738307;7037.366637002694;7085.078939737801;7103.751368702071;6909.896351554831;6966.4775141865575;6978.860422791618;6985.965070174617;6995.230524642387;7721.884171737541;7984.560849153352;8017.19828017217;8093.0692970309165;8137.674493020213;7837.255460731221;8100.959495202486;8116.797080072809;8126.309263712415;8266.13205613402;5944.702764861826;5980.700964951822;6470.870582588416;6660.6336651484635;6715.127033485615;7151.392131668658;7164.355208031302;7218.3503484686635;7221.747238846615;7222.422206223385;6492.870142597216;6773.695183716646;6818.897716534157;6830.795076147723;6992.790216293316;6753.763618273337;6801.693923773343;6836.521443499107;6862.828429289308;6906.654667266516;6487.3188315226225;6838.487113466411;6861.176658800976;6862.691178896862;6883.380495755406;6330.620162790247;6381.138546296376;6400.103985441949;6401.263854656774;6418.19772528434;6200.503959683305;6240;6246.531510136667;6250.218722659668;6250.718717657625 23:10:19 INFO - PROCESS | 13536 | |4;prototype.html;328.9259916518783;333.0441632514683;333.1288680101535;337.14701804434776;341.98632054717814;5765.625234359763;5813.33146688131;5814.912776308353;5851.0930805725075;5897.823065308037;5650.773969041234;5756.884862302752;5758.049921762915;5784.103463963082;5797.3912739162415;4468.285074388098;4492.505824359318;4502.527234640364;4503.819847206108;4506.143832671798;4277.059047009653;4329.9567004329865;4351.064521127957;4446.2219111655495;4498.910021799562;4405.713628614146;4407.3609326647775;4416.73499590024;4422.734635921839;4437.090396468732;4419.447569053868;4419.712718673276;4425.88935276619;4428.180786554498;4431.933520997188;3893.552241492236;3893.8637147699696;3899.459713413186;3902.9804850975565;3904.4533765272886;5469.15228139635;5579.776808927638;5584.6090773645865;5589.552835773169;5592.6085174037835;5156.819511317086;5161.071007218699;5166.638335316529;5167.276581278624;5170.095233334151;6127.111568822495;6127.724252408652;6135.570510064297;6136;6138.508919286446;4106.993786522321;4180.937285940713;4232.407462955189;4313.84901528445;4329.631981281595;6400.487960963112;6401.8399540011405;6410.551261411703;6419.711112999879;6447.032945058232;4460.085682435093;4469.351943968107;4471.195184866755;4474.574915383034;4474.731516109044;4425.889352766207;4524.09518096382;4530.433695788027;4532;4535.523770004168;5190.6107041972;5191.428942816287;5198.830263190752;5200.531952124327;5201.401838788512;6176.3514830943;6185.567010309235;6186.412290832363;6190.133381326618;6199.287081985539;1598.3446786817349;1614.6932082904211;1615.2650544002452;1616.1515204517486;1616.3373017062947;1083.5882364701363;1086.7120213143523;1099.5162128663362;1100.4112799652148;1112.1492058575197;5844.649321040666;5844.649321040752;5846.093855452412;5908.704564771744;5926.970365148147;6299.622022678654;6308.589941653778;6321.936780632135;6385.616862988236;6400.519961002943;5906.970465147647;5917.733701983421;5919.852003699856;5921.407859214044;5924.6149000314845;3358.9328213436083;3472.0625431133453;3479.634638362986;3480.077779388464;3482.1120614243205;6574.474042076718;6583.703733332011;6586.473082153416;6588.341165883373;6629.635370054597;6611.471082313404;6621.635810030398;6627.768028118992;6643.93697008486;6647.501437392215;6537.477001839841;6672.432843208285;6675.165604299463;6679.56582822115;6679.833004174838;6174.567780255339;6405.807825765234;6423.935760642521;6428.8071357859335;6434.67826608677;6195.2255968004;6286.119943207863;6316.873662526816;6334.144890439732;6400.23197216337;6655.73377064912;6661.3338666132995;6668.166479190101;6672.266050734513;6680.632565208765;4382.298832186835;4425.181341451842;4425.557444255549;4427.778611069498;4438.045820148684;6289.9371006291185;6453.064305675744;6453.225612926479;6460.515461340325;6466.353364663496;6271.404216599416;6282.560220784501;6284.402981716729;6290;6293.276273228637;6138.600990935575;6258.43674069336;6271.498280137669;6277.089821975879;6287.559870808999;6128.63228206309;6156.78451254204;6159.784407545714;6166.568340216142;6188.1027251049245;6292.2134733158355;6299.401556852092;6299.590526615755;6304.968475157595;6305.2433707953505;6049.758009679564;6124;6151.5386346025125;6170.043643235305;6177.351378105234 23:10:19 INFO - PROCESS | 13536 | |5;yui.html;762.6911101004092;775.5850619918344;777.1917206105651;811.4928169893816;867.2151702709049;13683.589492315234;13892.305384730773;13916.721665566683;13925.860741392584;13951.860481395182;12826.807597886016;12837;12837.807432888514;12870.806937895939;12891.742165156691;654.0614218596306;661.1768348406241;786.6656670914867;791.5369508837337;794.0193860582206;782.9804254893645;800.2077942836609;800.3077338102557;801.6432687454085;802.0215337288498;815.9224873637024;830.5805568188086;830.6511265268572;831.3058596072287;831.5592735850009;675.7938828657282;681.931806819319;810.8459392715424;822.2065706593137;822.5763731678161;608.8386577556951;611;611.4069352727847;611.6146827498692;613.4938675592654;12952.48190072396;13028.348582570834;13076.673083172902;13099.934500327437;13130.540431084866;11877;12078.456469458895;12241.510339586406;12852.614421567368;12925.482980680761;10371.896281037169;10700.892991070068;10807.297525660806;10914.454277286104;11027.338359698444;3612.331718632035;3677.2277821657217;3705.2589482103685;3763.5671897731563;3765.981170094132;44366;44648.553514464766;44795.104097918185;44831.3275300874;44900.3264951026;9727.270454715925;9929.851052234222;10308.793824123475;10508.106810921157;10561.524731387106;17224.13879306055;17501.649967000587;17521.12394380276;17524.5618859527;17525.386611468537;7032.7538536152015;7241.746538871114;7293.124825021031;7409.7777066687;7426.405887528985;4408.559144085566;4454.933176002362;4459.353393757887;4465.977670111629;4473.6868419211;3032.727054565056;3067.539869019665;3068.70847269509;3068.969310306913;3070.969290307113;521.6895946911582;537.5350321971466;546.8086169840524;549.198170670817;554.163213547538;546.2707285773457;657.4575974820697;670.3798985938085;675.2651760370578;695.857349243414;7719.575423351657;8138.470999385021;8140.267375936194;8238.176182381714;8415.663373464993;543.7118327286545;638.6327861479667;672.8856094463953;683.3986092238897;708.4190963409955;3685.5761587417255;3747.6252374762853;3757.3205894383514;3824.521934758155;3917.8628747993685;52709.209361859605;53347;53604;53710.73144634252;54317.1852422214;46569.767151164706;47306.5269347309;47473;47587.524124759;49242.507574923795;43348;43681.34477982833;44096;44610.77694611506;45315.09369812651;8058.556779376956;8135.30849877767;8626;8726.694565690424;8786.780330491789;36538.8173059133;36886.44670330001;37744.433833491974;38421.4236786454;38599.42100868433;46625.3006204914;47161.52838471571;47287;47957.280640789715;49493.50506495033;11439.027682647069;11501.424928753697;11693.88306116928;11963.581274655346;12288.447019883948;12643.178193417398;12753.48986040548;12768.6807829805;13068.738625227632;13124.703176943805;11405.144614153805;11626.593069242535;11700.531978720755;12030.398480075786;12119.515219391125;11012.889871101186;11122.499487523242;11380.146489013523;11417.486213120263;11484.023857972166;11349.978501934866;11428.771424571629;11431.771364572496;11494.137939654727;11637.185397022127;9666.709998700051;9683.467409292556;9838.508074596384;10222.284440089123;10229.488525573543;8808.779780505538;8864.77838054028;9186.770330741785;9495.248905786108;9570.425774453555 23:10:19 INFO - PROCESS | 13536 | __end_tp_report 23:10:19 INFO - PROCESS | 13536 | __start_cc_report 23:10:19 INFO - PROCESS | 13536 | _x_x_mozilla_cycle_collect,1001 23:10:19 INFO - PROCESS | 13536 | __end_cc_report 23:10:19 INFO - PROCESS | 13536 | __startTimestamp1451977819627__endTimestamp 23:10:19 INFO - PROCESS | 13536 | 23:10:19 INFO - PROCESS | 13536 | ------- Summary: start ------- 23:10:19 INFO - PROCESS | 13536 | Number of tests: 6 23:10:19 INFO - PROCESS | 13536 | 23:10:19 INFO - PROCESS | 13536 | [#0] dojo.html Cycles:165 Average:5162.77 Median:5355.36 stddev:562.23 (10.5%) stddev-sans-first:539.15 23:10:19 INFO - PROCESS | 13536 | Values: 3057.7 3111.5 3159.2 3159.6 3174.7 4944.3 5097.5 5195.3 5244.2 5269.6 5192.8 5210.8 5238.3 5258.9 5343.9 4689.4 4700.5 4768.3 4804.9 4827.6 4753.4 4769.5 4812.4 4812.9 4824.7 4654.5 4681.4 4728.6 4760.3 4767.0 4699.1 4721.9 4740.7 4743.5 4755.5 4718.8 4729.4 4757.3 4766.4 4779.1 4894.1 4975.3 5015.5 5051.2 5076.3 5455.6 5485.9 5492.3 5498.3 5510.9 5507.2 5522.3 5523.2 5559.2 5563.5 5102.8 5148.6 5156.4 5185.7 5195.8 5713.8 5721.8 5726.8 5728.9 5740.7 5494.6 5495.7 5499.5 5501.8 5523.2 5434.2 5462.7 5494.2 5551.1 5592.9 5514.3 5518.7 5543.2 5548.2 5550.6 5520.2 5538.6 5542.6 5544.8 5601.6 4206.8 4275.3 4279.8 4319.0 4346.9 3826.1 3846.1 3849.8 3881.2 3881.3 5073.9 5126.2 5180.9 5181.9 5230.6 5533.3 5564.0 5571.6 5626.9 5673.1 5212.0 5269.7 5286.7 5286.8 5295.1 4713.2 4810.0 4817.5 4823.2 4827.0 5713.5 5725.1 5741.1 5765.1 5848.1 5495.4 5531.4 5545.2 5549.8 5559.4 5665.5 5730.9 5734.1 5742.6 5790.3 5473.8 5488.6 5513.8 5522.8 5564.5 5515.5 5523.9 5524.7 5593.5 5599.6 5276.3 5346.8 5380.8 5392.5 5443.7 5346.4 5375.1 5434.5 5443.9 5564.5 5332.5 5415.5 5421.2 5427.7 5427.9 5304.8 5351.3 5516.7 5551.6 5576.8 5308.4 5355.4 5365.9 5375.6 5397.1 23:10:19 INFO - PROCESS | 13536 | 23:10:19 INFO - PROCESS | 13536 | [#1] ext.html Cycles:180 Average:48484.28 Median:36490.45 stddev:85210.63 (233.5%) stddev-sans-first:85373.64 23:10:19 INFO - PROCESS | 13536 | Values: 541.6 544.0 563.7 566.4 575.4 27424.2 27909.0 39240.0 39316.4 39423.2 41228.2 41392.6 41714.4 41909.2 41957.6 8422.8 8569.4 8571.2 8582.2 8588.0 7327.6 7462.9 9836.3 9942.2 9990.5 9855.1 9949.8 9963.3 9967.9 9972.0 7234.7 7358.7 9848.5 9936.1 9971.2 7388.1 9877.3 10096.8 10101.3 10110.2 35844.0 36420.8 36487.3 36493.6 36526.0 2865.5 3001.0 3124.3 3741.4 3914.6 27347.9 28166.7 28226.3 28381.3 28449.1 3752.2 3859.4 3875.6 3923.4 3965.5 267777.0 268207.0 269012.0 270599.6 270767.0 59804.7 59838.4 60100.7 60117.4 60124.7 63310.4 63587.4 63593.4 63614.0 63618.7 14409.1 14410.4 14414.6 14494.9 14565.0 11836.3 11863.2 11884.2 11906.5 11909.5 19504.7 19799.0 19977.9 20014.7 20016.2 6179.1 7279.8 7484.2 7555.1 7571.1 889.8 918.5 945.4 1045.7 1079.4 26809.5 27574.7 27576.8 27976.9 28000.4 967.8 1000.1 1016.3 1030.3 1117.8 14907.8 15076.6 15082.4 15167.3 15228.3 346112.0 353437.0 354072.0 455857.0 463923.0 56300.4 56428.4 56633.4 56644.0 57000.7 1360.8 1377.6 1392.5 1395.2 1395.7 26255.3 26340.5 29529.0 30113.2 31109.0 48724.3 49681.5 49741.5 49792.8 49834.0 287492.0 288137.0 289377.0 290213.0 290214.0 31827.7 32119.2 32333.5 32477.4 32546.7 41777.4 42113.0 42462.8 42574.0 42740.8 35775.8 36829.0 37274.3 37326.3 37634.2 31561.9 31615.4 31617.4 31696.4 32000.4 37726.8 38326.2 38642.6 38831.4 38909.2 30296.5 30989.0 32809.3 33464.5 33479.0 24921.3 25619.7 26676.9 26898.5 27236.7 23:10:19 INFO - PROCESS | 13536 | 23:10:19 INFO - PROCESS | 13536 | [#2] jquery.html Cycles:180 Average:28301.84 Median:25103.83 stddev:91294.39 (363.7%) stddev-sans-first:91526.39 23:10:19 INFO - PROCESS | 13536 | Values: 361.8 362.2 365.4 365.9 366.6 14062.5 14172.6 16080.6 16220.7 16986.8 16160.9 17052.6 17246.2 17270.7 17446.2 5352.3 5463.6 5475.4 5475.6 5478.4 4051.0 4129.1 5323.9 5350.2 5921.7 5949.3 5991.6 6000.2 6010.0 6016.0 4916.1 5078.3 5083.4 5086.9 5963.6 4793.0 4840.3 4853.9 4948.2 5144.0 11841.5 11884.9 12078.3 12083.0 12109.2 1983.7 1992.2 2072.1 2108.6 2134.4 8905.2 9208.7 9260.1 9417.8 9468.2 1620.1 1632.2 1660.9 1661.2 1744.6 55584.4 55797.2 56480.7 56484.7 59015.7 9529.6 9783.4 9887.0 9899.1 9949.6 12862.4 12920.9 12926.4 12947.0 12959.4 7421.7 7451.9 7476.6 7549.1 7628.4 7410.4 7494.6 7502.8 7531.8 7546.5 4345.3 4353.0 4355.6 4425.7 4451.1 1723.1 1757.2 1757.6 1767.5 1791.5 814.4 870.7 930.9 932.2 948.6 15409.7 15833.6 15996.3 16751.9 16867.6 875.1 896.4 902.6 941.3 941.5 9279.7 9302.8 9397.3 9433.3 9485.7 548421.0 556145.0 558096.0 565284.0 566127.0 70264.0 75333.2 76958.0 78938.0 79669.6 1098.2 1125.4 1133.7 1154.1 1154.3 13847.2 13896.9 13941.8 14110.7 14229.4 18273.5 18533.2 30124.7 31072.0 31618.3 45756.5 46175.0 48724.7 48794.3 50125.0 9081.7 9085.2 9166.8 9205.1 9436.3 11249.9 11322.1 11349.1 12185.8 16206.5 10679.2 11061.4 12812.6 13229.2 13440.7 13353.5 13637.8 13779.6 13931.7 14122.2 12162.0 12330.8 12424.6 13128.9 13144.7 9459.0 9580.0 9598.7 9659.0 9774.7 9334.7 12975.4 12997.4 13477.7 14158.1 23:10:19 INFO - PROCESS | 13536 | 23:10:19 INFO - PROCESS | 13536 | [#3] mootools.html Cycles:180 Average:5261.43 Median:6243.27 stddev:2745.12 (44.0%) stddev-sans-first:2736.51 23:10:19 INFO - PROCESS | 13536 | Values: 1280.3 1460.4 1460.8 1611.4 1788.4 6730.4 7346.3 7442.3 7454.6 7462.2 7435.9 7587.4 7610.5 7626.9 7632.6 2222.7 2271.6 2272.1 2272.3 2274.3 2211.9 2229.5 2281.0 2285.5 2285.6 2115.9 2163.8 2166.6 2188.9 2194.3 2178.4 2195.9 2228.0 2231.6 2232.1 2249.5 2249.7 2274.7 2275.1 2281.3 7509.8 7580.0 7599.6 7605.8 7608.4 4492.2 4574.5 4588.3 4589.5 4596.3 2973.3 3019.4 3028.2 3048.1 3048.9 1019.5 1039.9 1047.1 1052.9 1122.0 10405.5 10422.8 10435.0 10436.3 10460.5 3995.7 4058.9 4075.2 4083.7 4099.9 8944.1 8947.5 8955.2 8962.4 8967.1 4505.8 4510.5 4546.0 4582.5 4585.7 3728.3 3742.2 4053.7 4122.7 4136.9 3524.3 3552.7 3556.9 3558.8 3610.3 1134.1 1150.3 1154.3 1165.7 1171.2 964.9 980.2 980.7 1066.9 1306.9 7254.6 7269.0 7269.6 7276.6 7297.2 461.8 462.7 469.6 470.5 470.6 5577.8 5659.2 5681.5 5688.7 5689.6 8845.6 8860.1 8959.0 8994.5 9087.1 8858.0 8977.1 8981.1 8998.1 9033.2 6723.5 6855.6 7037.4 7085.1 7103.8 6909.9 6966.5 6978.9 6986.0 6995.2 7721.9 7984.6 8017.2 8093.1 8137.7 7837.3 8101.0 8116.8 8126.3 8266.1 5944.7 5980.7 6470.9 6660.6 6715.1 7151.4 7164.4 7218.4 7221.7 7222.4 6492.9 6773.7 6818.9 6830.8 6992.8 6753.8 6801.7 6836.5 6862.8 6906.7 6487.3 6838.5 6861.2 6862.7 6883.4 6330.6 6381.1 6400.1 6401.3 6418.2 6200.5 6240.0 6246.5 6250.2 6250.7 23:10:19 INFO - PROCESS | 13536 | 23:10:19 INFO - PROCESS | 13536 | [#4] prototype.html Cycles:180 Average:5191.43 Median:5848.59 stddev:1560.32 (26.7%) stddev-sans-first:1521.41 23:10:19 INFO - PROCESS | 13536 | Values: 328.9 333.0 333.1 337.1 342.0 5765.6 5813.3 5814.9 5851.1 5897.8 5650.8 5756.9 5758.0 5784.1 5797.4 4468.3 4492.5 4502.5 4503.8 4506.1 4277.1 4330.0 4351.1 4446.2 4498.9 4405.7 4407.4 4416.7 4422.7 4437.1 4419.4 4419.7 4425.9 4428.2 4431.9 3893.6 3893.9 3899.5 3903.0 3904.5 5469.2 5579.8 5584.6 5589.6 5592.6 5156.8 5161.1 5166.6 5167.3 5170.1 6127.1 6127.7 6135.6 6136.0 6138.5 4107.0 4180.9 4232.4 4313.8 4329.6 6400.5 6401.8 6410.6 6419.7 6447.0 4460.1 4469.4 4471.2 4474.6 4474.7 4425.9 4524.1 4530.4 4532.0 4535.5 5190.6 5191.4 5198.8 5200.5 5201.4 6176.4 6185.6 6186.4 6190.1 6199.3 1598.3 1614.7 1615.3 1616.2 1616.3 1083.6 1086.7 1099.5 1100.4 1112.1 5844.6 5844.6 5846.1 5908.7 5927.0 6299.6 6308.6 6321.9 6385.6 6400.5 5907.0 5917.7 5919.9 5921.4 5924.6 3358.9 3472.1 3479.6 3480.1 3482.1 6574.5 6583.7 6586.5 6588.3 6629.6 6611.5 6621.6 6627.8 6643.9 6647.5 6537.5 6672.4 6675.2 6679.6 6679.8 6174.6 6405.8 6423.9 6428.8 6434.7 6195.2 6286.1 6316.9 6334.1 6400.2 6655.7 6661.3 6668.2 6672.3 6680.6 4382.3 4425.2 4425.6 4427.8 4438.0 6289.9 6453.1 6453.2 6460.5 6466.4 6271.4 6282.6 6284.4 6290.0 6293.3 6138.6 6258.4 6271.5 6277.1 6287.6 6128.6 6156.8 6159.8 6166.6 6188.1 6292.2 6299.4 6299.6 6305.0 6305.2 6049.8 6124.0 6151.5 6170.0 6177.4 23:10:19 INFO - PROCESS | 13536 | 23:10:19 INFO - PROCESS | 13536 | [#5] yui.html Cycles:180 Average:13599.88 Median:24634.40 stddev:15382.60 (62.4%) stddev-sans-first:15395.55 23:10:19 INFO - PROCESS | 13536 | Values: 762.7 775.6 777.2 811.5 867.2 13683.6 13892.3 13916.7 13925.9 13951.9 12826.8 12837.0 12837.8 12870.8 12891.7 654.1 661.2 786.7 791.5 794.0 783.0 800.2 800.3 801.6 802.0 815.9 830.6 830.7 831.3 831.6 675.8 681.9 810.8 822.2 822.6 608.8 611.0 611.4 611.6 613.5 12952.5 13028.3 13076.7 13099.9 13130.5 11877.0 12078.5 12241.5 12852.6 12925.5 10371.9 10700.9 10807.3 10914.5 11027.3 3612.3 3677.2 3705.3 3763.6 3766.0 44366.0 44648.6 44795.1 44831.3 44900.3 9727.3 9929.9 10308.8 10508.1 10561.5 17224.1 17501.6 17521.1 17524.6 17525.4 7032.8 7241.7 7293.1 7409.8 7426.4 4408.6 4454.9 4459.4 4466.0 4473.7 3032.7 3067.5 3068.7 3069.0 3071.0 521.7 537.5 546.8 549.2 554.2 546.3 657.5 670.4 675.3 695.9 7719.6 8138.5 8140.3 8238.2 8415.7 543.7 638.6 672.9 683.4 708.4 3685.6 3747.6 3757.3 3824.5 3917.9 52709.2 53347.0 53604.0 53710.7 54317.2 46569.8 47306.5 47473.0 47587.5 49242.5 43348.0 43681.3 44096.0 44610.8 45315.1 8058.6 8135.3 8626.0 8726.7 8786.8 36538.8 36886.4 37744.4 38421.4 38599.4 46625.3 47161.5 47287.0 47957.3 49493.5 11439.0 11501.4 11693.9 11963.6 12288.4 12643.2 12753.5 12768.7 13068.7 13124.7 11405.1 11626.6 11700.5 12030.4 12119.5 11012.9 11122.5 11380.1 11417.5 11484.0 11350.0 11428.8 11431.8 11494.1 11637.2 9666.7 9683.5 9838.5 10222.3 10229.5 8808.8 8864.8 9186.8 9495.2 9570.4 23:10:19 INFO - PROCESS | 13536 | -------- Summary: end -------- 23:10:19 INFO - PROCESS | 13536 | 23:10:20 INFO - TEST-INFO | 13536: exit 0 23:10:20 INFO - TEST-OK | dromaeo_css | took 1113326ms 23:10:20 INFO - TEST-START | kraken 23:10:20 INFO - operating with platform_type : linux_ 23:10:20 INFO - Initialising browser for kraken test... 23:10:20 INFO - TEST-INFO | started process 13724 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH8c9wr/profile http://localhost:38482/getInfo.html) 23:10:24 INFO - PROCESS | 13724 | __metrics Screen width/height:1600/1200 23:10:24 INFO - PROCESS | 13724 | colorDepth:24 23:10:24 INFO - PROCESS | 13724 | Browser inner width/height: 1024/697 23:10:24 INFO - PROCESS | 13724 | __metrics 23:10:24 INFO - PROCESS | 13724 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:10:24 INFO - PROCESS | 13724 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:10:25 INFO - TEST-INFO | 13724: exit 0 23:10:25 INFO - Browser initialized. 23:10:25 INFO - Running cycle 1/1 for kraken test... 23:10:25 INFO - TEST-INFO | started process 13807 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH8c9wr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:37 INFO - PROCESS | 13807 | RSS: Main: 150040576 23:10:37 INFO - PROCESS | 13807 | 23:10:39 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38482/tests/kraken/driver.html?testName=audio-beat-detection) 23:10:40 INFO - PROCESS | 13807 | RSS: Main: 185790464 23:10:40 INFO - PROCESS | 13807 | 23:10:43 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38482/tests/kraken/driver.html?testName=audio-dft) 23:10:43 INFO - PROCESS | 13807 | RSS: Main: 174039040 23:10:43 INFO - PROCESS | 13807 | 23:10:46 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38482/tests/kraken/driver.html?testName=audio-fft) 23:10:47 INFO - PROCESS | 13807 | RSS: Main: 160174080 23:10:47 INFO - PROCESS | 13807 | 23:10:49 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38482/tests/kraken/driver.html?testName=audio-oscillator) 23:10:49 INFO - PROCESS | 13807 | RSS: Main: 163561472 23:10:49 INFO - PROCESS | 13807 | 23:10:51 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:10:52 INFO - PROCESS | 13807 | RSS: Main: 163680256 23:10:52 INFO - PROCESS | 13807 | 23:10:55 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38482/tests/kraken/driver.html?testName=imaging-darkroom) 23:10:55 INFO - PROCESS | 13807 | RSS: Main: 165400576 23:10:55 INFO - PROCESS | 13807 | 23:10:59 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38482/tests/kraken/driver.html?testName=imaging-desaturate) 23:10:59 INFO - PROCESS | 13807 | RSS: Main: 165724160 23:10:59 INFO - PROCESS | 13807 | 23:11:02 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38482/tests/kraken/driver.html?testName=json-parse-financial) 23:11:03 INFO - PROCESS | 13807 | RSS: Main: 166326272 23:11:03 INFO - PROCESS | 13807 | 23:11:04 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:11:05 INFO - PROCESS | 13807 | RSS: Main: 174862336 23:11:05 INFO - PROCESS | 13807 | 23:11:07 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38482/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:11:07 INFO - PROCESS | 13807 | RSS: Main: 172752896 23:11:07 INFO - PROCESS | 13807 | 23:11:09 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:11:10 INFO - PROCESS | 13807 | RSS: Main: 180088832 23:11:10 INFO - PROCESS | 13807 | 23:11:12 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:11:13 INFO - PROCESS | 13807 | RSS: Main: 190812160 23:11:13 INFO - PROCESS | 13807 | 23:11:15 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:11:16 INFO - PROCESS | 13807 | RSS: Main: 187871232 23:11:16 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | Cycle 1(1): loaded http://localhost:38482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38482/tests/kraken/driver.html?testName=ai-astar) 23:11:18 INFO - PROCESS | 13807 | RSS: Main: 246980608 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | __start_tp_report 23:11:18 INFO - PROCESS | 13807 | _x_x_mozilla_page_load 23:11:18 INFO - PROCESS | 13807 | _x_x_mozilla_page_load_details 23:11:18 INFO - PROCESS | 13807 | |i|pagename|runs| 23:11:18 INFO - PROCESS | 13807 | |0;ai-astar;109;111;104;113;112;113;102;114;110;109 23:11:18 INFO - PROCESS | 13807 | |1;audio-beat-detection;153;127;152;175;125;152;150;124;164;126 23:11:18 INFO - PROCESS | 13807 | |2;audio-dft;161;161;159;161;161;161;160;162;162;162 23:11:18 INFO - PROCESS | 13807 | |3;audio-fft;72;73;79;94;71;72;73;104;92;73 23:11:18 INFO - PROCESS | 13807 | |4;audio-oscillator;96;96;138;95;96;96;140;95;97;140 23:11:18 INFO - PROCESS | 13807 | |5;imaging-gaussian-blur;110;109;109;110;110;109;110;110;110;109 23:11:18 INFO - PROCESS | 13807 | |6;imaging-darkroom;146;145;145;145;145;151;145;145;145;146 23:11:18 INFO - PROCESS | 13807 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;98;95 23:11:18 INFO - PROCESS | 13807 | |8;json-parse-financial;56;57;59;56;56;57;57;70;55;55 23:11:18 INFO - PROCESS | 13807 | |9;json-stringify-tinderbox;67;67;68;68;69;67;68;66;67;67 23:11:18 INFO - PROCESS | 13807 | |10;stanford-crypto-aes;84;88;87;90;93;85;86;86;87;88 23:11:18 INFO - PROCESS | 13807 | |11;stanford-crypto-ccm;134;115;117;121;119;125;126;116;115;119 23:11:18 INFO - PROCESS | 13807 | |12;stanford-crypto-pbkdf2;148;152;157;157;160;151;161;156;156;149 23:11:18 INFO - PROCESS | 13807 | |13;stanford-crypto-sha256-iterative;70;68;70;70;67;69;67;68;69;69 23:11:18 INFO - PROCESS | 13807 | __end_tp_report 23:11:18 INFO - PROCESS | 13807 | __start_cc_report 23:11:18 INFO - PROCESS | 13807 | _x_x_mozilla_cycle_collect,940 23:11:18 INFO - PROCESS | 13807 | __end_cc_report 23:11:18 INFO - PROCESS | 13807 | __startTimestamp1451977878517__endTimestamp 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | ------- Summary: start ------- 23:11:18 INFO - PROCESS | 13807 | Number of tests: 14 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.50 stddev:3.95 (3.5%) stddev-sans-first:4.18 23:11:18 INFO - PROCESS | 13807 | Values: 109.0 111.0 104.0 113.0 112.0 113.0 102.0 114.0 110.0 109.0 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:152.00 stddev:18.18 (12.0%) stddev-sans-first:19.04 23:11:18 INFO - PROCESS | 13807 | Values: 153.0 127.0 152.0 175.0 125.0 152.0 150.0 124.0 164.0 126.0 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 23:11:18 INFO - PROCESS | 13807 | Values: 161.0 161.0 159.0 161.0 161.0 161.0 160.0 162.0 162.0 162.0 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#3] audio-fft Cycles:10 Average:80.30 Median:73.00 stddev:11.89 (16.3%) stddev-sans-first:12.22 23:11:18 INFO - PROCESS | 13807 | Values: 72.0 73.0 79.0 94.0 71.0 72.0 73.0 104.0 92.0 73.0 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:96.00 stddev:21.02 (21.9%) stddev-sans-first:21.77 23:11:18 INFO - PROCESS | 13807 | Values: 96.0 96.0 138.0 95.0 96.0 96.0 140.0 95.0 97.0 140.0 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:11:18 INFO - PROCESS | 13807 | Values: 110.0 109.0 109.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:145.00 stddev:1.87 (1.3%) stddev-sans-first:1.99 23:11:18 INFO - PROCESS | 13807 | Values: 146.0 145.0 145.0 145.0 145.0 151.0 145.0 145.0 145.0 146.0 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 23:11:18 INFO - PROCESS | 13807 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 98.0 95.0 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.00 stddev:4.44 (7.8%) stddev-sans-first:4.66 23:11:18 INFO - PROCESS | 13807 | Values: 56.0 57.0 59.0 56.0 56.0 57.0 57.0 70.0 55.0 55.0 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 23:11:18 INFO - PROCESS | 13807 | Values: 67.0 67.0 68.0 68.0 69.0 67.0 68.0 66.0 67.0 67.0 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.50 stddev:2.59 (3.0%) stddev-sans-first:2.44 23:11:18 INFO - PROCESS | 13807 | Values: 84.0 88.0 87.0 90.0 93.0 85.0 86.0 86.0 87.0 88.0 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:120.00 stddev:6.06 (5.0%) stddev-sans-first:4.09 23:11:18 INFO - PROCESS | 13807 | Values: 134.0 115.0 117.0 121.0 119.0 125.0 126.0 116.0 115.0 119.0 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:156.50 stddev:4.47 (2.9%) stddev-sans-first:4.03 23:11:18 INFO - PROCESS | 13807 | Values: 148.0 152.0 157.0 157.0 160.0 151.0 161.0 156.0 156.0 149.0 23:11:18 INFO - PROCESS | 13807 | 23:11:18 INFO - PROCESS | 13807 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 23:11:18 INFO - PROCESS | 13807 | Values: 70.0 68.0 70.0 70.0 67.0 69.0 67.0 68.0 69.0 69.0 23:11:18 INFO - PROCESS | 13807 | -------- Summary: end -------- 23:11:18 INFO - PROCESS | 13807 | 23:11:19 INFO - TEST-INFO | 13807: exit 0 23:11:19 INFO - TEST-OK | kraken | took 59271ms 23:11:19 INFO - TEST-START | v8_7 23:11:19 INFO - operating with platform_type : linux_ 23:11:19 INFO - Initialising browser for v8_7 test... 23:11:19 INFO - TEST-INFO | started process 14059 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplIrT9O/profile http://localhost:38482/getInfo.html) 23:11:23 INFO - PROCESS | 14059 | __metrics Screen width/height:1600/1200 23:11:23 INFO - PROCESS | 14059 | colorDepth:24 23:11:23 INFO - PROCESS | 14059 | Browser inner width/height: 1024/697 23:11:23 INFO - PROCESS | 14059 | __metrics 23:11:23 INFO - PROCESS | 14059 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:11:23 INFO - PROCESS | 14059 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:11:24 INFO - TEST-INFO | 14059: exit 0 23:11:24 INFO - Browser initialized. 23:11:24 INFO - Running cycle 1/1 for v8_7 test... 23:11:24 INFO - TEST-INFO | started process 14144 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplIrT9O/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:11:36 INFO - PROCESS | 14144 | RSS: Main: 150429696 23:11:36 INFO - PROCESS | 14144 | 23:11:57 INFO - PROCESS | 14144 | Cycle 1(1): loaded http://localhost:38482/tests/v8_7/run.html (next: http://localhost:38482/tests/v8_7/run.html) 23:11:58 INFO - PROCESS | 14144 | RSS: Main: 602066944 23:11:58 INFO - PROCESS | 14144 | 23:11:58 INFO - PROCESS | 14144 | __start_tp_report 23:11:58 INFO - PROCESS | 14144 | _x_x_mozilla_page_load 23:11:58 INFO - PROCESS | 14144 | _x_x_mozilla_page_load_details 23:11:58 INFO - PROCESS | 14144 | |i|pagename|runs| 23:11:58 INFO - PROCESS | 14144 | |0;Richards;166.75004168751042 23:11:58 INFO - PROCESS | 14144 | |1;DeltaBlue;191.57088122605364 23:11:58 INFO - PROCESS | 14144 | |2;Encrypt;280.3476310625175 23:11:58 INFO - PROCESS | 14144 | |3;Decrypt;5251.308900523561 23:11:58 INFO - PROCESS | 14144 | |4;RayTrace;1102.5358324145534 23:11:58 INFO - PROCESS | 14144 | |5;Earley;790.5138339920949 23:11:58 INFO - PROCESS | 14144 | |6;Boyer;12329.268292682927 23:11:58 INFO - PROCESS | 14144 | |7;RegExp;25948.71794871795 23:11:58 INFO - PROCESS | 14144 | |8;Splay;681.8181818181819 23:11:58 INFO - PROCESS | 14144 | |9;NavierStokes;4835.748792270531 23:11:58 INFO - PROCESS | 14144 | __end_tp_report 23:11:58 INFO - PROCESS | 14144 | __startTimestamp1451977918230__endTimestamp 23:11:58 INFO - PROCESS | 14144 | 23:11:58 INFO - PROCESS | 14144 | ------- Summary: start ------- 23:11:58 INFO - PROCESS | 14144 | Number of tests: 10 23:11:58 INFO - PROCESS | 14144 | 23:11:58 INFO - PROCESS | 14144 | [#0] Richards Cycles:1 Average:166.75 Median:166.75 stddev:0.00 (0.0%) 23:11:58 INFO - PROCESS | 14144 | Values: 166.8 23:11:58 INFO - PROCESS | 14144 | 23:11:58 INFO - PROCESS | 14144 | [#1] DeltaBlue Cycles:1 Average:191.57 Median:191.57 stddev:0.00 (0.0%) 23:11:58 INFO - PROCESS | 14144 | Values: 191.6 23:11:58 INFO - PROCESS | 14144 | 23:11:58 INFO - PROCESS | 14144 | [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 23:11:58 INFO - PROCESS | 14144 | Values: 280.3 23:11:58 INFO - PROCESS | 14144 | 23:11:58 INFO - PROCESS | 14144 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 23:11:58 INFO - PROCESS | 14144 | Values: 5251.3 23:11:58 INFO - PROCESS | 14144 | 23:11:58 INFO - PROCESS | 14144 | [#4] RayTrace Cycles:1 Average:1102.54 Median:1102.54 stddev:0.00 (0.0%) 23:11:58 INFO - PROCESS | 14144 | Values: 1102.5 23:11:58 INFO - PROCESS | 14144 | 23:11:58 INFO - PROCESS | 14144 | [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 23:11:58 INFO - PROCESS | 14144 | Values: 790.5 23:11:58 INFO - PROCESS | 14144 | 23:11:58 INFO - PROCESS | 14144 | [#6] Boyer Cycles:1 Average:12329.27 Median:12329.27 stddev:0.00 (0.0%) 23:11:58 INFO - PROCESS | 14144 | Values: 12329.3 23:11:58 INFO - PROCESS | 14144 | 23:11:58 INFO - PROCESS | 14144 | [#7] RegExp Cycles:1 Average:25948.72 Median:25948.72 stddev:0.00 (0.0%) 23:11:58 INFO - PROCESS | 14144 | Values: 25948.7 23:11:58 INFO - PROCESS | 14144 | 23:11:58 INFO - PROCESS | 14144 | [#8] Splay Cycles:1 Average:681.82 Median:681.82 stddev:0.00 (0.0%) 23:11:58 INFO - PROCESS | 14144 | Values: 681.8 23:11:58 INFO - PROCESS | 14144 | 23:11:58 INFO - PROCESS | 14144 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 23:11:58 INFO - PROCESS | 14144 | Values: 4835.7 23:11:58 INFO - PROCESS | 14144 | -------- Summary: end -------- 23:11:58 INFO - PROCESS | 14144 | 23:11:59 INFO - TEST-INFO | 14144: exit 0 23:11:59 INFO - TEST-OK | v8_7 | took 39415ms 23:11:59 INFO - SUITE-END | took 1212s 23:11:59 INFO - Completed test suite (00:20:12) 23:11:59 INFO - Working with test: dromaeo_css 23:11:59 INFO - Generating results file: dromaeo_css 23:11:59 INFO - Working with test: kraken 23:11:59 INFO - Generating results file: kraken 23:11:59 INFO - javascript benchmark 23:11:59 INFO - Working with test: v8_7 23:11:59 INFO - Generating results file: v8_7 23:11:59 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:11:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:11:59 INFO - process_Request line: dromaeo_css 6800.06 graph.html#tests=[[72,201,35]] 23:11:59 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:11:59 INFO - process_Request line: kraken 1512.80 graph.html#tests=[[232,201,35]] 23:11:59 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:11:59 INFO - process_Request line: v8_7 20697.22 graph.html#tests=[[230,201,35]] 23:11:59 INFO - RETURN: dromaeo_css: 6800.06 23:11:59 INFO - RETURN: kraken: 1512.80 23:11:59 INFO - RETURN: v8_7: 20697.22 23:11:59 INFO - javascript benchmark 23:11:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3057.694230576942, 3111.471049921513, 3159.241781972326, 3159.5576619273306, 3174.7460203183746, 4944.283078953549, 5097.490250974901, 5195.272661827343, 5244.160934250525, 5269.5520880725135, 5192.818251361203, 5210.843674689756, 5238.345206849144, 5258.894822103555, 5343.946560534394, 4689.413823272091, 4700.506446823086, 4768.260919557474, 4804.927926081112, 4827.63792715546, 4753.429588449391, 4769.523047695237, 4812.350332705075, 4812.87967800806, 4824.662273640846, 4654.4647365553055, 4681.438227412698, 4728.645351598644, 4760.333553302523, 4766.976165119187, 4699.0836786826585, 4721.881952951204, 4740.691855029447, 4743.549362810528, 4755.453122890877, 4718.764061796931, 4729.432468103815, 4757.26262429324, 4766.428028636551, 4779.115863565252, 4894.143524883167, 4975.253711943201, 5015.52352526513, 5051.2423136529815, 5076.340075790161, 5455.563554915637, 5485.945140548623, 5492.313460817398, 5498.285222921035, 5510.889782204334, 5507.173923911405, 5522.282103326542, 5523.226748255248, 5559.16612508127, 5563.471470210364, 5102.821401250975, 5148.58811295103, 5156.407013193456, 5185.688858668492, 5195.818146364934, 5713.8285851424525, 5721.828345149652, 5726.77092916287, 5728.914066289009, 5740.68426236561, 5494.615376923577, 5495.670259784426, 5499.532539734168, 5501.807436739775, 5523.171524271392, 5434.184872269191, 5462.7268636568015, 5494.230807686927, 5551.056320425538, 5592.916106258409, 5514.28314319144, 5518.668879867221, 5543.168524721244, 5548.195511650869, 5550.583706221969, 5520.227168196376, 5538.556915446755, 5542.5565954723525, 5544.750486228129, 5601.6358936668985, 4206.810693518799, 4275.294576394922, 4279.786010699452, 4319.0, 4346.913061738747, 3826.0626146594263, 3846.1346197105427, 3849.7882616456363, 3881.165549406891, 3881.3207688654375, 5073.949260507421, 5126.154184559506, 5180.870478237999, 5181.922271165936, 5230.581553475713, 5533.335999680065, 5564.0, 5571.637843540157, 5626.85932851682, 5673.1490276458035, 5211.973940130275, 5269.71016594091, 5286.682799032071, 5286.762095705702, 5295.12630415977, 4713.2458806590785, 4810.013947140827, 4817.5182481752245, 4823.155947709137, 4826.975865120722, 5713.457221563945, 5725.08398656213, 5741.081426971665, 5765.07758758605, 5848.093545500455, 5495.395506494362, 5531.363893152339, 5545.1682247663175, 5549.750261238173, 5559.360673522435, 5665.461781130786, 5730.942690573041, 5734.082546792493, 5742.626729262584, 5790.276215473066, 5473.808416705396, 5488.56091512686, 5513.814529876096, 5522.840203557298, 5564.527015203753, 5515.503604675599, 5523.895220955745, 5524.696141712245, 5593.524550413261, 5599.60802743804, 5276.314079169683, 5346.839594812006, 5380.838574842604, 5392.5416339611575, 5443.673379597237, 5346.358436987431, 5375.1399776037215, 5434.456554344534, 5443.918341224806, 5564.471375219509, 5332.466753324637, 5415.539679127318, 5421.241026256406, 5427.728613569227, 5427.918581221364, 5304.761285742228, 5351.3043304370185, 5516.668999860021, 5551.555875529867, 5576.804811831566, 5308.442613525524, 5355.357357117171, 5365.892682146257, 5375.623706340519, 5397.055515284731], "unit": "score", "name": "dojo.html", "value": 5127.062435763942}, {"lowerIsBetter": false, "replicates": [541.591098720466, 543.9728013599319, 563.7068724263382, 566.3684991234775, 575.4102045403461, 27424.177274681766, 27909.0, 39240.0, 39316.410253846145, 39423.211535769304, 41228.17543649133, 41392.586074139246, 41714.37428438568, 41909.16181676365, 41957.58042419575, 8422.83154336913, 8569.35729820266, 8571.22858942695, 8582.184692454206, 8588.0, 7327.596982165979, 7462.925370746305, 9836.262280328969, 9942.154916832078, 9990.50047497626, 9855.113039826414, 9949.801003979916, 9963.302568820185, 9967.900320996807, 9972.0, 7234.674439650228, 7358.742444014488, 9848.507574621277, 9936.056074672895, 9971.20230381575, 7388.076490438695, 9877.25920555954, 10096.848547271797, 10101.343412678227, 10110.241731870066, 35844.0, 36420.81789591035, 36487.27025459502, 36493.62076550804, 36526.0, 2865.5271880139753, 3000.969990300113, 3124.3126512167287, 3741.4387841823673, 3914.628110329514, 27347.863260683767, 28166.718332816614, 28226.29434264139, 28381.290467738472, 28449.146525604265, 3752.249550089966, 3859.4210868369687, 3875.5930627284292, 3923.431102490123, 3965.504311961005, 267777.0, 268207.0, 269012.0, 270599.6470017657, 270767.0, 59804.70097649484, 59838.401615984156, 60100.69949650224, 60117.39882601205, 60124.69937650371, 63310.366896330444, 63587.36412635907, 63593.36406635874, 63614.0, 63618.6819065911, 14409.13545187292, 14410.42358305677, 14414.567562973127, 14494.927525362516, 14565.0, 11836.349000805038, 11863.16957812962, 11884.227525210834, 11906.464209110438, 11909.464074116686, 19504.70742938857, 19799.0, 19977.900110499355, 20014.69977950332, 20016.199352025757, 6179.084483810033, 7279.818004549928, 7484.176740558534, 7555.13115991657, 7571.053618297713, 889.7642124836923, 918.5131880103556, 945.3807755919884, 1045.6810672744887, 1079.379356869803, 26809.463810723675, 27574.724252757616, 27576.812924728805, 27976.86011569929, 28000.43999120047, 967.811276801017, 1000.0799264676515, 1016.3190662256306, 1030.3251370352432, 1117.8486159255979, 14907.776383354258, 15076.623084422758, 15082.396704131712, 15167.317470713624, 15228.314725837365, 346112.0, 353437.0, 354072.0, 455857.0, 463923.0, 56300.43699562952, 56428.435715643136, 56633.43366566364, 56644.0, 57000.71499642475, 1360.7754720471012, 1377.638561908939, 1392.5195807446414, 1395.2186775405805, 1395.7348103860234, 26255.343616409744, 26340.473190536464, 29529.0, 30113.247168820955, 31109.0, 48724.26913596228, 49681.50318496769, 49741.51809373309, 49792.75518112076, 49834.0, 287492.0, 288137.0, 289377.0, 290213.0, 290214.0, 31827.68172318247, 32119.197020074684, 32333.51499727553, 32477.35045299128, 32546.67453325531, 41777.373339399324, 42113.0, 42462.78768606137, 42574.0, 42740.78629606832, 35775.82112089423, 36829.0, 37274.25451490901, 37326.25347493089, 37634.24731505409, 31561.89533366321, 31615.36769264648, 31617.367652647277, 31696.36607267888, 32000.35999279955, 37726.811365942995, 38326.2334753309, 38642.6135738639, 38831.41752873766, 38909.221815564095, 30296.54555181718, 30989.0, 32809.343813124084, 33464.498032529045, 33479.0, 24921.25236242843, 25619.743802561738, 26676.866615666797, 26898.462030758885, 27236.727632723418], "unit": "score", "name": "ext.html", "value": 18570.176144777226}, {"lowerIsBetter": false, "replicates": [361.79558549419573, 362.1561761096645, 365.36426617685237, 365.8810886461899, 366.58758896241727, 14062.507812226575, 14172.645683857909, 16080.597985050365, 16220.675586488263, 16986.83013169868, 16160.919195404007, 17052.573685657866, 17246.223919923603, 17270.654586908255, 17446.214920328584, 5352.304200453946, 5463.644863083887, 5475.370332411764, 5475.561955043587, 5478.424765399635, 4051.0075031617293, 4129.091599848029, 5323.9467605324035, 5350.170723537838, 5921.674307913063, 5949.345571987078, 5991.610545314541, 6000.2199714037115, 6009.969950150265, 6016.037434010537, 4916.115099282128, 5078.339815823919, 5083.440821509649, 5086.898262034775, 5963.55273354498, 4793.0, 4840.322354870321, 4853.9029219415415, 4948.158813001798, 5144.048351055067, 11841.467133978991, 11884.881151188463, 12078.335691536962, 12083.033357331393, 12109.212901161396, 1983.652860749363, 1992.163291417608, 2072.0986370928695, 2108.5888251790907, 2134.402367337148, 8905.243054340388, 9208.677696280598, 9260.073992600754, 9417.811643767087, 9468.195203407719, 1620.0684606351394, 1632.159437889476, 1660.900345979233, 1661.1860188507665, 1744.6249056452796, 55584.44415555873, 55797.16304255439, 56480.717596411756, 56484.71757641186, 59015.704921475546, 9529.618815247313, 9783.36408133469, 9886.950565247127, 9899.059589339002, 9949.602015919427, 12862.421191046426, 12920.870791292155, 12926.41831117602, 12947.0, 12959.352032398343, 7421.740239091606, 7451.850962980819, 7476.5514069156025, 7549.112721819545, 7628.427867909929, 7410.407167426701, 7494.587797671072, 7502.774916752506, 7531.8117047074265, 7546.5094768840945, 4345.283028300295, 4352.956470435319, 4355.607995280377, 4425.668074894395, 4451.109778044404, 1723.1039859273108, 1757.244384914499, 1757.613325068483, 1767.4874286456784, 1791.5073354827528, 814.3892080939296, 870.6822009966317, 930.8789857318505, 932.2076235200161, 948.6015873333216, 15409.691806163813, 15833.604159896095, 15996.280167392262, 16751.91624041872, 16867.578310542336, 875.1205038935828, 896.3680605173337, 902.566767951387, 941.3128416256035, 941.4586612697726, 9279.67521136757, 9302.813943721088, 9397.342186046912, 9433.25484785317, 9485.715428537154, 548421.0, 556145.0, 558096.0, 565284.0, 566127.0, 70264.0, 75333.24666753372, 76958.0, 78938.0, 79669.60165199137, 1098.23123813331, 1125.3585456289836, 1133.7165708572693, 1154.0940361815933, 1154.255505199142, 13847.238401887993, 13896.930515347358, 13941.790873137114, 14110.717785644025, 14229.359678814686, 18273.543161420537, 18533.166007529424, 30124.698753012188, 31072.0, 31618.26099564546, 45756.54243457656, 46175.0, 48724.652722336745, 48794.26808597803, 50125.0, 9081.68214112503, 9085.22775564058, 9166.770830729285, 9205.125513076247, 9436.292278079034, 11249.943750281196, 11322.094232461219, 11349.092072634005, 12185.756284874431, 16206.513804585882, 10679.19906007037, 11061.391623460788, 12812.61562153137, 13229.206247625174, 13440.731185376433, 13353.53262635803, 13637.79543306871, 13779.586612401645, 13931.651708707363, 14122.223277719824, 12162.0, 12330.75338493243, 12424.56514022005, 13128.868711312765, 13144.737105257651, 9459.006804285451, 9580.0, 9598.712038638852, 9659.0, 9774.657886973922, 9334.71995840126, 12975.351232438152, 12997.4403071632, 13477.663058423617, 14158.079724817853], "unit": "score", "name": "jquery.html", "value": 8343.246103546198}, {"lowerIsBetter": false, "replicates": [1280.2894393611552, 1460.401235493448, 1460.824701035876, 1611.355457816873, 1788.4098247578293, 6730.360615741502, 7346.338829505344, 7442.292982166699, 7454.5899975501325, 7462.179160292363, 7435.851282974338, 7587.430942679293, 7610.54336739796, 7626.885596716053, 7632.580208088553, 2222.688823564702, 2271.613825649635, 2272.091163534583, 2272.329662749493, 2274.3177046885867, 2211.8783466909313, 2229.520653059592, 2281.041962375806, 2285.4514916420108, 2285.5771682238756, 2115.851890367675, 2163.805257526822, 2166.620841352757, 2188.89055547222, 2194.3087927302927, 2178.36827320077, 2195.9451013724706, 2228.0308065991267, 2231.564844855262, 2232.1294695068937, 2249.5275992041693, 2249.6850440938283, 2274.749777524471, 2275.0899640143907, 2281.3498153026308, 7509.849803003964, 7579.962100189519, 7599.620018999028, 7605.80985475362, 7608.35328997036, 4492.168948744493, 4574.473935497427, 4588.2888152336445, 4589.5410458954175, 4596.333531637927, 2973.3458639099363, 3019.3659331540402, 3028.2278019105206, 3048.1465189746905, 3048.923776905573, 1019.4545917933943, 1039.8544203811473, 1047.089032541686, 1052.899974502421, 1121.9887801122047, 10405.47972601367, 10422.843657345145, 10434.999999999924, 10436.32163909351, 10460.52927618259, 3995.680345572347, 4058.857939972087, 4075.2053349597136, 4083.7345572538284, 4099.877003689894, 8944.105589441135, 8947.507887066275, 8955.238804701543, 8962.372633915693, 8967.058458861857, 4505.752183629932, 4510.548945105529, 4546.04533048057, 4582.495925448198, 4585.656075794329, 3728.3475391806323, 3742.232842267383, 4053.7365071270274, 4122.690798190088, 4136.91726165475, 3524.2599054198395, 3552.6802587767224, 3556.928861422757, 3558.768680035789, 3610.29599228148, 1134.0700625487023, 1150.3147888343617, 1154.2785758900686, 1165.650304908524, 1171.1918776044672, 964.8842138943372, 980.2403137568299, 980.6616717232686, 1066.903978641926, 1306.8627794081674, 7254.600996945113, 7269.0, 7269.600171990592, 7276.63616819157, 7297.197308296083, 461.7737308718704, 462.6853739457134, 469.55157824277734, 470.4848191230597, 470.5741304119777, 5577.832665020056, 5659.236003139606, 5681.517071048925, 5688.658680479184, 5689.601727879091, 8845.601947912359, 8860.113988601088, 8959.0, 8994.460332379947, 9087.091290870992, 8857.955710221408, 8977.057408972094, 8981.14679105484, 8998.100189980949, 9033.187013168847, 6723.495737819683, 6855.622940738307, 7037.366637002694, 7085.078939737801, 7103.751368702071, 6909.896351554831, 6966.4775141865575, 6978.860422791618, 6985.965070174617, 6995.230524642387, 7721.884171737541, 7984.560849153352, 8017.19828017217, 8093.0692970309165, 8137.674493020213, 7837.255460731221, 8100.959495202486, 8116.797080072809, 8126.309263712415, 8266.13205613402, 5944.702764861826, 5980.700964951822, 6470.870582588416, 6660.6336651484635, 6715.127033485615, 7151.392131668658, 7164.355208031302, 7218.3503484686635, 7221.747238846615, 7222.422206223385, 6492.870142597216, 6773.695183716646, 6818.897716534157, 6830.795076147723, 6992.790216293316, 6753.763618273337, 6801.693923773343, 6836.521443499107, 6862.828429289308, 6906.654667266516, 6487.3188315226225, 6838.487113466411, 6861.176658800976, 6862.691178896862, 6883.380495755406, 6330.620162790247, 6381.138546296376, 6400.103985441949, 6401.263854656774, 6418.19772528434, 6200.503959683305, 6240.0, 6246.531510136667, 6250.218722659668, 6250.718717657625], "unit": "score", "name": "mootools.html", "value": 4252.189290328314}, {"lowerIsBetter": false, "replicates": [328.9259916518783, 333.0441632514683, 333.1288680101535, 337.14701804434776, 341.98632054717814, 5765.625234359763, 5813.33146688131, 5814.912776308353, 5851.0930805725075, 5897.823065308037, 5650.773969041234, 5756.884862302752, 5758.049921762915, 5784.103463963082, 5797.3912739162415, 4468.285074388098, 4492.505824359318, 4502.527234640364, 4503.819847206108, 4506.143832671798, 4277.059047009653, 4329.9567004329865, 4351.064521127957, 4446.2219111655495, 4498.910021799562, 4405.713628614146, 4407.3609326647775, 4416.73499590024, 4422.734635921839, 4437.090396468732, 4419.447569053868, 4419.712718673276, 4425.88935276619, 4428.180786554498, 4431.933520997188, 3893.552241492236, 3893.8637147699696, 3899.459713413186, 3902.9804850975565, 3904.4533765272886, 5469.15228139635, 5579.776808927638, 5584.6090773645865, 5589.552835773169, 5592.6085174037835, 5156.819511317086, 5161.071007218699, 5166.638335316529, 5167.276581278624, 5170.095233334151, 6127.111568822495, 6127.724252408652, 6135.570510064297, 6136.0, 6138.508919286446, 4106.993786522321, 4180.937285940713, 4232.407462955189, 4313.84901528445, 4329.631981281595, 6400.487960963112, 6401.8399540011405, 6410.551261411703, 6419.711112999879, 6447.032945058232, 4460.085682435093, 4469.351943968107, 4471.195184866755, 4474.574915383034, 4474.731516109044, 4425.889352766207, 4524.09518096382, 4530.433695788027, 4532.0, 4535.523770004168, 5190.6107041972, 5191.428942816287, 5198.830263190752, 5200.531952124327, 5201.401838788512, 6176.3514830943, 6185.567010309235, 6186.412290832363, 6190.133381326618, 6199.287081985539, 1598.3446786817349, 1614.6932082904211, 1615.2650544002452, 1616.1515204517486, 1616.3373017062947, 1083.5882364701363, 1086.7120213143523, 1099.5162128663362, 1100.4112799652148, 1112.1492058575197, 5844.649321040666, 5844.649321040752, 5846.093855452412, 5908.704564771744, 5926.970365148147, 6299.622022678654, 6308.589941653778, 6321.936780632135, 6385.616862988236, 6400.519961002943, 5906.970465147647, 5917.733701983421, 5919.852003699856, 5921.407859214044, 5924.6149000314845, 3358.9328213436083, 3472.0625431133453, 3479.634638362986, 3480.077779388464, 3482.1120614243205, 6574.474042076718, 6583.703733332011, 6586.473082153416, 6588.341165883373, 6629.635370054597, 6611.471082313404, 6621.635810030398, 6627.768028118992, 6643.93697008486, 6647.501437392215, 6537.477001839841, 6672.432843208285, 6675.165604299463, 6679.56582822115, 6679.833004174838, 6174.567780255339, 6405.807825765234, 6423.935760642521, 6428.8071357859335, 6434.67826608677, 6195.2255968004, 6286.119943207863, 6316.873662526816, 6334.144890439732, 6400.23197216337, 6655.73377064912, 6661.3338666132995, 6668.166479190101, 6672.266050734513, 6680.632565208765, 4382.298832186835, 4425.181341451842, 4425.557444255549, 4427.778611069498, 4438.045820148684, 6289.9371006291185, 6453.064305675744, 6453.225612926479, 6460.515461340325, 6466.353364663496, 6271.404216599416, 6282.560220784501, 6284.402981716729, 6290.0, 6293.276273228637, 6138.600990935575, 6258.43674069336, 6271.498280137669, 6277.089821975879, 6287.559870808999, 6128.63228206309, 6156.78451254204, 6159.784407545714, 6166.568340216142, 6188.1027251049245, 6292.2134733158355, 6299.401556852092, 6299.590526615755, 6304.968475157595, 6305.2433707953505, 6049.758009679564, 6124.0, 6151.5386346025125, 6170.043643235305, 6177.351378105234], "unit": "score", "name": "prototype.html", "value": 4690.474459757023}, {"lowerIsBetter": false, "replicates": [762.6911101004092, 775.5850619918344, 777.1917206105651, 811.4928169893816, 867.2151702709049, 13683.589492315234, 13892.305384730773, 13916.721665566683, 13925.860741392584, 13951.860481395182, 12826.807597886016, 12837.0, 12837.807432888514, 12870.806937895939, 12891.742165156691, 654.0614218596306, 661.1768348406241, 786.6656670914867, 791.5369508837337, 794.0193860582206, 782.9804254893645, 800.2077942836609, 800.3077338102557, 801.6432687454085, 802.0215337288498, 815.9224873637024, 830.5805568188086, 830.6511265268572, 831.3058596072287, 831.5592735850009, 675.7938828657282, 681.931806819319, 810.8459392715424, 822.2065706593137, 822.5763731678161, 608.8386577556951, 611.0, 611.4069352727847, 611.6146827498692, 613.4938675592654, 12952.48190072396, 13028.348582570834, 13076.673083172902, 13099.934500327437, 13130.540431084866, 11877.0, 12078.456469458895, 12241.510339586406, 12852.614421567368, 12925.482980680761, 10371.896281037169, 10700.892991070068, 10807.297525660806, 10914.454277286104, 11027.338359698444, 3612.331718632035, 3677.2277821657217, 3705.2589482103685, 3763.5671897731563, 3765.981170094132, 44366.0, 44648.553514464766, 44795.104097918185, 44831.3275300874, 44900.3264951026, 9727.270454715925, 9929.851052234222, 10308.793824123475, 10508.106810921157, 10561.524731387106, 17224.13879306055, 17501.649967000587, 17521.12394380276, 17524.5618859527, 17525.386611468537, 7032.7538536152015, 7241.746538871114, 7293.124825021031, 7409.7777066687, 7426.405887528985, 4408.559144085566, 4454.933176002362, 4459.353393757887, 4465.977670111629, 4473.6868419211, 3032.727054565056, 3067.539869019665, 3068.70847269509, 3068.969310306913, 3070.969290307113, 521.6895946911582, 537.5350321971466, 546.8086169840524, 549.198170670817, 554.163213547538, 546.2707285773457, 657.4575974820697, 670.3798985938085, 675.2651760370578, 695.857349243414, 7719.575423351657, 8138.470999385021, 8140.267375936194, 8238.176182381714, 8415.663373464993, 543.7118327286545, 638.6327861479667, 672.8856094463953, 683.3986092238897, 708.4190963409955, 3685.5761587417255, 3747.6252374762853, 3757.3205894383514, 3824.521934758155, 3917.8628747993685, 52709.209361859605, 53347.0, 53604.0, 53710.73144634252, 54317.1852422214, 46569.767151164706, 47306.5269347309, 47473.0, 47587.524124759, 49242.507574923795, 43348.0, 43681.34477982833, 44096.0, 44610.77694611506, 45315.09369812651, 8058.556779376956, 8135.30849877767, 8626.0, 8726.694565690424, 8786.780330491789, 36538.8173059133, 36886.44670330001, 37744.433833491974, 38421.4236786454, 38599.42100868433, 46625.3006204914, 47161.52838471571, 47287.0, 47957.280640789715, 49493.50506495033, 11439.027682647069, 11501.424928753697, 11693.88306116928, 11963.581274655346, 12288.447019883948, 12643.178193417398, 12753.48986040548, 12768.6807829805, 13068.738625227632, 13124.703176943805, 11405.144614153805, 11626.593069242535, 11700.531978720755, 12030.398480075786, 12119.515219391125, 11012.889871101186, 11122.499487523242, 11380.146489013523, 11417.486213120263, 11484.023857972166, 11349.978501934866, 11428.771424571629, 11431.771364572496, 11494.137939654727, 11637.185397022127, 9666.709998700051, 9683.467409292556, 9838.508074596384, 10222.284440089123, 10229.488525573543, 8808.779780505538, 8864.77838054028, 9186.770330741785, 9495.248905786108, 9570.425774453555], "unit": "score", "name": "yui.html", "value": 6240.002475817248}], "name": "dromaeo_css", "value": 6800.056354561574}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 113.0, 112.0, 113.0, 102.0, 114.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [153.0, 127.0, 152.0, 175.0, 125.0, 152.0, 150.0, 124.0, 164.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 159.0, 161.0, 161.0, 161.0, 160.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 79.0, 94.0, 71.0, 72.0, 73.0, 104.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 138.0, 95.0, 96.0, 96.0, 140.0, 95.0, 97.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 151.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 59.0, 56.0, 56.0, 57.0, 57.0, 70.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 69.0, 67.0, 68.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [84.0, 88.0, 87.0, 90.0, 93.0, 85.0, 86.0, 86.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [134.0, 115.0, 117.0, 121.0, 119.0, 125.0, 126.0, 116.0, 115.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [148.0, 152.0, 157.0, 157.0, 160.0, 151.0, 161.0, 156.0, 156.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.7}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 70.0, 70.0, 67.0, 69.0, 67.0, 68.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1512.8000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.75004168751042], "unit": "score", "name": "Richards", "value": 211.70609399999992}, {"lowerIsBetter": false, "replicates": [191.57088122605364], "unit": "score", "name": "DeltaBlue", "value": 345.13596000000007}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1102.5358324145534], "unit": "score", "name": "RayTrace", "value": 671.170023}, {"lowerIsBetter": false, "replicates": [790.5138339920949], "unit": "score", "name": "Earley", "value": 843.0756950000003}, {"lowerIsBetter": false, "replicates": [12329.268292682927], "unit": "score", "name": "Boyer", "value": 54.05535707220569}, {"lowerIsBetter": false, "replicates": [25948.71794871795], "unit": "score", "name": "RegExp", "value": 35.107129446640336}, {"lowerIsBetter": false, "replicates": [681.8181818181819], "unit": "score", "name": "Splay", "value": 119.52013333333332}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20697.224019873636}]} 23:11:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20697.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1512.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6800.06"}}} 23:11:59 INFO - Return code: 0 23:11:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:11:59 INFO - # TBPL SUCCESS # 23:11:59 INFO - Running post-action listener: _resource_record_post_action 23:11:59 INFO - Running post-run listener: _resource_record_post_run 23:12:00 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 566104064; Read time: 0; Write time: 604904 23:12:00 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246378496; Read time: 0; Write time: 365228 23:12:00 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 319561728; Read time: 0; Write time: 239652 23:12:00 INFO - Running post-run listener: _upload_blobber_files 23:12:00 INFO - Blob upload gear active. 23:12:00 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:12:00 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 23:12:00 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:12:00 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:12:01 INFO - (blobuploader) - INFO - Open directory for files ... 23:12:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:12:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:12:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:12:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:12:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:12:01 INFO - (blobuploader) - INFO - Done attempting. 23:12:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:12:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:12:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:12:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:12:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:12:02 INFO - (blobuploader) - INFO - Done attempting. 23:12:02 INFO - (blobuploader) - INFO - Iteration through files over. 23:12:02 INFO - Return code: 0 23:12:02 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:12:02 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:12:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e7e9ab9060200fbd07f8a5587f80694786cdefc34e1cf1563264a2a0ec5fc6dae93eeaa877e6ea77adc8fe90972ecced114b6fe09ef0dd55a926b002ef36bbfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/442433ddfd13eb8ca9c59c78c66605717562599c933d981d412ec3eb4b8aa2bd32f5b004a1674e575d157cefce1faa82792d5e26d0cb4f7fa2a37d5d85617763"} 23:12:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:12:02 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:12:02 INFO - Contents: 23:12:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e7e9ab9060200fbd07f8a5587f80694786cdefc34e1cf1563264a2a0ec5fc6dae93eeaa877e6ea77adc8fe90972ecced114b6fe09ef0dd55a926b002ef36bbfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/442433ddfd13eb8ca9c59c78c66605717562599c933d981d412ec3eb4b8aa2bd32f5b004a1674e575d157cefce1faa82792d5e26d0cb4f7fa2a37d5d85617763"} 23:12:02 INFO - Copying logs to upload dir... 23:12:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.999909 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-04 23:12:01.610723) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 23:12:01.614025) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e7e9ab9060200fbd07f8a5587f80694786cdefc34e1cf1563264a2a0ec5fc6dae93eeaa877e6ea77adc8fe90972ecced114b6fe09ef0dd55a926b002ef36bbfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/442433ddfd13eb8ca9c59c78c66605717562599c933d981d412ec3eb4b8aa2bd32f5b004a1674e575d157cefce1faa82792d5e26d0cb4f7fa2a37d5d85617763"} build_url:https://queue.taskcluster.net/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/CselPyI5SbCpGUf8hU8Ieg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e7e9ab9060200fbd07f8a5587f80694786cdefc34e1cf1563264a2a0ec5fc6dae93eeaa877e6ea77adc8fe90972ecced114b6fe09ef0dd55a926b002ef36bbfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/442433ddfd13eb8ca9c59c78c66605717562599c933d981d412ec3eb4b8aa2bd32f5b004a1674e575d157cefce1faa82792d5e26d0cb4f7fa2a37d5d85617763"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 23:12:01.640753) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 23:12:01.641247) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1451970465.390182-26932600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 23:12:01.723585) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 23:12:01.723938) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 23:12:01.724274) ========= ========= Total master_lag: 0.22 =========