builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1452268583.23 results: success (0) buildid: 20160108053005 builduid: 303f6a3dca7d43bda3f49834c5d22203 revision: 9cd5467e15f1be886586351f9a52e36bf0de711c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.227812) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.228320) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.228656) ========= 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=cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005647 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.248192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.248505) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.258517) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.258816) ========= 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=cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.307755) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.308076) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.308440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.308745) ========= 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=cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 07:56:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-01-08 07:56:23 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140490 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.462104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.462457) ========= 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=cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019480 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.511740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:23.512107) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 9cd5467e15f1be886586351f9a52e36bf0de711c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 9cd5467e15f1be886586351f9a52e36bf0de711c --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=cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 07:56:23,762 truncating revision to first 12 chars 2016-01-08 07:56:23,763 Setting DEBUG logging. 2016-01-08 07:56:23,763 attempt 1/10 2016-01-08 07:56:23,763 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/9cd5467e15f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 07:56:24,232 unpacking tar archive at: b2g-inbound-9cd5467e15f1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.762616 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:24.289569) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:24.289946) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:24.299535) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:24.299831) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 07:56:24.300294) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-08 07:56:24.300626) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:56:24 INFO - MultiFileLogger online at 20160108 07:56:24 in /builds/slave/test-pgo 07:56:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 07:56:24 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:56:24 INFO - {'append_to_log': False, 07:56:24 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:56:24 INFO - 'blob_upload_branch': 'B2G-Inbound', 07:56:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:56:24 INFO - 'branch': 'B2G-Inbound', 07:56:24 INFO - 'buildbot_json_path': 'buildprops.json', 07:56:24 INFO - 'config_files': ('talos/linux_config.py',), 07:56:24 INFO - 'default_actions': ('clobber', 07:56:24 INFO - 'read-buildbot-config', 07:56:24 INFO - 'download-and-extract', 07:56:24 INFO - 'populate-webroot', 07:56:24 INFO - 'create-virtualenv', 07:56:24 INFO - 'install', 07:56:24 INFO - 'run-tests'), 07:56:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:56:24 INFO - 'download_minidump_stackwalk': True, 07:56:24 INFO - 'download_symbols': 'ondemand', 07:56:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:56:24 INFO - 'tooltool.py': '/tools/tooltool.py', 07:56:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:56:24 INFO - '/tools/misc-python/virtualenv.py')}, 07:56:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:56:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:56:24 INFO - 'installer_path': 'installer.exe', 07:56:24 INFO - 'log_level': 'info', 07:56:24 INFO - 'log_name': 'talos', 07:56:24 INFO - 'log_to_console': True, 07:56:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:56:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:56:24 INFO - 'opt_config_files': (), 07:56:24 INFO - 'pip_index': False, 07:56:24 INFO - 'sps_profile': False, 07:56:24 INFO - 'sps_profile_interval': 0, 07:56:24 INFO - 'suite': 'dromaeojs', 07:56:24 INFO - 'system_bits': '32', 07:56:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:56:24 INFO - 'title': 'talos-linux64-ix-054', 07:56:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:56:24 INFO - 'use_talos_json': True, 07:56:24 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:56:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:56:24 INFO - 'work_dir': 'build'} 07:56:24 INFO - ##### 07:56:24 INFO - ##### Running clobber step. 07:56:24 INFO - ##### 07:56:24 INFO - Running pre-action listener: _resource_record_pre_action 07:56:24 INFO - Running main action method: clobber 07:56:24 INFO - rmtree: /builds/slave/test-pgo/build 07:56:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:56:25 INFO - Running post-action listener: _resource_record_post_action 07:56:25 INFO - ##### 07:56:25 INFO - ##### Running read-buildbot-config step. 07:56:25 INFO - ##### 07:56:25 INFO - Running pre-action listener: _resource_record_pre_action 07:56:25 INFO - Running main action method: read_buildbot_config 07:56:25 INFO - Using buildbot properties: 07:56:25 INFO - { 07:56:25 INFO - "project": "", 07:56:25 INFO - "product": "firefox", 07:56:25 INFO - "script_repo_revision": "production", 07:56:25 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 07:56:25 INFO - "repository": "", 07:56:25 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 07:56:25 INFO - "buildid": "20160108053005", 07:56:25 INFO - "pgo_build": "True", 07:56:25 INFO - "basedir": "/builds/slave/test-pgo", 07:56:25 INFO - "buildnumber": 196, 07:56:25 INFO - "slavename": "talos-linux64-ix-054", 07:56:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:56:25 INFO - "platform": "ubuntu64_hw", 07:56:25 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 07:56:25 INFO - "branch": "b2g-inbound", 07:56:25 INFO - "repo_path": "integration/b2g-inbound", 07:56:25 INFO - "revision": "9cd5467e15f1be886586351f9a52e36bf0de711c", 07:56:25 INFO - "stage_platform": "linux64-pgo", 07:56:25 INFO - "builduid": "303f6a3dca7d43bda3f49834c5d22203", 07:56:25 INFO - "slavebuilddir": "test" 07:56:25 INFO - } 07:56:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:56:25 INFO - Running post-action listener: _resource_record_post_action 07:56:25 INFO - ##### 07:56:25 INFO - ##### Running download-and-extract step. 07:56:25 INFO - ##### 07:56:25 INFO - Running pre-action listener: _resource_record_pre_action 07:56:25 INFO - Running main action method: download_and_extract 07:56:25 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:56:25 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')]} 07:56:25 INFO - https://queue.taskcluster.net/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:56:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/test_packages.json 07:56:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/test_packages.json 07:56:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:56:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:56:25 INFO - Downloaded 1302 bytes. 07:56:25 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:56:25 INFO - Using the following test package requirements: 07:56:25 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:56:25 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:56:25 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:25 INFO - u'jsshell-linux-x86_64.zip'], 07:56:25 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:56:25 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:56:25 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:56:25 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:56:25 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:56:25 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:56:25 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:56:25 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:56:25 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')]} 07:56:25 INFO - https://queue.taskcluster.net/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:56:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:56:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:56:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/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 07:56:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/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 07:56:26 INFO - Downloaded 24018252 bytes. 07:56:26 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 07:56:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:56:26 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 07:56:27 INFO - Return code: 0 07:56:27 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 07:56: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')]} 07:56:27 INFO - https://queue.taskcluster.net/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:56:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:56:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:56:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/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 07:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/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 07:56:29 INFO - Downloaded 24018252 bytes. 07:56:29 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 07:56:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:56:29 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 07:56:30 INFO - Return code: 0 07:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:30 INFO - https://queue.taskcluster.net/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:56:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/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 07:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/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 07:56:31 INFO - Downloaded 11132285 bytes. 07:56:31 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 07:56:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:31 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 07:56:32 INFO - Return code: 0 07:56: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')]} 07:56:32 INFO - https://queue.taskcluster.net/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/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 07:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/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 07:56:33 INFO - Downloaded 55906129 bytes. 07:56:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:56:33 INFO - mkdir: /builds/slave/test-pgo/properties 07:56:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:56:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:56:33 INFO - Contents: 07:56:33 INFO - build_url:https://queue.taskcluster.net/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:56:33 INFO - Running post-action listener: _resource_record_post_action 07:56:33 INFO - Running post-action listener: set_extra_try_arguments 07:56:33 INFO - ##### 07:56:33 INFO - ##### Running populate-webroot step. 07:56:33 INFO - ##### 07:56:33 INFO - Running pre-action listener: _resource_record_pre_action 07:56:33 INFO - Running main action method: populate_webroot 07:56:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:56:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:56:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:56:33 INFO - '--tppagecycles', 07:56:33 INFO - '7'], 07:56:33 INFO - 'tests': ['tsvgm']}}, 07:56:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:56:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:56:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:56:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:56:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:56:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:56:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:33 INFO - 'talos_options': ['--e10s'], 07:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:33 INFO - 'tests': ['damp', 'tps']}, 07:56:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:33 INFO - 'talos_options': ['--e10s'], 07:56:33 INFO - 'tests': ['damp', 'tps']}, 07:56:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:56:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:56:33 INFO - 'other': {'tests': ['a11yr', 07:56:33 INFO - 'ts_paint', 07:56:33 INFO - 'tpaint', 07:56:33 INFO - 'sessionrestore', 07:56:33 INFO - 'sessionrestore_no_auto_restore']}, 07:56:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:56:33 INFO - 'tests': ['a11yr', 07:56:33 INFO - 'ts_paint', 07:56:33 INFO - 'tpaint', 07:56:33 INFO - 'sessionrestore', 07:56:33 INFO - 'sessionrestore_no_auto_restore']}, 07:56:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:56:33 INFO - 'tests': ['a11yr', 07:56:33 INFO - 'ts_paint', 07:56:33 INFO - 'tpaint', 07:56:33 INFO - 'sessionrestore', 07:56:33 INFO - 'sessionrestore_no_auto_restore']}, 07:56:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:56:33 INFO - 'tests': ['a11yr', 07:56:33 INFO - 'ts_paint', 07:56:33 INFO - 'tpaint', 07:56:33 INFO - 'sessionrestore', 07:56:33 INFO - 'sessionrestore_no_auto_restore']}, 07:56:33 INFO - 'other_l64': {'tests': ['a11yr', 07:56:33 INFO - 'ts_paint', 07:56:33 INFO - 'tpaint', 07:56:33 INFO - 'sessionrestore', 07:56:33 INFO - 'sessionrestore_no_auto_restore']}, 07:56:33 INFO - 'other_nol64': {'tests': ['a11yr', 07:56:33 INFO - 'ts_paint', 07:56:33 INFO - 'tpaint', 07:56:33 INFO - 'sessionrestore', 07:56:33 INFO - 'sessionrestore_no_auto_restore']}, 07:56:33 INFO - 'svgr': {'tests': ['tsvgx', 07:56:33 INFO - 'tsvgr_opacity', 07:56:33 INFO - 'tart', 07:56:33 INFO - 'tscrollx', 07:56:33 INFO - 'cart']}, 07:56:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:56:33 INFO - 'tests': ['tsvgx', 07:56:33 INFO - 'tsvgr_opacity', 07:56:33 INFO - 'tart', 07:56:33 INFO - 'tscrollx', 07:56:33 INFO - 'cart']}, 07:56:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:33 INFO - 'tests': ['tp5o']}, 07:56:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:33 INFO - 'talos_options': ['--e10s'], 07:56:33 INFO - 'tests': ['tp5o']}, 07:56:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:33 INFO - 'talos_options': ['--xperf_path', 07:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:33 INFO - 'tests': ['tp5n']}, 07:56:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:33 INFO - 'talos_options': ['--e10s', 07:56:33 INFO - '--xperf_path', 07:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:33 INFO - 'tests': ['tp5n']}}, 07:56:33 INFO - 'talos.zip': {'path': '', 07:56:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:56:33 INFO - Running post-action listener: _resource_record_post_action 07:56:33 INFO - ##### 07:56:33 INFO - ##### Running create-virtualenv step. 07:56:33 INFO - ##### 07:56:33 INFO - Running pre-action listener: _resource_record_pre_action 07:56:33 INFO - Running main action method: create_virtualenv 07:56:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:56:33 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 07:56:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:56:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:56:33 INFO - Using real prefix '/usr' 07:56:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:56:34 INFO - Installing distribute.............................................................................................................................................................................................done. 07:56:36 INFO - Installing pip.................done. 07:56:36 INFO - Return code: 0 07:56:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:56: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')]} 07:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:36 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 0x7f41cbecef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2420840>, '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 0x238d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238db60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', '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 07:56:36 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 07:56:36 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 07:56:36 INFO - Using env: {'DISPLAY': ':0', 07:56:36 INFO - 'HOME': '/home/cltbld', 07:56:36 INFO - 'LANG': 'en_US.UTF-8', 07:56:36 INFO - 'LANGUAGE': 'en_US:en', 07:56:36 INFO - 'LOGNAME': 'cltbld', 07:56:36 INFO - 'MAIL': '/var/mail/cltbld', 07:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:36 INFO - 'MOZ_NO_REMOTE': '1', 07:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:36 INFO - 'NO_EM_RESTART': '1', 07:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:36 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:36 INFO - 'SHELL': '/bin/bash', 07:56:36 INFO - 'SHLVL': '1', 07:56:36 INFO - 'TERM': 'linux', 07:56:36 INFO - 'TMOUT': '86400', 07:56:36 INFO - 'USER': 'cltbld', 07:56:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', 07:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:36 INFO - '_': '/tools/buildbot/bin/python'} 07:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:36 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 07:56:36 INFO - Cleaning up... 07:56:36 INFO - Return code: 0 07:56:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:56: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')]} 07:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:36 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 0x7f41cbecef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2420840>, '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 0x238d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238db60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', '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 07:56:36 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 07:56:36 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 07:56:36 INFO - Using env: {'DISPLAY': ':0', 07:56:36 INFO - 'HOME': '/home/cltbld', 07:56:36 INFO - 'LANG': 'en_US.UTF-8', 07:56:36 INFO - 'LANGUAGE': 'en_US:en', 07:56:36 INFO - 'LOGNAME': 'cltbld', 07:56:36 INFO - 'MAIL': '/var/mail/cltbld', 07:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:36 INFO - 'MOZ_NO_REMOTE': '1', 07:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:36 INFO - 'NO_EM_RESTART': '1', 07:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:36 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:36 INFO - 'SHELL': '/bin/bash', 07:56:36 INFO - 'SHLVL': '1', 07:56:36 INFO - 'TERM': 'linux', 07:56:36 INFO - 'TMOUT': '86400', 07:56:36 INFO - 'USER': 'cltbld', 07:56:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', 07:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:36 INFO - '_': '/tools/buildbot/bin/python'} 07:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:36 INFO - Downloading/unpacking psutil>=0.7.1 07:56:36 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 07:56:36 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 07:56:36 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 07:56:36 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 07:56:36 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 07:56:36 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 07:56:38 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:56:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:56:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:56:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:38 INFO - Installing collected packages: psutil 07:56:38 INFO - Running setup.py install for psutil 07:56:38 INFO - building 'psutil._psutil_linux' extension 07:56:38 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 07:56:38 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 07:56:38 INFO - building 'psutil._psutil_posix' extension 07:56:38 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 07:56:38 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 07:56:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:38 INFO - Successfully installed psutil 07:56:38 INFO - Cleaning up... 07:56:38 INFO - Return code: 0 07:56:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:56:38 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')]} 07:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:38 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')]} 07:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:38 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 0x7f41cbecef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2420840>, '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 0x238d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238db60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', '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 07:56:38 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 07:56:38 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 07:56:38 INFO - Using env: {'DISPLAY': ':0', 07:56:38 INFO - 'HOME': '/home/cltbld', 07:56:38 INFO - 'LANG': 'en_US.UTF-8', 07:56:38 INFO - 'LANGUAGE': 'en_US:en', 07:56:38 INFO - 'LOGNAME': 'cltbld', 07:56:38 INFO - 'MAIL': '/var/mail/cltbld', 07:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:38 INFO - 'MOZ_NO_REMOTE': '1', 07:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:38 INFO - 'NO_EM_RESTART': '1', 07:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:38 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:38 INFO - 'SHELL': '/bin/bash', 07:56:38 INFO - 'SHLVL': '1', 07:56:38 INFO - 'TERM': 'linux', 07:56:38 INFO - 'TMOUT': '86400', 07:56:38 INFO - 'USER': 'cltbld', 07:56:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', 07:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:38 INFO - '_': '/tools/buildbot/bin/python'} 07:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:56:39 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 07:56:39 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 07:56:39 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 07:56:39 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 07:56:39 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 07:56:39 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 07:56:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:56:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:56:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:56:40 INFO - Installing collected packages: mozsystemmonitor 07:56:40 INFO - Running setup.py install for mozsystemmonitor 07:56:40 INFO - Successfully installed mozsystemmonitor 07:56:40 INFO - Cleaning up... 07:56:40 INFO - Return code: 0 07:56:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f41cbecef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2420840>, '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 0x238d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238db60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', '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 07:56:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:56:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:56:40 INFO - Using env: {'DISPLAY': ':0', 07:56:40 INFO - 'HOME': '/home/cltbld', 07:56:40 INFO - 'LANG': 'en_US.UTF-8', 07:56:40 INFO - 'LANGUAGE': 'en_US:en', 07:56:40 INFO - 'LOGNAME': 'cltbld', 07:56:40 INFO - 'MAIL': '/var/mail/cltbld', 07:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:40 INFO - 'MOZ_NO_REMOTE': '1', 07:56:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:40 INFO - 'NO_EM_RESTART': '1', 07:56:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:40 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:40 INFO - 'SHELL': '/bin/bash', 07:56:40 INFO - 'SHLVL': '1', 07:56:40 INFO - 'TERM': 'linux', 07:56:40 INFO - 'TMOUT': '86400', 07:56:40 INFO - 'USER': 'cltbld', 07:56:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', 07:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:40 INFO - '_': '/tools/buildbot/bin/python'} 07:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:41 INFO - Downloading/unpacking blobuploader==1.2.4 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:42 INFO - Downloading blobuploader-1.2.4.tar.gz 07:56:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:56:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:56:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:56:42 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 07:56:42 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 07:56:42 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 07:56:42 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 07:56:42 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 07:56:42 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 07:56:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:56:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:56:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:43 INFO - Downloading docopt-0.6.1.tar.gz 07:56:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:56:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:56:43 INFO - Installing collected packages: blobuploader, requests, docopt 07:56:43 INFO - Running setup.py install for blobuploader 07:56:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:56:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:56:43 INFO - Running setup.py install for requests 07:56:44 INFO - Running setup.py install for docopt 07:56:44 INFO - Successfully installed blobuploader requests docopt 07:56:44 INFO - Cleaning up... 07:56:44 INFO - Return code: 0 07:56:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:56: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')]} 07:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:44 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 0x7f41cbecef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2420840>, '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 0x238d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238db60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', '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 07:56:44 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 07:56:44 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 07:56:44 INFO - Using env: {'DISPLAY': ':0', 07:56:44 INFO - 'HOME': '/home/cltbld', 07:56:44 INFO - 'LANG': 'en_US.UTF-8', 07:56:44 INFO - 'LANGUAGE': 'en_US:en', 07:56:44 INFO - 'LOGNAME': 'cltbld', 07:56:44 INFO - 'MAIL': '/var/mail/cltbld', 07:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:44 INFO - 'MOZ_NO_REMOTE': '1', 07:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:44 INFO - 'NO_EM_RESTART': '1', 07:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:44 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:44 INFO - 'SHELL': '/bin/bash', 07:56:44 INFO - 'SHLVL': '1', 07:56:44 INFO - 'TERM': 'linux', 07:56:44 INFO - 'TMOUT': '86400', 07:56:44 INFO - 'USER': 'cltbld', 07:56:44 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', 07:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:44 INFO - '_': '/tools/buildbot/bin/python'} 07:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:56:44 INFO - Running setup.py (path:/tmp/pip-DAWha4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:56:44 INFO - Running setup.py (path:/tmp/pip-KDJ2Y4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:56:44 INFO - Running setup.py (path:/tmp/pip-cxJ0SN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:56:44 INFO - Running setup.py (path:/tmp/pip-N6fAl2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:56:44 INFO - Running setup.py (path:/tmp/pip-6qrk3L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:56:44 INFO - Running setup.py (path:/tmp/pip-9yGHpq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:56:44 INFO - Running setup.py (path:/tmp/pip-F0w8cr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:56:44 INFO - Running setup.py (path:/tmp/pip-38Hd14-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:56:44 INFO - Running setup.py (path:/tmp/pip-hCDMEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:56:45 INFO - Running setup.py (path:/tmp/pip-ZjP3fA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:56:45 INFO - Running setup.py (path:/tmp/pip-TxF4db-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:56:45 INFO - Running setup.py (path:/tmp/pip-OxvywX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:56:45 INFO - Running setup.py (path:/tmp/pip-eTEvWu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:56:45 INFO - Running setup.py (path:/tmp/pip-1jYhQt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:56:45 INFO - Running setup.py (path:/tmp/pip-CNyunx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:56:45 INFO - Running setup.py (path:/tmp/pip-eEdTxU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:56:45 INFO - Running setup.py (path:/tmp/pip-7rnlxk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:56:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:56:45 INFO - Running setup.py install for manifestparser 07:56:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:56:45 INFO - Running setup.py install for mozcrash 07:56:45 INFO - Running setup.py install for mozdebug 07:56:45 INFO - Running setup.py install for mozdevice 07:56:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:56:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:56:46 INFO - Running setup.py install for mozfile 07:56:46 INFO - Running setup.py install for mozhttpd 07:56:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:56:46 INFO - Running setup.py install for mozinfo 07:56:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:56:46 INFO - Running setup.py install for mozInstall 07:56:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:56:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:56:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:56:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:56:46 INFO - Running setup.py install for mozleak 07:56:46 INFO - Running setup.py install for mozlog 07:56:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:56:46 INFO - Running setup.py install for moznetwork 07:56:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:56:46 INFO - Running setup.py install for mozprocess 07:56:46 INFO - Running setup.py install for mozprofile 07:56:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:56:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:56:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:56:46 INFO - Running setup.py install for mozrunner 07:56:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:56:47 INFO - Running setup.py install for mozscreenshot 07:56:47 INFO - Running setup.py install for moztest 07:56:47 INFO - Running setup.py install for mozversion 07:56:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:56:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:56:47 INFO - Cleaning up... 07:56:47 INFO - Return code: 0 07:56:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:56:47 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')]} 07:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:47 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')]} 07:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:47 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 0x7f41cbecef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2420840>, '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 0x238d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238db60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', '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 07:56:47 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 07:56:47 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 07:56:47 INFO - Using env: {'DISPLAY': ':0', 07:56:47 INFO - 'HOME': '/home/cltbld', 07:56:47 INFO - 'LANG': 'en_US.UTF-8', 07:56:47 INFO - 'LANGUAGE': 'en_US:en', 07:56:47 INFO - 'LOGNAME': 'cltbld', 07:56:47 INFO - 'MAIL': '/var/mail/cltbld', 07:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:47 INFO - 'MOZ_NO_REMOTE': '1', 07:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:47 INFO - 'NO_EM_RESTART': '1', 07:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:47 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:47 INFO - 'SHELL': '/bin/bash', 07:56:47 INFO - 'SHLVL': '1', 07:56:47 INFO - 'TERM': 'linux', 07:56:47 INFO - 'TMOUT': '86400', 07:56:47 INFO - 'USER': 'cltbld', 07:56:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', 07:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:47 INFO - '_': '/tools/buildbot/bin/python'} 07:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:56:47 INFO - Running setup.py (path:/tmp/pip-xTuTxo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:56:47 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)) 07:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:56:47 INFO - Running setup.py (path:/tmp/pip-MvleRG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:56:47 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)) 07:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:56:47 INFO - Running setup.py (path:/tmp/pip-mxv3DQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:56:47 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)) 07:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:56:47 INFO - Running setup.py (path:/tmp/pip-nNJI8x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:56:47 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)) 07:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:56:47 INFO - Running setup.py (path:/tmp/pip-ZsKdxQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:56:47 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)) 07:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:56:47 INFO - Running setup.py (path:/tmp/pip-0J0O6H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:56:48 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)) 07:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:56:48 INFO - Running setup.py (path:/tmp/pip-68Cn1E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:56:48 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)) 07:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:56:48 INFO - Running setup.py (path:/tmp/pip-OsTJXI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:56:48 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)) 07:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:56:48 INFO - Running setup.py (path:/tmp/pip-uHICl2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:56:48 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)) 07:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:56:48 INFO - Running setup.py (path:/tmp/pip-ugQkqj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:56:48 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)) 07:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:56:48 INFO - Running setup.py (path:/tmp/pip-W_8zuZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:56:48 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)) 07:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:56:48 INFO - Running setup.py (path:/tmp/pip-WVBiEI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:56:48 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)) 07:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:56:48 INFO - Running setup.py (path:/tmp/pip-JS4ZtX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:56:48 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)) 07:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:56:48 INFO - Running setup.py (path:/tmp/pip-H0ngnx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:56:48 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)) 07:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:56:48 INFO - Running setup.py (path:/tmp/pip-eF72xT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:56:48 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)) 07:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:56:48 INFO - Running setup.py (path:/tmp/pip-G2OWiQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:56:48 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)) 07:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:56:48 INFO - Running setup.py (path:/tmp/pip-s2RsFf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:56:48 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)) 07:56:48 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)) 07:56:48 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)) 07:56:48 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)) 07:56:48 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)) 07:56:48 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)) 07:56:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:50 INFO - Downloading blessings-1.5.1.tar.gz 07:56:50 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 07:56:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:56:50 INFO - Installing collected packages: blessings 07:56:50 INFO - Running setup.py install for blessings 07:56:50 INFO - Successfully installed blessings 07:56:50 INFO - Cleaning up... 07:56:50 INFO - Return code: 0 07:56:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:56:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:56:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:56:50 INFO - Reading from file tmpfile_stdout 07:56:50 INFO - Current package versions: 07:56:50 INFO - argparse == 1.2.1 07:56:50 INFO - blessings == 1.5.1 07:56:50 INFO - blobuploader == 1.2.4 07:56:50 INFO - docopt == 0.6.1 07:56:50 INFO - manifestparser == 1.1 07:56:50 INFO - mozInstall == 1.12 07:56:50 INFO - mozcrash == 0.16 07:56:50 INFO - mozdebug == 0.1 07:56:50 INFO - mozdevice == 0.47 07:56:50 INFO - mozfile == 1.2 07:56:50 INFO - mozhttpd == 0.7 07:56:50 INFO - mozinfo == 0.9 07:56:50 INFO - mozleak == 0.1 07:56:50 INFO - mozlog == 3.1 07:56:50 INFO - moznetwork == 0.27 07:56:50 INFO - mozprocess == 0.22 07:56:50 INFO - mozprofile == 0.28 07:56:50 INFO - mozrunner == 6.11 07:56:50 INFO - mozscreenshot == 0.1 07:56:50 INFO - mozsystemmonitor == 0.0 07:56:50 INFO - moztest == 0.7 07:56:50 INFO - mozversion == 1.4 07:56:50 INFO - psutil == 3.1.1 07:56:50 INFO - requests == 1.2.3 07:56:50 INFO - wsgiref == 0.1.2 07:56:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:50 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 0x7f41cbecef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2420840>, '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 0x238d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238db60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', '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 07:56:50 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 07:56:50 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 07:56:50 INFO - Using env: {'DISPLAY': ':0', 07:56:50 INFO - 'HOME': '/home/cltbld', 07:56:50 INFO - 'LANG': 'en_US.UTF-8', 07:56:50 INFO - 'LANGUAGE': 'en_US:en', 07:56:50 INFO - 'LOGNAME': 'cltbld', 07:56:50 INFO - 'MAIL': '/var/mail/cltbld', 07:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:50 INFO - 'MOZ_NO_REMOTE': '1', 07:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:50 INFO - 'NO_EM_RESTART': '1', 07:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:50 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:50 INFO - 'SHELL': '/bin/bash', 07:56:50 INFO - 'SHLVL': '1', 07:56:50 INFO - 'TERM': 'linux', 07:56:50 INFO - 'TMOUT': '86400', 07:56:50 INFO - 'USER': 'cltbld', 07:56:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', 07:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:50 INFO - '_': '/tools/buildbot/bin/python'} 07:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:51 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)) 07:56:51 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)) 07:56:51 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)) 07:56:51 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)) 07:56:51 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)) 07:56:51 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)) 07:56:51 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)) 07:56:51 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)) 07:56:51 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)) 07:56:51 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)) 07:56:51 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)) 07:56:51 INFO - Cleaning up... 07:56:51 INFO - Return code: 0 07:56:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:51 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 0x7f41cbecef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2420840>, '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 0x238d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238db60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', '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 07:56:51 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 07:56:51 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 07:56:51 INFO - Using env: {'DISPLAY': ':0', 07:56:51 INFO - 'HOME': '/home/cltbld', 07:56:51 INFO - 'LANG': 'en_US.UTF-8', 07:56:51 INFO - 'LANGUAGE': 'en_US:en', 07:56:51 INFO - 'LOGNAME': 'cltbld', 07:56:51 INFO - 'MAIL': '/var/mail/cltbld', 07:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:51 INFO - 'MOZ_NO_REMOTE': '1', 07:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:51 INFO - 'NO_EM_RESTART': '1', 07:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:51 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:51 INFO - 'SHELL': '/bin/bash', 07:56:51 INFO - 'SHLVL': '1', 07:56:51 INFO - 'TERM': 'linux', 07:56:51 INFO - 'TMOUT': '86400', 07:56:51 INFO - 'USER': 'cltbld', 07:56:51 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', 07:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:51 INFO - '_': '/tools/buildbot/bin/python'} 07:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:51 INFO - Downloading/unpacking jsonschema 07:56:51 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 07:56:51 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 07:56:51 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 07:56:51 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 07:56:51 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 07:56:51 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 07:56:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:56:53 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 07:56:53 INFO - Downloading/unpacking functools32 (from jsonschema) 07:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:53 INFO - Downloading functools32-3.2.3-2.tar.gz 07:56:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:56:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:56:53 INFO - warning: no files found matching '*.txt' 07:56:53 INFO - no previously-included directories found matching 'build' 07:56:53 INFO - no previously-included directories found matching 'dist' 07:56:53 INFO - no previously-included directories found matching '.git*' 07:56:53 INFO - Installing collected packages: jsonschema, functools32 07:56:53 INFO - Running setup.py install for functools32 07:56:53 INFO - warning: no files found matching '*.txt' 07:56:53 INFO - no previously-included directories found matching 'build' 07:56:53 INFO - no previously-included directories found matching 'dist' 07:56:53 INFO - no previously-included directories found matching '.git*' 07:56:53 INFO - Successfully installed jsonschema functools32 07:56:53 INFO - Cleaning up... 07:56:53 INFO - Return code: 0 07:56:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:56:53 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')]} 07:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:53 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')]} 07:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:53 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 0x7f41cbecef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2420840>, '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 0x238d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238db60>, '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': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', '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 07:56:53 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 07:56:53 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 07:56:53 INFO - Using env: {'DISPLAY': ':0', 07:56:53 INFO - 'HOME': '/home/cltbld', 07:56:53 INFO - 'LANG': 'en_US.UTF-8', 07:56:53 INFO - 'LANGUAGE': 'en_US:en', 07:56:53 INFO - 'LOGNAME': 'cltbld', 07:56:53 INFO - 'MAIL': '/var/mail/cltbld', 07:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:53 INFO - 'MOZ_NO_REMOTE': '1', 07:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:53 INFO - 'NO_EM_RESTART': '1', 07:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:53 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:53 INFO - 'SHELL': '/bin/bash', 07:56:53 INFO - 'SHLVL': '1', 07:56:53 INFO - 'TERM': 'linux', 07:56:53 INFO - 'TMOUT': '86400', 07:56:53 INFO - 'USER': 'cltbld', 07:56:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', 07:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:53 INFO - '_': '/tools/buildbot/bin/python'} 07:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:53 INFO - Downloading/unpacking flake8 07:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:56:55 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 07:56:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:56:55 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 07:56:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 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 07:56:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:56:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:56:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:56 INFO - no previously-included directories found matching 'docs/_build' 07:56:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:56:56 INFO - Running setup.py install for pep8 07:56:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:56 INFO - no previously-included directories found matching 'docs/_build' 07:56:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:56:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:56:56 INFO - Cleaning up... 07:56:56 INFO - Return code: 0 07:56:56 INFO - Running post-action listener: _resource_record_post_action 07:56:56 INFO - Running post-action listener: _start_resource_monitoring 07:56:56 INFO - Starting resource monitoring. 07:56:56 INFO - ##### 07:56:56 INFO - ##### Running install step. 07:56:56 INFO - ##### 07:56:56 INFO - Running pre-action listener: _resource_record_pre_action 07:56:56 INFO - Running main action method: install 07:56:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:56:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:56:56 INFO - Reading from file tmpfile_stdout 07:56:56 INFO - Detecting whether we're running mozinstall >=1.0... 07:56:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:56:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:56:56 INFO - Reading from file tmpfile_stdout 07:56:56 INFO - Output received: 07:56:56 INFO - Usage: mozinstall [options] installer 07:56:56 INFO - Options: 07:56:56 INFO - -h, --help show this help message and exit 07:56:56 INFO - -d DEST, --destination=DEST 07:56:56 INFO - Directory to install application into. [default: 07:56:56 INFO - "/builds/slave/test-pgo"] 07:56:56 INFO - --app=APP Application being installed. [default: firefox] 07:56:56 INFO - mkdir: /builds/slave/test-pgo/build/application 07:56:56 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'] 07:56:56 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 07:57:12 INFO - Reading from file tmpfile_stdout 07:57:12 INFO - Output received: 07:57:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:57:12 INFO - Running post-action listener: _resource_record_post_action 07:57:12 INFO - ##### 07:57:12 INFO - ##### Running run-tests step. 07:57:12 INFO - ##### 07:57:12 INFO - Running pre-action listener: _resource_record_pre_action 07:57:12 INFO - Running main action method: run_tests 07:57:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:57:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:57:12 INFO - Python 2.7.3 07:57:12 INFO - Return code: 0 07:57:12 INFO - grabbing minidump binary from tooltool 07:57:12 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')]} 07:57:12 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 0x2420840>, '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 0x238d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:57:12 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 07:57:12 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 07:57:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:57:12 INFO - Return code: 0 07:57:12 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:57:12 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:57:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:57:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:57:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:57:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:57:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:57:13 INFO - Return code: 0 07:57:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 07:57:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 07:57:13 INFO - Using env: {'DISPLAY': ':0', 07:57:13 INFO - 'HOME': '/home/cltbld', 07:57:13 INFO - 'LANG': 'en_US.UTF-8', 07:57:13 INFO - 'LANGUAGE': 'en_US:en', 07:57:13 INFO - 'LOGNAME': 'cltbld', 07:57:13 INFO - 'MAIL': '/var/mail/cltbld', 07:57:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:57:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:13 INFO - 'MOZ_NO_REMOTE': '1', 07:57:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:57:13 INFO - 'NO_EM_RESTART': '1', 07:57:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:57:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:57:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:57:13 INFO - 'SHELL': '/bin/bash', 07:57:13 INFO - 'SHLVL': '1', 07:57:13 INFO - 'TERM': 'linux', 07:57:13 INFO - 'TMOUT': '86400', 07:57:13 INFO - 'USER': 'cltbld', 07:57:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385', 07:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:13 INFO - '_': '/tools/buildbot/bin/python'} 07:57:13 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 07:57:13 INFO - mozversion application_buildid: 20160108053005 07:57:13 INFO - mozversion application_changeset: 9cd5467e15f1be886586351f9a52e36bf0de711c 07:57:13 INFO - mozversion application_display_name: Nightly 07:57:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:57:13 INFO - mozversion application_name: Firefox 07:57:14 INFO - mozversion application_remotingname: firefox 07:57:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 07:57:14 INFO - mozversion application_vendor: Mozilla 07:57:14 INFO - mozversion application_version: 46.0a1 07:57:14 INFO - mozversion platform_buildid: 20160108053005 07:57:14 INFO - mozversion platform_changeset: 9cd5467e15f1be886586351f9a52e36bf0de711c 07:57:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 07:57:14 INFO - mozversion platform_version: 46.0a1 07:57:14 INFO - using testdate: 1452268633 07:57:14 INFO - actual date: 1452268633 07:57:14 INFO - starting webserver on 'localhost:48561' 07:57:14 INFO - SUITE-START | Running 3 tests 07:57:14 INFO - TEST-START | dromaeo_css 07:57:14 INFO - operating with platform_type : linux_ 07:57:14 INFO - Initialising browser for dromaeo_css test... 07:57:14 INFO - TEST-INFO | started process 23015 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzxqbmt/profile http://localhost:48561/getInfo.html) 07:57:17 INFO - PROCESS | 23015 | __metrics Screen width/height:1600/1200 07:57:17 INFO - PROCESS | 23015 | colorDepth:24 07:57:17 INFO - PROCESS | 23015 | Browser inner width/height: 1024/697 07:57:17 INFO - PROCESS | 23015 | __metrics 07:57:18 INFO - PROCESS | 23015 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:57:18 INFO - PROCESS | 23015 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:57:19 INFO - TEST-INFO | 23015: exit 0 07:57:19 INFO - Browser initialized. 07:57:19 INFO - Running cycle 1/1 for dromaeo_css test... 07:57:19 INFO - TEST-INFO | started process 23106 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzxqbmt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:31 INFO - PROCESS | 23106 | RSS: Main: 150601728 07:57:31 INFO - PROCESS | 23106 | 07:58:22 INFO - PROCESS | 23106 | 1452268702515 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] 08:00:30 INFO - PROCESS | 23106 | Cycle 1(1): loaded http://localhost:48561/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48561/tests/dromaeo/cssquery-ext.html) 08:00:31 INFO - PROCESS | 23106 | RSS: Main: 330551296 08:00:31 INFO - PROCESS | 23106 | 08:03:34 INFO - PROCESS | 23106 | Cycle 1(1): loaded http://localhost:48561/tests/dromaeo/cssquery-ext.html (next: http://localhost:48561/tests/dromaeo/cssquery-jquery.html) 08:03:35 INFO - PROCESS | 23106 | RSS: Main: 231141376 08:03:35 INFO - PROCESS | 23106 | 08:06:37 INFO - PROCESS | 23106 | Cycle 1(1): loaded http://localhost:48561/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48561/tests/dromaeo/cssquery-mootools.html) 08:06:37 INFO - PROCESS | 23106 | RSS: Main: 247275520 08:06:37 INFO - PROCESS | 23106 | 08:09:39 INFO - PROCESS | 23106 | Cycle 1(1): loaded http://localhost:48561/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48561/tests/dromaeo/cssquery-prototype.html) 08:09:40 INFO - PROCESS | 23106 | RSS: Main: 215441408 08:09:40 INFO - PROCESS | 23106 | 08:12:42 INFO - PROCESS | 23106 | Cycle 1(1): loaded http://localhost:48561/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48561/tests/dromaeo/cssquery-yui.html) 08:12:43 INFO - PROCESS | 23106 | RSS: Main: 215965696 08:12:43 INFO - PROCESS | 23106 | 08:15:46 INFO - PROCESS | 23106 | Cycle 1(1): loaded http://localhost:48561/tests/dromaeo/cssquery-yui.html (next: http://localhost:48561/tests/dromaeo/cssquery-dojo.html) 08:15:46 INFO - PROCESS | 23106 | RSS: Main: 260685824 08:15:46 INFO - PROCESS | 23106 | 08:15:46 INFO - PROCESS | 23106 | __start_tp_report 08:15:46 INFO - PROCESS | 23106 | _x_x_mozilla_page_load 08:15:46 INFO - PROCESS | 23106 | _x_x_mozilla_page_load_details 08:15:46 INFO - PROCESS | 23106 | |i|pagename|runs| 08:15:46 INFO - PROCESS | 23106 | |0;dojo.html;3033.362993771308;3079.553464747613;3111.346617210387;3118.173683973746;3143.827089510077;4819.012102518984;4950.900981980359;4956.182229932061;4956.851294461163;4994.200927851544;4927.950720492794;4931.531504507075;4983.053219888218;5034.67274627149;5056.772445239963;4512.345709872066;4515.571020753023;4534.387857639218;4561.612262957653;4640.211164102111;4565.452145742515;4574.290984897346;4631.282151266559;4654.674172807905;4686.179918514264;4459.710118842265;4481.395011673431;4562.589366956973;4582.656300777422;4598.586127248547;4602.05657840142;4605.792739326738;4609.83865564707;4611.953880461219;4655.208614535537;4538.183127037132;4574.862754117382;4579.473360563545;4585.380973568559;4634.397528321297;4755.120302744003;4761.428628564559;4825.879353016167;4833.516648335173;4851.490593487703;5308.654937429054;5312.389075256357;5341.706206158659;5342.492463216027;5358.732063396854;5368.248445217672;5376.623636345457;5379.65032272905;5383.784648614051;5415.48552887475;4805.6155507559315;4900.58345040672;5017.67385119966;5021.723805190713;5127.025865085622;5331.70675612845;5342.679439233659;5368.3826359968325;5370.70461124634;5373.2746079278795;5189.455107213764;5195.9740201298755;5197.922031169535;5203.583713302926;5248.291480650139;5221.869453263623;5248.05535003703;5329.786808527693;5340.839774806762;5345.625806193529;5338.786448542015;5342.332208473941;5345.973270133624;5348.9465105348445;5355.357357117171;5336.7865285388925;5354.196870469461;5356.91964620531;5359.196120581944;5396.92061587684;4063.187362527506;4144.854930077433;4151.813168407429;4222.704410691222;4232.899446144024;3723.0506220913494;3745.1573395985683;3745.85016599333;3796.183820478555;3807.790571518593;4927.556519913153;4967.850964471072;4980;4980.05378977993;5020.648554601143;5209.4009188943;5276.551493123127;5309.41596424393;5312.150055991023;5312.946870531323;4973.577245934064;4992.176290912032;4996;4996.375453068366;5036.11867923112;4563.406757121553;4566.337881007302;4568.246239370533;4583.587477127075;4606.631469482433;5354.063038968165;5436.782528698808;5458.727063646802;5461.481159289861;5503.422140675251;5363.03465376236;5371.62398632092;5381.434949330421;5381.892362152813;5383.515483606494;5526;5545.029619816597;5547.057000310037;5547.833564992895;5594.328680558359;5206.5314121729225;5222.086134926449;5299.655522391032;5329.09405401075;5336.67979921206;5297.099493086262;5297.788088476418;5298;5301.125314323248;5305.098133317422;5183.611229157904;5183.663061901115;5187.351581052369;5190;5230.529252367153;5157.638965272545;5214.243934629381;5241.947580524146;5267.236250743697;5267.920981185209;5114.5652619527755;5133.512316329943;5133.8716532087;5136;5137.743112844418;5197.584193264605;5220.034293655686;5227.634065615371;5230.8169214077325;5233.659812112201;5088.6946783193125;5136.589072874086;5150.253213283978;5151.407588127413;5182.559482444034 08:15:46 INFO - PROCESS | 23106 | |1;ext.html;530.580841135503;531.8510816971248;560.7981126794356;566.8639526513638;568.2555851834097;28822;29530.261743456398;36290.63709362909;36847.4472882907;36855.815720921426;38973.415398769044;39341.8032909835;39391.21217575654;39399.80300098495;39402;7459.701611935543;8455.154484551542;8743.519106449143;8778.736637900873;8792.956035219848;7548.622568871562;7579.772606821776;7582.810429739246;9992.500374981259;10266.53800578972;10060.647877324294;10103.949480252588;10116.747081322988;10128.139108175814;10150.9492452538;9932.453715045669;10031.448270345092;10047.497625118714;10051.798964020678;10056;7611.2388761124;7836.686532538692;9964.202863770954;10232.232582556264;10242.743931401774;36303.27393452143;36745.63254367449;36830.815845920864;36854.26291474183;36868.63131368706;2995.341024974502;3279.2785587170783;3342.548755917944;3483.425234836249;3856.3636999894984;27856.16431507058;27874.860625696943;28231.57652635212;28594;28690.426191476054;3898.2788184185733;3920;4004.599540045972;4007.3788562772816;4117.505899292074;262103;262707;262794;263492;264224;52392.73803631034;53249.733751331;59301.703491482265;61568.69215653893;62497.68751156306;53690.73154634202;53797.46202538003;54297.45702542924;54314;54316.45683543193;13976.371063302176;14013.159210447406;14077.296135193199;14132.364043618061;14163.78754318686;11625.709357266136;11694.649160525198;11695.29828210293;11703.063754899587;11839.940800295943;19786;20141.697874531892;20288.797112028988;20374.28689995843;20418.591628167353;7173.1392232932385;7272.23641517633;7290.45321600882;7317.670704818296;7319.950413884121;965.8599503072156;980.8724865767405;1028.100412139378;1060.2631171336002;1120.4341807387218;26617.600735988977;27488.58767118495;27561;27897;27962.580561291597;996.7906739584623;1029.9691009269734;1064.164630764846;1099.9660319299833;1144.9771004579861;13383.933080334731;13452.596422107352;13612.93193534026;13787.586372408843;13803.723925521434;299949;309125;309275;309487;310063;50709.23936140961;50726;50734.238986415236;50735.49264507308;50818.237726434134;1204.4519743516678;1255.7739606870668;1321.5308565459509;1352.6821197018692;1360.333436616051;26400.339991500365;27797.861010694818;28026.579601306403;28252.15243542697;28265.71734282631;42702.145957080065;42849.35725964051;42962.57037429711;42984;43043;275902;283852;283995;342786;355782;30199.376074871157;30259.243518911324;30329.545056823725;30420.695793042672;30447.695523044487;38634.6136538631;39310.80344598373;39559.60440395674;39675.2064958705;40103;35683;35815.82092089523;36060.27879442449;36259.45610815893;36961.44557831581;36537.68731827416;36867.63132368642;37091;37342.626573735004;37433.43849842309;33930.321393572485;33939.15152121217;34324.828375857964;34631.82684086564;34859.4771078429;27063.323416914736;27095.86452067727;29635;30097.398052039276;30279.243018923822;23698.407539811644;23922.64116038226;23938.40153996164;24056.87971560131;24364.147254845997 08:15:46 INFO - PROCESS | 23106 | |2;jquery.html;365.8829174664107;365.9670629643333;367.28746232309317;367.50570482700766;371.4057507987219;13709.931450342734;13733.72532549351;16095.114768687718;16984.83015169848;17937.910310448446;14582.635434114152;14767.335469903854;14792.40830366784;14825.110493370405;15523;5189.403218629849;5373.328333958255;5375.973120134394;5376.892462150755;5379.488948549882;3969.126792105732;4136.420901073852;4141.378793181032;5331.813386531472;5540.252065971083;5598.664080155183;5710.514606258473;5711.685857277848;5719.971400143014;5729.598928075036;5819.127130930373;5890.263717035371;5895.882082358372;5896.823095307148;5902.3507414184405;4987.750612469398;5205.453427390107;5244.134717771563;5251.55361794248;5254.8686282842855;19838.70241946372;19928.202871885107;20128.597428051504;20134.29529966444;20240.49398765028;2062.669972804359;2201.6587428948537;2208.447888027993;2216.357256395643;2582.3802287451063;9588.472634005127;9711.757206069904;11905.523779048828;12008.579699710468;12421.93789031049;1777.4312220089575;1789.0696837644352;1860.367475058473;1878.8684792064562;1900.5343690795705;55152.172717409274;55399.72300138474;56015;56368.71815640936;56905.715471422795;9898.208143348515;10171;10246.333988290737;10248.948755256326;10276.280660353703;13442.596722098353;13548.11937224097;13555.390007449689;13561.932190338985;13571.796423053662;7294.635268236567;7343.436097125383;7352.96323518379;7395.371393431618;7529.322360987428;7073.363397294268;7167.175774785862;7167.9025976932435;7263.455240856957;7264.636768161571;3839.347310957144;4342.913141737147;4353.542877997765;4450.844220452269;4520.299353600131;1721.5467958159572;1723.0351003437863;1760.243095468935;1763.8059813420514;1780.7061834797373;898.4070513461085;975.878015248094;1004.909558139771;1010.6412223660494;1024.8616436781087;13734.381952812148;15323.616909577127;15612.3755049799;16027.19864006795;16765.413210537816;855.2302927365297;940.6472572785206;951.690700522333;985.8176237395961;1005.4269066631949;8018.55897925608;9197.448153110834;9324.580393882292;9439;9505.939968247223;449859;463075;485999;491415;495767;72206.277937221;72374.63812681008;72568.27431725721;72799.63600181966;73268;974.7270764185897;1035.7669524356959;1066.6906597086913;1168.5209064283604;1172.038928078967;15157.848421515644;15310.856480093018;15533.689326213187;15636.687266254383;15886.920565397098;33499.16252093717;33618.831905841296;33821.66178338185;34159.658403416644;34499.65500344965;41027.794861025504;42649.57350426456;42788.572114279705;43093;43187.35218971655;7033.085698859116;7264.802753770379;7475.700971961278;7482.102147742088;7546.358559522502;9666.56500457467;10675.359478431319;10923.617673381712;11082.61210857616;11372.601958931398;9566.13904748576;9571;9737.123658870736;9959.900400995897;9991;9144.63421463134;9192.540372981457;9496.47769372691;9501.809963800824;9901;3278.5737854078816;5763.971180144073;9713.951430242803;9812.950935245564;10010.849837252592;7337.853242935218;7461.365783908212;7650.387968962358;7663.770086897402;7685.03937007874;9700.951495242478;10206.081452669296;10221;10338.172946164139;10596.629117980834 08:15:46 INFO - PROCESS | 23106 | |3;mootools.html;1300.8829205371514;1460.824701035876;1462.3711803924311;1624.967500649987;1781.6347648732003;6941.965290173548;7508.249175082489;7625.8474830503355;7637.9236207637905;7644.082710074799;7466.365358944497;7661.655225514851;7669.271419215165;7669.769906902788;7670;2056.897155142244;2101.6006958677804;2253.5943530164564;2306.8385213035053;2332.0671731307443;2278.3392816083397;2282.5092605089903;2283.1095872609694;2287.1080278691325;2288.9542209155807;2161.319184456891;2303.366574192094;2303.435658263728;2305.1125316753005;2306.3426923326856;2286.0512887151813;2299.9195028174017;2301.827362947777;2318.466752646884;2325.430269583946;2290.89690963907;2310.722713274401;2310.9653355199684;2312.086725743322;2360.7167139943144;7736.381089512825;7788.299053085193;7791.532508049535;7793.766187014342;7801.687932482694;4725.763711814396;4822.6624136310475;4835.854924352275;4840.370751802278;4844.467108618049;3062.219134120785;3118.8440577971237;3155.652878183398;3164.762642801776;3185.681431856819;992.8758905136858;995.2933417273745;1012.4886932099242;1026.5893642542967;1034.8551202831609;10824.296420732628;10831.404272764994;10840.349579025205;10841.78316433667;10898.18263630223;4398.142362239332;4467.687261891637;4506.2564676828615;4525.162844873709;4529.411176547028;9347.626094956262;9439.150476457151;9464.763380915532;9465.242780577675;9465.337426380087;4791.5687588117235;4830.686005409637;4834.226523756182;4838.612910967185;4840.080384726891;4346.413234213341;4356.324769660708;4359.934600980988;4364.672649551297;4365.956340436555;3509.1402606361603;3554.608993010767;3711.8678802964814;3713.4986776785327;3770.1894092770185;1199.244475980127;1210.5339444314002;1218.8415505984165;1227.7176249462673;1229.3484453239798;1077.8167711489066;1096.6764804382726;1098.1160166066393;1237.0969192489533;1330.7072444062292;6882.7591034313555;7091.574505529582;7161.283871612901;7186;7206.135263768277;1090.5201711247025;1097.5390336058874;1100.5542755184163;1101.9228653994144;1118.3178261260625;5632;5666.093425052054;5670.461306175906;5672.659640421588;5681.0910254359105;9393.624255029723;9491.335606507479;9665.516724163763;9766.804663906823;9774.02259774017;9528.714138575853;9550.808983820285;9591.280653950982;9626.326157169071;9663.46850923206;7371.198944401201;7460.477766556289;7496.58768767723;7521.435892307989;7522.285382888617;7007.194172670208;7025.508214424941;7029.437644988491;7066.823329416806;7069.9646501767165;8181.263686268265;8453.78865528342;8581.613827377907;8650.178233067849;8660.783480412789;8818.691345802867;8831.02858685557;8837.690680826141;8843.115688431106;8852.29181665478;6956.373926346653;7184.317489838457;7185;7185.173705023989;7196.856062878818;6691.330866913465;6804.047433359433;7121.572705637471;7371.226021267904;7378.594177320084;6812.761553345609;6896.310368963063;7021.894671579828;7103.82240443993;7125.786226413215;6701.497387695845;6826.112605361272;6861.485388595976;6877.65611719422;6964.79657302055;6796.184457865088;6847.417969472452;6848.2466928638805;6854.760083397057;6857.074294970115;6257.749690012531;6435.613863168225;6442.645654488861;6443.7744678936015;6445.70994305248;6439.452646525097;6447.871042579216;6476.093346931528;6482.902756458751;6506.609603423621 08:15:46 INFO - PROCESS | 23106 | |4;prototype.html;326.6309070750052;331.844033304347;333.6130089096648;345.4904016575553;350.2906614106434;5662.17898404731;5774.018416869137;5777.133429985504;5814.215080964073;5852.824415267538;5610.859728506789;5747.741351639176;5762.049261871796;5766.423357664232;5772.653640781546;4477.350784136298;4481.843135490259;4489.753063581502;4499.595036446719;4502.617277531397;4273.401723758676;4342.240107981106;4347.847825326115;4353.172897149548;4494.797734101957;4318.244307246235;4338.891527711801;4413.558644135593;4432.578905004036;4438.911221775563;4404.515503294635;4413.735175889441;4424.778761061934;4430.9556904430865;4434.290513517838;3919.412088186766;3934.547527034399;3945.6843452524017;3954.149857780591;3957.168994511156;5385.5960802939935;5513.7794488220425;5516.558675305966;5518.503334699856;5520.66875987438;5164.6384753067305;5171.3535808024;5175.223716442526;5177.37871455424;5178.0679477694;6100.145979562864;6100.542459315525;6101.267847858241;6103.29812071613;6105.938940610581;4310.892227694301;4342.2401079811225;4351.5648435156545;4352.717073390219;4354.978225108885;6237.157983672191;6262.3111457739615;6403.135576697179;6413.454856337217;6433.453156481704;4445.866624001221;4446.088551846864;4446.333050042519;4448.110377924363;4449.7997590108525;4504.851262927932;4510.661700372485;4512.120136573337;4513.368128462018;4516.006478574708;5047.141985862412;5130.589552835764;5134.460881607452;5135.306733590992;5145.485451454824;6143.692815359214;6148.477379422709;6186.81439556814;6186.938130618726;6197.55196697302;1607.0357785328943;1614.7739316495465;1621.7891674082293;1627.6256461014034;1630.8450697183987;1112.9387883666477;1117.5864929975799;1121.4897221764077;1133.4616057372848;1141.50915106505;5883.17635531026;5885.882282354329;5891.998360278762;5892.6759028253;5903;6105.755769769248;6297.622142671455;6327.3988971047675;6335.841603959938;6357.396047375492;5756.798512052058;5840.269966254218;5860.677662728505;5921.555883308769;5950.702464876739;3406.0463070340343;3430.644895266356;3436.1237884339835;3436.329915666471;3443.517907492953;6393.328700486475;6596.73613055482;6597.373249541286;6599.175103112111;6602.2737498875085;6504.089427480062;6557.180352455943;6580.703868325937;6581.572197807127;6592.538522303488;6562.967185164043;6605.933940660532;6609.173853268341;6610.735570577219;6629.635370054597;6187.628742275478;6390.169277993831;6399.136116624196;6410.294867564658;6414.743410263537;6333.1766870306565;6339.112524246517;6346.2067241594805;6352.269489008823;6356.046593011085;6566.540342176002;6593.868122637617;6609.768658096944;6613.338666133348;6615;4369.929367305031;4403.471583410012;4410.625096866802;4416.227160247008;4423.292273236267;6239.313675495782;6400.615963042233;6402.679866006774;6402.711877965409;6402.807915762534;6243.687815609111;6244.250689917239;6247.125402443752;6249.25008998923;6249.281332646804;6212.968935155295;6213.968930155501;6217.160683307696;6218.906716399348;6224.62652240867;5958.612690175125;6084.6349219047;6103.145559621567;6115.4190351916495;6127.479164270909;6248.968755156195;6252.406021427957;6253.593516421418;6258.499320054476;6258.906116408349;5853.824385268449;6101.054336577838;6106.267247930276;6107.328193898757;6117.021276595723 08:15:46 INFO - PROCESS | 23106 | |5;yui.html;720.6720941971404;723.5875550935968;732.7605439681113;734.5152199548297;787.1459466478871;13240.139390939583;13618;13620.727585448285;13631.386587603556;13667.726645467084;12564.811527827067;12621.495140194382;12647.62057138285;12660.113792034539;12728.93635531821;667.0927538547584;679.4768028617962;785.4344871692373;793.5159552672894;800.3757069485811;797.2744802229972;802.9116797152309;806.4596720197452;806.9435139540205;810.0158307656196;847.7499137754377;848.2111636178352;848.3255811629738;850.086157380815;850.0988951711206;697.7557854750822;704.380145471984;827.0819390476566;839.6977088248226;845.382870504529;620.011082323693;620.9037599172091;621.801023672425;622.3838399984029;622.4895585619794;13102.148360356547;13109.737805243936;13136.6715832104;13152.21086734799;13155.53955611549;12062.939685301604;12552.497900083985;13009.544665936646;13087.41106650203;13238.470461181541;10335.638252661196;10424.895751042468;10436.947815260952;10954.342739435659;11102.222844400896;3564.2515071834946;3600.225951420457;3607.206414588786;3608.9278214435826;3671.375866102769;45151.322730159074;45602.54397456016;45681.31478027832;45728.54271457276;45800;9835.311528192959;10036.899631003742;10072.395656260647;10264.728782766688;10409.063184313449;17341.132943352783;17356.13219339028;17357.13214339278;17437.564060898578;17438.302467901394;7250.891236631454;7320.7071717131785;7346.33882950537;7535.924640753632;8021.719239826578;4399.186150562156;4483.484399294058;4492.505824359318;4526.864194074183;4531.728096314232;3115.6572776994512;3120.8595613197463;3124.4376012318003;3133.7963032403277;3138.450771115046;570.1447828257614;576.4437317988162;576.8990426675399;580.4398755201252;602.0457574743992;508.3594670714852;597.3041406761075;598.3986093975614;635.9713812878432;654.3456543456543;7903.288704016666;8073.434859559892;8079.272865442138;8166.346692264605;8175.223353781381;483.1713611156883;531.1050879268445;536.7906516458585;574.9568782341341;579.9507041901401;3631.4008188649104;3634.636536346344;3712.1833196696684;3715.8142092895787;3866.74866133706;51894.48105518897;52473.21290180574;52541.47458525442;52603.73698131561;54118.45881541213;47723.04553908972;48155.75922120367;49234;49771;49872.50127498751;39776.20447591032;40086.1982760349;41675.37486937698;44197.337039944425;45298;8152.307053900247;8415.663373464993;8601.784955375915;8807.647694092164;8812.603432845666;31396;31599.526007110373;32089.67910320867;32463.18842028968;32778.83610581932;38237.235255295294;38363;38698.806505968416;42345.576544234165;42480.57519424766;10316.793664126526;10513.474326283807;10516;10940;10993.450327483753;11630.127740419333;12230.44962976686;12445.502179913065;12545.31000794965;12692.428840702007;10993.890061099606;11021.283616565219;11046.779064418828;11310.773784524099;11781.823272651089;10559.841602375816;10748.516316765608;10931.344119352865;11026.173037022096;11287.322760634388;7642.579658118634;9032.232260257952;11050.834237486284;11196.216264861381;11499.195056345976;8541.572921354033;8981;9173.633054677739;9346.813063738551;9371.671991480265;9468.431894086378;9742.171915387271;9842.901570984199;9908.455034973145;9961.452120133463 08:15:46 INFO - PROCESS | 23106 | __end_tp_report 08:15:46 INFO - PROCESS | 23106 | __start_cc_report 08:15:46 INFO - PROCESS | 23106 | _x_x_mozilla_cycle_collect,1445 08:15:46 INFO - PROCESS | 23106 | __end_cc_report 08:15:46 INFO - PROCESS | 23106 | __startTimestamp1452269746256__endTimestamp 08:15:46 INFO - PROCESS | 23106 | 08:15:46 INFO - PROCESS | 23106 | ------- Summary: start ------- 08:15:46 INFO - PROCESS | 23106 | Number of tests: 6 08:15:46 INFO - PROCESS | 23106 | 08:15:46 INFO - PROCESS | 23106 | [#0] dojo.html Cycles:165 Average:4958.47 Median:5150.25 stddev:517.40 (10.0%) stddev-sans-first:496.46 08:15:46 INFO - PROCESS | 23106 | Values: 3033.4 3079.6 3111.3 3118.2 3143.8 4819.0 4950.9 4956.2 4956.9 4994.2 4928.0 4931.5 4983.1 5034.7 5056.8 4512.3 4515.6 4534.4 4561.6 4640.2 4565.5 4574.3 4631.3 4654.7 4686.2 4459.7 4481.4 4562.6 4582.7 4598.6 4602.1 4605.8 4609.8 4612.0 4655.2 4538.2 4574.9 4579.5 4585.4 4634.4 4755.1 4761.4 4825.9 4833.5 4851.5 5308.7 5312.4 5341.7 5342.5 5358.7 5368.2 5376.6 5379.7 5383.8 5415.5 4805.6 4900.6 5017.7 5021.7 5127.0 5331.7 5342.7 5368.4 5370.7 5373.3 5189.5 5196.0 5197.9 5203.6 5248.3 5221.9 5248.1 5329.8 5340.8 5345.6 5338.8 5342.3 5346.0 5348.9 5355.4 5336.8 5354.2 5356.9 5359.2 5396.9 4063.2 4144.9 4151.8 4222.7 4232.9 3723.1 3745.2 3745.9 3796.2 3807.8 4927.6 4967.9 4980.0 4980.1 5020.6 5209.4 5276.6 5309.4 5312.2 5312.9 4973.6 4992.2 4996.0 4996.4 5036.1 4563.4 4566.3 4568.2 4583.6 4606.6 5354.1 5436.8 5458.7 5461.5 5503.4 5363.0 5371.6 5381.4 5381.9 5383.5 5526.0 5545.0 5547.1 5547.8 5594.3 5206.5 5222.1 5299.7 5329.1 5336.7 5297.1 5297.8 5298.0 5301.1 5305.1 5183.6 5183.7 5187.4 5190.0 5230.5 5157.6 5214.2 5241.9 5267.2 5267.9 5114.6 5133.5 5133.9 5136.0 5137.7 5197.6 5220.0 5227.6 5230.8 5233.7 5088.7 5136.6 5150.3 5151.4 5182.6 08:15:46 INFO - PROCESS | 23106 | 08:15:46 INFO - PROCESS | 23106 | [#1] ext.html Cycles:180 Average:45348.84 Median:3310.91 stddev:77013.94 (2326.1%) stddev-sans-first:77156.47 08:15:46 INFO - PROCESS | 23106 | Values: 530.6 531.9 560.8 566.9 568.3 28822.0 29530.3 36290.6 36847.4 36855.8 38973.4 39341.8 39391.2 39399.8 39402.0 7459.7 8455.2 8743.5 8778.7 8793.0 7548.6 7579.8 7582.8 9992.5 10266.5 10060.6 10103.9 10116.7 10128.1 10150.9 9932.5 10031.4 10047.5 10051.8 10056.0 7611.2 7836.7 9964.2 10232.2 10242.7 36303.3 36745.6 36830.8 36854.3 36868.6 2995.3 3279.3 3342.5 3483.4 3856.4 27856.2 27874.9 28231.6 28594.0 28690.4 3898.3 3920.0 4004.6 4007.4 4117.5 262103.0 262707.0 262794.0 263492.0 264224.0 52392.7 53249.7 59301.7 61568.7 62497.7 53690.7 53797.5 54297.5 54314.0 54316.5 13976.4 14013.2 14077.3 14132.4 14163.8 11625.7 11694.6 11695.3 11703.1 11839.9 19786.0 20141.7 20288.8 20374.3 20418.6 7173.1 7272.2 7290.5 7317.7 7320.0 965.9 980.9 1028.1 1060.3 1120.4 26617.6 27488.6 27561.0 27897.0 27962.6 996.8 1030.0 1064.2 1100.0 1145.0 13383.9 13452.6 13612.9 13787.6 13803.7 299949.0 309125.0 309275.0 309487.0 310063.0 50709.2 50726.0 50734.2 50735.5 50818.2 1204.5 1255.8 1321.5 1352.7 1360.3 26400.3 27797.9 28026.6 28252.2 28265.7 42702.1 42849.4 42962.6 42984.0 43043.0 275902.0 283852.0 283995.0 342786.0 355782.0 30199.4 30259.2 30329.5 30420.7 30447.7 38634.6 39310.8 39559.6 39675.2 40103.0 35683.0 35815.8 36060.3 36259.5 36961.4 36537.7 36867.6 37091.0 37342.6 37433.4 33930.3 33939.2 34324.8 34631.8 34859.5 27063.3 27095.9 29635.0 30097.4 30279.2 23698.4 23922.6 23938.4 24056.9 24364.1 08:15:46 INFO - PROCESS | 23106 | 08:15:46 INFO - PROCESS | 23106 | [#2] jquery.html Cycles:180 Average:25708.48 Median:4402.19 stddev:78097.39 (1774.1%) stddev-sans-first:78293.29 08:15:46 INFO - PROCESS | 23106 | Values: 365.9 366.0 367.3 367.5 371.4 13709.9 13733.7 16095.1 16984.8 17937.9 14582.6 14767.3 14792.4 14825.1 15523.0 5189.4 5373.3 5376.0 5376.9 5379.5 3969.1 4136.4 4141.4 5331.8 5540.3 5598.7 5710.5 5711.7 5720.0 5729.6 5819.1 5890.3 5895.9 5896.8 5902.4 4987.8 5205.5 5244.1 5251.6 5254.9 19838.7 19928.2 20128.6 20134.3 20240.5 2062.7 2201.7 2208.4 2216.4 2582.4 9588.5 9711.8 11905.5 12008.6 12421.9 1777.4 1789.1 1860.4 1878.9 1900.5 55152.2 55399.7 56015.0 56368.7 56905.7 9898.2 10171.0 10246.3 10248.9 10276.3 13442.6 13548.1 13555.4 13561.9 13571.8 7294.6 7343.4 7353.0 7395.4 7529.3 7073.4 7167.2 7167.9 7263.5 7264.6 3839.3 4342.9 4353.5 4450.8 4520.3 1721.5 1723.0 1760.2 1763.8 1780.7 898.4 975.9 1004.9 1010.6 1024.9 13734.4 15323.6 15612.4 16027.2 16765.4 855.2 940.6 951.7 985.8 1005.4 8018.6 9197.4 9324.6 9439.0 9505.9 449859.0 463075.0 485999.0 491415.0 495767.0 72206.3 72374.6 72568.3 72799.6 73268.0 974.7 1035.8 1066.7 1168.5 1172.0 15157.8 15310.9 15533.7 15636.7 15886.9 33499.2 33618.8 33821.7 34159.7 34499.7 41027.8 42649.6 42788.6 43093.0 43187.4 7033.1 7264.8 7475.7 7482.1 7546.4 9666.6 10675.4 10923.6 11082.6 11372.6 9566.1 9571.0 9737.1 9959.9 9991.0 9144.6 9192.5 9496.5 9501.8 9901.0 3278.6 5764.0 9714.0 9813.0 10010.8 7337.9 7461.4 7650.4 7663.8 7685.0 9701.0 10206.1 10221.0 10338.2 10596.6 08:15:46 INFO - PROCESS | 23106 | 08:15:46 INFO - PROCESS | 23106 | [#3] mootools.html Cycles:180 Average:5485.13 Median:6441.05 stddev:2846.58 (44.2%) stddev-sans-first:2837.19 08:15:46 INFO - PROCESS | 23106 | Values: 1300.9 1460.8 1462.4 1625.0 1781.6 6942.0 7508.2 7625.8 7637.9 7644.1 7466.4 7661.7 7669.3 7669.8 7670.0 2056.9 2101.6 2253.6 2306.8 2332.1 2278.3 2282.5 2283.1 2287.1 2289.0 2161.3 2303.4 2303.4 2305.1 2306.3 2286.1 2299.9 2301.8 2318.5 2325.4 2290.9 2310.7 2311.0 2312.1 2360.7 7736.4 7788.3 7791.5 7793.8 7801.7 4725.8 4822.7 4835.9 4840.4 4844.5 3062.2 3118.8 3155.7 3164.8 3185.7 992.9 995.3 1012.5 1026.6 1034.9 10824.3 10831.4 10840.3 10841.8 10898.2 4398.1 4467.7 4506.3 4525.2 4529.4 9347.6 9439.2 9464.8 9465.2 9465.3 4791.6 4830.7 4834.2 4838.6 4840.1 4346.4 4356.3 4359.9 4364.7 4366.0 3509.1 3554.6 3711.9 3713.5 3770.2 1199.2 1210.5 1218.8 1227.7 1229.3 1077.8 1096.7 1098.1 1237.1 1330.7 6882.8 7091.6 7161.3 7186.0 7206.1 1090.5 1097.5 1100.6 1101.9 1118.3 5632.0 5666.1 5670.5 5672.7 5681.1 9393.6 9491.3 9665.5 9766.8 9774.0 9528.7 9550.8 9591.3 9626.3 9663.5 7371.2 7460.5 7496.6 7521.4 7522.3 7007.2 7025.5 7029.4 7066.8 7070.0 8181.3 8453.8 8581.6 8650.2 8660.8 8818.7 8831.0 8837.7 8843.1 8852.3 6956.4 7184.3 7185.0 7185.2 7196.9 6691.3 6804.0 7121.6 7371.2 7378.6 6812.8 6896.3 7021.9 7103.8 7125.8 6701.5 6826.1 6861.5 6877.7 6964.8 6796.2 6847.4 6848.2 6854.8 6857.1 6257.7 6435.6 6442.6 6443.8 6445.7 6439.5 6447.9 6476.1 6482.9 6506.6 08:15:46 INFO - PROCESS | 23106 | 08:15:46 INFO - PROCESS | 23106 | [#4] prototype.html Cycles:180 Average:5167.67 Median:5846.55 stddev:1540.72 (26.4%) stddev-sans-first:1501.59 08:15:46 INFO - PROCESS | 23106 | Values: 326.6 331.8 333.6 345.5 350.3 5662.2 5774.0 5777.1 5814.2 5852.8 5610.9 5747.7 5762.0 5766.4 5772.7 4477.4 4481.8 4489.8 4499.6 4502.6 4273.4 4342.2 4347.8 4353.2 4494.8 4318.2 4338.9 4413.6 4432.6 4438.9 4404.5 4413.7 4424.8 4431.0 4434.3 3919.4 3934.5 3945.7 3954.1 3957.2 5385.6 5513.8 5516.6 5518.5 5520.7 5164.6 5171.4 5175.2 5177.4 5178.1 6100.1 6100.5 6101.3 6103.3 6105.9 4310.9 4342.2 4351.6 4352.7 4355.0 6237.2 6262.3 6403.1 6413.5 6433.5 4445.9 4446.1 4446.3 4448.1 4449.8 4504.9 4510.7 4512.1 4513.4 4516.0 5047.1 5130.6 5134.5 5135.3 5145.5 6143.7 6148.5 6186.8 6186.9 6197.6 1607.0 1614.8 1621.8 1627.6 1630.8 1112.9 1117.6 1121.5 1133.5 1141.5 5883.2 5885.9 5892.0 5892.7 5903.0 6105.8 6297.6 6327.4 6335.8 6357.4 5756.8 5840.3 5860.7 5921.6 5950.7 3406.0 3430.6 3436.1 3436.3 3443.5 6393.3 6596.7 6597.4 6599.2 6602.3 6504.1 6557.2 6580.7 6581.6 6592.5 6563.0 6605.9 6609.2 6610.7 6629.6 6187.6 6390.2 6399.1 6410.3 6414.7 6333.2 6339.1 6346.2 6352.3 6356.0 6566.5 6593.9 6609.8 6613.3 6615.0 4369.9 4403.5 4410.6 4416.2 4423.3 6239.3 6400.6 6402.7 6402.7 6402.8 6243.7 6244.3 6247.1 6249.3 6249.3 6213.0 6214.0 6217.2 6218.9 6224.6 5958.6 6084.6 6103.1 6115.4 6127.5 6249.0 6252.4 6253.6 6258.5 6258.9 5853.8 6101.1 6106.3 6107.3 6117.0 08:15:46 INFO - PROCESS | 23106 | 08:15:46 INFO - PROCESS | 23106 | [#5] yui.html Cycles:180 Average:13090.01 Median:24912.43 stddev:14718.47 (59.1%) stddev-sans-first:14730.45 08:15:46 INFO - PROCESS | 23106 | Values: 720.7 723.6 732.8 734.5 787.1 13240.1 13618.0 13620.7 13631.4 13667.7 12564.8 12621.5 12647.6 12660.1 12728.9 667.1 679.5 785.4 793.5 800.4 797.3 802.9 806.5 806.9 810.0 847.7 848.2 848.3 850.1 850.1 697.8 704.4 827.1 839.7 845.4 620.0 620.9 621.8 622.4 622.5 13102.1 13109.7 13136.7 13152.2 13155.5 12062.9 12552.5 13009.5 13087.4 13238.5 10335.6 10424.9 10436.9 10954.3 11102.2 3564.3 3600.2 3607.2 3608.9 3671.4 45151.3 45602.5 45681.3 45728.5 45800.0 9835.3 10036.9 10072.4 10264.7 10409.1 17341.1 17356.1 17357.1 17437.6 17438.3 7250.9 7320.7 7346.3 7535.9 8021.7 4399.2 4483.5 4492.5 4526.9 4531.7 3115.7 3120.9 3124.4 3133.8 3138.5 570.1 576.4 576.9 580.4 602.0 508.4 597.3 598.4 636.0 654.3 7903.3 8073.4 8079.3 8166.3 8175.2 483.2 531.1 536.8 575.0 580.0 3631.4 3634.6 3712.2 3715.8 3866.7 51894.5 52473.2 52541.5 52603.7 54118.5 47723.0 48155.8 49234.0 49771.0 49872.5 39776.2 40086.2 41675.4 44197.3 45298.0 8152.3 8415.7 8601.8 8807.6 8812.6 31396.0 31599.5 32089.7 32463.2 32778.8 38237.2 38363.0 38698.8 42345.6 42480.6 10316.8 10513.5 10516.0 10940.0 10993.5 11630.1 12230.4 12445.5 12545.3 12692.4 10993.9 11021.3 11046.8 11310.8 11781.8 10559.8 10748.5 10931.3 11026.2 11287.3 7642.6 9032.2 11050.8 11196.2 11499.2 8541.6 8981.0 9173.6 9346.8 9371.7 9468.4 9742.2 9842.9 9908.5 9961.5 08:15:46 INFO - PROCESS | 23106 | -------- Summary: end -------- 08:15:46 INFO - PROCESS | 23106 | 08:15:46 INFO - TEST-INFO | 23106: exit 0 08:15:46 INFO - TEST-OK | dromaeo_css | took 1112898ms 08:15:46 INFO - TEST-START | kraken 08:15:46 INFO - operating with platform_type : linux_ 08:15:46 INFO - Initialising browser for kraken test... 08:15:46 INFO - TEST-INFO | started process 23304 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpifrcAW/profile http://localhost:48561/getInfo.html) 08:15:51 INFO - PROCESS | 23304 | __metrics Screen width/height:1600/1200 08:15:51 INFO - PROCESS | 23304 | colorDepth:24 08:15:51 INFO - PROCESS | 23304 | Browser inner width/height: 1024/697 08:15:51 INFO - PROCESS | 23304 | __metrics 08:15:51 INFO - PROCESS | 23304 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:15:51 INFO - PROCESS | 23304 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:51 INFO - PROCESS | 23304 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 08:15:52 INFO - TEST-INFO | 23304: exit 0 08:15:52 INFO - Browser initialized. 08:15:52 INFO - Running cycle 1/1 for kraken test... 08:15:52 INFO - TEST-INFO | started process 23386 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpifrcAW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:03 INFO - PROCESS | 23386 | RSS: Main: 147730432 08:16:03 INFO - PROCESS | 23386 | 08:16:06 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48561/tests/kraken/driver.html?testName=audio-beat-detection) 08:16:07 INFO - PROCESS | 23386 | RSS: Main: 183656448 08:16:07 INFO - PROCESS | 23386 | 08:16:09 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48561/tests/kraken/driver.html?testName=audio-dft) 08:16:10 INFO - PROCESS | 23386 | RSS: Main: 174223360 08:16:10 INFO - PROCESS | 23386 | 08:16:13 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48561/tests/kraken/driver.html?testName=audio-fft) 08:16:13 INFO - PROCESS | 23386 | RSS: Main: 159617024 08:16:13 INFO - PROCESS | 23386 | 08:16:15 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48561/tests/kraken/driver.html?testName=audio-oscillator) 08:16:16 INFO - PROCESS | 23386 | RSS: Main: 161677312 08:16:16 INFO - PROCESS | 23386 | 08:16:18 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48561/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:16:19 INFO - PROCESS | 23386 | RSS: Main: 163278848 08:16:19 INFO - PROCESS | 23386 | 08:16:21 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48561/tests/kraken/driver.html?testName=imaging-darkroom) 08:16:22 INFO - PROCESS | 23386 | RSS: Main: 164171776 08:16:22 INFO - PROCESS | 23386 | 08:16:25 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48561/tests/kraken/driver.html?testName=imaging-desaturate) 08:16:26 INFO - PROCESS | 23386 | RSS: Main: 164532224 08:16:26 INFO - PROCESS | 23386 | 08:16:29 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48561/tests/kraken/driver.html?testName=json-parse-financial) 08:16:29 INFO - PROCESS | 23386 | RSS: Main: 163504128 08:16:29 INFO - PROCESS | 23386 | 08:16:31 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48561/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:16:31 INFO - PROCESS | 23386 | RSS: Main: 174211072 08:16:31 INFO - PROCESS | 23386 | 08:16:33 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48561/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:16:34 INFO - PROCESS | 23386 | RSS: Main: 172179456 08:16:34 INFO - PROCESS | 23386 | 08:16:36 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48561/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:16:36 INFO - PROCESS | 23386 | RSS: Main: 182284288 08:16:36 INFO - PROCESS | 23386 | 08:16:39 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:16:39 INFO - PROCESS | 23386 | RSS: Main: 188776448 08:16:39 INFO - PROCESS | 23386 | 08:16:42 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:16:43 INFO - PROCESS | 23386 | RSS: Main: 188112896 08:16:43 INFO - PROCESS | 23386 | 08:16:44 INFO - PROCESS | 23386 | Cycle 1(1): loaded http://localhost:48561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48561/tests/kraken/driver.html?testName=ai-astar) 08:16:45 INFO - PROCESS | 23386 | RSS: Main: 246743040 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | __start_tp_report 08:16:45 INFO - PROCESS | 23386 | _x_x_mozilla_page_load 08:16:45 INFO - PROCESS | 23386 | _x_x_mozilla_page_load_details 08:16:45 INFO - PROCESS | 23386 | |i|pagename|runs| 08:16:45 INFO - PROCESS | 23386 | |0;ai-astar;111;109;104;110;110;110;99;109;109;109 08:16:45 INFO - PROCESS | 23386 | |1;audio-beat-detection;154;127;152;162;125;153;148;124;172;126 08:16:45 INFO - PROCESS | 23386 | |2;audio-dft;161;163;160;160;162;160;164;162;162;162 08:16:45 INFO - PROCESS | 23386 | |3;audio-fft;75;72;85;90;71;71;74;98;95;71 08:16:45 INFO - PROCESS | 23386 | |4;audio-oscillator;95;96;139;94;97;96;141;96;95;138 08:16:45 INFO - PROCESS | 23386 | |5;imaging-gaussian-blur;109;109;109;109;110;110;110;109;110;109 08:16:45 INFO - PROCESS | 23386 | |6;imaging-darkroom;146;145;145;145;145;145;145;145;146;145 08:16:45 INFO - PROCESS | 23386 | |7;imaging-desaturate;96;97;95;95;96;96;96;96;96;96 08:16:45 INFO - PROCESS | 23386 | |8;json-parse-financial;58;58;58;58;57;57;58;65;55;55 08:16:45 INFO - PROCESS | 23386 | |9;json-stringify-tinderbox;66;66;67;67;66;66;66;67;67;67 08:16:45 INFO - PROCESS | 23386 | |10;stanford-crypto-aes;84;85;85;85;85;85;86;86;86;85 08:16:45 INFO - PROCESS | 23386 | |11;stanford-crypto-ccm;114;125;120;122;116;121;123;124;113;121 08:16:45 INFO - PROCESS | 23386 | |12;stanford-crypto-pbkdf2;156;140;151;161;152;142;152;151;150;142 08:16:45 INFO - PROCESS | 23386 | |13;stanford-crypto-sha256-iterative;68;68;68;68;69;67;67;70;68;73 08:16:45 INFO - PROCESS | 23386 | __end_tp_report 08:16:45 INFO - PROCESS | 23386 | __start_cc_report 08:16:45 INFO - PROCESS | 23386 | _x_x_mozilla_cycle_collect,956 08:16:45 INFO - PROCESS | 23386 | __end_cc_report 08:16:45 INFO - PROCESS | 23386 | __startTimestamp1452269805119__endTimestamp 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | ------- Summary: start ------- 08:16:45 INFO - PROCESS | 23386 | Number of tests: 14 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:3.68 (3.3%) stddev-sans-first:3.74 08:16:45 INFO - PROCESS | 23386 | Values: 111.0 109.0 104.0 110.0 110.0 110.0 99.0 109.0 109.0 109.0 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:152.50 stddev:17.46 (11.4%) stddev-sans-first:18.16 08:16:45 INFO - PROCESS | 23386 | Values: 154.0 127.0 152.0 162.0 125.0 153.0 148.0 124.0 172.0 126.0 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.41 08:16:45 INFO - PROCESS | 23386 | Values: 161.0 163.0 160.0 160.0 162.0 160.0 164.0 162.0 162.0 162.0 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#3] audio-fft Cycles:10 Average:80.20 Median:80.00 stddev:10.76 (13.4%) stddev-sans-first:11.24 08:16:45 INFO - PROCESS | 23386 | Values: 75.0 72.0 85.0 90.0 71.0 71.0 74.0 98.0 95.0 71.0 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:95.50 stddev:21.17 (22.2%) stddev-sans-first:21.86 08:16:45 INFO - PROCESS | 23386 | Values: 95.0 96.0 139.0 94.0 97.0 96.0 141.0 96.0 95.0 138.0 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:16:45 INFO - PROCESS | 23386 | Values: 109.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 110.0 109.0 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 08:16:45 INFO - PROCESS | 23386 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:16:45 INFO - PROCESS | 23386 | Values: 96.0 97.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:2.77 (4.8%) stddev-sans-first:2.93 08:16:45 INFO - PROCESS | 23386 | Values: 58.0 58.0 58.0 58.0 57.0 57.0 58.0 65.0 55.0 55.0 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 08:16:45 INFO - PROCESS | 23386 | Values: 66.0 66.0 67.0 67.0 66.0 66.0 66.0 67.0 67.0 67.0 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 08:16:45 INFO - PROCESS | 23386 | Values: 84.0 85.0 85.0 85.0 85.0 85.0 86.0 86.0 86.0 85.0 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:121.50 stddev:4.18 (3.4%) stddev-sans-first:3.84 08:16:45 INFO - PROCESS | 23386 | Values: 114.0 125.0 120.0 122.0 116.0 121.0 123.0 124.0 113.0 121.0 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:151.50 stddev:6.62 (4.4%) stddev-sans-first:6.61 08:16:45 INFO - PROCESS | 23386 | Values: 156.0 140.0 151.0 161.0 152.0 142.0 152.0 151.0 150.0 142.0 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - PROCESS | 23386 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:1.78 (2.6%) stddev-sans-first:1.87 08:16:45 INFO - PROCESS | 23386 | Values: 68.0 68.0 68.0 68.0 69.0 67.0 67.0 70.0 68.0 73.0 08:16:45 INFO - PROCESS | 23386 | -------- Summary: end -------- 08:16:45 INFO - PROCESS | 23386 | 08:16:45 INFO - TEST-INFO | 23386: exit 0 08:16:46 INFO - TEST-OK | kraken | took 59183ms 08:16:46 INFO - TEST-START | v8_7 08:16:46 INFO - operating with platform_type : linux_ 08:16:46 INFO - Initialising browser for v8_7 test... 08:16:46 INFO - TEST-INFO | started process 23639 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpT2knWp/profile http://localhost:48561/getInfo.html) 08:16:49 INFO - PROCESS | 23639 | __metrics Screen width/height:1600/1200 08:16:49 INFO - PROCESS | 23639 | colorDepth:24 08:16:49 INFO - PROCESS | 23639 | Browser inner width/height: 1024/697 08:16:49 INFO - PROCESS | 23639 | __metrics 08:16:50 INFO - PROCESS | 23639 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:16:50 INFO - PROCESS | 23639 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:51 INFO - TEST-INFO | 23639: exit 0 08:16:51 INFO - Browser initialized. 08:16:51 INFO - Running cycle 1/1 for v8_7 test... 08:16:51 INFO - TEST-INFO | started process 23721 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpT2knWp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:03 INFO - PROCESS | 23721 | RSS: Main: 150175744 08:17:03 INFO - PROCESS | 23721 | 08:17:25 INFO - PROCESS | 23721 | Cycle 1(1): loaded http://localhost:48561/tests/v8_7/run.html (next: http://localhost:48561/tests/v8_7/run.html) 08:17:25 INFO - PROCESS | 23721 | RSS: Main: 570232832 08:17:25 INFO - PROCESS | 23721 | 08:17:25 INFO - PROCESS | 23721 | __start_tp_report 08:17:25 INFO - PROCESS | 23721 | _x_x_mozilla_page_load 08:17:25 INFO - PROCESS | 23721 | _x_x_mozilla_page_load_details 08:17:25 INFO - PROCESS | 23721 | |i|pagename|runs| 08:17:25 INFO - PROCESS | 23721 | |0;Richards;167.7570877369569 08:17:25 INFO - PROCESS | 23721 | |1;DeltaBlue;190.43991620643686 08:17:25 INFO - PROCESS | 23721 | |2;Encrypt;281.0567734682406 08:17:25 INFO - PROCESS | 23721 | |3;Decrypt;5256.544502617801 08:17:25 INFO - PROCESS | 23721 | |4;RayTrace;1992.03187250996 08:17:25 INFO - PROCESS | 23721 | |5;Earley;798.7220447284345 08:17:25 INFO - PROCESS | 23721 | |6;Boyer;12358.024691358025 08:17:25 INFO - PROCESS | 23721 | |7;RegExp;42102.04081632653 08:17:25 INFO - PROCESS | 23721 | |8;Splay;586.9947275922672 08:17:25 INFO - PROCESS | 23721 | |9;NavierStokes;4840.579710144928 08:17:25 INFO - PROCESS | 23721 | __end_tp_report 08:17:25 INFO - PROCESS | 23721 | __startTimestamp1452269845676__endTimestamp 08:17:25 INFO - PROCESS | 23721 | 08:17:25 INFO - PROCESS | 23721 | ------- Summary: start ------- 08:17:25 INFO - PROCESS | 23721 | Number of tests: 10 08:17:25 INFO - PROCESS | 23721 | 08:17:25 INFO - PROCESS | 23721 | [#0] Richards Cycles:1 Average:167.76 Median:167.76 stddev:0.00 (0.0%) 08:17:25 INFO - PROCESS | 23721 | Values: 167.8 08:17:25 INFO - PROCESS | 23721 | 08:17:25 INFO - PROCESS | 23721 | [#1] DeltaBlue Cycles:1 Average:190.44 Median:190.44 stddev:0.00 (0.0%) 08:17:25 INFO - PROCESS | 23721 | Values: 190.4 08:17:25 INFO - PROCESS | 23721 | 08:17:25 INFO - PROCESS | 23721 | [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 08:17:25 INFO - PROCESS | 23721 | Values: 281.1 08:17:25 INFO - PROCESS | 23721 | 08:17:25 INFO - PROCESS | 23721 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 08:17:25 INFO - PROCESS | 23721 | Values: 5256.5 08:17:25 INFO - PROCESS | 23721 | 08:17:25 INFO - PROCESS | 23721 | [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 08:17:25 INFO - PROCESS | 23721 | Values: 1992.0 08:17:25 INFO - PROCESS | 23721 | 08:17:25 INFO - PROCESS | 23721 | [#5] Earley Cycles:1 Average:798.72 Median:798.72 stddev:0.00 (0.0%) 08:17:25 INFO - PROCESS | 23721 | Values: 798.7 08:17:25 INFO - PROCESS | 23721 | 08:17:25 INFO - PROCESS | 23721 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 08:17:25 INFO - PROCESS | 23721 | Values: 12358.0 08:17:25 INFO - PROCESS | 23721 | 08:17:25 INFO - PROCESS | 23721 | [#7] RegExp Cycles:1 Average:42102.04 Median:42102.04 stddev:0.00 (0.0%) 08:17:25 INFO - PROCESS | 23721 | Values: 42102.0 08:17:25 INFO - PROCESS | 23721 | 08:17:25 INFO - PROCESS | 23721 | [#8] Splay Cycles:1 Average:586.99 Median:586.99 stddev:0.00 (0.0%) 08:17:25 INFO - PROCESS | 23721 | Values: 587.0 08:17:25 INFO - PROCESS | 23721 | 08:17:25 INFO - PROCESS | 23721 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 08:17:25 INFO - PROCESS | 23721 | Values: 4840.6 08:17:25 INFO - PROCESS | 23721 | -------- Summary: end -------- 08:17:25 INFO - PROCESS | 23721 | 08:17:26 INFO - TEST-INFO | 23721: exit 0 08:17:26 INFO - TEST-OK | v8_7 | took 40428ms 08:17:26 INFO - SUITE-END | took 1212s 08:17:26 INFO - Completed test suite (00:20:12) 08:17:26 INFO - Working with test: dromaeo_css 08:17:26 INFO - Generating results file: dromaeo_css 08:17:26 INFO - Working with test: kraken 08:17:26 INFO - Generating results file: kraken 08:17:26 INFO - javascript benchmark 08:17:26 INFO - Working with test: v8_7 08:17:26 INFO - Generating results file: v8_7 08:17:26 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:17:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 08:17:26 INFO - process_Request line: dromaeo_css 6722.24 graph.html#tests=[[72,201,35]] 08:17:26 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:17:26 INFO - process_Request line: kraken 1501.10 graph.html#tests=[[232,201,35]] 08:17:26 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:17:26 INFO - process_Request line: v8_7 18858.22 graph.html#tests=[[230,201,35]] 08:17:26 INFO - RETURN: dromaeo_css: 6722.24 08:17:26 INFO - RETURN: kraken: 1501.10 08:17:26 INFO - RETURN: v8_7: 18858.22 08:17:26 INFO - javascript benchmark 08:17:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3033.362993771308, 3079.553464747613, 3111.346617210387, 3118.173683973746, 3143.827089510077, 4819.012102518984, 4950.900981980359, 4956.182229932061, 4956.851294461163, 4994.200927851544, 4927.950720492794, 4931.531504507075, 4983.053219888218, 5034.67274627149, 5056.772445239963, 4512.345709872066, 4515.571020753023, 4534.387857639218, 4561.612262957653, 4640.211164102111, 4565.452145742515, 4574.290984897346, 4631.282151266559, 4654.674172807905, 4686.179918514264, 4459.710118842265, 4481.395011673431, 4562.589366956973, 4582.656300777422, 4598.586127248547, 4602.05657840142, 4605.792739326738, 4609.83865564707, 4611.953880461219, 4655.208614535537, 4538.183127037132, 4574.862754117382, 4579.473360563545, 4585.380973568559, 4634.397528321297, 4755.120302744003, 4761.428628564559, 4825.879353016167, 4833.516648335173, 4851.490593487703, 5308.654937429054, 5312.389075256357, 5341.706206158659, 5342.492463216027, 5358.732063396854, 5368.248445217672, 5376.623636345457, 5379.65032272905, 5383.784648614051, 5415.48552887475, 4805.6155507559315, 4900.58345040672, 5017.67385119966, 5021.723805190713, 5127.025865085622, 5331.70675612845, 5342.679439233659, 5368.3826359968325, 5370.70461124634, 5373.2746079278795, 5189.455107213764, 5195.9740201298755, 5197.922031169535, 5203.583713302926, 5248.291480650139, 5221.869453263623, 5248.05535003703, 5329.786808527693, 5340.839774806762, 5345.625806193529, 5338.786448542015, 5342.332208473941, 5345.973270133624, 5348.9465105348445, 5355.357357117171, 5336.7865285388925, 5354.196870469461, 5356.91964620531, 5359.196120581944, 5396.92061587684, 4063.187362527506, 4144.854930077433, 4151.813168407429, 4222.704410691222, 4232.899446144024, 3723.0506220913494, 3745.1573395985683, 3745.85016599333, 3796.183820478555, 3807.790571518593, 4927.556519913153, 4967.850964471072, 4980.0, 4980.05378977993, 5020.648554601143, 5209.4009188943, 5276.551493123127, 5309.41596424393, 5312.150055991023, 5312.946870531323, 4973.577245934064, 4992.176290912032, 4996.0, 4996.375453068366, 5036.11867923112, 4563.406757121553, 4566.337881007302, 4568.246239370533, 4583.587477127075, 4606.631469482433, 5354.063038968165, 5436.782528698808, 5458.727063646802, 5461.481159289861, 5503.422140675251, 5363.03465376236, 5371.62398632092, 5381.434949330421, 5381.892362152813, 5383.515483606494, 5526.0, 5545.029619816597, 5547.057000310037, 5547.833564992895, 5594.328680558359, 5206.5314121729225, 5222.086134926449, 5299.655522391032, 5329.09405401075, 5336.67979921206, 5297.099493086262, 5297.788088476418, 5298.0, 5301.125314323248, 5305.098133317422, 5183.611229157904, 5183.663061901115, 5187.351581052369, 5190.0, 5230.529252367153, 5157.638965272545, 5214.243934629381, 5241.947580524146, 5267.236250743697, 5267.920981185209, 5114.5652619527755, 5133.512316329943, 5133.8716532087, 5136.0, 5137.743112844418, 5197.584193264605, 5220.034293655686, 5227.634065615371, 5230.8169214077325, 5233.659812112201, 5088.6946783193125, 5136.589072874086, 5150.253213283978, 5151.407588127413, 5182.559482444034], "unit": "score", "name": "dojo.html", "value": 4927.307468205545}, {"lowerIsBetter": false, "replicates": [530.580841135503, 531.8510816971248, 560.7981126794356, 566.8639526513638, 568.2555851834097, 28822.0, 29530.261743456398, 36290.63709362909, 36847.4472882907, 36855.815720921426, 38973.415398769044, 39341.8032909835, 39391.21217575654, 39399.80300098495, 39402.0, 7459.701611935543, 8455.154484551542, 8743.519106449143, 8778.736637900873, 8792.956035219848, 7548.622568871562, 7579.772606821776, 7582.810429739246, 9992.500374981259, 10266.53800578972, 10060.647877324294, 10103.949480252588, 10116.747081322988, 10128.139108175814, 10150.9492452538, 9932.453715045669, 10031.448270345092, 10047.497625118714, 10051.798964020678, 10056.0, 7611.2388761124, 7836.686532538692, 9964.202863770954, 10232.232582556264, 10242.743931401774, 36303.27393452143, 36745.63254367449, 36830.815845920864, 36854.26291474183, 36868.63131368706, 2995.341024974502, 3279.2785587170783, 3342.548755917944, 3483.425234836249, 3856.3636999894984, 27856.16431507058, 27874.860625696943, 28231.57652635212, 28594.0, 28690.426191476054, 3898.2788184185733, 3920.0, 4004.599540045972, 4007.3788562772816, 4117.505899292074, 262103.0, 262707.0, 262794.0, 263492.0, 264224.0, 52392.73803631034, 53249.733751331, 59301.703491482265, 61568.69215653893, 62497.68751156306, 53690.73154634202, 53797.46202538003, 54297.45702542924, 54314.0, 54316.45683543193, 13976.371063302176, 14013.159210447406, 14077.296135193199, 14132.364043618061, 14163.78754318686, 11625.709357266136, 11694.649160525198, 11695.29828210293, 11703.063754899587, 11839.940800295943, 19786.0, 20141.697874531892, 20288.797112028988, 20374.28689995843, 20418.591628167353, 7173.1392232932385, 7272.23641517633, 7290.45321600882, 7317.670704818296, 7319.950413884121, 965.8599503072156, 980.8724865767405, 1028.100412139378, 1060.2631171336002, 1120.4341807387218, 26617.600735988977, 27488.58767118495, 27561.0, 27897.0, 27962.580561291597, 996.7906739584623, 1029.9691009269734, 1064.164630764846, 1099.9660319299833, 1144.9771004579861, 13383.933080334731, 13452.596422107352, 13612.93193534026, 13787.586372408843, 13803.723925521434, 299949.0, 309125.0, 309275.0, 309487.0, 310063.0, 50709.23936140961, 50726.0, 50734.238986415236, 50735.49264507308, 50818.237726434134, 1204.4519743516678, 1255.7739606870668, 1321.5308565459509, 1352.6821197018692, 1360.333436616051, 26400.339991500365, 27797.861010694818, 28026.579601306403, 28252.15243542697, 28265.71734282631, 42702.145957080065, 42849.35725964051, 42962.57037429711, 42984.0, 43043.0, 275902.0, 283852.0, 283995.0, 342786.0, 355782.0, 30199.376074871157, 30259.243518911324, 30329.545056823725, 30420.695793042672, 30447.695523044487, 38634.6136538631, 39310.80344598373, 39559.60440395674, 39675.2064958705, 40103.0, 35683.0, 35815.82092089523, 36060.27879442449, 36259.45610815893, 36961.44557831581, 36537.68731827416, 36867.63132368642, 37091.0, 37342.626573735004, 37433.43849842309, 33930.321393572485, 33939.15152121217, 34324.828375857964, 34631.82684086564, 34859.4771078429, 27063.323416914736, 27095.86452067727, 29635.0, 30097.398052039276, 30279.243018923822, 23698.407539811644, 23922.64116038226, 23938.40153996164, 24056.87971560131, 24364.147254845997], "unit": "score", "name": "ext.html", "value": 18021.79952003099}, {"lowerIsBetter": false, "replicates": [365.8829174664107, 365.9670629643333, 367.28746232309317, 367.50570482700766, 371.4057507987219, 13709.931450342734, 13733.72532549351, 16095.114768687718, 16984.83015169848, 17937.910310448446, 14582.635434114152, 14767.335469903854, 14792.40830366784, 14825.110493370405, 15523.0, 5189.403218629849, 5373.328333958255, 5375.973120134394, 5376.892462150755, 5379.488948549882, 3969.126792105732, 4136.420901073852, 4141.378793181032, 5331.813386531472, 5540.252065971083, 5598.664080155183, 5710.514606258473, 5711.685857277848, 5719.971400143014, 5729.598928075036, 5819.127130930373, 5890.263717035371, 5895.882082358372, 5896.823095307148, 5902.3507414184405, 4987.750612469398, 5205.453427390107, 5244.134717771563, 5251.55361794248, 5254.8686282842855, 19838.70241946372, 19928.202871885107, 20128.597428051504, 20134.29529966444, 20240.49398765028, 2062.669972804359, 2201.6587428948537, 2208.447888027993, 2216.357256395643, 2582.3802287451063, 9588.472634005127, 9711.757206069904, 11905.523779048828, 12008.579699710468, 12421.93789031049, 1777.4312220089575, 1789.0696837644352, 1860.367475058473, 1878.8684792064562, 1900.5343690795705, 55152.172717409274, 55399.72300138474, 56015.0, 56368.71815640936, 56905.715471422795, 9898.208143348515, 10171.0, 10246.333988290737, 10248.948755256326, 10276.280660353703, 13442.596722098353, 13548.11937224097, 13555.390007449689, 13561.932190338985, 13571.796423053662, 7294.635268236567, 7343.436097125383, 7352.96323518379, 7395.371393431618, 7529.322360987428, 7073.363397294268, 7167.175774785862, 7167.9025976932435, 7263.455240856957, 7264.636768161571, 3839.347310957144, 4342.913141737147, 4353.542877997765, 4450.844220452269, 4520.299353600131, 1721.5467958159572, 1723.0351003437863, 1760.243095468935, 1763.8059813420514, 1780.7061834797373, 898.4070513461085, 975.878015248094, 1004.909558139771, 1010.6412223660494, 1024.8616436781087, 13734.381952812148, 15323.616909577127, 15612.3755049799, 16027.19864006795, 16765.413210537816, 855.2302927365297, 940.6472572785206, 951.690700522333, 985.8176237395961, 1005.4269066631949, 8018.55897925608, 9197.448153110834, 9324.580393882292, 9439.0, 9505.939968247223, 449859.0, 463075.0, 485999.0, 491415.0, 495767.0, 72206.277937221, 72374.63812681008, 72568.27431725721, 72799.63600181966, 73268.0, 974.7270764185897, 1035.7669524356959, 1066.6906597086913, 1168.5209064283604, 1172.038928078967, 15157.848421515644, 15310.856480093018, 15533.689326213187, 15636.687266254383, 15886.920565397098, 33499.16252093717, 33618.831905841296, 33821.66178338185, 34159.658403416644, 34499.65500344965, 41027.794861025504, 42649.57350426456, 42788.572114279705, 43093.0, 43187.35218971655, 7033.085698859116, 7264.802753770379, 7475.700971961278, 7482.102147742088, 7546.358559522502, 9666.56500457467, 10675.359478431319, 10923.617673381712, 11082.61210857616, 11372.601958931398, 9566.13904748576, 9571.0, 9737.123658870736, 9959.900400995897, 9991.0, 9144.63421463134, 9192.540372981457, 9496.47769372691, 9501.809963800824, 9901.0, 3278.5737854078816, 5763.971180144073, 9713.951430242803, 9812.950935245564, 10010.849837252592, 7337.853242935218, 7461.365783908212, 7650.387968962358, 7663.770086897402, 7685.03937007874, 9700.951495242478, 10206.081452669296, 10221.0, 10338.172946164139, 10596.629117980834], "unit": "score", "name": "jquery.html", "value": 8099.695464892278}, {"lowerIsBetter": false, "replicates": [1300.8829205371514, 1460.824701035876, 1462.3711803924311, 1624.967500649987, 1781.6347648732003, 6941.965290173548, 7508.249175082489, 7625.8474830503355, 7637.9236207637905, 7644.082710074799, 7466.365358944497, 7661.655225514851, 7669.271419215165, 7669.769906902788, 7670.0, 2056.897155142244, 2101.6006958677804, 2253.5943530164564, 2306.8385213035053, 2332.0671731307443, 2278.3392816083397, 2282.5092605089903, 2283.1095872609694, 2287.1080278691325, 2288.9542209155807, 2161.319184456891, 2303.366574192094, 2303.435658263728, 2305.1125316753005, 2306.3426923326856, 2286.0512887151813, 2299.9195028174017, 2301.827362947777, 2318.466752646884, 2325.430269583946, 2290.89690963907, 2310.722713274401, 2310.9653355199684, 2312.086725743322, 2360.7167139943144, 7736.381089512825, 7788.299053085193, 7791.532508049535, 7793.766187014342, 7801.687932482694, 4725.763711814396, 4822.6624136310475, 4835.854924352275, 4840.370751802278, 4844.467108618049, 3062.219134120785, 3118.8440577971237, 3155.652878183398, 3164.762642801776, 3185.681431856819, 992.8758905136858, 995.2933417273745, 1012.4886932099242, 1026.5893642542967, 1034.8551202831609, 10824.296420732628, 10831.404272764994, 10840.349579025205, 10841.78316433667, 10898.18263630223, 4398.142362239332, 4467.687261891637, 4506.2564676828615, 4525.162844873709, 4529.411176547028, 9347.626094956262, 9439.150476457151, 9464.763380915532, 9465.242780577675, 9465.337426380087, 4791.5687588117235, 4830.686005409637, 4834.226523756182, 4838.612910967185, 4840.080384726891, 4346.413234213341, 4356.324769660708, 4359.934600980988, 4364.672649551297, 4365.956340436555, 3509.1402606361603, 3554.608993010767, 3711.8678802964814, 3713.4986776785327, 3770.1894092770185, 1199.244475980127, 1210.5339444314002, 1218.8415505984165, 1227.7176249462673, 1229.3484453239798, 1077.8167711489066, 1096.6764804382726, 1098.1160166066393, 1237.0969192489533, 1330.7072444062292, 6882.7591034313555, 7091.574505529582, 7161.283871612901, 7186.0, 7206.135263768277, 1090.5201711247025, 1097.5390336058874, 1100.5542755184163, 1101.9228653994144, 1118.3178261260625, 5632.0, 5666.093425052054, 5670.461306175906, 5672.659640421588, 5681.0910254359105, 9393.624255029723, 9491.335606507479, 9665.516724163763, 9766.804663906823, 9774.02259774017, 9528.714138575853, 9550.808983820285, 9591.280653950982, 9626.326157169071, 9663.46850923206, 7371.198944401201, 7460.477766556289, 7496.58768767723, 7521.435892307989, 7522.285382888617, 7007.194172670208, 7025.508214424941, 7029.437644988491, 7066.823329416806, 7069.9646501767165, 8181.263686268265, 8453.78865528342, 8581.613827377907, 8650.178233067849, 8660.783480412789, 8818.691345802867, 8831.02858685557, 8837.690680826141, 8843.115688431106, 8852.29181665478, 6956.373926346653, 7184.317489838457, 7185.0, 7185.173705023989, 7196.856062878818, 6691.330866913465, 6804.047433359433, 7121.572705637471, 7371.226021267904, 7378.594177320084, 6812.761553345609, 6896.310368963063, 7021.894671579828, 7103.82240443993, 7125.786226413215, 6701.497387695845, 6826.112605361272, 6861.485388595976, 6877.65611719422, 6964.79657302055, 6796.184457865088, 6847.417969472452, 6848.2466928638805, 6854.760083397057, 6857.074294970115, 6257.749690012531, 6435.613863168225, 6442.645654488861, 6443.7744678936015, 6445.70994305248, 6439.452646525097, 6447.871042579216, 6476.093346931528, 6482.902756458751, 6506.609603423621], "unit": "score", "name": "mootools.html", "value": 4509.750386456735}, {"lowerIsBetter": false, "replicates": [326.6309070750052, 331.844033304347, 333.6130089096648, 345.4904016575553, 350.2906614106434, 5662.17898404731, 5774.018416869137, 5777.133429985504, 5814.215080964073, 5852.824415267538, 5610.859728506789, 5747.741351639176, 5762.049261871796, 5766.423357664232, 5772.653640781546, 4477.350784136298, 4481.843135490259, 4489.753063581502, 4499.595036446719, 4502.617277531397, 4273.401723758676, 4342.240107981106, 4347.847825326115, 4353.172897149548, 4494.797734101957, 4318.244307246235, 4338.891527711801, 4413.558644135593, 4432.578905004036, 4438.911221775563, 4404.515503294635, 4413.735175889441, 4424.778761061934, 4430.9556904430865, 4434.290513517838, 3919.412088186766, 3934.547527034399, 3945.6843452524017, 3954.149857780591, 3957.168994511156, 5385.5960802939935, 5513.7794488220425, 5516.558675305966, 5518.503334699856, 5520.66875987438, 5164.6384753067305, 5171.3535808024, 5175.223716442526, 5177.37871455424, 5178.0679477694, 6100.145979562864, 6100.542459315525, 6101.267847858241, 6103.29812071613, 6105.938940610581, 4310.892227694301, 4342.2401079811225, 4351.5648435156545, 4352.717073390219, 4354.978225108885, 6237.157983672191, 6262.3111457739615, 6403.135576697179, 6413.454856337217, 6433.453156481704, 4445.866624001221, 4446.088551846864, 4446.333050042519, 4448.110377924363, 4449.7997590108525, 4504.851262927932, 4510.661700372485, 4512.120136573337, 4513.368128462018, 4516.006478574708, 5047.141985862412, 5130.589552835764, 5134.460881607452, 5135.306733590992, 5145.485451454824, 6143.692815359214, 6148.477379422709, 6186.81439556814, 6186.938130618726, 6197.55196697302, 1607.0357785328943, 1614.7739316495465, 1621.7891674082293, 1627.6256461014034, 1630.8450697183987, 1112.9387883666477, 1117.5864929975799, 1121.4897221764077, 1133.4616057372848, 1141.50915106505, 5883.17635531026, 5885.882282354329, 5891.998360278762, 5892.6759028253, 5903.0, 6105.755769769248, 6297.622142671455, 6327.3988971047675, 6335.841603959938, 6357.396047375492, 5756.798512052058, 5840.269966254218, 5860.677662728505, 5921.555883308769, 5950.702464876739, 3406.0463070340343, 3430.644895266356, 3436.1237884339835, 3436.329915666471, 3443.517907492953, 6393.328700486475, 6596.73613055482, 6597.373249541286, 6599.175103112111, 6602.2737498875085, 6504.089427480062, 6557.180352455943, 6580.703868325937, 6581.572197807127, 6592.538522303488, 6562.967185164043, 6605.933940660532, 6609.173853268341, 6610.735570577219, 6629.635370054597, 6187.628742275478, 6390.169277993831, 6399.136116624196, 6410.294867564658, 6414.743410263537, 6333.1766870306565, 6339.112524246517, 6346.2067241594805, 6352.269489008823, 6356.046593011085, 6566.540342176002, 6593.868122637617, 6609.768658096944, 6613.338666133348, 6615.0, 4369.929367305031, 4403.471583410012, 4410.625096866802, 4416.227160247008, 4423.292273236267, 6239.313675495782, 6400.615963042233, 6402.679866006774, 6402.711877965409, 6402.807915762534, 6243.687815609111, 6244.250689917239, 6247.125402443752, 6249.25008998923, 6249.281332646804, 6212.968935155295, 6213.968930155501, 6217.160683307696, 6218.906716399348, 6224.62652240867, 5958.612690175125, 6084.6349219047, 6103.145559621567, 6115.4190351916495, 6127.479164270909, 6248.968755156195, 6252.406021427957, 6253.593516421418, 6258.499320054476, 6258.906116408349, 5853.824385268449, 6101.054336577838, 6106.267247930276, 6107.328193898757, 6117.021276595723], "unit": "score", "name": "prototype.html", "value": 4676.873642021427}, {"lowerIsBetter": false, "replicates": [720.6720941971404, 723.5875550935968, 732.7605439681113, 734.5152199548297, 787.1459466478871, 13240.139390939583, 13618.0, 13620.727585448285, 13631.386587603556, 13667.726645467084, 12564.811527827067, 12621.495140194382, 12647.62057138285, 12660.113792034539, 12728.93635531821, 667.0927538547584, 679.4768028617962, 785.4344871692373, 793.5159552672894, 800.3757069485811, 797.2744802229972, 802.9116797152309, 806.4596720197452, 806.9435139540205, 810.0158307656196, 847.7499137754377, 848.2111636178352, 848.3255811629738, 850.086157380815, 850.0988951711206, 697.7557854750822, 704.380145471984, 827.0819390476566, 839.6977088248226, 845.382870504529, 620.011082323693, 620.9037599172091, 621.801023672425, 622.3838399984029, 622.4895585619794, 13102.148360356547, 13109.737805243936, 13136.6715832104, 13152.21086734799, 13155.53955611549, 12062.939685301604, 12552.497900083985, 13009.544665936646, 13087.41106650203, 13238.470461181541, 10335.638252661196, 10424.895751042468, 10436.947815260952, 10954.342739435659, 11102.222844400896, 3564.2515071834946, 3600.225951420457, 3607.206414588786, 3608.9278214435826, 3671.375866102769, 45151.322730159074, 45602.54397456016, 45681.31478027832, 45728.54271457276, 45800.0, 9835.311528192959, 10036.899631003742, 10072.395656260647, 10264.728782766688, 10409.063184313449, 17341.132943352783, 17356.13219339028, 17357.13214339278, 17437.564060898578, 17438.302467901394, 7250.891236631454, 7320.7071717131785, 7346.33882950537, 7535.924640753632, 8021.719239826578, 4399.186150562156, 4483.484399294058, 4492.505824359318, 4526.864194074183, 4531.728096314232, 3115.6572776994512, 3120.8595613197463, 3124.4376012318003, 3133.7963032403277, 3138.450771115046, 570.1447828257614, 576.4437317988162, 576.8990426675399, 580.4398755201252, 602.0457574743992, 508.3594670714852, 597.3041406761075, 598.3986093975614, 635.9713812878432, 654.3456543456543, 7903.288704016666, 8073.434859559892, 8079.272865442138, 8166.346692264605, 8175.223353781381, 483.1713611156883, 531.1050879268445, 536.7906516458585, 574.9568782341341, 579.9507041901401, 3631.4008188649104, 3634.636536346344, 3712.1833196696684, 3715.8142092895787, 3866.74866133706, 51894.48105518897, 52473.21290180574, 52541.47458525442, 52603.73698131561, 54118.45881541213, 47723.04553908972, 48155.75922120367, 49234.0, 49771.0, 49872.50127498751, 39776.20447591032, 40086.1982760349, 41675.37486937698, 44197.337039944425, 45298.0, 8152.307053900247, 8415.663373464993, 8601.784955375915, 8807.647694092164, 8812.603432845666, 31396.0, 31599.526007110373, 32089.67910320867, 32463.18842028968, 32778.83610581932, 38237.235255295294, 38363.0, 38698.806505968416, 42345.576544234165, 42480.57519424766, 10316.793664126526, 10513.474326283807, 10516.0, 10940.0, 10993.450327483753, 11630.127740419333, 12230.44962976686, 12445.502179913065, 12545.31000794965, 12692.428840702007, 10993.890061099606, 11021.283616565219, 11046.779064418828, 11310.773784524099, 11781.823272651089, 10559.841602375816, 10748.516316765608, 10931.344119352865, 11026.173037022096, 11287.322760634388, 7642.579658118634, 9032.232260257952, 11050.834237486284, 11196.216264861381, 11499.195056345976, 8541.572921354033, 8981.0, 9173.633054677739, 9346.813063738551, 9371.671991480265, 9468.431894086378, 9742.171915387271, 9842.901570984199, 9908.455034973145, 9961.452120133463], "unit": "score", "name": "yui.html", "value": 6082.193509774699}], "name": "dromaeo_css", "value": 6722.238911945123}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 104.0, 110.0, 110.0, 110.0, 99.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 152.0, 162.0, 125.0, 153.0, 148.0, 124.0, 172.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 160.0, 160.0, 162.0, 160.0, 164.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 85.0, 90.0, 71.0, 71.0, 74.0, 98.0, 95.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 139.0, 94.0, 97.0, 96.0, 141.0, 96.0, 95.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0, 65.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 86.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [114.0, 125.0, 120.0, 122.0, 116.0, 121.0, 123.0, 124.0, 113.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [156.0, 140.0, 151.0, 161.0, 152.0, 142.0, 152.0, 151.0, 150.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 67.0, 67.0, 70.0, 68.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1501.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7570877369569], "unit": "score", "name": "Richards", "value": 210.43522200000004}, {"lowerIsBetter": false, "replicates": [190.43991620643686], "unit": "score", "name": "DeltaBlue", "value": 347.1856180000001}, {"lowerIsBetter": false, "replicates": [281.0567734682406], "unit": "score", "name": "Encrypt", "value": 947.0719979999998}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [798.7220447284345], "unit": "score", "name": "Earley", "value": 834.4116759999996}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [42102.04081632653], "unit": "score", "name": "RegExp", "value": 21.637549684924874}, {"lowerIsBetter": false, "replicates": [586.9947275922672], "unit": "score", "name": "Splay", "value": 138.8274820359282}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 18858.217954897416}]} 08:17:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18858.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1501.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6722.24"}}} 08:17:26 INFO - Return code: 0 08:17:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:17:26 INFO - # TBPL SUCCESS # 08:17:26 INFO - Running post-action listener: _resource_record_post_action 08:17:26 INFO - Running post-run listener: _resource_record_post_run 08:17:28 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 564899840; Read time: 0; Write time: 451488 08:17:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243232768; Read time: 0; Write time: 275440 08:17:28 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 321667072; Read time: 0; Write time: 176048 08:17:28 INFO - Running post-run listener: _upload_blobber_files 08:17:28 INFO - Blob upload gear active. 08:17:28 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:17:28 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 08:17:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:17:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:17:28 INFO - (blobuploader) - INFO - Open directory for files ... 08:17:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:17:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:17:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:29 INFO - (blobuploader) - INFO - Done attempting. 08:17:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:17:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:17:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:30 INFO - (blobuploader) - INFO - Done attempting. 08:17:30 INFO - (blobuploader) - INFO - Iteration through files over. 08:17:30 INFO - Return code: 0 08:17:30 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:17:30 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:17:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/809460c52175cd0f3f27bca2e84caaf95cd9c617cade56979c70cdf791ee28e293936f3c5be572910439e37cd3500f66ed620e6c8754427f423282731bfc24d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1040b0a44ddc265b819f92f6a72f27189069087c9ec2b9a280d5060cbc319de4f7322e6554a642c08bcf102085d11a7032a62b37e279ca54e84625ce7774d4da"} 08:17:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:17:30 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:17:30 INFO - Contents: 08:17:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/809460c52175cd0f3f27bca2e84caaf95cd9c617cade56979c70cdf791ee28e293936f3c5be572910439e37cd3500f66ed620e6c8754427f423282731bfc24d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1040b0a44ddc265b819f92f6a72f27189069087c9ec2b9a280d5060cbc319de4f7322e6554a642c08bcf102085d11a7032a62b37e279ca54e84625ce7774d4da"} 08:17:30 INFO - Copying logs to upload dir... 08:17:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.574332 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-08 08:17:29.884799) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 08:17:29.888432) ========= 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=cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/809460c52175cd0f3f27bca2e84caaf95cd9c617cade56979c70cdf791ee28e293936f3c5be572910439e37cd3500f66ed620e6c8754427f423282731bfc24d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1040b0a44ddc265b819f92f6a72f27189069087c9ec2b9a280d5060cbc319de4f7322e6554a642c08bcf102085d11a7032a62b37e279ca54e84625ce7774d4da"} build_url:https://queue.taskcluster.net/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/KvyJ1YsxQy-OSIrC8BW7oQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/809460c52175cd0f3f27bca2e84caaf95cd9c617cade56979c70cdf791ee28e293936f3c5be572910439e37cd3500f66ed620e6c8754427f423282731bfc24d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1040b0a44ddc265b819f92f6a72f27189069087c9ec2b9a280d5060cbc319de4f7322e6554a642c08bcf102085d11a7032a62b37e279ca54e84625ce7774d4da"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 08:17:29.912826) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 08:17:29.913136) ========= 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=cbe409c6de289db6ac707de3000001d4-1452268582.735128-1470712385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 08:17:29.995780) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 08:17:29.996124) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 08:17:29.996411) ========= ========= Total master_lag: 0.22 =========