builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1451707421.52 results: success (0) buildid: 20160101173006 builduid: 3c21e9a1c21b439d93c51b19fcbdbf6e revision: f7fbc524f9f378ab381f02412adceffed5f6a1c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.515757) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.516290) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.516619) ========= 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=61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006324 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.541041) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.541402) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.563701) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.564093) ========= 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=61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.613268) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.613662) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.614110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.614428) ========= 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=61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-01 20:03:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-01-01 20:03:41 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171222 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.798486) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.798846) ========= 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=61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017740 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.849262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:41.849681) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev f7fbc524f9f378ab381f02412adceffed5f6a1c7 --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 f7fbc524f9f378ab381f02412adceffed5f6a1c7 --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=61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-01 20:03:41,878 truncating revision to first 12 chars 2016-01-01 20:03:41,878 Setting DEBUG logging. 2016-01-01 20:03:41,878 attempt 1/10 2016-01-01 20:03:41,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/f7fbc524f9f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-01 20:03:42,226 unpacking tar archive at: b2g-inbound-f7fbc524f9f3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649422 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:42.515726) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:42.516199) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:42.529983) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:42.530291) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 20:03:42.530728) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-01 20:03:42.531066) ========= /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=61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:03:42 INFO - MultiFileLogger online at 20160101 20:03:42 in /builds/slave/test-pgo 20:03:42 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 20:03:42 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:03:42 INFO - {'append_to_log': False, 20:03:42 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:03:42 INFO - 'blob_upload_branch': 'B2G-Inbound', 20:03:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:03:42 INFO - 'branch': 'B2G-Inbound', 20:03:42 INFO - 'buildbot_json_path': 'buildprops.json', 20:03:42 INFO - 'config_files': ('talos/linux_config.py',), 20:03:42 INFO - 'default_actions': ('clobber', 20:03:42 INFO - 'read-buildbot-config', 20:03:42 INFO - 'download-and-extract', 20:03:42 INFO - 'populate-webroot', 20:03:42 INFO - 'create-virtualenv', 20:03:42 INFO - 'install', 20:03:42 INFO - 'run-tests'), 20:03:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:03:42 INFO - 'download_minidump_stackwalk': True, 20:03:42 INFO - 'download_symbols': 'ondemand', 20:03:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:03:42 INFO - 'tooltool.py': '/tools/tooltool.py', 20:03:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:03:42 INFO - '/tools/misc-python/virtualenv.py')}, 20:03:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:03:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:03:42 INFO - 'installer_path': 'installer.exe', 20:03:42 INFO - 'log_level': 'info', 20:03:42 INFO - 'log_name': 'talos', 20:03:42 INFO - 'log_to_console': True, 20:03:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:03:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:03:42 INFO - 'opt_config_files': (), 20:03:42 INFO - 'pip_index': False, 20:03:42 INFO - 'sps_profile': False, 20:03:42 INFO - 'sps_profile_interval': 0, 20:03:42 INFO - 'suite': 'dromaeojs', 20:03:42 INFO - 'system_bits': '32', 20:03:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:03:42 INFO - 'title': 'talos-linux64-ix-045', 20:03:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:03:42 INFO - 'use_talos_json': True, 20:03:42 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:03:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:03:42 INFO - 'work_dir': 'build'} 20:03:42 INFO - ##### 20:03:42 INFO - ##### Running clobber step. 20:03:42 INFO - ##### 20:03:42 INFO - Running pre-action listener: _resource_record_pre_action 20:03:42 INFO - Running main action method: clobber 20:03:42 INFO - rmtree: /builds/slave/test-pgo/build 20:03:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:03:43 INFO - Running post-action listener: _resource_record_post_action 20:03:43 INFO - ##### 20:03:43 INFO - ##### Running read-buildbot-config step. 20:03:43 INFO - ##### 20:03:43 INFO - Running pre-action listener: _resource_record_pre_action 20:03:43 INFO - Running main action method: read_buildbot_config 20:03:43 INFO - Using buildbot properties: 20:03:43 INFO - { 20:03:43 INFO - "project": "", 20:03:43 INFO - "product": "firefox", 20:03:43 INFO - "script_repo_revision": "production", 20:03:43 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 20:03:43 INFO - "repository": "", 20:03:43 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 20:03:43 INFO - "buildid": "20160101173006", 20:03:43 INFO - "pgo_build": "True", 20:03:43 INFO - "basedir": "/builds/slave/test-pgo", 20:03:43 INFO - "buildnumber": 1083, 20:03:43 INFO - "slavename": "talos-linux64-ix-045", 20:03:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:03:43 INFO - "platform": "ubuntu64_hw", 20:03:43 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 20:03:43 INFO - "branch": "b2g-inbound", 20:03:43 INFO - "repo_path": "integration/b2g-inbound", 20:03:43 INFO - "revision": "f7fbc524f9f378ab381f02412adceffed5f6a1c7", 20:03:43 INFO - "stage_platform": "linux64-pgo", 20:03:43 INFO - "builduid": "3c21e9a1c21b439d93c51b19fcbdbf6e", 20:03:43 INFO - "slavebuilddir": "test" 20:03:43 INFO - } 20:03:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 20:03:43 INFO - Running post-action listener: _resource_record_post_action 20:03:43 INFO - ##### 20:03:43 INFO - ##### Running download-and-extract step. 20:03:43 INFO - ##### 20:03:43 INFO - Running pre-action listener: _resource_record_pre_action 20:03:43 INFO - Running main action method: download_and_extract 20:03:43 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:43 INFO - https://queue.taskcluster.net/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:03:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/test_packages.json 20:03:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/test_packages.json 20:03:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:03:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:03:43 INFO - Downloaded 1302 bytes. 20:03:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:03:43 INFO - Using the following test package requirements: 20:03:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:03:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:03:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:43 INFO - u'jsshell-linux-x86_64.zip'], 20:03:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:03:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:03:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:03:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:03:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:03:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:03:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:03:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:43 INFO - https://queue.taskcluster.net/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:03:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:03:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:03:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/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 20:03:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/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 20:03:44 INFO - Downloaded 23197959 bytes. 20:03:44 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 20:03:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:03:44 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 20:03:45 INFO - Return code: 0 20:03:45 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 20:03: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')]} 20:03:45 INFO - https://queue.taskcluster.net/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:03:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:03:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:03:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/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 20:03:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/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 20:03:48 INFO - Downloaded 23197959 bytes. 20:03:48 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 20:03:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:03:48 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 20:03:50 INFO - Return code: 0 20:03:50 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')]} 20:03:50 INFO - https://queue.taskcluster.net/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:03:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:03:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:03:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/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 20:03:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/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 20:03:51 INFO - Downloaded 11132285 bytes. 20:03:51 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 20:03:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:03:51 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 20:03:51 INFO - Return code: 0 20:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:51 INFO - https://queue.taskcluster.net/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:03:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:03:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:03:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/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 20:03:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYtvEX5NReibcT8x6cMzNA/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 20:03:53 INFO - Downloaded 54985418 bytes. 20:03:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:03:53 INFO - mkdir: /builds/slave/test-pgo/properties 20:03:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:03:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:03:53 INFO - Contents: 20:03:53 INFO - build_url:https://queue.taskcluster.net/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:03:53 INFO - Running post-action listener: _resource_record_post_action 20:03:53 INFO - Running post-action listener: set_extra_try_arguments 20:03:53 INFO - ##### 20:03:53 INFO - ##### Running populate-webroot step. 20:03:53 INFO - ##### 20:03:53 INFO - Running pre-action listener: _resource_record_pre_action 20:03:53 INFO - Running main action method: populate_webroot 20:03:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:03:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:03:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:03:53 INFO - '--tppagecycles', 20:03:53 INFO - '7'], 20:03:53 INFO - 'tests': ['tsvgm']}}, 20:03:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:03:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:03:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:03:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:03:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:03:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:03:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:53 INFO - 'talos_options': ['--e10s'], 20:03:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:53 INFO - 'tests': ['damp', 'tps']}, 20:03:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:53 INFO - 'talos_options': ['--e10s'], 20:03:53 INFO - 'tests': ['damp', 'tps']}, 20:03:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:03:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:03:53 INFO - 'other': {'tests': ['a11yr', 20:03:53 INFO - 'ts_paint', 20:03:53 INFO - 'tpaint', 20:03:53 INFO - 'sessionrestore', 20:03:53 INFO - 'sessionrestore_no_auto_restore']}, 20:03:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:03:53 INFO - 'tests': ['a11yr', 20:03:53 INFO - 'ts_paint', 20:03:53 INFO - 'tpaint', 20:03:53 INFO - 'sessionrestore', 20:03:53 INFO - 'sessionrestore_no_auto_restore']}, 20:03:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:03:53 INFO - 'tests': ['a11yr', 20:03:53 INFO - 'ts_paint', 20:03:53 INFO - 'tpaint', 20:03:53 INFO - 'sessionrestore', 20:03:53 INFO - 'sessionrestore_no_auto_restore']}, 20:03:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:03:53 INFO - 'tests': ['a11yr', 20:03:53 INFO - 'ts_paint', 20:03:53 INFO - 'tpaint', 20:03:53 INFO - 'sessionrestore', 20:03:53 INFO - 'sessionrestore_no_auto_restore']}, 20:03:53 INFO - 'other_l64': {'tests': ['a11yr', 20:03:53 INFO - 'ts_paint', 20:03:53 INFO - 'tpaint', 20:03:53 INFO - 'sessionrestore', 20:03:53 INFO - 'sessionrestore_no_auto_restore']}, 20:03:53 INFO - 'other_nol64': {'tests': ['a11yr', 20:03:53 INFO - 'ts_paint', 20:03:53 INFO - 'tpaint', 20:03:53 INFO - 'sessionrestore', 20:03:53 INFO - 'sessionrestore_no_auto_restore']}, 20:03:53 INFO - 'svgr': {'tests': ['tsvgx', 20:03:53 INFO - 'tsvgr_opacity', 20:03:53 INFO - 'tart', 20:03:53 INFO - 'tscrollx', 20:03:53 INFO - 'cart']}, 20:03:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:03:53 INFO - 'tests': ['tsvgx', 20:03:53 INFO - 'tsvgr_opacity', 20:03:53 INFO - 'tart', 20:03:53 INFO - 'tscrollx', 20:03:53 INFO - 'cart']}, 20:03:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:53 INFO - 'tests': ['tp5o']}, 20:03:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:53 INFO - 'talos_options': ['--e10s'], 20:03:53 INFO - 'tests': ['tp5o']}, 20:03:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:53 INFO - 'talos_options': ['--xperf_path', 20:03:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:53 INFO - 'tests': ['tp5n']}, 20:03:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:53 INFO - 'talos_options': ['--e10s', 20:03:53 INFO - '--xperf_path', 20:03:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:53 INFO - 'tests': ['tp5n']}}, 20:03:53 INFO - 'talos.zip': {'path': '', 20:03:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:03:53 INFO - Running post-action listener: _resource_record_post_action 20:03:53 INFO - ##### 20:03:53 INFO - ##### Running create-virtualenv step. 20:03:53 INFO - ##### 20:03:53 INFO - Running pre-action listener: _resource_record_pre_action 20:03:53 INFO - Running main action method: create_virtualenv 20:03:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:03:53 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 20:03:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:03:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:03:53 INFO - Using real prefix '/usr' 20:03:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:03:54 INFO - Installing distribute.............................................................................................................................................................................................done. 20:03:56 INFO - Installing pip.................done. 20:03:56 INFO - Return code: 0 20:03:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6d89909f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b740>, '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 0x1f6c640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6caf0>, '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': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', '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 20:03:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:03:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:03:56 INFO - Using env: {'DISPLAY': ':0', 20:03:56 INFO - 'HOME': '/home/cltbld', 20:03:56 INFO - 'LANG': 'en_US.UTF-8', 20:03:56 INFO - 'LANGUAGE': 'en_US:en', 20:03:56 INFO - 'LOGNAME': 'cltbld', 20:03:56 INFO - 'MAIL': '/var/mail/cltbld', 20:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:56 INFO - 'MOZ_NO_REMOTE': '1', 20:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:56 INFO - 'NO_EM_RESTART': '1', 20:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:56 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:56 INFO - 'SHELL': '/bin/bash', 20:03:56 INFO - 'SHLVL': '1', 20:03:56 INFO - 'TERM': 'linux', 20:03:56 INFO - 'TMOUT': '86400', 20:03:56 INFO - 'USER': 'cltbld', 20:03:56 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', 20:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:56 INFO - '_': '/tools/buildbot/bin/python'} 20:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:56 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 20:03:56 INFO - Cleaning up... 20:03:56 INFO - Return code: 0 20:03:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6d89909f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b740>, '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 0x1f6c640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6caf0>, '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': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', '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 20:03:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:03:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:03:56 INFO - Using env: {'DISPLAY': ':0', 20:03:56 INFO - 'HOME': '/home/cltbld', 20:03:56 INFO - 'LANG': 'en_US.UTF-8', 20:03:56 INFO - 'LANGUAGE': 'en_US:en', 20:03:56 INFO - 'LOGNAME': 'cltbld', 20:03:56 INFO - 'MAIL': '/var/mail/cltbld', 20:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:56 INFO - 'MOZ_NO_REMOTE': '1', 20:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:56 INFO - 'NO_EM_RESTART': '1', 20:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:56 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:56 INFO - 'SHELL': '/bin/bash', 20:03:56 INFO - 'SHLVL': '1', 20:03:56 INFO - 'TERM': 'linux', 20:03:56 INFO - 'TMOUT': '86400', 20:03:56 INFO - 'USER': 'cltbld', 20:03:56 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', 20:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:56 INFO - '_': '/tools/buildbot/bin/python'} 20:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:56 INFO - Downloading/unpacking psutil>=0.7.1 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:03:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:03:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:03:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:58 INFO - Installing collected packages: psutil 20:03:58 INFO - Running setup.py install for psutil 20:03:58 INFO - building 'psutil._psutil_linux' extension 20:03:58 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 20:03:58 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 20:03:58 INFO - building 'psutil._psutil_posix' extension 20:03:58 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 20:03:58 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 20:03:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:58 INFO - Successfully installed psutil 20:03:58 INFO - Cleaning up... 20:03:58 INFO - Return code: 0 20:03:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6d89909f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b740>, '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 0x1f6c640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6caf0>, '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': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', '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 20:03:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 20:03:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:03:58 INFO - Using env: {'DISPLAY': ':0', 20:03:58 INFO - 'HOME': '/home/cltbld', 20:03:58 INFO - 'LANG': 'en_US.UTF-8', 20:03:58 INFO - 'LANGUAGE': 'en_US:en', 20:03:58 INFO - 'LOGNAME': 'cltbld', 20:03:58 INFO - 'MAIL': '/var/mail/cltbld', 20:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:58 INFO - 'MOZ_NO_REMOTE': '1', 20:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:58 INFO - 'NO_EM_RESTART': '1', 20:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:58 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:58 INFO - 'SHELL': '/bin/bash', 20:03:58 INFO - 'SHLVL': '1', 20:03:58 INFO - 'TERM': 'linux', 20:03:58 INFO - 'TMOUT': '86400', 20:03:58 INFO - 'USER': 'cltbld', 20:03:58 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', 20:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:58 INFO - '_': '/tools/buildbot/bin/python'} 20:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:03:59 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 20:03:59 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 20:03:59 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 20:03:59 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 20:03:59 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 20:03:59 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 20:04:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:04:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:04:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:04:00 INFO - Installing collected packages: mozsystemmonitor 20:04:00 INFO - Running setup.py install for mozsystemmonitor 20:04:00 INFO - Successfully installed mozsystemmonitor 20:04:00 INFO - Cleaning up... 20:04:00 INFO - Return code: 0 20:04:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:00 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 0x7f6d89909f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b740>, '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 0x1f6c640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6caf0>, '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': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', '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 20:04:00 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 20:04:00 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 20:04:00 INFO - Using env: {'DISPLAY': ':0', 20:04:00 INFO - 'HOME': '/home/cltbld', 20:04:00 INFO - 'LANG': 'en_US.UTF-8', 20:04:00 INFO - 'LANGUAGE': 'en_US:en', 20:04:00 INFO - 'LOGNAME': 'cltbld', 20:04:00 INFO - 'MAIL': '/var/mail/cltbld', 20:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:00 INFO - 'MOZ_NO_REMOTE': '1', 20:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:00 INFO - 'NO_EM_RESTART': '1', 20:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:04:00 INFO - 'PWD': '/builds/slave/test-pgo', 20:04:00 INFO - 'SHELL': '/bin/bash', 20:04:00 INFO - 'SHLVL': '1', 20:04:00 INFO - 'TERM': 'linux', 20:04:00 INFO - 'TMOUT': '86400', 20:04:00 INFO - 'USER': 'cltbld', 20:04:00 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', 20:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:00 INFO - '_': '/tools/buildbot/bin/python'} 20:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:01 INFO - Downloading/unpacking blobuploader==1.2.4 20:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:02 INFO - Downloading blobuploader-1.2.4.tar.gz 20:04:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:04:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:04:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:04:02 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 20:04:02 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 20:04:02 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 20:04:02 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 20:04:02 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 20:04:02 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 20:04:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:04:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:04:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:04:03 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 20:04:03 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 20:04:03 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 20:04:03 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 20:04:03 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 20:04:03 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 20:04:03 INFO - Downloading docopt-0.6.1.tar.gz 20:04:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:04:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:04:03 INFO - Installing collected packages: blobuploader, requests, docopt 20:04:03 INFO - Running setup.py install for blobuploader 20:04:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:04:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:04:03 INFO - Running setup.py install for requests 20:04:04 INFO - Running setup.py install for docopt 20:04:04 INFO - Successfully installed blobuploader requests docopt 20:04:04 INFO - Cleaning up... 20:04:04 INFO - Return code: 0 20:04:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:04: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')]} 20:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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')]} 20:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:04 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 0x7f6d89909f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b740>, '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 0x1f6c640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6caf0>, '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': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', '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 20:04:04 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 20:04:04 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 20:04:04 INFO - Using env: {'DISPLAY': ':0', 20:04:04 INFO - 'HOME': '/home/cltbld', 20:04:04 INFO - 'LANG': 'en_US.UTF-8', 20:04:04 INFO - 'LANGUAGE': 'en_US:en', 20:04:04 INFO - 'LOGNAME': 'cltbld', 20:04:04 INFO - 'MAIL': '/var/mail/cltbld', 20:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:04 INFO - 'MOZ_NO_REMOTE': '1', 20:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:04 INFO - 'NO_EM_RESTART': '1', 20:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:04:04 INFO - 'PWD': '/builds/slave/test-pgo', 20:04:04 INFO - 'SHELL': '/bin/bash', 20:04:04 INFO - 'SHLVL': '1', 20:04:04 INFO - 'TERM': 'linux', 20:04:04 INFO - 'TMOUT': '86400', 20:04:04 INFO - 'USER': 'cltbld', 20:04:04 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', 20:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:04 INFO - '_': '/tools/buildbot/bin/python'} 20:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:04:04 INFO - Running setup.py (path:/tmp/pip-awUzkG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:04:04 INFO - Running setup.py (path:/tmp/pip-IqZUYb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:04:04 INFO - Running setup.py (path:/tmp/pip-AdrBFf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:04:04 INFO - Running setup.py (path:/tmp/pip-RUCCFj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:04:04 INFO - Running setup.py (path:/tmp/pip-Vek73V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:04:04 INFO - Running setup.py (path:/tmp/pip-p7zjZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:04:04 INFO - Running setup.py (path:/tmp/pip-4ClYui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:04:04 INFO - Running setup.py (path:/tmp/pip-N06OHl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:04:04 INFO - Running setup.py (path:/tmp/pip-SDz5af-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:04:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:04:05 INFO - Running setup.py (path:/tmp/pip-zEscoM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:04:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:04:05 INFO - Running setup.py (path:/tmp/pip-5C8Kri-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:04:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:04:05 INFO - Running setup.py (path:/tmp/pip-ueywAN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:04:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:04:05 INFO - Running setup.py (path:/tmp/pip-Y1BS3X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:04:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:04:05 INFO - Running setup.py (path:/tmp/pip-SnJa3_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:04:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:04:05 INFO - Running setup.py (path:/tmp/pip-4brPrj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:04:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:04:05 INFO - Running setup.py (path:/tmp/pip-GU1I2w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:04:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:04:05 INFO - Running setup.py (path:/tmp/pip-qj9xbT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:04:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:04:05 INFO - Running setup.py install for manifestparser 20:04:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:04:05 INFO - Running setup.py install for mozcrash 20:04:05 INFO - Running setup.py install for mozdebug 20:04:05 INFO - Running setup.py install for mozdevice 20:04:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:04:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:04:06 INFO - Running setup.py install for mozfile 20:04:06 INFO - Running setup.py install for mozhttpd 20:04:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:04:06 INFO - Running setup.py install for mozinfo 20:04:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:04:06 INFO - Running setup.py install for mozInstall 20:04:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:04:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:04:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:04:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:04:06 INFO - Running setup.py install for mozleak 20:04:06 INFO - Running setup.py install for mozlog 20:04:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:04:06 INFO - Running setup.py install for moznetwork 20:04:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:04:06 INFO - Running setup.py install for mozprocess 20:04:06 INFO - Running setup.py install for mozprofile 20:04:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:04:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:04:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:04:06 INFO - Running setup.py install for mozrunner 20:04:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:04:07 INFO - Running setup.py install for mozscreenshot 20:04:07 INFO - Running setup.py install for moztest 20:04:07 INFO - Running setup.py install for mozversion 20:04:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:04:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:04:07 INFO - Cleaning up... 20:04:07 INFO - Return code: 0 20:04:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:04:07 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')]} 20:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:07 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')]} 20:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:07 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 0x7f6d89909f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b740>, '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 0x1f6c640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6caf0>, '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': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', '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 20:04:07 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 20:04:07 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 20:04:07 INFO - Using env: {'DISPLAY': ':0', 20:04:07 INFO - 'HOME': '/home/cltbld', 20:04:07 INFO - 'LANG': 'en_US.UTF-8', 20:04:07 INFO - 'LANGUAGE': 'en_US:en', 20:04:07 INFO - 'LOGNAME': 'cltbld', 20:04:07 INFO - 'MAIL': '/var/mail/cltbld', 20:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:07 INFO - 'MOZ_NO_REMOTE': '1', 20:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:07 INFO - 'NO_EM_RESTART': '1', 20:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:04:07 INFO - 'PWD': '/builds/slave/test-pgo', 20:04:07 INFO - 'SHELL': '/bin/bash', 20:04:07 INFO - 'SHLVL': '1', 20:04:07 INFO - 'TERM': 'linux', 20:04:07 INFO - 'TMOUT': '86400', 20:04:07 INFO - 'USER': 'cltbld', 20:04:07 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', 20:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:07 INFO - '_': '/tools/buildbot/bin/python'} 20:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:04:07 INFO - Running setup.py (path:/tmp/pip-stRj8O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:04:07 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)) 20:04:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:04:07 INFO - Running setup.py (path:/tmp/pip-Iv4pmN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:04:07 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)) 20:04:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:04:07 INFO - Running setup.py (path:/tmp/pip-NFhO6w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:04:07 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)) 20:04:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:04:07 INFO - Running setup.py (path:/tmp/pip-i87xCj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:04:07 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)) 20:04:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:04:07 INFO - Running setup.py (path:/tmp/pip-0_9kYQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:04:07 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)) 20:04:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:04:07 INFO - Running setup.py (path:/tmp/pip-4UAj2k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:04:08 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)) 20:04:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:04:08 INFO - Running setup.py (path:/tmp/pip-O2TbaD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:04:08 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)) 20:04:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:04:08 INFO - Running setup.py (path:/tmp/pip-NZcDQN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:04:08 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)) 20:04:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:04:08 INFO - Running setup.py (path:/tmp/pip-rmN4zP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:04:08 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)) 20:04:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:04:08 INFO - Running setup.py (path:/tmp/pip-zShG29-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:04:08 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)) 20:04:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:04:08 INFO - Running setup.py (path:/tmp/pip-C_J98x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:04:08 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)) 20:04:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:04:08 INFO - Running setup.py (path:/tmp/pip-wOSbgN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:04:08 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)) 20:04:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:04:08 INFO - Running setup.py (path:/tmp/pip-ZQtRUq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:04:08 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)) 20:04:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:04:08 INFO - Running setup.py (path:/tmp/pip-LXHiYB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:04:08 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)) 20:04:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:04:08 INFO - Running setup.py (path:/tmp/pip-kS4ZML-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:04:08 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)) 20:04:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:04:08 INFO - Running setup.py (path:/tmp/pip-jHNxCk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:04:08 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)) 20:04:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:04:08 INFO - Running setup.py (path:/tmp/pip-HYYEcd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:04:08 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)) 20:04:08 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)) 20:04:08 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)) 20:04:08 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)) 20:04:08 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)) 20:04:08 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)) 20:04:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:04:08 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 20:04:08 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 20:04:08 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 20:04:08 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 20:04:08 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 20:04:08 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 20:04:10 INFO - Downloading blessings-1.5.1.tar.gz 20:04:10 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 20:04:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:04:10 INFO - Installing collected packages: blessings 20:04:10 INFO - Running setup.py install for blessings 20:04:10 INFO - Successfully installed blessings 20:04:10 INFO - Cleaning up... 20:04:10 INFO - Return code: 0 20:04:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:04:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:04:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:04:10 INFO - Reading from file tmpfile_stdout 20:04:10 INFO - Current package versions: 20:04:10 INFO - argparse == 1.2.1 20:04:10 INFO - blessings == 1.5.1 20:04:11 INFO - blobuploader == 1.2.4 20:04:11 INFO - docopt == 0.6.1 20:04:11 INFO - manifestparser == 1.1 20:04:11 INFO - mozInstall == 1.12 20:04:11 INFO - mozcrash == 0.16 20:04:11 INFO - mozdebug == 0.1 20:04:11 INFO - mozdevice == 0.47 20:04:11 INFO - mozfile == 1.2 20:04:11 INFO - mozhttpd == 0.7 20:04:11 INFO - mozinfo == 0.9 20:04:11 INFO - mozleak == 0.1 20:04:11 INFO - mozlog == 3.1 20:04:11 INFO - moznetwork == 0.27 20:04:11 INFO - mozprocess == 0.22 20:04:11 INFO - mozprofile == 0.28 20:04:11 INFO - mozrunner == 6.11 20:04:11 INFO - mozscreenshot == 0.1 20:04:11 INFO - mozsystemmonitor == 0.0 20:04:11 INFO - moztest == 0.7 20:04:11 INFO - mozversion == 1.4 20:04:11 INFO - psutil == 3.1.1 20:04:11 INFO - requests == 1.2.3 20:04:11 INFO - wsgiref == 0.1.2 20:04:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:04: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')]} 20:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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')]} 20:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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', '-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 0x7f6d89909f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b740>, '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 0x1f6c640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6caf0>, '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': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', '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 20:04:11 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 20:04:11 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 20:04:11 INFO - Using env: {'DISPLAY': ':0', 20:04:11 INFO - 'HOME': '/home/cltbld', 20:04:11 INFO - 'LANG': 'en_US.UTF-8', 20:04:11 INFO - 'LANGUAGE': 'en_US:en', 20:04:11 INFO - 'LOGNAME': 'cltbld', 20:04:11 INFO - 'MAIL': '/var/mail/cltbld', 20:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:11 INFO - 'MOZ_NO_REMOTE': '1', 20:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:11 INFO - 'NO_EM_RESTART': '1', 20:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:04:11 INFO - 'PWD': '/builds/slave/test-pgo', 20:04:11 INFO - 'SHELL': '/bin/bash', 20:04:11 INFO - 'SHLVL': '1', 20:04:11 INFO - 'TERM': 'linux', 20:04:11 INFO - 'TMOUT': '86400', 20:04:11 INFO - 'USER': 'cltbld', 20:04:11 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', 20:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:11 INFO - '_': '/tools/buildbot/bin/python'} 20:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:11 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)) 20:04:11 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)) 20:04:11 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)) 20:04:11 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)) 20:04:11 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)) 20:04:11 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)) 20:04:11 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)) 20:04:11 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)) 20:04:11 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)) 20:04:11 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)) 20:04:11 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)) 20:04:11 INFO - Cleaning up... 20:04:11 INFO - Return code: 0 20:04:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:04: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')]} 20:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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')]} 20:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6d89909f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b740>, '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 0x1f6c640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6caf0>, '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': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', '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 20:04: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', 'jsonschema'] in /builds/slave/test-pgo/build 20:04: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 jsonschema 20:04:11 INFO - Using env: {'DISPLAY': ':0', 20:04:11 INFO - 'HOME': '/home/cltbld', 20:04:11 INFO - 'LANG': 'en_US.UTF-8', 20:04:11 INFO - 'LANGUAGE': 'en_US:en', 20:04:11 INFO - 'LOGNAME': 'cltbld', 20:04:11 INFO - 'MAIL': '/var/mail/cltbld', 20:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:11 INFO - 'MOZ_NO_REMOTE': '1', 20:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:11 INFO - 'NO_EM_RESTART': '1', 20:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:04:11 INFO - 'PWD': '/builds/slave/test-pgo', 20:04:11 INFO - 'SHELL': '/bin/bash', 20:04:11 INFO - 'SHLVL': '1', 20:04:11 INFO - 'TERM': 'linux', 20:04:11 INFO - 'TMOUT': '86400', 20:04:11 INFO - 'USER': 'cltbld', 20:04:11 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', 20:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:11 INFO - '_': '/tools/buildbot/bin/python'} 20:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:11 INFO - Downloading/unpacking jsonschema 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:04:13 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 20:04:13 INFO - Downloading/unpacking functools32 (from jsonschema) 20:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:13 INFO - Downloading functools32-3.2.3-2.tar.gz 20:04:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:04:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:04:13 INFO - warning: no files found matching '*.txt' 20:04:13 INFO - no previously-included directories found matching 'build' 20:04:13 INFO - no previously-included directories found matching 'dist' 20:04:13 INFO - no previously-included directories found matching '.git*' 20:04:13 INFO - Installing collected packages: jsonschema, functools32 20:04:13 INFO - Running setup.py install for functools32 20:04:13 INFO - warning: no files found matching '*.txt' 20:04:13 INFO - no previously-included directories found matching 'build' 20:04:13 INFO - no previously-included directories found matching 'dist' 20:04:13 INFO - no previously-included directories found matching '.git*' 20:04:13 INFO - Successfully installed jsonschema functools32 20:04:13 INFO - Cleaning up... 20:04:13 INFO - Return code: 0 20:04:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:04: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')]} 20:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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')]} 20:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6d89909f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b740>, '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 0x1f6c640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6caf0>, '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': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', '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 20:04: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', 'flake8'] in /builds/slave/test-pgo/build 20:04: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 flake8 20:04:13 INFO - Using env: {'DISPLAY': ':0', 20:04:13 INFO - 'HOME': '/home/cltbld', 20:04:13 INFO - 'LANG': 'en_US.UTF-8', 20:04:13 INFO - 'LANGUAGE': 'en_US:en', 20:04:13 INFO - 'LOGNAME': 'cltbld', 20:04:13 INFO - 'MAIL': '/var/mail/cltbld', 20:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:13 INFO - 'MOZ_NO_REMOTE': '1', 20:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:13 INFO - 'NO_EM_RESTART': '1', 20:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:04:13 INFO - 'PWD': '/builds/slave/test-pgo', 20:04:13 INFO - 'SHELL': '/bin/bash', 20:04:13 INFO - 'SHLVL': '1', 20:04:13 INFO - 'TERM': 'linux', 20:04:13 INFO - 'TMOUT': '86400', 20:04:13 INFO - 'USER': 'cltbld', 20:04:13 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', 20:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:13 INFO - '_': '/tools/buildbot/bin/python'} 20:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:13 INFO - Downloading/unpacking flake8 20:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:04:16 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 20:04:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:04:16 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 20:04:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04:16 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 20:04:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:04:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:04:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:04:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:04:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:04:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:04:17 INFO - no previously-included directories found matching 'docs/_build' 20:04:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:04:17 INFO - Running setup.py install for pep8 20:04:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:04:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:04:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:04:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:04:17 INFO - no previously-included directories found matching 'docs/_build' 20:04:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:04:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:04:17 INFO - Cleaning up... 20:04:17 INFO - Return code: 0 20:04:17 INFO - Running post-action listener: _resource_record_post_action 20:04:17 INFO - Running post-action listener: _start_resource_monitoring 20:04:17 INFO - Starting resource monitoring. 20:04:17 INFO - ##### 20:04:17 INFO - ##### Running install step. 20:04:17 INFO - ##### 20:04:17 INFO - Running pre-action listener: _resource_record_pre_action 20:04:17 INFO - Running main action method: install 20:04:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:04:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:04:17 INFO - Reading from file tmpfile_stdout 20:04:17 INFO - Detecting whether we're running mozinstall >=1.0... 20:04:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:04:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:04:17 INFO - Reading from file tmpfile_stdout 20:04:17 INFO - Output received: 20:04:17 INFO - Usage: mozinstall [options] installer 20:04:17 INFO - Options: 20:04:17 INFO - -h, --help show this help message and exit 20:04:17 INFO - -d DEST, --destination=DEST 20:04:17 INFO - Directory to install application into. [default: 20:04:17 INFO - "/builds/slave/test-pgo"] 20:04:17 INFO - --app=APP Application being installed. [default: firefox] 20:04:17 INFO - mkdir: /builds/slave/test-pgo/build/application 20:04:17 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'] 20:04:17 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 20:04:33 INFO - Reading from file tmpfile_stdout 20:04:33 INFO - Output received: 20:04:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:04:33 INFO - Running post-action listener: _resource_record_post_action 20:04:33 INFO - ##### 20:04:33 INFO - ##### Running run-tests step. 20:04:33 INFO - ##### 20:04:33 INFO - Running pre-action listener: _resource_record_pre_action 20:04:33 INFO - Running main action method: run_tests 20:04:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:04:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:04:33 INFO - Python 2.7.3 20:04:33 INFO - Return code: 0 20:04:33 INFO - grabbing minidump binary from tooltool 20:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:33 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 0x1f6b740>, '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 0x1f6c640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6caf0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:04:33 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 20:04:33 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 20:04:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:04:33 INFO - Return code: 0 20:04:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:04:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:04:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:04:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:04:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:04:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:04:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:04:34 INFO - Return code: 0 20:04:34 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/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 20:04:34 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/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 20:04:34 INFO - Using env: {'DISPLAY': ':0', 20:04:34 INFO - 'HOME': '/home/cltbld', 20:04:34 INFO - 'LANG': 'en_US.UTF-8', 20:04:34 INFO - 'LANGUAGE': 'en_US:en', 20:04:34 INFO - 'LOGNAME': 'cltbld', 20:04:34 INFO - 'MAIL': '/var/mail/cltbld', 20:04:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:04:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:34 INFO - 'MOZ_NO_REMOTE': '1', 20:04:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:34 INFO - 'NO_EM_RESTART': '1', 20:04:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:04:34 INFO - 'PWD': '/builds/slave/test-pgo', 20:04:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:04:34 INFO - 'SHELL': '/bin/bash', 20:04:34 INFO - 'SHLVL': '1', 20:04:34 INFO - 'TERM': 'linux', 20:04:34 INFO - 'TMOUT': '86400', 20:04:34 INFO - 'USER': 'cltbld', 20:04:34 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404', 20:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:34 INFO - '_': '/tools/buildbot/bin/python'} 20:04:34 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/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 20:04:34 INFO - mozversion application_buildid: 20160101173006 20:04:34 INFO - mozversion application_changeset: f7fbc524f9f378ab381f02412adceffed5f6a1c7 20:04:34 INFO - mozversion application_display_name: Nightly 20:04:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:04:34 INFO - mozversion application_name: Firefox 20:04:34 INFO - mozversion application_remotingname: firefox 20:04:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 20:04:34 INFO - mozversion application_vendor: Mozilla 20:04:34 INFO - mozversion application_version: 46.0a1 20:04:34 INFO - mozversion platform_buildid: 20160101173006 20:04:34 INFO - mozversion platform_changeset: f7fbc524f9f378ab381f02412adceffed5f6a1c7 20:04:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 20:04:34 INFO - mozversion platform_version: 46.0a1 20:04:34 INFO - using testdate: 1451707474 20:04:34 INFO - actual date: 1451707474 20:04:34 INFO - starting webserver on 'localhost:44167' 20:04:34 INFO - SUITE-START | Running 3 tests 20:04:34 INFO - TEST-START | dromaeo_css 20:04:34 INFO - operating with platform_type : linux_ 20:04:34 INFO - Initialising browser for dromaeo_css test... 20:04:34 INFO - TEST-INFO | started process 4648 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpus60tj/profile http://localhost:44167/getInfo.html) 20:04:39 INFO - PROCESS | 4648 | __metrics Screen width/height:1600/1200 20:04:39 INFO - PROCESS | 4648 | colorDepth:24 20:04:39 INFO - PROCESS | 4648 | Browser inner width/height: 1024/697 20:04:39 INFO - PROCESS | 4648 | __metrics 20:04:39 INFO - PROCESS | 4648 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:04:39 INFO - PROCESS | 4648 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:04:40 INFO - TEST-INFO | 4648: exit 0 20:04:40 INFO - Browser initialized. 20:04:40 INFO - Running cycle 1/1 for dromaeo_css test... 20:04:40 INFO - TEST-INFO | started process 4743 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpus60tj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:04:51 INFO - PROCESS | 4743 | RSS: Main: 149778432 20:04:51 INFO - PROCESS | 4743 | 20:05:43 INFO - PROCESS | 4743 | 1451707543392 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] 20:07:51 INFO - PROCESS | 4743 | Cycle 1(1): loaded http://localhost:44167/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44167/tests/dromaeo/cssquery-ext.html) 20:07:52 INFO - PROCESS | 4743 | RSS: Main: 276930560 20:07:52 INFO - PROCESS | 4743 | 20:10:55 INFO - PROCESS | 4743 | Cycle 1(1): loaded http://localhost:44167/tests/dromaeo/cssquery-ext.html (next: http://localhost:44167/tests/dromaeo/cssquery-jquery.html) 20:10:56 INFO - PROCESS | 4743 | RSS: Main: 228331520 20:10:56 INFO - PROCESS | 4743 | 20:13:57 INFO - PROCESS | 4743 | Cycle 1(1): loaded http://localhost:44167/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44167/tests/dromaeo/cssquery-mootools.html) 20:13:58 INFO - PROCESS | 4743 | RSS: Main: 235323392 20:13:58 INFO - PROCESS | 4743 | 20:17:00 INFO - PROCESS | 4743 | Cycle 1(1): loaded http://localhost:44167/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44167/tests/dromaeo/cssquery-prototype.html) 20:17:00 INFO - PROCESS | 4743 | RSS: Main: 215449600 20:17:00 INFO - PROCESS | 4743 | 20:20:03 INFO - PROCESS | 4743 | Cycle 1(1): loaded http://localhost:44167/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44167/tests/dromaeo/cssquery-yui.html) 20:20:04 INFO - PROCESS | 4743 | RSS: Main: 219242496 20:20:04 INFO - PROCESS | 4743 | 20:23:06 INFO - PROCESS | 4743 | Cycle 1(1): loaded http://localhost:44167/tests/dromaeo/cssquery-yui.html (next: http://localhost:44167/tests/dromaeo/cssquery-dojo.html) 20:23:07 INFO - PROCESS | 4743 | RSS: Main: 261009408 20:23:07 INFO - PROCESS | 4743 | 20:23:07 INFO - PROCESS | 4743 | __start_tp_report 20:23:07 INFO - PROCESS | 4743 | _x_x_mozilla_page_load 20:23:07 INFO - PROCESS | 4743 | _x_x_mozilla_page_load_details 20:23:07 INFO - PROCESS | 4743 | |i|pagename|runs| 20:23:07 INFO - PROCESS | 4743 | |0;dojo.html;3076.5846610707554;3138.529220616909;3159.4155081309973;3182.8408579571014;3213.3412650406667;5114.130597798383;5213.635045546814;5288.89422211556;5300.628955973083;5324.600654950885;5201;5252.763625636846;5267.762950667219;5268;5342.679439233639;4716.4340279166545;4735.3370528125915;4753.619710423175;4802.5197480252045;4881.780319885614;4875.756212189394;4938.012397520492;4938.876528086808;4964.950350496503;5005;4716.551927566876;4719.834805781798;4822.156122678517;4822.324874517571;4849.806007759686;4765.21373973294;4766;4780.091782561302;4813.109574728686;4834.903301933941;4743.596794272491;4746.833860814855;4755.476897541268;4761.214399624093;4761.333413322138;4950.504949505057;5013.949860501385;5038.748062596892;5130.230465430215;5178.17149256121;5633.464820842013;5645.15322701594;5657.405972372924;5666.036773748473;5673.574481913873;5677.233573467612;5684.886302273972;5708.4291570843;5709.229254050733;5716.171155182476;5187.948120518822;5209.739513024371;5303.6552624079695;5305.549028332558;5310.309659744247;5740.225069615549;5782.797602083907;5790.7973220937065;5793.870195311873;5806.796762113306;5501.807436739695;5508.173773933861;5513.255710479114;5515.420880807537;5523.033469142884;5468.863278418072;5597.468240517144;5599.608027438122;5618.410066942912;5627.8593035174445;5436.160549405588;5561.5272701820795;5566.805161819317;5572.972135139298;5607.271054762937;5579.581531385081;5588.21764952907;5588.469095435927;5588.748506317225;5604.299462567179;4288.635465985364;4383.07955329378;4391.84628538006;4401.295792673157;4427.557244275611;3843.3466310727244;3863.30460517104;3872.341701910682;3903.0047337928645;3908.120672848643;5183.870403239949;5194.636375453682;5281.735913204325;5292.788288468495;5334.11987022137;5583.776648933997;5590.049691552445;5626.324841019104;5634.7182640867795;5647.011772939719;5106;5216.243644671501;5278.868028299246;5305.495977882095;5356.169793681907;4742.407199100113;4869.610431165498;4946.8763280918265;4993.1262029144755;5004.749762511859;5784.1034639630925;5798.9130163047585;5801.970990145022;5803.82588522345;5819.952408566499;5461.453854614507;5591.133374326986;5597.916031259453;5608.85977850557;5615.466530679742;5718.79984200551;5735.799247026334;5788.363280039276;5843.795467158629;5887.0580707086665;5505.311836020497;5546.473085057075;5547.2511210986;5573.7770489179975;5606.131049687305;5622.803201887914;5624.915626265692;5631.943680563142;5639.041362968387;5646.632968857011;5245.396779370269;5413.485718856702;5497.47773961473;5527.640703354269;5531.308586426697;5511.972440137773;5513.558915286848;5531.944680553143;5535.474129957647;5554.944450555605;5409.810656626999;5412.810551630674;5420.810271640474;5424.5660347172925;5457.072297709319;5327;5444.128939369682;5464;5496.6701997880255;5500.339959204921;5466.480684334982;5466.480684334982;5484.451554844483;5490.6431081979545;5504.064309067388 20:23:07 INFO - PROCESS | 4743 | |1;ext.html;545.5035917315241;545.6344249352934;553.7286729502545;565.8557067947672;578.7829563913532;28085.297867553294;28800.279993000186;35715.46426803597;35865.641343586554;36013;39099.21801563967;39527.40708889369;39540.20919581607;39643.60356396435;39659.80170099153;7316.378107860838;8396.370272229577;8662.090480499552;8676.913230867705;8678.696245631405;7387.963060184691;7506.324430801227;10150.28947973642;10287.177025837915;10345.948270258637;9938.503074846265;10003.099721025106;10040.497975101252;10043.799124017552;10051.849222261635;7521.736739214156;7679.961600192019;9979.850302245472;10105.39367637944;10110.241731870103;10131.290809643328;10350.275480716353;10364.067233948905;10366.429846358447;10369.170466362673;35602.28795424077;36022;36065.45901811475;36082.819585902165;36122.45816312757;3375.848086836074;3386.8324272465643;3433.5879694436576;3592.7305452091196;3918.4318273850417;29689;29733.10800675983;30168.849155754302;30595.541066884016;30647.594122406685;3829.1958688675413;3873.98063009686;3875.748076375027;3921.8823435296986;3927.9410808837893;274443;275800;276121;276752;276869;51247.48752512502;51721.224181637306;58795.41204587985;58817;59031.40968590345;53258.46741532535;53375.466245337826;53515.464845351045;53655.19517207167;53667;15196.468123615621;15369.615759606098;15380.92309538445;15391.615209619626;15397.230138493254;11380.601678941362;11387.544498220144;11397;11409.42952852354;11595.942020289845;19509;19529.511762206057;19905.502362441053;19912.402627921187;19986.60026799456;7466.962665186639;7473.9267099430945;7629.160792312841;7633.885491717629;7738.342240909586;898.4125717932443;905.7599736069947;926.8331700293877;983.4197823284154;1023.5138309303021;24028.27915162548;24452.388690282885;24454.266372008868;24513.142040028513;24566.140185093434;1005.4620777883797;1032.4270030133348;1038.7039693687263;1044.6291566493937;1102.9944850275697;13210.207387556777;13289.671032896633;13476.460941562227;13681.938448684075;13893.513727019708;314883;318478;318643;318681;320075;51438;51622.74188629108;51696.48303516992;51727.74136129295;51789.48210517922;1315.2568798628745;1333.4199623163954;1344.522694443478;1353.6548180213983;1357.0365040821127;25126.12058577941;25360.873195634642;25658.230253092435;25815.055868851683;25914.740852591232;43257.13485730205;43768;43785.56214437942;43805.56194438142;43876.341854872844;298201;299794;300378;301287;304256;27879.860600697677;28332.291692707848;30647.54028689527;31346.216344590655;31812.84093579517;36762.448563272104;36879.44680829843;37315;37469.81265093657;37982.81008594939;30930.69069309278;31408.84295578599;31730.682693172774;31737.841310793297;32218.35563288768;27716.722832772222;32771.50842737409;33576.49635255522;33617.49573756347;34295.31409371749;25238.816489960078;25773.3556661085;25813.3546661335;27133.457330853667;27498.587521186797;29878.551821722256;29974;30898.845505772326;31165.220869478446;31315.217119572193;23385.532289354458;23436.17973370924;23627.527449450572;23664.88167559151;23677.526449471257 20:23:07 INFO - PROCESS | 4743 | |2;jquery.html;366.7414472796678;367.0859559696357;368.6037509677097;370.4850258141183;371.50404210379145;14120.717585648306;14275.143491390523;16211.594710132253;16640.251188696508;17356.392526261585;11041.779164416706;11294;16078.919605401987;16543;16547.66904661906;4879.878003049926;5008.373953255843;5010;5011.298418221452;5015.523525265094;3841.5966323536045;3934.3114954882926;4984.626153038518;5008.949910500903;5412.675239485624;5474.09677403228;5487.094629386166;5498.45015498451;5511.3937466878615;5516.365617953947;5363.839084827461;5467.6719396836315;5806.825795226129;5834.4165583441745;5839.124131380285;5194.63637545372;5203.531682148625;5211.452797456288;5213.2701421800975;5213.4004589472315;13469.326533673375;13483.393247303895;13489.055766096377;14085.577432677037;16220.675586488322;1910.722945172956;1970.3252235599768;2061.989690051555;2151.236311109549;2191.583599116179;9787.314887957846;9885.357451765683;9929.75175620608;12660.11379203456;12712.872871271355;1805.1515787579947;1856.3781133320354;1859.4514618187668;1872.8220819022172;1874.5875907300372;54323.72838135823;54413;55020.174697379975;56767.43232567663;59500.70249648724;9550.331476796697;9826.557804898797;9905.950470247602;9906.504674766233;9975.201983841276;13327.267000315076;13357.33213339329;13364.465421383231;13369.66575835612;13375.933120334335;7668.693252269958;7711.807204819812;7714.691412343555;7731.188225236382;7877.212278772077;7517.924820751832;7546.886796698054;7616.124145723202;7734.651940662684;7745.922540774633;4401;4463.888402789957;4478.440194975628;4501;4502.054568540578;1585.904845709238;1674.7320428731346;1723.147042214087;1768.2043080613776;1829.9451016469527;863.4242507423851;914.6295750221171;939.5208443693765;1015.603914473356;1023.488255872064;15486.922565387325;16800.15999200035;17706.114694265492;17825.821741782675;18079.638407232043;875.9474431534128;894.4901406198404;919.0992827029548;937.634322614181;963.6001059560344;8604.913950860411;8846.557672116369;8891.288696904232;9001.144891235323;9220;527201;527967;538367;540756;543465;77909.22090779133;80708;80845.59577202077;80857;81884;1059.777446736194;1100.2463312630873;1103.2828661370174;1120.6974116988367;1124.9493772780245;14613.269336533343;14830.184339861411;14981;15039.323230454436;15231.314590843216;35425.645743542234;35522;35579.28841423209;35716.107097322776;35830.46254306135;45225;47556;48552.02895942132;49459;51873.48126518838;9090.272778177598;9221.585028673591;9299.163075323253;9377.624895004123;9471;16848;17231.138443078045;17373.47879563615;17452.563685907953;17583.120843958008;11177;12359;13665.658358541115;13695.109817861807;14516.709665806413;11770.588029419272;13695.931520342334;14114.435422582981;14322.641933951734;14363.353649086026;13904.37430315618;14220.146791192561;14226.288685565472;14423;14431.061980971203;9318.114779095975;9423.905760942303;9486.810263794547;9541.618335266512;9569.425834449956;10518.399729071656;13245.470181192644;13526.84963902791;13532.93233533826;13669.589912302647 20:23:07 INFO - PROCESS | 4743 | |3;mootools.html;1312;1434.390384086763;1434.756091464451;1586.833382494838;1761.1722490429493;6420;6957;7060.399866011382;7070.363667269945;7074.717011319541;6879.1057162568795;7032.578045317285;7036.401905837997;7045.8590828183405;7051.048108505363;1957.9118939647751;1990.6118306930155;2146;2168.1002384010617;2182.1162429216115;2192.6272533669235;2199.076387917071;2199.7800219977953;2200.0759680933966;2201.2405720026563;2100.2544096845554;2182.945426364338;2201.2955854126685;2202.1191523390694;2211.1045026764186;2148.924787632441;2168.826493880486;2186.835987300943;2190.047329411695;2205.614017546931;2156.8813715245656;2181.7818218178213;2190.0692205812466;2190.769969153232;2193.6599827026835;7146.178189508221;7211.206767255598;7224.783256502314;7227.277272272783;7260.382867456273;4389.582989615981;4463.24124898768;4466.1067786442845;4470.664700147502;4470.977645111753;2984.7761417893744;2985.149232468758;3023.1232942446886;3036.75705943524;3097.0399176255432;1022.6267412394496;1040.953157107932;1043.1654676258963;1043.9739006524899;1092.83607458881;10081.546330415149;10123.34198277117;10176.236782241362;10198.490075496196;10232.38605683654;4063.674906007512;4072.429859819628;4151.232022075926;4171.874843754692;4192.748435093904;8825.38222324444;8841.16008979146;8846.46921184731;8859;8875.511846848485;4482.372467854503;4502.594766470967;4520.276755719069;4529.773511324421;4537.319402089713;4133.441985332001;4138.903190654479;4140.896477588024;4143.91712165755;4145.191687620885;3252.447083995726;3297.274599588087;3455.4989526519016;3507.7544571879725;3529.3823580873245;1114.7714718482691;1117.536222467683;1120.7839494148939;1136.193302755053;1150.3558007515817;1102.3165637304921;1277.1953669188351;1302.1470936536584;1324.7814110671825;1324.8608896065775;6572.572782769104;6646.86706265872;6647.4349680276755;6652.600843949379;6664.166979127609;1159.681087700889;1175.788358095551;1197.9041676665845;1204.2894692131683;1222.2910711787142;5465.6447330923365;5519.558435325164;5544.86137846549;5546.195801608744;5553.416891226444;8208.343332533503;8282.503049816909;8305.95847020761;8383.874241886255;8415.368847336475;8236.258736713724;8240.793980150544;8245.83508329842;8338.166183381612;8340.416170868102;6640.734370625218;6700.83247918806;6745.662716864137;6793.286704895915;6851.520393572402;6667.299933507106;6719.26088130315;6766.18805743314;6774.424173945073;6893.93106068953;7692.92307076922;7785.961070194613;7895.644695988809;7908.130105688255;7937.40469464804;7877.645505952131;7967.083785364757;7988.84022319562;8111.107778144517;8123.268905798506;6645.1361323027695;6660.6336651484635;6665.300143484864;6704.530682852153;6819.352161544645;6494.350564943468;6626.701798419179;6688.899666505104;6836.248012718696;6846.691898864663;6601.240857301472;6625.337466253529;6721.966390168018;6816.454683625398;6834;6555.967220163869;6559.048937904073;6631.568948018364;6706.362895524917;6715.3620406061345;6628.53600247978;6652.567583107082;6653.900191497229;6674.132362792806;6674.566153200027;5850.853728656818;5864.32560255559;5876.706164691663;5895.174675545512;5896.469317761422;6152.384761523812;6196.938030619636;6204.441600255998;6273.874522509615;6287.748490060347 20:23:07 INFO - PROCESS | 4743 | |4;prototype.html;343.3836263906289;343.5019222127915;351.24482362919736;351.4605081200358;354.62232722150924;5830.737616807243;5944.256967879015;5949.970250148754;5966.164736936827;5974.402559744029;5581.553475721943;5747.879163563107;5814.215080964069;5814.563907706918;5905.114232865072;4572.15415148197;4576.931346029813;4579.679422440422;4580.541945805426;4589.885252868671;4359.2153412385915;4580.725156490605;4588.380568623244;4592.517785632511;4600.35595016698;4401.889952751175;4430.3133014382665;4497.235469970096;4501.234790085677;4521.457425108975;4463.620592249663;4489.506154323039;4525.208088584517;4538.1377538267625;4542.500324964251;4039.0306326481727;4039.7374170678813;4041.5352234493116;4045.6358927696356;4052.2705912935658;5424.538914192299;5499.780008799643;5500.257465242181;5571.749271282762;5574;5260.710660913648;5261.15821468567;5262.473752624707;5269.394019687747;5271.920921186185;6132.877342453171;6177.3822617738315;6178.598391104564;6178.9691051544905;6180.567360284782;4412.161689279027;4413.9117217655785;4414.84548040817;4414.845480408202;4419.845305414327;6236.095766113934;6443.710033048524;6464.547481676284;6465.64438955862;6488.188976377953;4518.43519560055;4549.249373853343;4551.340055691906;4556.6126879215635;4562.68061235717;4614.123316569841;4616.422947131608;4618.030213655103;4623.56076172763;4623.815047398067;5251.081060814342;5253.080710875582;5253.579713622901;5259.263703081571;5263.447338029452;6078.878422431527;6232.906506402408;6251.468625166821;6283.277423096311;6303.2751233607805;1614.104172184449;1632.4286499725001;1632.6000129967997;1632.8122265939332;1633.6895989761906;1065.1532032034552;1111.827666711661;1120.7478317378525;1120.8486854274568;1134.3194083549804;5971.940280597139;5982;5982.700864956735;5983.880322393527;5989.371116032754;6403.167588213502;6404.743810247538;6406.967965160145;6409.070684750685;6418.19772528434;5842.386549412336;5874.295084589791;5976.342602313742;6034.668093254825;6038.426349496791;3436.0722604896537;3446.172918499542;3464;3472.965270347315;3473.9652603474146;6757.695903684346;6759.797206083826;6761.053452516651;6762.053312536249;6766.28953959837;6431.74273029083;6532.608043517404;6554.442872355903;6612.570182938093;6655.567388119756;6781.25406205317;6798.898016529756;6800.489963252677;6807.217170025411;6807.421369183576;6473.417392434703;6474.093626892333;6475.384838440529;6475.740970361321;6477.093206950936;6296.181496405438;6388.425041746265;6411.422971932362;6414.03789431589;6416.133821934166;6766.594004359754;6787.932120678927;6792.72829086831;6798.694058767268;6802.795916122524;4466.285394336891;4480.708753930984;4517.119161763425;4518.254488009442;4522.977385113053;6292.056191571301;6478.578892371981;6486.481081513562;6506.739730410731;6532.183477065367;6274.529410294155;6275.686215689106;6337.207849018872;6354.17395738551;6354.872902542016;6330.873382532415;6338.809835704937;6344.397282258178;6364.968175159094;6432.292447830641;6104.816855494342;6194.039923811816;6209.968950155401;6210.192674952227;6246.46905013079;6337.841553961188;6346.111544383698;6347.333529979285;6352.396522330371;6362.522810789302;6209.410106039919;6213.471854892385;6215.254169499689;6222.471089957405;6228.906566401598 20:23:07 INFO - PROCESS | 4743 | |5;yui.html;810.995945020275;819.9631016604252;821.8972628421449;826.6114925984785;828.1304630138353;13150;13271.469141234338;13403.865961340383;13411.32943352832;13414.128081674684;12653.240805551673;13491.325433728323;13509.594712158627;13537.187768733882;13539.661508462294;679.7349033876792;686.9107016087902;820.9835803283946;838.1911455445494;838.5178522349643;826.6693322670919;833.0669649992018;844.1895780051158;844.9197326253995;847.0470720439506;857.7941294089436;889.7820034091657;889.8309321228945;890.0254221627308;890.0298674444854;701.8210356359122;710.5878590417572;853.317346123099;868.9869651955225;871.5685735560907;638.8243233110885;640.8237734622969;644.5778015399874;644.9258335291407;645.1194120026178;13470.393832277474;13558.796618050737;13593.728125437436;13599.04806663534;13625.863741362558;12124.818127728091;12462.563810266687;12577.308248046354;12586.559470418582;12650.430730617145;10565.471726413649;10641;10674;10687.091597214168;10839;3633.400488919325;3708.962910370889;3725.6274372562525;3797.5063241778666;3798.1454172811173;48295;48893.266601001014;49023;49045.26432103521;49332.26001609979;9828.459434731158;10164.695059148238;10272.897271027194;10285.691429257135;10589.15286777056;17671.29314827418;17690.5577360567;17698.40714335716;17716.822831771777;17732.645347093243;6860.622665753432;7091.716331346688;7145.035420218308;7223.494355395072;7240.96379518099;4462.209086085248;4525.728456292633;4552.544745525421;4569.588737013684;4580.129775342674;3058.892938747133;3077.5075987841838;3078.2150551609197;3082.352705931735;3086.583311252997;545.7025920873134;546.8304825504107;550.7246376811594;555.1672491263105;570.7060863655221;587.632729544035;633.996830015847;664.6610228783355;675.3449154320301;688.7141836138047;8505.362097842686;8542.914570854213;8605.612747426381;8626.18051285127;8652.928210485314;571.0834111251464;634.7619642634012;645.6394466800293;651.1535004494139;662.6918482905472;3778.6221377862544;3895.6493915547735;3907.5701672815967;4052.858149964737;4102.671786257092;61209.69395152996;61854.690726546076;62024.37975620276;62123.6893815528;62143;47424.5257547427;49357.50642493601;49701;50385.74807125941;50481.24278135831;44632;44953.32570011518;45233;45448.54551454443;46343.76828115838;8503.404761666872;8548.187922147386;8588.785280368042;8635.740927772176;8767.342449316455;35037;35068.298634027684;35793.105172369855;35930.46104308385;36798.26403471862;44713;44993.55006449894;45092;45121.54878451173;45148.548514514434;10994.34033957965;10995;11093.833592496281;11496.367699776592;11668.649940501798;11918.225315354473;12265.69335766613;12370.81443778362;12395.132340736061;12395.62813115608;10513;10634.361938283728;10652.8934710655;11059.447027648746;11260.605878794202;10642.829288778383;10973.451327433757;11120.165987551129;11301.943490282496;11424.485898134437;10579.4710264488;10648.201384896009;10777.191710621579;10898.455077246264;11003.724906877393;9161.409889842938;9231.76920576991;9530.666426675032;9534.332596718163;9927.156191723785;8469.74590762278;8500.36247281444;8532.786680333042;8673.95663021706;9577.23382129442 20:23:07 INFO - PROCESS | 4743 | __end_tp_report 20:23:07 INFO - PROCESS | 4743 | __start_cc_report 20:23:07 INFO - PROCESS | 4743 | _x_x_mozilla_cycle_collect,1060 20:23:07 INFO - PROCESS | 4743 | __end_cc_report 20:23:07 INFO - PROCESS | 4743 | __startTimestamp1451708587010__endTimestamp 20:23:07 INFO - PROCESS | 4743 | 20:23:07 INFO - PROCESS | 4743 | ------- Summary: start ------- 20:23:07 INFO - PROCESS | 4743 | Number of tests: 6 20:23:07 INFO - PROCESS | 4743 | 20:23:07 INFO - PROCESS | 4743 | [#0] dojo.html Cycles:165 Average:5224.26 Median:5436.16 stddev:568.21 (10.5%) stddev-sans-first:544.40 20:23:07 INFO - PROCESS | 4743 | Values: 3076.6 3138.5 3159.4 3182.8 3213.3 5114.1 5213.6 5288.9 5300.6 5324.6 5201.0 5252.8 5267.8 5268.0 5342.7 4716.4 4735.3 4753.6 4802.5 4881.8 4875.8 4938.0 4938.9 4965.0 5005.0 4716.6 4719.8 4822.2 4822.3 4849.8 4765.2 4766.0 4780.1 4813.1 4834.9 4743.6 4746.8 4755.5 4761.2 4761.3 4950.5 5013.9 5038.7 5130.2 5178.2 5633.5 5645.2 5657.4 5666.0 5673.6 5677.2 5684.9 5708.4 5709.2 5716.2 5187.9 5209.7 5303.7 5305.5 5310.3 5740.2 5782.8 5790.8 5793.9 5806.8 5501.8 5508.2 5513.3 5515.4 5523.0 5468.9 5597.5 5599.6 5618.4 5627.9 5436.2 5561.5 5566.8 5573.0 5607.3 5579.6 5588.2 5588.5 5588.7 5604.3 4288.6 4383.1 4391.8 4401.3 4427.6 3843.3 3863.3 3872.3 3903.0 3908.1 5183.9 5194.6 5281.7 5292.8 5334.1 5583.8 5590.0 5626.3 5634.7 5647.0 5106.0 5216.2 5278.9 5305.5 5356.2 4742.4 4869.6 4946.9 4993.1 5004.7 5784.1 5798.9 5802.0 5803.8 5820.0 5461.5 5591.1 5597.9 5608.9 5615.5 5718.8 5735.8 5788.4 5843.8 5887.1 5505.3 5546.5 5547.3 5573.8 5606.1 5622.8 5624.9 5631.9 5639.0 5646.6 5245.4 5413.5 5497.5 5527.6 5531.3 5512.0 5513.6 5531.9 5535.5 5554.9 5409.8 5412.8 5420.8 5424.6 5457.1 5327.0 5444.1 5464.0 5496.7 5500.3 5466.5 5466.5 5484.5 5490.6 5504.1 20:23:07 INFO - PROCESS | 4743 | 20:23:07 INFO - PROCESS | 4743 | [#1] ext.html Cycles:180 Average:45162.74 Median:31240.22 stddev:78238.93 (250.4%) stddev-sans-first:78386.69 20:23:07 INFO - PROCESS | 4743 | Values: 545.5 545.6 553.7 565.9 578.8 28085.3 28800.3 35715.5 35865.6 36013.0 39099.2 39527.4 39540.2 39643.6 39659.8 7316.4 8396.4 8662.1 8676.9 8678.7 7388.0 7506.3 10150.3 10287.2 10345.9 9938.5 10003.1 10040.5 10043.8 10051.8 7521.7 7680.0 9979.9 10105.4 10110.2 10131.3 10350.3 10364.1 10366.4 10369.2 35602.3 36022.0 36065.5 36082.8 36122.5 3375.8 3386.8 3433.6 3592.7 3918.4 29689.0 29733.1 30168.8 30595.5 30647.6 3829.2 3874.0 3875.7 3921.9 3927.9 274443.0 275800.0 276121.0 276752.0 276869.0 51247.5 51721.2 58795.4 58817.0 59031.4 53258.5 53375.5 53515.5 53655.2 53667.0 15196.5 15369.6 15380.9 15391.6 15397.2 11380.6 11387.5 11397.0 11409.4 11595.9 19509.0 19529.5 19905.5 19912.4 19986.6 7467.0 7473.9 7629.2 7633.9 7738.3 898.4 905.8 926.8 983.4 1023.5 24028.3 24452.4 24454.3 24513.1 24566.1 1005.5 1032.4 1038.7 1044.6 1103.0 13210.2 13289.7 13476.5 13681.9 13893.5 314883.0 318478.0 318643.0 318681.0 320075.0 51438.0 51622.7 51696.5 51727.7 51789.5 1315.3 1333.4 1344.5 1353.7 1357.0 25126.1 25360.9 25658.2 25815.1 25914.7 43257.1 43768.0 43785.6 43805.6 43876.3 298201.0 299794.0 300378.0 301287.0 304256.0 27879.9 28332.3 30647.5 31346.2 31812.8 36762.4 36879.4 37315.0 37469.8 37982.8 30930.7 31408.8 31730.7 31737.8 32218.4 27716.7 32771.5 33576.5 33617.5 34295.3 25238.8 25773.4 25813.4 27133.5 27498.6 29878.6 29974.0 30898.8 31165.2 31315.2 23385.5 23436.2 23627.5 23664.9 23677.5 20:23:07 INFO - PROCESS | 4743 | 20:23:07 INFO - PROCESS | 4743 | [#2] jquery.html Cycles:180 Average:28340.73 Median:4167.66 stddev:87539.05 (2100.4%) stddev-sans-first:87759.41 20:23:07 INFO - PROCESS | 4743 | Values: 366.7 367.1 368.6 370.5 371.5 14120.7 14275.1 16211.6 16640.3 17356.4 11041.8 11294.0 16078.9 16543.0 16547.7 4879.9 5008.4 5010.0 5011.3 5015.5 3841.6 3934.3 4984.6 5008.9 5412.7 5474.1 5487.1 5498.5 5511.4 5516.4 5363.8 5467.7 5806.8 5834.4 5839.1 5194.6 5203.5 5211.5 5213.3 5213.4 13469.3 13483.4 13489.1 14085.6 16220.7 1910.7 1970.3 2062.0 2151.2 2191.6 9787.3 9885.4 9929.8 12660.1 12712.9 1805.2 1856.4 1859.5 1872.8 1874.6 54323.7 54413.0 55020.2 56767.4 59500.7 9550.3 9826.6 9906.0 9906.5 9975.2 13327.3 13357.3 13364.5 13369.7 13375.9 7668.7 7711.8 7714.7 7731.2 7877.2 7517.9 7546.9 7616.1 7734.7 7745.9 4401.0 4463.9 4478.4 4501.0 4502.1 1585.9 1674.7 1723.1 1768.2 1829.9 863.4 914.6 939.5 1015.6 1023.5 15486.9 16800.2 17706.1 17825.8 18079.6 875.9 894.5 919.1 937.6 963.6 8604.9 8846.6 8891.3 9001.1 9220.0 527201.0 527967.0 538367.0 540756.0 543465.0 77909.2 80708.0 80845.6 80857.0 81884.0 1059.8 1100.2 1103.3 1120.7 1124.9 14613.3 14830.2 14981.0 15039.3 15231.3 35425.6 35522.0 35579.3 35716.1 35830.5 45225.0 47556.0 48552.0 49459.0 51873.5 9090.3 9221.6 9299.2 9377.6 9471.0 16848.0 17231.1 17373.5 17452.6 17583.1 11177.0 12359.0 13665.7 13695.1 14516.7 11770.6 13695.9 14114.4 14322.6 14363.4 13904.4 14220.1 14226.3 14423.0 14431.1 9318.1 9423.9 9486.8 9541.6 9569.4 10518.4 13245.5 13526.8 13532.9 13669.6 20:23:07 INFO - PROCESS | 4743 | 20:23:07 INFO - PROCESS | 4743 | [#3] mootools.html Cycles:180 Average:5123.08 Median:5857.59 stddev:2578.95 (44.0%) stddev-sans-first:2570.27 20:23:07 INFO - PROCESS | 4743 | Values: 1312.0 1434.4 1434.8 1586.8 1761.2 6420.0 6957.0 7060.4 7070.4 7074.7 6879.1 7032.6 7036.4 7045.9 7051.0 1957.9 1990.6 2146.0 2168.1 2182.1 2192.6 2199.1 2199.8 2200.1 2201.2 2100.3 2182.9 2201.3 2202.1 2211.1 2148.9 2168.8 2186.8 2190.0 2205.6 2156.9 2181.8 2190.1 2190.8 2193.7 7146.2 7211.2 7224.8 7227.3 7260.4 4389.6 4463.2 4466.1 4470.7 4471.0 2984.8 2985.1 3023.1 3036.8 3097.0 1022.6 1041.0 1043.2 1044.0 1092.8 10081.5 10123.3 10176.2 10198.5 10232.4 4063.7 4072.4 4151.2 4171.9 4192.7 8825.4 8841.2 8846.5 8859.0 8875.5 4482.4 4502.6 4520.3 4529.8 4537.3 4133.4 4138.9 4140.9 4143.9 4145.2 3252.4 3297.3 3455.5 3507.8 3529.4 1114.8 1117.5 1120.8 1136.2 1150.4 1102.3 1277.2 1302.1 1324.8 1324.9 6572.6 6646.9 6647.4 6652.6 6664.2 1159.7 1175.8 1197.9 1204.3 1222.3 5465.6 5519.6 5544.9 5546.2 5553.4 8208.3 8282.5 8306.0 8383.9 8415.4 8236.3 8240.8 8245.8 8338.2 8340.4 6640.7 6700.8 6745.7 6793.3 6851.5 6667.3 6719.3 6766.2 6774.4 6893.9 7692.9 7786.0 7895.6 7908.1 7937.4 7877.6 7967.1 7988.8 8111.1 8123.3 6645.1 6660.6 6665.3 6704.5 6819.4 6494.4 6626.7 6688.9 6836.2 6846.7 6601.2 6625.3 6722.0 6816.5 6834.0 6556.0 6559.0 6631.6 6706.4 6715.4 6628.5 6652.6 6653.9 6674.1 6674.6 5850.9 5864.3 5876.7 5895.2 5896.5 6152.4 6196.9 6204.4 6273.9 6287.7 20:23:07 INFO - PROCESS | 4743 | 20:23:07 INFO - PROCESS | 4743 | [#4] prototype.html Cycles:180 Average:5259.81 Median:5969.05 stddev:1568.16 (26.3%) stddev-sans-first:1528.53 20:23:07 INFO - PROCESS | 4743 | Values: 343.4 343.5 351.2 351.5 354.6 5830.7 5944.3 5950.0 5966.2 5974.4 5581.6 5747.9 5814.2 5814.6 5905.1 4572.2 4576.9 4579.7 4580.5 4589.9 4359.2 4580.7 4588.4 4592.5 4600.4 4401.9 4430.3 4497.2 4501.2 4521.5 4463.6 4489.5 4525.2 4538.1 4542.5 4039.0 4039.7 4041.5 4045.6 4052.3 5424.5 5499.8 5500.3 5571.7 5574.0 5260.7 5261.2 5262.5 5269.4 5271.9 6132.9 6177.4 6178.6 6179.0 6180.6 4412.2 4413.9 4414.8 4414.8 4419.8 6236.1 6443.7 6464.5 6465.6 6488.2 4518.4 4549.2 4551.3 4556.6 4562.7 4614.1 4616.4 4618.0 4623.6 4623.8 5251.1 5253.1 5253.6 5259.3 5263.4 6078.9 6232.9 6251.5 6283.3 6303.3 1614.1 1632.4 1632.6 1632.8 1633.7 1065.2 1111.8 1120.7 1120.8 1134.3 5971.9 5982.0 5982.7 5983.9 5989.4 6403.2 6404.7 6407.0 6409.1 6418.2 5842.4 5874.3 5976.3 6034.7 6038.4 3436.1 3446.2 3464.0 3473.0 3474.0 6757.7 6759.8 6761.1 6762.1 6766.3 6431.7 6532.6 6554.4 6612.6 6655.6 6781.3 6798.9 6800.5 6807.2 6807.4 6473.4 6474.1 6475.4 6475.7 6477.1 6296.2 6388.4 6411.4 6414.0 6416.1 6766.6 6787.9 6792.7 6798.7 6802.8 4466.3 4480.7 4517.1 4518.3 4523.0 6292.1 6478.6 6486.5 6506.7 6532.2 6274.5 6275.7 6337.2 6354.2 6354.9 6330.9 6338.8 6344.4 6365.0 6432.3 6104.8 6194.0 6210.0 6210.2 6246.5 6337.8 6346.1 6347.3 6352.4 6362.5 6209.4 6213.5 6215.3 6222.5 6228.9 20:23:07 INFO - PROCESS | 4743 | 20:23:07 INFO - PROCESS | 4743 | [#5] yui.html Cycles:180 Average:13841.76 Median:4561.07 stddev:16222.29 (355.7%) stddev-sans-first:16238.28 20:23:07 INFO - PROCESS | 4743 | Values: 811.0 820.0 821.9 826.6 828.1 13150.0 13271.5 13403.9 13411.3 13414.1 12653.2 13491.3 13509.6 13537.2 13539.7 679.7 686.9 821.0 838.2 838.5 826.7 833.1 844.2 844.9 847.0 857.8 889.8 889.8 890.0 890.0 701.8 710.6 853.3 869.0 871.6 638.8 640.8 644.6 644.9 645.1 13470.4 13558.8 13593.7 13599.0 13625.9 12124.8 12462.6 12577.3 12586.6 12650.4 10565.5 10641.0 10674.0 10687.1 10839.0 3633.4 3709.0 3725.6 3797.5 3798.1 48295.0 48893.3 49023.0 49045.3 49332.3 9828.5 10164.7 10272.9 10285.7 10589.2 17671.3 17690.6 17698.4 17716.8 17732.6 6860.6 7091.7 7145.0 7223.5 7241.0 4462.2 4525.7 4552.5 4569.6 4580.1 3058.9 3077.5 3078.2 3082.4 3086.6 545.7 546.8 550.7 555.2 570.7 587.6 634.0 664.7 675.3 688.7 8505.4 8542.9 8605.6 8626.2 8652.9 571.1 634.8 645.6 651.2 662.7 3778.6 3895.6 3907.6 4052.9 4102.7 61209.7 61854.7 62024.4 62123.7 62143.0 47424.5 49357.5 49701.0 50385.7 50481.2 44632.0 44953.3 45233.0 45448.5 46343.8 8503.4 8548.2 8588.8 8635.7 8767.3 35037.0 35068.3 35793.1 35930.5 36798.3 44713.0 44993.6 45092.0 45121.5 45148.5 10994.3 10995.0 11093.8 11496.4 11668.6 11918.2 12265.7 12370.8 12395.1 12395.6 10513.0 10634.4 10652.9 11059.4 11260.6 10642.8 10973.5 11120.2 11301.9 11424.5 10579.5 10648.2 10777.2 10898.5 11003.7 9161.4 9231.8 9530.7 9534.3 9927.2 8469.7 8500.4 8532.8 8674.0 9577.2 20:23:07 INFO - PROCESS | 4743 | -------- Summary: end -------- 20:23:07 INFO - PROCESS | 4743 | 20:23:07 INFO - TEST-INFO | 4743: exit 0 20:23:07 INFO - TEST-OK | dromaeo_css | took 1113028ms 20:23:07 INFO - TEST-START | kraken 20:23:07 INFO - operating with platform_type : linux_ 20:23:07 INFO - Initialising browser for kraken test... 20:23:07 INFO - TEST-INFO | started process 4943 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuBbE9h/profile http://localhost:44167/getInfo.html) 20:23:11 INFO - PROCESS | 4943 | __metrics Screen width/height:1600/1200 20:23:11 INFO - PROCESS | 4943 | colorDepth:24 20:23:11 INFO - PROCESS | 4943 | Browser inner width/height: 1024/697 20:23:11 INFO - PROCESS | 4943 | __metrics 20:23:12 INFO - PROCESS | 4943 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:23:12 INFO - PROCESS | 4943 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:23:12 INFO - TEST-INFO | 4943: exit 0 20:23:12 INFO - Browser initialized. 20:23:12 INFO - Running cycle 1/1 for kraken test... 20:23:12 INFO - TEST-INFO | started process 5029 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuBbE9h/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:24 INFO - PROCESS | 5029 | RSS: Main: 150085632 20:23:24 INFO - PROCESS | 5029 | 20:23:27 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44167/tests/kraken/driver.html?testName=audio-beat-detection) 20:23:27 INFO - PROCESS | 5029 | RSS: Main: 184872960 20:23:27 INFO - PROCESS | 5029 | 20:23:30 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44167/tests/kraken/driver.html?testName=audio-dft) 20:23:31 INFO - PROCESS | 5029 | RSS: Main: 174993408 20:23:31 INFO - PROCESS | 5029 | 20:23:33 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44167/tests/kraken/driver.html?testName=audio-fft) 20:23:34 INFO - PROCESS | 5029 | RSS: Main: 161501184 20:23:34 INFO - PROCESS | 5029 | 20:23:36 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44167/tests/kraken/driver.html?testName=audio-oscillator) 20:23:37 INFO - PROCESS | 5029 | RSS: Main: 161222656 20:23:37 INFO - PROCESS | 5029 | 20:23:39 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44167/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:23:39 INFO - PROCESS | 5029 | RSS: Main: 165068800 20:23:39 INFO - PROCESS | 5029 | 20:23:42 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44167/tests/kraken/driver.html?testName=imaging-darkroom) 20:23:43 INFO - PROCESS | 5029 | RSS: Main: 165302272 20:23:43 INFO - PROCESS | 5029 | 20:23:46 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44167/tests/kraken/driver.html?testName=imaging-desaturate) 20:23:47 INFO - PROCESS | 5029 | RSS: Main: 164507648 20:23:47 INFO - PROCESS | 5029 | 20:23:50 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44167/tests/kraken/driver.html?testName=json-parse-financial) 20:23:50 INFO - PROCESS | 5029 | RSS: Main: 165863424 20:23:50 INFO - PROCESS | 5029 | 20:23:52 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44167/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:23:52 INFO - PROCESS | 5029 | RSS: Main: 174804992 20:23:52 INFO - PROCESS | 5029 | 20:23:54 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44167/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:23:55 INFO - PROCESS | 5029 | RSS: Main: 173809664 20:23:55 INFO - PROCESS | 5029 | 20:23:57 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44167/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:23:57 INFO - PROCESS | 5029 | RSS: Main: 184999936 20:23:57 INFO - PROCESS | 5029 | 20:24:00 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44167/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:24:00 INFO - PROCESS | 5029 | RSS: Main: 191893504 20:24:00 INFO - PROCESS | 5029 | 20:24:03 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44167/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:24:03 INFO - PROCESS | 5029 | RSS: Main: 189911040 20:24:03 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | Cycle 1(1): loaded http://localhost:44167/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44167/tests/kraken/driver.html?testName=ai-astar) 20:24:05 INFO - PROCESS | 5029 | RSS: Main: 247328768 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | __start_tp_report 20:24:05 INFO - PROCESS | 5029 | _x_x_mozilla_page_load 20:24:05 INFO - PROCESS | 5029 | _x_x_mozilla_page_load_details 20:24:05 INFO - PROCESS | 5029 | |i|pagename|runs| 20:24:05 INFO - PROCESS | 5029 | |0;ai-astar;110;112;107;110;111;113;101;112;111;110 20:24:05 INFO - PROCESS | 5029 | |1;audio-beat-detection;151;124;154;169;132;153;152;130;177;127 20:24:05 INFO - PROCESS | 5029 | |2;audio-dft;160;160;162;160;162;162;159;162;161;160 20:24:05 INFO - PROCESS | 5029 | |3;audio-fft;72;71;86;95;76;73;73;114;88;72 20:24:05 INFO - PROCESS | 5029 | |4;audio-oscillator;96;95;139;95;98;96;140;95;96;142 20:24:05 INFO - PROCESS | 5029 | |5;imaging-gaussian-blur;109;110;109;109;110;110;109;110;110;109 20:24:05 INFO - PROCESS | 5029 | |6;imaging-darkroom;147;146;146;145;145;146;147;146;147;145 20:24:05 INFO - PROCESS | 5029 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;95 20:24:05 INFO - PROCESS | 5029 | |8;json-parse-financial;59;59;57;57;57;60;61;66;57;55 20:24:05 INFO - PROCESS | 5029 | |9;json-stringify-tinderbox;66;67;66;67;67;67;68;67;67;68 20:24:05 INFO - PROCESS | 5029 | |10;stanford-crypto-aes;84;85;86;85;84;84;84;84;84;85 20:24:05 INFO - PROCESS | 5029 | |11;stanford-crypto-ccm;119;115;125;115;120;117;121;122;125;116 20:24:05 INFO - PROCESS | 5029 | |12;stanford-crypto-pbkdf2;147;155;150;150;150;140;162;151;151;143 20:24:05 INFO - PROCESS | 5029 | |13;stanford-crypto-sha256-iterative;68;67;69;70;68;66;69;67;69;69 20:24:05 INFO - PROCESS | 5029 | __end_tp_report 20:24:05 INFO - PROCESS | 5029 | __start_cc_report 20:24:05 INFO - PROCESS | 5029 | _x_x_mozilla_cycle_collect,945 20:24:05 INFO - PROCESS | 5029 | __end_cc_report 20:24:05 INFO - PROCESS | 5029 | __startTimestamp1451708645786__endTimestamp 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | ------- Summary: start ------- 20:24:05 INFO - PROCESS | 5029 | Number of tests: 14 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.47 (3.1%) stddev-sans-first:3.67 20:24:05 INFO - PROCESS | 5029 | Values: 110.0 112.0 107.0 110.0 111.0 113.0 101.0 112.0 111.0 110.0 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:152.50 stddev:18.11 (11.9%) stddev-sans-first:19.15 20:24:05 INFO - PROCESS | 5029 | Values: 151.0 124.0 154.0 169.0 132.0 153.0 152.0 130.0 177.0 127.0 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 20:24:05 INFO - PROCESS | 5029 | Values: 160.0 160.0 162.0 160.0 162.0 162.0 159.0 162.0 161.0 160.0 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#3] audio-fft Cycles:10 Average:82.00 Median:74.50 stddev:14.00 (18.8%) stddev-sans-first:14.37 20:24:05 INFO - PROCESS | 5029 | Values: 72.0 71.0 86.0 95.0 76.0 73.0 73.0 114.0 88.0 72.0 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:95.50 stddev:21.51 (22.5%) stddev-sans-first:22.28 20:24:05 INFO - PROCESS | 5029 | Values: 96.0 95.0 139.0 95.0 98.0 96.0 140.0 95.0 96.0 142.0 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:24:05 INFO - PROCESS | 5029 | Values: 109.0 110.0 109.0 109.0 110.0 110.0 109.0 110.0 110.0 109.0 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 20:24:05 INFO - PROCESS | 5029 | Values: 147.0 146.0 146.0 145.0 145.0 146.0 147.0 146.0 147.0 145.0 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:24:05 INFO - PROCESS | 5029 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:59.00 stddev:3.08 (5.2%) stddev-sans-first:3.27 20:24:05 INFO - PROCESS | 5029 | Values: 59.0 59.0 57.0 57.0 57.0 60.0 61.0 66.0 57.0 55.0 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 20:24:05 INFO - PROCESS | 5029 | Values: 66.0 67.0 66.0 67.0 67.0 67.0 68.0 67.0 67.0 68.0 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 20:24:05 INFO - PROCESS | 5029 | Values: 84.0 85.0 86.0 85.0 84.0 84.0 84.0 84.0 84.0 85.0 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:120.50 stddev:3.78 (3.1%) stddev-sans-first:4.00 20:24:05 INFO - PROCESS | 5029 | Values: 119.0 115.0 125.0 115.0 120.0 117.0 121.0 122.0 125.0 116.0 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.90 Median:150.50 stddev:6.05 (4.0%) stddev-sans-first:6.32 20:24:05 INFO - PROCESS | 5029 | Values: 147.0 155.0 150.0 150.0 150.0 140.0 162.0 151.0 151.0 143.0 20:24:05 INFO - PROCESS | 5029 | 20:24:05 INFO - PROCESS | 5029 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 20:24:05 INFO - PROCESS | 5029 | Values: 68.0 67.0 69.0 70.0 68.0 66.0 69.0 67.0 69.0 69.0 20:24:05 INFO - PROCESS | 5029 | -------- Summary: end -------- 20:24:05 INFO - PROCESS | 5029 | 20:24:06 INFO - TEST-INFO | 5029: exit 0 20:24:06 INFO - TEST-OK | kraken | took 58870ms 20:24:06 INFO - TEST-START | v8_7 20:24:06 INFO - operating with platform_type : linux_ 20:24:06 INFO - Initialising browser for v8_7 test... 20:24:06 INFO - TEST-INFO | started process 5281 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3MxXSk/profile http://localhost:44167/getInfo.html) 20:24:10 INFO - PROCESS | 5281 | __metrics Screen width/height:1600/1200 20:24:10 INFO - PROCESS | 5281 | colorDepth:24 20:24:10 INFO - PROCESS | 5281 | Browser inner width/height: 1024/697 20:24:10 INFO - PROCESS | 5281 | __metrics 20:24:10 INFO - PROCESS | 5281 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:24:10 INFO - PROCESS | 5281 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:24:11 INFO - TEST-INFO | 5281: exit 0 20:24:11 INFO - Browser initialized. 20:24:11 INFO - Running cycle 1/1 for v8_7 test... 20:24:11 INFO - TEST-INFO | started process 5361 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3MxXSk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:24:23 INFO - PROCESS | 5361 | RSS: Main: 150151168 20:24:23 INFO - PROCESS | 5361 | 20:24:44 INFO - PROCESS | 5361 | Cycle 1(1): loaded http://localhost:44167/tests/v8_7/run.html (next: http://localhost:44167/tests/v8_7/run.html) 20:24:45 INFO - PROCESS | 5361 | RSS: Main: 616095744 20:24:45 INFO - PROCESS | 5361 | 20:24:45 INFO - PROCESS | 5361 | __start_tp_report 20:24:45 INFO - PROCESS | 5361 | _x_x_mozilla_page_load 20:24:45 INFO - PROCESS | 5361 | _x_x_mozilla_page_load_details 20:24:45 INFO - PROCESS | 5361 | |i|pagename|runs| 20:24:45 INFO - PROCESS | 5361 | |0;Richards;166.72224074691565 20:24:45 INFO - PROCESS | 5361 | |1;DeltaBlue;190.22256039566292 20:24:45 INFO - PROCESS | 5361 | |2;Encrypt;280.42624789680315 20:24:45 INFO - PROCESS | 5361 | |3;Decrypt;5208.333333333333 20:24:45 INFO - PROCESS | 5361 | |4;RayTrace;1119.8208286674133 20:24:45 INFO - PROCESS | 5361 | |5;Earley;787.4015748031496 20:24:45 INFO - PROCESS | 5361 | |6;Boyer;12219.512195121952 20:24:45 INFO - PROCESS | 5361 | |7;RegExp;25717.94871794872 20:24:45 INFO - PROCESS | 5361 | |8;Splay;660.1307189542483 20:24:45 INFO - PROCESS | 5361 | |9;NavierStokes;4840.579710144928 20:24:45 INFO - PROCESS | 5361 | __end_tp_report 20:24:45 INFO - PROCESS | 5361 | __startTimestamp1451708685080__endTimestamp 20:24:45 INFO - PROCESS | 5361 | 20:24:45 INFO - PROCESS | 5361 | ------- Summary: start ------- 20:24:45 INFO - PROCESS | 5361 | Number of tests: 10 20:24:45 INFO - PROCESS | 5361 | 20:24:45 INFO - PROCESS | 5361 | [#0] Richards Cycles:1 Average:166.72 Median:166.72 stddev:0.00 (0.0%) 20:24:45 INFO - PROCESS | 5361 | Values: 166.7 20:24:45 INFO - PROCESS | 5361 | 20:24:45 INFO - PROCESS | 5361 | [#1] DeltaBlue Cycles:1 Average:190.22 Median:190.22 stddev:0.00 (0.0%) 20:24:45 INFO - PROCESS | 5361 | Values: 190.2 20:24:45 INFO - PROCESS | 5361 | 20:24:45 INFO - PROCESS | 5361 | [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 20:24:45 INFO - PROCESS | 5361 | Values: 280.4 20:24:45 INFO - PROCESS | 5361 | 20:24:45 INFO - PROCESS | 5361 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 20:24:45 INFO - PROCESS | 5361 | Values: 5208.3 20:24:45 INFO - PROCESS | 5361 | 20:24:45 INFO - PROCESS | 5361 | [#4] RayTrace Cycles:1 Average:1119.82 Median:1119.82 stddev:0.00 (0.0%) 20:24:45 INFO - PROCESS | 5361 | Values: 1119.8 20:24:45 INFO - PROCESS | 5361 | 20:24:45 INFO - PROCESS | 5361 | [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 20:24:45 INFO - PROCESS | 5361 | Values: 787.4 20:24:45 INFO - PROCESS | 5361 | 20:24:45 INFO - PROCESS | 5361 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 20:24:45 INFO - PROCESS | 5361 | Values: 12219.5 20:24:45 INFO - PROCESS | 5361 | 20:24:45 INFO - PROCESS | 5361 | [#7] RegExp Cycles:1 Average:25717.95 Median:25717.95 stddev:0.00 (0.0%) 20:24:45 INFO - PROCESS | 5361 | Values: 25717.9 20:24:45 INFO - PROCESS | 5361 | 20:24:45 INFO - PROCESS | 5361 | [#8] Splay Cycles:1 Average:660.13 Median:660.13 stddev:0.00 (0.0%) 20:24:45 INFO - PROCESS | 5361 | Values: 660.1 20:24:45 INFO - PROCESS | 5361 | 20:24:45 INFO - PROCESS | 5361 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:24:45 INFO - PROCESS | 5361 | Values: 4840.6 20:24:45 INFO - PROCESS | 5361 | -------- Summary: end -------- 20:24:45 INFO - PROCESS | 5361 | 20:24:45 INFO - TEST-INFO | 5361: exit 0 20:24:45 INFO - TEST-OK | v8_7 | took 39324ms 20:24:45 INFO - SUITE-END | took 1211s 20:24:46 INFO - Completed test suite (00:20:11) 20:24:46 INFO - Working with test: dromaeo_css 20:24:46 INFO - Generating results file: dromaeo_css 20:24:46 INFO - Working with test: kraken 20:24:46 INFO - Generating results file: kraken 20:24:46 INFO - javascript benchmark 20:24:46 INFO - Working with test: v8_7 20:24:46 INFO - Generating results file: v8_7 20:24:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:24:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 20:24:46 INFO - process_Request line: dromaeo_css 6830.55 graph.html#tests=[[72,201,35]] 20:24:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:24:46 INFO - process_Request line: kraken 1507.90 graph.html#tests=[[232,201,35]] 20:24:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:24:46 INFO - process_Request line: v8_7 20805.50 graph.html#tests=[[230,201,35]] 20:24:46 INFO - RETURN: dromaeo_css: 6830.55 20:24:46 INFO - RETURN: kraken: 1507.90 20:24:46 INFO - RETURN: v8_7: 20805.50 20:24:46 INFO - javascript benchmark 20:24:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3076.5846610707554, 3138.529220616909, 3159.4155081309973, 3182.8408579571014, 3213.3412650406667, 5114.130597798383, 5213.635045546814, 5288.89422211556, 5300.628955973083, 5324.600654950885, 5201.0, 5252.763625636846, 5267.762950667219, 5268.0, 5342.679439233639, 4716.4340279166545, 4735.3370528125915, 4753.619710423175, 4802.5197480252045, 4881.780319885614, 4875.756212189394, 4938.012397520492, 4938.876528086808, 4964.950350496503, 5005.0, 4716.551927566876, 4719.834805781798, 4822.156122678517, 4822.324874517571, 4849.806007759686, 4765.21373973294, 4766.0, 4780.091782561302, 4813.109574728686, 4834.903301933941, 4743.596794272491, 4746.833860814855, 4755.476897541268, 4761.214399624093, 4761.333413322138, 4950.504949505057, 5013.949860501385, 5038.748062596892, 5130.230465430215, 5178.17149256121, 5633.464820842013, 5645.15322701594, 5657.405972372924, 5666.036773748473, 5673.574481913873, 5677.233573467612, 5684.886302273972, 5708.4291570843, 5709.229254050733, 5716.171155182476, 5187.948120518822, 5209.739513024371, 5303.6552624079695, 5305.549028332558, 5310.309659744247, 5740.225069615549, 5782.797602083907, 5790.7973220937065, 5793.870195311873, 5806.796762113306, 5501.807436739695, 5508.173773933861, 5513.255710479114, 5515.420880807537, 5523.033469142884, 5468.863278418072, 5597.468240517144, 5599.608027438122, 5618.410066942912, 5627.8593035174445, 5436.160549405588, 5561.5272701820795, 5566.805161819317, 5572.972135139298, 5607.271054762937, 5579.581531385081, 5588.21764952907, 5588.469095435927, 5588.748506317225, 5604.299462567179, 4288.635465985364, 4383.07955329378, 4391.84628538006, 4401.295792673157, 4427.557244275611, 3843.3466310727244, 3863.30460517104, 3872.341701910682, 3903.0047337928645, 3908.120672848643, 5183.870403239949, 5194.636375453682, 5281.735913204325, 5292.788288468495, 5334.11987022137, 5583.776648933997, 5590.049691552445, 5626.324841019104, 5634.7182640867795, 5647.011772939719, 5106.0, 5216.243644671501, 5278.868028299246, 5305.495977882095, 5356.169793681907, 4742.407199100113, 4869.610431165498, 4946.8763280918265, 4993.1262029144755, 5004.749762511859, 5784.1034639630925, 5798.9130163047585, 5801.970990145022, 5803.82588522345, 5819.952408566499, 5461.453854614507, 5591.133374326986, 5597.916031259453, 5608.85977850557, 5615.466530679742, 5718.79984200551, 5735.799247026334, 5788.363280039276, 5843.795467158629, 5887.0580707086665, 5505.311836020497, 5546.473085057075, 5547.2511210986, 5573.7770489179975, 5606.131049687305, 5622.803201887914, 5624.915626265692, 5631.943680563142, 5639.041362968387, 5646.632968857011, 5245.396779370269, 5413.485718856702, 5497.47773961473, 5527.640703354269, 5531.308586426697, 5511.972440137773, 5513.558915286848, 5531.944680553143, 5535.474129957647, 5554.944450555605, 5409.810656626999, 5412.810551630674, 5420.810271640474, 5424.5660347172925, 5457.072297709319, 5327.0, 5444.128939369682, 5464.0, 5496.6701997880255, 5500.339959204921, 5466.480684334982, 5466.480684334982, 5484.451554844483, 5490.6431081979545, 5504.064309067388], "unit": "score", "name": "dojo.html", "value": 5188.075768173563}, {"lowerIsBetter": false, "replicates": [545.5035917315241, 545.6344249352934, 553.7286729502545, 565.8557067947672, 578.7829563913532, 28085.297867553294, 28800.279993000186, 35715.46426803597, 35865.641343586554, 36013.0, 39099.21801563967, 39527.40708889369, 39540.20919581607, 39643.60356396435, 39659.80170099153, 7316.378107860838, 8396.370272229577, 8662.090480499552, 8676.913230867705, 8678.696245631405, 7387.963060184691, 7506.324430801227, 10150.28947973642, 10287.177025837915, 10345.948270258637, 9938.503074846265, 10003.099721025106, 10040.497975101252, 10043.799124017552, 10051.849222261635, 7521.736739214156, 7679.961600192019, 9979.850302245472, 10105.39367637944, 10110.241731870103, 10131.290809643328, 10350.275480716353, 10364.067233948905, 10366.429846358447, 10369.170466362673, 35602.28795424077, 36022.0, 36065.45901811475, 36082.819585902165, 36122.45816312757, 3375.848086836074, 3386.8324272465643, 3433.5879694436576, 3592.7305452091196, 3918.4318273850417, 29689.0, 29733.10800675983, 30168.849155754302, 30595.541066884016, 30647.594122406685, 3829.1958688675413, 3873.98063009686, 3875.748076375027, 3921.8823435296986, 3927.9410808837893, 274443.0, 275800.0, 276121.0, 276752.0, 276869.0, 51247.48752512502, 51721.224181637306, 58795.41204587985, 58817.0, 59031.40968590345, 53258.46741532535, 53375.466245337826, 53515.464845351045, 53655.19517207167, 53667.0, 15196.468123615621, 15369.615759606098, 15380.92309538445, 15391.615209619626, 15397.230138493254, 11380.601678941362, 11387.544498220144, 11397.0, 11409.42952852354, 11595.942020289845, 19509.0, 19529.511762206057, 19905.502362441053, 19912.402627921187, 19986.60026799456, 7466.962665186639, 7473.9267099430945, 7629.160792312841, 7633.885491717629, 7738.342240909586, 898.4125717932443, 905.7599736069947, 926.8331700293877, 983.4197823284154, 1023.5138309303021, 24028.27915162548, 24452.388690282885, 24454.266372008868, 24513.142040028513, 24566.140185093434, 1005.4620777883797, 1032.4270030133348, 1038.7039693687263, 1044.6291566493937, 1102.9944850275697, 13210.207387556777, 13289.671032896633, 13476.460941562227, 13681.938448684075, 13893.513727019708, 314883.0, 318478.0, 318643.0, 318681.0, 320075.0, 51438.0, 51622.74188629108, 51696.48303516992, 51727.74136129295, 51789.48210517922, 1315.2568798628745, 1333.4199623163954, 1344.522694443478, 1353.6548180213983, 1357.0365040821127, 25126.12058577941, 25360.873195634642, 25658.230253092435, 25815.055868851683, 25914.740852591232, 43257.13485730205, 43768.0, 43785.56214437942, 43805.56194438142, 43876.341854872844, 298201.0, 299794.0, 300378.0, 301287.0, 304256.0, 27879.860600697677, 28332.291692707848, 30647.54028689527, 31346.216344590655, 31812.84093579517, 36762.448563272104, 36879.44680829843, 37315.0, 37469.81265093657, 37982.81008594939, 30930.69069309278, 31408.84295578599, 31730.682693172774, 31737.841310793297, 32218.35563288768, 27716.722832772222, 32771.50842737409, 33576.49635255522, 33617.49573756347, 34295.31409371749, 25238.816489960078, 25773.3556661085, 25813.3546661335, 27133.457330853667, 27498.587521186797, 29878.551821722256, 29974.0, 30898.845505772326, 31165.220869478446, 31315.217119572193, 23385.532289354458, 23436.17973370924, 23627.527449450572, 23664.88167559151, 23677.526449471257], "unit": "score", "name": "ext.html", "value": 17724.586223623744}, {"lowerIsBetter": false, "replicates": [366.7414472796678, 367.0859559696357, 368.6037509677097, 370.4850258141183, 371.50404210379145, 14120.717585648306, 14275.143491390523, 16211.594710132253, 16640.251188696508, 17356.392526261585, 11041.779164416706, 11294.0, 16078.919605401987, 16543.0, 16547.66904661906, 4879.878003049926, 5008.373953255843, 5010.0, 5011.298418221452, 5015.523525265094, 3841.5966323536045, 3934.3114954882926, 4984.626153038518, 5008.949910500903, 5412.675239485624, 5474.09677403228, 5487.094629386166, 5498.45015498451, 5511.3937466878615, 5516.365617953947, 5363.839084827461, 5467.6719396836315, 5806.825795226129, 5834.4165583441745, 5839.124131380285, 5194.63637545372, 5203.531682148625, 5211.452797456288, 5213.2701421800975, 5213.4004589472315, 13469.326533673375, 13483.393247303895, 13489.055766096377, 14085.577432677037, 16220.675586488322, 1910.722945172956, 1970.3252235599768, 2061.989690051555, 2151.236311109549, 2191.583599116179, 9787.314887957846, 9885.357451765683, 9929.75175620608, 12660.11379203456, 12712.872871271355, 1805.1515787579947, 1856.3781133320354, 1859.4514618187668, 1872.8220819022172, 1874.5875907300372, 54323.72838135823, 54413.0, 55020.174697379975, 56767.43232567663, 59500.70249648724, 9550.331476796697, 9826.557804898797, 9905.950470247602, 9906.504674766233, 9975.201983841276, 13327.267000315076, 13357.33213339329, 13364.465421383231, 13369.66575835612, 13375.933120334335, 7668.693252269958, 7711.807204819812, 7714.691412343555, 7731.188225236382, 7877.212278772077, 7517.924820751832, 7546.886796698054, 7616.124145723202, 7734.651940662684, 7745.922540774633, 4401.0, 4463.888402789957, 4478.440194975628, 4501.0, 4502.054568540578, 1585.904845709238, 1674.7320428731346, 1723.147042214087, 1768.2043080613776, 1829.9451016469527, 863.4242507423851, 914.6295750221171, 939.5208443693765, 1015.603914473356, 1023.488255872064, 15486.922565387325, 16800.15999200035, 17706.114694265492, 17825.821741782675, 18079.638407232043, 875.9474431534128, 894.4901406198404, 919.0992827029548, 937.634322614181, 963.6001059560344, 8604.913950860411, 8846.557672116369, 8891.288696904232, 9001.144891235323, 9220.0, 527201.0, 527967.0, 538367.0, 540756.0, 543465.0, 77909.22090779133, 80708.0, 80845.59577202077, 80857.0, 81884.0, 1059.777446736194, 1100.2463312630873, 1103.2828661370174, 1120.6974116988367, 1124.9493772780245, 14613.269336533343, 14830.184339861411, 14981.0, 15039.323230454436, 15231.314590843216, 35425.645743542234, 35522.0, 35579.28841423209, 35716.107097322776, 35830.46254306135, 45225.0, 47556.0, 48552.02895942132, 49459.0, 51873.48126518838, 9090.272778177598, 9221.585028673591, 9299.163075323253, 9377.624895004123, 9471.0, 16848.0, 17231.138443078045, 17373.47879563615, 17452.563685907953, 17583.120843958008, 11177.0, 12359.0, 13665.658358541115, 13695.109817861807, 14516.709665806413, 11770.588029419272, 13695.931520342334, 14114.435422582981, 14322.641933951734, 14363.353649086026, 13904.37430315618, 14220.146791192561, 14226.288685565472, 14423.0, 14431.061980971203, 9318.114779095975, 9423.905760942303, 9486.810263794547, 9541.618335266512, 9569.425834449956, 10518.399729071656, 13245.470181192644, 13526.84963902791, 13532.93233533826, 13669.589912302647], "unit": "score", "name": "jquery.html", "value": 8634.309999452827}, {"lowerIsBetter": false, "replicates": [1312.0, 1434.390384086763, 1434.756091464451, 1586.833382494838, 1761.1722490429493, 6420.0, 6957.0, 7060.399866011382, 7070.363667269945, 7074.717011319541, 6879.1057162568795, 7032.578045317285, 7036.401905837997, 7045.8590828183405, 7051.048108505363, 1957.9118939647751, 1990.6118306930155, 2146.0, 2168.1002384010617, 2182.1162429216115, 2192.6272533669235, 2199.076387917071, 2199.7800219977953, 2200.0759680933966, 2201.2405720026563, 2100.2544096845554, 2182.945426364338, 2201.2955854126685, 2202.1191523390694, 2211.1045026764186, 2148.924787632441, 2168.826493880486, 2186.835987300943, 2190.047329411695, 2205.614017546931, 2156.8813715245656, 2181.7818218178213, 2190.0692205812466, 2190.769969153232, 2193.6599827026835, 7146.178189508221, 7211.206767255598, 7224.783256502314, 7227.277272272783, 7260.382867456273, 4389.582989615981, 4463.24124898768, 4466.1067786442845, 4470.664700147502, 4470.977645111753, 2984.7761417893744, 2985.149232468758, 3023.1232942446886, 3036.75705943524, 3097.0399176255432, 1022.6267412394496, 1040.953157107932, 1043.1654676258963, 1043.9739006524899, 1092.83607458881, 10081.546330415149, 10123.34198277117, 10176.236782241362, 10198.490075496196, 10232.38605683654, 4063.674906007512, 4072.429859819628, 4151.232022075926, 4171.874843754692, 4192.748435093904, 8825.38222324444, 8841.16008979146, 8846.46921184731, 8859.0, 8875.511846848485, 4482.372467854503, 4502.594766470967, 4520.276755719069, 4529.773511324421, 4537.319402089713, 4133.441985332001, 4138.903190654479, 4140.896477588024, 4143.91712165755, 4145.191687620885, 3252.447083995726, 3297.274599588087, 3455.4989526519016, 3507.7544571879725, 3529.3823580873245, 1114.7714718482691, 1117.536222467683, 1120.7839494148939, 1136.193302755053, 1150.3558007515817, 1102.3165637304921, 1277.1953669188351, 1302.1470936536584, 1324.7814110671825, 1324.8608896065775, 6572.572782769104, 6646.86706265872, 6647.4349680276755, 6652.600843949379, 6664.166979127609, 1159.681087700889, 1175.788358095551, 1197.9041676665845, 1204.2894692131683, 1222.2910711787142, 5465.6447330923365, 5519.558435325164, 5544.86137846549, 5546.195801608744, 5553.416891226444, 8208.343332533503, 8282.503049816909, 8305.95847020761, 8383.874241886255, 8415.368847336475, 8236.258736713724, 8240.793980150544, 8245.83508329842, 8338.166183381612, 8340.416170868102, 6640.734370625218, 6700.83247918806, 6745.662716864137, 6793.286704895915, 6851.520393572402, 6667.299933507106, 6719.26088130315, 6766.18805743314, 6774.424173945073, 6893.93106068953, 7692.92307076922, 7785.961070194613, 7895.644695988809, 7908.130105688255, 7937.40469464804, 7877.645505952131, 7967.083785364757, 7988.84022319562, 8111.107778144517, 8123.268905798506, 6645.1361323027695, 6660.6336651484635, 6665.300143484864, 6704.530682852153, 6819.352161544645, 6494.350564943468, 6626.701798419179, 6688.899666505104, 6836.248012718696, 6846.691898864663, 6601.240857301472, 6625.337466253529, 6721.966390168018, 6816.454683625398, 6834.0, 6555.967220163869, 6559.048937904073, 6631.568948018364, 6706.362895524917, 6715.3620406061345, 6628.53600247978, 6652.567583107082, 6653.900191497229, 6674.132362792806, 6674.566153200027, 5850.853728656818, 5864.32560255559, 5876.706164691663, 5895.174675545512, 5896.469317761422, 6152.384761523812, 6196.938030619636, 6204.441600255998, 6273.874522509615, 6287.748490060347], "unit": "score", "name": "mootools.html", "value": 4272.146619546513}, {"lowerIsBetter": false, "replicates": [343.3836263906289, 343.5019222127915, 351.24482362919736, 351.4605081200358, 354.62232722150924, 5830.737616807243, 5944.256967879015, 5949.970250148754, 5966.164736936827, 5974.402559744029, 5581.553475721943, 5747.879163563107, 5814.215080964069, 5814.563907706918, 5905.114232865072, 4572.15415148197, 4576.931346029813, 4579.679422440422, 4580.541945805426, 4589.885252868671, 4359.2153412385915, 4580.725156490605, 4588.380568623244, 4592.517785632511, 4600.35595016698, 4401.889952751175, 4430.3133014382665, 4497.235469970096, 4501.234790085677, 4521.457425108975, 4463.620592249663, 4489.506154323039, 4525.208088584517, 4538.1377538267625, 4542.500324964251, 4039.0306326481727, 4039.7374170678813, 4041.5352234493116, 4045.6358927696356, 4052.2705912935658, 5424.538914192299, 5499.780008799643, 5500.257465242181, 5571.749271282762, 5574.0, 5260.710660913648, 5261.15821468567, 5262.473752624707, 5269.394019687747, 5271.920921186185, 6132.877342453171, 6177.3822617738315, 6178.598391104564, 6178.9691051544905, 6180.567360284782, 4412.161689279027, 4413.9117217655785, 4414.84548040817, 4414.845480408202, 4419.845305414327, 6236.095766113934, 6443.710033048524, 6464.547481676284, 6465.64438955862, 6488.188976377953, 4518.43519560055, 4549.249373853343, 4551.340055691906, 4556.6126879215635, 4562.68061235717, 4614.123316569841, 4616.422947131608, 4618.030213655103, 4623.56076172763, 4623.815047398067, 5251.081060814342, 5253.080710875582, 5253.579713622901, 5259.263703081571, 5263.447338029452, 6078.878422431527, 6232.906506402408, 6251.468625166821, 6283.277423096311, 6303.2751233607805, 1614.104172184449, 1632.4286499725001, 1632.6000129967997, 1632.8122265939332, 1633.6895989761906, 1065.1532032034552, 1111.827666711661, 1120.7478317378525, 1120.8486854274568, 1134.3194083549804, 5971.940280597139, 5982.0, 5982.700864956735, 5983.880322393527, 5989.371116032754, 6403.167588213502, 6404.743810247538, 6406.967965160145, 6409.070684750685, 6418.19772528434, 5842.386549412336, 5874.295084589791, 5976.342602313742, 6034.668093254825, 6038.426349496791, 3436.0722604896537, 3446.172918499542, 3464.0, 3472.965270347315, 3473.9652603474146, 6757.695903684346, 6759.797206083826, 6761.053452516651, 6762.053312536249, 6766.28953959837, 6431.74273029083, 6532.608043517404, 6554.442872355903, 6612.570182938093, 6655.567388119756, 6781.25406205317, 6798.898016529756, 6800.489963252677, 6807.217170025411, 6807.421369183576, 6473.417392434703, 6474.093626892333, 6475.384838440529, 6475.740970361321, 6477.093206950936, 6296.181496405438, 6388.425041746265, 6411.422971932362, 6414.03789431589, 6416.133821934166, 6766.594004359754, 6787.932120678927, 6792.72829086831, 6798.694058767268, 6802.795916122524, 4466.285394336891, 4480.708753930984, 4517.119161763425, 4518.254488009442, 4522.977385113053, 6292.056191571301, 6478.578892371981, 6486.481081513562, 6506.739730410731, 6532.183477065367, 6274.529410294155, 6275.686215689106, 6337.207849018872, 6354.17395738551, 6354.872902542016, 6330.873382532415, 6338.809835704937, 6344.397282258178, 6364.968175159094, 6432.292447830641, 6104.816855494342, 6194.039923811816, 6209.968950155401, 6210.192674952227, 6246.46905013079, 6337.841553961188, 6346.111544383698, 6347.333529979285, 6352.396522330371, 6362.522810789302, 6209.410106039919, 6213.471854892385, 6215.254169499689, 6222.471089957405, 6228.906566401598], "unit": "score", "name": "prototype.html", "value": 4758.738876053107}, {"lowerIsBetter": false, "replicates": [810.995945020275, 819.9631016604252, 821.8972628421449, 826.6114925984785, 828.1304630138353, 13150.0, 13271.469141234338, 13403.865961340383, 13411.32943352832, 13414.128081674684, 12653.240805551673, 13491.325433728323, 13509.594712158627, 13537.187768733882, 13539.661508462294, 679.7349033876792, 686.9107016087902, 820.9835803283946, 838.1911455445494, 838.5178522349643, 826.6693322670919, 833.0669649992018, 844.1895780051158, 844.9197326253995, 847.0470720439506, 857.7941294089436, 889.7820034091657, 889.8309321228945, 890.0254221627308, 890.0298674444854, 701.8210356359122, 710.5878590417572, 853.317346123099, 868.9869651955225, 871.5685735560907, 638.8243233110885, 640.8237734622969, 644.5778015399874, 644.9258335291407, 645.1194120026178, 13470.393832277474, 13558.796618050737, 13593.728125437436, 13599.04806663534, 13625.863741362558, 12124.818127728091, 12462.563810266687, 12577.308248046354, 12586.559470418582, 12650.430730617145, 10565.471726413649, 10641.0, 10674.0, 10687.091597214168, 10839.0, 3633.400488919325, 3708.962910370889, 3725.6274372562525, 3797.5063241778666, 3798.1454172811173, 48295.0, 48893.266601001014, 49023.0, 49045.26432103521, 49332.26001609979, 9828.459434731158, 10164.695059148238, 10272.897271027194, 10285.691429257135, 10589.15286777056, 17671.29314827418, 17690.5577360567, 17698.40714335716, 17716.822831771777, 17732.645347093243, 6860.622665753432, 7091.716331346688, 7145.035420218308, 7223.494355395072, 7240.96379518099, 4462.209086085248, 4525.728456292633, 4552.544745525421, 4569.588737013684, 4580.129775342674, 3058.892938747133, 3077.5075987841838, 3078.2150551609197, 3082.352705931735, 3086.583311252997, 545.7025920873134, 546.8304825504107, 550.7246376811594, 555.1672491263105, 570.7060863655221, 587.632729544035, 633.996830015847, 664.6610228783355, 675.3449154320301, 688.7141836138047, 8505.362097842686, 8542.914570854213, 8605.612747426381, 8626.18051285127, 8652.928210485314, 571.0834111251464, 634.7619642634012, 645.6394466800293, 651.1535004494139, 662.6918482905472, 3778.6221377862544, 3895.6493915547735, 3907.5701672815967, 4052.858149964737, 4102.671786257092, 61209.69395152996, 61854.690726546076, 62024.37975620276, 62123.6893815528, 62143.0, 47424.5257547427, 49357.50642493601, 49701.0, 50385.74807125941, 50481.24278135831, 44632.0, 44953.32570011518, 45233.0, 45448.54551454443, 46343.76828115838, 8503.404761666872, 8548.187922147386, 8588.785280368042, 8635.740927772176, 8767.342449316455, 35037.0, 35068.298634027684, 35793.105172369855, 35930.46104308385, 36798.26403471862, 44713.0, 44993.55006449894, 45092.0, 45121.54878451173, 45148.548514514434, 10994.34033957965, 10995.0, 11093.833592496281, 11496.367699776592, 11668.649940501798, 11918.225315354473, 12265.69335766613, 12370.81443778362, 12395.132340736061, 12395.62813115608, 10513.0, 10634.361938283728, 10652.8934710655, 11059.447027648746, 11260.605878794202, 10642.829288778383, 10973.451327433757, 11120.165987551129, 11301.943490282496, 11424.485898134437, 10579.4710264488, 10648.201384896009, 10777.191710621579, 10898.455077246264, 11003.724906877393, 9161.409889842938, 9231.76920576991, 9530.666426675032, 9534.332596718163, 9927.156191723785, 8469.74590762278, 8500.36247281444, 8532.786680333042, 8673.95663021706, 9577.23382129442], "unit": "score", "name": "yui.html", "value": 6291.3694354424915}], "name": "dromaeo_css", "value": 6830.545227029938}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 107.0, 110.0, 111.0, 113.0, 101.0, 112.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 154.0, 169.0, 132.0, 153.0, 152.0, 130.0, 177.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 160.0, 162.0, 162.0, 159.0, 162.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 86.0, 95.0, 76.0, 73.0, 73.0, 114.0, 88.0, 72.0], "unit": "score", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 139.0, 95.0, 98.0, 96.0, 140.0, 95.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 145.0, 145.0, 146.0, 147.0, 146.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 57.0, 57.0, 57.0, 60.0, 61.0, 66.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.8}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 125.0, 115.0, 120.0, 117.0, 121.0, 122.0, 125.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.5}, {"lowerIsBetter": true, "replicates": [147.0, 155.0, 150.0, 150.0, 150.0, 140.0, 162.0, 151.0, 151.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.9}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 69.0, 70.0, 68.0, 66.0, 69.0, 67.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1507.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.72224074691565], "unit": "score", "name": "Richards", "value": 211.74139599999998}, {"lowerIsBetter": false, "replicates": [190.22256039566292], "unit": "score", "name": "DeltaBlue", "value": 347.58232600000014}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1119.8208286674133], "unit": "score", "name": "RayTrace", "value": 660.8101769999998}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [25717.94871794872], "unit": "score", "name": "RegExp", "value": 35.42214855433696}, {"lowerIsBetter": false, "replicates": [660.1307189542483], "unit": "score", "name": "Splay", "value": 123.44676237623759}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20805.501193288903}]} 20:24:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20805.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1507.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6830.55"}}} 20:24:46 INFO - Return code: 0 20:24:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:24:46 INFO - # TBPL SUCCESS # 20:24:46 INFO - Running post-action listener: _resource_record_post_action 20:24:46 INFO - Running post-run listener: _resource_record_post_run 20:24:47 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552550400; Read time: 12; Write time: 596172 20:24:47 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 243982336; Read time: 0; Write time: 329832 20:24:47 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 307503104; Read time: 12; Write time: 266300 20:24:47 INFO - Running post-run listener: _upload_blobber_files 20:24:47 INFO - Blob upload gear active. 20:24:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:24:47 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 20:24:47 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'] 20:24:47 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 20:24:47 INFO - (blobuploader) - INFO - Open directory for files ... 20:24:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:24:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:24:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:48 INFO - (blobuploader) - INFO - Done attempting. 20:24:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:24:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:24:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:49 INFO - (blobuploader) - INFO - Done attempting. 20:24:49 INFO - (blobuploader) - INFO - Iteration through files over. 20:24:49 INFO - Return code: 0 20:24:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:24:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:24:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1ce13c06332a1081fbee9cb98855f42f92b9b012ad81bcd2fe229ddba9d629f31cb84c2210fdb9fe1ed391138b48682fe818bdbca578610e352031dd107d5bf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/06896fb4b11ed57321e1f6a0720aa13edde1100cec2d03ae638a3f5bc740f564df5db500431bdc4342ff1fe50e742e20545cbd0c8e206be9e9b38b008b89a412"} 20:24:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:24:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:24:49 INFO - Contents: 20:24:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1ce13c06332a1081fbee9cb98855f42f92b9b012ad81bcd2fe229ddba9d629f31cb84c2210fdb9fe1ed391138b48682fe818bdbca578610e352031dd107d5bf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/06896fb4b11ed57321e1f6a0720aa13edde1100cec2d03ae638a3f5bc740f564df5db500431bdc4342ff1fe50e742e20545cbd0c8e206be9e9b38b008b89a412"} 20:24:49 INFO - Copying logs to upload dir... 20:24:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.083187 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-01 20:24:49.633191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 20:24:49.636542) ========= 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=61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404 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/1ce13c06332a1081fbee9cb98855f42f92b9b012ad81bcd2fe229ddba9d629f31cb84c2210fdb9fe1ed391138b48682fe818bdbca578610e352031dd107d5bf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/06896fb4b11ed57321e1f6a0720aa13edde1100cec2d03ae638a3f5bc740f564df5db500431bdc4342ff1fe50e742e20545cbd0c8e206be9e9b38b008b89a412"} build_url:https://queue.taskcluster.net/v1/task/NYtvEX5NReibcT8x6cMzNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/NYtvEX5NReibcT8x6cMzNA/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/1ce13c06332a1081fbee9cb98855f42f92b9b012ad81bcd2fe229ddba9d629f31cb84c2210fdb9fe1ed391138b48682fe818bdbca578610e352031dd107d5bf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/06896fb4b11ed57321e1f6a0720aa13edde1100cec2d03ae638a3f5bc740f564df5db500431bdc4342ff1fe50e742e20545cbd0c8e206be9e9b38b008b89a412"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 20:24:49.662101) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:24:49.662464) ========= 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=61fa6ed41387771909ec0f71000001b3-1451707069.67422-600796404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:24:49.748224) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 20:24:49.748552) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 20:24:49.748867) ========= ========= Total master_lag: 0.24 =========