builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1452264589.1 results: success (0) buildid: 20160108043006 builduid: df896889f67f4889800f7f9fa90f7a5f revision: 1424cdfc075d1b7e277be914488ac73e20d1c982 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.100272) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.100749) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.101035) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005055 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.122467) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.122787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.389348) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.389785) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.440005) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.440349) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.440757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.441059) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 06:49:49-- 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% 218M=0s 2016-01-08 06:49:49 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178123 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.631535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.631860) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019692 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.682216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:49.682565) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1424cdfc075d1b7e277be914488ac73e20d1c982 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1424cdfc075d1b7e277be914488ac73e20d1c982 --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=edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 06:49:49,928 truncating revision to first 12 chars 2016-01-08 06:49:49,928 Setting DEBUG logging. 2016-01-08 06:49:49,929 attempt 1/10 2016-01-08 06:49:49,929 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1424cdfc075d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 06:49:50,177 unpacking tar archive at: mozilla-central-1424cdfc075d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545010 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:50.241166) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:50.241539) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:50.249683) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:50.250083) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 06:49:50.250581) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-08 06:49:50.250884) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:49:50 INFO - MultiFileLogger online at 20160108 06:49:50 in /builds/slave/test-pgo 06:49:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:49:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:49:50 INFO - {'append_to_log': False, 06:49:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:49:50 INFO - 'blob_upload_branch': 'Firefox', 06:49:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:49:50 INFO - 'branch': 'Firefox', 06:49:50 INFO - 'buildbot_json_path': 'buildprops.json', 06:49:50 INFO - 'config_files': ('talos/linux_config.py',), 06:49:50 INFO - 'default_actions': ('clobber', 06:49:50 INFO - 'read-buildbot-config', 06:49:50 INFO - 'download-and-extract', 06:49:50 INFO - 'populate-webroot', 06:49:50 INFO - 'create-virtualenv', 06:49:50 INFO - 'install', 06:49:50 INFO - 'run-tests'), 06:49:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:49:50 INFO - 'download_minidump_stackwalk': True, 06:49:50 INFO - 'download_symbols': 'ondemand', 06:49:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:49:50 INFO - 'tooltool.py': '/tools/tooltool.py', 06:49:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:49:50 INFO - '/tools/misc-python/virtualenv.py')}, 06:49:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:49:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:49:50 INFO - 'installer_path': 'installer.exe', 06:49:50 INFO - 'log_level': 'info', 06:49:50 INFO - 'log_name': 'talos', 06:49:50 INFO - 'log_to_console': True, 06:49:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:49:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:49:50 INFO - 'opt_config_files': (), 06:49:50 INFO - 'pip_index': False, 06:49:50 INFO - 'sps_profile': False, 06:49:50 INFO - 'sps_profile_interval': 0, 06:49:50 INFO - 'suite': 'dromaeojs', 06:49:50 INFO - 'system_bits': '32', 06:49:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:49:50 INFO - 'title': 'talos-linux64-ix-033', 06:49:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:49:50 INFO - 'use_talos_json': True, 06:49:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:49:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:49:50 INFO - 'work_dir': 'build'} 06:49:50 INFO - ##### 06:49:50 INFO - ##### Running clobber step. 06:49:50 INFO - ##### 06:49:50 INFO - Running pre-action listener: _resource_record_pre_action 06:49:50 INFO - Running main action method: clobber 06:49:50 INFO - rmtree: /builds/slave/test-pgo/build 06:49:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:49:51 INFO - Running post-action listener: _resource_record_post_action 06:49:51 INFO - ##### 06:49:51 INFO - ##### Running read-buildbot-config step. 06:49:51 INFO - ##### 06:49:51 INFO - Running pre-action listener: _resource_record_pre_action 06:49:51 INFO - Running main action method: read_buildbot_config 06:49:51 INFO - Using buildbot properties: 06:49:51 INFO - { 06:49:51 INFO - "project": "", 06:49:51 INFO - "product": "firefox", 06:49:51 INFO - "script_repo_revision": "production", 06:49:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:49:51 INFO - "repository": "", 06:49:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:49:51 INFO - "buildid": "20160108043006", 06:49:51 INFO - "pgo_build": "True", 06:49:51 INFO - "basedir": "/builds/slave/test-pgo", 06:49:51 INFO - "buildnumber": 634, 06:49:51 INFO - "slavename": "talos-linux64-ix-033", 06:49:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:49:51 INFO - "platform": "ubuntu64_hw", 06:49:51 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:49:51 INFO - "branch": "mozilla-central", 06:49:51 INFO - "repo_path": "mozilla-central", 06:49:51 INFO - "revision": "1424cdfc075d1b7e277be914488ac73e20d1c982", 06:49:51 INFO - "stage_platform": "linux64-pgo", 06:49:51 INFO - "builduid": "df896889f67f4889800f7f9fa90f7a5f", 06:49:51 INFO - "slavebuilddir": "test" 06:49:51 INFO - } 06:49:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:49:51 INFO - Running post-action listener: _resource_record_post_action 06:49:51 INFO - ##### 06:49:51 INFO - ##### Running download-and-extract step. 06:49:51 INFO - ##### 06:49:51 INFO - Running pre-action listener: _resource_record_pre_action 06:49:51 INFO - Running main action method: download_and_extract 06:49:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:51 INFO - https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:49:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/test_packages.json 06:49:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/test_packages.json 06:49:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:49:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:49:52 INFO - Downloaded 1302 bytes. 06:49:52 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:49:52 INFO - Using the following test package requirements: 06:49:52 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:52 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:49:52 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:52 INFO - u'jsshell-linux-x86_64.zip'], 06:49:52 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:49:52 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:52 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:49:52 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:49:52 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:49:52 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:52 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:49:52 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:49: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')]} 06:49:52 INFO - https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:49:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:49:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:49:53 INFO - Downloaded 24028185 bytes. 06:49:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:49:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:49:55 INFO - Return code: 0 06:49:55 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 06:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:55 INFO - https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:49:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:49:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:49:56 INFO - Downloaded 24028185 bytes. 06:49:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:49:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:49:57 INFO - Return code: 0 06:49: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')]} 06:49:57 INFO - https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:49:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:49:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:49:58 INFO - Downloaded 11132285 bytes. 06:49:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 06:49:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:49:58 INFO - Return code: 0 06:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:58 INFO - https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:49:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:49:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:49:59 INFO - Downloaded 55916804 bytes. 06:49:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:59 INFO - mkdir: /builds/slave/test-pgo/properties 06:49:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:49:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:49:59 INFO - Contents: 06:49:59 INFO - build_url:https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:59 INFO - Running post-action listener: _resource_record_post_action 06:49:59 INFO - Running post-action listener: set_extra_try_arguments 06:49:59 INFO - ##### 06:49:59 INFO - ##### Running populate-webroot step. 06:49:59 INFO - ##### 06:49:59 INFO - Running pre-action listener: _resource_record_pre_action 06:49:59 INFO - Running main action method: populate_webroot 06:49:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:49:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:49:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:49:59 INFO - '--tppagecycles', 06:49:59 INFO - '7'], 06:49:59 INFO - 'tests': ['tsvgm']}}, 06:49:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:49:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:49:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:49:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:49:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:49:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:49:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:59 INFO - 'talos_options': ['--e10s'], 06:49:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:59 INFO - 'tests': ['damp', 'tps']}, 06:49:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:59 INFO - 'talos_options': ['--e10s'], 06:49:59 INFO - 'tests': ['damp', 'tps']}, 06:49:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:49:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:49:59 INFO - 'other': {'tests': ['a11yr', 06:49:59 INFO - 'ts_paint', 06:49:59 INFO - 'tpaint', 06:49:59 INFO - 'sessionrestore', 06:49:59 INFO - 'sessionrestore_no_auto_restore']}, 06:49:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:49:59 INFO - 'tests': ['a11yr', 06:49:59 INFO - 'ts_paint', 06:49:59 INFO - 'tpaint', 06:49:59 INFO - 'sessionrestore', 06:49:59 INFO - 'sessionrestore_no_auto_restore']}, 06:49:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:49:59 INFO - 'tests': ['a11yr', 06:49:59 INFO - 'ts_paint', 06:49:59 INFO - 'tpaint', 06:49:59 INFO - 'sessionrestore', 06:49:59 INFO - 'sessionrestore_no_auto_restore']}, 06:49:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:49:59 INFO - 'tests': ['a11yr', 06:49:59 INFO - 'ts_paint', 06:49:59 INFO - 'tpaint', 06:49:59 INFO - 'sessionrestore', 06:49:59 INFO - 'sessionrestore_no_auto_restore']}, 06:49:59 INFO - 'other_l64': {'tests': ['a11yr', 06:49:59 INFO - 'ts_paint', 06:49:59 INFO - 'tpaint', 06:49:59 INFO - 'sessionrestore', 06:49:59 INFO - 'sessionrestore_no_auto_restore']}, 06:49:59 INFO - 'other_nol64': {'tests': ['a11yr', 06:49:59 INFO - 'ts_paint', 06:49:59 INFO - 'tpaint', 06:49:59 INFO - 'sessionrestore', 06:49:59 INFO - 'sessionrestore_no_auto_restore']}, 06:49:59 INFO - 'svgr': {'tests': ['tsvgx', 06:49:59 INFO - 'tsvgr_opacity', 06:49:59 INFO - 'tart', 06:49:59 INFO - 'tscrollx', 06:49:59 INFO - 'cart']}, 06:49:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:49:59 INFO - 'tests': ['tsvgx', 06:49:59 INFO - 'tsvgr_opacity', 06:49:59 INFO - 'tart', 06:49:59 INFO - 'tscrollx', 06:49:59 INFO - 'cart']}, 06:49:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:59 INFO - 'tests': ['tp5o']}, 06:49:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:59 INFO - 'talos_options': ['--e10s'], 06:49:59 INFO - 'tests': ['tp5o']}, 06:49:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:59 INFO - 'talos_options': ['--xperf_path', 06:49:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:59 INFO - 'tests': ['tp5n']}, 06:49:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:59 INFO - 'talos_options': ['--e10s', 06:49:59 INFO - '--xperf_path', 06:49:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:59 INFO - 'tests': ['tp5n']}}, 06:49:59 INFO - 'talos.zip': {'path': '', 06:49:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:49:59 INFO - Running post-action listener: _resource_record_post_action 06:49:59 INFO - ##### 06:49:59 INFO - ##### Running create-virtualenv step. 06:49:59 INFO - ##### 06:49:59 INFO - Running pre-action listener: _resource_record_pre_action 06:49:59 INFO - Running main action method: create_virtualenv 06:49:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:49:59 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 06:49:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:50:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:50:00 INFO - Using real prefix '/usr' 06:50:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:50:00 INFO - Installing distribute.............................................................................................................................................................................................done. 06:50:02 INFO - Installing pip.................done. 06:50:02 INFO - Return code: 0 06:50:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:02 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 0x7fd5a6709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004840>, '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 0xf716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf71b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', '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 06:50:02 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 06:50:02 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 06:50:02 INFO - Using env: {'DISPLAY': ':0', 06:50:02 INFO - 'HOME': '/home/cltbld', 06:50:02 INFO - 'LANG': 'en_US.UTF-8', 06:50:02 INFO - 'LANGUAGE': 'en_US:en', 06:50:02 INFO - 'LOGNAME': 'cltbld', 06:50:02 INFO - 'MAIL': '/var/mail/cltbld', 06:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:02 INFO - 'MOZ_NO_REMOTE': '1', 06:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:02 INFO - 'NO_EM_RESTART': '1', 06:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:02 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:02 INFO - 'SHELL': '/bin/bash', 06:50:02 INFO - 'SHLVL': '1', 06:50:02 INFO - 'TERM': 'linux', 06:50:02 INFO - 'TMOUT': '86400', 06:50:02 INFO - 'USER': 'cltbld', 06:50:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', 06:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:02 INFO - '_': '/tools/buildbot/bin/python'} 06:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:02 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 06:50:02 INFO - Cleaning up... 06:50:02 INFO - Return code: 0 06:50:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:02 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 0x7fd5a6709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004840>, '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 0xf716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf71b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', '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 06:50:02 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 06:50:02 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 06:50:02 INFO - Using env: {'DISPLAY': ':0', 06:50:02 INFO - 'HOME': '/home/cltbld', 06:50:02 INFO - 'LANG': 'en_US.UTF-8', 06:50:02 INFO - 'LANGUAGE': 'en_US:en', 06:50:02 INFO - 'LOGNAME': 'cltbld', 06:50:02 INFO - 'MAIL': '/var/mail/cltbld', 06:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:02 INFO - 'MOZ_NO_REMOTE': '1', 06:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:02 INFO - 'NO_EM_RESTART': '1', 06:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:02 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:02 INFO - 'SHELL': '/bin/bash', 06:50:02 INFO - 'SHLVL': '1', 06:50:02 INFO - 'TERM': 'linux', 06:50:02 INFO - 'TMOUT': '86400', 06:50:02 INFO - 'USER': 'cltbld', 06:50:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', 06:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:02 INFO - '_': '/tools/buildbot/bin/python'} 06:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:02 INFO - Downloading/unpacking psutil>=0.7.1 06:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:50:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:50:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:50:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:05 INFO - Installing collected packages: psutil 06:50:05 INFO - Running setup.py install for psutil 06:50:05 INFO - building 'psutil._psutil_linux' extension 06:50:05 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 06:50:05 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 06:50:05 INFO - building 'psutil._psutil_posix' extension 06:50:05 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 06:50:06 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 06:50:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:06 INFO - Successfully installed psutil 06:50:06 INFO - Cleaning up... 06:50:06 INFO - Return code: 0 06:50:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:50:06 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')]} 06:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:06 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')]} 06:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:06 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 0x7fd5a6709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004840>, '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 0xf716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf71b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', '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 06:50:06 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 06:50:06 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 06:50:06 INFO - Using env: {'DISPLAY': ':0', 06:50:06 INFO - 'HOME': '/home/cltbld', 06:50:06 INFO - 'LANG': 'en_US.UTF-8', 06:50:06 INFO - 'LANGUAGE': 'en_US:en', 06:50:06 INFO - 'LOGNAME': 'cltbld', 06:50:06 INFO - 'MAIL': '/var/mail/cltbld', 06:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:06 INFO - 'MOZ_NO_REMOTE': '1', 06:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:06 INFO - 'NO_EM_RESTART': '1', 06:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:06 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:06 INFO - 'SHELL': '/bin/bash', 06:50:06 INFO - 'SHLVL': '1', 06:50:06 INFO - 'TERM': 'linux', 06:50:06 INFO - 'TMOUT': '86400', 06:50:06 INFO - 'USER': 'cltbld', 06:50:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', 06:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:06 INFO - '_': '/tools/buildbot/bin/python'} 06:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:50:06 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 06:50:06 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 06:50:06 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 06:50:06 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 06:50:06 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 06:50:06 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 06:50:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:50:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:50:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:50:08 INFO - Installing collected packages: mozsystemmonitor 06:50:08 INFO - Running setup.py install for mozsystemmonitor 06:50:08 INFO - Successfully installed mozsystemmonitor 06:50:08 INFO - Cleaning up... 06:50:08 INFO - Return code: 0 06:50:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd5a6709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004840>, '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 0xf716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf71b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', '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 06:50:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:50:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:50:08 INFO - Using env: {'DISPLAY': ':0', 06:50:08 INFO - 'HOME': '/home/cltbld', 06:50:08 INFO - 'LANG': 'en_US.UTF-8', 06:50:08 INFO - 'LANGUAGE': 'en_US:en', 06:50:08 INFO - 'LOGNAME': 'cltbld', 06:50:08 INFO - 'MAIL': '/var/mail/cltbld', 06:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:08 INFO - 'MOZ_NO_REMOTE': '1', 06:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:08 INFO - 'NO_EM_RESTART': '1', 06:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:08 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:08 INFO - 'SHELL': '/bin/bash', 06:50:08 INFO - 'SHLVL': '1', 06:50:08 INFO - 'TERM': 'linux', 06:50:08 INFO - 'TMOUT': '86400', 06:50:08 INFO - 'USER': 'cltbld', 06:50:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', 06:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:08 INFO - '_': '/tools/buildbot/bin/python'} 06:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:08 INFO - Downloading/unpacking blobuploader==1.2.4 06:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:10 INFO - Downloading blobuploader-1.2.4.tar.gz 06:50:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:50:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:50:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:50:10 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 06:50:10 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 06:50:10 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 06:50:10 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 06:50:10 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 06:50:10 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 06:50:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:50:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:50:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50:10 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 06:50:10 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 06:50:10 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 06:50:10 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 06:50:10 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 06:50:10 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 06:50:10 INFO - Downloading docopt-0.6.1.tar.gz 06:50:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:50:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:11 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:11 INFO - Running setup.py install for blobuploader 06:50:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:50:11 INFO - Running setup.py install for requests 06:50:11 INFO - Running setup.py install for docopt 06:50:11 INFO - Successfully installed blobuploader requests docopt 06:50:11 INFO - Cleaning up... 06:50:11 INFO - Return code: 0 06:50:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:11 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 0x7fd5a6709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004840>, '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 0xf716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf71b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', '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 06:50:11 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 06:50:11 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 06:50:11 INFO - Using env: {'DISPLAY': ':0', 06:50:11 INFO - 'HOME': '/home/cltbld', 06:50:11 INFO - 'LANG': 'en_US.UTF-8', 06:50:11 INFO - 'LANGUAGE': 'en_US:en', 06:50:11 INFO - 'LOGNAME': 'cltbld', 06:50:11 INFO - 'MAIL': '/var/mail/cltbld', 06:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:11 INFO - 'MOZ_NO_REMOTE': '1', 06:50:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:11 INFO - 'NO_EM_RESTART': '1', 06:50:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:11 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:11 INFO - 'SHELL': '/bin/bash', 06:50:11 INFO - 'SHLVL': '1', 06:50:11 INFO - 'TERM': 'linux', 06:50:11 INFO - 'TMOUT': '86400', 06:50:11 INFO - 'USER': 'cltbld', 06:50:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', 06:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:11 INFO - '_': '/tools/buildbot/bin/python'} 06:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:11 INFO - Running setup.py (path:/tmp/pip-BFwhXF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:11 INFO - Running setup.py (path:/tmp/pip-g2df2M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:11 INFO - Running setup.py (path:/tmp/pip-URc2QH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:12 INFO - Running setup.py (path:/tmp/pip-WHY6w1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:12 INFO - Running setup.py (path:/tmp/pip-VhdVto-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:12 INFO - Running setup.py (path:/tmp/pip-2c9pPy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:12 INFO - Running setup.py (path:/tmp/pip-6Y15sV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:12 INFO - Running setup.py (path:/tmp/pip-STW2kb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:12 INFO - Running setup.py (path:/tmp/pip-np8Nm6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:12 INFO - Running setup.py (path:/tmp/pip-8hmNYS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:12 INFO - Running setup.py (path:/tmp/pip-1PHH25-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:12 INFO - Running setup.py (path:/tmp/pip-HRRIE1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:12 INFO - Running setup.py (path:/tmp/pip-qvdV3B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:12 INFO - Running setup.py (path:/tmp/pip-SNfcpy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:12 INFO - Running setup.py (path:/tmp/pip-qy2mab-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:12 INFO - Running setup.py (path:/tmp/pip-vks2Io-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:12 INFO - Running setup.py (path:/tmp/pip-3Vtb7d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:13 INFO - Running setup.py install for manifestparser 06:50:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:50:13 INFO - Running setup.py install for mozcrash 06:50:13 INFO - Running setup.py install for mozdebug 06:50:13 INFO - Running setup.py install for mozdevice 06:50:13 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:50:13 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:50:13 INFO - Running setup.py install for mozfile 06:50:13 INFO - Running setup.py install for mozhttpd 06:50:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:50:13 INFO - Running setup.py install for mozinfo 06:50:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:50:13 INFO - Running setup.py install for mozInstall 06:50:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:50:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:50:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:50:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:50:13 INFO - Running setup.py install for mozleak 06:50:13 INFO - Running setup.py install for mozlog 06:50:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:50:14 INFO - Running setup.py install for moznetwork 06:50:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:50:14 INFO - Running setup.py install for mozprocess 06:50:14 INFO - Running setup.py install for mozprofile 06:50:14 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:50:14 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:50:14 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:50:14 INFO - Running setup.py install for mozrunner 06:50:14 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:50:14 INFO - Running setup.py install for mozscreenshot 06:50:14 INFO - Running setup.py install for moztest 06:50:14 INFO - Running setup.py install for mozversion 06:50:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:50:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:50:14 INFO - Cleaning up... 06:50:14 INFO - Return code: 0 06:50:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50:14 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')]} 06:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:14 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')]} 06:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:14 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 0x7fd5a6709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004840>, '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 0xf716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf71b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', '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 06:50:14 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 06:50:14 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 06:50:14 INFO - Using env: {'DISPLAY': ':0', 06:50:14 INFO - 'HOME': '/home/cltbld', 06:50:14 INFO - 'LANG': 'en_US.UTF-8', 06:50:14 INFO - 'LANGUAGE': 'en_US:en', 06:50:14 INFO - 'LOGNAME': 'cltbld', 06:50:14 INFO - 'MAIL': '/var/mail/cltbld', 06:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:14 INFO - 'MOZ_NO_REMOTE': '1', 06:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:14 INFO - 'NO_EM_RESTART': '1', 06:50:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:14 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:14 INFO - 'SHELL': '/bin/bash', 06:50:14 INFO - 'SHLVL': '1', 06:50:14 INFO - 'TERM': 'linux', 06:50:14 INFO - 'TMOUT': '86400', 06:50:14 INFO - 'USER': 'cltbld', 06:50:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', 06:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:14 INFO - '_': '/tools/buildbot/bin/python'} 06:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:15 INFO - Running setup.py (path:/tmp/pip-sER2i3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:15 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)) 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:15 INFO - Running setup.py (path:/tmp/pip-0bSbpf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:15 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)) 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:15 INFO - Running setup.py (path:/tmp/pip-rMbyJw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:15 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)) 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:15 INFO - Running setup.py (path:/tmp/pip-JwbrTC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:15 INFO - Running setup.py (path:/tmp/pip-q3fPjR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:15 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)) 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:15 INFO - Running setup.py (path:/tmp/pip-VzHXqu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:15 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)) 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:15 INFO - Running setup.py (path:/tmp/pip-HDNP6O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:15 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)) 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:15 INFO - Running setup.py (path:/tmp/pip-8s9TRs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:15 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)) 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:15 INFO - Running setup.py (path:/tmp/pip-LFZJk5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:15 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)) 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:15 INFO - Running setup.py (path:/tmp/pip-7HcA4a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:15 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)) 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:15 INFO - Running setup.py (path:/tmp/pip-sf49yC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:15 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)) 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:15 INFO - Running setup.py (path:/tmp/pip-6mW8N4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:15 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)) 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:15 INFO - Running setup.py (path:/tmp/pip-hAiyVv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:15 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)) 06:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:15 INFO - Running setup.py (path:/tmp/pip-qmLEBn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:16 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)) 06:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:16 INFO - Running setup.py (path:/tmp/pip-t0Ds1K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:16 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)) 06:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:16 INFO - Running setup.py (path:/tmp/pip-nVEBoA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:16 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)) 06:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:16 INFO - Running setup.py (path:/tmp/pip-_OhZvM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:16 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)) 06:50:16 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)) 06:50:16 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)) 06:50:16 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)) 06:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:50:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:17 INFO - Downloading blessings-1.5.1.tar.gz 06:50:17 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 06:50:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:50:18 INFO - Installing collected packages: blessings 06:50:18 INFO - Running setup.py install for blessings 06:50:18 INFO - Successfully installed blessings 06:50:18 INFO - Cleaning up... 06:50:18 INFO - Return code: 0 06:50:18 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:50:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:50:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:50:18 INFO - Reading from file tmpfile_stdout 06:50:18 INFO - Current package versions: 06:50:18 INFO - argparse == 1.2.1 06:50:18 INFO - blessings == 1.5.1 06:50:18 INFO - blobuploader == 1.2.4 06:50:18 INFO - docopt == 0.6.1 06:50:18 INFO - manifestparser == 1.1 06:50:18 INFO - mozInstall == 1.12 06:50:18 INFO - mozcrash == 0.16 06:50:18 INFO - mozdebug == 0.1 06:50:18 INFO - mozdevice == 0.47 06:50:18 INFO - mozfile == 1.2 06:50:18 INFO - mozhttpd == 0.7 06:50:18 INFO - mozinfo == 0.9 06:50:18 INFO - mozleak == 0.1 06:50:18 INFO - mozlog == 3.1 06:50:18 INFO - moznetwork == 0.27 06:50:18 INFO - mozprocess == 0.22 06:50:18 INFO - mozprofile == 0.28 06:50:18 INFO - mozrunner == 6.11 06:50:18 INFO - mozscreenshot == 0.1 06:50:18 INFO - mozsystemmonitor == 0.0 06:50:18 INFO - moztest == 0.7 06:50:18 INFO - mozversion == 1.4 06:50:18 INFO - psutil == 3.1.1 06:50:18 INFO - requests == 1.2.3 06:50:18 INFO - wsgiref == 0.1.2 06:50:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:18 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 0x7fd5a6709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004840>, '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 0xf716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf71b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', '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 06:50:18 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 06:50:18 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 06:50:18 INFO - Using env: {'DISPLAY': ':0', 06:50:18 INFO - 'HOME': '/home/cltbld', 06:50:18 INFO - 'LANG': 'en_US.UTF-8', 06:50:18 INFO - 'LANGUAGE': 'en_US:en', 06:50:18 INFO - 'LOGNAME': 'cltbld', 06:50:18 INFO - 'MAIL': '/var/mail/cltbld', 06:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:18 INFO - 'MOZ_NO_REMOTE': '1', 06:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:18 INFO - 'NO_EM_RESTART': '1', 06:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:18 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:18 INFO - 'SHELL': '/bin/bash', 06:50:18 INFO - 'SHLVL': '1', 06:50:18 INFO - 'TERM': 'linux', 06:50:18 INFO - 'TMOUT': '86400', 06:50:18 INFO - 'USER': 'cltbld', 06:50:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', 06:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:18 INFO - '_': '/tools/buildbot/bin/python'} 06:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:18 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)) 06:50:18 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)) 06:50:18 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)) 06:50:18 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)) 06:50:18 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)) 06:50:18 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)) 06:50:18 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)) 06:50:18 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)) 06:50:18 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)) 06:50:18 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)) 06:50:18 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)) 06:50:18 INFO - Cleaning up... 06:50:18 INFO - Return code: 0 06:50:18 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:18 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 0x7fd5a6709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004840>, '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 0xf716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf71b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', '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 06:50:18 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 06:50:18 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 06:50:18 INFO - Using env: {'DISPLAY': ':0', 06:50:18 INFO - 'HOME': '/home/cltbld', 06:50:18 INFO - 'LANG': 'en_US.UTF-8', 06:50:18 INFO - 'LANGUAGE': 'en_US:en', 06:50:18 INFO - 'LOGNAME': 'cltbld', 06:50:18 INFO - 'MAIL': '/var/mail/cltbld', 06:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:18 INFO - 'MOZ_NO_REMOTE': '1', 06:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:18 INFO - 'NO_EM_RESTART': '1', 06:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:18 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:18 INFO - 'SHELL': '/bin/bash', 06:50:18 INFO - 'SHLVL': '1', 06:50:18 INFO - 'TERM': 'linux', 06:50:18 INFO - 'TMOUT': '86400', 06:50:18 INFO - 'USER': 'cltbld', 06:50:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', 06:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:18 INFO - '_': '/tools/buildbot/bin/python'} 06:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:18 INFO - Downloading/unpacking jsonschema 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:50:20 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 06:50:20 INFO - Downloading/unpacking functools32 (from jsonschema) 06:50:20 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 06:50:20 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 06:50:20 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 06:50:20 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 06:50:20 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 06:50:20 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 06:50:20 INFO - Downloading functools32-3.2.3-2.tar.gz 06:50:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:50:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:50:20 INFO - warning: no files found matching '*.txt' 06:50:20 INFO - no previously-included directories found matching 'build' 06:50:20 INFO - no previously-included directories found matching 'dist' 06:50:20 INFO - no previously-included directories found matching '.git*' 06:50:20 INFO - Installing collected packages: jsonschema, functools32 06:50:20 INFO - Running setup.py install for functools32 06:50:20 INFO - warning: no files found matching '*.txt' 06:50:20 INFO - no previously-included directories found matching 'build' 06:50:20 INFO - no previously-included directories found matching 'dist' 06:50:20 INFO - no previously-included directories found matching '.git*' 06:50:20 INFO - Successfully installed jsonschema functools32 06:50:20 INFO - Cleaning up... 06:50:21 INFO - Return code: 0 06:50:21 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:50:21 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')]} 06:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:21 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')]} 06:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:21 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 0x7fd5a6709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004840>, '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 0xf716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf71b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', '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 06:50:21 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 06:50:21 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 06:50:21 INFO - Using env: {'DISPLAY': ':0', 06:50:21 INFO - 'HOME': '/home/cltbld', 06:50:21 INFO - 'LANG': 'en_US.UTF-8', 06:50:21 INFO - 'LANGUAGE': 'en_US:en', 06:50:21 INFO - 'LOGNAME': 'cltbld', 06:50:21 INFO - 'MAIL': '/var/mail/cltbld', 06:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:21 INFO - 'MOZ_NO_REMOTE': '1', 06:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:21 INFO - 'NO_EM_RESTART': '1', 06:50:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:21 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:21 INFO - 'SHELL': '/bin/bash', 06:50:21 INFO - 'SHLVL': '1', 06:50:21 INFO - 'TERM': 'linux', 06:50:21 INFO - 'TMOUT': '86400', 06:50:21 INFO - 'USER': 'cltbld', 06:50:21 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', 06:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:21 INFO - '_': '/tools/buildbot/bin/python'} 06:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:21 INFO - Downloading/unpacking flake8 06:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:50:22 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 06:50:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:50:22 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 06:50:22 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 06:50:22 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 06:50:22 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 06:50:22 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 06:50:22 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 06:50:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:50:23 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 06:50:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:23 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 06:50:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:50:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:50:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:23 INFO - no previously-included directories found matching 'docs/_build' 06:50:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:50:23 INFO - Running setup.py install for pep8 06:50:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:23 INFO - no previously-included directories found matching 'docs/_build' 06:50:23 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:50:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:50:23 INFO - Cleaning up... 06:50:23 INFO - Return code: 0 06:50:23 INFO - Running post-action listener: _resource_record_post_action 06:50:23 INFO - Running post-action listener: _start_resource_monitoring 06:50:23 INFO - Starting resource monitoring. 06:50:23 INFO - ##### 06:50:23 INFO - ##### Running install step. 06:50:23 INFO - ##### 06:50:23 INFO - Running pre-action listener: _resource_record_pre_action 06:50:23 INFO - Running main action method: install 06:50:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:50:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:50:24 INFO - Reading from file tmpfile_stdout 06:50:24 INFO - Detecting whether we're running mozinstall >=1.0... 06:50:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:50:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:50:24 INFO - Reading from file tmpfile_stdout 06:50:24 INFO - Output received: 06:50:24 INFO - Usage: mozinstall [options] installer 06:50:24 INFO - Options: 06:50:24 INFO - -h, --help show this help message and exit 06:50:24 INFO - -d DEST, --destination=DEST 06:50:24 INFO - Directory to install application into. [default: 06:50:24 INFO - "/builds/slave/test-pgo"] 06:50:24 INFO - --app=APP Application being installed. [default: firefox] 06:50:24 INFO - mkdir: /builds/slave/test-pgo/build/application 06:50:24 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'] 06:50:24 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 06:50:40 INFO - Reading from file tmpfile_stdout 06:50:40 INFO - Output received: 06:50:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:50:40 INFO - Running post-action listener: _resource_record_post_action 06:50:40 INFO - ##### 06:50:40 INFO - ##### Running run-tests step. 06:50:40 INFO - ##### 06:50:40 INFO - Running pre-action listener: _resource_record_pre_action 06:50:40 INFO - Running main action method: run_tests 06:50:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:50:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:50:40 INFO - Python 2.7.3 06:50:40 INFO - Return code: 0 06:50:40 INFO - grabbing minidump binary from tooltool 06:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:40 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 0x1004840>, '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 0xf716b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf71b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:50:40 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 06:50:40 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 06:50:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:40 INFO - Return code: 0 06:50:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:50:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:50:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:50:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:50:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:50:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:50:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:50:41 INFO - Return code: 0 06:50:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 06:50:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 06:50:41 INFO - Using env: {'DISPLAY': ':0', 06:50:41 INFO - 'HOME': '/home/cltbld', 06:50:41 INFO - 'LANG': 'en_US.UTF-8', 06:50:41 INFO - 'LANGUAGE': 'en_US:en', 06:50:41 INFO - 'LOGNAME': 'cltbld', 06:50:41 INFO - 'MAIL': '/var/mail/cltbld', 06:50:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:50:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:41 INFO - 'MOZ_NO_REMOTE': '1', 06:50:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:50:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:41 INFO - 'NO_EM_RESTART': '1', 06:50:41 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:41 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:41 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:50:41 INFO - 'SHELL': '/bin/bash', 06:50:41 INFO - 'SHLVL': '1', 06:50:41 INFO - 'TERM': 'linux', 06:50:41 INFO - 'TMOUT': '86400', 06:50:41 INFO - 'USER': 'cltbld', 06:50:41 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612', 06:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:41 INFO - '_': '/tools/buildbot/bin/python'} 06:50:41 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 06:50:41 INFO - mozversion application_buildid: 20160108043006 06:50:41 INFO - mozversion application_changeset: 1424cdfc075d1b7e277be914488ac73e20d1c982 06:50:41 INFO - mozversion application_display_name: Nightly 06:50:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:41 INFO - mozversion application_name: Firefox 06:50:41 INFO - mozversion application_remotingname: firefox 06:50:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:50:41 INFO - mozversion application_vendor: Mozilla 06:50:41 INFO - mozversion application_version: 46.0a1 06:50:41 INFO - mozversion platform_buildid: 20160108043006 06:50:41 INFO - mozversion platform_changeset: 1424cdfc075d1b7e277be914488ac73e20d1c982 06:50:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:50:41 INFO - mozversion platform_version: 46.0a1 06:50:41 INFO - using testdate: 1452264641 06:50:41 INFO - actual date: 1452264641 06:50:41 INFO - starting webserver on 'localhost:35641' 06:50:41 INFO - SUITE-START | Running 3 tests 06:50:41 INFO - TEST-START | dromaeo_css 06:50:41 INFO - operating with platform_type : linux_ 06:50:41 INFO - Initialising browser for dromaeo_css test... 06:50:41 INFO - TEST-INFO | started process 28984 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpa4D2ck/profile http://localhost:35641/getInfo.html) 06:50:46 INFO - PROCESS | 28984 | __metrics Screen width/height:1600/1200 06:50:46 INFO - PROCESS | 28984 | colorDepth:24 06:50:46 INFO - PROCESS | 28984 | Browser inner width/height: 1024/697 06:50:46 INFO - PROCESS | 28984 | __metrics 06:50:47 INFO - PROCESS | 28984 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:50:47 INFO - PROCESS | 28984 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:50:48 INFO - TEST-INFO | 28984: exit 0 06:50:48 INFO - Browser initialized. 06:50:48 INFO - Running cycle 1/1 for dromaeo_css test... 06:50:48 INFO - TEST-INFO | started process 29079 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpa4D2ck/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:51:00 INFO - PROCESS | 29079 | RSS: Main: 148815872 06:51:00 INFO - PROCESS | 29079 | 06:51:51 INFO - PROCESS | 29079 | 1452264711793 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] 06:54:00 INFO - PROCESS | 29079 | Cycle 1(1): loaded http://localhost:35641/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35641/tests/dromaeo/cssquery-ext.html) 06:54:01 INFO - PROCESS | 29079 | RSS: Main: 273096704 06:54:01 INFO - PROCESS | 29079 | 06:57:04 INFO - PROCESS | 29079 | Cycle 1(1): loaded http://localhost:35641/tests/dromaeo/cssquery-ext.html (next: http://localhost:35641/tests/dromaeo/cssquery-jquery.html) 06:57:04 INFO - PROCESS | 29079 | RSS: Main: 238010368 06:57:04 INFO - PROCESS | 29079 | 07:00:06 INFO - PROCESS | 29079 | Cycle 1(1): loaded http://localhost:35641/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35641/tests/dromaeo/cssquery-mootools.html) 07:00:07 INFO - PROCESS | 29079 | RSS: Main: 228569088 07:00:07 INFO - PROCESS | 29079 | 07:03:09 INFO - PROCESS | 29079 | Cycle 1(1): loaded http://localhost:35641/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35641/tests/dromaeo/cssquery-prototype.html) 07:03:09 INFO - PROCESS | 29079 | RSS: Main: 217939968 07:03:09 INFO - PROCESS | 29079 | 07:06:12 INFO - PROCESS | 29079 | Cycle 1(1): loaded http://localhost:35641/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35641/tests/dromaeo/cssquery-yui.html) 07:06:12 INFO - PROCESS | 29079 | RSS: Main: 221032448 07:06:12 INFO - PROCESS | 29079 | 07:09:15 INFO - PROCESS | 29079 | Cycle 1(1): loaded http://localhost:35641/tests/dromaeo/cssquery-yui.html (next: http://localhost:35641/tests/dromaeo/cssquery-dojo.html) 07:09:16 INFO - PROCESS | 29079 | RSS: Main: 294440960 07:09:16 INFO - PROCESS | 29079 | 07:09:16 INFO - PROCESS | 29079 | __start_tp_report 07:09:16 INFO - PROCESS | 29079 | _x_x_mozilla_page_load 07:09:16 INFO - PROCESS | 29079 | _x_x_mozilla_page_load_details 07:09:16 INFO - PROCESS | 29079 | |i|pagename|runs| 07:09:16 INFO - PROCESS | 29079 | |0;dojo.html;3096.2568983443975;3135.561021456998;3175.2379428937047;3176.745860331174;3183.0291761012895;5010.824621138261;5104.489551044893;5126.077306084903;5129.358830146227;5160.096983027969;5057.974710126444;5135.152699804537;5199.558037566811;5202.167653175483;5218.39988401334;4507.571780680846;4612.8385506507275;4686.742229177394;4752.310914917335;4797.592204662608;4642.65180111493;4748.121597504472;4754.857354279377;4762.666613337068;4873.853784386474;4644.767761611923;4727.503612120747;4733.668643194977;4745.09843129806;4767.189577771787;4654.441467023945;4685.672002959795;4695.5069717679835;4711.8350857719815;4734.171519984024;4633.62930965522;4670.743109128996;4674.088552732219;4705.388299521041;4731.621470282369;4943.802247910079;5035.144025515671;5047.369078865142;5053.090443720129;5062.443131255559;5536.889262214773;5568.387477377485;5577.107662773978;5577.637453565505;5615.634983726086;5409.323834520685;5506.972465137689;5512.366077901052;5593.580481463907;5594.636348637367;5166.483351664803;5250.947490525045;5262.421133675292;5290.65610735301;5310.9203361949985;5636.971815140898;5640.887182256414;5641.633293835887;5642.520385767256;5643.915341269884;5384.40771515133;5457.126859702428;5460.31746031746;5461.317335333083;5461.754221060062;5427.94155139744;5473.589480788957;5494.2857428534035;5568.805091821767;5621.7751289948765;5422.864428389243;5435.347758269033;5446.046941785172;5446.591505637093;5447.428020057916;5423.267858839006;5426.728663566806;5430.782768689208;5451.427600102012;5482.533984611353;4290.141971605692;4298.634616057608;4338.956610433918;4366.585174408426;4378.211921854033;3841.769493830379;3841.8463261469788;3856.82644281008;3869.729118961646;3893.649571538575;5025.698458092526;5107.770150343244;5109.6678715883345;5113.718745469035;5150.793968241228;5429.53848922846;5545.805896793593;5572.749226284827;5595.4124816894455;5640.351359593617;5140.717260550631;5144.125498665236;5146.073706732824;5186.948130518646;5198.350206224222;4686.695364801277;4721.315409265637;4727.149113159596;4730.787114579852;4779.474257831635;5564.387917329091;5670.262865827416;5673.489385955201;5731.5701322400155;5737.225474560964;5469.371022332482;5564.4991950724625;5567;5568.443155684561;5617.101263797773;5725.656460612377;5728.455796699307;5729.369769325288;5731.971340143273;5734.713264336683;5350.545203657733;5442.210879422382;5448.264484294569;5463;5467.234587157722;5546.140348246028;5570.080936645571;5572.331320241597;5606.831795046155;5640.182173584725;5413.9729301353245;5426.403095659553;5428.56571474289;5431.83704488866;5437.157240627709;5208.114620514598;5233.058049551118;5283.313169287968;5285.524302812765;5379.273798037371;5259.710715910662;5278.604104692086;5280.762365693477;5282.524572788314;5288.3918349390315;5454.781808727606;5517.641353312022;5554.777808887599;5559.888802223852;5562.666240025612;5298.337707786527;5303.416624171416;5326.573874090141;5335.2263921730355;5347.358317001985 07:09:16 INFO - PROCESS | 29079 | |1;ext.html;515.8349328214972;516.0865268474797;520.3313741841735;541.445018855673;549.4697616799788;27084.322891927688;27832.860835695818;35363.4695479568;35379.2924141517;35399.2920141597;38245.426318605176;38628.420573691415;38744;38748.612513874854;38761.41857872134;7329.047223860917;8263;8454.746357609281;8466.830663386729;8475;7340.706371745124;7459.440541959348;9894;10083.14293285068;10087.94956025219;9853.408795472295;9865.062819032217;9932.801343973117;9940.453275069869;9945.055219754111;7217.639118044077;7354.191038985708;9799.020097990215;9900.207983361313;9910.05854443834;7501.324880760703;7651.770446886547;7656.234376562355;9857.211423086135;10121.089101980857;35051;35275.64724352749;35396.82301588476;35423.82288088569;35455.645443545494;2736.9178924632292;2926.0929111975356;2928.941421171586;3055.4194703006356;3460;27026;27536.036238731747;27669.86165069182;27847.721522784715;27967.88128474879;3902.453656488094;3955.8219880105466;3966.7210668423477;3971.4241434992055;4060.4721386219603;275729;278601;278788;278894;279073;50089.499105009214;51117.488825112014;56519.43480565224;56958.14562781562;57333;52922.20616690753;53210.201846972326;53258.73370633122;53437.465625344026;53446.46553534415;13183.604491865259;13383.732325353438;13399.397027133802;13408.530701425598;13426.865731342561;10163.339382940234;10283.07452329294;10320.174386049099;10323.587056517805;10323.63867264642;18437.354692585694;19052.237910483425;19251.711224331648;19256.22975081009;19283.807161928482;7272.527285726411;7297.70809167638;7351.889721654179;7402.407807375397;7476.953226548288;909.6952520905438;997.5660587644398;1002.5839276700087;1029.325791606499;1060.5545670818121;27662.723372766417;28089.297767555567;28523.690177825632;28591.14226573206;28793.42413151725;983.9655612053543;1010.5705075343096;1042.8070806900596;1052.3685788526975;1109.2124591540096;13051.804222936664;13742.519011834538;13850.722985540435;14862.256887155816;15113.427802619219;325273;327182;328801;329313;330479;50406;51401.48598513967;51421;51439;51472.48527514677;1185.9525618975144;1186.6677330347688;1191.3149938785234;1306.0726883912528;1323.8676132386684;22051.558968820213;28716.71283287224;28883.422331552832;28963;29436;49135.75432122959;49860.501394985586;49877.25184122168;49900.75049624729;49917.500824991286;271758;275602;304547;306167;307532;29081.85459072691;29122.56316155217;29142.41715165727;29437.26406839846;29459.55810662799;40333.1933361337;43506;43580.56419435765;44402.11195776002;44566.55433445624;34838.47742283918;35813.1046723834;35988.28023439569;36398.27203455969;36627.816860915525;31969.520457193626;32533.674663254013;32680.83659581687;34497.48253776246;35706;31500.133701755298;31855.522167167976;32271.193220169684;32365;32430.35139297248;28075.298117547223;29081.709182908748;29959.0981644056;30207.819514407314;31746;22466.213682521033;23200.88399558059;23366;23403.76596234084;23565.764342356357 07:09:16 INFO - PROCESS | 29079 | |2;jquery.html;347.91476088358354;354.18537364062655;357.6387848273244;358.7650089191577;359.5146552154592;13520.188788672662;13845.169289842592;15845.683086338266;15944.36222551098;16747.4138405156;9427.48148851813;9675.371100878438;9693.806123877519;13676.726465470685;14140.434382624682;4871.12319782439;5024.321716568253;5032.345795046657;5033.823816166435;5175.508326708976;3755.4742336072973;3877.2827026999953;5332.973335133338;5370.140777475604;5542.473465020817;5329;5494.36814766301;5509.47659972302;5536.612437129403;5540.529055030307;5508.531774799147;5523.337199536081;5527.889442211173;5542.75057622408;5552.833414997536;4996.825111121129;5179.8446046618665;5187.118189907725;5321.893562128775;5332.200169974535;18099.185536650883;18187.54531136719;18228.179731912096;18440.63118737631;18517.537061573435;2085.092984551725;2099.8005189507126;2114.8731076135327;2140.8501404901663;2217.733871935362;9232.215261702697;9744;9837.85243221345;10556.683299501028;12311.138220324581;1718.7937447506254;1818.3181307009872;1834.6972749496317;1867.7105048717472;1916.2718167096552;55663;56267.718661406434;57561.42438575603;57876.71061644707;58162;9972.700818975442;9973.152282056106;10037.297389182833;10070.395776253448;10140.797184056277;13173.40719667598;13289.867101329057;13296.468141274434;13309.866901330863;13333.733325333633;6845.760398386033;6859.897101543481;6892.896606550906;6966.268541803139;7056.717731290793;6435.967820160963;6452.064450654629;6523.7064332105165;6588.4729221662155;6599.571027883172;4364.650827933758;4423;4425.203463376623;4451.888702782457;4462.219111655448;1678.8237235090385;1741.0772290685957;1769.4780039888265;1853.2123847364817;1866.9346572869883;898.6180873128894;938.9765255868522;956.7426988697154;956.8373376526007;1004.4927311707687;13499.460021599027;16425.58936026585;16439.753403698953;16452.917735411247;16761;862.3489265604428;900.1718419054486;906.1255888068046;963.3834346018554;974.5760594141572;8967.775805604912;9246.212140072332;9423.764405889771;9433.716988490356;9597.856032159523;478915;488607;497169.71227158105;532246;534219;40080.19839603192;47122.5287747125;50312.49687503078;69720.65139674269;71106.64446677733;1081.5944020992129;1084.4577711144427;1089.9509522071526;1104.8508451359126;1112.554978008803;14333.65627590627;14519.34662940149;14629;14792.48226312117;14865.108093514424;31102.844485777427;31704.841475792473;31973;31981.68018319787;32604.51093233556;39514.40728389019;39678.801605991786;41138;41147.38278925879;41303.1739365205;6893.724251030103;7222.241664625349;7280.344768970818;7286.526375785557;7413.1104267488245;10132.645357412455;10891;11338.376389298668;11383.943080284545;11493.885061149616;9250.861237081315;9543.12489384851;9651.324407291422;9732.318737688294;9791.902080979098;3060.234941264684;3724.3296206681975;9136.172765446805;9662.516874156405;10082.495875206358;9051.411658242194;9276.860847087433;9540;9694.46680432583;9810.950945245228;7373.594452305175;7421.628918553943;7559.886601701089;7564.319211271012;7647.770566883002;9124.680636177702;9252.629894804133;9285.953570232106;9308.95345523268;9352 07:09:16 INFO - PROCESS | 29079 | |3;mootools.html;1176.8234764785275;1418.6949805791755;1430.6852492451658;1579.6998570271649;1752.4742577226837;6985.40624046956;7575.204603516634;7738.8452230955345;7748.61256937153;7749.341305988984;7461.962690186541;7621.771346859603;7646.732364367248;7647.197044310351;7647.732329368473;2301.229088255432;2320.2575175943703;2329.755375685554;2332.0438620165737;2332.1487657005155;2266.1841736974675;2305.8270629702756;2308.8730119843403;2311.191083120911;2324.9070037198576;2250.5386395788905;2254.9774502255013;2260.7513173550897;2276.692646492727;2286.8856557172076;2193.1885202475028;2276.8975396107217;2278.4759505313787;2281.7718228177214;2283.8401311908174;2266.626006708891;2272.0684519347155;2274.431392151962;2274.579202847462;2275.0899640143907;6648.202215734094;6790;7781.844363112706;7826.1391246962785;7840.09838868526;4037;4135.1316223592785;4138.089620283533;4439.378487011821;4527.705699129546;2922.298648324408;2987.910362689123;3043.360894212196;3051.2982014136874;3062.1119875236154;928.2110206324637;942.9717108486687;952.6618050592009;954.9331546791727;998.3427510332886;10500.579976800918;10621.787564248672;10636.680899572948;10642.57429702811;10642.680719578426;4387.824487020547;4397.2304846651705;4438.889027774267;4463.553644635511;4505.797239124247;9383.577739001761;9396.577154028086;9423.575939082757;9425.528723563795;9433.481158536346;4689.109069276827;4690.695104818176;4695.9530404695515;4696.647751418657;4702.623790096784;4184.14225083857;4218.894527636834;4219.261629214875;4222.936655950163;4226.323788193936;3542.6457354264367;3610.2598967211657;3641.5812181598926;3655.1593133579427;3657.469666898338;1130.988690113105;1165.2717051842599;1166.6091859227083;1168.6377223060879;1181.8286348479423;1055.9419231942318;1093.9015488606065;1094.9124070074374;1232.6363722701824;1342.6374878782674;7441.330280274801;7592;7599.848003039909;7610.505317154367;7639.465237433437;495.57628227864654;502.0536289095009;509.6839959225304;515.6699712184205;516.3029909622055;5158.484151584811;5603.971980140073;5669.291338582677;5674.460926212003;5681.147827825859;8725.21473067427;8729.127087291221;8741.868871966926;8842.77893052666;8861.025287218401;8574.984878553534;8622.223999839918;8663.960324760943;8704.477731336141;8715.346349023848;7326.157491888394;7373.77878663641;7419.332260096618;7436.888446673304;7461.209309765617;7016.7544135954995;7067.045948797052;7169.749058782918;7175.46184036189;7176.102987126609;8395.95802020986;8507.95746021266;8530.872036919576;8681.305495560466;8763.211310982042;8685;8929.73210803677;8952.731418057469;9017.413868098552;9096.681616143404;6979.441644668313;7017.96491017562;7031.6835742390695;7046.788596342118;7063.505554611128;7189.676464559212;7340.853182936418;7567.508111972704;7635.083789945242;7648.73229436967;6886.552374095668;6969.54697944632;6970.477214208853;7019.4033507150425;7072.611006394698;6769.08617336673;6773.559718618274;6786.355296246848;6850.246472887879;7038.964805175941;6920.446364290945;6981.581105133709;6989.37095661393;6992.79021629352;6993.615351155735;6386.489080873612;6472.482201423969;6631.867362652816;6656.2345330287635;6658.467322614082;6497.9025314619375;6500.3174666659315;6566.0479230510355;6572.572782769104;6585 07:09:16 INFO - PROCESS | 29079 | |4;prototype.html;327.89507357645556;333.66466700965526;340.63041599864175;342.7652058340037;347.730508855637;5815.255423372987;5899.85250368741;5920;5933.851653708649;5951.553633477496;5572.693501857407;5692.943070569293;5764.51001664859;5827.067669172933;5836.095405212199;4553.430821147356;4573.7713114344315;4577.656675749316;4583.1062942726185;4591;4521.660875434339;4568.977155114219;4574.656900732459;4576.885577860564;4594.402727645418;4320.611144996949;4379.386885835986;4384.7149935254265;4397.802098905541;4479.731216127043;4449.28811390176;4461.397711308964;4461.620762235214;4471.441069866267;4482.17079840229;3954.209158168349;3955.070558418798;3965.920681586352;3992.540857801361;4036.2331157080353;5585.609007369486;5598.524125449342;5598.832035038955;5614.775408983635;5616.073347897633;5174.3790745110455;5224.268602395668;5286.101362768339;5291.576673866081;5294.735263236861;6195.7521699131985;6200.131981522591;6202.224721909762;6215.192025036717;6228.906566401508;4441.644668426518;4445.644348452149;4447.466304043503;4447.666425018104;4452.9554704453185;6250.124982502453;6402.455791257748;6475.320091390383;6484.708188131545;6504.674766261715;4404.317330813729;4426.756528390905;4427.867163985085;4427.933580996288;4437.755923424243;4466;4478.216312145361;4480.529544397791;4482.686211965196;4487.102579484116;5157.535821776059;5200.063988482109;5202.505761952609;5203.947960520422;5206.687598744087;6120.7551697931585;6207.441330280206;6278.560500764903;6281.277653069864;6286.18279623646;1564.1788061267926;1578.8894777365704;1580.4389441748244;1580.6127498762876;1582.185174635064;1010.8938561451089;1032.509557959963;1042.3641578637025;1046.3721766939927;1061.4851796878509;5929.762809487658;5934.732937017845;5942.524598032147;5944.316403613553;5948.286205655262;6348.365163483707;6400.839979000562;6410.1987251593555;6412.134361861183;6429;5745.052066409079;5835.066389377764;5871.941280587225;5922.674252916045;5947.821565353046;3465.4108801503803;3467.4452087665854;3479.3563190809273;3480.8781692640637;3487.738419618488;6749.223839258548;6759.898601520981;6762.391384775394;6768.492363072789;6769.120014398097;6493.058506516529;6562.278149403562;6618.900716489256;6619.404253617101;6620.437262832616;6732.427743641747;6734.326567343226;6742.426893713991;6744.0558321834005;6758.831029224309;6449.580777249464;6460.741570337322;6465.094886715958;6465.935340646533;6470.514711396759;6265.342139075331;6346.048092786119;6355.650439225887;6383.638053920079;6395.6482393468805;6729.99050142463;6730.798076057726;6734.3602357775935;6741;6747.392734653708;4447.977760111179;4451.6661250407;4454;4455.1980643484485;4456.353828694886;6265.686715664289;6413.390727880844;6481.708323125376;6482.708278127401;6490.902636460552;6340.873182536416;6341.239051313872;6348.111264422892;6359.523035772243;6369.585976911486;6338.144350512622;6342.365763423805;6343.080253363144;6344.619322840645;6353.078803573549;6096.268447786294;6222.315545289924;6228.190335256388;6237.220347456568;6241.188645476059;6331.778387756406;6349.619022858643;6352.745890164341;6360.936390636034;6364.172657554674;6208.1308616792785;6208.441240288395;6211.503079753699;6212.471939884979;6220.377962203925 07:09:16 INFO - PROCESS | 29079 | |5;yui.html;746.8917007033976;792.1484404265412;807.4428644235477;816.2001238785989;818.6070686070686;12876.935615321921;13338.266395348277;13345.399457024445;13346.399412026458;13359.19844809311;10634.096101831334;12300.38498075097;12317.260964342146;12333.629991100259;12370.319632420213;621.4251817069215;753.581762122022;758.9620518974057;761.090496856257;765.4641750774452;757.3827330725442;758.4198088462331;763.8892360607708;766.0615745711486;767.3247542162917;655.5312951239863;657.1030543308398;802.8675268580677;804.4409135650725;807.7778610881995;805.7341077444429;822.6709316273478;822.8066404394963;823.259066839843;824.4023083264615;589.2604780999818;590.583638534832;590.630855715178;591.0248090650418;592.4253474130087;12145.574904878287;12188.695282617917;12203.511859525608;12211.93894030533;12219.511219551207;10258.384496930208;10655.151905882805;11146.108311335074;11203.439828008648;11266.324020558794;10446.373217606968;10533.578656853717;10588.576456941713;10698.625548105856;11110.666679999533;3332.683395077464;3575.3743094958277;3584.8566057357675;3591.676749092568;3699.8705045323554;45527;45548.77225613851;45909.31136032962;46326.53673463256;46539.30191047171;9821.066998635119;10014.54934527948;10238.53926573306;10251.7437064074;10293.94853025745;17086.40197593078;17172.141392930553;17177.227024783915;17182.484525464257;17182.828171718375;7589.172528646997;7629.465937384441;7640.885386719204;7827.334676552443;7860.528368297921;4306.074194048295;4363.912721745611;4406.162829062468;4462.308342206963;4498.5501449854755;2783.6520434945633;2812.578113283024;2821.195959151673;2829.0522674904137;2835.4754370441533;514.6268955007589;525.8816766227568;530.3105962249061;553.8393865778879;555.081340381669;522.8588281164141;552.809280798124;581.9301683797971;613.2763339259716;667.5827607745159;8395.454295470774;8730.214280714767;8743.519106449206;8877.24297342803;8916.37585369031;526.8199233716448;553.0929275987384;593.6972144206486;640.0111827226946;701.1551080947446;3864.246471937945;3930.744501607386;3987.322155233617;4027.8993025174605;4102.610252026053;48654.02691946212;48896.75551622219;49216.753916230904;52732;52867;42976.78511607422;43202.35196471993;43354.34968475475;43456;43804.78097609492;43676.781616091714;43914.12171756611;43991.56008439939;44580.3312950306;44608.3308750369;8217.260446559838;8393.538355390512;8707.738767836974;8922.189510304233;9040.276777857624;30753.231169220948;32673;33864.15339616529;33929.49105763366;34525.827370862986;41648;43303.566964329955;44108.33837492376;44257.33613995728;44284.11431771411;10063.547140378847;10183.388996660224;10278.588856445658;10407.739806504898;10922.617708380169;11715.648530544097;11859.135445538492;11949.283043017447;12402.5659101931;12483.12618116723;11676.824847627462;11929.463174157358;12008.459619316976;12153.210041347284;12645.430955607204;11639.825402618799;11838.704032399259;11919.880801191877;11998.220115692453;12396.194247373893;11023.44882755843;11932.76134477323;12143.696407589881;12155.939220303842;12163.331016794162;9428.15146636806;9552.23582113443;9574.617015319309;9605.934724034367;9919.40483570988;8836.734897953073;9152.808564356937;9464.337496375188;9788.608455661693;9901.752456188653 07:09:16 INFO - PROCESS | 29079 | __end_tp_report 07:09:16 INFO - PROCESS | 29079 | __start_cc_report 07:09:16 INFO - PROCESS | 29079 | _x_x_mozilla_cycle_collect,1130 07:09:16 INFO - PROCESS | 29079 | __end_cc_report 07:09:16 INFO - PROCESS | 29079 | __startTimestamp1452265756003__endTimestamp 07:09:16 INFO - PROCESS | 29079 | 07:09:16 INFO - PROCESS | 29079 | ------- Summary: start ------- 07:09:16 INFO - PROCESS | 29079 | Number of tests: 6 07:09:16 INFO - PROCESS | 29079 | 07:09:16 INFO - PROCESS | 29079 | [#0] dojo.html Cycles:165 Average:5132.97 Median:5290.66 stddev:552.74 (10.4%) stddev-sans-first:530.85 07:09:16 INFO - PROCESS | 29079 | Values: 3096.3 3135.6 3175.2 3176.7 3183.0 5010.8 5104.5 5126.1 5129.4 5160.1 5058.0 5135.2 5199.6 5202.2 5218.4 4507.6 4612.8 4686.7 4752.3 4797.6 4642.7 4748.1 4754.9 4762.7 4873.9 4644.8 4727.5 4733.7 4745.1 4767.2 4654.4 4685.7 4695.5 4711.8 4734.2 4633.6 4670.7 4674.1 4705.4 4731.6 4943.8 5035.1 5047.4 5053.1 5062.4 5536.9 5568.4 5577.1 5577.6 5615.6 5409.3 5507.0 5512.4 5593.6 5594.6 5166.5 5250.9 5262.4 5290.7 5310.9 5637.0 5640.9 5641.6 5642.5 5643.9 5384.4 5457.1 5460.3 5461.3 5461.8 5427.9 5473.6 5494.3 5568.8 5621.8 5422.9 5435.3 5446.0 5446.6 5447.4 5423.3 5426.7 5430.8 5451.4 5482.5 4290.1 4298.6 4339.0 4366.6 4378.2 3841.8 3841.8 3856.8 3869.7 3893.6 5025.7 5107.8 5109.7 5113.7 5150.8 5429.5 5545.8 5572.7 5595.4 5640.4 5140.7 5144.1 5146.1 5186.9 5198.4 4686.7 4721.3 4727.1 4730.8 4779.5 5564.4 5670.3 5673.5 5731.6 5737.2 5469.4 5564.5 5567.0 5568.4 5617.1 5725.7 5728.5 5729.4 5732.0 5734.7 5350.5 5442.2 5448.3 5463.0 5467.2 5546.1 5570.1 5572.3 5606.8 5640.2 5414.0 5426.4 5428.6 5431.8 5437.2 5208.1 5233.1 5283.3 5285.5 5379.3 5259.7 5278.6 5280.8 5282.5 5288.4 5454.8 5517.6 5554.8 5559.9 5562.7 5298.3 5303.4 5326.6 5335.2 5347.4 07:09:16 INFO - PROCESS | 29079 | 07:09:16 INFO - PROCESS | 29079 | [#1] ext.html Cycles:180 Average:45677.06 Median:327991.50 stddev:78776.10 (24.0%) stddev-sans-first:78924.11 07:09:16 INFO - PROCESS | 29079 | Values: 515.8 516.1 520.3 541.4 549.5 27084.3 27832.9 35363.5 35379.3 35399.3 38245.4 38628.4 38744.0 38748.6 38761.4 7329.0 8263.0 8454.7 8466.8 8475.0 7340.7 7459.4 9894.0 10083.1 10087.9 9853.4 9865.1 9932.8 9940.5 9945.1 7217.6 7354.2 9799.0 9900.2 9910.1 7501.3 7651.8 7656.2 9857.2 10121.1 35051.0 35275.6 35396.8 35423.8 35455.6 2736.9 2926.1 2928.9 3055.4 3460.0 27026.0 27536.0 27669.9 27847.7 27967.9 3902.5 3955.8 3966.7 3971.4 4060.5 275729.0 278601.0 278788.0 278894.0 279073.0 50089.5 51117.5 56519.4 56958.1 57333.0 52922.2 53210.2 53258.7 53437.5 53446.5 13183.6 13383.7 13399.4 13408.5 13426.9 10163.3 10283.1 10320.2 10323.6 10323.6 18437.4 19052.2 19251.7 19256.2 19283.8 7272.5 7297.7 7351.9 7402.4 7477.0 909.7 997.6 1002.6 1029.3 1060.6 27662.7 28089.3 28523.7 28591.1 28793.4 984.0 1010.6 1042.8 1052.4 1109.2 13051.8 13742.5 13850.7 14862.3 15113.4 325273.0 327182.0 328801.0 329313.0 330479.0 50406.0 51401.5 51421.0 51439.0 51472.5 1186.0 1186.7 1191.3 1306.1 1323.9 22051.6 28716.7 28883.4 28963.0 29436.0 49135.8 49860.5 49877.3 49900.8 49917.5 271758.0 275602.0 304547.0 306167.0 307532.0 29081.9 29122.6 29142.4 29437.3 29459.6 40333.2 43506.0 43580.6 44402.1 44566.6 34838.5 35813.1 35988.3 36398.3 36627.8 31969.5 32533.7 32680.8 34497.5 35706.0 31500.1 31855.5 32271.2 32365.0 32430.4 28075.3 29081.7 29959.1 30207.8 31746.0 22466.2 23200.9 23366.0 23403.8 23565.8 07:09:16 INFO - PROCESS | 29079 | 07:09:16 INFO - PROCESS | 29079 | [#2] jquery.html Cycles:180 Average:25665.87 Median:27668.41 stddev:82677.68 (298.8%) stddev-sans-first:82887.76 07:09:16 INFO - PROCESS | 29079 | Values: 347.9 354.2 357.6 358.8 359.5 13520.2 13845.2 15845.7 15944.4 16747.4 9427.5 9675.4 9693.8 13676.7 14140.4 4871.1 5024.3 5032.3 5033.8 5175.5 3755.5 3877.3 5333.0 5370.1 5542.5 5329.0 5494.4 5509.5 5536.6 5540.5 5508.5 5523.3 5527.9 5542.8 5552.8 4996.8 5179.8 5187.1 5321.9 5332.2 18099.2 18187.5 18228.2 18440.6 18517.5 2085.1 2099.8 2114.9 2140.9 2217.7 9232.2 9744.0 9837.9 10556.7 12311.1 1718.8 1818.3 1834.7 1867.7 1916.3 55663.0 56267.7 57561.4 57876.7 58162.0 9972.7 9973.2 10037.3 10070.4 10140.8 13173.4 13289.9 13296.5 13309.9 13333.7 6845.8 6859.9 6892.9 6966.3 7056.7 6436.0 6452.1 6523.7 6588.5 6599.6 4364.7 4423.0 4425.2 4451.9 4462.2 1678.8 1741.1 1769.5 1853.2 1866.9 898.6 939.0 956.7 956.8 1004.5 13499.5 16425.6 16439.8 16452.9 16761.0 862.3 900.2 906.1 963.4 974.6 8967.8 9246.2 9423.8 9433.7 9597.9 478915.0 488607.0 497169.7 532246.0 534219.0 40080.2 47122.5 50312.5 69720.7 71106.6 1081.6 1084.5 1090.0 1104.9 1112.6 14333.7 14519.3 14629.0 14792.5 14865.1 31102.8 31704.8 31973.0 31981.7 32604.5 39514.4 39678.8 41138.0 41147.4 41303.2 6893.7 7222.2 7280.3 7286.5 7413.1 10132.6 10891.0 11338.4 11383.9 11493.9 9250.9 9543.1 9651.3 9732.3 9791.9 3060.2 3724.3 9136.2 9662.5 10082.5 9051.4 9276.9 9540.0 9694.5 9811.0 7373.6 7421.6 7559.9 7564.3 7647.8 9124.7 9252.6 9286.0 9309.0 9352.0 07:09:16 INFO - PROCESS | 29079 | 07:09:16 INFO - PROCESS | 29079 | [#3] mootools.html Cycles:180 Average:5403.07 Median:6578.79 stddev:2830.75 (43.0%) stddev-sans-first:2820.87 07:09:16 INFO - PROCESS | 29079 | Values: 1176.8 1418.7 1430.7 1579.7 1752.5 6985.4 7575.2 7738.8 7748.6 7749.3 7462.0 7621.8 7646.7 7647.2 7647.7 2301.2 2320.3 2329.8 2332.0 2332.1 2266.2 2305.8 2308.9 2311.2 2324.9 2250.5 2255.0 2260.8 2276.7 2286.9 2193.2 2276.9 2278.5 2281.8 2283.8 2266.6 2272.1 2274.4 2274.6 2275.1 6648.2 6790.0 7781.8 7826.1 7840.1 4037.0 4135.1 4138.1 4439.4 4527.7 2922.3 2987.9 3043.4 3051.3 3062.1 928.2 943.0 952.7 954.9 998.3 10500.6 10621.8 10636.7 10642.6 10642.7 4387.8 4397.2 4438.9 4463.6 4505.8 9383.6 9396.6 9423.6 9425.5 9433.5 4689.1 4690.7 4696.0 4696.6 4702.6 4184.1 4218.9 4219.3 4222.9 4226.3 3542.6 3610.3 3641.6 3655.2 3657.5 1131.0 1165.3 1166.6 1168.6 1181.8 1055.9 1093.9 1094.9 1232.6 1342.6 7441.3 7592.0 7599.8 7610.5 7639.5 495.6 502.1 509.7 515.7 516.3 5158.5 5604.0 5669.3 5674.5 5681.1 8725.2 8729.1 8741.9 8842.8 8861.0 8575.0 8622.2 8664.0 8704.5 8715.3 7326.2 7373.8 7419.3 7436.9 7461.2 7016.8 7067.0 7169.7 7175.5 7176.1 8396.0 8508.0 8530.9 8681.3 8763.2 8685.0 8929.7 8952.7 9017.4 9096.7 6979.4 7018.0 7031.7 7046.8 7063.5 7189.7 7340.9 7567.5 7635.1 7648.7 6886.6 6969.5 6970.5 7019.4 7072.6 6769.1 6773.6 6786.4 6850.2 7039.0 6920.4 6981.6 6989.4 6992.8 6993.6 6386.5 6472.5 6631.9 6656.2 6658.5 6497.9 6500.3 6566.0 6572.6 6585.0 07:09:16 INFO - PROCESS | 29079 | 07:09:16 INFO - PROCESS | 29079 | [#4] prototype.html Cycles:180 Average:5236.36 Median:5921.34 stddev:1578.84 (26.7%) stddev-sans-first:1539.69 07:09:16 INFO - PROCESS | 29079 | Values: 327.9 333.7 340.6 342.8 347.7 5815.3 5899.9 5920.0 5933.9 5951.6 5572.7 5692.9 5764.5 5827.1 5836.1 4553.4 4573.8 4577.7 4583.1 4591.0 4521.7 4569.0 4574.7 4576.9 4594.4 4320.6 4379.4 4384.7 4397.8 4479.7 4449.3 4461.4 4461.6 4471.4 4482.2 3954.2 3955.1 3965.9 3992.5 4036.2 5585.6 5598.5 5598.8 5614.8 5616.1 5174.4 5224.3 5286.1 5291.6 5294.7 6195.8 6200.1 6202.2 6215.2 6228.9 4441.6 4445.6 4447.5 4447.7 4453.0 6250.1 6402.5 6475.3 6484.7 6504.7 4404.3 4426.8 4427.9 4427.9 4437.8 4466.0 4478.2 4480.5 4482.7 4487.1 5157.5 5200.1 5202.5 5203.9 5206.7 6120.8 6207.4 6278.6 6281.3 6286.2 1564.2 1578.9 1580.4 1580.6 1582.2 1010.9 1032.5 1042.4 1046.4 1061.5 5929.8 5934.7 5942.5 5944.3 5948.3 6348.4 6400.8 6410.2 6412.1 6429.0 5745.1 5835.1 5871.9 5922.7 5947.8 3465.4 3467.4 3479.4 3480.9 3487.7 6749.2 6759.9 6762.4 6768.5 6769.1 6493.1 6562.3 6618.9 6619.4 6620.4 6732.4 6734.3 6742.4 6744.1 6758.8 6449.6 6460.7 6465.1 6465.9 6470.5 6265.3 6346.0 6355.7 6383.6 6395.6 6730.0 6730.8 6734.4 6741.0 6747.4 4448.0 4451.7 4454.0 4455.2 4456.4 6265.7 6413.4 6481.7 6482.7 6490.9 6340.9 6341.2 6348.1 6359.5 6369.6 6338.1 6342.4 6343.1 6344.6 6353.1 6096.3 6222.3 6228.2 6237.2 6241.2 6331.8 6349.6 6352.7 6360.9 6364.2 6208.1 6208.4 6211.5 6212.5 6220.4 07:09:16 INFO - PROCESS | 29079 | 07:09:16 INFO - PROCESS | 29079 | [#5] yui.html Cycles:180 Average:13066.34 Median:24198.86 stddev:14550.47 (60.1%) stddev-sans-first:14561.88 07:09:16 INFO - PROCESS | 29079 | Values: 746.9 792.1 807.4 816.2 818.6 12876.9 13338.3 13345.4 13346.4 13359.2 10634.1 12300.4 12317.3 12333.6 12370.3 621.4 753.6 759.0 761.1 765.5 757.4 758.4 763.9 766.1 767.3 655.5 657.1 802.9 804.4 807.8 805.7 822.7 822.8 823.3 824.4 589.3 590.6 590.6 591.0 592.4 12145.6 12188.7 12203.5 12211.9 12219.5 10258.4 10655.2 11146.1 11203.4 11266.3 10446.4 10533.6 10588.6 10698.6 11110.7 3332.7 3575.4 3584.9 3591.7 3699.9 45527.0 45548.8 45909.3 46326.5 46539.3 9821.1 10014.5 10238.5 10251.7 10293.9 17086.4 17172.1 17177.2 17182.5 17182.8 7589.2 7629.5 7640.9 7827.3 7860.5 4306.1 4363.9 4406.2 4462.3 4498.6 2783.7 2812.6 2821.2 2829.1 2835.5 514.6 525.9 530.3 553.8 555.1 522.9 552.8 581.9 613.3 667.6 8395.5 8730.2 8743.5 8877.2 8916.4 526.8 553.1 593.7 640.0 701.2 3864.2 3930.7 3987.3 4027.9 4102.6 48654.0 48896.8 49216.8 52732.0 52867.0 42976.8 43202.4 43354.3 43456.0 43804.8 43676.8 43914.1 43991.6 44580.3 44608.3 8217.3 8393.5 8707.7 8922.2 9040.3 30753.2 32673.0 33864.2 33929.5 34525.8 41648.0 43303.6 44108.3 44257.3 44284.1 10063.5 10183.4 10278.6 10407.7 10922.6 11715.6 11859.1 11949.3 12402.6 12483.1 11676.8 11929.5 12008.5 12153.2 12645.4 11639.8 11838.7 11919.9 11998.2 12396.2 11023.4 11932.8 12143.7 12155.9 12163.3 9428.2 9552.2 9574.6 9605.9 9919.4 8836.7 9152.8 9464.3 9788.6 9901.8 07:09:16 INFO - PROCESS | 29079 | -------- Summary: end -------- 07:09:16 INFO - PROCESS | 29079 | 07:09:16 INFO - TEST-INFO | 29079: exit 0 07:09:16 INFO - TEST-OK | dromaeo_css | took 1115242ms 07:09:16 INFO - TEST-START | kraken 07:09:16 INFO - operating with platform_type : linux_ 07:09:16 INFO - Initialising browser for kraken test... 07:09:16 INFO - TEST-INFO | started process 29269 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCzqAPv/profile http://localhost:35641/getInfo.html) 07:09:21 INFO - PROCESS | 29269 | __metrics Screen width/height:1600/1200 07:09:21 INFO - PROCESS | 29269 | colorDepth:24 07:09:21 INFO - PROCESS | 29269 | Browser inner width/height: 1024/697 07:09:21 INFO - PROCESS | 29269 | __metrics 07:09:21 INFO - PROCESS | 29269 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:09:21 INFO - PROCESS | 29269 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:09:23 INFO - TEST-INFO | 29269: exit 0 07:09:23 INFO - Browser initialized. 07:09:23 INFO - Running cycle 1/1 for kraken test... 07:09:23 INFO - TEST-INFO | started process 29354 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCzqAPv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:35 INFO - PROCESS | 29354 | RSS: Main: 149303296 07:09:35 INFO - PROCESS | 29354 | 07:09:37 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35641/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:38 INFO - PROCESS | 29354 | RSS: Main: 184614912 07:09:38 INFO - PROCESS | 29354 | 07:09:40 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35641/tests/kraken/driver.html?testName=audio-dft) 07:09:41 INFO - PROCESS | 29354 | RSS: Main: 175136768 07:09:41 INFO - PROCESS | 29354 | 07:09:44 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35641/tests/kraken/driver.html?testName=audio-fft) 07:09:44 INFO - PROCESS | 29354 | RSS: Main: 160419840 07:09:44 INFO - PROCESS | 29354 | 07:09:46 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35641/tests/kraken/driver.html?testName=audio-oscillator) 07:09:47 INFO - PROCESS | 29354 | RSS: Main: 162099200 07:09:47 INFO - PROCESS | 29354 | 07:09:49 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35641/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:09:50 INFO - PROCESS | 29354 | RSS: Main: 165654528 07:09:50 INFO - PROCESS | 29354 | 07:09:53 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35641/tests/kraken/driver.html?testName=imaging-darkroom) 07:09:53 INFO - PROCESS | 29354 | RSS: Main: 164564992 07:09:53 INFO - PROCESS | 29354 | 07:09:57 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35641/tests/kraken/driver.html?testName=imaging-desaturate) 07:09:57 INFO - PROCESS | 29354 | RSS: Main: 165158912 07:09:57 INFO - PROCESS | 29354 | 07:10:00 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35641/tests/kraken/driver.html?testName=json-parse-financial) 07:10:00 INFO - PROCESS | 29354 | RSS: Main: 164855808 07:10:00 INFO - PROCESS | 29354 | 07:10:02 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35641/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:10:03 INFO - PROCESS | 29354 | RSS: Main: 174788608 07:10:03 INFO - PROCESS | 29354 | 07:10:04 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:10:05 INFO - PROCESS | 29354 | RSS: Main: 171982848 07:10:05 INFO - PROCESS | 29354 | 07:10:07 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:10:08 INFO - PROCESS | 29354 | RSS: Main: 182857728 07:10:08 INFO - PROCESS | 29354 | 07:10:10 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:10:11 INFO - PROCESS | 29354 | RSS: Main: 186081280 07:10:11 INFO - PROCESS | 29354 | 07:10:13 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:10:14 INFO - PROCESS | 29354 | RSS: Main: 185184256 07:10:14 INFO - PROCESS | 29354 | 07:10:15 INFO - PROCESS | 29354 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35641/tests/kraken/driver.html?testName=ai-astar) 07:10:16 INFO - PROCESS | 29354 | RSS: Main: 242204672 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | __start_tp_report 07:10:16 INFO - PROCESS | 29354 | _x_x_mozilla_page_load 07:10:16 INFO - PROCESS | 29354 | _x_x_mozilla_page_load_details 07:10:16 INFO - PROCESS | 29354 | |i|pagename|runs| 07:10:16 INFO - PROCESS | 29354 | |0;ai-astar;109;111;106;110;110;111;100;110;111;111 07:10:16 INFO - PROCESS | 29354 | |1;audio-beat-detection;148;123;154;162;123;162;147;127;161;131 07:10:16 INFO - PROCESS | 29354 | |2;audio-dft;162;161;160;160;160;162;159;163;161;163 07:10:16 INFO - PROCESS | 29354 | |3;audio-fft;73;71;85;93;70;71;72;98;98;73 07:10:16 INFO - PROCESS | 29354 | |4;audio-oscillator;96;98;140;96;96;96;141;95;97;133 07:10:16 INFO - PROCESS | 29354 | |5;imaging-gaussian-blur;109;110;110;109;109;110;109;109;109;110 07:10:16 INFO - PROCESS | 29354 | |6;imaging-darkroom;145;145;146;146;145;147;146;147;147;145 07:10:16 INFO - PROCESS | 29354 | |7;imaging-desaturate;96;96;96;96;96;96;95;96;96;96 07:10:16 INFO - PROCESS | 29354 | |8;json-parse-financial;56;55;56;55;55;55;55;63;54;53 07:10:16 INFO - PROCESS | 29354 | |9;json-stringify-tinderbox;66;68;67;67;68;67;66;66;67;66 07:10:16 INFO - PROCESS | 29354 | |10;stanford-crypto-aes;86;86;87;84;93;85;85;84;92;85 07:10:16 INFO - PROCESS | 29354 | |11;stanford-crypto-ccm;120;118;124;114;116;115;115;113;115;124 07:10:16 INFO - PROCESS | 29354 | |12;stanford-crypto-pbkdf2;140;142;149;158;151;138;153;150;148;139 07:10:16 INFO - PROCESS | 29354 | |13;stanford-crypto-sha256-iterative;68;68;68;70;67;69;67;66;66;66 07:10:16 INFO - PROCESS | 29354 | __end_tp_report 07:10:16 INFO - PROCESS | 29354 | __start_cc_report 07:10:16 INFO - PROCESS | 29354 | _x_x_mozilla_cycle_collect,942 07:10:16 INFO - PROCESS | 29354 | __end_cc_report 07:10:16 INFO - PROCESS | 29354 | __startTimestamp1452265816078__endTimestamp 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | ------- Summary: start ------- 07:10:16 INFO - PROCESS | 29354 | Number of tests: 14 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.50 stddev:3.48 (3.1%) stddev-sans-first:3.69 07:10:16 INFO - PROCESS | 29354 | Values: 109.0 111.0 106.0 110.0 110.0 111.0 100.0 110.0 111.0 111.0 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:151.00 stddev:16.34 (10.8%) stddev-sans-first:17.26 07:10:16 INFO - PROCESS | 29354 | Values: 148.0 123.0 154.0 162.0 123.0 162.0 147.0 127.0 161.0 131.0 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.37 (0.8%) stddev-sans-first:1.41 07:10:16 INFO - PROCESS | 29354 | Values: 162.0 161.0 160.0 160.0 160.0 162.0 159.0 163.0 161.0 163.0 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#3] audio-fft Cycles:10 Average:80.40 Median:79.00 stddev:11.85 (15.0%) stddev-sans-first:12.27 07:10:16 INFO - PROCESS | 29354 | Values: 73.0 71.0 85.0 93.0 70.0 71.0 72.0 98.0 98.0 73.0 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:96.00 stddev:20.27 (21.1%) stddev-sans-first:20.96 07:10:16 INFO - PROCESS | 29354 | Values: 96.0 98.0 140.0 96.0 96.0 96.0 141.0 95.0 97.0 133.0 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:10:16 INFO - PROCESS | 29354 | Values: 109.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 07:10:16 INFO - PROCESS | 29354 | Values: 145.0 145.0 146.0 146.0 145.0 147.0 146.0 147.0 147.0 145.0 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:10:16 INFO - PROCESS | 29354 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:2.71 (4.9%) stddev-sans-first:2.87 07:10:16 INFO - PROCESS | 29354 | Values: 56.0 55.0 56.0 55.0 55.0 55.0 55.0 63.0 54.0 53.0 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 07:10:16 INFO - PROCESS | 29354 | Values: 66.0 68.0 67.0 67.0 68.0 67.0 66.0 66.0 67.0 66.0 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.00 stddev:3.20 (3.7%) stddev-sans-first:3.38 07:10:16 INFO - PROCESS | 29354 | Values: 86.0 86.0 87.0 84.0 93.0 85.0 85.0 84.0 92.0 85.0 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:117.00 stddev:4.01 (3.4%) stddev-sans-first:4.14 07:10:16 INFO - PROCESS | 29354 | Values: 120.0 118.0 124.0 114.0 116.0 115.0 115.0 113.0 115.0 124.0 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:149.50 stddev:6.71 (4.5%) stddev-sans-first:6.65 07:10:16 INFO - PROCESS | 29354 | Values: 140.0 142.0 149.0 158.0 151.0 138.0 153.0 150.0 148.0 139.0 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - PROCESS | 29354 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 07:10:16 INFO - PROCESS | 29354 | Values: 68.0 68.0 68.0 70.0 67.0 69.0 67.0 66.0 66.0 66.0 07:10:16 INFO - PROCESS | 29354 | -------- Summary: end -------- 07:10:16 INFO - PROCESS | 29354 | 07:10:16 INFO - TEST-INFO | 29354: exit 0 07:10:17 INFO - TEST-OK | kraken | took 60247ms 07:10:17 INFO - TEST-START | v8_7 07:10:17 INFO - operating with platform_type : linux_ 07:10:17 INFO - Initialising browser for v8_7 test... 07:10:17 INFO - TEST-INFO | started process 29606 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDfI_v9/profile http://localhost:35641/getInfo.html) 07:10:22 INFO - PROCESS | 29606 | __metrics Screen width/height:1600/1200 07:10:22 INFO - PROCESS | 29606 | colorDepth:24 07:10:22 INFO - PROCESS | 29606 | Browser inner width/height: 1024/697 07:10:22 INFO - PROCESS | 29606 | __metrics 07:10:22 INFO - PROCESS | 29606 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:10:22 INFO - PROCESS | 29606 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:10:23 INFO - TEST-INFO | 29606: exit 0 07:10:23 INFO - Browser initialized. 07:10:23 INFO - Running cycle 1/1 for v8_7 test... 07:10:23 INFO - TEST-INFO | started process 29687 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDfI_v9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:35 INFO - PROCESS | 29687 | RSS: Main: 149037056 07:10:35 INFO - PROCESS | 29687 | 07:10:58 INFO - PROCESS | 29687 | Cycle 1(1): loaded http://localhost:35641/tests/v8_7/run.html (next: http://localhost:35641/tests/v8_7/run.html) 07:10:58 INFO - PROCESS | 29687 | RSS: Main: 552034304 07:10:58 INFO - PROCESS | 29687 | 07:10:58 INFO - PROCESS | 29687 | __start_tp_report 07:10:58 INFO - PROCESS | 29687 | _x_x_mozilla_page_load 07:10:58 INFO - PROCESS | 29687 | _x_x_mozilla_page_load_details 07:10:58 INFO - PROCESS | 29687 | |i|pagename|runs| 07:10:58 INFO - PROCESS | 29687 | |0;Richards;166.44474034620507 07:10:58 INFO - PROCESS | 29687 | |1;DeltaBlue;190.1863826550019 07:10:58 INFO - PROCESS | 29687 | |2;Encrypt;280.3476310625175 07:10:58 INFO - PROCESS | 29687 | |3;Decrypt;5159.79381443299 07:10:58 INFO - PROCESS | 29687 | |4;RayTrace;1955.078125 07:10:58 INFO - PROCESS | 29687 | |5;Earley;799.3605115907275 07:10:58 INFO - PROCESS | 29687 | |6;Boyer;12195.121951219513 07:10:58 INFO - PROCESS | 29687 | |7;RegExp;42812.5 07:10:58 INFO - PROCESS | 29687 | |8;Splay;576.036866359447 07:10:58 INFO - PROCESS | 29687 | |9;NavierStokes;4845.410628019324 07:10:58 INFO - PROCESS | 29687 | __end_tp_report 07:10:58 INFO - PROCESS | 29687 | __startTimestamp1452265858394__endTimestamp 07:10:58 INFO - PROCESS | 29687 | 07:10:58 INFO - PROCESS | 29687 | ------- Summary: start ------- 07:10:58 INFO - PROCESS | 29687 | Number of tests: 10 07:10:58 INFO - PROCESS | 29687 | 07:10:58 INFO - PROCESS | 29687 | [#0] Richards Cycles:1 Average:166.44 Median:166.44 stddev:0.00 (0.0%) 07:10:58 INFO - PROCESS | 29687 | Values: 166.4 07:10:58 INFO - PROCESS | 29687 | 07:10:58 INFO - PROCESS | 29687 | [#1] DeltaBlue Cycles:1 Average:190.19 Median:190.19 stddev:0.00 (0.0%) 07:10:58 INFO - PROCESS | 29687 | Values: 190.2 07:10:58 INFO - PROCESS | 29687 | 07:10:58 INFO - PROCESS | 29687 | [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 07:10:58 INFO - PROCESS | 29687 | Values: 280.3 07:10:58 INFO - PROCESS | 29687 | 07:10:58 INFO - PROCESS | 29687 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 07:10:58 INFO - PROCESS | 29687 | Values: 5159.8 07:10:58 INFO - PROCESS | 29687 | 07:10:58 INFO - PROCESS | 29687 | [#4] RayTrace Cycles:1 Average:1955.08 Median:1955.08 stddev:0.00 (0.0%) 07:10:58 INFO - PROCESS | 29687 | Values: 1955.1 07:10:58 INFO - PROCESS | 29687 | 07:10:58 INFO - PROCESS | 29687 | [#5] Earley Cycles:1 Average:799.36 Median:799.36 stddev:0.00 (0.0%) 07:10:58 INFO - PROCESS | 29687 | Values: 799.4 07:10:58 INFO - PROCESS | 29687 | 07:10:58 INFO - PROCESS | 29687 | [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 07:10:58 INFO - PROCESS | 29687 | Values: 12195.1 07:10:58 INFO - PROCESS | 29687 | 07:10:58 INFO - PROCESS | 29687 | [#7] RegExp Cycles:1 Average:42812.50 Median:42812.50 stddev:0.00 (0.0%) 07:10:58 INFO - PROCESS | 29687 | Values: 42812.5 07:10:58 INFO - PROCESS | 29687 | 07:10:58 INFO - PROCESS | 29687 | [#8] Splay Cycles:1 Average:576.04 Median:576.04 stddev:0.00 (0.0%) 07:10:58 INFO - PROCESS | 29687 | Values: 576.0 07:10:58 INFO - PROCESS | 29687 | 07:10:58 INFO - PROCESS | 29687 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 07:10:58 INFO - PROCESS | 29687 | Values: 4845.4 07:10:58 INFO - PROCESS | 29687 | -------- Summary: end -------- 07:10:58 INFO - PROCESS | 29687 | 07:10:59 INFO - TEST-INFO | 29687: exit 0 07:10:59 INFO - TEST-OK | v8_7 | took 42286ms 07:10:59 INFO - SUITE-END | took 1217s 07:10:59 INFO - Completed test suite (00:20:17) 07:10:59 INFO - Working with test: dromaeo_css 07:10:59 INFO - Generating results file: dromaeo_css 07:10:59 INFO - Working with test: kraken 07:10:59 INFO - Generating results file: kraken 07:10:59 INFO - javascript benchmark 07:10:59 INFO - Working with test: v8_7 07:10:59 INFO - Generating results file: v8_7 07:10:59 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:10:59 INFO - process_Request line: dromaeo_css 6664.58 graph.html#tests=[[72,1,35]] 07:10:59 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:59 INFO - process_Request line: kraken 1495.10 graph.html#tests=[[232,1,35]] 07:10:59 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:59 INFO - process_Request line: v8_7 18977.12 graph.html#tests=[[230,1,35]] 07:10:59 INFO - RETURN: dromaeo_css: 6664.58 07:10:59 INFO - RETURN: kraken: 1495.10 07:10:59 INFO - RETURN: v8_7: 18977.12 07:10:59 INFO - javascript benchmark 07:10:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3096.2568983443975, 3135.561021456998, 3175.2379428937047, 3176.745860331174, 3183.0291761012895, 5010.824621138261, 5104.489551044893, 5126.077306084903, 5129.358830146227, 5160.096983027969, 5057.974710126444, 5135.152699804537, 5199.558037566811, 5202.167653175483, 5218.39988401334, 4507.571780680846, 4612.8385506507275, 4686.742229177394, 4752.310914917335, 4797.592204662608, 4642.65180111493, 4748.121597504472, 4754.857354279377, 4762.666613337068, 4873.853784386474, 4644.767761611923, 4727.503612120747, 4733.668643194977, 4745.09843129806, 4767.189577771787, 4654.441467023945, 4685.672002959795, 4695.5069717679835, 4711.8350857719815, 4734.171519984024, 4633.62930965522, 4670.743109128996, 4674.088552732219, 4705.388299521041, 4731.621470282369, 4943.802247910079, 5035.144025515671, 5047.369078865142, 5053.090443720129, 5062.443131255559, 5536.889262214773, 5568.387477377485, 5577.107662773978, 5577.637453565505, 5615.634983726086, 5409.323834520685, 5506.972465137689, 5512.366077901052, 5593.580481463907, 5594.636348637367, 5166.483351664803, 5250.947490525045, 5262.421133675292, 5290.65610735301, 5310.9203361949985, 5636.971815140898, 5640.887182256414, 5641.633293835887, 5642.520385767256, 5643.915341269884, 5384.40771515133, 5457.126859702428, 5460.31746031746, 5461.317335333083, 5461.754221060062, 5427.94155139744, 5473.589480788957, 5494.2857428534035, 5568.805091821767, 5621.7751289948765, 5422.864428389243, 5435.347758269033, 5446.046941785172, 5446.591505637093, 5447.428020057916, 5423.267858839006, 5426.728663566806, 5430.782768689208, 5451.427600102012, 5482.533984611353, 4290.141971605692, 4298.634616057608, 4338.956610433918, 4366.585174408426, 4378.211921854033, 3841.769493830379, 3841.8463261469788, 3856.82644281008, 3869.729118961646, 3893.649571538575, 5025.698458092526, 5107.770150343244, 5109.6678715883345, 5113.718745469035, 5150.793968241228, 5429.53848922846, 5545.805896793593, 5572.749226284827, 5595.4124816894455, 5640.351359593617, 5140.717260550631, 5144.125498665236, 5146.073706732824, 5186.948130518646, 5198.350206224222, 4686.695364801277, 4721.315409265637, 4727.149113159596, 4730.787114579852, 4779.474257831635, 5564.387917329091, 5670.262865827416, 5673.489385955201, 5731.5701322400155, 5737.225474560964, 5469.371022332482, 5564.4991950724625, 5567.0, 5568.443155684561, 5617.101263797773, 5725.656460612377, 5728.455796699307, 5729.369769325288, 5731.971340143273, 5734.713264336683, 5350.545203657733, 5442.210879422382, 5448.264484294569, 5463.0, 5467.234587157722, 5546.140348246028, 5570.080936645571, 5572.331320241597, 5606.831795046155, 5640.182173584725, 5413.9729301353245, 5426.403095659553, 5428.56571474289, 5431.83704488866, 5437.157240627709, 5208.114620514598, 5233.058049551118, 5283.313169287968, 5285.524302812765, 5379.273798037371, 5259.710715910662, 5278.604104692086, 5280.762365693477, 5282.524572788314, 5288.3918349390315, 5454.781808727606, 5517.641353312022, 5554.777808887599, 5559.888802223852, 5562.666240025612, 5298.337707786527, 5303.416624171416, 5326.573874090141, 5335.2263921730355, 5347.358317001985], "unit": "score", "name": "dojo.html", "value": 5098.517353280517}, {"lowerIsBetter": false, "replicates": [515.8349328214972, 516.0865268474797, 520.3313741841735, 541.445018855673, 549.4697616799788, 27084.322891927688, 27832.860835695818, 35363.4695479568, 35379.2924141517, 35399.2920141597, 38245.426318605176, 38628.420573691415, 38744.0, 38748.612513874854, 38761.41857872134, 7329.047223860917, 8263.0, 8454.746357609281, 8466.830663386729, 8475.0, 7340.706371745124, 7459.440541959348, 9894.0, 10083.14293285068, 10087.94956025219, 9853.408795472295, 9865.062819032217, 9932.801343973117, 9940.453275069869, 9945.055219754111, 7217.639118044077, 7354.191038985708, 9799.020097990215, 9900.207983361313, 9910.05854443834, 7501.324880760703, 7651.770446886547, 7656.234376562355, 9857.211423086135, 10121.089101980857, 35051.0, 35275.64724352749, 35396.82301588476, 35423.82288088569, 35455.645443545494, 2736.9178924632292, 2926.0929111975356, 2928.941421171586, 3055.4194703006356, 3460.0, 27026.0, 27536.036238731747, 27669.86165069182, 27847.721522784715, 27967.88128474879, 3902.453656488094, 3955.8219880105466, 3966.7210668423477, 3971.4241434992055, 4060.4721386219603, 275729.0, 278601.0, 278788.0, 278894.0, 279073.0, 50089.499105009214, 51117.488825112014, 56519.43480565224, 56958.14562781562, 57333.0, 52922.20616690753, 53210.201846972326, 53258.73370633122, 53437.465625344026, 53446.46553534415, 13183.604491865259, 13383.732325353438, 13399.397027133802, 13408.530701425598, 13426.865731342561, 10163.339382940234, 10283.07452329294, 10320.174386049099, 10323.587056517805, 10323.63867264642, 18437.354692585694, 19052.237910483425, 19251.711224331648, 19256.22975081009, 19283.807161928482, 7272.527285726411, 7297.70809167638, 7351.889721654179, 7402.407807375397, 7476.953226548288, 909.6952520905438, 997.5660587644398, 1002.5839276700087, 1029.325791606499, 1060.5545670818121, 27662.723372766417, 28089.297767555567, 28523.690177825632, 28591.14226573206, 28793.42413151725, 983.9655612053543, 1010.5705075343096, 1042.8070806900596, 1052.3685788526975, 1109.2124591540096, 13051.804222936664, 13742.519011834538, 13850.722985540435, 14862.256887155816, 15113.427802619219, 325273.0, 327182.0, 328801.0, 329313.0, 330479.0, 50406.0, 51401.48598513967, 51421.0, 51439.0, 51472.48527514677, 1185.9525618975144, 1186.6677330347688, 1191.3149938785234, 1306.0726883912528, 1323.8676132386684, 22051.558968820213, 28716.71283287224, 28883.422331552832, 28963.0, 29436.0, 49135.75432122959, 49860.501394985586, 49877.25184122168, 49900.75049624729, 49917.500824991286, 271758.0, 275602.0, 304547.0, 306167.0, 307532.0, 29081.85459072691, 29122.56316155217, 29142.41715165727, 29437.26406839846, 29459.55810662799, 40333.1933361337, 43506.0, 43580.56419435765, 44402.11195776002, 44566.55433445624, 34838.47742283918, 35813.1046723834, 35988.28023439569, 36398.27203455969, 36627.816860915525, 31969.520457193626, 32533.674663254013, 32680.83659581687, 34497.48253776246, 35706.0, 31500.133701755298, 31855.522167167976, 32271.193220169684, 32365.0, 32430.35139297248, 28075.298117547223, 29081.709182908748, 29959.0981644056, 30207.819514407314, 31746.0, 22466.213682521033, 23200.88399558059, 23366.0, 23403.76596234084, 23565.764342356357], "unit": "score", "name": "ext.html", "value": 17660.631384857606}, {"lowerIsBetter": false, "replicates": [347.91476088358354, 354.18537364062655, 357.6387848273244, 358.7650089191577, 359.5146552154592, 13520.188788672662, 13845.169289842592, 15845.683086338266, 15944.36222551098, 16747.4138405156, 9427.48148851813, 9675.371100878438, 9693.806123877519, 13676.726465470685, 14140.434382624682, 4871.12319782439, 5024.321716568253, 5032.345795046657, 5033.823816166435, 5175.508326708976, 3755.4742336072973, 3877.2827026999953, 5332.973335133338, 5370.140777475604, 5542.473465020817, 5329.0, 5494.36814766301, 5509.47659972302, 5536.612437129403, 5540.529055030307, 5508.531774799147, 5523.337199536081, 5527.889442211173, 5542.75057622408, 5552.833414997536, 4996.825111121129, 5179.8446046618665, 5187.118189907725, 5321.893562128775, 5332.200169974535, 18099.185536650883, 18187.54531136719, 18228.179731912096, 18440.63118737631, 18517.537061573435, 2085.092984551725, 2099.8005189507126, 2114.8731076135327, 2140.8501404901663, 2217.733871935362, 9232.215261702697, 9744.0, 9837.85243221345, 10556.683299501028, 12311.138220324581, 1718.7937447506254, 1818.3181307009872, 1834.6972749496317, 1867.7105048717472, 1916.2718167096552, 55663.0, 56267.718661406434, 57561.42438575603, 57876.71061644707, 58162.0, 9972.700818975442, 9973.152282056106, 10037.297389182833, 10070.395776253448, 10140.797184056277, 13173.40719667598, 13289.867101329057, 13296.468141274434, 13309.866901330863, 13333.733325333633, 6845.760398386033, 6859.897101543481, 6892.896606550906, 6966.268541803139, 7056.717731290793, 6435.967820160963, 6452.064450654629, 6523.7064332105165, 6588.4729221662155, 6599.571027883172, 4364.650827933758, 4423.0, 4425.203463376623, 4451.888702782457, 4462.219111655448, 1678.8237235090385, 1741.0772290685957, 1769.4780039888265, 1853.2123847364817, 1866.9346572869883, 898.6180873128894, 938.9765255868522, 956.7426988697154, 956.8373376526007, 1004.4927311707687, 13499.460021599027, 16425.58936026585, 16439.753403698953, 16452.917735411247, 16761.0, 862.3489265604428, 900.1718419054486, 906.1255888068046, 963.3834346018554, 974.5760594141572, 8967.775805604912, 9246.212140072332, 9423.764405889771, 9433.716988490356, 9597.856032159523, 478915.0, 488607.0, 497169.71227158105, 532246.0, 534219.0, 40080.19839603192, 47122.5287747125, 50312.49687503078, 69720.65139674269, 71106.64446677733, 1081.5944020992129, 1084.4577711144427, 1089.9509522071526, 1104.8508451359126, 1112.554978008803, 14333.65627590627, 14519.34662940149, 14629.0, 14792.48226312117, 14865.108093514424, 31102.844485777427, 31704.841475792473, 31973.0, 31981.68018319787, 32604.51093233556, 39514.40728389019, 39678.801605991786, 41138.0, 41147.38278925879, 41303.1739365205, 6893.724251030103, 7222.241664625349, 7280.344768970818, 7286.526375785557, 7413.1104267488245, 10132.645357412455, 10891.0, 11338.376389298668, 11383.943080284545, 11493.885061149616, 9250.861237081315, 9543.12489384851, 9651.324407291422, 9732.318737688294, 9791.902080979098, 3060.234941264684, 3724.3296206681975, 9136.172765446805, 9662.516874156405, 10082.495875206358, 9051.411658242194, 9276.860847087433, 9540.0, 9694.46680432583, 9810.950945245228, 7373.594452305175, 7421.628918553943, 7559.886601701089, 7564.319211271012, 7647.770566883002, 9124.680636177702, 9252.629894804133, 9285.953570232106, 9308.95345523268, 9352.0], "unit": "score", "name": "jquery.html", "value": 7794.882706416804}, {"lowerIsBetter": false, "replicates": [1176.8234764785275, 1418.6949805791755, 1430.6852492451658, 1579.6998570271649, 1752.4742577226837, 6985.40624046956, 7575.204603516634, 7738.8452230955345, 7748.61256937153, 7749.341305988984, 7461.962690186541, 7621.771346859603, 7646.732364367248, 7647.197044310351, 7647.732329368473, 2301.229088255432, 2320.2575175943703, 2329.755375685554, 2332.0438620165737, 2332.1487657005155, 2266.1841736974675, 2305.8270629702756, 2308.8730119843403, 2311.191083120911, 2324.9070037198576, 2250.5386395788905, 2254.9774502255013, 2260.7513173550897, 2276.692646492727, 2286.8856557172076, 2193.1885202475028, 2276.8975396107217, 2278.4759505313787, 2281.7718228177214, 2283.8401311908174, 2266.626006708891, 2272.0684519347155, 2274.431392151962, 2274.579202847462, 2275.0899640143907, 6648.202215734094, 6790.0, 7781.844363112706, 7826.1391246962785, 7840.09838868526, 4037.0, 4135.1316223592785, 4138.089620283533, 4439.378487011821, 4527.705699129546, 2922.298648324408, 2987.910362689123, 3043.360894212196, 3051.2982014136874, 3062.1119875236154, 928.2110206324637, 942.9717108486687, 952.6618050592009, 954.9331546791727, 998.3427510332886, 10500.579976800918, 10621.787564248672, 10636.680899572948, 10642.57429702811, 10642.680719578426, 4387.824487020547, 4397.2304846651705, 4438.889027774267, 4463.553644635511, 4505.797239124247, 9383.577739001761, 9396.577154028086, 9423.575939082757, 9425.528723563795, 9433.481158536346, 4689.109069276827, 4690.695104818176, 4695.9530404695515, 4696.647751418657, 4702.623790096784, 4184.14225083857, 4218.894527636834, 4219.261629214875, 4222.936655950163, 4226.323788193936, 3542.6457354264367, 3610.2598967211657, 3641.5812181598926, 3655.1593133579427, 3657.469666898338, 1130.988690113105, 1165.2717051842599, 1166.6091859227083, 1168.6377223060879, 1181.8286348479423, 1055.9419231942318, 1093.9015488606065, 1094.9124070074374, 1232.6363722701824, 1342.6374878782674, 7441.330280274801, 7592.0, 7599.848003039909, 7610.505317154367, 7639.465237433437, 495.57628227864654, 502.0536289095009, 509.6839959225304, 515.6699712184205, 516.3029909622055, 5158.484151584811, 5603.971980140073, 5669.291338582677, 5674.460926212003, 5681.147827825859, 8725.21473067427, 8729.127087291221, 8741.868871966926, 8842.77893052666, 8861.025287218401, 8574.984878553534, 8622.223999839918, 8663.960324760943, 8704.477731336141, 8715.346349023848, 7326.157491888394, 7373.77878663641, 7419.332260096618, 7436.888446673304, 7461.209309765617, 7016.7544135954995, 7067.045948797052, 7169.749058782918, 7175.46184036189, 7176.102987126609, 8395.95802020986, 8507.95746021266, 8530.872036919576, 8681.305495560466, 8763.211310982042, 8685.0, 8929.73210803677, 8952.731418057469, 9017.413868098552, 9096.681616143404, 6979.441644668313, 7017.96491017562, 7031.6835742390695, 7046.788596342118, 7063.505554611128, 7189.676464559212, 7340.853182936418, 7567.508111972704, 7635.083789945242, 7648.73229436967, 6886.552374095668, 6969.54697944632, 6970.477214208853, 7019.4033507150425, 7072.611006394698, 6769.08617336673, 6773.559718618274, 6786.355296246848, 6850.246472887879, 7038.964805175941, 6920.446364290945, 6981.581105133709, 6989.37095661393, 6992.79021629352, 6993.615351155735, 6386.489080873612, 6472.482201423969, 6631.867362652816, 6656.2345330287635, 6658.467322614082, 6497.9025314619375, 6500.3174666659315, 6566.0479230510355, 6572.572782769104, 6585.0], "unit": "score", "name": "mootools.html", "value": 4355.900845136678}, {"lowerIsBetter": false, "replicates": [327.89507357645556, 333.66466700965526, 340.63041599864175, 342.7652058340037, 347.730508855637, 5815.255423372987, 5899.85250368741, 5920.0, 5933.851653708649, 5951.553633477496, 5572.693501857407, 5692.943070569293, 5764.51001664859, 5827.067669172933, 5836.095405212199, 4553.430821147356, 4573.7713114344315, 4577.656675749316, 4583.1062942726185, 4591.0, 4521.660875434339, 4568.977155114219, 4574.656900732459, 4576.885577860564, 4594.402727645418, 4320.611144996949, 4379.386885835986, 4384.7149935254265, 4397.802098905541, 4479.731216127043, 4449.28811390176, 4461.397711308964, 4461.620762235214, 4471.441069866267, 4482.17079840229, 3954.209158168349, 3955.070558418798, 3965.920681586352, 3992.540857801361, 4036.2331157080353, 5585.609007369486, 5598.524125449342, 5598.832035038955, 5614.775408983635, 5616.073347897633, 5174.3790745110455, 5224.268602395668, 5286.101362768339, 5291.576673866081, 5294.735263236861, 6195.7521699131985, 6200.131981522591, 6202.224721909762, 6215.192025036717, 6228.906566401508, 4441.644668426518, 4445.644348452149, 4447.466304043503, 4447.666425018104, 4452.9554704453185, 6250.124982502453, 6402.455791257748, 6475.320091390383, 6484.708188131545, 6504.674766261715, 4404.317330813729, 4426.756528390905, 4427.867163985085, 4427.933580996288, 4437.755923424243, 4466.0, 4478.216312145361, 4480.529544397791, 4482.686211965196, 4487.102579484116, 5157.535821776059, 5200.063988482109, 5202.505761952609, 5203.947960520422, 5206.687598744087, 6120.7551697931585, 6207.441330280206, 6278.560500764903, 6281.277653069864, 6286.18279623646, 1564.1788061267926, 1578.8894777365704, 1580.4389441748244, 1580.6127498762876, 1582.185174635064, 1010.8938561451089, 1032.509557959963, 1042.3641578637025, 1046.3721766939927, 1061.4851796878509, 5929.762809487658, 5934.732937017845, 5942.524598032147, 5944.316403613553, 5948.286205655262, 6348.365163483707, 6400.839979000562, 6410.1987251593555, 6412.134361861183, 6429.0, 5745.052066409079, 5835.066389377764, 5871.941280587225, 5922.674252916045, 5947.821565353046, 3465.4108801503803, 3467.4452087665854, 3479.3563190809273, 3480.8781692640637, 3487.738419618488, 6749.223839258548, 6759.898601520981, 6762.391384775394, 6768.492363072789, 6769.120014398097, 6493.058506516529, 6562.278149403562, 6618.900716489256, 6619.404253617101, 6620.437262832616, 6732.427743641747, 6734.326567343226, 6742.426893713991, 6744.0558321834005, 6758.831029224309, 6449.580777249464, 6460.741570337322, 6465.094886715958, 6465.935340646533, 6470.514711396759, 6265.342139075331, 6346.048092786119, 6355.650439225887, 6383.638053920079, 6395.6482393468805, 6729.99050142463, 6730.798076057726, 6734.3602357775935, 6741.0, 6747.392734653708, 4447.977760111179, 4451.6661250407, 4454.0, 4455.1980643484485, 4456.353828694886, 6265.686715664289, 6413.390727880844, 6481.708323125376, 6482.708278127401, 6490.902636460552, 6340.873182536416, 6341.239051313872, 6348.111264422892, 6359.523035772243, 6369.585976911486, 6338.144350512622, 6342.365763423805, 6343.080253363144, 6344.619322840645, 6353.078803573549, 6096.268447786294, 6222.315545289924, 6228.190335256388, 6237.220347456568, 6241.188645476059, 6331.778387756406, 6349.619022858643, 6352.745890164341, 6360.936390636034, 6364.172657554674, 6208.1308616792785, 6208.441240288395, 6211.503079753699, 6212.471939884979, 6220.377962203925], "unit": "score", "name": "prototype.html", "value": 4723.062166587844}, {"lowerIsBetter": false, "replicates": [746.8917007033976, 792.1484404265412, 807.4428644235477, 816.2001238785989, 818.6070686070686, 12876.935615321921, 13338.266395348277, 13345.399457024445, 13346.399412026458, 13359.19844809311, 10634.096101831334, 12300.38498075097, 12317.260964342146, 12333.629991100259, 12370.319632420213, 621.4251817069215, 753.581762122022, 758.9620518974057, 761.090496856257, 765.4641750774452, 757.3827330725442, 758.4198088462331, 763.8892360607708, 766.0615745711486, 767.3247542162917, 655.5312951239863, 657.1030543308398, 802.8675268580677, 804.4409135650725, 807.7778610881995, 805.7341077444429, 822.6709316273478, 822.8066404394963, 823.259066839843, 824.4023083264615, 589.2604780999818, 590.583638534832, 590.630855715178, 591.0248090650418, 592.4253474130087, 12145.574904878287, 12188.695282617917, 12203.511859525608, 12211.93894030533, 12219.511219551207, 10258.384496930208, 10655.151905882805, 11146.108311335074, 11203.439828008648, 11266.324020558794, 10446.373217606968, 10533.578656853717, 10588.576456941713, 10698.625548105856, 11110.666679999533, 3332.683395077464, 3575.3743094958277, 3584.8566057357675, 3591.676749092568, 3699.8705045323554, 45527.0, 45548.77225613851, 45909.31136032962, 46326.53673463256, 46539.30191047171, 9821.066998635119, 10014.54934527948, 10238.53926573306, 10251.7437064074, 10293.94853025745, 17086.40197593078, 17172.141392930553, 17177.227024783915, 17182.484525464257, 17182.828171718375, 7589.172528646997, 7629.465937384441, 7640.885386719204, 7827.334676552443, 7860.528368297921, 4306.074194048295, 4363.912721745611, 4406.162829062468, 4462.308342206963, 4498.5501449854755, 2783.6520434945633, 2812.578113283024, 2821.195959151673, 2829.0522674904137, 2835.4754370441533, 514.6268955007589, 525.8816766227568, 530.3105962249061, 553.8393865778879, 555.081340381669, 522.8588281164141, 552.809280798124, 581.9301683797971, 613.2763339259716, 667.5827607745159, 8395.454295470774, 8730.214280714767, 8743.519106449206, 8877.24297342803, 8916.37585369031, 526.8199233716448, 553.0929275987384, 593.6972144206486, 640.0111827226946, 701.1551080947446, 3864.246471937945, 3930.744501607386, 3987.322155233617, 4027.8993025174605, 4102.610252026053, 48654.02691946212, 48896.75551622219, 49216.753916230904, 52732.0, 52867.0, 42976.78511607422, 43202.35196471993, 43354.34968475475, 43456.0, 43804.78097609492, 43676.781616091714, 43914.12171756611, 43991.56008439939, 44580.3312950306, 44608.3308750369, 8217.260446559838, 8393.538355390512, 8707.738767836974, 8922.189510304233, 9040.276777857624, 30753.231169220948, 32673.0, 33864.15339616529, 33929.49105763366, 34525.827370862986, 41648.0, 43303.566964329955, 44108.33837492376, 44257.33613995728, 44284.11431771411, 10063.547140378847, 10183.388996660224, 10278.588856445658, 10407.739806504898, 10922.617708380169, 11715.648530544097, 11859.135445538492, 11949.283043017447, 12402.5659101931, 12483.12618116723, 11676.824847627462, 11929.463174157358, 12008.459619316976, 12153.210041347284, 12645.430955607204, 11639.825402618799, 11838.704032399259, 11919.880801191877, 11998.220115692453, 12396.194247373893, 11023.44882755843, 11932.76134477323, 12143.696407589881, 12155.939220303842, 12163.331016794162, 9428.15146636806, 9552.23582113443, 9574.617015319309, 9605.934724034367, 9919.40483570988, 8836.734897953073, 9152.808564356937, 9464.337496375188, 9788.608455661693, 9901.752456188653], "unit": "score", "name": "yui.html", "value": 6067.9016374477715}], "name": "dromaeo_css", "value": 6664.582288665512}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 110.0, 110.0, 111.0, 100.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [148.0, 123.0, 154.0, 162.0, 123.0, 162.0, 147.0, 127.0, 161.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 160.0, 160.0, 162.0, 159.0, 163.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 85.0, 93.0, 70.0, 71.0, 72.0, 98.0, 98.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 140.0, 96.0, 96.0, 96.0, 141.0, 95.0, 97.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 147.0, 146.0, 147.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 55.0, 55.0, 55.0, 55.0, 63.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 68.0, 67.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 87.0, 84.0, 93.0, 85.0, 85.0, 84.0, 92.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [120.0, 118.0, 124.0, 114.0, 116.0, 115.0, 115.0, 113.0, 115.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.4}, {"lowerIsBetter": true, "replicates": [140.0, 142.0, 149.0, 158.0, 151.0, 138.0, 153.0, 150.0, 148.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 70.0, 67.0, 69.0, 67.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1495.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.44474034620507], "unit": "score", "name": "Richards", "value": 212.09441600000005}, {"lowerIsBetter": false, "replicates": [190.1863826550019], "unit": "score", "name": "DeltaBlue", "value": 347.648444}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1955.078125], "unit": "score", "name": "RayTrace", "value": 378.49587212787225}, {"lowerIsBetter": false, "replicates": [799.3605115907275], "unit": "score", "name": "Earley", "value": 833.7452129999997}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [42812.5], "unit": "score", "name": "RegExp", "value": 21.278481751824803}, {"lowerIsBetter": false, "replicates": [576.036866359447], "unit": "score", "name": "Splay", "value": 141.46837599999995}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 18977.123246138774}]} 07:10:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18977.12"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1495.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6664.58"}}} 07:10:59 INFO - Return code: 0 07:10:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:10:59 INFO - # TBPL SUCCESS # 07:10:59 INFO - Running post-action listener: _resource_record_post_action 07:10:59 INFO - Running post-run listener: _resource_record_post_run 07:11:00 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 8192; Write bytes: 557223936; Read time: 784; Write time: 1102764 07:11:00 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 239665152; Read time: 0; Write time: 523228 07:11:00 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 317558784; Read time: 784; Write time: 579536 07:11:00 INFO - Running post-run listener: _upload_blobber_files 07:11:00 INFO - Blob upload gear active. 07:11:00 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:11:00 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:11:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:11:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:11:01 INFO - (blobuploader) - INFO - Open directory for files ... 07:11:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:11:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:11:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:02 INFO - (blobuploader) - INFO - Done attempting. 07:11:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:11:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:11:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:04 INFO - (blobuploader) - INFO - Done attempting. 07:11:04 INFO - (blobuploader) - INFO - Iteration through files over. 07:11:04 INFO - Return code: 0 07:11:04 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:11:04 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:11:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eee14b47c68c597b4207529a64d9695ba3d062a2a64493accbba417319642ddd1fe74c22c063b82c95639660e2c7a8df91cb148be0fa611cc5a615db8da63a53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0308a32574f4bc2f1fee8caba6b59e4559ee6735d5c098f35444d4e9b99980b6372c3194956b069b2550a23fe9e550ffd4950ac9d0e029983d57fb83feaabb21"} 07:11:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:11:04 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:11:04 INFO - Contents: 07:11:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eee14b47c68c597b4207529a64d9695ba3d062a2a64493accbba417319642ddd1fe74c22c063b82c95639660e2c7a8df91cb148be0fa611cc5a615db8da63a53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0308a32574f4bc2f1fee8caba6b59e4559ee6735d5c098f35444d4e9b99980b6372c3194956b069b2550a23fe9e550ffd4950ac9d0e029983d57fb83feaabb21"} 07:11:04 INFO - Copying logs to upload dir... 07:11:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.916424 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-08 07:11:04.213091) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 07:11:04.221328) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eee14b47c68c597b4207529a64d9695ba3d062a2a64493accbba417319642ddd1fe74c22c063b82c95639660e2c7a8df91cb148be0fa611cc5a615db8da63a53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0308a32574f4bc2f1fee8caba6b59e4559ee6735d5c098f35444d4e9b99980b6372c3194956b069b2550a23fe9e550ffd4950ac9d0e029983d57fb83feaabb21"} build_url:https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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/Firefox/sha512/eee14b47c68c597b4207529a64d9695ba3d062a2a64493accbba417319642ddd1fe74c22c063b82c95639660e2c7a8df91cb148be0fa611cc5a615db8da63a53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0308a32574f4bc2f1fee8caba6b59e4559ee6735d5c098f35444d4e9b99980b6372c3194956b069b2550a23fe9e550ffd4950ac9d0e029983d57fb83feaabb21"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 07:11:04.252199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 07:11:04.252596) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452264588.404171-771258612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 07:11:04.335295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 07:11:04.335666) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 07:11:04.337698) ========= ========= Total master_lag: 0.26 =========