builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1451184444.57 results: success (0) buildid: 20151226163004 builduid: 2abff7d4f28f4d679380d1eedad73d62 revision: 4c4e8470286f0dc817e988189f6584ba5d4ff5a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.571648) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.572218) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.572571) ========= 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=dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006447 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.629865) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.630204) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.704614) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.704918) ========= 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=dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004608 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.774957) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.775321) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.775747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.776148) ========= 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=dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-26 18:47:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-12-26 18:47:26 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.968801) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:24.969161) ========= 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=dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019001 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.018881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.019355) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4c4e8470286f0dc817e988189f6584ba5d4ff5a6 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4c4e8470286f0dc817e988189f6584ba5d4ff5a6 --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=dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-26 18:47:26,165 truncating revision to first 12 chars 2015-12-26 18:47:26,165 Setting DEBUG logging. 2015-12-26 18:47:26,165 attempt 1/10 2015-12-26 18:47:26,165 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4c4e8470286f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-26 18:47:26,564 unpacking tar archive at: mozilla-inbound-4c4e8470286f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675705 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.710734) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.711566) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.725449) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.725753) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 18:47:25.726303) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-26 18:47:25.727134) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:47:26 INFO - MultiFileLogger online at 20151226 18:47:26 in /builds/slave/test-pgo 18:47:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:47:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:47:26 INFO - {'append_to_log': False, 18:47:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:47:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:47:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:47:26 INFO - 'branch': 'Mozilla-Inbound', 18:47:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:47:26 INFO - 'config_files': ('talos/linux_config.py',), 18:47:26 INFO - 'default_actions': ('clobber', 18:47:26 INFO - 'read-buildbot-config', 18:47:26 INFO - 'download-and-extract', 18:47:26 INFO - 'populate-webroot', 18:47:26 INFO - 'create-virtualenv', 18:47:26 INFO - 'install', 18:47:26 INFO - 'run-tests'), 18:47:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:47:26 INFO - 'download_minidump_stackwalk': True, 18:47:26 INFO - 'download_symbols': 'ondemand', 18:47:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:47:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:47:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:47:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:47:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:47:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:47:26 INFO - 'installer_path': 'installer.exe', 18:47:26 INFO - 'log_level': 'info', 18:47:26 INFO - 'log_name': 'talos', 18:47:26 INFO - 'log_to_console': True, 18:47:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:47:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:47:26 INFO - 'opt_config_files': (), 18:47:26 INFO - 'pip_index': False, 18:47:26 INFO - 'sps_profile': False, 18:47:26 INFO - 'sps_profile_interval': 0, 18:47:26 INFO - 'suite': 'dromaeojs', 18:47:26 INFO - 'system_bits': '64', 18:47:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:47:26 INFO - 'title': 'talos-linux64-ix-002', 18:47:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:47:26 INFO - 'use_talos_json': True, 18:47:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:47:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:47:26 INFO - 'work_dir': 'build'} 18:47:26 INFO - ##### 18:47:26 INFO - ##### Running clobber step. 18:47:26 INFO - ##### 18:47:26 INFO - Running pre-action listener: _resource_record_pre_action 18:47:26 INFO - Running main action method: clobber 18:47:26 INFO - rmtree: /builds/slave/test-pgo/build 18:47:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:47:27 INFO - Running post-action listener: _resource_record_post_action 18:47:27 INFO - ##### 18:47:27 INFO - ##### Running read-buildbot-config step. 18:47:27 INFO - ##### 18:47:27 INFO - Running pre-action listener: _resource_record_pre_action 18:47:27 INFO - Running main action method: read_buildbot_config 18:47:27 INFO - Using buildbot properties: 18:47:27 INFO - { 18:47:27 INFO - "project": "", 18:47:27 INFO - "product": "firefox", 18:47:27 INFO - "script_repo_revision": "production", 18:47:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:47:27 INFO - "repository": "", 18:47:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:47:27 INFO - "buildid": "20151226163004", 18:47:27 INFO - "pgo_build": "True", 18:47:27 INFO - "basedir": "/builds/slave/test-pgo", 18:47:27 INFO - "buildnumber": 1380, 18:47:27 INFO - "slavename": "talos-linux64-ix-002", 18:47:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:47:27 INFO - "platform": "ubuntu64_hw", 18:47:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:47:27 INFO - "branch": "mozilla-inbound", 18:47:27 INFO - "repo_path": "integration/mozilla-inbound", 18:47:27 INFO - "revision": "4c4e8470286f0dc817e988189f6584ba5d4ff5a6", 18:47:27 INFO - "stage_platform": "linux64-pgo", 18:47:27 INFO - "builduid": "2abff7d4f28f4d679380d1eedad73d62", 18:47:27 INFO - "slavebuilddir": "test" 18:47:27 INFO - } 18:47:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:47:27 INFO - Running post-action listener: _resource_record_post_action 18:47:27 INFO - ##### 18:47:27 INFO - ##### Running download-and-extract step. 18:47:27 INFO - ##### 18:47:27 INFO - Running pre-action listener: _resource_record_pre_action 18:47:27 INFO - Running main action method: download_and_extract 18:47:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:47:27 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')]} 18:47:27 INFO - https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:47:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/test_packages.json 18:47:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/test_packages.json 18:47:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:47:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:47:28 INFO - Downloaded 1302 bytes. 18:47:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:47:28 INFO - Using the following test package requirements: 18:47:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:47:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:28 INFO - u'jsshell-linux-x86_64.zip'], 18:47:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:47:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:47:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:47:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:47:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:47:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:28 INFO - https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:47:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:30 INFO - Downloaded 23191568 bytes. 18:47:30 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 18:47:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:30 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 18:47:32 INFO - Return code: 0 18:47:32 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 18:47:32 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')]} 18:47:32 INFO - https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:47:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:33 INFO - Downloaded 23191568 bytes. 18:47:33 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 18:47:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:33 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 18:47:34 INFO - Return code: 0 18:47:34 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')]} 18:47:34 INFO - https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:47:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:36 INFO - Downloaded 11132270 bytes. 18:47:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 18:47:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:47:36 INFO - Return code: 0 18:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:36 INFO - https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:47:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:47:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:47:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPp13FHoRTqCU6CXrWYDBw/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 18:47:38 INFO - Downloaded 54927265 bytes. 18:47:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:47:38 INFO - mkdir: /builds/slave/test-pgo/properties 18:47:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:47:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:47:38 INFO - Contents: 18:47:38 INFO - build_url:https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:47:38 INFO - Running post-action listener: _resource_record_post_action 18:47:38 INFO - Running post-action listener: set_extra_try_arguments 18:47:38 INFO - ##### 18:47:38 INFO - ##### Running populate-webroot step. 18:47:38 INFO - ##### 18:47:38 INFO - Running pre-action listener: _resource_record_pre_action 18:47:38 INFO - Running main action method: populate_webroot 18:47:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:47:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:47:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:47:38 INFO - '--tppagecycles', 18:47:38 INFO - '7'], 18:47:38 INFO - 'tests': ['tsvgm']}}, 18:47:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:47:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:47:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:47:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:47:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:47:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:47:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:38 INFO - 'talos_options': ['--e10s'], 18:47:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:38 INFO - 'tests': ['damp', 'tps']}, 18:47:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:38 INFO - 'talos_options': ['--e10s'], 18:47:38 INFO - 'tests': ['damp', 'tps']}, 18:47:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:47:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:47:38 INFO - 'other': {'tests': ['a11yr', 18:47:38 INFO - 'ts_paint', 18:47:38 INFO - 'tpaint', 18:47:38 INFO - 'sessionrestore', 18:47:38 INFO - 'sessionrestore_no_auto_restore']}, 18:47:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:47:38 INFO - 'tests': ['a11yr', 18:47:38 INFO - 'ts_paint', 18:47:38 INFO - 'tpaint', 18:47:38 INFO - 'sessionrestore', 18:47:38 INFO - 'sessionrestore_no_auto_restore']}, 18:47:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:47:38 INFO - 'tests': ['a11yr', 18:47:38 INFO - 'ts_paint', 18:47:38 INFO - 'tpaint', 18:47:38 INFO - 'sessionrestore', 18:47:38 INFO - 'sessionrestore_no_auto_restore']}, 18:47:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:47:38 INFO - 'tests': ['a11yr', 18:47:38 INFO - 'ts_paint', 18:47:38 INFO - 'tpaint', 18:47:38 INFO - 'sessionrestore', 18:47:38 INFO - 'sessionrestore_no_auto_restore']}, 18:47:38 INFO - 'other_l64': {'tests': ['a11yr', 18:47:38 INFO - 'ts_paint', 18:47:38 INFO - 'tpaint', 18:47:38 INFO - 'sessionrestore', 18:47:38 INFO - 'sessionrestore_no_auto_restore']}, 18:47:38 INFO - 'other_nol64': {'tests': ['a11yr', 18:47:38 INFO - 'ts_paint', 18:47:38 INFO - 'tpaint', 18:47:38 INFO - 'sessionrestore', 18:47:38 INFO - 'sessionrestore_no_auto_restore']}, 18:47:38 INFO - 'svgr': {'tests': ['tsvgx', 18:47:38 INFO - 'tsvgr_opacity', 18:47:38 INFO - 'tart', 18:47:38 INFO - 'tscrollx', 18:47:38 INFO - 'cart']}, 18:47:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:47:38 INFO - 'tests': ['tsvgx', 18:47:38 INFO - 'tsvgr_opacity', 18:47:38 INFO - 'tart', 18:47:38 INFO - 'tscrollx', 18:47:38 INFO - 'cart']}, 18:47:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:38 INFO - 'tests': ['tp5o']}, 18:47:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:38 INFO - 'talos_options': ['--e10s'], 18:47:38 INFO - 'tests': ['tp5o']}, 18:47:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:38 INFO - 'talos_options': ['--xperf_path', 18:47:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:38 INFO - 'tests': ['tp5n']}, 18:47:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:38 INFO - 'talos_options': ['--e10s', 18:47:38 INFO - '--xperf_path', 18:47:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:38 INFO - 'tests': ['tp5n']}}, 18:47:38 INFO - 'talos.zip': {'path': '', 18:47:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:47:38 INFO - Running post-action listener: _resource_record_post_action 18:47:38 INFO - ##### 18:47:38 INFO - ##### Running create-virtualenv step. 18:47:38 INFO - ##### 18:47:38 INFO - Running pre-action listener: _resource_record_pre_action 18:47:38 INFO - Running main action method: create_virtualenv 18:47:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:47:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 18:47:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:47:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:47:38 INFO - Using real prefix '/usr' 18:47:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:47:39 INFO - Installing distribute.............................................................................................................................................................................................done. 18:47:41 INFO - Installing pip.................done. 18:47:41 INFO - Return code: 0 18:47:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb066fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830660>, '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 0x2831560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831a10>, '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': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', '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 18:47:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:47:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:47:41 INFO - Using env: {'DISPLAY': ':0', 18:47:41 INFO - 'HOME': '/home/cltbld', 18:47:41 INFO - 'LANG': 'en_US.UTF-8', 18:47:41 INFO - 'LANGUAGE': 'en_US:en', 18:47:41 INFO - 'LOGNAME': 'cltbld', 18:47:41 INFO - 'MAIL': '/var/mail/cltbld', 18:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:41 INFO - 'MOZ_NO_REMOTE': '1', 18:47:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:41 INFO - 'NO_EM_RESTART': '1', 18:47:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:41 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:41 INFO - 'SHELL': '/bin/bash', 18:47:41 INFO - 'SHLVL': '1', 18:47:41 INFO - 'TERM': 'linux', 18:47:41 INFO - 'TMOUT': '86400', 18:47:41 INFO - 'USER': 'cltbld', 18:47:41 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', 18:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:41 INFO - '_': '/tools/buildbot/bin/python'} 18:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:47:41 INFO - Cleaning up... 18:47:41 INFO - Return code: 0 18:47:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb066fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830660>, '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 0x2831560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831a10>, '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': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', '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 18:47:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:47:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:47:41 INFO - Using env: {'DISPLAY': ':0', 18:47:41 INFO - 'HOME': '/home/cltbld', 18:47:41 INFO - 'LANG': 'en_US.UTF-8', 18:47:41 INFO - 'LANGUAGE': 'en_US:en', 18:47:41 INFO - 'LOGNAME': 'cltbld', 18:47:41 INFO - 'MAIL': '/var/mail/cltbld', 18:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:41 INFO - 'MOZ_NO_REMOTE': '1', 18:47:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:41 INFO - 'NO_EM_RESTART': '1', 18:47:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:41 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:41 INFO - 'SHELL': '/bin/bash', 18:47:41 INFO - 'SHLVL': '1', 18:47:41 INFO - 'TERM': 'linux', 18:47:41 INFO - 'TMOUT': '86400', 18:47:41 INFO - 'USER': 'cltbld', 18:47:41 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', 18:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:41 INFO - '_': '/tools/buildbot/bin/python'} 18:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:41 INFO - Downloading/unpacking psutil>=0.7.1 18:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:47:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:47:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:47:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:47:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:47:43 INFO - Installing collected packages: psutil 18:47:43 INFO - Running setup.py install for psutil 18:47:43 INFO - building 'psutil._psutil_linux' extension 18:47:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:47:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:47:43 INFO - building 'psutil._psutil_posix' extension 18:47:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:47:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:47:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:47:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:47:44 INFO - Successfully installed psutil 18:47:44 INFO - Cleaning up... 18:47:44 INFO - Return code: 0 18:47:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:47:44 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')]} 18:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:44 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')]} 18:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:44 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 0x7fcb066fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830660>, '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 0x2831560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831a10>, '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': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', '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 18:47:44 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 18:47:44 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 18:47:44 INFO - Using env: {'DISPLAY': ':0', 18:47:44 INFO - 'HOME': '/home/cltbld', 18:47:44 INFO - 'LANG': 'en_US.UTF-8', 18:47:44 INFO - 'LANGUAGE': 'en_US:en', 18:47:44 INFO - 'LOGNAME': 'cltbld', 18:47:44 INFO - 'MAIL': '/var/mail/cltbld', 18:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:44 INFO - 'MOZ_NO_REMOTE': '1', 18:47:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:44 INFO - 'NO_EM_RESTART': '1', 18:47:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:44 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:44 INFO - 'SHELL': '/bin/bash', 18:47:44 INFO - 'SHLVL': '1', 18:47:44 INFO - 'TERM': 'linux', 18:47:44 INFO - 'TMOUT': '86400', 18:47:44 INFO - 'USER': 'cltbld', 18:47:44 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', 18:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:44 INFO - '_': '/tools/buildbot/bin/python'} 18:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:47:44 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 18:47:44 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 18:47:44 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 18:47:44 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 18:47:44 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 18:47:44 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 18:47:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:47:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:47:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:47:46 INFO - Installing collected packages: mozsystemmonitor 18:47:46 INFO - Running setup.py install for mozsystemmonitor 18:47:46 INFO - Successfully installed mozsystemmonitor 18:47:46 INFO - Cleaning up... 18:47:46 INFO - Return code: 0 18:47:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:47:46 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')]} 18:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:46 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')]} 18:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:46 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 0x7fcb066fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830660>, '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 0x2831560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831a10>, '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': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', '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 18:47:46 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 18:47:46 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 18:47:46 INFO - Using env: {'DISPLAY': ':0', 18:47:46 INFO - 'HOME': '/home/cltbld', 18:47:46 INFO - 'LANG': 'en_US.UTF-8', 18:47:46 INFO - 'LANGUAGE': 'en_US:en', 18:47:46 INFO - 'LOGNAME': 'cltbld', 18:47:46 INFO - 'MAIL': '/var/mail/cltbld', 18:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:46 INFO - 'MOZ_NO_REMOTE': '1', 18:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:46 INFO - 'NO_EM_RESTART': '1', 18:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:46 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:46 INFO - 'SHELL': '/bin/bash', 18:47:46 INFO - 'SHLVL': '1', 18:47:46 INFO - 'TERM': 'linux', 18:47:46 INFO - 'TMOUT': '86400', 18:47:46 INFO - 'USER': 'cltbld', 18:47:46 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', 18:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:46 INFO - '_': '/tools/buildbot/bin/python'} 18:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:46 INFO - Downloading/unpacking blobuploader==1.2.4 18:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:48 INFO - Downloading blobuploader-1.2.4.tar.gz 18:47:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:47:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:47:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:47:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:47:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:48 INFO - Downloading docopt-0.6.1.tar.gz 18:47:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:47:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:47:48 INFO - Installing collected packages: blobuploader, requests, docopt 18:47:48 INFO - Running setup.py install for blobuploader 18:47:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:47:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:47:48 INFO - Running setup.py install for requests 18:47:49 INFO - Running setup.py install for docopt 18:47:49 INFO - Successfully installed blobuploader requests docopt 18:47:49 INFO - Cleaning up... 18:47:49 INFO - Return code: 0 18:47:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb066fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830660>, '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 0x2831560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831a10>, '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': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', '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 18:47:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:47:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:49 INFO - Using env: {'DISPLAY': ':0', 18:47:49 INFO - 'HOME': '/home/cltbld', 18:47:49 INFO - 'LANG': 'en_US.UTF-8', 18:47:49 INFO - 'LANGUAGE': 'en_US:en', 18:47:49 INFO - 'LOGNAME': 'cltbld', 18:47:49 INFO - 'MAIL': '/var/mail/cltbld', 18:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:49 INFO - 'MOZ_NO_REMOTE': '1', 18:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:49 INFO - 'NO_EM_RESTART': '1', 18:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:49 INFO - 'SHELL': '/bin/bash', 18:47:49 INFO - 'SHLVL': '1', 18:47:49 INFO - 'TERM': 'linux', 18:47:49 INFO - 'TMOUT': '86400', 18:47:49 INFO - 'USER': 'cltbld', 18:47:49 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', 18:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:49 INFO - '_': '/tools/buildbot/bin/python'} 18:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:49 INFO - Running setup.py (path:/tmp/pip-bKQ8FW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:49 INFO - Running setup.py (path:/tmp/pip-uZCDtf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:49 INFO - Running setup.py (path:/tmp/pip-zgPvCx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:49 INFO - Running setup.py (path:/tmp/pip-fEl9hC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:49 INFO - Running setup.py (path:/tmp/pip-Vj_Jf5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:49 INFO - Running setup.py (path:/tmp/pip-wi2z0B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:50 INFO - Running setup.py (path:/tmp/pip-mVH_V0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:50 INFO - Running setup.py (path:/tmp/pip-wj3f93-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:50 INFO - Running setup.py (path:/tmp/pip-wpiyUK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:50 INFO - Running setup.py (path:/tmp/pip-4HzpcP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:50 INFO - Running setup.py (path:/tmp/pip-_IHJha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:50 INFO - Running setup.py (path:/tmp/pip-H81mly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:50 INFO - Running setup.py (path:/tmp/pip-CES1ej-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:50 INFO - Running setup.py (path:/tmp/pip-3HZrJH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:50 INFO - Running setup.py (path:/tmp/pip-UxkBJG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:50 INFO - Running setup.py (path:/tmp/pip-KxTAmV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:50 INFO - Running setup.py (path:/tmp/pip-yBjByv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:47:50 INFO - Running setup.py install for manifestparser 18:47:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:47:50 INFO - Running setup.py install for mozcrash 18:47:51 INFO - Running setup.py install for mozdebug 18:47:51 INFO - Running setup.py install for mozdevice 18:47:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:47:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:47:51 INFO - Running setup.py install for mozfile 18:47:51 INFO - Running setup.py install for mozhttpd 18:47:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:47:51 INFO - Running setup.py install for mozinfo 18:47:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:47:51 INFO - Running setup.py install for mozInstall 18:47:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:47:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:47:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:47:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:47:51 INFO - Running setup.py install for mozleak 18:47:51 INFO - Running setup.py install for mozlog 18:47:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:47:51 INFO - Running setup.py install for moznetwork 18:47:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:47:51 INFO - Running setup.py install for mozprocess 18:47:52 INFO - Running setup.py install for mozprofile 18:47:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:47:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:47:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:47:52 INFO - Running setup.py install for mozrunner 18:47:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:47:52 INFO - Running setup.py install for mozscreenshot 18:47:52 INFO - Running setup.py install for moztest 18:47:52 INFO - Running setup.py install for mozversion 18:47:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:47:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:47:52 INFO - Cleaning up... 18:47:52 INFO - Return code: 0 18:47:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb066fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830660>, '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 0x2831560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831a10>, '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': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', '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 18:47:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:47:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:52 INFO - Using env: {'DISPLAY': ':0', 18:47:52 INFO - 'HOME': '/home/cltbld', 18:47:52 INFO - 'LANG': 'en_US.UTF-8', 18:47:52 INFO - 'LANGUAGE': 'en_US:en', 18:47:52 INFO - 'LOGNAME': 'cltbld', 18:47:52 INFO - 'MAIL': '/var/mail/cltbld', 18:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:52 INFO - 'MOZ_NO_REMOTE': '1', 18:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:52 INFO - 'NO_EM_RESTART': '1', 18:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:52 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:52 INFO - 'SHELL': '/bin/bash', 18:47:52 INFO - 'SHLVL': '1', 18:47:52 INFO - 'TERM': 'linux', 18:47:52 INFO - 'TMOUT': '86400', 18:47:52 INFO - 'USER': 'cltbld', 18:47:52 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', 18:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:52 INFO - '_': '/tools/buildbot/bin/python'} 18:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:52 INFO - Running setup.py (path:/tmp/pip-XebybQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 18:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:52 INFO - Running setup.py (path:/tmp/pip-y9R6Hc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:52 INFO - Running setup.py (path:/tmp/pip-GtFkUu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:53 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)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:53 INFO - Running setup.py (path:/tmp/pip-MU1xOT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:53 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)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:53 INFO - Running setup.py (path:/tmp/pip-kFT2iZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:53 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)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:53 INFO - Running setup.py (path:/tmp/pip-ouCeV0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:53 INFO - Running setup.py (path:/tmp/pip-UXJL0V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:53 INFO - Running setup.py (path:/tmp/pip-gvH5Zq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:53 INFO - Running setup.py (path:/tmp/pip-tawT87-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:53 INFO - Running setup.py (path:/tmp/pip-cSfnYw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:53 INFO - Running setup.py (path:/tmp/pip-W5pK9e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:53 INFO - Running setup.py (path:/tmp/pip-0HuAnM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:53 INFO - Running setup.py (path:/tmp/pip-FdKitI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:53 INFO - Running setup.py (path:/tmp/pip-8ScCUT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:53 INFO - Running setup.py (path:/tmp/pip-HDV6QM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:53 INFO - Running setup.py (path:/tmp/pip-xmYVdh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 18:47:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:53 INFO - Running setup.py (path:/tmp/pip-tBc0S3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:54 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)) 18:47:54 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)) 18:47:54 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)) 18:47:54 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)) 18:47:54 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)) 18:47:54 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)) 18:47:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:47:54 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 18:47:54 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 18:47:54 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 18:47:54 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 18:47:54 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 18:47:54 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 18:47:55 INFO - Downloading blessings-1.5.1.tar.gz 18:47:55 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:47:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:47:55 INFO - Installing collected packages: blessings 18:47:55 INFO - Running setup.py install for blessings 18:47:55 INFO - Successfully installed blessings 18:47:55 INFO - Cleaning up... 18:47:55 INFO - Return code: 0 18:47:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:47:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:47:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:47:56 INFO - Reading from file tmpfile_stdout 18:47:56 INFO - Current package versions: 18:47:56 INFO - argparse == 1.2.1 18:47:56 INFO - blessings == 1.5.1 18:47:56 INFO - blobuploader == 1.2.4 18:47:56 INFO - docopt == 0.6.1 18:47:56 INFO - manifestparser == 1.1 18:47:56 INFO - mozInstall == 1.12 18:47:56 INFO - mozcrash == 0.16 18:47:56 INFO - mozdebug == 0.1 18:47:56 INFO - mozdevice == 0.47 18:47:56 INFO - mozfile == 1.2 18:47:56 INFO - mozhttpd == 0.7 18:47:56 INFO - mozinfo == 0.9 18:47:56 INFO - mozleak == 0.1 18:47:56 INFO - mozlog == 3.1 18:47:56 INFO - moznetwork == 0.27 18:47:56 INFO - mozprocess == 0.22 18:47:56 INFO - mozprofile == 0.28 18:47:56 INFO - mozrunner == 6.11 18:47:56 INFO - mozscreenshot == 0.1 18:47:56 INFO - mozsystemmonitor == 0.0 18:47:56 INFO - moztest == 0.7 18:47:56 INFO - mozversion == 1.4 18:47:56 INFO - psutil == 3.1.1 18:47:56 INFO - requests == 1.2.3 18:47:56 INFO - wsgiref == 0.1.2 18:47:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47: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')]} 18:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47: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')]} 18:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47: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', '-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 0x7fcb066fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830660>, '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 0x2831560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831a10>, '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': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', '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 18:47:56 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 18:47:56 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 18:47:56 INFO - Using env: {'DISPLAY': ':0', 18:47:56 INFO - 'HOME': '/home/cltbld', 18:47:56 INFO - 'LANG': 'en_US.UTF-8', 18:47:56 INFO - 'LANGUAGE': 'en_US:en', 18:47:56 INFO - 'LOGNAME': 'cltbld', 18:47:56 INFO - 'MAIL': '/var/mail/cltbld', 18:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:56 INFO - 'MOZ_NO_REMOTE': '1', 18:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:56 INFO - 'NO_EM_RESTART': '1', 18:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:56 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:56 INFO - 'SHELL': '/bin/bash', 18:47:56 INFO - 'SHLVL': '1', 18:47:56 INFO - 'TERM': 'linux', 18:47:56 INFO - 'TMOUT': '86400', 18:47:56 INFO - 'USER': 'cltbld', 18:47:56 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', 18:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:56 INFO - '_': '/tools/buildbot/bin/python'} 18:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 18:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 18:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 18:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 18:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 18:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 18:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:47:56 INFO - Cleaning up... 18:47:56 INFO - Return code: 0 18:47:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:47: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')]} 18:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47: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')]} 18:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb066fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830660>, '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 0x2831560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831a10>, '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': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', '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 18:47:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 18:47:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:47:56 INFO - Using env: {'DISPLAY': ':0', 18:47:56 INFO - 'HOME': '/home/cltbld', 18:47:56 INFO - 'LANG': 'en_US.UTF-8', 18:47:56 INFO - 'LANGUAGE': 'en_US:en', 18:47:56 INFO - 'LOGNAME': 'cltbld', 18:47:56 INFO - 'MAIL': '/var/mail/cltbld', 18:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:56 INFO - 'MOZ_NO_REMOTE': '1', 18:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:56 INFO - 'NO_EM_RESTART': '1', 18:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:56 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:56 INFO - 'SHELL': '/bin/bash', 18:47:56 INFO - 'SHLVL': '1', 18:47:56 INFO - 'TERM': 'linux', 18:47:56 INFO - 'TMOUT': '86400', 18:47:56 INFO - 'USER': 'cltbld', 18:47:56 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', 18:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:56 INFO - '_': '/tools/buildbot/bin/python'} 18:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:56 INFO - Downloading/unpacking jsonschema 18:47: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 18:47: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 18:47: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 18:47: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 18:47: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 18:47: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 18:47:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:47:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:47:58 INFO - Downloading/unpacking functools32 (from jsonschema) 18:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:58 INFO - Downloading functools32-3.2.3-2.tar.gz 18:47:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:47:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:47:58 INFO - warning: no files found matching '*.txt' 18:47:58 INFO - no previously-included directories found matching 'build' 18:47:58 INFO - no previously-included directories found matching 'dist' 18:47:58 INFO - no previously-included directories found matching '.git*' 18:47:58 INFO - Installing collected packages: jsonschema, functools32 18:47:58 INFO - Running setup.py install for functools32 18:47:58 INFO - warning: no files found matching '*.txt' 18:47:58 INFO - no previously-included directories found matching 'build' 18:47:58 INFO - no previously-included directories found matching 'dist' 18:47:58 INFO - no previously-included directories found matching '.git*' 18:47:58 INFO - Successfully installed jsonschema functools32 18:47:58 INFO - Cleaning up... 18:47:58 INFO - Return code: 0 18:47:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:47: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')]} 18:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47: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')]} 18:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb066fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830660>, '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 0x2831560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831a10>, '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': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', '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 18:47:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 18:47:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:47:58 INFO - Using env: {'DISPLAY': ':0', 18:47:58 INFO - 'HOME': '/home/cltbld', 18:47:58 INFO - 'LANG': 'en_US.UTF-8', 18:47:58 INFO - 'LANGUAGE': 'en_US:en', 18:47:58 INFO - 'LOGNAME': 'cltbld', 18:47:58 INFO - 'MAIL': '/var/mail/cltbld', 18:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:58 INFO - 'MOZ_NO_REMOTE': '1', 18:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:58 INFO - 'NO_EM_RESTART': '1', 18:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:58 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:58 INFO - 'SHELL': '/bin/bash', 18:47:58 INFO - 'SHLVL': '1', 18:47:58 INFO - 'TERM': 'linux', 18:47:58 INFO - 'TMOUT': '86400', 18:47:58 INFO - 'USER': 'cltbld', 18:47:58 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', 18:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:58 INFO - '_': '/tools/buildbot/bin/python'} 18:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:58 INFO - Downloading/unpacking flake8 18:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:48:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:48:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:48:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 18:48:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:00 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 18:48:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:48:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:48:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:48:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:48:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:48:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:48:01 INFO - no previously-included directories found matching 'docs/_build' 18:48:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:48:01 INFO - Running setup.py install for pep8 18:48:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:48:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:48:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:48:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:48:01 INFO - no previously-included directories found matching 'docs/_build' 18:48:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:48:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:48:01 INFO - Cleaning up... 18:48:01 INFO - Return code: 0 18:48:01 INFO - Running post-action listener: _resource_record_post_action 18:48:01 INFO - Running post-action listener: _start_resource_monitoring 18:48:01 INFO - Starting resource monitoring. 18:48:01 INFO - ##### 18:48:01 INFO - ##### Running install step. 18:48:01 INFO - ##### 18:48:01 INFO - Running pre-action listener: _resource_record_pre_action 18:48:01 INFO - Running main action method: install 18:48:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:48:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:48:01 INFO - Reading from file tmpfile_stdout 18:48:01 INFO - Detecting whether we're running mozinstall >=1.0... 18:48:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:48:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:48:01 INFO - Reading from file tmpfile_stdout 18:48:01 INFO - Output received: 18:48:01 INFO - Usage: mozinstall [options] installer 18:48:01 INFO - Options: 18:48:01 INFO - -h, --help show this help message and exit 18:48:01 INFO - -d DEST, --destination=DEST 18:48:01 INFO - Directory to install application into. [default: 18:48:01 INFO - "/builds/slave/test-pgo"] 18:48:01 INFO - --app=APP Application being installed. [default: firefox] 18:48:01 INFO - mkdir: /builds/slave/test-pgo/build/application 18:48:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:48:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:48:17 INFO - Reading from file tmpfile_stdout 18:48:17 INFO - Output received: 18:48:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:48:17 INFO - Running post-action listener: _resource_record_post_action 18:48:17 INFO - ##### 18:48:17 INFO - ##### Running run-tests step. 18:48:17 INFO - ##### 18:48:17 INFO - Running pre-action listener: _resource_record_pre_action 18:48:17 INFO - Running main action method: run_tests 18:48:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:48:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:48:17 INFO - Python 2.7.3 18:48:17 INFO - Return code: 0 18:48:17 INFO - grabbing minidump binary from tooltool 18:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2830660>, '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 0x2831560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2831a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:48:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 18:48:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:48:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:48:17 INFO - Return code: 0 18:48:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:48:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:48:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:48:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:48:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:48:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:48:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:48:18 INFO - Return code: 0 18:48:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 18:48:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 18:48:18 INFO - Using env: {'DISPLAY': ':0', 18:48:18 INFO - 'HOME': '/home/cltbld', 18:48:18 INFO - 'LANG': 'en_US.UTF-8', 18:48:18 INFO - 'LANGUAGE': 'en_US:en', 18:48:18 INFO - 'LOGNAME': 'cltbld', 18:48:18 INFO - 'MAIL': '/var/mail/cltbld', 18:48:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:48:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:18 INFO - 'MOZ_NO_REMOTE': '1', 18:48:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:18 INFO - 'NO_EM_RESTART': '1', 18:48:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:18 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:48:18 INFO - 'SHELL': '/bin/bash', 18:48:18 INFO - 'SHLVL': '1', 18:48:18 INFO - 'TERM': 'linux', 18:48:18 INFO - 'TMOUT': '86400', 18:48:18 INFO - 'USER': 'cltbld', 18:48:18 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484', 18:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:18 INFO - '_': '/tools/buildbot/bin/python'} 18:48:18 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 18:48:18 INFO - mozversion application_buildid: 20151226163004 18:48:18 INFO - mozversion application_changeset: 4c4e8470286f0dc817e988189f6584ba5d4ff5a6 18:48:18 INFO - mozversion application_display_name: Nightly 18:48:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:48:18 INFO - mozversion application_name: Firefox 18:48:18 INFO - mozversion application_remotingname: firefox 18:48:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:48:18 INFO - mozversion application_vendor: Mozilla 18:48:18 INFO - mozversion application_version: 46.0a1 18:48:18 INFO - mozversion platform_buildid: 20151226163004 18:48:18 INFO - mozversion platform_changeset: 4c4e8470286f0dc817e988189f6584ba5d4ff5a6 18:48:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:48:18 INFO - mozversion platform_version: 46.0a1 18:48:18 INFO - using testdate: 1451184498 18:48:18 INFO - actual date: 1451184498 18:48:18 INFO - starting webserver on 'localhost:58220' 18:48:18 INFO - SUITE-START | Running 3 tests 18:48:18 INFO - TEST-START | dromaeo_css 18:48:18 INFO - operating with platform_type : linux_ 18:48:18 INFO - Initialising browser for dromaeo_css test... 18:48:18 INFO - TEST-INFO | started process 14699 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3e69UL/profile http://localhost:58220/getInfo.html) 18:48:23 INFO - PROCESS | 14699 | __metrics Screen width/height:1600/1200 18:48:23 INFO - PROCESS | 14699 | colorDepth:24 18:48:23 INFO - PROCESS | 14699 | Browser inner width/height: 1024/697 18:48:23 INFO - PROCESS | 14699 | __metrics 18:48:23 INFO - PROCESS | 14699 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:48:23 INFO - PROCESS | 14699 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:48:24 INFO - TEST-INFO | 14699: exit 0 18:48:24 INFO - Browser initialized. 18:48:24 INFO - Running cycle 1/1 for dromaeo_css test... 18:48:24 INFO - TEST-INFO | started process 14790 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3e69UL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:48:35 INFO - PROCESS | 14790 | RSS: Main: 148291584 18:48:35 INFO - PROCESS | 14790 | 18:49:27 INFO - PROCESS | 14790 | 1451184567279 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] 18:51:35 INFO - PROCESS | 14790 | Cycle 1(1): loaded http://localhost:58220/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58220/tests/dromaeo/cssquery-ext.html) 18:51:36 INFO - PROCESS | 14790 | RSS: Main: 239423488 18:51:36 INFO - PROCESS | 14790 | 18:54:39 INFO - PROCESS | 14790 | Cycle 1(1): loaded http://localhost:58220/tests/dromaeo/cssquery-ext.html (next: http://localhost:58220/tests/dromaeo/cssquery-jquery.html) 18:54:39 INFO - PROCESS | 14790 | RSS: Main: 231301120 18:54:39 INFO - PROCESS | 14790 | 18:57:41 INFO - PROCESS | 14790 | Cycle 1(1): loaded http://localhost:58220/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58220/tests/dromaeo/cssquery-mootools.html) 18:57:42 INFO - PROCESS | 14790 | RSS: Main: 238276608 18:57:42 INFO - PROCESS | 14790 | 19:00:43 INFO - PROCESS | 14790 | Cycle 1(1): loaded http://localhost:58220/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58220/tests/dromaeo/cssquery-prototype.html) 19:00:44 INFO - PROCESS | 14790 | RSS: Main: 212078592 19:00:44 INFO - PROCESS | 14790 | 19:03:47 INFO - PROCESS | 14790 | Cycle 1(1): loaded http://localhost:58220/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58220/tests/dromaeo/cssquery-yui.html) 19:03:47 INFO - PROCESS | 14790 | RSS: Main: 214777856 19:03:47 INFO - PROCESS | 14790 | 19:06:50 INFO - PROCESS | 14790 | Cycle 1(1): loaded http://localhost:58220/tests/dromaeo/cssquery-yui.html (next: http://localhost:58220/tests/dromaeo/cssquery-dojo.html) 19:06:50 INFO - PROCESS | 14790 | RSS: Main: 277516288 19:06:50 INFO - PROCESS | 14790 | 19:06:50 INFO - PROCESS | 14790 | __start_tp_report 19:06:50 INFO - PROCESS | 14790 | _x_x_mozilla_page_load 19:06:50 INFO - PROCESS | 14790 | _x_x_mozilla_page_load_details 19:06:50 INFO - PROCESS | 14790 | |i|pagename|runs| 19:06:50 INFO - PROCESS | 14790 | |0;dojo.html;3130.264387868851;3172;3204.0868352519537;3210.4542227821266;3238.158078899486;5109.4379618241965;5226.425093239741;5226.738663066846;5238.52853243208;5266.789328426863;5183.663061900974;5186.351706036746;5268.973655131728;5273.129933560967;5295.417504074549;4739.170645137105;4791.472937976829;4810.807567697306;4813.711177329354;4868.05073010763;4714.599259062984;4801.663883528155;4827.493113223114;4863.635227357945;4920.409550853885;4729.692569982957;4749.073930583538;4783.569478746929;4809.591184749301;4825.734584597846;4747.928781068286;4748.477667456577;4751.714897106184;4762.928556071662;4789.592884604813;4690.671652984292;4706.411698537683;4708.223143181371;4736.431628204603;4754.286856971447;4981.27771473138;5045.823396181153;5066.746662666852;5116.539511443988;5148.021875843578;5605.075162598167;5605.439456054402;5610.775568977236;5615.101583746622;5615.241942337773;5461.15352120422;5613.80351687693;5629.155626656035;5654.717264136777;5658.34928983164;5226.085435048852;5283.128283833163;5363.329583802025;5372.462753724635;5373.9731301343245;5712.514436272963;5712.885742285131;5720.227769251181;5760.251167348218;5769.480746732815;5513.145462453326;5513.58648101394;5516.282883225155;5517.1172612382625;5518.503334699896;5475.4250803665045;5495.780168793203;5587.413321601254;5589.832305030855;5702.6863522506665;5569.721513924287;5578.497935185772;5602.579806514527;5607.691576963224;5610.046292130348;5576.776928922879;5577.191307260506;5578.888422231533;5579.191017302468;5582.581306402036;4223.239816832999;4286.678499112579;4311.137772445523;4392.033752574429;4404.207242696345;3843.6925045996254;3844.461775351453;3868.1490072184074;3879.980600097038;3881.8253178606465;5186.170212766015;5208.062548741263;5208.687478751287;5215.713135777569;5216.426193118754;5508.779648814003;5548.195511650788;5593.580481463907;5607.074832652566;5609.382967873531;5230.712310822942;5239.554637855748;5240.4759524047295;5240.764165612557;5282.181261904411;4856.368672072608;4871.902561948741;4872.220444728827;4877.878053048702;4920.138975679313;5660.943390566042;5727.083666613322;5752.568557358215;5758.1362795581;5799.420057994167;5618.438156184349;5644.407337229696;5656.8020119295625;5658.660480371191;5698.287714035746;5757.366689664217;5789.247397838254;5790.276215473066;5790.536757059509;5791.942080579309;5419.864503387447;5483.314585676791;5500.037493438552;5509.173623956439;5520.779168833202;5551.916721249266;5588.385277619377;5617.32592088952;5618.494335509824;5621.213030175697;5414.242006119068;5454.727263636882;5486.259354987025;5495.093309604031;5513.035218836768;5448.482394172547;5464.617476776746;5465.59008074388;5468.0977638690765;5469.781208751764;5260.158374660036;5375.1131063374105;5385.515303622693;5390.137577987503;5437.918431223614;5394.163904594794;5443.265159203615;5472.370677372153;5498.422665620053;5518.2826232589505;5378.5966052547;5435;5435.130379139318;5439.5920305976415;5441.972790136024 19:06:50 INFO - PROCESS | 14790 | |1;ext.html;577.5610535992645;594.4709208804162;597.5667640960304;605.1527860994607;610.1640752169528;27633.171004869862;37549.06127346818;38260.42609360862;38343;38353.23293534131;40567.59432405675;41059.17881642366;41079.38380924281;41109.58890411095;41140.177196456054;7295.416366690679;8658.870116948236;8818.911810881873;8828.602712877904;8828.955855220715;7157.749478768244;10062;10234.181265498779;10241.078302952732;10241.692749217535;9977.151942084894;10049.346792458467;10101.949490252538;10122.240831937597;10128.645497407591;7477.551346919202;7626.809329766745;9981.600735970589;10084.09243168111;10103.797924041552;10062.295639305252;10238.33450825694;10238.385696858213;10239.795204095877;10242.641507547274;35523.82238088819;35708.821455892554;35810.64189358099;35829.64170358289;35925;2889.436559870826;3062;3111.9533207001914;3429.176997520602;3720.8426643413454;27296.45407091867;27304.590431143548;28000;29372;29576.852115739497;3975.284448799215;3994.560598334181;4001.8599349022643;4018.095928416083;4100.118474527991;183907;184601.07699461418;184895;184919;184942.07528962404;55534;55801.44198557962;56121.43878561162;56167.71916140393;56340.43659563434;53124.46875531272;53879.46120538823;58383.41616583865;58545.414545854845;59753.40246597478;14573.198474083814;14840.10959342443;14930.25348732559;14977.625559361104;14984.40062397492;11442.199046066695;11497.770044599061;11520.53917843277;11529.250598711056;11539.249948753471;17961.371352002618;17982.730259046126;18215.271389144287;18531.98074105937;18660.34688785886;7196.928030719626;7422.331990120915;7465.477416580788;7507.471488400443;7569.205233450409;949.7578117579973;955.694177863091;989.3223142147652;1045.984310235347;1076.4886678827652;27557.862210689218;27656.308592284953;27680.86159569189;27944;28144;975.6682727872558;1004.4324956399611;1033.3180101133366;1034.7852374604163;1045.895410458948;14202.218877961812;14522.782158267635;14629.414823407158;14725.337359818619;14740.484083057041;294490;297145;299020;299052;299372;50605.24092138621;50745.49254507481;50842.74578627083;50882.49117508777;50931.23603145956;1326;1337.9464821407034;1349.1770020287618;1351.5472316773794;1357.4570171931307;26215.344616384744;27137.192308651836;27172.45655086927;27263.182104536896;27413.862930686017;43874;44036;44268;44409;44418;286611;288376;288570;288689;288932;26974.730252698006;27498.862505687342;30634.84682576573;31195.064148075595;31784.841075795397;36178.45732313965;36641;36820.81589592035;37004.81497592495;37566;31590.210244744067;31671.891483798878;31970.84014579912;32094.839525803156;32578.51132232971;28228.15315540537;32527.837360813046;33542.16144596405;34736.30527389488;35065.824670877504;31446.371072578877;31620.36759264848;34791;35112.297754044266;35250.82374588213;27006.729932700422;28982.473975074146;30849.941266650054;30978.201117429824;31495.37009259756;23857.522849542565;23935.401614959766;24123.276301710976;24380.63429048601;24513.264602061965 19:06:50 INFO - PROCESS | 14790 | |2;jquery.html;352.55225863153794;357.6030606027311;357.8353957179696;359.6313778377163;360.45571187506863;13763.380647870845;14095.859041409583;15674.843251567496;15676.84323156768;16329.591760205985;16249.918750406261;16706.916465417686;17355.305787768506;17636.294548218055;17643.470695879143;5300.284461597683;5407.297051383334;5410.377806552257;5418.8916221675545;5421.620486565942;3965.4448377227213;4082.4080508326274;5378.811741589046;5875.383084776101;5986.7605295788335;5907.527397808187;5927.992241318986;5936.168936348915;5951;5963.3738457462;5751;5876.764929402819;5884.499817515516;5893.381194974509;5906.114082887601;5202.557782588485;5209.791608335662;5210.739463026872;5214.45248248936;5221.71280579568;21320.360389188194;22115.115395384164;22506.66240006401;23093.191738289246;23456.413589660224;2278.6012447821563;2299.2527428585777;2358.749862572839;2461.3433346049746;2482.8013758899247;13911.86088139126;14322.785158222636;14419.567412977627;14673.853261467355;14902.776458353133;2007.1068374573322;2087.123408168573;2105.6841473778904;2144.4210063282826;2189.4745261137373;67477.32522674759;70350;71909;72770.27229727688;72851.63574182148;15282.46511372119;15378.538643840478;15406.691866162613;15411.383544658313;15514.767278490832;24343.513129737305;24359.269221923372;24548.754512455005;24653.753462465505;24678.25965221046;8532.274756645755;8639.438436501607;8642.956785216034;8677.56612169389;8687.435316704394;7223.638818059076;7236.240194779472;7238.348548630648;7268.818279543054;7293.380062694624;7611.809704757315;7790;7795.961020194863;7859.921400786034;7888.171741967126;2634.4467661790854;2969.168632782781;2980.672126066131;3080.199148221434;3103.7720770398982;842.6208206307186;919.5907821019716;974.6491263145263;1014.1683819268277;1041.3283432186197;16741.6651666966;17118.229679664444;17230.224639891236;17322.944274000696;17379.913100434416;872.1757938747949;903.5933829776627;937.4141161773891;954.9522523873917;976.1507488484922;9507.66723164686;9534.952325238468;9686.031396860399;9732.513374331254;9869.506524673738;388313;393915;489809;495411;523941;41420.37869431961;81638.59180704059;82361.58819205865;84115;88426.55786721154;1085.4735453305298;1104.0891264706809;1107.9224454288124;1111.2721167635211;1124.6288724720823;12614.243145411305;14649.560513184622;14943;15283.61790955235;15651.37394504207;32650;33249.833750831094;34343.48484772781;36228.27543449169;37091.443628345056;41037.79481102576;41170.38244426276;41291.587084128776;41331.586684133974;41920.58079419289;9300.488473133772;9326.95336523313;9464.384814987005;9535.237181025363;9552.808943821223;17024.829751702324;17030.82969170342;17232.913835431245;17534.561635959202;17598.472045838644;14080.22558759278;14334.641633959234;14483.493077742229;14860.554183374516;14920.477783277533;13115.803262951255;14534.636634084232;14828.481003164838;15079;15161;14418.711625767217;14841.85158148448;14981;15212.695746085237;15551.922240388725;9769.560369783234;9939.254555908192;9960.452175130438;10002.99970003023;10036.49817509107;14430.494932677306;14577.416903323749;14623.92688036553;14851.554453366416;15247.237638118271 19:06:50 INFO - PROCESS | 14790 | |3;mootools.html;1250.0124901327952;1379.5102738527823;1429.892758043147;1549.4112237349811;1758.252742584402;6319.5576309658345;6927.4458043356535;7034.964825175867;7036.472264580151;7049.54177978431;6958.338957799014;7134.6432678366;7138.500304978654;7143.607101609409;7144.785656430316;1884.076802366844;1911.7036859286832;1911.827935485806;2151.257816053463;2181.2365672014826;2214.756376798559;2239.4513344230686;2256.232880820529;2259.3334966184934;2259.8192144628474;2142.6143294207036;2174.8803815790125;2186.7922547357975;2187.278198194592;2188.7811218878064;2132.9040193191345;2144.6032483990434;2159.0500179920864;2172.3157205480225;2214.2250212425683;2230.3309007297908;2237.463008877874;2253.278950735765;2257.8645281283175;2272.6022945984387;6966.164060312795;7022.543534670282;7026.789196324118;7029.929700702979;7038.260982596805;4412.691111622188;4416.690831641787;4478.104379124188;4478.865634030984;4479.1489616972995;2930.9413811723857;2960.7335339819306;3001.8048826826403;3023.349979754363;3045.5888455058507;999.5651891427252;1014.852846337277;1034.5137785241;1051.1328154272678;1056.1339701444817;9868.111869931741;9872.308938374317;9876.87647155865;9883.061109194616;9887.159591434736;4004.2992476316526;4066.9389959150635;4080.755154690728;4090.3250963591267;4121.690873184523;8524.27543658796;8526.23263906239;8526.445781024213;8527.573621318908;8531.317494600416;4371.519132895379;4395.164918665443;4402.625776808943;4404.229259879572;4407.911841763147;4007.0783719744622;4014.1770936957855;4015.7188996769946;4016.835117815859;4020.577839326887;3139.560461535387;3178.825164615922;3467.3065386922717;3469.583649962021;3541.94687079694;1120.7758448310208;1128.7516746315798;1129.4296380327883;1137.9260348077514;1153.5674122204173;991.940483570988;1001.2390583156853;1010.8129995950773;1103.8509801176738;1292.3344477594046;6553.4101930826455;6651;6657.1345725055435;6692.899606505906;6707.56400833954;1086.1365214654368;1093.6227001684406;1097.1113398147527;1118.4016551145098;1132.7394699219226;5210.76551555181;5313.149896016619;5317.9202311965355;5318.97340513295;5321.068812957717;8330.166983301742;8381.287590554872;8487.915120848713;8583.828323433496;8598.140185981352;8450.661973521113;8456.027556831043;8460.534670593053;8482.660693572312;8531.10423405546;6598.868022639616;6718.563293385914;6790.660466976631;6811.761588344384;6832.692528836314;6385.680715964276;6391.265004524539;6419.646919419477;6427.3251308611925;6431.807045788634;7407.407407407502;7576.924230757842;7595.658195381332;7661.808454788675;7685.730999414994;7652.387808975157;7816.296533312029;7845.686172553034;7918.049834019955;7974.800629984296;6143.849206349207;6197.473214776614;6229.190205273286;6242;6244.969580019428;6780.796576102724;6820.965895170492;6855.348741869514;6897.206821215625;6910.308969103049;6408.61548307103;6451.6774161290805;6519.576227545194;6538.444232240123;6593.142891424084;6265.342139075331;6357.936420635734;6381.553291269753;6424.357564243538;6469.676516174267;6248.125262463168;6269;6299.181106456132;6310.116583678197;6313.842153946188;5747.1379293106365;5775.364709881826;5782.421757824184;5795.39148389413;5796.478316951495;5889.440503152194;5907.940920590911;6046.334903160737;6047.153398524298;6061.6666083365835 19:06:50 INFO - PROCESS | 14790 | |4;prototype.html;337.22774845603567;341.8666719979207;343.5842630417195;344.65362310877566;352.0494664406104;6051.788187413442;6063.333033366326;6094.939050609492;6108.450239478446;6133.110698948655;5760.683162426065;5812.622179558336;5917.644941303525;5992.820215393534;6029.306629737571;4641.048585040058;4660.603848672867;4672.0889426561835;4674.111918735446;4684.765761711918;4391.341298805173;4670.532946705336;4671.462781780087;4672.813087476514;4675.368825208604;4409.735415875058;4489.932651010221;4578.702384345023;4589.954100458986;4624.190766615846;4570.291604801261;4584.656150788671;4595.264757638778;4598.494165641777;4621.607163391116;4060.918781624351;4064.0855807443386;4065.1259979104634;4065.9390109148385;4075.5109386873764;5644;5749.59752817303;5754.539636829044;5757.65454072757;5757.68332741699;5324.653897496651;5325.520703136736;5328.92006619901;5333.866653333659;5334.119870221448;6364.904526432108;6393.424591786715;6405.29541750407;6408.807735767934;6417;4446.688731788776;4451.532589078165;4454.955450445486;4455.398521199629;4456.46522417312;6545;6612.636305003223;6674.899876501856;6679.599224046573;6679.732810687567;4523.23105072132;4527.569880861313;4529.162105010583;4529.54704529551;4530.161920044802;4584.885377865513;4585.908281834345;4586.449626044896;4590.609798167126;4591.334256532851;5308.628396012319;5308.761105750251;5309.044372012998;5309.65487243328;5318.521333080042;6258.405451482193;6417.133686952295;6421.74313027483;6429.935700642934;6434.045784745813;1595.7686135510287;1620.1494215536702;1621.4162901355503;1623.2857542681184;1623.9756403653955;1053.773438710681;1075.8493810866485;1082.53992053377;1093.8851420600881;1098.368438148068;6077.1491991121275;6077.453029227391;6083.756649733961;6087.421694938974;6090.634561926298;6421.29365769765;6593.2088149421415;6595.439387652007;6599.670016499156;6602.372774586406;5958.463738263577;6033.823404436181;6133.6319820810895;6134.723937422827;6134.846628834225;3564.502908778319;3615.764975276651;3616.692581130581;3618.5476815398074;3619.8914032579064;6771.322867713189;6899.310068993061;6911.133993821741;6915.89626155608;6916.723331066802;6821.556598821061;6828.658567071726;6831.316868313129;6841.350071743176;6841.897371539431;6918.896216556655;6919.861602767916;6921.134858142732;6924.619145947021;6929.930700693029;6554.57395269325;6684.766033188815;6686;6689.46484281266;6695.0626912231355;6559.409653131241;6565.146530950946;6567.080608714688;6568.80293591193;6572.047053177358;6895.172579290517;6900.102986611709;6900.2064762550945;6920.653967301514;6921.6193109379465;4452.220861349316;4564.977175114236;4566.88582785433;4567.109413664303;4568.565986231302;6643.335666433318;6677.599344039373;6693.397594216543;6694.330566943267;6713.462922966053;6493.318201588765;6493.74025039012;6494.577852439576;6500.447461965786;6503.447206987459;6371.904421433775;6477.578957367756;6481.708323125565;6482.805515834532;6490;6351.841203969938;6361.268454127649;6362.427381535684;6363.427291543598;6363.459105975859;6483.546151769331;6487.708053137714;6522.086907833002;6528.543001989815;6537.28089910119;6150.50795936333;6349.428551430394;6351.396617321347;6353.301136875032;6356.618602883842 19:06:50 INFO - PROCESS | 14790 | |5;yui.html;712.2130046298839;741.6996116572789;750.3884334267572;800.2627728507867;822.8806823010664;13687.3156342183;13891.374888130033;13901.443942242324;13918.652033699163;13939.790903136449;12605.873941260585;12930.74138517229;12932.094753367268;12933.482660693584;12953.676158096052;664.5713514782963;811.7889348769319;824.2416976381743;825.0511911301991;825.3644693585966;670.2894931372737;821.6097353756977;833.5040650812757;834.0325222741621;834.1158372125536;847.4660963592928;857.2798848966867;859.7979474823411;860.1570460948275;861.1861790607878;697.7732237022963;703.5778532880282;856.7215654912147;857.2284943550823;860.3977215948861;636.6434796513921;638.8434833465784;641.1344684675697;641.3137942401632;642.2870613618879;12443.813342799865;12461.252324860447;12518.436670349856;12549;12638.74722505554;11733.53065877364;11746;11982.940085299517;12288.078394120477;12482.188657737308;9814.116729494308;10118.342307749972;10203;10308.639197628121;10456.895431045668;3693.630636936312;3699;3709.109813644706;3768.3782175940937;3834.578196398394;43339.34990975138;43402.34896476555;43867;43987.34018989718;44126.33810492877;10119.595216191417;10132.34139780912;10146.188304935587;10174.767290859125;10359.067683908333;18043.819561804477;18055.45833624967;18064.548386290448;18076.457706268833;18088.909555452137;7782.766517004499;7855.685772569148;7952;8025.3980951428875;8028.518288902567;4298.3552467130185;4467.40511354618;4472.798724057425;4519.706219095749;4556.794944227518;2981.8061825981677;2995.0715278263806;2999.3851260491983;3005.594244776927;3007.1279328994783;527.6833899660173;532.4276402866933;541.0909671751496;542.7096503370677;546.8878879829625;618.8452886778306;657.454312920275;673.9494537909676;692.5533031194951;699.4544255480733;8172.787552292461;8572.099929507436;8591.828163436696;8741.912580874237;8761.430507017023;594.2898236607213;654.8853950558633;657.4707360574688;661.6691654172913;663.4460225711489;3956.8812935611977;4210.15796840627;4367.912641747147;4393.802278897458;4471.552844715502;52455.73772131191;56789;56866.715666421405;56928.43071569231;56974.71512642493;49124.75437622789;50272.74863625732;50508;50730.49269507331;50973;43668.563314367086;44388.112237755064;44431.77784111059;45253.32120018202;45547.54452455499;8415.621297041771;8598.527081010605;8629.913700862911;8639.042054561827;8861.601227944888;32723.181920452178;33290.5006424899;33362;33538.32923341568;33604.663953360156;38739;39832.40251396174;40540.1891962165;40596.79701601473;43374.34938475989;10901.781964360827;10909;10931.61739339151;10985.560577576807;11425.428728563373;12203.267803931793;12513.562025329069;12549.372531373578;12984.545540906023;13115.08194426381;11244.831327530257;11277.32336059839;11363.034142098015;11758.647240582795;11997.76004479888;11057.170712196457;11186.608468703556;11399.259048161843;11545.538178472767;11665.475053622777;10734.946325268324;10801.351918884891;11107.44462776874;11158;11230.438478075901;9862.852057219005;10035.19718422539;10289.588416463257;10406;10528.684139475828;8370.455920365157;8687.218150366498;9050.411723237969;9304.58129384193;9729.221662267144 19:06:50 INFO - PROCESS | 14790 | __end_tp_report 19:06:50 INFO - PROCESS | 14790 | __start_cc_report 19:06:50 INFO - PROCESS | 14790 | _x_x_mozilla_cycle_collect,1063 19:06:50 INFO - PROCESS | 14790 | __end_cc_report 19:06:50 INFO - PROCESS | 14790 | __startTimestamp1451185610410__endTimestamp 19:06:50 INFO - PROCESS | 14790 | 19:06:50 INFO - PROCESS | 14790 | ------- Summary: start ------- 19:06:50 INFO - PROCESS | 14790 | Number of tests: 6 19:06:50 INFO - PROCESS | 14790 | 19:06:50 INFO - PROCESS | 14790 | [#0] dojo.html Cycles:165 Average:5202.85 Median:5419.86 stddev:561.68 (10.4%) stddev-sans-first:539.36 19:06:50 INFO - PROCESS | 14790 | Values: 3130.3 3172.0 3204.1 3210.5 3238.2 5109.4 5226.4 5226.7 5238.5 5266.8 5183.7 5186.4 5269.0 5273.1 5295.4 4739.2 4791.5 4810.8 4813.7 4868.1 4714.6 4801.7 4827.5 4863.6 4920.4 4729.7 4749.1 4783.6 4809.6 4825.7 4747.9 4748.5 4751.7 4762.9 4789.6 4690.7 4706.4 4708.2 4736.4 4754.3 4981.3 5045.8 5066.7 5116.5 5148.0 5605.1 5605.4 5610.8 5615.1 5615.2 5461.2 5613.8 5629.2 5654.7 5658.3 5226.1 5283.1 5363.3 5372.5 5374.0 5712.5 5712.9 5720.2 5760.3 5769.5 5513.1 5513.6 5516.3 5517.1 5518.5 5475.4 5495.8 5587.4 5589.8 5702.7 5569.7 5578.5 5602.6 5607.7 5610.0 5576.8 5577.2 5578.9 5579.2 5582.6 4223.2 4286.7 4311.1 4392.0 4404.2 3843.7 3844.5 3868.1 3880.0 3881.8 5186.2 5208.1 5208.7 5215.7 5216.4 5508.8 5548.2 5593.6 5607.1 5609.4 5230.7 5239.6 5240.5 5240.8 5282.2 4856.4 4871.9 4872.2 4877.9 4920.1 5660.9 5727.1 5752.6 5758.1 5799.4 5618.4 5644.4 5656.8 5658.7 5698.3 5757.4 5789.2 5790.3 5790.5 5791.9 5419.9 5483.3 5500.0 5509.2 5520.8 5551.9 5588.4 5617.3 5618.5 5621.2 5414.2 5454.7 5486.3 5495.1 5513.0 5448.5 5464.6 5465.6 5468.1 5469.8 5260.2 5375.1 5385.5 5390.1 5437.9 5394.2 5443.3 5472.4 5498.4 5518.3 5378.6 5435.0 5435.1 5439.6 5442.0 19:06:50 INFO - PROCESS | 14790 | 19:06:50 INFO - PROCESS | 14790 | [#1] ext.html Cycles:180 Average:42182.19 Median:30914.07 stddev:68441.33 (221.4%) stddev-sans-first:68562.04 19:06:50 INFO - PROCESS | 14790 | Values: 577.6 594.5 597.6 605.2 610.2 27633.2 37549.1 38260.4 38343.0 38353.2 40567.6 41059.2 41079.4 41109.6 41140.2 7295.4 8658.9 8818.9 8828.6 8829.0 7157.7 10062.0 10234.2 10241.1 10241.7 9977.2 10049.3 10101.9 10122.2 10128.6 7477.6 7626.8 9981.6 10084.1 10103.8 10062.3 10238.3 10238.4 10239.8 10242.6 35523.8 35708.8 35810.6 35829.6 35925.0 2889.4 3062.0 3112.0 3429.2 3720.8 27296.5 27304.6 28000.0 29372.0 29576.9 3975.3 3994.6 4001.9 4018.1 4100.1 183907.0 184601.1 184895.0 184919.0 184942.1 55534.0 55801.4 56121.4 56167.7 56340.4 53124.5 53879.5 58383.4 58545.4 59753.4 14573.2 14840.1 14930.3 14977.6 14984.4 11442.2 11497.8 11520.5 11529.3 11539.2 17961.4 17982.7 18215.3 18532.0 18660.3 7196.9 7422.3 7465.5 7507.5 7569.2 949.8 955.7 989.3 1046.0 1076.5 27557.9 27656.3 27680.9 27944.0 28144.0 975.7 1004.4 1033.3 1034.8 1045.9 14202.2 14522.8 14629.4 14725.3 14740.5 294490.0 297145.0 299020.0 299052.0 299372.0 50605.2 50745.5 50842.7 50882.5 50931.2 1326.0 1337.9 1349.2 1351.5 1357.5 26215.3 27137.2 27172.5 27263.2 27413.9 43874.0 44036.0 44268.0 44409.0 44418.0 286611.0 288376.0 288570.0 288689.0 288932.0 26974.7 27498.9 30634.8 31195.1 31784.8 36178.5 36641.0 36820.8 37004.8 37566.0 31590.2 31671.9 31970.8 32094.8 32578.5 28228.2 32527.8 33542.2 34736.3 35065.8 31446.4 31620.4 34791.0 35112.3 35250.8 27006.7 28982.5 30849.9 30978.2 31495.4 23857.5 23935.4 24123.3 24380.6 24513.3 19:06:50 INFO - PROCESS | 14790 | 19:06:50 INFO - PROCESS | 14790 | [#2] jquery.html Cycles:180 Average:27471.10 Median:33796.66 stddev:75556.45 (223.6%) stddev-sans-first:75740.97 19:06:50 INFO - PROCESS | 14790 | Values: 352.6 357.6 357.8 359.6 360.5 13763.4 14095.9 15674.8 15676.8 16329.6 16249.9 16706.9 17355.3 17636.3 17643.5 5300.3 5407.3 5410.4 5418.9 5421.6 3965.4 4082.4 5378.8 5875.4 5986.8 5907.5 5928.0 5936.2 5951.0 5963.4 5751.0 5876.8 5884.5 5893.4 5906.1 5202.6 5209.8 5210.7 5214.5 5221.7 21320.4 22115.1 22506.7 23093.2 23456.4 2278.6 2299.3 2358.7 2461.3 2482.8 13911.9 14322.8 14419.6 14673.9 14902.8 2007.1 2087.1 2105.7 2144.4 2189.5 67477.3 70350.0 71909.0 72770.3 72851.6 15282.5 15378.5 15406.7 15411.4 15514.8 24343.5 24359.3 24548.8 24653.8 24678.3 8532.3 8639.4 8643.0 8677.6 8687.4 7223.6 7236.2 7238.3 7268.8 7293.4 7611.8 7790.0 7796.0 7859.9 7888.2 2634.4 2969.2 2980.7 3080.2 3103.8 842.6 919.6 974.6 1014.2 1041.3 16741.7 17118.2 17230.2 17322.9 17379.9 872.2 903.6 937.4 955.0 976.2 9507.7 9535.0 9686.0 9732.5 9869.5 388313.0 393915.0 489809.0 495411.0 523941.0 41420.4 81638.6 82361.6 84115.0 88426.6 1085.5 1104.1 1107.9 1111.3 1124.6 12614.2 14649.6 14943.0 15283.6 15651.4 32650.0 33249.8 34343.5 36228.3 37091.4 41037.8 41170.4 41291.6 41331.6 41920.6 9300.5 9327.0 9464.4 9535.2 9552.8 17024.8 17030.8 17232.9 17534.6 17598.5 14080.2 14334.6 14483.5 14860.6 14920.5 13115.8 14534.6 14828.5 15079.0 15161.0 14418.7 14841.9 14981.0 15212.7 15551.9 9769.6 9939.3 9960.5 10003.0 10036.5 14430.5 14577.4 14623.9 14851.6 15247.2 19:06:50 INFO - PROCESS | 14790 | 19:06:50 INFO - PROCESS | 14790 | [#3] mootools.html Cycles:180 Average:5023.65 Median:6046.74 stddev:2537.77 (42.0%) stddev-sans-first:2529.03 19:06:50 INFO - PROCESS | 14790 | Values: 1250.0 1379.5 1429.9 1549.4 1758.3 6319.6 6927.4 7035.0 7036.5 7049.5 6958.3 7134.6 7138.5 7143.6 7144.8 1884.1 1911.7 1911.8 2151.3 2181.2 2214.8 2239.5 2256.2 2259.3 2259.8 2142.6 2174.9 2186.8 2187.3 2188.8 2132.9 2144.6 2159.1 2172.3 2214.2 2230.3 2237.5 2253.3 2257.9 2272.6 6966.2 7022.5 7026.8 7029.9 7038.3 4412.7 4416.7 4478.1 4478.9 4479.1 2930.9 2960.7 3001.8 3023.3 3045.6 999.6 1014.9 1034.5 1051.1 1056.1 9868.1 9872.3 9876.9 9883.1 9887.2 4004.3 4066.9 4080.8 4090.3 4121.7 8524.3 8526.2 8526.4 8527.6 8531.3 4371.5 4395.2 4402.6 4404.2 4407.9 4007.1 4014.2 4015.7 4016.8 4020.6 3139.6 3178.8 3467.3 3469.6 3541.9 1120.8 1128.8 1129.4 1137.9 1153.6 991.9 1001.2 1010.8 1103.9 1292.3 6553.4 6651.0 6657.1 6692.9 6707.6 1086.1 1093.6 1097.1 1118.4 1132.7 5210.8 5313.1 5317.9 5319.0 5321.1 8330.2 8381.3 8487.9 8583.8 8598.1 8450.7 8456.0 8460.5 8482.7 8531.1 6598.9 6718.6 6790.7 6811.8 6832.7 6385.7 6391.3 6419.6 6427.3 6431.8 7407.4 7576.9 7595.7 7661.8 7685.7 7652.4 7816.3 7845.7 7918.0 7974.8 6143.8 6197.5 6229.2 6242.0 6245.0 6780.8 6821.0 6855.3 6897.2 6910.3 6408.6 6451.7 6519.6 6538.4 6593.1 6265.3 6357.9 6381.6 6424.4 6469.7 6248.1 6269.0 6299.2 6310.1 6313.8 5747.1 5775.4 5782.4 5795.4 5796.5 5889.4 5907.9 6046.3 6047.2 6061.7 19:06:50 INFO - PROCESS | 14790 | 19:06:50 INFO - PROCESS | 14790 | [#4] prototype.html Cycles:180 Average:5371.23 Median:6080.60 stddev:1625.31 (26.7%) stddev-sans-first:1585.34 19:06:50 INFO - PROCESS | 14790 | Values: 337.2 341.9 343.6 344.7 352.0 6051.8 6063.3 6094.9 6108.5 6133.1 5760.7 5812.6 5917.6 5992.8 6029.3 4641.0 4660.6 4672.1 4674.1 4684.8 4391.3 4670.5 4671.5 4672.8 4675.4 4409.7 4489.9 4578.7 4590.0 4624.2 4570.3 4584.7 4595.3 4598.5 4621.6 4060.9 4064.1 4065.1 4065.9 4075.5 5644.0 5749.6 5754.5 5757.7 5757.7 5324.7 5325.5 5328.9 5333.9 5334.1 6364.9 6393.4 6405.3 6408.8 6417.0 4446.7 4451.5 4455.0 4455.4 4456.5 6545.0 6612.6 6674.9 6679.6 6679.7 4523.2 4527.6 4529.2 4529.5 4530.2 4584.9 4585.9 4586.4 4590.6 4591.3 5308.6 5308.8 5309.0 5309.7 5318.5 6258.4 6417.1 6421.7 6429.9 6434.0 1595.8 1620.1 1621.4 1623.3 1624.0 1053.8 1075.8 1082.5 1093.9 1098.4 6077.1 6077.5 6083.8 6087.4 6090.6 6421.3 6593.2 6595.4 6599.7 6602.4 5958.5 6033.8 6133.6 6134.7 6134.8 3564.5 3615.8 3616.7 3618.5 3619.9 6771.3 6899.3 6911.1 6915.9 6916.7 6821.6 6828.7 6831.3 6841.4 6841.9 6918.9 6919.9 6921.1 6924.6 6929.9 6554.6 6684.8 6686.0 6689.5 6695.1 6559.4 6565.1 6567.1 6568.8 6572.0 6895.2 6900.1 6900.2 6920.7 6921.6 4452.2 4565.0 4566.9 4567.1 4568.6 6643.3 6677.6 6693.4 6694.3 6713.5 6493.3 6493.7 6494.6 6500.4 6503.4 6371.9 6477.6 6481.7 6482.8 6490.0 6351.8 6361.3 6362.4 6363.4 6363.5 6483.5 6487.7 6522.1 6528.5 6537.3 6150.5 6349.4 6351.4 6353.3 6356.6 19:06:50 INFO - PROCESS | 14790 | 19:06:50 INFO - PROCESS | 14790 | [#5] yui.html Cycles:180 Average:13398.81 Median:24130.40 stddev:15136.18 (62.7%) stddev-sans-first:15148.65 19:06:50 INFO - PROCESS | 14790 | Values: 712.2 741.7 750.4 800.3 822.9 13687.3 13891.4 13901.4 13918.7 13939.8 12605.9 12930.7 12932.1 12933.5 12953.7 664.6 811.8 824.2 825.1 825.4 670.3 821.6 833.5 834.0 834.1 847.5 857.3 859.8 860.2 861.2 697.8 703.6 856.7 857.2 860.4 636.6 638.8 641.1 641.3 642.3 12443.8 12461.3 12518.4 12549.0 12638.7 11733.5 11746.0 11982.9 12288.1 12482.2 9814.1 10118.3 10203.0 10308.6 10456.9 3693.6 3699.0 3709.1 3768.4 3834.6 43339.3 43402.3 43867.0 43987.3 44126.3 10119.6 10132.3 10146.2 10174.8 10359.1 18043.8 18055.5 18064.5 18076.5 18088.9 7782.8 7855.7 7952.0 8025.4 8028.5 4298.4 4467.4 4472.8 4519.7 4556.8 2981.8 2995.1 2999.4 3005.6 3007.1 527.7 532.4 541.1 542.7 546.9 618.8 657.5 673.9 692.6 699.5 8172.8 8572.1 8591.8 8741.9 8761.4 594.3 654.9 657.5 661.7 663.4 3956.9 4210.2 4367.9 4393.8 4471.6 52455.7 56789.0 56866.7 56928.4 56974.7 49124.8 50272.7 50508.0 50730.5 50973.0 43668.6 44388.1 44431.8 45253.3 45547.5 8415.6 8598.5 8629.9 8639.0 8861.6 32723.2 33290.5 33362.0 33538.3 33604.7 38739.0 39832.4 40540.2 40596.8 43374.3 10901.8 10909.0 10931.6 10985.6 11425.4 12203.3 12513.6 12549.4 12984.5 13115.1 11244.8 11277.3 11363.0 11758.6 11997.8 11057.2 11186.6 11399.3 11545.5 11665.5 10734.9 10801.4 11107.4 11158.0 11230.4 9862.9 10035.2 10289.6 10406.0 10528.7 8370.5 8687.2 9050.4 9304.6 9729.2 19:06:50 INFO - PROCESS | 14790 | -------- Summary: end -------- 19:06:50 INFO - PROCESS | 14790 | 19:06:51 INFO - TEST-INFO | 14790: exit 0 19:06:51 INFO - TEST-OK | dromaeo_css | took 1112201ms 19:06:51 INFO - TEST-START | kraken 19:06:51 INFO - operating with platform_type : linux_ 19:06:51 INFO - Initialising browser for kraken test... 19:06:51 INFO - TEST-INFO | started process 14973 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp825KFg/profile http://localhost:58220/getInfo.html) 19:06:55 INFO - PROCESS | 14973 | __metrics Screen width/height:1600/1200 19:06:55 INFO - PROCESS | 14973 | colorDepth:24 19:06:55 INFO - PROCESS | 14973 | Browser inner width/height: 1024/697 19:06:55 INFO - PROCESS | 14973 | __metrics 19:06:55 INFO - PROCESS | 14973 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:06:55 INFO - PROCESS | 14973 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:06:56 INFO - TEST-INFO | 14973: exit 0 19:06:56 INFO - Browser initialized. 19:06:56 INFO - Running cycle 1/1 for kraken test... 19:06:56 INFO - TEST-INFO | started process 15055 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp825KFg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:07 INFO - PROCESS | 15055 | RSS: Main: 148238336 19:07:07 INFO - PROCESS | 15055 | 19:07:10 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58220/tests/kraken/driver.html?testName=audio-beat-detection) 19:07:11 INFO - PROCESS | 15055 | RSS: Main: 184246272 19:07:11 INFO - PROCESS | 15055 | 19:07:13 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58220/tests/kraken/driver.html?testName=audio-dft) 19:07:14 INFO - PROCESS | 15055 | RSS: Main: 173187072 19:07:14 INFO - PROCESS | 15055 | 19:07:17 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58220/tests/kraken/driver.html?testName=audio-fft) 19:07:17 INFO - PROCESS | 15055 | RSS: Main: 159629312 19:07:17 INFO - PROCESS | 15055 | 19:07:19 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58220/tests/kraken/driver.html?testName=audio-oscillator) 19:07:20 INFO - PROCESS | 15055 | RSS: Main: 162746368 19:07:20 INFO - PROCESS | 15055 | 19:07:22 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58220/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:07:23 INFO - PROCESS | 15055 | RSS: Main: 164585472 19:07:23 INFO - PROCESS | 15055 | 19:07:25 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58220/tests/kraken/driver.html?testName=imaging-darkroom) 19:07:26 INFO - PROCESS | 15055 | RSS: Main: 165052416 19:07:26 INFO - PROCESS | 15055 | 19:07:29 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58220/tests/kraken/driver.html?testName=imaging-desaturate) 19:07:30 INFO - PROCESS | 15055 | RSS: Main: 164933632 19:07:30 INFO - PROCESS | 15055 | 19:07:33 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58220/tests/kraken/driver.html?testName=json-parse-financial) 19:07:33 INFO - PROCESS | 15055 | RSS: Main: 163913728 19:07:33 INFO - PROCESS | 15055 | 19:07:35 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58220/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:07:35 INFO - PROCESS | 15055 | RSS: Main: 178610176 19:07:35 INFO - PROCESS | 15055 | 19:07:37 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58220/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:07:38 INFO - PROCESS | 15055 | RSS: Main: 176537600 19:07:38 INFO - PROCESS | 15055 | 19:07:40 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58220/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:07:40 INFO - PROCESS | 15055 | RSS: Main: 188809216 19:07:40 INFO - PROCESS | 15055 | 19:07:43 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:07:43 INFO - PROCESS | 15055 | RSS: Main: 192643072 19:07:43 INFO - PROCESS | 15055 | 19:07:46 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:07:47 INFO - PROCESS | 15055 | RSS: Main: 192106496 19:07:47 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | Cycle 1(1): loaded http://localhost:58220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58220/tests/kraken/driver.html?testName=ai-astar) 19:07:48 INFO - PROCESS | 15055 | RSS: Main: 250150912 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | __start_tp_report 19:07:48 INFO - PROCESS | 15055 | _x_x_mozilla_page_load 19:07:48 INFO - PROCESS | 15055 | _x_x_mozilla_page_load_details 19:07:48 INFO - PROCESS | 15055 | |i|pagename|runs| 19:07:48 INFO - PROCESS | 15055 | |0;ai-astar;109;111;108;112;118;111;100;112;110;102 19:07:48 INFO - PROCESS | 15055 | |1;audio-beat-detection;153;123;146;164;124;152;150;128;169;124 19:07:48 INFO - PROCESS | 15055 | |2;audio-dft;162;159;160;160;162;161;167;161;160;161 19:07:48 INFO - PROCESS | 15055 | |3;audio-fft;72;71;81;91;71;73;73;111;95;70 19:07:48 INFO - PROCESS | 15055 | |4;audio-oscillator;96;96;139;95;96;97;141;96;103;139 19:07:48 INFO - PROCESS | 15055 | |5;imaging-gaussian-blur;109;109;109;109;109;110;109;109;110;110 19:07:48 INFO - PROCESS | 15055 | |6;imaging-darkroom;146;145;145;145;146;146;145;146;145;145 19:07:48 INFO - PROCESS | 15055 | |7;imaging-desaturate;96;96;95;96;96;95;96;96;96;95 19:07:48 INFO - PROCESS | 15055 | |8;json-parse-financial;60;60;58;58;58;57;58;66;55;56 19:07:48 INFO - PROCESS | 15055 | |9;json-stringify-tinderbox;67;68;67;67;69;69;68;67;68;67 19:07:48 INFO - PROCESS | 15055 | |10;stanford-crypto-aes;85;84;85;85;85;85;86;86;85;87 19:07:48 INFO - PROCESS | 15055 | |11;stanford-crypto-ccm;122;121;118;115;130;115;126;129;122;119 19:07:48 INFO - PROCESS | 15055 | |12;stanford-crypto-pbkdf2;138;149;154;148;155;141;143;156;151;143 19:07:48 INFO - PROCESS | 15055 | |13;stanford-crypto-sha256-iterative;66;66;66;69;67;67;66;68;66;66 19:07:48 INFO - PROCESS | 15055 | __end_tp_report 19:07:48 INFO - PROCESS | 15055 | __start_cc_report 19:07:48 INFO - PROCESS | 15055 | _x_x_mozilla_cycle_collect,923 19:07:48 INFO - PROCESS | 15055 | __end_cc_report 19:07:48 INFO - PROCESS | 15055 | __startTimestamp1451185668971__endTimestamp 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | ------- Summary: start ------- 19:07:48 INFO - PROCESS | 15055 | Number of tests: 14 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:5.14 (4.6%) stddev-sans-first:5.45 19:07:48 INFO - PROCESS | 15055 | Values: 109.0 111.0 108.0 112.0 118.0 111.0 100.0 112.0 110.0 102.0 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:151.00 stddev:17.33 (11.5%) stddev-sans-first:18.02 19:07:48 INFO - PROCESS | 15055 | Values: 153.0 123.0 146.0 164.0 124.0 152.0 150.0 128.0 169.0 124.0 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:2.21 (1.4%) stddev-sans-first:2.33 19:07:48 INFO - PROCESS | 15055 | Values: 162.0 159.0 160.0 160.0 162.0 161.0 167.0 161.0 160.0 161.0 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#3] audio-fft Cycles:10 Average:80.80 Median:73.00 stddev:13.85 (19.0%) stddev-sans-first:14.32 19:07:48 INFO - PROCESS | 15055 | Values: 72.0 71.0 81.0 91.0 71.0 73.0 73.0 111.0 95.0 70.0 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:96.00 stddev:20.74 (21.6%) stddev-sans-first:21.38 19:07:48 INFO - PROCESS | 15055 | Values: 96.0 96.0 139.0 95.0 96.0 97.0 141.0 96.0 103.0 139.0 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:07:48 INFO - PROCESS | 15055 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 110.0 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:07:48 INFO - PROCESS | 15055 | Values: 146.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:07:48 INFO - PROCESS | 15055 | Values: 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.00 stddev:3.03 (5.2%) stddev-sans-first:3.17 19:07:48 INFO - PROCESS | 15055 | Values: 60.0 60.0 58.0 58.0 58.0 57.0 58.0 66.0 55.0 56.0 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 19:07:48 INFO - PROCESS | 15055 | Values: 67.0 68.0 67.0 67.0 69.0 69.0 68.0 67.0 68.0 67.0 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 19:07:48 INFO - PROCESS | 15055 | Values: 85.0 84.0 85.0 85.0 85.0 85.0 86.0 86.0 85.0 87.0 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:122.00 stddev:5.29 (4.3%) stddev-sans-first:5.61 19:07:48 INFO - PROCESS | 15055 | Values: 122.0 121.0 118.0 115.0 130.0 115.0 126.0 129.0 122.0 119.0 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:150.00 stddev:6.30 (4.2%) stddev-sans-first:5.60 19:07:48 INFO - PROCESS | 15055 | Values: 138.0 149.0 154.0 148.0 155.0 141.0 143.0 156.0 151.0 143.0 19:07:48 INFO - PROCESS | 15055 | 19:07:48 INFO - PROCESS | 15055 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:1.06 (1.6%) stddev-sans-first:1.09 19:07:48 INFO - PROCESS | 15055 | Values: 66.0 66.0 66.0 69.0 67.0 67.0 66.0 68.0 66.0 66.0 19:07:48 INFO - PROCESS | 15055 | -------- Summary: end -------- 19:07:48 INFO - PROCESS | 15055 | 19:07:49 INFO - TEST-INFO | 15055: exit 0 19:07:49 INFO - TEST-OK | kraken | took 58703ms 19:07:49 INFO - TEST-START | v8_7 19:07:49 INFO - operating with platform_type : linux_ 19:07:49 INFO - Initialising browser for v8_7 test... 19:07:49 INFO - TEST-INFO | started process 15304 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKH7ikj/profile http://localhost:58220/getInfo.html) 19:07:53 INFO - PROCESS | 15304 | __metrics Screen width/height:1600/1200 19:07:53 INFO - PROCESS | 15304 | colorDepth:24 19:07:53 INFO - PROCESS | 15304 | Browser inner width/height: 1024/697 19:07:53 INFO - PROCESS | 15304 | __metrics 19:07:53 INFO - PROCESS | 15304 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:07:53 INFO - PROCESS | 15304 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:07:54 INFO - TEST-INFO | 15304: exit 0 19:07:54 INFO - Browser initialized. 19:07:54 INFO - Running cycle 1/1 for v8_7 test... 19:07:54 INFO - TEST-INFO | started process 15385 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKH7ikj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:06 INFO - PROCESS | 15385 | RSS: Main: 148189184 19:08:06 INFO - PROCESS | 15385 | 19:08:28 INFO - PROCESS | 15385 | Cycle 1(1): loaded http://localhost:58220/tests/v8_7/run.html (next: http://localhost:58220/tests/v8_7/run.html) 19:08:28 INFO - PROCESS | 15385 | RSS: Main: 544145408 19:08:28 INFO - PROCESS | 15385 | 19:08:28 INFO - PROCESS | 15385 | __start_tp_report 19:08:28 INFO - PROCESS | 15385 | _x_x_mozilla_page_load 19:08:28 INFO - PROCESS | 15385 | _x_x_mozilla_page_load_details 19:08:28 INFO - PROCESS | 15385 | |i|pagename|runs| 19:08:28 INFO - PROCESS | 15385 | |0;Richards;167.897918065816 19:08:28 INFO - PROCESS | 15385 | |1;DeltaBlue;191.90174630589138 19:08:28 INFO - PROCESS | 15385 | |2;Encrypt;280.8199943836001 19:08:28 INFO - PROCESS | 15385 | |3;Decrypt;5170.103092783505 19:08:28 INFO - PROCESS | 15385 | |4;RayTrace;1106.1946902654868 19:08:28 INFO - PROCESS | 15385 | |5;Earley;809.0614886731391 19:08:28 INFO - PROCESS | 15385 | |6;Boyer;12407.407407407407 19:08:28 INFO - PROCESS | 15385 | |7;RegExp;25794.871794871793 19:08:28 INFO - PROCESS | 15385 | |8;Splay;594.1770647653001 19:08:28 INFO - PROCESS | 15385 | |9;NavierStokes;4830.917874396136 19:08:28 INFO - PROCESS | 15385 | __end_tp_report 19:08:28 INFO - PROCESS | 15385 | __startTimestamp1451185708277__endTimestamp 19:08:28 INFO - PROCESS | 15385 | 19:08:28 INFO - PROCESS | 15385 | ------- Summary: start ------- 19:08:28 INFO - PROCESS | 15385 | Number of tests: 10 19:08:28 INFO - PROCESS | 15385 | 19:08:28 INFO - PROCESS | 15385 | [#0] Richards Cycles:1 Average:167.90 Median:167.90 stddev:0.00 (0.0%) 19:08:28 INFO - PROCESS | 15385 | Values: 167.9 19:08:28 INFO - PROCESS | 15385 | 19:08:28 INFO - PROCESS | 15385 | [#1] DeltaBlue Cycles:1 Average:191.90 Median:191.90 stddev:0.00 (0.0%) 19:08:28 INFO - PROCESS | 15385 | Values: 191.9 19:08:28 INFO - PROCESS | 15385 | 19:08:28 INFO - PROCESS | 15385 | [#2] Encrypt Cycles:1 Average:280.82 Median:280.82 stddev:0.00 (0.0%) 19:08:28 INFO - PROCESS | 15385 | Values: 280.8 19:08:28 INFO - PROCESS | 15385 | 19:08:28 INFO - PROCESS | 15385 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 19:08:28 INFO - PROCESS | 15385 | Values: 5170.1 19:08:28 INFO - PROCESS | 15385 | 19:08:28 INFO - PROCESS | 15385 | [#4] RayTrace Cycles:1 Average:1106.19 Median:1106.19 stddev:0.00 (0.0%) 19:08:28 INFO - PROCESS | 15385 | Values: 1106.2 19:08:28 INFO - PROCESS | 15385 | 19:08:28 INFO - PROCESS | 15385 | [#5] Earley Cycles:1 Average:809.06 Median:809.06 stddev:0.00 (0.0%) 19:08:28 INFO - PROCESS | 15385 | Values: 809.1 19:08:28 INFO - PROCESS | 15385 | 19:08:28 INFO - PROCESS | 15385 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 19:08:28 INFO - PROCESS | 15385 | Values: 12407.4 19:08:28 INFO - PROCESS | 15385 | 19:08:28 INFO - PROCESS | 15385 | [#7] RegExp Cycles:1 Average:25794.87 Median:25794.87 stddev:0.00 (0.0%) 19:08:28 INFO - PROCESS | 15385 | Values: 25794.9 19:08:28 INFO - PROCESS | 15385 | 19:08:28 INFO - PROCESS | 15385 | [#8] Splay Cycles:1 Average:594.18 Median:594.18 stddev:0.00 (0.0%) 19:08:28 INFO - PROCESS | 15385 | Values: 594.2 19:08:28 INFO - PROCESS | 15385 | 19:08:28 INFO - PROCESS | 15385 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 19:08:28 INFO - PROCESS | 15385 | Values: 4830.9 19:08:28 INFO - PROCESS | 15385 | -------- Summary: end -------- 19:08:28 INFO - PROCESS | 15385 | 19:08:29 INFO - TEST-INFO | 15385: exit 0 19:08:29 INFO - TEST-OK | v8_7 | took 39334ms 19:08:29 INFO - SUITE-END | took 1210s 19:08:29 INFO - Completed test suite (00:20:10) 19:08:29 INFO - Working with test: dromaeo_css 19:08:29 INFO - Generating results file: dromaeo_css 19:08:29 INFO - Working with test: kraken 19:08:29 INFO - Generating results file: kraken 19:08:29 INFO - javascript benchmark 19:08:29 INFO - Working with test: v8_7 19:08:29 INFO - Generating results file: v8_7 19:08:29 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:08:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 19:08:29 INFO - process_Request line: dromaeo_css 6941.05 graph.html#tests=[[72,63,35]] 19:08:29 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:08:29 INFO - process_Request line: kraken 1502.70 graph.html#tests=[[232,63,35]] 19:08:29 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:08:29 INFO - process_Request line: v8_7 20939.20 graph.html#tests=[[230,63,35]] 19:08:29 INFO - RETURN: dromaeo_css: 6941.05 19:08:29 INFO - RETURN: kraken: 1502.70 19:08:29 INFO - RETURN: v8_7: 20939.20 19:08:29 INFO - javascript benchmark 19:08:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3130.264387868851, 3172.0, 3204.0868352519537, 3210.4542227821266, 3238.158078899486, 5109.4379618241965, 5226.425093239741, 5226.738663066846, 5238.52853243208, 5266.789328426863, 5183.663061900974, 5186.351706036746, 5268.973655131728, 5273.129933560967, 5295.417504074549, 4739.170645137105, 4791.472937976829, 4810.807567697306, 4813.711177329354, 4868.05073010763, 4714.599259062984, 4801.663883528155, 4827.493113223114, 4863.635227357945, 4920.409550853885, 4729.692569982957, 4749.073930583538, 4783.569478746929, 4809.591184749301, 4825.734584597846, 4747.928781068286, 4748.477667456577, 4751.714897106184, 4762.928556071662, 4789.592884604813, 4690.671652984292, 4706.411698537683, 4708.223143181371, 4736.431628204603, 4754.286856971447, 4981.27771473138, 5045.823396181153, 5066.746662666852, 5116.539511443988, 5148.021875843578, 5605.075162598167, 5605.439456054402, 5610.775568977236, 5615.101583746622, 5615.241942337773, 5461.15352120422, 5613.80351687693, 5629.155626656035, 5654.717264136777, 5658.34928983164, 5226.085435048852, 5283.128283833163, 5363.329583802025, 5372.462753724635, 5373.9731301343245, 5712.514436272963, 5712.885742285131, 5720.227769251181, 5760.251167348218, 5769.480746732815, 5513.145462453326, 5513.58648101394, 5516.282883225155, 5517.1172612382625, 5518.503334699896, 5475.4250803665045, 5495.780168793203, 5587.413321601254, 5589.832305030855, 5702.6863522506665, 5569.721513924287, 5578.497935185772, 5602.579806514527, 5607.691576963224, 5610.046292130348, 5576.776928922879, 5577.191307260506, 5578.888422231533, 5579.191017302468, 5582.581306402036, 4223.239816832999, 4286.678499112579, 4311.137772445523, 4392.033752574429, 4404.207242696345, 3843.6925045996254, 3844.461775351453, 3868.1490072184074, 3879.980600097038, 3881.8253178606465, 5186.170212766015, 5208.062548741263, 5208.687478751287, 5215.713135777569, 5216.426193118754, 5508.779648814003, 5548.195511650788, 5593.580481463907, 5607.074832652566, 5609.382967873531, 5230.712310822942, 5239.554637855748, 5240.4759524047295, 5240.764165612557, 5282.181261904411, 4856.368672072608, 4871.902561948741, 4872.220444728827, 4877.878053048702, 4920.138975679313, 5660.943390566042, 5727.083666613322, 5752.568557358215, 5758.1362795581, 5799.420057994167, 5618.438156184349, 5644.407337229696, 5656.8020119295625, 5658.660480371191, 5698.287714035746, 5757.366689664217, 5789.247397838254, 5790.276215473066, 5790.536757059509, 5791.942080579309, 5419.864503387447, 5483.314585676791, 5500.037493438552, 5509.173623956439, 5520.779168833202, 5551.916721249266, 5588.385277619377, 5617.32592088952, 5618.494335509824, 5621.213030175697, 5414.242006119068, 5454.727263636882, 5486.259354987025, 5495.093309604031, 5513.035218836768, 5448.482394172547, 5464.617476776746, 5465.59008074388, 5468.0977638690765, 5469.781208751764, 5260.158374660036, 5375.1131063374105, 5385.515303622693, 5390.137577987503, 5437.918431223614, 5394.163904594794, 5443.265159203615, 5472.370677372153, 5498.422665620053, 5518.2826232589505, 5378.5966052547, 5435.0, 5435.130379139318, 5439.5920305976415, 5441.972790136024], "unit": "score", "name": "dojo.html", "value": 5167.495516413207}, {"lowerIsBetter": false, "replicates": [577.5610535992645, 594.4709208804162, 597.5667640960304, 605.1527860994607, 610.1640752169528, 27633.171004869862, 37549.06127346818, 38260.42609360862, 38343.0, 38353.23293534131, 40567.59432405675, 41059.17881642366, 41079.38380924281, 41109.58890411095, 41140.177196456054, 7295.416366690679, 8658.870116948236, 8818.911810881873, 8828.602712877904, 8828.955855220715, 7157.749478768244, 10062.0, 10234.181265498779, 10241.078302952732, 10241.692749217535, 9977.151942084894, 10049.346792458467, 10101.949490252538, 10122.240831937597, 10128.645497407591, 7477.551346919202, 7626.809329766745, 9981.600735970589, 10084.09243168111, 10103.797924041552, 10062.295639305252, 10238.33450825694, 10238.385696858213, 10239.795204095877, 10242.641507547274, 35523.82238088819, 35708.821455892554, 35810.64189358099, 35829.64170358289, 35925.0, 2889.436559870826, 3062.0, 3111.9533207001914, 3429.176997520602, 3720.8426643413454, 27296.45407091867, 27304.590431143548, 28000.0, 29372.0, 29576.852115739497, 3975.284448799215, 3994.560598334181, 4001.8599349022643, 4018.095928416083, 4100.118474527991, 183907.0, 184601.07699461418, 184895.0, 184919.0, 184942.07528962404, 55534.0, 55801.44198557962, 56121.43878561162, 56167.71916140393, 56340.43659563434, 53124.46875531272, 53879.46120538823, 58383.41616583865, 58545.414545854845, 59753.40246597478, 14573.198474083814, 14840.10959342443, 14930.25348732559, 14977.625559361104, 14984.40062397492, 11442.199046066695, 11497.770044599061, 11520.53917843277, 11529.250598711056, 11539.249948753471, 17961.371352002618, 17982.730259046126, 18215.271389144287, 18531.98074105937, 18660.34688785886, 7196.928030719626, 7422.331990120915, 7465.477416580788, 7507.471488400443, 7569.205233450409, 949.7578117579973, 955.694177863091, 989.3223142147652, 1045.984310235347, 1076.4886678827652, 27557.862210689218, 27656.308592284953, 27680.86159569189, 27944.0, 28144.0, 975.6682727872558, 1004.4324956399611, 1033.3180101133366, 1034.7852374604163, 1045.895410458948, 14202.218877961812, 14522.782158267635, 14629.414823407158, 14725.337359818619, 14740.484083057041, 294490.0, 297145.0, 299020.0, 299052.0, 299372.0, 50605.24092138621, 50745.49254507481, 50842.74578627083, 50882.49117508777, 50931.23603145956, 1326.0, 1337.9464821407034, 1349.1770020287618, 1351.5472316773794, 1357.4570171931307, 26215.344616384744, 27137.192308651836, 27172.45655086927, 27263.182104536896, 27413.862930686017, 43874.0, 44036.0, 44268.0, 44409.0, 44418.0, 286611.0, 288376.0, 288570.0, 288689.0, 288932.0, 26974.730252698006, 27498.862505687342, 30634.84682576573, 31195.064148075595, 31784.841075795397, 36178.45732313965, 36641.0, 36820.81589592035, 37004.81497592495, 37566.0, 31590.210244744067, 31671.891483798878, 31970.84014579912, 32094.839525803156, 32578.51132232971, 28228.15315540537, 32527.837360813046, 33542.16144596405, 34736.30527389488, 35065.824670877504, 31446.371072578877, 31620.36759264848, 34791.0, 35112.297754044266, 35250.82374588213, 27006.729932700422, 28982.473975074146, 30849.941266650054, 30978.201117429824, 31495.37009259756, 23857.522849542565, 23935.401614959766, 24123.276301710976, 24380.63429048601, 24513.264602061965], "unit": "score", "name": "ext.html", "value": 17768.584737537003}, {"lowerIsBetter": false, "replicates": [352.55225863153794, 357.6030606027311, 357.8353957179696, 359.6313778377163, 360.45571187506863, 13763.380647870845, 14095.859041409583, 15674.843251567496, 15676.84323156768, 16329.591760205985, 16249.918750406261, 16706.916465417686, 17355.305787768506, 17636.294548218055, 17643.470695879143, 5300.284461597683, 5407.297051383334, 5410.377806552257, 5418.8916221675545, 5421.620486565942, 3965.4448377227213, 4082.4080508326274, 5378.811741589046, 5875.383084776101, 5986.7605295788335, 5907.527397808187, 5927.992241318986, 5936.168936348915, 5951.0, 5963.3738457462, 5751.0, 5876.764929402819, 5884.499817515516, 5893.381194974509, 5906.114082887601, 5202.557782588485, 5209.791608335662, 5210.739463026872, 5214.45248248936, 5221.71280579568, 21320.360389188194, 22115.115395384164, 22506.66240006401, 23093.191738289246, 23456.413589660224, 2278.6012447821563, 2299.2527428585777, 2358.749862572839, 2461.3433346049746, 2482.8013758899247, 13911.86088139126, 14322.785158222636, 14419.567412977627, 14673.853261467355, 14902.776458353133, 2007.1068374573322, 2087.123408168573, 2105.6841473778904, 2144.4210063282826, 2189.4745261137373, 67477.32522674759, 70350.0, 71909.0, 72770.27229727688, 72851.63574182148, 15282.46511372119, 15378.538643840478, 15406.691866162613, 15411.383544658313, 15514.767278490832, 24343.513129737305, 24359.269221923372, 24548.754512455005, 24653.753462465505, 24678.25965221046, 8532.274756645755, 8639.438436501607, 8642.956785216034, 8677.56612169389, 8687.435316704394, 7223.638818059076, 7236.240194779472, 7238.348548630648, 7268.818279543054, 7293.380062694624, 7611.809704757315, 7790.0, 7795.961020194863, 7859.921400786034, 7888.171741967126, 2634.4467661790854, 2969.168632782781, 2980.672126066131, 3080.199148221434, 3103.7720770398982, 842.6208206307186, 919.5907821019716, 974.6491263145263, 1014.1683819268277, 1041.3283432186197, 16741.6651666966, 17118.229679664444, 17230.224639891236, 17322.944274000696, 17379.913100434416, 872.1757938747949, 903.5933829776627, 937.4141161773891, 954.9522523873917, 976.1507488484922, 9507.66723164686, 9534.952325238468, 9686.031396860399, 9732.513374331254, 9869.506524673738, 388313.0, 393915.0, 489809.0, 495411.0, 523941.0, 41420.37869431961, 81638.59180704059, 82361.58819205865, 84115.0, 88426.55786721154, 1085.4735453305298, 1104.0891264706809, 1107.9224454288124, 1111.2721167635211, 1124.6288724720823, 12614.243145411305, 14649.560513184622, 14943.0, 15283.61790955235, 15651.37394504207, 32650.0, 33249.833750831094, 34343.48484772781, 36228.27543449169, 37091.443628345056, 41037.79481102576, 41170.38244426276, 41291.587084128776, 41331.586684133974, 41920.58079419289, 9300.488473133772, 9326.95336523313, 9464.384814987005, 9535.237181025363, 9552.808943821223, 17024.829751702324, 17030.82969170342, 17232.913835431245, 17534.561635959202, 17598.472045838644, 14080.22558759278, 14334.641633959234, 14483.493077742229, 14860.554183374516, 14920.477783277533, 13115.803262951255, 14534.636634084232, 14828.481003164838, 15079.0, 15161.0, 14418.711625767217, 14841.85158148448, 14981.0, 15212.695746085237, 15551.922240388725, 9769.560369783234, 9939.254555908192, 9960.452175130438, 10002.99970003023, 10036.49817509107, 14430.494932677306, 14577.416903323749, 14623.92688036553, 14851.554453366416, 15247.237638118271], "unit": "score", "name": "jquery.html", "value": 9633.65379969172}, {"lowerIsBetter": false, "replicates": [1250.0124901327952, 1379.5102738527823, 1429.892758043147, 1549.4112237349811, 1758.252742584402, 6319.5576309658345, 6927.4458043356535, 7034.964825175867, 7036.472264580151, 7049.54177978431, 6958.338957799014, 7134.6432678366, 7138.500304978654, 7143.607101609409, 7144.785656430316, 1884.076802366844, 1911.7036859286832, 1911.827935485806, 2151.257816053463, 2181.2365672014826, 2214.756376798559, 2239.4513344230686, 2256.232880820529, 2259.3334966184934, 2259.8192144628474, 2142.6143294207036, 2174.8803815790125, 2186.7922547357975, 2187.278198194592, 2188.7811218878064, 2132.9040193191345, 2144.6032483990434, 2159.0500179920864, 2172.3157205480225, 2214.2250212425683, 2230.3309007297908, 2237.463008877874, 2253.278950735765, 2257.8645281283175, 2272.6022945984387, 6966.164060312795, 7022.543534670282, 7026.789196324118, 7029.929700702979, 7038.260982596805, 4412.691111622188, 4416.690831641787, 4478.104379124188, 4478.865634030984, 4479.1489616972995, 2930.9413811723857, 2960.7335339819306, 3001.8048826826403, 3023.349979754363, 3045.5888455058507, 999.5651891427252, 1014.852846337277, 1034.5137785241, 1051.1328154272678, 1056.1339701444817, 9868.111869931741, 9872.308938374317, 9876.87647155865, 9883.061109194616, 9887.159591434736, 4004.2992476316526, 4066.9389959150635, 4080.755154690728, 4090.3250963591267, 4121.690873184523, 8524.27543658796, 8526.23263906239, 8526.445781024213, 8527.573621318908, 8531.317494600416, 4371.519132895379, 4395.164918665443, 4402.625776808943, 4404.229259879572, 4407.911841763147, 4007.0783719744622, 4014.1770936957855, 4015.7188996769946, 4016.835117815859, 4020.577839326887, 3139.560461535387, 3178.825164615922, 3467.3065386922717, 3469.583649962021, 3541.94687079694, 1120.7758448310208, 1128.7516746315798, 1129.4296380327883, 1137.9260348077514, 1153.5674122204173, 991.940483570988, 1001.2390583156853, 1010.8129995950773, 1103.8509801176738, 1292.3344477594046, 6553.4101930826455, 6651.0, 6657.1345725055435, 6692.899606505906, 6707.56400833954, 1086.1365214654368, 1093.6227001684406, 1097.1113398147527, 1118.4016551145098, 1132.7394699219226, 5210.76551555181, 5313.149896016619, 5317.9202311965355, 5318.97340513295, 5321.068812957717, 8330.166983301742, 8381.287590554872, 8487.915120848713, 8583.828323433496, 8598.140185981352, 8450.661973521113, 8456.027556831043, 8460.534670593053, 8482.660693572312, 8531.10423405546, 6598.868022639616, 6718.563293385914, 6790.660466976631, 6811.761588344384, 6832.692528836314, 6385.680715964276, 6391.265004524539, 6419.646919419477, 6427.3251308611925, 6431.807045788634, 7407.407407407502, 7576.924230757842, 7595.658195381332, 7661.808454788675, 7685.730999414994, 7652.387808975157, 7816.296533312029, 7845.686172553034, 7918.049834019955, 7974.800629984296, 6143.849206349207, 6197.473214776614, 6229.190205273286, 6242.0, 6244.969580019428, 6780.796576102724, 6820.965895170492, 6855.348741869514, 6897.206821215625, 6910.308969103049, 6408.61548307103, 6451.6774161290805, 6519.576227545194, 6538.444232240123, 6593.142891424084, 6265.342139075331, 6357.936420635734, 6381.553291269753, 6424.357564243538, 6469.676516174267, 6248.125262463168, 6269.0, 6299.181106456132, 6310.116583678197, 6313.842153946188, 5747.1379293106365, 5775.364709881826, 5782.421757824184, 5795.39148389413, 5796.478316951495, 5889.440503152194, 5907.940920590911, 6046.334903160737, 6047.153398524298, 6061.6666083365835], "unit": "score", "name": "mootools.html", "value": 4179.542414613308}, {"lowerIsBetter": false, "replicates": [337.22774845603567, 341.8666719979207, 343.5842630417195, 344.65362310877566, 352.0494664406104, 6051.788187413442, 6063.333033366326, 6094.939050609492, 6108.450239478446, 6133.110698948655, 5760.683162426065, 5812.622179558336, 5917.644941303525, 5992.820215393534, 6029.306629737571, 4641.048585040058, 4660.603848672867, 4672.0889426561835, 4674.111918735446, 4684.765761711918, 4391.341298805173, 4670.532946705336, 4671.462781780087, 4672.813087476514, 4675.368825208604, 4409.735415875058, 4489.932651010221, 4578.702384345023, 4589.954100458986, 4624.190766615846, 4570.291604801261, 4584.656150788671, 4595.264757638778, 4598.494165641777, 4621.607163391116, 4060.918781624351, 4064.0855807443386, 4065.1259979104634, 4065.9390109148385, 4075.5109386873764, 5644.0, 5749.59752817303, 5754.539636829044, 5757.65454072757, 5757.68332741699, 5324.653897496651, 5325.520703136736, 5328.92006619901, 5333.866653333659, 5334.119870221448, 6364.904526432108, 6393.424591786715, 6405.29541750407, 6408.807735767934, 6417.0, 4446.688731788776, 4451.532589078165, 4454.955450445486, 4455.398521199629, 4456.46522417312, 6545.0, 6612.636305003223, 6674.899876501856, 6679.599224046573, 6679.732810687567, 4523.23105072132, 4527.569880861313, 4529.162105010583, 4529.54704529551, 4530.161920044802, 4584.885377865513, 4585.908281834345, 4586.449626044896, 4590.609798167126, 4591.334256532851, 5308.628396012319, 5308.761105750251, 5309.044372012998, 5309.65487243328, 5318.521333080042, 6258.405451482193, 6417.133686952295, 6421.74313027483, 6429.935700642934, 6434.045784745813, 1595.7686135510287, 1620.1494215536702, 1621.4162901355503, 1623.2857542681184, 1623.9756403653955, 1053.773438710681, 1075.8493810866485, 1082.53992053377, 1093.8851420600881, 1098.368438148068, 6077.1491991121275, 6077.453029227391, 6083.756649733961, 6087.421694938974, 6090.634561926298, 6421.29365769765, 6593.2088149421415, 6595.439387652007, 6599.670016499156, 6602.372774586406, 5958.463738263577, 6033.823404436181, 6133.6319820810895, 6134.723937422827, 6134.846628834225, 3564.502908778319, 3615.764975276651, 3616.692581130581, 3618.5476815398074, 3619.8914032579064, 6771.322867713189, 6899.310068993061, 6911.133993821741, 6915.89626155608, 6916.723331066802, 6821.556598821061, 6828.658567071726, 6831.316868313129, 6841.350071743176, 6841.897371539431, 6918.896216556655, 6919.861602767916, 6921.134858142732, 6924.619145947021, 6929.930700693029, 6554.57395269325, 6684.766033188815, 6686.0, 6689.46484281266, 6695.0626912231355, 6559.409653131241, 6565.146530950946, 6567.080608714688, 6568.80293591193, 6572.047053177358, 6895.172579290517, 6900.102986611709, 6900.2064762550945, 6920.653967301514, 6921.6193109379465, 4452.220861349316, 4564.977175114236, 4566.88582785433, 4567.109413664303, 4568.565986231302, 6643.335666433318, 6677.599344039373, 6693.397594216543, 6694.330566943267, 6713.462922966053, 6493.318201588765, 6493.74025039012, 6494.577852439576, 6500.447461965786, 6503.447206987459, 6371.904421433775, 6477.578957367756, 6481.708323125565, 6482.805515834532, 6490.0, 6351.841203969938, 6361.268454127649, 6362.427381535684, 6363.427291543598, 6363.459105975859, 6483.546151769331, 6487.708053137714, 6522.086907833002, 6528.543001989815, 6537.28089910119, 6150.50795936333, 6349.428551430394, 6351.396617321347, 6353.301136875032, 6356.618602883842], "unit": "score", "name": "prototype.html", "value": 4843.4430476339485}, {"lowerIsBetter": false, "replicates": [712.2130046298839, 741.6996116572789, 750.3884334267572, 800.2627728507867, 822.8806823010664, 13687.3156342183, 13891.374888130033, 13901.443942242324, 13918.652033699163, 13939.790903136449, 12605.873941260585, 12930.74138517229, 12932.094753367268, 12933.482660693584, 12953.676158096052, 664.5713514782963, 811.7889348769319, 824.2416976381743, 825.0511911301991, 825.3644693585966, 670.2894931372737, 821.6097353756977, 833.5040650812757, 834.0325222741621, 834.1158372125536, 847.4660963592928, 857.2798848966867, 859.7979474823411, 860.1570460948275, 861.1861790607878, 697.7732237022963, 703.5778532880282, 856.7215654912147, 857.2284943550823, 860.3977215948861, 636.6434796513921, 638.8434833465784, 641.1344684675697, 641.3137942401632, 642.2870613618879, 12443.813342799865, 12461.252324860447, 12518.436670349856, 12549.0, 12638.74722505554, 11733.53065877364, 11746.0, 11982.940085299517, 12288.078394120477, 12482.188657737308, 9814.116729494308, 10118.342307749972, 10203.0, 10308.639197628121, 10456.895431045668, 3693.630636936312, 3699.0, 3709.109813644706, 3768.3782175940937, 3834.578196398394, 43339.34990975138, 43402.34896476555, 43867.0, 43987.34018989718, 44126.33810492877, 10119.595216191417, 10132.34139780912, 10146.188304935587, 10174.767290859125, 10359.067683908333, 18043.819561804477, 18055.45833624967, 18064.548386290448, 18076.457706268833, 18088.909555452137, 7782.766517004499, 7855.685772569148, 7952.0, 8025.3980951428875, 8028.518288902567, 4298.3552467130185, 4467.40511354618, 4472.798724057425, 4519.706219095749, 4556.794944227518, 2981.8061825981677, 2995.0715278263806, 2999.3851260491983, 3005.594244776927, 3007.1279328994783, 527.6833899660173, 532.4276402866933, 541.0909671751496, 542.7096503370677, 546.8878879829625, 618.8452886778306, 657.454312920275, 673.9494537909676, 692.5533031194951, 699.4544255480733, 8172.787552292461, 8572.099929507436, 8591.828163436696, 8741.912580874237, 8761.430507017023, 594.2898236607213, 654.8853950558633, 657.4707360574688, 661.6691654172913, 663.4460225711489, 3956.8812935611977, 4210.15796840627, 4367.912641747147, 4393.802278897458, 4471.552844715502, 52455.73772131191, 56789.0, 56866.715666421405, 56928.43071569231, 56974.71512642493, 49124.75437622789, 50272.74863625732, 50508.0, 50730.49269507331, 50973.0, 43668.563314367086, 44388.112237755064, 44431.77784111059, 45253.32120018202, 45547.54452455499, 8415.621297041771, 8598.527081010605, 8629.913700862911, 8639.042054561827, 8861.601227944888, 32723.181920452178, 33290.5006424899, 33362.0, 33538.32923341568, 33604.663953360156, 38739.0, 39832.40251396174, 40540.1891962165, 40596.79701601473, 43374.34938475989, 10901.781964360827, 10909.0, 10931.61739339151, 10985.560577576807, 11425.428728563373, 12203.267803931793, 12513.562025329069, 12549.372531373578, 12984.545540906023, 13115.08194426381, 11244.831327530257, 11277.32336059839, 11363.034142098015, 11758.647240582795, 11997.76004479888, 11057.170712196457, 11186.608468703556, 11399.259048161843, 11545.538178472767, 11665.475053622777, 10734.946325268324, 10801.351918884891, 11107.44462776874, 11158.0, 11230.438478075901, 9862.852057219005, 10035.19718422539, 10289.588416463257, 10406.0, 10528.684139475828, 8370.455920365157, 8687.218150366498, 9050.411723237969, 9304.58129384193, 9729.221662267144], "unit": "score", "name": "yui.html", "value": 6244.570839212182}], "name": "dromaeo_css", "value": 6941.049306443196}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 108.0, 112.0, 118.0, 111.0, 100.0, 112.0, 110.0, 102.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [153.0, 123.0, 146.0, 164.0, 124.0, 152.0, 150.0, 128.0, 169.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [162.0, 159.0, 160.0, 160.0, 162.0, 161.0, 167.0, 161.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 81.0, 91.0, 71.0, 73.0, 73.0, 111.0, 95.0, 70.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 95.0, 96.0, 97.0, 141.0, 96.0, 103.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 58.0, 58.0, 58.0, 57.0, 58.0, 66.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 69.0, 69.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 86.0, 86.0, 85.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [122.0, 121.0, 118.0, 115.0, 130.0, 115.0, 126.0, 129.0, 122.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [138.0, 149.0, 154.0, 148.0, 155.0, 141.0, 143.0, 156.0, 151.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 69.0, 67.0, 67.0, 66.0, 68.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1502.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.897918065816], "unit": "score", "name": "Richards", "value": 210.25871200000006}, {"lowerIsBetter": false, "replicates": [191.90174630589138], "unit": "score", "name": "DeltaBlue", "value": 344.54089799999997}, {"lowerIsBetter": false, "replicates": [280.8199943836001], "unit": "score", "name": "Encrypt", "value": 947.8705409999999}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1106.1946902654868], "unit": "score", "name": "RayTrace", "value": 668.9500559999998}, {"lowerIsBetter": false, "replicates": [809.0614886731391], "unit": "score", "name": "Earley", "value": 823.7482679999999}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [25794.871794871793], "unit": "score", "name": "RegExp", "value": 35.31651590457257}, {"lowerIsBetter": false, "replicates": [594.1770647653001], "unit": "score", "name": "Splay", "value": 137.14935300000005}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20939.198294825903}]} 19:08:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20939.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1502.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6941.05"}}} 19:08:29 INFO - Return code: 0 19:08:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:08:29 INFO - # TBPL SUCCESS # 19:08:29 INFO - Running post-action listener: _resource_record_post_action 19:08:29 INFO - Running post-run listener: _resource_record_post_run 19:08:30 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 551751680; Read time: 0; Write time: 555244 19:08:30 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 245968896; Read time: 0; Write time: 324356 19:08:30 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 304906240; Read time: 0; Write time: 230840 19:08:30 INFO - Running post-run listener: _upload_blobber_files 19:08:30 INFO - Blob upload gear active. 19:08:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:08:30 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:08:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:08:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:08:31 INFO - (blobuploader) - INFO - Open directory for files ... 19:08:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:08:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:08:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:32 INFO - (blobuploader) - INFO - Done attempting. 19:08:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:08:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:08:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:32 INFO - (blobuploader) - INFO - Done attempting. 19:08:32 INFO - (blobuploader) - INFO - Iteration through files over. 19:08:32 INFO - Return code: 0 19:08:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:08:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:08:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/83743d4f95de9eacfea9924afa0cebbd2c8ac53a322727996cfbd2a3822d885d13a3c1a07576456c5eda55b958c67779e3e4e6f3028deeb92696fdd897930011", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef125c9d9a38af7393877c2ac9919bec1f8875f487e722c42bc05af878aa84fa6c78436bf6fd3dea3383d770ac4754091eb82803cb3807c697439d2d079f3914"} 19:08:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:08:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:08:32 INFO - Contents: 19:08:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/83743d4f95de9eacfea9924afa0cebbd2c8ac53a322727996cfbd2a3822d885d13a3c1a07576456c5eda55b958c67779e3e4e6f3028deeb92696fdd897930011", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef125c9d9a38af7393877c2ac9919bec1f8875f487e722c42bc05af878aa84fa6c78436bf6fd3dea3383d770ac4754091eb82803cb3807c697439d2d079f3914"} 19:08:32 INFO - Copying logs to upload dir... 19:08:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.109181 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-26 19:08:31.859444) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 19:08:31.863435) ========= 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=dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/83743d4f95de9eacfea9924afa0cebbd2c8ac53a322727996cfbd2a3822d885d13a3c1a07576456c5eda55b958c67779e3e4e6f3028deeb92696fdd897930011", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef125c9d9a38af7393877c2ac9919bec1f8875f487e722c42bc05af878aa84fa6c78436bf6fd3dea3383d770ac4754091eb82803cb3807c697439d2d079f3914"} build_url:https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/IPp13FHoRTqCU6CXrWYDBw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/83743d4f95de9eacfea9924afa0cebbd2c8ac53a322727996cfbd2a3822d885d13a3c1a07576456c5eda55b958c67779e3e4e6f3028deeb92696fdd897930011", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef125c9d9a38af7393877c2ac9919bec1f8875f487e722c42bc05af878aa84fa6c78436bf6fd3dea3383d770ac4754091eb82803cb3807c697439d2d079f3914"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 19:08:31.888427) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 19:08:31.888851) ========= 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=dd132779db58144225c4cf24000001c8-1451180651.735997-1245619484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 19:08:31.974062) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 19:08:31.974421) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 19:08:31.974759) ========= ========= Total master_lag: 0.30 =========