builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1452798051.26 results: success (0) buildid: 20160114083200 builduid: 0c4c1f12287048f0a3922e0532f69ffb revision: 5097ab0e8aec9b85b05e5f60b41a18cf79917b01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.262950) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.263313) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.263582) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006365 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.303154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.303450) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.344843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.345102) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004619 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.393496) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.393759) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.394111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.394381) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 11:00:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.6M=0s 2016-01-14 11:00:51 (37.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158564 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.564987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.565275) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017632 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.614687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:51.615073) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 5097ab0e8aec9b85b05e5f60b41a18cf79917b01 --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 5097ab0e8aec9b85b05e5f60b41a18cf79917b01 --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=8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 11:00:51,798 truncating revision to first 12 chars 2016-01-14 11:00:51,798 Setting DEBUG logging. 2016-01-14 11:00:51,798 attempt 1/10 2016-01-14 11:00:51,798 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/5097ab0e8aec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 11:00:52,064 unpacking tar archive at: b2g-inbound-5097ab0e8aec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565039 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:52.193581) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:52.193891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:52.201693) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:52.201952) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 11:00:52.204392) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-14 11:00:52.204679) ========= /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=8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:00:52 INFO - MultiFileLogger online at 20160114 11:00:52 in /builds/slave/test-pgo 11:00:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 11:00:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:00:52 INFO - {'append_to_log': False, 11:00:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:00:52 INFO - 'blob_upload_branch': 'B2G-Inbound', 11:00:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:00:52 INFO - 'branch': 'B2G-Inbound', 11:00:52 INFO - 'buildbot_json_path': 'buildprops.json', 11:00:52 INFO - 'config_files': ('talos/linux_config.py',), 11:00:52 INFO - 'default_actions': ('clobber', 11:00:52 INFO - 'read-buildbot-config', 11:00:52 INFO - 'download-and-extract', 11:00:52 INFO - 'populate-webroot', 11:00:52 INFO - 'create-virtualenv', 11:00:52 INFO - 'install', 11:00:52 INFO - 'run-tests'), 11:00:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:00:52 INFO - 'download_minidump_stackwalk': True, 11:00:52 INFO - 'download_symbols': 'ondemand', 11:00:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:00:52 INFO - 'tooltool.py': '/tools/tooltool.py', 11:00:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:00:52 INFO - '/tools/misc-python/virtualenv.py')}, 11:00:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:00:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:00:52 INFO - 'installer_path': 'installer.exe', 11:00:52 INFO - 'log_level': 'info', 11:00:52 INFO - 'log_name': 'talos', 11:00:52 INFO - 'log_to_console': True, 11:00:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:00:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:00:52 INFO - 'opt_config_files': (), 11:00:52 INFO - 'pip_index': False, 11:00:52 INFO - 'sps_profile': False, 11:00:52 INFO - 'sps_profile_interval': 0, 11:00:52 INFO - 'suite': 'dromaeojs', 11:00:52 INFO - 'system_bits': '32', 11:00:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:00:52 INFO - 'title': 'talos-linux64-ix-001', 11:00:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:00:52 INFO - 'use_talos_json': True, 11:00:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:00:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:00:52 INFO - 'work_dir': 'build'} 11:00:52 INFO - ##### 11:00:52 INFO - ##### Running clobber step. 11:00:52 INFO - ##### 11:00:52 INFO - Running pre-action listener: _resource_record_pre_action 11:00:52 INFO - Running main action method: clobber 11:00:52 INFO - rmtree: /builds/slave/test-pgo/build 11:00:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:00:52 INFO - Running post-action listener: _resource_record_post_action 11:00:52 INFO - ##### 11:00:52 INFO - ##### Running read-buildbot-config step. 11:00:52 INFO - ##### 11:00:52 INFO - Running pre-action listener: _resource_record_pre_action 11:00:52 INFO - Running main action method: read_buildbot_config 11:00:52 INFO - Using buildbot properties: 11:00:52 INFO - { 11:00:52 INFO - "project": "", 11:00:52 INFO - "product": "firefox", 11:00:52 INFO - "script_repo_revision": "production", 11:00:52 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 11:00:52 INFO - "repository": "", 11:00:52 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 11:00:52 INFO - "buildid": "20160114083200", 11:00:52 INFO - "pgo_build": "True", 11:00:52 INFO - "basedir": "/builds/slave/test-pgo", 11:00:52 INFO - "buildnumber": 1110, 11:00:52 INFO - "slavename": "talos-linux64-ix-001", 11:00:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:00:52 INFO - "platform": "ubuntu64_hw", 11:00:52 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 11:00:52 INFO - "branch": "b2g-inbound", 11:00:52 INFO - "repo_path": "integration/b2g-inbound", 11:00:52 INFO - "revision": "5097ab0e8aec9b85b05e5f60b41a18cf79917b01", 11:00:52 INFO - "stage_platform": "linux64-pgo", 11:00:52 INFO - "builduid": "0c4c1f12287048f0a3922e0532f69ffb", 11:00:52 INFO - "slavebuilddir": "test" 11:00:52 INFO - } 11:00:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:00:52 INFO - Running post-action listener: _resource_record_post_action 11:00:52 INFO - ##### 11:00:52 INFO - ##### Running download-and-extract step. 11:00:52 INFO - ##### 11:00:52 INFO - Running pre-action listener: _resource_record_pre_action 11:00:52 INFO - Running main action method: download_and_extract 11:00:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:52 INFO - https://queue.taskcluster.net/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:00:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/test_packages.json 11:00:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/test_packages.json 11:00:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:00:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:00:53 INFO - Downloaded 1448 bytes. 11:00:53 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:00:53 INFO - Using the following test package requirements: 11:00:53 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:00:53 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:00:53 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:00:53 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:53 INFO - u'jsshell-linux-x86_64.zip'], 11:00:53 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:00:53 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:00:53 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:00:53 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:00:53 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:00:53 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:00:53 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:00:53 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:00: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')]} 11:00:53 INFO - https://queue.taskcluster.net/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:00:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/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 11:00:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/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 11:00:56 INFO - Downloaded 24030808 bytes. 11:00:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:00:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:00:57 INFO - Return code: 0 11:00:57 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 11:00:57 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')]} 11:00:57 INFO - https://queue.taskcluster.net/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:00:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/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 11:00:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/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 11:01:01 INFO - Downloaded 24030808 bytes. 11:01:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:01:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:01:03 INFO - Return code: 0 11:01:03 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')]} 11:01:03 INFO - https://queue.taskcluster.net/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:01:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/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 11:01:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/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 11:01:05 INFO - Downloaded 11132144 bytes. 11:01:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:01:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 11:01:05 INFO - Return code: 0 11:01:05 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')]} 11:01:05 INFO - https://queue.taskcluster.net/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:01:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:01:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:01:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/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 11:01:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GASgRh7vR8OiraIyCvT8tg/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 11:01:08 INFO - Downloaded 55860975 bytes. 11:01:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:01:08 INFO - mkdir: /builds/slave/test-pgo/properties 11:01:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:01:08 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:01:08 INFO - Contents: 11:01:08 INFO - build_url:https://queue.taskcluster.net/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:01:08 INFO - Running post-action listener: _resource_record_post_action 11:01:08 INFO - Running post-action listener: set_extra_try_arguments 11:01:08 INFO - ##### 11:01:08 INFO - ##### Running populate-webroot step. 11:01:08 INFO - ##### 11:01:08 INFO - Running pre-action listener: _resource_record_pre_action 11:01:08 INFO - Running main action method: populate_webroot 11:01:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:01:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:01:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:01:08 INFO - '--tppagecycles', 11:01:08 INFO - '7'], 11:01:08 INFO - 'tests': ['tsvgm']}}, 11:01:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:01:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:01:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:01:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:01:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:01:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:01:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'talos_options': ['--e10s'], 11:01:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'tests': ['damp', 'tps']}, 11:01:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'talos_options': ['--e10s'], 11:01:08 INFO - 'tests': ['damp', 'tps']}, 11:01:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:01:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:01:08 INFO - 'other': {'tests': ['a11yr', 11:01:08 INFO - 'ts_paint', 11:01:08 INFO - 'tpaint', 11:01:08 INFO - 'sessionrestore', 11:01:08 INFO - 'sessionrestore_no_auto_restore']}, 11:01:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:01:08 INFO - 'tests': ['a11yr', 11:01:08 INFO - 'ts_paint', 11:01:08 INFO - 'tpaint', 11:01:08 INFO - 'sessionrestore', 11:01:08 INFO - 'sessionrestore_no_auto_restore']}, 11:01:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:01:08 INFO - 'tests': ['a11yr', 11:01:08 INFO - 'ts_paint', 11:01:08 INFO - 'tpaint', 11:01:08 INFO - 'sessionrestore', 11:01:08 INFO - 'sessionrestore_no_auto_restore']}, 11:01:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:01:08 INFO - 'tests': ['a11yr', 11:01:08 INFO - 'ts_paint', 11:01:08 INFO - 'tpaint', 11:01:08 INFO - 'sessionrestore', 11:01:08 INFO - 'sessionrestore_no_auto_restore']}, 11:01:08 INFO - 'other_l64': {'tests': ['a11yr', 11:01:08 INFO - 'ts_paint', 11:01:08 INFO - 'tpaint', 11:01:08 INFO - 'sessionrestore', 11:01:08 INFO - 'sessionrestore_no_auto_restore']}, 11:01:08 INFO - 'other_nol64': {'tests': ['a11yr', 11:01:08 INFO - 'ts_paint', 11:01:08 INFO - 'tpaint', 11:01:08 INFO - 'sessionrestore', 11:01:08 INFO - 'sessionrestore_no_auto_restore']}, 11:01:08 INFO - 'svgr': {'tests': ['tsvgx', 11:01:08 INFO - 'tsvgr_opacity', 11:01:08 INFO - 'tart', 11:01:08 INFO - 'tscrollx', 11:01:08 INFO - 'cart']}, 11:01:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:01:08 INFO - 'tests': ['tsvgx', 11:01:08 INFO - 'tsvgr_opacity', 11:01:08 INFO - 'tart', 11:01:08 INFO - 'tscrollx', 11:01:08 INFO - 'cart']}, 11:01:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'tests': ['tp5o']}, 11:01:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'talos_options': ['--e10s'], 11:01:08 INFO - 'tests': ['tp5o']}, 11:01:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'talos_options': ['--xperf_path', 11:01:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:08 INFO - 'tests': ['tp5n']}, 11:01:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'talos_options': ['--e10s', 11:01:08 INFO - '--xperf_path', 11:01:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:08 INFO - 'tests': ['tp5n']}}, 11:01:08 INFO - 'talos.zip': {'path': '', 11:01:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:01:08 INFO - Running post-action listener: _resource_record_post_action 11:01:08 INFO - ##### 11:01:08 INFO - ##### Running create-virtualenv step. 11:01:08 INFO - ##### 11:01:08 INFO - Running pre-action listener: _resource_record_pre_action 11:01:08 INFO - Running main action method: create_virtualenv 11:01:08 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:01:08 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 11:01:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:01:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:01:08 INFO - Using real prefix '/usr' 11:01:08 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:01:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:01:10 INFO - Installing pip.................done. 11:01:10 INFO - Return code: 0 11:01:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:01:10 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')]} 11:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:10 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')]} 11:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:10 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 0x7fb582090f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34840>, '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 0x29a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', '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 11:01:10 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 11:01:10 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 11:01:10 INFO - Using env: {'DISPLAY': ':0', 11:01:10 INFO - 'HOME': '/home/cltbld', 11:01:10 INFO - 'LANG': 'en_US.UTF-8', 11:01:10 INFO - 'LANGUAGE': 'en_US:en', 11:01:10 INFO - 'LOGNAME': 'cltbld', 11:01:10 INFO - 'MAIL': '/var/mail/cltbld', 11:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:10 INFO - 'MOZ_NO_REMOTE': '1', 11:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:10 INFO - 'NO_EM_RESTART': '1', 11:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:10 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:10 INFO - 'SHELL': '/bin/bash', 11:01:10 INFO - 'SHLVL': '1', 11:01:10 INFO - 'TERM': 'linux', 11:01:10 INFO - 'TMOUT': '86400', 11:01:10 INFO - 'USER': 'cltbld', 11:01:10 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', 11:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:10 INFO - '_': '/tools/buildbot/bin/python'} 11:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:10 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 11:01:10 INFO - Cleaning up... 11:01:10 INFO - Return code: 0 11:01:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:01:10 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')]} 11:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:10 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')]} 11:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:10 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 0x7fb582090f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34840>, '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 0x29a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', '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 11:01:10 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 11:01:10 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 11:01:11 INFO - Using env: {'DISPLAY': ':0', 11:01:11 INFO - 'HOME': '/home/cltbld', 11:01:11 INFO - 'LANG': 'en_US.UTF-8', 11:01:11 INFO - 'LANGUAGE': 'en_US:en', 11:01:11 INFO - 'LOGNAME': 'cltbld', 11:01:11 INFO - 'MAIL': '/var/mail/cltbld', 11:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:11 INFO - 'MOZ_NO_REMOTE': '1', 11:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:11 INFO - 'NO_EM_RESTART': '1', 11:01:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:11 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:11 INFO - 'SHELL': '/bin/bash', 11:01:11 INFO - 'SHLVL': '1', 11:01:11 INFO - 'TERM': 'linux', 11:01:11 INFO - 'TMOUT': '86400', 11:01:11 INFO - 'USER': 'cltbld', 11:01:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', 11:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:11 INFO - '_': '/tools/buildbot/bin/python'} 11:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:11 INFO - Downloading/unpacking psutil>=0.7.1 11:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:12 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:01:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:01:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:01:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:13 INFO - Installing collected packages: psutil 11:01:13 INFO - Running setup.py install for psutil 11:01:13 INFO - building 'psutil._psutil_linux' extension 11:01:13 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 11:01:13 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 11:01:13 INFO - building 'psutil._psutil_posix' extension 11:01:13 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 11:01:13 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 11:01:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:13 INFO - Successfully installed psutil 11:01:13 INFO - Cleaning up... 11:01:13 INFO - Return code: 0 11:01:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb582090f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34840>, '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 0x29a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', '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 11:01:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:01:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:01:13 INFO - Using env: {'DISPLAY': ':0', 11:01:13 INFO - 'HOME': '/home/cltbld', 11:01:13 INFO - 'LANG': 'en_US.UTF-8', 11:01:13 INFO - 'LANGUAGE': 'en_US:en', 11:01:13 INFO - 'LOGNAME': 'cltbld', 11:01:13 INFO - 'MAIL': '/var/mail/cltbld', 11:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:13 INFO - 'MOZ_NO_REMOTE': '1', 11:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:13 INFO - 'NO_EM_RESTART': '1', 11:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:13 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:13 INFO - 'SHELL': '/bin/bash', 11:01:13 INFO - 'SHLVL': '1', 11:01:13 INFO - 'TERM': 'linux', 11:01:13 INFO - 'TMOUT': '86400', 11:01:13 INFO - 'USER': 'cltbld', 11:01:13 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', 11:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:13 INFO - '_': '/tools/buildbot/bin/python'} 11:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:01:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:01:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:01:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:01:15 INFO - Installing collected packages: mozsystemmonitor 11:01:15 INFO - Running setup.py install for mozsystemmonitor 11:01:15 INFO - Successfully installed mozsystemmonitor 11:01:15 INFO - Cleaning up... 11:01:15 INFO - Return code: 0 11:01:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:01:15 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')]} 11:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:15 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')]} 11:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:15 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 0x7fb582090f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34840>, '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 0x29a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', '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 11:01:15 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 11:01:15 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 11:01:15 INFO - Using env: {'DISPLAY': ':0', 11:01:15 INFO - 'HOME': '/home/cltbld', 11:01:15 INFO - 'LANG': 'en_US.UTF-8', 11:01:15 INFO - 'LANGUAGE': 'en_US:en', 11:01:15 INFO - 'LOGNAME': 'cltbld', 11:01:15 INFO - 'MAIL': '/var/mail/cltbld', 11:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:15 INFO - 'MOZ_NO_REMOTE': '1', 11:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:15 INFO - 'NO_EM_RESTART': '1', 11:01:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:15 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:15 INFO - 'SHELL': '/bin/bash', 11:01:15 INFO - 'SHLVL': '1', 11:01:15 INFO - 'TERM': 'linux', 11:01:15 INFO - 'TMOUT': '86400', 11:01:15 INFO - 'USER': 'cltbld', 11:01:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', 11:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:15 INFO - '_': '/tools/buildbot/bin/python'} 11:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:15 INFO - Downloading/unpacking blobuploader==1.2.4 11:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:17 INFO - Downloading blobuploader-1.2.4.tar.gz 11:01:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:01:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:01:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:01:17 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 11:01:17 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 11:01:17 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 11:01:17 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 11:01:17 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 11:01:17 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 11:01:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:01:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:01:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:01:18 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 11:01:18 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 11:01:18 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 11:01:18 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 11:01:18 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 11:01:18 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 11:01:18 INFO - Downloading docopt-0.6.1.tar.gz 11:01:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:01:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:01:18 INFO - Installing collected packages: blobuploader, requests, docopt 11:01:18 INFO - Running setup.py install for blobuploader 11:01:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:01:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:01:18 INFO - Running setup.py install for requests 11:01:18 INFO - Running setup.py install for docopt 11:01:18 INFO - Successfully installed blobuploader requests docopt 11:01:18 INFO - Cleaning up... 11:01:18 INFO - Return code: 0 11:01:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:01:18 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')]} 11:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:18 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')]} 11:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:18 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 0x7fb582090f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34840>, '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 0x29a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', '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 11:01:18 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 11:01:18 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 11:01:18 INFO - Using env: {'DISPLAY': ':0', 11:01:18 INFO - 'HOME': '/home/cltbld', 11:01:18 INFO - 'LANG': 'en_US.UTF-8', 11:01:18 INFO - 'LANGUAGE': 'en_US:en', 11:01:18 INFO - 'LOGNAME': 'cltbld', 11:01:18 INFO - 'MAIL': '/var/mail/cltbld', 11:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:18 INFO - 'MOZ_NO_REMOTE': '1', 11:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:18 INFO - 'NO_EM_RESTART': '1', 11:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:18 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:18 INFO - 'SHELL': '/bin/bash', 11:01:18 INFO - 'SHLVL': '1', 11:01:18 INFO - 'TERM': 'linux', 11:01:18 INFO - 'TMOUT': '86400', 11:01:18 INFO - 'USER': 'cltbld', 11:01:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', 11:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:18 INFO - '_': '/tools/buildbot/bin/python'} 11:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:01:19 INFO - Running setup.py (path:/tmp/pip-Op52kC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:01:19 INFO - Running setup.py (path:/tmp/pip-1y9meG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:01:19 INFO - Running setup.py (path:/tmp/pip-hQ1IYt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:01:19 INFO - Running setup.py (path:/tmp/pip-NkcqaJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:01:19 INFO - Running setup.py (path:/tmp/pip-KYi9pP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:01:19 INFO - Running setup.py (path:/tmp/pip-XvtdgM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:01:19 INFO - Running setup.py (path:/tmp/pip-Wjo4IP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:01:19 INFO - Running setup.py (path:/tmp/pip-kNwjjH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:01:19 INFO - Running setup.py (path:/tmp/pip-Pf8QxY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:01:19 INFO - Running setup.py (path:/tmp/pip-H3e6rb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:01:19 INFO - Running setup.py (path:/tmp/pip-wuXrop-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:01:19 INFO - Running setup.py (path:/tmp/pip-27StGV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:01:20 INFO - Running setup.py (path:/tmp/pip-ekE1s5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:01:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:01:20 INFO - Running setup.py (path:/tmp/pip-h1qoqi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:01:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:01:20 INFO - Running setup.py (path:/tmp/pip-XM8WAX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:01:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:01:20 INFO - Running setup.py (path:/tmp/pip-a_gPnX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:01:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:01:20 INFO - Running setup.py (path:/tmp/pip-IEJRBz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:01:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:01:20 INFO - Running setup.py install for manifestparser 11:01:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:01:20 INFO - Running setup.py install for mozcrash 11:01:20 INFO - Running setup.py install for mozdebug 11:01:20 INFO - Running setup.py install for mozdevice 11:01:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:01:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:01:20 INFO - Running setup.py install for mozfile 11:01:20 INFO - Running setup.py install for mozhttpd 11:01:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:01:20 INFO - Running setup.py install for mozinfo 11:01:21 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:01:21 INFO - Running setup.py install for mozInstall 11:01:21 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:01:21 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:01:21 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:01:21 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:01:21 INFO - Running setup.py install for mozleak 11:01:21 INFO - Running setup.py install for mozlog 11:01:21 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:01:21 INFO - Running setup.py install for moznetwork 11:01:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:01:21 INFO - Running setup.py install for mozprocess 11:01:21 INFO - Running setup.py install for mozprofile 11:01:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:01:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:01:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:01:21 INFO - Running setup.py install for mozrunner 11:01:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:01:21 INFO - Running setup.py install for mozscreenshot 11:01:21 INFO - Running setup.py install for moztest 11:01:22 INFO - Running setup.py install for mozversion 11:01:22 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:01:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:01:22 INFO - Cleaning up... 11:01:22 INFO - Return code: 0 11:01:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:01:22 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')]} 11:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:22 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')]} 11:01:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:22 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 0x7fb582090f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34840>, '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 0x29a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', '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 11:01:22 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 11:01:22 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 11:01:22 INFO - Using env: {'DISPLAY': ':0', 11:01:22 INFO - 'HOME': '/home/cltbld', 11:01:22 INFO - 'LANG': 'en_US.UTF-8', 11:01:22 INFO - 'LANGUAGE': 'en_US:en', 11:01:22 INFO - 'LOGNAME': 'cltbld', 11:01:22 INFO - 'MAIL': '/var/mail/cltbld', 11:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:22 INFO - 'MOZ_NO_REMOTE': '1', 11:01:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:22 INFO - 'NO_EM_RESTART': '1', 11:01:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:22 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:22 INFO - 'SHELL': '/bin/bash', 11:01:22 INFO - 'SHLVL': '1', 11:01:22 INFO - 'TERM': 'linux', 11:01:22 INFO - 'TMOUT': '86400', 11:01:22 INFO - 'USER': 'cltbld', 11:01:22 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', 11:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:22 INFO - '_': '/tools/buildbot/bin/python'} 11:01:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:01:22 INFO - Running setup.py (path:/tmp/pip-CYP1qH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:01:22 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)) 11:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:01:22 INFO - Running setup.py (path:/tmp/pip-wBo8vV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:01:22 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)) 11:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:01:22 INFO - Running setup.py (path:/tmp/pip-BiDbr0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:01:22 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)) 11:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:01:22 INFO - Running setup.py (path:/tmp/pip-zim6xb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:01:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 11:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:01:22 INFO - Running setup.py (path:/tmp/pip-snWW75-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:01:22 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)) 11:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:01:22 INFO - Running setup.py (path:/tmp/pip-4h6CSR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:01:22 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)) 11:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:01:22 INFO - Running setup.py (path:/tmp/pip-6jQj6Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:01:22 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)) 11:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:01:22 INFO - Running setup.py (path:/tmp/pip-733Ch_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:01:22 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)) 11:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:01:22 INFO - Running setup.py (path:/tmp/pip-kfRv76-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:01:22 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)) 11:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:01:23 INFO - Running setup.py (path:/tmp/pip-u2t3Du-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:01:23 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)) 11:01:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:01:23 INFO - Running setup.py (path:/tmp/pip-Lsw4Ee-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:01:23 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)) 11:01:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:01:23 INFO - Running setup.py (path:/tmp/pip-hiNcN7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:01:23 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)) 11:01:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:01:23 INFO - Running setup.py (path:/tmp/pip-xBOm4w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:01:23 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)) 11:01:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:01:23 INFO - Running setup.py (path:/tmp/pip-9LU_vL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:01:23 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)) 11:01:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:01:23 INFO - Running setup.py (path:/tmp/pip-toxj6K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:01:23 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)) 11:01:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:01:23 INFO - Running setup.py (path:/tmp/pip-jVWiKo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:01:23 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)) 11:01:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:01:23 INFO - Running setup.py (path:/tmp/pip-CiarWy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:01:23 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)) 11:01:23 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)) 11:01:23 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)) 11:01:23 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)) 11:01:23 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:01:23 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:01:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:01:23 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 11:01:23 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 11:01:23 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 11:01:23 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 11:01:23 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 11:01:23 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 11:01:25 INFO - Downloading blessings-1.5.1.tar.gz 11:01:25 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 11:01:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:01:25 INFO - Installing collected packages: blessings 11:01:25 INFO - Running setup.py install for blessings 11:01:25 INFO - Successfully installed blessings 11:01:25 INFO - Cleaning up... 11:01:25 INFO - Return code: 0 11:01:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:01:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:01:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:01:25 INFO - Reading from file tmpfile_stdout 11:01:25 INFO - Current package versions: 11:01:25 INFO - argparse == 1.2.1 11:01:25 INFO - blessings == 1.5.1 11:01:25 INFO - blobuploader == 1.2.4 11:01:25 INFO - docopt == 0.6.1 11:01:25 INFO - manifestparser == 1.1 11:01:25 INFO - mozInstall == 1.12 11:01:25 INFO - mozcrash == 0.16 11:01:25 INFO - mozdebug == 0.1 11:01:25 INFO - mozdevice == 0.48 11:01:25 INFO - mozfile == 1.2 11:01:25 INFO - mozhttpd == 0.7 11:01:25 INFO - mozinfo == 0.9 11:01:25 INFO - mozleak == 0.1 11:01:25 INFO - mozlog == 3.1 11:01:25 INFO - moznetwork == 0.27 11:01:25 INFO - mozprocess == 0.22 11:01:25 INFO - mozprofile == 0.28 11:01:25 INFO - mozrunner == 6.11 11:01:25 INFO - mozscreenshot == 0.1 11:01:25 INFO - mozsystemmonitor == 0.0 11:01:25 INFO - moztest == 0.7 11:01:25 INFO - mozversion == 1.4 11:01:25 INFO - psutil == 3.1.1 11:01:25 INFO - requests == 1.2.3 11:01:25 INFO - wsgiref == 0.1.2 11:01:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:01: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')]} 11:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01: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')]} 11:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:25 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 0x7fb582090f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34840>, '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 0x29a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', '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 11:01:25 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 11:01:25 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 11:01:25 INFO - Using env: {'DISPLAY': ':0', 11:01:25 INFO - 'HOME': '/home/cltbld', 11:01:25 INFO - 'LANG': 'en_US.UTF-8', 11:01:25 INFO - 'LANGUAGE': 'en_US:en', 11:01:25 INFO - 'LOGNAME': 'cltbld', 11:01:25 INFO - 'MAIL': '/var/mail/cltbld', 11:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:25 INFO - 'MOZ_NO_REMOTE': '1', 11:01:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:25 INFO - 'NO_EM_RESTART': '1', 11:01:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:25 INFO - 'SHELL': '/bin/bash', 11:01:25 INFO - 'SHLVL': '1', 11:01:25 INFO - 'TERM': 'linux', 11:01:25 INFO - 'TMOUT': '86400', 11:01:25 INFO - 'USER': 'cltbld', 11:01:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', 11:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:25 INFO - '_': '/tools/buildbot/bin/python'} 11:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:25 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)) 11:01:25 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)) 11:01:25 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)) 11:01:25 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)) 11:01:25 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)) 11:01:25 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)) 11:01:25 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)) 11:01:25 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)) 11:01:25 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)) 11:01:25 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)) 11:01:25 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)) 11:01:25 INFO - Cleaning up... 11:01:25 INFO - Return code: 0 11:01:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:01: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')]} 11:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb582090f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34840>, '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 0x29a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', '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 11:01:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:01:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:01:26 INFO - Using env: {'DISPLAY': ':0', 11:01:26 INFO - 'HOME': '/home/cltbld', 11:01:26 INFO - 'LANG': 'en_US.UTF-8', 11:01:26 INFO - 'LANGUAGE': 'en_US:en', 11:01:26 INFO - 'LOGNAME': 'cltbld', 11:01:26 INFO - 'MAIL': '/var/mail/cltbld', 11:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:26 INFO - 'MOZ_NO_REMOTE': '1', 11:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:26 INFO - 'NO_EM_RESTART': '1', 11:01:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:26 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:26 INFO - 'SHELL': '/bin/bash', 11:01:26 INFO - 'SHLVL': '1', 11:01:26 INFO - 'TERM': 'linux', 11:01:26 INFO - 'TMOUT': '86400', 11:01:26 INFO - 'USER': 'cltbld', 11:01:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', 11:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:26 INFO - '_': '/tools/buildbot/bin/python'} 11:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:26 INFO - Downloading/unpacking jsonschema 11:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:01:27 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 11:01:27 INFO - Downloading/unpacking functools32 (from jsonschema) 11:01:27 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 11:01:27 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 11:01:27 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 11:01:27 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 11:01:27 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 11:01:27 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 11:01:28 INFO - Downloading functools32-3.2.3-2.tar.gz 11:01:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:01:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:01:28 INFO - warning: no files found matching '*.txt' 11:01:28 INFO - no previously-included directories found matching 'build' 11:01:28 INFO - no previously-included directories found matching 'dist' 11:01:28 INFO - no previously-included directories found matching '.git*' 11:01:28 INFO - Installing collected packages: jsonschema, functools32 11:01:28 INFO - Running setup.py install for functools32 11:01:28 INFO - warning: no files found matching '*.txt' 11:01:28 INFO - no previously-included directories found matching 'build' 11:01:28 INFO - no previously-included directories found matching 'dist' 11:01:28 INFO - no previously-included directories found matching '.git*' 11:01:28 INFO - Successfully installed jsonschema functools32 11:01:28 INFO - Cleaning up... 11:01:28 INFO - Return code: 0 11:01:28 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:28 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 0x7fb582090f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a34840>, '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 0x29a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', '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 11:01:28 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 11:01:28 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 11:01:28 INFO - Using env: {'DISPLAY': ':0', 11:01:28 INFO - 'HOME': '/home/cltbld', 11:01:28 INFO - 'LANG': 'en_US.UTF-8', 11:01:28 INFO - 'LANGUAGE': 'en_US:en', 11:01:28 INFO - 'LOGNAME': 'cltbld', 11:01:28 INFO - 'MAIL': '/var/mail/cltbld', 11:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:28 INFO - 'MOZ_NO_REMOTE': '1', 11:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:28 INFO - 'NO_EM_RESTART': '1', 11:01:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:28 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:28 INFO - 'SHELL': '/bin/bash', 11:01:28 INFO - 'SHLVL': '1', 11:01:28 INFO - 'TERM': 'linux', 11:01:28 INFO - 'TMOUT': '86400', 11:01:28 INFO - 'USER': 'cltbld', 11:01:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', 11:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:28 INFO - '_': '/tools/buildbot/bin/python'} 11:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:28 INFO - Downloading/unpacking flake8 11:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:01:30 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 11:01:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:01:30 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 11:01:30 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 11:01:30 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 11:01:30 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 11:01:30 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 11:01:30 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 11:01:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:01:30 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 11:01:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:01:30 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 11:01:30 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 11:01:30 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 11:01:30 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 11:01:30 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 11:01:30 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 11:01:30 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 11:01:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:01:30 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 11:01:30 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 11:01:30 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 11:01:30 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 11:01:30 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 11:01:30 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 11:01:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:01:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:01:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:01:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:01:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:01:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:01:30 INFO - no previously-included directories found matching 'docs/_build' 11:01:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:01:31 INFO - Running setup.py install for pep8 11:01:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:01:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:01:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:01:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:01:31 INFO - no previously-included directories found matching 'docs/_build' 11:01:31 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:01:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:01:31 INFO - Cleaning up... 11:01:31 INFO - Return code: 0 11:01:31 INFO - Running post-action listener: _resource_record_post_action 11:01:31 INFO - Running post-action listener: _start_resource_monitoring 11:01:31 INFO - Starting resource monitoring. 11:01:31 INFO - ##### 11:01:31 INFO - ##### Running install step. 11:01:31 INFO - ##### 11:01:31 INFO - Running pre-action listener: _resource_record_pre_action 11:01:31 INFO - Running main action method: install 11:01:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:01:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:01:31 INFO - Reading from file tmpfile_stdout 11:01:31 INFO - Detecting whether we're running mozinstall >=1.0... 11:01:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:01:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:01:31 INFO - Reading from file tmpfile_stdout 11:01:31 INFO - Output received: 11:01:31 INFO - Usage: mozinstall [options] installer 11:01:31 INFO - Options: 11:01:31 INFO - -h, --help show this help message and exit 11:01:31 INFO - -d DEST, --destination=DEST 11:01:31 INFO - Directory to install application into. [default: 11:01:31 INFO - "/builds/slave/test-pgo"] 11:01:31 INFO - --app=APP Application being installed. [default: firefox] 11:01:31 INFO - mkdir: /builds/slave/test-pgo/build/application 11:01:31 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'] 11:01:31 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 11:01:47 INFO - Reading from file tmpfile_stdout 11:01:47 INFO - Output received: 11:01:47 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:01:47 INFO - Running post-action listener: _resource_record_post_action 11:01:47 INFO - ##### 11:01:47 INFO - ##### Running run-tests step. 11:01:47 INFO - ##### 11:01:47 INFO - Running pre-action listener: _resource_record_pre_action 11:01:47 INFO - Running main action method: run_tests 11:01:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:01:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:01:47 INFO - Python 2.7.3 11:01:47 INFO - Return code: 0 11:01:47 INFO - grabbing minidump binary from tooltool 11:01: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')]} 11:01:47 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 0x2a34840>, '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 0x29a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:01:47 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 11:01:47 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 11:01:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:01:47 INFO - Return code: 0 11:01:47 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:01:47 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:01:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:01:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:01:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:01:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:01:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:01:48 INFO - Return code: 0 11:01:48 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/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 11:01:48 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/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 11:01:48 INFO - Using env: {'DISPLAY': ':0', 11:01:48 INFO - 'HOME': '/home/cltbld', 11:01:48 INFO - 'LANG': 'en_US.UTF-8', 11:01:48 INFO - 'LANGUAGE': 'en_US:en', 11:01:48 INFO - 'LOGNAME': 'cltbld', 11:01:48 INFO - 'MAIL': '/var/mail/cltbld', 11:01:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:01:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:48 INFO - 'MOZ_NO_REMOTE': '1', 11:01:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:48 INFO - 'NO_EM_RESTART': '1', 11:01:48 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:48 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:48 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:01:48 INFO - 'SHELL': '/bin/bash', 11:01:48 INFO - 'SHLVL': '1', 11:01:48 INFO - 'TERM': 'linux', 11:01:48 INFO - 'TMOUT': '86400', 11:01:48 INFO - 'USER': 'cltbld', 11:01:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635', 11:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:48 INFO - '_': '/tools/buildbot/bin/python'} 11:01:48 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/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 11:01:49 INFO - mozversion application_buildid: 20160114083200 11:01:49 INFO - mozversion application_changeset: 5097ab0e8aec9b85b05e5f60b41a18cf79917b01 11:01:49 INFO - mozversion application_display_name: Nightly 11:01:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:01:49 INFO - mozversion application_name: Firefox 11:01:49 INFO - mozversion application_remotingname: firefox 11:01:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 11:01:49 INFO - mozversion application_vendor: Mozilla 11:01:49 INFO - mozversion application_version: 46.0a1 11:01:49 INFO - mozversion platform_buildid: 20160114083200 11:01:49 INFO - mozversion platform_changeset: 5097ab0e8aec9b85b05e5f60b41a18cf79917b01 11:01:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 11:01:49 INFO - mozversion platform_version: 46.0a1 11:01:49 INFO - using testdate: 1452798109 11:01:49 INFO - actual date: 1452798109 11:01:49 INFO - starting webserver on 'localhost:49452' 11:01:49 INFO - SUITE-START | Running 3 tests 11:01:49 INFO - TEST-START | dromaeo_css 11:01:49 INFO - operating with platform_type : linux_ 11:01:49 INFO - Initialising browser for dromaeo_css test... 11:01:49 INFO - TEST-INFO | started process 16444 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp95LcRM/profile http://localhost:49452/getInfo.html) 11:01:53 INFO - PROCESS | 16444 | __metrics Screen width/height:1600/1200 11:01:53 INFO - PROCESS | 16444 | colorDepth:24 11:01:53 INFO - PROCESS | 16444 | Browser inner width/height: 1024/697 11:01:53 INFO - PROCESS | 16444 | __metrics 11:01:53 INFO - PROCESS | 16444 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:01:53 INFO - PROCESS | 16444 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:01:54 INFO - TEST-INFO | 16444: exit 0 11:01:54 INFO - Browser initialized. 11:01:54 INFO - Running cycle 1/1 for dromaeo_css test... 11:01:54 INFO - TEST-INFO | started process 16540 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp95LcRM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:02:06 INFO - PROCESS | 16540 | RSS: Main: 150245376 11:02:06 INFO - PROCESS | 16540 | 11:02:57 INFO - PROCESS | 16540 | 1452798177402 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] 11:05:05 INFO - PROCESS | 16540 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49452/tests/dromaeo/cssquery-ext.html) 11:05:06 INFO - PROCESS | 16540 | RSS: Main: 250834944 11:05:06 INFO - PROCESS | 16540 | 11:08:09 INFO - PROCESS | 16540 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-ext.html (next: http://localhost:49452/tests/dromaeo/cssquery-jquery.html) 11:08:09 INFO - PROCESS | 16540 | RSS: Main: 225779712 11:08:09 INFO - PROCESS | 16540 | 11:11:11 INFO - PROCESS | 16540 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49452/tests/dromaeo/cssquery-mootools.html) 11:11:12 INFO - PROCESS | 16540 | RSS: Main: 222441472 11:11:12 INFO - PROCESS | 16540 | 11:14:14 INFO - PROCESS | 16540 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49452/tests/dromaeo/cssquery-prototype.html) 11:14:14 INFO - PROCESS | 16540 | RSS: Main: 208744448 11:14:14 INFO - PROCESS | 16540 | 11:17:17 INFO - PROCESS | 16540 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49452/tests/dromaeo/cssquery-yui.html) 11:17:18 INFO - PROCESS | 16540 | RSS: Main: 212668416 11:17:18 INFO - PROCESS | 16540 | 11:20:20 INFO - PROCESS | 16540 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-yui.html (next: http://localhost:49452/tests/dromaeo/cssquery-dojo.html) 11:20:21 INFO - PROCESS | 16540 | RSS: Main: 253837312 11:20:21 INFO - PROCESS | 16540 | 11:20:21 INFO - PROCESS | 16540 | __start_tp_report 11:20:21 INFO - PROCESS | 16540 | _x_x_mozilla_page_load 11:20:21 INFO - PROCESS | 16540 | _x_x_mozilla_page_load_details 11:20:21 INFO - PROCESS | 16540 | |i|pagename|runs| 11:20:21 INFO - PROCESS | 16540 | |0;dojo.html;3118.173683973746;3137.0588823352996;3179.713825755683;3189.2186414328494;3206.35872825435;5008.449070602231;5107.310513080733;5110.054639891623;5120.871978200542;5154.381474223093;5063.822766203184;5098.61760367973;5099.847004589859;5115.641905066647;5119.795208191668;4439.422875026258;4628.69913455626;4638.814447422099;4708.223143181371;4710.152172608929;4613.446386433633;4653.441587009564;4655.068986202756;4693.929591056137;4779.211430114027;4641.999999999983;4669.929951050737;4672.715003374065;4708.858734237944;4716.858494245178;4650.116477869228;4656.115338085787;4656.720596764171;4681;4696.412948381452;4566.406367172246;4654.371659825914;4661.836835710767;4675.088357770236;4685.648576356787;4976.751162441899;5033.572146367563;5035.194368900959;5047.343845300087;5080.898382032338;5440.510354068113;5450.5639548836;5450.972745136289;5457.836264912059;5505.587080968903;5392.78428862845;5398.379186393576;5475.753591088371;5494.066008778517;5543.833684989457;5033.295338652591;5146.639735218536;5147.948520514747;5167.6641018333685;5189.481051894856;5585.050541407971;5585.720713964285;5595.188697638901;5627.774889004476;5634.915476267859;5413.53984911287;5424.864378390572;5430.647007944471;5432.945670543244;5438.972805135949;5404.8108316208745;5450.427705090988;5463.016657001698;5476.123820188751;5488.53347465462;5408.1887716842;5477.589180811455;5479.178123281539;5484.8354549363585;5525.475079867406;5472.452754724496;5473.343198816088;5476.698781566973;5483.204935284361;5543.972280138573;4207.76857272853;4251.043515209115;4273.166732487135;4300.935485967713;4310.374995625617;3815.0271680721794;3825.6748176404762;3837.76973381598;3838.8848334550007;3855.267499175148;5070.366204224472;5077.289179514797;5079.415867175248;5081.110805609003;5107.846764597068;5408.5402740766685;5421.213923981;5467.152591348347;5494.450554944474;5533.501984821385;5007.349044624249;5055.064813009605;5069.5690866276045;5083.339165908408;5120.7951681933055;4672.813087476531;4705.12955103307;4713.2458806590785;4716.5990890774665;4738.336632871401;5579.69311687861;5605.439456054362;5605.943940560624;5606.21512988182;5612.719364031782;5487.314085739283;5512.173174023928;5523.1991361253195;5553.750081246434;5563.8887222256135;5600.243967064394;5606.831795046155;5609.691466969356;5613.971930140323;5615.522680572034;5331.200319952039;5335.706536140394;5393;5394.514493695587;5419.918701219406;5448.373437054789;5454.372747133972;5460.945390546044;5505.504504594605;5528.530074943675;5318;5347.919781203363;5351.331083614548;5354.491323324278;5364.249005139206;5246.265522826731;5339.145736682268;5352.866178345573;5359.598030147677;5407.891842163056;5155.046316431472;5204.739763011758;5251.763670634754;5272.314599102092;5329.440408757025;5399.568034557147;5419.078756611464;5424.349078110652;5424.83725488236;5428.945710542844;5242.501962313574;5299.44355842631;5305.814296499604;5309.177077552986;5363.865903352447 11:20:21 INFO - PROCESS | 16540 | |1;ext.html;538.7575590984055;554.8347526597627;562.4207066721278;612.7855250662267;614.1371373220625;35087.122821929464;35699;35769.82115089424;35805.64194358059;35828.82085589575;42681.35977960333;43800.61993800618;43805.56194438055;43869.341959870544;43910.56089439105;8591.785205369884;8814.427062240933;8816.206541411271;8817.16236957488;8821.206091451768;8456.957715211416;8617.48295102296;8620.784480387978;8630.050694423608;8632.913670863274;8517.148285171495;8581.914180858204;8635.913640863606;8642.438241514314;8651.567421628924;8465.873011904796;8521;8562.571871406404;8568.614412351459;8572.057073721886;8444.408891377607;8535.573221338971;8562.871556926651;8566.357523185723;8568.657253709844;39281.803590981865;39514.802425987684;39661.60338396608;39741.60258397437;39748.20503589912;3332.2502436951736;3359.10983589349;3371.3088816792497;3800.9619903800885;3968.7817170055637;29459.85270073636;29685.70314296851;29936.550951735742;30646.387072258654;31313.217169570944;3544.946825797615;3581.5881173665102;3597.406427939387;3735.0849041984616;3742.700583953277;222229;223328;223771;223987;224059;41970;42752.14495710131;52679.73660131675;53582;58700;40761.59238407637;40931;40966.59033409687;40998.79500602478;41028.79485602613;13158.539451119164;13351.799723004162;13415.865841341461;13428.19430834153;13466.865331346562;10463.895361046445;10782.245242833083;10899.509522071527;11001.394923279136;11018.063464605599;14043.929780351033;14130.929345353414;14131.78802317966;14220.431182752782;14262.500812471513;5634.6337488063145;5653.65373370055;5749.540036797046;5761.971190144106;5814.854628634318;910.4082346474844;984.6898227058454;989.5547003848297;1049.6955882794057;1114.7046032801313;28125;29016.7098329014;29102.417951640848;30685.539716904263;32279.677203228137;1001.2190491416707;1035.321864178964;1045.3100953370738;1052.021619893491;1067.8558394616782;14906.70186596262;14949.476768313058;15022.24888755558;15258.389664413298;15271.312790924212;383114;383814;385331;387047;388508;53124;53479;53620.463795362324;53622;53699.46300536945;1318.8153658487627;1330.5409633676366;1339.9263040532865;1340.477213886585;1378.179982910167;27693.307667307672;27966.580501292905;28884;28887.133385998455;28925.56611650785;46292.53707463017;46561.301580477;46841;46879.76560117314;47004;279753;284951;285403;293217;293314;30687.693123068482;30690;30731.539026915063;31177.53233701451;31219.219519512193;41087.178256434105;42043.369349460394;42061.789691052574;42873.14253714846;42959.78520107379;36515.817420912725;36584.08539786527;36952.26095478129;38332.42501362426;39475.210495790496;33971.49042764311;38386.6161338383;38737.225255494166;39835.2032959345;40108.59891401049;33993.320133597685;34192.14519637029;38891.80554097211;39772;39882.40176397299;29446.411071778017;30573.54139687951;30722.846385767927;30790.846045770522;31059.84470077635;24070.277891663278;24430.633540497263;26581.60127598049;26616.334591635365;26742 11:20:21 INFO - PROCESS | 16540 | |2;jquery.html;367.3369567929887;369.8261816946035;370.7293675616798;371.54300210740786;372.8527231743463;13477.39351729172;13548;15598.142102184376;16345.673086538278;17048.744268835977;10844.295120817142;11209.607663731771;16031.438899638515;16699;16700.08149551777;4913.066517361699;5042.974785126069;5062.367204099488;5062.949370506303;5063.139266324715;3734.8692795752154;3866.130120722843;4996.200607902736;5043.067032598981;5286.995470860525;5447.428020057877;5447.564194864422;5485.835424937239;5497.340319161706;5497.752601132958;5502.697351645658;6026.6986650667295;6045.848853778647;6049.274087109553;6052.394760523935;5192.688438693691;5359.758810853521;5365.061114304981;5367.75845086972;5369.48989845964;17706.734398983896;18250.269989200417;18386.356477523223;19743.308984185627;19856.602867942704;2095.1724068992817;2105.884176370299;2129.744430668314;2144.538924131319;2189.2884812435864;9373.343865929388;9598.472084035375;10403.84394234087;10570.312929659625;12691.873081269161;1739.4259894234872;1825.2060353746162;1843.2719075965053;1977.7033444983367;1991.661417559004;48610.7569462154;49533.257001145015;49882.7505862472;50155.746106347266;50666.7466662668;9661.855072173923;9811.509424528746;9861.40936928342;10146.746331341628;10294.485275736333;13374.799378009338;13433.932830335982;13478.326083695973;13483.730325393437;13490.39293231807;7294.8905766413545;7351.632418379059;7402.7409040683315;7464.104307483137;7564.432667549956;7238.131424229021;7298.598577078205;7326.640648813947;7356.080489938758;7367.300106489874;4476.910461790746;4480.887977800516;4497.055618320124;4520.61574766142;4521.321801729767;1609.7102521546235;1626.268179319311;1757.261949981011;1861.5718384771578;1873.6721073812027;460.55096281126305;899.8875140607424;902.5487256371814;997.680742162501;1007.6976906927893;10027.247956403298;10332.121769649513;10388.272820902615;10711.678649640524;10725.731856703489;450.3132722598064;452.6265830689628;462.9722216667011;473.51701264710493;481.230031948879;5739.8565035874435;5773.24947756789;5948.167256584082;5974.492168165754;5979.372165922602;259565;422236;425488;431732;582352;55517.72241138769;64221.35778642154;66050;67519.32480675228;67905;502.8265248489265;518.9558887494529;519.6336582709181;519.6596229469628;520.4431258553387;9395.765105872408;10285.43430111351;10421.270511064153;10516;10651.30766500175;32220.35559288848;32440.513392299606;32622.83688581542;32649.020529384157;33142.66857331396;41524;42175.7891210542;42232.36651450169;42301.78849105735;43426.78286608673;2992.7456166226116;7157.355837974607;7157.677904494206;7355.77932662021;7411.998760334787;8537.615807288563;9428.622855085994;11027.558897644325;11123.83314250303;11272.549098035986;8384.496930184208;9606.183474404754;9627.378858147988;9649.131578158;9973.202143828621;6794.966025169842;7587.962060189664;7698.615069246627;7789.1821358756515;9705.805883882424;6806.455483561403;7285.7814265572115;7382.580239518155;7516.736914207976;7629.38964882797;9531;10056.597736090767;10118.08937195656;10221.897781022095;10321.535530901278;6965.268646792014;7075;7378.379448204961;7512.5492470451945;10033.297669163381 11:20:21 INFO - PROCESS | 16540 | |3;mootools.html;1337.5786627212422;1460.4596299369234;1462.0715845438147;1612.322824413746;1778.759867417899;6930.826729331763;7617.809554761134;7711.807204819876;7758.107817600978;7776.727814526493;7657.425693073028;7804.687812487494;7819.33535649469;7823.491473054261;7833.843323133534;1947.8928658923753;1988.880667159975;1991.8207361337477;2266.5920134375765;2291.415688999311;2043.1214577731569;2291.736450308211;2335.311083230443;2338.959163172389;2345.8240631952585;2227.7549469558335;2270.6707527408516;2272;2272.2047283450743;2296.1619009061737;2241.3612120545567;2248.685184074231;2250.189931624622;2261.4459457432868;2263.581237471073;2254.3011666383472;2289.9695137188332;2293.9197128100604;2294.1855641247284;2303.1593468384085;7867.724629637993;7893.250141236574;7928.524288542706;7928.722494712657;7933.048034235871;4662.510436404163;4734.4081989751285;4746.169420351424;4755.025219829927;4768.403949506312;3012.623422072241;3088.4795670411;3149.0395429394025;3170.6670799565945;3181.650018497963;1072.6406653770996;1085.7080074711148;1799.4421729263838;1863.6831738604335;1874.5594785225462;10745.194110441747;10837.67486975392;10842.132629389629;10869.565217391295;10881;4100.712950093465;4156.771377574202;4206.179794940019;4207.579242075829;4250.213710463574;8885.822283554293;8898.4660920345;8900.910990890137;8904.59929303183;8910.73267801954;4762.52374762521;4792.017636384533;4797.18447863864;4797.56821886032;4800.399950006249;4360.934585981213;4383.693141480066;4384.495782984934;4389.3635422864145;4393.846215382447;3369.140869078369;3440.6043305019743;3488.947665785015;3545.7340699447645;3547.6274991126074;1082.312731415541;1092.0335503079673;1093.2565855218368;1093.9671809845559;1107.9723006924892;1227.8219658149696;1241.3669028795198;1259.6913756129807;1260.0927332320714;1268.3277862732766;6949.131358580177;6993.790186294419;7014.351627367564;7177.856442871113;7215.747448839265;1080.270817198388;1080.5623722392443;1081.2647399768234;1084.360227465799;1111.8610173728284;5667.659940403589;5747.137929310553;5756.884862302731;5758.712064396764;5759.971200143972;9412.576434060484;9603.615855365708;9866.062724041205;9866.161376282953;9876.35803672759;9703.07820757027;9784.706458806248;9801.068898454636;9817.312788104764;9821.852672209923;7414.295641914009;7559.697612095564;7571.507851989603;7623.580703061385;7624.351930086005;7121.67952442131;7154;7160.641967901688;7176.995220669006;7178.784636460915;8419.158084191531;8507.617157227816;8753;8853.557322133996;8867.866981995146;8762.430442021248;8912.242459391024;9067.637294508146;9071.138241867277;9073.364864459425;6703.195616526048;6794.592324460548;6811.318868113149;6815.93184068153;6827.761028363983;6725;6888.931110689029;7187.389071928945;7556.168821429748;7622.237776222333;7007.054047703495;7042.401395881408;7107.60908150036;7116;7180.964095179491;6957.512974091967;7018.438524918097;7018.6490675465;7141.607211603412;7144.749933752294;6880;6923.099997000358;6953.130858642669;6992.475564332593;6995.860082798417;6438.098666186644;6508.414242717989;6587.242467116343;6599.967000164968;6602.66986650656;6242.812715618538;6293.96853015732;6296.685165741603;6300.21247344082;6304.243490781136 11:20:21 INFO - PROCESS | 16540 | |4;prototype.html;334.6235485079286;348.98953031409053;351.89794959461756;353.9805310707911;356.83585550646717;5808.390119037493;5953.136795164699;5971.283445986477;5984.311804142525;6005.399460053993;5740.770369185238;5825.9417405825925;5828.825135245939;5837.182794408786;5859.736311865966;4526.162659907911;4547.18150732868;4563.383943167663;4567.155076310876;4624.953750462486;4435.933460998088;4443.977780111095;4545.386372839657;4548.7725613719185;4659.207934651117;4524.095180963804;4556.430446194226;4564.84023059193;4582.945922437842;4596.770161491929;4546.97726511367;4561.064981678781;4562.3156526521125;4566.1780879441685;4580.55712450577;3988.3818008208773;4013.7591744495426;4020.336644453662;4022.6781857451333;4023.8994025149605;5476.507114359687;5591.10542313228;5659.490645841894;5692;5694.402087780806;5309.707966061865;5312.840614781563;5315.946840531584;5319.441458646825;5322.121849894763;5994.2806863176265;6302.842428939267;6307.9684601577155;6309.085182648536;6316.905246421307;4221.387898754663;4295.398644189816;4382.320740285261;4438.112377524508;4438.467383913951;6468.191476065492;6523.739050438025;6543;6547.672616369163;6561.704723287464;4513.684042117086;4516.774161291923;4521.3896124023495;4522.932156017662;4528.026474307973;4483.21543729846;4546.40896683429;4574.336721175411;4583.9083218335445;4586.059857729224;5219.086659834514;5226.869328266824;5262.526372626482;5263.736813159327;5268.578513718893;6251;6252.718627661766;6302.779402720975;6311.810645680545;6318.778842740482;1602.3910913852894;1622.5862405086627;1622.6349071458828;1623.0829581286534;1628.731259342219;1070.2454769387564;1071.5553045486192;1097.0620119797459;1102.7132945434246;1104.0394856474918;5986.491148252448;5989.580729348991;5996.400359963969;6010.759569617254;6012.857557064144;6471.870562588816;6488.448481878999;6489.610623362613;6492.448141907897;6502.447291980235;5872.471477566954;5966.164736936832;5969.940300597025;5972.940270597325;5990.311114221833;3479.095435186819;3482.930341393158;3515.0333658244185;3516.3143187078276;3516.49010893419;6735.730570777212;6746.527743058037;6748;6750.122484077038;6753.898691519631;6621.81480111562;6623.105880706139;6629.1382120325015;6631.30371311015;6638.634875081821;6530.902036469457;6712.53012289135;6712.765053223211;6722;6722.327767223336;6303.2436107665535;6414.775482858077;6426.646534440651;6439.227292724903;6442.226932768098;6286.968565157328;6381.3937675920715;6383.234011918599;6389.808305750835;6437.549371543947;6745;6815.761448349284;6816.693248803716;6829.863402732017;6830.965845170941;4489.515502718218;4535.773211339354;4548.727076375428;4560.065186636798;4568.109218702321;6542.443892269211;6545.738170473128;6557.245916719638;6558.475321974135;6566.671666416755;6380.7447702091395;6418.582792118497;6443.387878151568;6457.354264573505;6480.513961453004;6241.812745617639;6308.684565771785;6349.0476428536085;6351.96824015877;6352.587081839665;6200.224971878515;6216.906746398898;6220.626762394271;6223.564350495421;6223.937760622517;6406.1031455597185;6409.551331406757;6412.935870641234;6418.935810641834;6421.454176395058;6101.511879049576;6270.0908368287255;6271.184745983175;6271.6550589718;6286.245650521967 11:20:21 INFO - PROCESS | 16540 | |5;yui.html;683.5249501596386;693.4279219643795;775.7440044785218;781.4022272961184;786.0881377601982;13063.673408164801;13208.207507549554;13224.206547607138;13242.073054886137;13268.469261229538;12297.938510307436;12311.445984930677;12323.507059717624;12339.197952133105;12355.258684478938;662.4104546953215;672.4452326830384;800.0599295827409;803.2088392932957;807.1403954788161;792.7780221537979;793.2107552984788;794.7496538590326;801.3388954112851;805.3034125481475;698.5040621158984;846.4159729786459;848.2323497234981;848.5248260973843;849.1296421168321;678.6030172349157;696.3523922751839;698.1935864077;846.2848892685732;867.2888231650049;620.3393386043849;622.4335854372545;624.0265186309372;624.2228425610099;624.6845343101704;12424.875751242553;12507.562235321811;12589.622311330675;12627.621171364874;12657.240565566095;11759;12147.392630368535;12290.815637765441;12553.121281510297;12636.11547191697;10036.14692751117;10044.547995340226;10055.748606284827;10134.442605656686;10234.385936843813;3504.929901401983;3526.400511912955;3552.271784284241;3578.320119177374;3639.981800091009;47845.76077119592;48583;48711.51288487105;48815.023699526166;48895.51104488945;9200.493972831558;9225.72322830316;9250.676226332045;9264.305177111744;9590.568424420779;15879.920600397156;15906.443274485337;15914.76127858083;15930.203489825693;15948.920255398649;7011.123609548807;7141.9642901785155;7294.234105418961;7369;7535.962320188364;4064.898377540526;4100.835966561363;4184.707070505096;4202.054537728986;4208.894777630584;2900.2894290898867;2912.228259511231;2921.2258751430886;2925.3710452252867;2927.780416468773;525.7423862307442;546.778554685353;556.9554435645139;561.9157126431068;564.7797359029981;547.3103889099763;563.248063834777;573.2948473377685;579.3742757821543;594.197832925547;7529.4729368943645;7751.689932402754;7885.44801863864;7983.12185659577;8010.5994700264755;441.882901031227;476.66871524290286;545.3782687735984;559.7537083683167;564.601955621286;3552.236269202134;3553.484744712054;3600.5319308490252;3636.8727094551564;3683.097641077953;54505.72747136239;55257.447425526036;55584.44415555873;56335;56779.71610141923;50996;51172.74413627908;52342.47657523452;52628.47371526236;52658.473415266126;46293;46352;46759.29861052087;46856.5314346859;47040.2943955841;7701.845963080819;7790.493617914817;7824.687260912162;7826.7651970440975;8063.516189028677;33773;33972;34765.30469390548;35224.647753522135;37462.250754985296;44776.77611611921;44907.55092449034;45847.541524584325;46034.53965460436;46123;9772;9860.605575776888;9997.400155990665;10127.594896204364;10340.896591033994;11231;11402.600908968147;11663.533458661559;11698.70753231176;11754.902836056344;10308.175345972455;10362.896371036193;10387.740306492398;10632.946835265775;10789.352638841694;10581.89418105809;10652.733681658021;10809.254294509235;10813.243072984815;11051.668449946514;10611.151107911193;10616.105233228067;10804.135669146292;11017.944910275397;11232.66302010941;8443.240108390275;8553.401261911606;8628.439151455135;8735.956320218358;9298.800873712962;8702.738917832476;8941.195292423714;9079.319051071328;9209.401388909699;9414.764630884283 11:20:21 INFO - PROCESS | 16540 | __end_tp_report 11:20:21 INFO - PROCESS | 16540 | __start_cc_report 11:20:21 INFO - PROCESS | 16540 | _x_x_mozilla_cycle_collect,868 11:20:21 INFO - PROCESS | 16540 | __end_cc_report 11:20:21 INFO - PROCESS | 16540 | __startTimestamp1452799221158__endTimestamp 11:20:21 INFO - PROCESS | 16540 | 11:20:21 INFO - PROCESS | 16540 | ------- Summary: start ------- 11:20:21 INFO - PROCESS | 16540 | Number of tests: 6 11:20:21 INFO - PROCESS | 16540 | 11:20:21 INFO - PROCESS | 16540 | [#0] dojo.html Cycles:165 Average:5087.70 Median:5305.81 stddev:540.37 (10.2%) stddev-sans-first:519.47 11:20:21 INFO - PROCESS | 16540 | Values: 3118.2 3137.1 3179.7 3189.2 3206.4 5008.4 5107.3 5110.1 5120.9 5154.4 5063.8 5098.6 5099.8 5115.6 5119.8 4439.4 4628.7 4638.8 4708.2 4710.2 4613.4 4653.4 4655.1 4693.9 4779.2 4642.0 4669.9 4672.7 4708.9 4716.9 4650.1 4656.1 4656.7 4681.0 4696.4 4566.4 4654.4 4661.8 4675.1 4685.6 4976.8 5033.6 5035.2 5047.3 5080.9 5440.5 5450.6 5451.0 5457.8 5505.6 5392.8 5398.4 5475.8 5494.1 5543.8 5033.3 5146.6 5147.9 5167.7 5189.5 5585.1 5585.7 5595.2 5627.8 5634.9 5413.5 5424.9 5430.6 5432.9 5439.0 5404.8 5450.4 5463.0 5476.1 5488.5 5408.2 5477.6 5479.2 5484.8 5525.5 5472.5 5473.3 5476.7 5483.2 5544.0 4207.8 4251.0 4273.2 4300.9 4310.4 3815.0 3825.7 3837.8 3838.9 3855.3 5070.4 5077.3 5079.4 5081.1 5107.8 5408.5 5421.2 5467.2 5494.5 5533.5 5007.3 5055.1 5069.6 5083.3 5120.8 4672.8 4705.1 4713.2 4716.6 4738.3 5579.7 5605.4 5605.9 5606.2 5612.7 5487.3 5512.2 5523.2 5553.8 5563.9 5600.2 5606.8 5609.7 5614.0 5615.5 5331.2 5335.7 5393.0 5394.5 5419.9 5448.4 5454.4 5460.9 5505.5 5528.5 5318.0 5347.9 5351.3 5354.5 5364.2 5246.3 5339.1 5352.9 5359.6 5407.9 5155.0 5204.7 5251.8 5272.3 5329.4 5399.6 5419.1 5424.3 5424.8 5428.9 5242.5 5299.4 5305.8 5309.2 5363.9 11:20:21 INFO - PROCESS | 16540 | 11:20:21 INFO - PROCESS | 16540 | [#1] ext.html Cycles:180 Average:45851.22 Median:3771.83 stddev:80481.41 (2133.7%) stddev-sans-first:80635.27 11:20:21 INFO - PROCESS | 16540 | Values: 538.8 554.8 562.4 612.8 614.1 35087.1 35699.0 35769.8 35805.6 35828.8 42681.4 43800.6 43805.6 43869.3 43910.6 8591.8 8814.4 8816.2 8817.2 8821.2 8457.0 8617.5 8620.8 8630.1 8632.9 8517.1 8581.9 8635.9 8642.4 8651.6 8465.9 8521.0 8562.6 8568.6 8572.1 8444.4 8535.6 8562.9 8566.4 8568.7 39281.8 39514.8 39661.6 39741.6 39748.2 3332.3 3359.1 3371.3 3801.0 3968.8 29459.9 29685.7 29936.6 30646.4 31313.2 3544.9 3581.6 3597.4 3735.1 3742.7 222229.0 223328.0 223771.0 223987.0 224059.0 41970.0 42752.1 52679.7 53582.0 58700.0 40761.6 40931.0 40966.6 40998.8 41028.8 13158.5 13351.8 13415.9 13428.2 13466.9 10463.9 10782.2 10899.5 11001.4 11018.1 14043.9 14130.9 14131.8 14220.4 14262.5 5634.6 5653.7 5749.5 5762.0 5814.9 910.4 984.7 989.6 1049.7 1114.7 28125.0 29016.7 29102.4 30685.5 32279.7 1001.2 1035.3 1045.3 1052.0 1067.9 14906.7 14949.5 15022.2 15258.4 15271.3 383114.0 383814.0 385331.0 387047.0 388508.0 53124.0 53479.0 53620.5 53622.0 53699.5 1318.8 1330.5 1339.9 1340.5 1378.2 27693.3 27966.6 28884.0 28887.1 28925.6 46292.5 46561.3 46841.0 46879.8 47004.0 279753.0 284951.0 285403.0 293217.0 293314.0 30687.7 30690.0 30731.5 31177.5 31219.2 41087.2 42043.4 42061.8 42873.1 42959.8 36515.8 36584.1 36952.3 38332.4 39475.2 33971.5 38386.6 38737.2 39835.2 40108.6 33993.3 34192.1 38891.8 39772.0 39882.4 29446.4 30573.5 30722.8 30790.8 31059.8 24070.3 24430.6 26581.6 26616.3 26742.0 11:20:21 INFO - PROCESS | 16540 | 11:20:21 INFO - PROCESS | 16540 | [#2] jquery.html Cycles:180 Average:23188.96 Median:24545.99 stddev:71459.37 (291.1%) stddev-sans-first:71639.29 11:20:21 INFO - PROCESS | 16540 | Values: 367.3 369.8 370.7 371.5 372.9 13477.4 13548.0 15598.1 16345.7 17048.7 10844.3 11209.6 16031.4 16699.0 16700.1 4913.1 5043.0 5062.4 5062.9 5063.1 3734.9 3866.1 4996.2 5043.1 5287.0 5447.4 5447.6 5485.8 5497.3 5497.8 5502.7 6026.7 6045.8 6049.3 6052.4 5192.7 5359.8 5365.1 5367.8 5369.5 17706.7 18250.3 18386.4 19743.3 19856.6 2095.2 2105.9 2129.7 2144.5 2189.3 9373.3 9598.5 10403.8 10570.3 12691.9 1739.4 1825.2 1843.3 1977.7 1991.7 48610.8 49533.3 49882.8 50155.7 50666.7 9661.9 9811.5 9861.4 10146.7 10294.5 13374.8 13433.9 13478.3 13483.7 13490.4 7294.9 7351.6 7402.7 7464.1 7564.4 7238.1 7298.6 7326.6 7356.1 7367.3 4476.9 4480.9 4497.1 4520.6 4521.3 1609.7 1626.3 1757.3 1861.6 1873.7 460.6 899.9 902.5 997.7 1007.7 10027.2 10332.1 10388.3 10711.7 10725.7 450.3 452.6 463.0 473.5 481.2 5739.9 5773.2 5948.2 5974.5 5979.4 259565.0 422236.0 425488.0 431732.0 582352.0 55517.7 64221.4 66050.0 67519.3 67905.0 502.8 519.0 519.6 519.7 520.4 9395.8 10285.4 10421.3 10516.0 10651.3 32220.4 32440.5 32622.8 32649.0 33142.7 41524.0 42175.8 42232.4 42301.8 43426.8 2992.7 7157.4 7157.7 7355.8 7412.0 8537.6 9428.6 11027.6 11123.8 11272.5 8384.5 9606.2 9627.4 9649.1 9973.2 6795.0 7588.0 7698.6 7789.2 9705.8 6806.5 7285.8 7382.6 7516.7 7629.4 9531.0 10056.6 10118.1 10221.9 10321.5 6965.3 7075.0 7378.4 7512.5 10033.3 11:20:21 INFO - PROCESS | 16540 | 11:20:21 INFO - PROCESS | 16540 | [#3] mootools.html Cycles:180 Average:5499.19 Median:6268.39 stddev:2859.07 (45.6%) stddev-sans-first:2849.98 11:20:21 INFO - PROCESS | 16540 | Values: 1337.6 1460.5 1462.1 1612.3 1778.8 6930.8 7617.8 7711.8 7758.1 7776.7 7657.4 7804.7 7819.3 7823.5 7833.8 1947.9 1988.9 1991.8 2266.6 2291.4 2043.1 2291.7 2335.3 2339.0 2345.8 2227.8 2270.7 2272.0 2272.2 2296.2 2241.4 2248.7 2250.2 2261.4 2263.6 2254.3 2290.0 2293.9 2294.2 2303.2 7867.7 7893.3 7928.5 7928.7 7933.0 4662.5 4734.4 4746.2 4755.0 4768.4 3012.6 3088.5 3149.0 3170.7 3181.7 1072.6 1085.7 1799.4 1863.7 1874.6 10745.2 10837.7 10842.1 10869.6 10881.0 4100.7 4156.8 4206.2 4207.6 4250.2 8885.8 8898.5 8900.9 8904.6 8910.7 4762.5 4792.0 4797.2 4797.6 4800.4 4360.9 4383.7 4384.5 4389.4 4393.8 3369.1 3440.6 3488.9 3545.7 3547.6 1082.3 1092.0 1093.3 1094.0 1108.0 1227.8 1241.4 1259.7 1260.1 1268.3 6949.1 6993.8 7014.4 7177.9 7215.7 1080.3 1080.6 1081.3 1084.4 1111.9 5667.7 5747.1 5756.9 5758.7 5760.0 9412.6 9603.6 9866.1 9866.2 9876.4 9703.1 9784.7 9801.1 9817.3 9821.9 7414.3 7559.7 7571.5 7623.6 7624.4 7121.7 7154.0 7160.6 7177.0 7178.8 8419.2 8507.6 8753.0 8853.6 8867.9 8762.4 8912.2 9067.6 9071.1 9073.4 6703.2 6794.6 6811.3 6815.9 6827.8 6725.0 6888.9 7187.4 7556.2 7622.2 7007.1 7042.4 7107.6 7116.0 7181.0 6957.5 7018.4 7018.6 7141.6 7144.7 6880.0 6923.1 6953.1 6992.5 6995.9 6438.1 6508.4 6587.2 6600.0 6602.7 6242.8 6294.0 6296.7 6300.2 6304.2 11:20:21 INFO - PROCESS | 16540 | 11:20:21 INFO - PROCESS | 16540 | [#4] prototype.html Cycles:180 Average:5279.09 Median:5972.11 stddev:1579.99 (26.5%) stddev-sans-first:1540.22 11:20:21 INFO - PROCESS | 16540 | Values: 334.6 349.0 351.9 354.0 356.8 5808.4 5953.1 5971.3 5984.3 6005.4 5740.8 5825.9 5828.8 5837.2 5859.7 4526.2 4547.2 4563.4 4567.2 4625.0 4435.9 4444.0 4545.4 4548.8 4659.2 4524.1 4556.4 4564.8 4582.9 4596.8 4547.0 4561.1 4562.3 4566.2 4580.6 3988.4 4013.8 4020.3 4022.7 4023.9 5476.5 5591.1 5659.5 5692.0 5694.4 5309.7 5312.8 5315.9 5319.4 5322.1 5994.3 6302.8 6308.0 6309.1 6316.9 4221.4 4295.4 4382.3 4438.1 4438.5 6468.2 6523.7 6543.0 6547.7 6561.7 4513.7 4516.8 4521.4 4522.9 4528.0 4483.2 4546.4 4574.3 4583.9 4586.1 5219.1 5226.9 5262.5 5263.7 5268.6 6251.0 6252.7 6302.8 6311.8 6318.8 1602.4 1622.6 1622.6 1623.1 1628.7 1070.2 1071.6 1097.1 1102.7 1104.0 5986.5 5989.6 5996.4 6010.8 6012.9 6471.9 6488.4 6489.6 6492.4 6502.4 5872.5 5966.2 5969.9 5972.9 5990.3 3479.1 3482.9 3515.0 3516.3 3516.5 6735.7 6746.5 6748.0 6750.1 6753.9 6621.8 6623.1 6629.1 6631.3 6638.6 6530.9 6712.5 6712.8 6722.0 6722.3 6303.2 6414.8 6426.6 6439.2 6442.2 6287.0 6381.4 6383.2 6389.8 6437.5 6745.0 6815.8 6816.7 6829.9 6831.0 4489.5 4535.8 4548.7 4560.1 4568.1 6542.4 6545.7 6557.2 6558.5 6566.7 6380.7 6418.6 6443.4 6457.4 6480.5 6241.8 6308.7 6349.0 6352.0 6352.6 6200.2 6216.9 6220.6 6223.6 6223.9 6406.1 6409.6 6412.9 6418.9 6421.5 6101.5 6270.1 6271.2 6271.7 6286.2 11:20:21 INFO - PROCESS | 16540 | 11:20:21 INFO - PROCESS | 16540 | [#5] yui.html Cycles:180 Average:13443.42 Median:48647.26 stddev:16014.78 (32.9%) stddev-sans-first:16031.04 11:20:21 INFO - PROCESS | 16540 | Values: 683.5 693.4 775.7 781.4 786.1 13063.7 13208.2 13224.2 13242.1 13268.5 12297.9 12311.4 12323.5 12339.2 12355.3 662.4 672.4 800.1 803.2 807.1 792.8 793.2 794.7 801.3 805.3 698.5 846.4 848.2 848.5 849.1 678.6 696.4 698.2 846.3 867.3 620.3 622.4 624.0 624.2 624.7 12424.9 12507.6 12589.6 12627.6 12657.2 11759.0 12147.4 12290.8 12553.1 12636.1 10036.1 10044.5 10055.7 10134.4 10234.4 3504.9 3526.4 3552.3 3578.3 3640.0 47845.8 48583.0 48711.5 48815.0 48895.5 9200.5 9225.7 9250.7 9264.3 9590.6 15879.9 15906.4 15914.8 15930.2 15948.9 7011.1 7142.0 7294.2 7369.0 7536.0 4064.9 4100.8 4184.7 4202.1 4208.9 2900.3 2912.2 2921.2 2925.4 2927.8 525.7 546.8 557.0 561.9 564.8 547.3 563.2 573.3 579.4 594.2 7529.5 7751.7 7885.4 7983.1 8010.6 441.9 476.7 545.4 559.8 564.6 3552.2 3553.5 3600.5 3636.9 3683.1 54505.7 55257.4 55584.4 56335.0 56779.7 50996.0 51172.7 52342.5 52628.5 52658.5 46293.0 46352.0 46759.3 46856.5 47040.3 7701.8 7790.5 7824.7 7826.8 8063.5 33773.0 33972.0 34765.3 35224.6 37462.3 44776.8 44907.6 45847.5 46034.5 46123.0 9772.0 9860.6 9997.4 10127.6 10340.9 11231.0 11402.6 11663.5 11698.7 11754.9 10308.2 10362.9 10387.7 10632.9 10789.4 10581.9 10652.7 10809.3 10813.2 11051.7 10611.2 10616.1 10804.1 11017.9 11232.7 8443.2 8553.4 8628.4 8736.0 9298.8 8702.7 8941.2 9079.3 9209.4 9414.8 11:20:21 INFO - PROCESS | 16540 | -------- Summary: end -------- 11:20:21 INFO - PROCESS | 16540 | 11:20:21 INFO - TEST-INFO | 16540: exit 0 11:20:21 INFO - TEST-OK | dromaeo_css | took 1112800ms 11:20:21 INFO - TEST-START | kraken 11:20:21 INFO - operating with platform_type : linux_ 11:20:21 INFO - Initialising browser for kraken test... 11:20:21 INFO - TEST-INFO | started process 16741 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBXXajh/profile http://localhost:49452/getInfo.html) 11:20:25 INFO - PROCESS | 16741 | __metrics Screen width/height:1600/1200 11:20:25 INFO - PROCESS | 16741 | colorDepth:24 11:20:25 INFO - PROCESS | 16741 | Browser inner width/height: 1024/697 11:20:25 INFO - PROCESS | 16741 | __metrics 11:20:25 INFO - PROCESS | 16741 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:20:25 INFO - PROCESS | 16741 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:20:26 INFO - TEST-INFO | 16741: exit 0 11:20:26 INFO - Browser initialized. 11:20:26 INFO - Running cycle 1/1 for kraken test... 11:20:26 INFO - TEST-INFO | started process 16822 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBXXajh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:38 INFO - PROCESS | 16822 | RSS: Main: 150147072 11:20:38 INFO - PROCESS | 16822 | 11:20:41 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49452/tests/kraken/driver.html?testName=audio-beat-detection) 11:20:41 INFO - PROCESS | 16822 | RSS: Main: 185360384 11:20:41 INFO - PROCESS | 16822 | 11:20:44 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49452/tests/kraken/driver.html?testName=audio-dft) 11:20:44 INFO - PROCESS | 16822 | RSS: Main: 176812032 11:20:44 INFO - PROCESS | 16822 | 11:20:47 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49452/tests/kraken/driver.html?testName=audio-fft) 11:20:48 INFO - PROCESS | 16822 | RSS: Main: 161583104 11:20:48 INFO - PROCESS | 16822 | 11:20:50 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49452/tests/kraken/driver.html?testName=audio-oscillator) 11:20:50 INFO - PROCESS | 16822 | RSS: Main: 163958784 11:20:50 INFO - PROCESS | 16822 | 11:20:53 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49452/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:20:53 INFO - PROCESS | 16822 | RSS: Main: 166080512 11:20:53 INFO - PROCESS | 16822 | 11:20:56 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49452/tests/kraken/driver.html?testName=imaging-darkroom) 11:20:57 INFO - PROCESS | 16822 | RSS: Main: 165961728 11:20:57 INFO - PROCESS | 16822 | 11:21:00 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49452/tests/kraken/driver.html?testName=imaging-desaturate) 11:21:01 INFO - PROCESS | 16822 | RSS: Main: 167956480 11:21:01 INFO - PROCESS | 16822 | 11:21:03 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49452/tests/kraken/driver.html?testName=json-parse-financial) 11:21:04 INFO - PROCESS | 16822 | RSS: Main: 165998592 11:21:04 INFO - PROCESS | 16822 | 11:21:05 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49452/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:21:06 INFO - PROCESS | 16822 | RSS: Main: 176476160 11:21:06 INFO - PROCESS | 16822 | 11:21:08 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:21:08 INFO - PROCESS | 16822 | RSS: Main: 172806144 11:21:08 INFO - PROCESS | 16822 | 11:21:10 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:21:11 INFO - PROCESS | 16822 | RSS: Main: 185139200 11:21:11 INFO - PROCESS | 16822 | 11:21:13 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:21:14 INFO - PROCESS | 16822 | RSS: Main: 190713856 11:21:14 INFO - PROCESS | 16822 | 11:21:16 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:21:17 INFO - PROCESS | 16822 | RSS: Main: 186974208 11:21:17 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49452/tests/kraken/driver.html?testName=ai-astar) 11:21:19 INFO - PROCESS | 16822 | RSS: Main: 246706176 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | __start_tp_report 11:21:19 INFO - PROCESS | 16822 | _x_x_mozilla_page_load 11:21:19 INFO - PROCESS | 16822 | _x_x_mozilla_page_load_details 11:21:19 INFO - PROCESS | 16822 | |i|pagename|runs| 11:21:19 INFO - PROCESS | 16822 | |0;ai-astar;112;110;105;109;111;110;99;110;110;112 11:21:19 INFO - PROCESS | 16822 | |1;audio-beat-detection;148;125;149;158;125;160;144;128;161;124 11:21:19 INFO - PROCESS | 16822 | |2;audio-dft;161;161;160;159;160;164;159;162;160;162 11:21:19 INFO - PROCESS | 16822 | |3;audio-fft;73;75;102;93;71;72;73;99;95;75 11:21:19 INFO - PROCESS | 16822 | |4;audio-oscillator;96;97;142;96;95;96;146;96;95;138 11:21:19 INFO - PROCESS | 16822 | |5;imaging-gaussian-blur;109;109;109;110;109;109;109;109;109;109 11:21:19 INFO - PROCESS | 16822 | |6;imaging-darkroom;146;145;146;145;145;146;147;146;145;145 11:21:19 INFO - PROCESS | 16822 | |7;imaging-desaturate;98;96;96;97;96;96;95;96;96;96 11:21:19 INFO - PROCESS | 16822 | |8;json-parse-financial;57;56;56;56;56;56;55;64;53;53 11:21:19 INFO - PROCESS | 16822 | |9;json-stringify-tinderbox;66;67;67;67;67;68;67;68;68;67 11:21:19 INFO - PROCESS | 16822 | |10;stanford-crypto-aes;81;81;83;82;82;83;81;83;82;90 11:21:19 INFO - PROCESS | 16822 | |11;stanford-crypto-ccm;115;114;113;124;112;122;113;124;112;118 11:21:19 INFO - PROCESS | 16822 | |12;stanford-crypto-pbkdf2;143;130;150;134;142;144;141;153;138;139 11:21:19 INFO - PROCESS | 16822 | |13;stanford-crypto-sha256-iterative;66;66;67;66;66;67;67;69;64;67 11:21:19 INFO - PROCESS | 16822 | __end_tp_report 11:21:19 INFO - PROCESS | 16822 | __start_cc_report 11:21:19 INFO - PROCESS | 16822 | _x_x_mozilla_cycle_collect,937 11:21:19 INFO - PROCESS | 16822 | __end_cc_report 11:21:19 INFO - PROCESS | 16822 | __startTimestamp1452799279481__endTimestamp 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | ------- Summary: start ------- 11:21:19 INFO - PROCESS | 16822 | Number of tests: 14 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:3.97 (3.6%) stddev-sans-first:4.03 11:21:19 INFO - PROCESS | 16822 | Values: 112.0 110.0 105.0 109.0 111.0 110.0 99.0 110.0 110.0 112.0 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:148.50 stddev:15.38 (10.4%) stddev-sans-first:16.16 11:21:19 INFO - PROCESS | 16822 | Values: 148.0 125.0 149.0 158.0 125.0 160.0 144.0 128.0 161.0 124.0 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.55 (1.0%) stddev-sans-first:1.64 11:21:19 INFO - PROCESS | 16822 | Values: 161.0 161.0 160.0 159.0 160.0 164.0 159.0 162.0 160.0 162.0 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.00 stddev:12.71 (16.9%) stddev-sans-first:12.98 11:21:19 INFO - PROCESS | 16822 | Values: 73.0 75.0 102.0 93.0 71.0 72.0 73.0 99.0 95.0 75.0 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:96.00 stddev:22.38 (23.3%) stddev-sans-first:23.18 11:21:19 INFO - PROCESS | 16822 | Values: 96.0 97.0 142.0 96.0 95.0 96.0 146.0 96.0 95.0 138.0 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:21:19 INFO - PROCESS | 16822 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 11:21:19 INFO - PROCESS | 16822 | Values: 146.0 145.0 146.0 145.0 145.0 146.0 147.0 146.0 145.0 145.0 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.50 11:21:19 INFO - PROCESS | 16822 | Values: 98.0 96.0 96.0 97.0 96.0 96.0 95.0 96.0 96.0 96.0 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:3.05 (5.4%) stddev-sans-first:3.22 11:21:19 INFO - PROCESS | 16822 | Values: 57.0 56.0 56.0 56.0 56.0 56.0 55.0 64.0 53.0 53.0 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 11:21:19 INFO - PROCESS | 16822 | Values: 66.0 67.0 67.0 67.0 67.0 68.0 67.0 68.0 68.0 67.0 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:2.66 (3.2%) stddev-sans-first:2.74 11:21:19 INFO - PROCESS | 16822 | Values: 81.0 81.0 83.0 82.0 82.0 83.0 81.0 83.0 82.0 90.0 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:116.50 stddev:4.92 (4.2%) stddev-sans-first:5.18 11:21:19 INFO - PROCESS | 16822 | Values: 115.0 114.0 113.0 124.0 112.0 122.0 113.0 124.0 112.0 118.0 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:142.50 stddev:6.83 (4.8%) stddev-sans-first:7.22 11:21:19 INFO - PROCESS | 16822 | Values: 143.0 130.0 150.0 134.0 142.0 144.0 141.0 153.0 138.0 139.0 11:21:19 INFO - PROCESS | 16822 | 11:21:19 INFO - PROCESS | 16822 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.27 (1.9%) stddev-sans-first:1.33 11:21:19 INFO - PROCESS | 16822 | Values: 66.0 66.0 67.0 66.0 66.0 67.0 67.0 69.0 64.0 67.0 11:21:19 INFO - PROCESS | 16822 | -------- Summary: end -------- 11:21:19 INFO - PROCESS | 16822 | 11:21:20 INFO - TEST-INFO | 16822: exit 0 11:21:20 INFO - TEST-OK | kraken | took 58605ms 11:21:20 INFO - TEST-START | v8_7 11:21:20 INFO - operating with platform_type : linux_ 11:21:20 INFO - Initialising browser for v8_7 test... 11:21:20 INFO - TEST-INFO | started process 17075 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiIFs0q/profile http://localhost:49452/getInfo.html) 11:21:24 INFO - PROCESS | 17075 | __metrics Screen width/height:1600/1200 11:21:24 INFO - PROCESS | 17075 | colorDepth:24 11:21:24 INFO - PROCESS | 17075 | Browser inner width/height: 1024/697 11:21:24 INFO - PROCESS | 17075 | __metrics 11:21:24 INFO - PROCESS | 17075 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:21:24 INFO - PROCESS | 17075 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:21:25 INFO - TEST-INFO | 17075: exit 0 11:21:25 INFO - Browser initialized. 11:21:25 INFO - Running cycle 1/1 for v8_7 test... 11:21:25 INFO - TEST-INFO | started process 17160 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiIFs0q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:37 INFO - PROCESS | 17160 | RSS: Main: 149651456 11:21:37 INFO - PROCESS | 17160 | 11:21:59 INFO - PROCESS | 17160 | Cycle 1(1): loaded http://localhost:49452/tests/v8_7/run.html (next: http://localhost:49452/tests/v8_7/run.html) 11:21:59 INFO - PROCESS | 17160 | RSS: Main: 551702528 11:21:59 INFO - PROCESS | 17160 | 11:21:59 INFO - PROCESS | 17160 | __start_tp_report 11:21:59 INFO - PROCESS | 17160 | _x_x_mozilla_page_load 11:21:59 INFO - PROCESS | 17160 | _x_x_mozilla_page_load_details 11:21:59 INFO - PROCESS | 17160 | |i|pagename|runs| 11:21:59 INFO - PROCESS | 17160 | |0;Richards;166.00265604249668 11:21:59 INFO - PROCESS | 17160 | |1;DeltaBlue;189.000189000189 11:21:59 INFO - PROCESS | 17160 | |2;Encrypt;280.662363177098 11:21:59 INFO - PROCESS | 17160 | |3;Decrypt;5170.103092783505 11:21:59 INFO - PROCESS | 17160 | |4;RayTrace;1919.3857965451057 11:21:59 INFO - PROCESS | 17160 | |5;Earley;788.1889763779527 11:21:59 INFO - PROCESS | 17160 | |6;Boyer;12304.878048780487 11:21:59 INFO - PROCESS | 17160 | |7;RegExp;42895.833333333336 11:21:59 INFO - PROCESS | 17160 | |8;Splay;573.9476678043231 11:21:59 INFO - PROCESS | 17160 | |9;NavierStokes;4830.917874396136 11:21:59 INFO - PROCESS | 17160 | __end_tp_report 11:21:59 INFO - PROCESS | 17160 | __startTimestamp1452799319993__endTimestamp 11:21:59 INFO - PROCESS | 17160 | 11:21:59 INFO - PROCESS | 17160 | ------- Summary: start ------- 11:22:00 INFO - PROCESS | 17160 | Number of tests: 10 11:22:00 INFO - PROCESS | 17160 | 11:22:00 INFO - PROCESS | 17160 | [#0] Richards Cycles:1 Average:166.00 Median:166.00 stddev:0.00 (0.0%) 11:22:00 INFO - PROCESS | 17160 | Values: 166.0 11:22:00 INFO - PROCESS | 17160 | 11:22:00 INFO - PROCESS | 17160 | [#1] DeltaBlue Cycles:1 Average:189.00 Median:189.00 stddev:0.00 (0.0%) 11:22:00 INFO - PROCESS | 17160 | Values: 189.0 11:22:00 INFO - PROCESS | 17160 | 11:22:00 INFO - PROCESS | 17160 | [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 11:22:00 INFO - PROCESS | 17160 | Values: 280.7 11:22:00 INFO - PROCESS | 17160 | 11:22:00 INFO - PROCESS | 17160 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 11:22:00 INFO - PROCESS | 17160 | Values: 5170.1 11:22:00 INFO - PROCESS | 17160 | 11:22:00 INFO - PROCESS | 17160 | [#4] RayTrace Cycles:1 Average:1919.39 Median:1919.39 stddev:0.00 (0.0%) 11:22:00 INFO - PROCESS | 17160 | Values: 1919.4 11:22:00 INFO - PROCESS | 17160 | 11:22:00 INFO - PROCESS | 17160 | [#5] Earley Cycles:1 Average:788.19 Median:788.19 stddev:0.00 (0.0%) 11:22:00 INFO - PROCESS | 17160 | Values: 788.2 11:22:00 INFO - PROCESS | 17160 | 11:22:00 INFO - PROCESS | 17160 | [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 11:22:00 INFO - PROCESS | 17160 | Values: 12304.9 11:22:00 INFO - PROCESS | 17160 | 11:22:00 INFO - PROCESS | 17160 | [#7] RegExp Cycles:1 Average:42895.83 Median:42895.83 stddev:0.00 (0.0%) 11:22:00 INFO - PROCESS | 17160 | Values: 42895.8 11:22:00 INFO - PROCESS | 17160 | 11:22:00 INFO - PROCESS | 17160 | [#8] Splay Cycles:1 Average:573.95 Median:573.95 stddev:0.00 (0.0%) 11:22:00 INFO - PROCESS | 17160 | Values: 573.9 11:22:00 INFO - PROCESS | 17160 | 11:22:00 INFO - PROCESS | 17160 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:22:00 INFO - PROCESS | 17160 | Values: 4830.9 11:22:00 INFO - PROCESS | 17160 | -------- Summary: end -------- 11:22:00 INFO - PROCESS | 17160 | 11:22:00 INFO - TEST-INFO | 17160: exit 0 11:22:00 INFO - TEST-OK | v8_7 | took 40439ms 11:22:00 INFO - SUITE-END | took 1211s 11:22:00 INFO - Completed test suite (00:20:11) 11:22:00 INFO - Working with test: dromaeo_css 11:22:00 INFO - Generating results file: dromaeo_css 11:22:00 INFO - Working with test: kraken 11:22:00 INFO - Generating results file: kraken 11:22:00 INFO - javascript benchmark 11:22:00 INFO - Working with test: v8_7 11:22:00 INFO - Generating results file: v8_7 11:22:00 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:01 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 11:22:01 INFO - process_Request line: dromaeo_css 6622.88 graph.html#tests=[[72,201,35]] 11:22:01 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:01 INFO - process_Request line: kraken 1486.00 graph.html#tests=[[232,201,35]] 11:22:01 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:01 INFO - process_Request line: v8_7 19042.44 graph.html#tests=[[230,201,35]] 11:22:01 INFO - RETURN: dromaeo_css: 6622.88 11:22:01 INFO - RETURN: kraken: 1486.00 11:22:01 INFO - RETURN: v8_7: 19042.44 11:22:01 INFO - javascript benchmark 11:22:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3118.173683973746, 3137.0588823352996, 3179.713825755683, 3189.2186414328494, 3206.35872825435, 5008.449070602231, 5107.310513080733, 5110.054639891623, 5120.871978200542, 5154.381474223093, 5063.822766203184, 5098.61760367973, 5099.847004589859, 5115.641905066647, 5119.795208191668, 4439.422875026258, 4628.69913455626, 4638.814447422099, 4708.223143181371, 4710.152172608929, 4613.446386433633, 4653.441587009564, 4655.068986202756, 4693.929591056137, 4779.211430114027, 4641.999999999983, 4669.929951050737, 4672.715003374065, 4708.858734237944, 4716.858494245178, 4650.116477869228, 4656.115338085787, 4656.720596764171, 4681.0, 4696.412948381452, 4566.406367172246, 4654.371659825914, 4661.836835710767, 4675.088357770236, 4685.648576356787, 4976.751162441899, 5033.572146367563, 5035.194368900959, 5047.343845300087, 5080.898382032338, 5440.510354068113, 5450.5639548836, 5450.972745136289, 5457.836264912059, 5505.587080968903, 5392.78428862845, 5398.379186393576, 5475.753591088371, 5494.066008778517, 5543.833684989457, 5033.295338652591, 5146.639735218536, 5147.948520514747, 5167.6641018333685, 5189.481051894856, 5585.050541407971, 5585.720713964285, 5595.188697638901, 5627.774889004476, 5634.915476267859, 5413.53984911287, 5424.864378390572, 5430.647007944471, 5432.945670543244, 5438.972805135949, 5404.8108316208745, 5450.427705090988, 5463.016657001698, 5476.123820188751, 5488.53347465462, 5408.1887716842, 5477.589180811455, 5479.178123281539, 5484.8354549363585, 5525.475079867406, 5472.452754724496, 5473.343198816088, 5476.698781566973, 5483.204935284361, 5543.972280138573, 4207.76857272853, 4251.043515209115, 4273.166732487135, 4300.935485967713, 4310.374995625617, 3815.0271680721794, 3825.6748176404762, 3837.76973381598, 3838.8848334550007, 3855.267499175148, 5070.366204224472, 5077.289179514797, 5079.415867175248, 5081.110805609003, 5107.846764597068, 5408.5402740766685, 5421.213923981, 5467.152591348347, 5494.450554944474, 5533.501984821385, 5007.349044624249, 5055.064813009605, 5069.5690866276045, 5083.339165908408, 5120.7951681933055, 4672.813087476531, 4705.12955103307, 4713.2458806590785, 4716.5990890774665, 4738.336632871401, 5579.69311687861, 5605.439456054362, 5605.943940560624, 5606.21512988182, 5612.719364031782, 5487.314085739283, 5512.173174023928, 5523.1991361253195, 5553.750081246434, 5563.8887222256135, 5600.243967064394, 5606.831795046155, 5609.691466969356, 5613.971930140323, 5615.522680572034, 5331.200319952039, 5335.706536140394, 5393.0, 5394.514493695587, 5419.918701219406, 5448.373437054789, 5454.372747133972, 5460.945390546044, 5505.504504594605, 5528.530074943675, 5318.0, 5347.919781203363, 5351.331083614548, 5354.491323324278, 5364.249005139206, 5246.265522826731, 5339.145736682268, 5352.866178345573, 5359.598030147677, 5407.891842163056, 5155.046316431472, 5204.739763011758, 5251.763670634754, 5272.314599102092, 5329.440408757025, 5399.568034557147, 5419.078756611464, 5424.349078110652, 5424.83725488236, 5428.945710542844, 5242.501962313574, 5299.44355842631, 5305.814296499604, 5309.177077552986, 5363.865903352447], "unit": "score", "name": "dojo.html", "value": 5054.543568041808}, {"lowerIsBetter": false, "replicates": [538.7575590984055, 554.8347526597627, 562.4207066721278, 612.7855250662267, 614.1371373220625, 35087.122821929464, 35699.0, 35769.82115089424, 35805.64194358059, 35828.82085589575, 42681.35977960333, 43800.61993800618, 43805.56194438055, 43869.341959870544, 43910.56089439105, 8591.785205369884, 8814.427062240933, 8816.206541411271, 8817.16236957488, 8821.206091451768, 8456.957715211416, 8617.48295102296, 8620.784480387978, 8630.050694423608, 8632.913670863274, 8517.148285171495, 8581.914180858204, 8635.913640863606, 8642.438241514314, 8651.567421628924, 8465.873011904796, 8521.0, 8562.571871406404, 8568.614412351459, 8572.057073721886, 8444.408891377607, 8535.573221338971, 8562.871556926651, 8566.357523185723, 8568.657253709844, 39281.803590981865, 39514.802425987684, 39661.60338396608, 39741.60258397437, 39748.20503589912, 3332.2502436951736, 3359.10983589349, 3371.3088816792497, 3800.9619903800885, 3968.7817170055637, 29459.85270073636, 29685.70314296851, 29936.550951735742, 30646.387072258654, 31313.217169570944, 3544.946825797615, 3581.5881173665102, 3597.406427939387, 3735.0849041984616, 3742.700583953277, 222229.0, 223328.0, 223771.0, 223987.0, 224059.0, 41970.0, 42752.14495710131, 52679.73660131675, 53582.0, 58700.0, 40761.59238407637, 40931.0, 40966.59033409687, 40998.79500602478, 41028.79485602613, 13158.539451119164, 13351.799723004162, 13415.865841341461, 13428.19430834153, 13466.865331346562, 10463.895361046445, 10782.245242833083, 10899.509522071527, 11001.394923279136, 11018.063464605599, 14043.929780351033, 14130.929345353414, 14131.78802317966, 14220.431182752782, 14262.500812471513, 5634.6337488063145, 5653.65373370055, 5749.540036797046, 5761.971190144106, 5814.854628634318, 910.4082346474844, 984.6898227058454, 989.5547003848297, 1049.6955882794057, 1114.7046032801313, 28125.0, 29016.7098329014, 29102.417951640848, 30685.539716904263, 32279.677203228137, 1001.2190491416707, 1035.321864178964, 1045.3100953370738, 1052.021619893491, 1067.8558394616782, 14906.70186596262, 14949.476768313058, 15022.24888755558, 15258.389664413298, 15271.312790924212, 383114.0, 383814.0, 385331.0, 387047.0, 388508.0, 53124.0, 53479.0, 53620.463795362324, 53622.0, 53699.46300536945, 1318.8153658487627, 1330.5409633676366, 1339.9263040532865, 1340.477213886585, 1378.179982910167, 27693.307667307672, 27966.580501292905, 28884.0, 28887.133385998455, 28925.56611650785, 46292.53707463017, 46561.301580477, 46841.0, 46879.76560117314, 47004.0, 279753.0, 284951.0, 285403.0, 293217.0, 293314.0, 30687.693123068482, 30690.0, 30731.539026915063, 31177.53233701451, 31219.219519512193, 41087.178256434105, 42043.369349460394, 42061.789691052574, 42873.14253714846, 42959.78520107379, 36515.817420912725, 36584.08539786527, 36952.26095478129, 38332.42501362426, 39475.210495790496, 33971.49042764311, 38386.6161338383, 38737.225255494166, 39835.2032959345, 40108.59891401049, 33993.320133597685, 34192.14519637029, 38891.80554097211, 39772.0, 39882.40176397299, 29446.411071778017, 30573.54139687951, 30722.846385767927, 30790.846045770522, 31059.84470077635, 24070.277891663278, 24430.633540497263, 26581.60127598049, 26616.334591635365, 26742.0], "unit": "score", "name": "ext.html", "value": 17768.096230685638}, {"lowerIsBetter": false, "replicates": [367.3369567929887, 369.8261816946035, 370.7293675616798, 371.54300210740786, 372.8527231743463, 13477.39351729172, 13548.0, 15598.142102184376, 16345.673086538278, 17048.744268835977, 10844.295120817142, 11209.607663731771, 16031.438899638515, 16699.0, 16700.08149551777, 4913.066517361699, 5042.974785126069, 5062.367204099488, 5062.949370506303, 5063.139266324715, 3734.8692795752154, 3866.130120722843, 4996.200607902736, 5043.067032598981, 5286.995470860525, 5447.428020057877, 5447.564194864422, 5485.835424937239, 5497.340319161706, 5497.752601132958, 5502.697351645658, 6026.6986650667295, 6045.848853778647, 6049.274087109553, 6052.394760523935, 5192.688438693691, 5359.758810853521, 5365.061114304981, 5367.75845086972, 5369.48989845964, 17706.734398983896, 18250.269989200417, 18386.356477523223, 19743.308984185627, 19856.602867942704, 2095.1724068992817, 2105.884176370299, 2129.744430668314, 2144.538924131319, 2189.2884812435864, 9373.343865929388, 9598.472084035375, 10403.84394234087, 10570.312929659625, 12691.873081269161, 1739.4259894234872, 1825.2060353746162, 1843.2719075965053, 1977.7033444983367, 1991.661417559004, 48610.7569462154, 49533.257001145015, 49882.7505862472, 50155.746106347266, 50666.7466662668, 9661.855072173923, 9811.509424528746, 9861.40936928342, 10146.746331341628, 10294.485275736333, 13374.799378009338, 13433.932830335982, 13478.326083695973, 13483.730325393437, 13490.39293231807, 7294.8905766413545, 7351.632418379059, 7402.7409040683315, 7464.104307483137, 7564.432667549956, 7238.131424229021, 7298.598577078205, 7326.640648813947, 7356.080489938758, 7367.300106489874, 4476.910461790746, 4480.887977800516, 4497.055618320124, 4520.61574766142, 4521.321801729767, 1609.7102521546235, 1626.268179319311, 1757.261949981011, 1861.5718384771578, 1873.6721073812027, 460.55096281126305, 899.8875140607424, 902.5487256371814, 997.680742162501, 1007.6976906927893, 10027.247956403298, 10332.121769649513, 10388.272820902615, 10711.678649640524, 10725.731856703489, 450.3132722598064, 452.6265830689628, 462.9722216667011, 473.51701264710493, 481.230031948879, 5739.8565035874435, 5773.24947756789, 5948.167256584082, 5974.492168165754, 5979.372165922602, 259565.0, 422236.0, 425488.0, 431732.0, 582352.0, 55517.72241138769, 64221.35778642154, 66050.0, 67519.32480675228, 67905.0, 502.8265248489265, 518.9558887494529, 519.6336582709181, 519.6596229469628, 520.4431258553387, 9395.765105872408, 10285.43430111351, 10421.270511064153, 10516.0, 10651.30766500175, 32220.35559288848, 32440.513392299606, 32622.83688581542, 32649.020529384157, 33142.66857331396, 41524.0, 42175.7891210542, 42232.36651450169, 42301.78849105735, 43426.78286608673, 2992.7456166226116, 7157.355837974607, 7157.677904494206, 7355.77932662021, 7411.998760334787, 8537.615807288563, 9428.622855085994, 11027.558897644325, 11123.83314250303, 11272.549098035986, 8384.496930184208, 9606.183474404754, 9627.378858147988, 9649.131578158, 9973.202143828621, 6794.966025169842, 7587.962060189664, 7698.615069246627, 7789.1821358756515, 9705.805883882424, 6806.455483561403, 7285.7814265572115, 7382.580239518155, 7516.736914207976, 7629.38964882797, 9531.0, 10056.597736090767, 10118.08937195656, 10221.897781022095, 10321.535530901278, 6965.268646792014, 7075.0, 7378.379448204961, 7512.5492470451945, 10033.297669163381], "unit": "score", "name": "jquery.html", "value": 7262.711726779874}, {"lowerIsBetter": false, "replicates": [1337.5786627212422, 1460.4596299369234, 1462.0715845438147, 1612.322824413746, 1778.759867417899, 6930.826729331763, 7617.809554761134, 7711.807204819876, 7758.107817600978, 7776.727814526493, 7657.425693073028, 7804.687812487494, 7819.33535649469, 7823.491473054261, 7833.843323133534, 1947.8928658923753, 1988.880667159975, 1991.8207361337477, 2266.5920134375765, 2291.415688999311, 2043.1214577731569, 2291.736450308211, 2335.311083230443, 2338.959163172389, 2345.8240631952585, 2227.7549469558335, 2270.6707527408516, 2272.0, 2272.2047283450743, 2296.1619009061737, 2241.3612120545567, 2248.685184074231, 2250.189931624622, 2261.4459457432868, 2263.581237471073, 2254.3011666383472, 2289.9695137188332, 2293.9197128100604, 2294.1855641247284, 2303.1593468384085, 7867.724629637993, 7893.250141236574, 7928.524288542706, 7928.722494712657, 7933.048034235871, 4662.510436404163, 4734.4081989751285, 4746.169420351424, 4755.025219829927, 4768.403949506312, 3012.623422072241, 3088.4795670411, 3149.0395429394025, 3170.6670799565945, 3181.650018497963, 1072.6406653770996, 1085.7080074711148, 1799.4421729263838, 1863.6831738604335, 1874.5594785225462, 10745.194110441747, 10837.67486975392, 10842.132629389629, 10869.565217391295, 10881.0, 4100.712950093465, 4156.771377574202, 4206.179794940019, 4207.579242075829, 4250.213710463574, 8885.822283554293, 8898.4660920345, 8900.910990890137, 8904.59929303183, 8910.73267801954, 4762.52374762521, 4792.017636384533, 4797.18447863864, 4797.56821886032, 4800.399950006249, 4360.934585981213, 4383.693141480066, 4384.495782984934, 4389.3635422864145, 4393.846215382447, 3369.140869078369, 3440.6043305019743, 3488.947665785015, 3545.7340699447645, 3547.6274991126074, 1082.312731415541, 1092.0335503079673, 1093.2565855218368, 1093.9671809845559, 1107.9723006924892, 1227.8219658149696, 1241.3669028795198, 1259.6913756129807, 1260.0927332320714, 1268.3277862732766, 6949.131358580177, 6993.790186294419, 7014.351627367564, 7177.856442871113, 7215.747448839265, 1080.270817198388, 1080.5623722392443, 1081.2647399768234, 1084.360227465799, 1111.8610173728284, 5667.659940403589, 5747.137929310553, 5756.884862302731, 5758.712064396764, 5759.971200143972, 9412.576434060484, 9603.615855365708, 9866.062724041205, 9866.161376282953, 9876.35803672759, 9703.07820757027, 9784.706458806248, 9801.068898454636, 9817.312788104764, 9821.852672209923, 7414.295641914009, 7559.697612095564, 7571.507851989603, 7623.580703061385, 7624.351930086005, 7121.67952442131, 7154.0, 7160.641967901688, 7176.995220669006, 7178.784636460915, 8419.158084191531, 8507.617157227816, 8753.0, 8853.557322133996, 8867.866981995146, 8762.430442021248, 8912.242459391024, 9067.637294508146, 9071.138241867277, 9073.364864459425, 6703.195616526048, 6794.592324460548, 6811.318868113149, 6815.93184068153, 6827.761028363983, 6725.0, 6888.931110689029, 7187.389071928945, 7556.168821429748, 7622.237776222333, 7007.054047703495, 7042.401395881408, 7107.60908150036, 7116.0, 7180.964095179491, 6957.512974091967, 7018.438524918097, 7018.6490675465, 7141.607211603412, 7144.749933752294, 6880.0, 6923.099997000358, 6953.130858642669, 6992.475564332593, 6995.860082798417, 6438.098666186644, 6508.414242717989, 6587.242467116343, 6599.967000164968, 6602.66986650656, 6242.812715618538, 6293.96853015732, 6296.685165741603, 6300.21247344082, 6304.243490781136], "unit": "score", "name": "mootools.html", "value": 4540.168004987682}, {"lowerIsBetter": false, "replicates": [334.6235485079286, 348.98953031409053, 351.89794959461756, 353.9805310707911, 356.83585550646717, 5808.390119037493, 5953.136795164699, 5971.283445986477, 5984.311804142525, 6005.399460053993, 5740.770369185238, 5825.9417405825925, 5828.825135245939, 5837.182794408786, 5859.736311865966, 4526.162659907911, 4547.18150732868, 4563.383943167663, 4567.155076310876, 4624.953750462486, 4435.933460998088, 4443.977780111095, 4545.386372839657, 4548.7725613719185, 4659.207934651117, 4524.095180963804, 4556.430446194226, 4564.84023059193, 4582.945922437842, 4596.770161491929, 4546.97726511367, 4561.064981678781, 4562.3156526521125, 4566.1780879441685, 4580.55712450577, 3988.3818008208773, 4013.7591744495426, 4020.336644453662, 4022.6781857451333, 4023.8994025149605, 5476.507114359687, 5591.10542313228, 5659.490645841894, 5692.0, 5694.402087780806, 5309.707966061865, 5312.840614781563, 5315.946840531584, 5319.441458646825, 5322.121849894763, 5994.2806863176265, 6302.842428939267, 6307.9684601577155, 6309.085182648536, 6316.905246421307, 4221.387898754663, 4295.398644189816, 4382.320740285261, 4438.112377524508, 4438.467383913951, 6468.191476065492, 6523.739050438025, 6543.0, 6547.672616369163, 6561.704723287464, 4513.684042117086, 4516.774161291923, 4521.3896124023495, 4522.932156017662, 4528.026474307973, 4483.21543729846, 4546.40896683429, 4574.336721175411, 4583.9083218335445, 4586.059857729224, 5219.086659834514, 5226.869328266824, 5262.526372626482, 5263.736813159327, 5268.578513718893, 6251.0, 6252.718627661766, 6302.779402720975, 6311.810645680545, 6318.778842740482, 1602.3910913852894, 1622.5862405086627, 1622.6349071458828, 1623.0829581286534, 1628.731259342219, 1070.2454769387564, 1071.5553045486192, 1097.0620119797459, 1102.7132945434246, 1104.0394856474918, 5986.491148252448, 5989.580729348991, 5996.400359963969, 6010.759569617254, 6012.857557064144, 6471.870562588816, 6488.448481878999, 6489.610623362613, 6492.448141907897, 6502.447291980235, 5872.471477566954, 5966.164736936832, 5969.940300597025, 5972.940270597325, 5990.311114221833, 3479.095435186819, 3482.930341393158, 3515.0333658244185, 3516.3143187078276, 3516.49010893419, 6735.730570777212, 6746.527743058037, 6748.0, 6750.122484077038, 6753.898691519631, 6621.81480111562, 6623.105880706139, 6629.1382120325015, 6631.30371311015, 6638.634875081821, 6530.902036469457, 6712.53012289135, 6712.765053223211, 6722.0, 6722.327767223336, 6303.2436107665535, 6414.775482858077, 6426.646534440651, 6439.227292724903, 6442.226932768098, 6286.968565157328, 6381.3937675920715, 6383.234011918599, 6389.808305750835, 6437.549371543947, 6745.0, 6815.761448349284, 6816.693248803716, 6829.863402732017, 6830.965845170941, 4489.515502718218, 4535.773211339354, 4548.727076375428, 4560.065186636798, 4568.109218702321, 6542.443892269211, 6545.738170473128, 6557.245916719638, 6558.475321974135, 6566.671666416755, 6380.7447702091395, 6418.582792118497, 6443.387878151568, 6457.354264573505, 6480.513961453004, 6241.812745617639, 6308.684565771785, 6349.0476428536085, 6351.96824015877, 6352.587081839665, 6200.224971878515, 6216.906746398898, 6220.626762394271, 6223.564350495421, 6223.937760622517, 6406.1031455597185, 6409.551331406757, 6412.935870641234, 6418.935810641834, 6421.454176395058, 6101.511879049576, 6270.0908368287255, 6271.184745983175, 6271.6550589718, 6286.245650521967], "unit": "score", "name": "prototype.html", "value": 4771.720781807994}, {"lowerIsBetter": false, "replicates": [683.5249501596386, 693.4279219643795, 775.7440044785218, 781.4022272961184, 786.0881377601982, 13063.673408164801, 13208.207507549554, 13224.206547607138, 13242.073054886137, 13268.469261229538, 12297.938510307436, 12311.445984930677, 12323.507059717624, 12339.197952133105, 12355.258684478938, 662.4104546953215, 672.4452326830384, 800.0599295827409, 803.2088392932957, 807.1403954788161, 792.7780221537979, 793.2107552984788, 794.7496538590326, 801.3388954112851, 805.3034125481475, 698.5040621158984, 846.4159729786459, 848.2323497234981, 848.5248260973843, 849.1296421168321, 678.6030172349157, 696.3523922751839, 698.1935864077, 846.2848892685732, 867.2888231650049, 620.3393386043849, 622.4335854372545, 624.0265186309372, 624.2228425610099, 624.6845343101704, 12424.875751242553, 12507.562235321811, 12589.622311330675, 12627.621171364874, 12657.240565566095, 11759.0, 12147.392630368535, 12290.815637765441, 12553.121281510297, 12636.11547191697, 10036.14692751117, 10044.547995340226, 10055.748606284827, 10134.442605656686, 10234.385936843813, 3504.929901401983, 3526.400511912955, 3552.271784284241, 3578.320119177374, 3639.981800091009, 47845.76077119592, 48583.0, 48711.51288487105, 48815.023699526166, 48895.51104488945, 9200.493972831558, 9225.72322830316, 9250.676226332045, 9264.305177111744, 9590.568424420779, 15879.920600397156, 15906.443274485337, 15914.76127858083, 15930.203489825693, 15948.920255398649, 7011.123609548807, 7141.9642901785155, 7294.234105418961, 7369.0, 7535.962320188364, 4064.898377540526, 4100.835966561363, 4184.707070505096, 4202.054537728986, 4208.894777630584, 2900.2894290898867, 2912.228259511231, 2921.2258751430886, 2925.3710452252867, 2927.780416468773, 525.7423862307442, 546.778554685353, 556.9554435645139, 561.9157126431068, 564.7797359029981, 547.3103889099763, 563.248063834777, 573.2948473377685, 579.3742757821543, 594.197832925547, 7529.4729368943645, 7751.689932402754, 7885.44801863864, 7983.12185659577, 8010.5994700264755, 441.882901031227, 476.66871524290286, 545.3782687735984, 559.7537083683167, 564.601955621286, 3552.236269202134, 3553.484744712054, 3600.5319308490252, 3636.8727094551564, 3683.097641077953, 54505.72747136239, 55257.447425526036, 55584.44415555873, 56335.0, 56779.71610141923, 50996.0, 51172.74413627908, 52342.47657523452, 52628.47371526236, 52658.473415266126, 46293.0, 46352.0, 46759.29861052087, 46856.5314346859, 47040.2943955841, 7701.845963080819, 7790.493617914817, 7824.687260912162, 7826.7651970440975, 8063.516189028677, 33773.0, 33972.0, 34765.30469390548, 35224.647753522135, 37462.250754985296, 44776.77611611921, 44907.55092449034, 45847.541524584325, 46034.53965460436, 46123.0, 9772.0, 9860.605575776888, 9997.400155990665, 10127.594896204364, 10340.896591033994, 11231.0, 11402.600908968147, 11663.533458661559, 11698.70753231176, 11754.902836056344, 10308.175345972455, 10362.896371036193, 10387.740306492398, 10632.946835265775, 10789.352638841694, 10581.89418105809, 10652.733681658021, 10809.254294509235, 10813.243072984815, 11051.668449946514, 10611.151107911193, 10616.105233228067, 10804.135669146292, 11017.944910275397, 11232.66302010941, 8443.240108390275, 8553.401261911606, 8628.439151455135, 8735.956320218358, 9298.800873712962, 8702.738917832476, 8941.195292423714, 9079.319051071328, 9209.401388909699, 9414.764630884283], "unit": "score", "name": "yui.html", "value": 5971.430333287504}], "name": "dromaeo_css", "value": 6622.884448677453}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 105.0, 109.0, 111.0, 110.0, 99.0, 110.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [148.0, 125.0, 149.0, 158.0, 125.0, 160.0, 144.0, 128.0, 161.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 159.0, 160.0, 164.0, 159.0, 162.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 102.0, 93.0, 71.0, 72.0, 73.0, 99.0, 95.0, 75.0], "unit": "score", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 142.0, 96.0, 95.0, 96.0, 146.0, 96.0, 95.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 147.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 56.0, 56.0, 56.0, 55.0, 64.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 83.0, 82.0, 82.0, 83.0, 81.0, 83.0, 82.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [115.0, 114.0, 113.0, 124.0, 112.0, 122.0, 113.0, 124.0, 112.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.7}, {"lowerIsBetter": true, "replicates": [143.0, 130.0, 150.0, 134.0, 142.0, 144.0, 141.0, 153.0, 138.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 69.0, 64.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1486.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.00265604249668], "unit": "score", "name": "Richards", "value": 212.659248}, {"lowerIsBetter": false, "replicates": [189.000189000189], "unit": "score", "name": "DeltaBlue", "value": 349.8303379999999}, {"lowerIsBetter": false, "replicates": [280.662363177098], "unit": "score", "name": "Encrypt", "value": 948.4029029999999}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1919.3857965451057], "unit": "score", "name": "RayTrace", "value": 385.5342689999999}, {"lowerIsBetter": false, "replicates": [788.1889763779527], "unit": "score", "name": "Earley", "value": 845.5624475524476}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [42895.833333333336], "unit": "score", "name": "RegExp", "value": 21.237144244779014}, {"lowerIsBetter": false, "replicates": [573.9476678043231], "unit": "score", "name": "Splay", "value": 141.9833280475719}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19042.43976076919}]} 11:22:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19042.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1486.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6622.88"}}} 11:22:01 INFO - Return code: 0 11:22:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:22:01 INFO - # TBPL SUCCESS # 11:22:01 INFO - Running post-action listener: _resource_record_post_action 11:22:01 INFO - Running post-run listener: _resource_record_post_run 11:22:02 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 151552; Write bytes: 541085696; Read time: 36; Write time: 395380 11:22:02 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 238534656; Read time: 0; Write time: 231228 11:22:02 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 151552; Write bytes: 301674496; Read time: 36; Write time: 164104 11:22:02 INFO - Running post-run listener: _upload_blobber_files 11:22:02 INFO - Blob upload gear active. 11:22:02 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:22:02 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 11:22:02 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'] 11:22:02 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 11:22:02 INFO - (blobuploader) - INFO - Open directory for files ... 11:22:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:22:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:22:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:04 INFO - (blobuploader) - INFO - Done attempting. 11:22:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:22:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:22:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:04 INFO - (blobuploader) - INFO - Done attempting. 11:22:04 INFO - (blobuploader) - INFO - Iteration through files over. 11:22:04 INFO - Return code: 0 11:22:04 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:22:04 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:22:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d07e376925b7825547161cdc6cb7827cd11556e065db5293f64ad3300f563ac48a090c3cceb776f91618e2b9c3af9184ec9f5841233b069d6ff8df030118e293", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/212300fd7dfae358d8c7567a906e7a01394ccb33b9fe3667efd6a2089d125a3e08c742be2d5dcbc082b7b70be0eecccd22c1ee8f5b2c2a0a12f5f5d03c7c2fca"} 11:22:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:22:04 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:22:04 INFO - Contents: 11:22:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d07e376925b7825547161cdc6cb7827cd11556e065db5293f64ad3300f563ac48a090c3cceb776f91618e2b9c3af9184ec9f5841233b069d6ff8df030118e293", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/212300fd7dfae358d8c7567a906e7a01394ccb33b9fe3667efd6a2089d125a3e08c742be2d5dcbc082b7b70be0eecccd22c1ee8f5b2c2a0a12f5f5d03c7c2fca"} 11:22:04 INFO - Copying logs to upload dir... 11:22:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.514630 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-14 11:22:04.733665) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 11:22:04.737506) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635 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/d07e376925b7825547161cdc6cb7827cd11556e065db5293f64ad3300f563ac48a090c3cceb776f91618e2b9c3af9184ec9f5841233b069d6ff8df030118e293", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/212300fd7dfae358d8c7567a906e7a01394ccb33b9fe3667efd6a2089d125a3e08c742be2d5dcbc082b7b70be0eecccd22c1ee8f5b2c2a0a12f5f5d03c7c2fca"} build_url:https://queue.taskcluster.net/v1/task/GASgRh7vR8OiraIyCvT8tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/GASgRh7vR8OiraIyCvT8tg/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/d07e376925b7825547161cdc6cb7827cd11556e065db5293f64ad3300f563ac48a090c3cceb776f91618e2b9c3af9184ec9f5841233b069d6ff8df030118e293", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/212300fd7dfae358d8c7567a906e7a01394ccb33b9fe3667efd6a2089d125a3e08c742be2d5dcbc082b7b70be0eecccd22c1ee8f5b2c2a0a12f5f5d03c7c2fca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 11:22:04.761904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 11:22:04.762268) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452797445.276572-1681672635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 11:22:04.847017) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 11:22:04.847350) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 11:22:04.847628) ========= ========= Total master_lag: 0.24 =========