builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1451383969.58 results: success (0) buildid: 20151228233005 builduid: cb27e85a244b4b6281959fbdb91a5e94 revision: 83cb1c2445fa081a67d379d975557afd56bf4979 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:49.583983) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:49.584510) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:49.584821) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006484 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:49.619881) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:49.620186) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:49.660559) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:49.660819) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014570 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:49.709337) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:49.709676) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:49.710090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:49.710373) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 02:12:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.0M=0s 2015-12-29 02:12:50 (32.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174171 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:49.902643) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:49.902929) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.143284 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:50.056167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:50.056532) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 83cb1c2445fa081a67d379d975557afd56bf4979 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 83cb1c2445fa081a67d379d975557afd56bf4979 --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=a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 02:12:50,428 truncating revision to first 12 chars 2015-12-29 02:12:50,428 Setting DEBUG logging. 2015-12-29 02:12:50,428 attempt 1/10 2015-12-29 02:12:50,428 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/83cb1c2445fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 02:12:50,772 unpacking tar archive at: fx-team-83cb1c2445fa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600795 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:50.669966) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:50.670301) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:50.679986) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:50.680271) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 02:12:50.680692) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-29 02:12:50.680990) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:12:51 INFO - MultiFileLogger online at 20151229 02:12:51 in /builds/slave/test-pgo 02:12:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:12:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:12:51 INFO - {'append_to_log': False, 02:12:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:12:51 INFO - 'blob_upload_branch': 'Fx-Team', 02:12:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:12:51 INFO - 'branch': 'Fx-Team', 02:12:51 INFO - 'buildbot_json_path': 'buildprops.json', 02:12:51 INFO - 'config_files': ('talos/linux_config.py',), 02:12:51 INFO - 'default_actions': ('clobber', 02:12:51 INFO - 'read-buildbot-config', 02:12:51 INFO - 'download-and-extract', 02:12:51 INFO - 'populate-webroot', 02:12:51 INFO - 'create-virtualenv', 02:12:51 INFO - 'install', 02:12:51 INFO - 'run-tests'), 02:12:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:12:51 INFO - 'download_minidump_stackwalk': True, 02:12:51 INFO - 'download_symbols': 'ondemand', 02:12:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:12:51 INFO - 'tooltool.py': '/tools/tooltool.py', 02:12:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:12:51 INFO - '/tools/misc-python/virtualenv.py')}, 02:12:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:12:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:12:51 INFO - 'installer_path': 'installer.exe', 02:12:51 INFO - 'log_level': 'info', 02:12:51 INFO - 'log_name': 'talos', 02:12:51 INFO - 'log_to_console': True, 02:12:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:12:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:12:51 INFO - 'opt_config_files': (), 02:12:51 INFO - 'pip_index': False, 02:12:51 INFO - 'sps_profile': False, 02:12:51 INFO - 'sps_profile_interval': 0, 02:12:51 INFO - 'suite': 'dromaeojs', 02:12:51 INFO - 'system_bits': '32', 02:12:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:12:51 INFO - 'title': 'talos-linux64-ix-009', 02:12:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:12:51 INFO - 'use_talos_json': True, 02:12:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:12:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:12:51 INFO - 'work_dir': 'build'} 02:12:51 INFO - ##### 02:12:51 INFO - ##### Running clobber step. 02:12:51 INFO - ##### 02:12:51 INFO - Running pre-action listener: _resource_record_pre_action 02:12:51 INFO - Running main action method: clobber 02:12:51 INFO - rmtree: /builds/slave/test-pgo/build 02:12:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:12:52 INFO - Running post-action listener: _resource_record_post_action 02:12:52 INFO - ##### 02:12:52 INFO - ##### Running read-buildbot-config step. 02:12:52 INFO - ##### 02:12:52 INFO - Running pre-action listener: _resource_record_pre_action 02:12:52 INFO - Running main action method: read_buildbot_config 02:12:52 INFO - Using buildbot properties: 02:12:52 INFO - { 02:12:52 INFO - "project": "", 02:12:52 INFO - "product": "firefox", 02:12:52 INFO - "script_repo_revision": "production", 02:12:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:12:52 INFO - "repository": "", 02:12:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:12:52 INFO - "buildid": "20151228233005", 02:12:52 INFO - "pgo_build": "True", 02:12:52 INFO - "basedir": "/builds/slave/test-pgo", 02:12:52 INFO - "buildnumber": 560, 02:12:52 INFO - "slavename": "talos-linux64-ix-009", 02:12:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:12:52 INFO - "platform": "ubuntu64_hw", 02:12:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:12:52 INFO - "branch": "fx-team", 02:12:52 INFO - "repo_path": "integration/fx-team", 02:12:52 INFO - "revision": "83cb1c2445fa081a67d379d975557afd56bf4979", 02:12:52 INFO - "stage_platform": "linux64-pgo", 02:12:52 INFO - "builduid": "cb27e85a244b4b6281959fbdb91a5e94", 02:12:52 INFO - "slavebuilddir": "test" 02:12:52 INFO - } 02:12:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:12:52 INFO - Running post-action listener: _resource_record_post_action 02:12:52 INFO - ##### 02:12:52 INFO - ##### Running download-and-extract step. 02:12:52 INFO - ##### 02:12:52 INFO - Running pre-action listener: _resource_record_pre_action 02:12:52 INFO - Running main action method: download_and_extract 02:12:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:12: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')]} 02:12:52 INFO - https://queue.taskcluster.net/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:12:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/test_packages.json 02:12:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/test_packages.json 02:12:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:12:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:12:53 INFO - Downloaded 1302 bytes. 02:12:53 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:12:53 INFO - Using the following test package requirements: 02:12:53 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:12:53 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:12:53 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:53 INFO - u'jsshell-linux-x86_64.zip'], 02:12:53 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:12:53 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:12:53 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:12:53 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:12:53 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:12:53 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:12:53 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:12:53 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:53 INFO - https://queue.taskcluster.net/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:12:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:12:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:12:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/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 02:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/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 02:12:54 INFO - Downloaded 23191592 bytes. 02:12:54 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 02:12:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:12:54 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 02:12:55 INFO - Return code: 0 02:12: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 02:12: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')]} 02:12:55 INFO - https://queue.taskcluster.net/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:12:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:12:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:12:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/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 02:12:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/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 02:12:58 INFO - Downloaded 23191592 bytes. 02:12:58 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 02:12:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:12:58 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 02:12:59 INFO - Return code: 0 02:12:59 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')]} 02:12:59 INFO - https://queue.taskcluster.net/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:12:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:12:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:12:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/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 02:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/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 02:13:00 INFO - Downloaded 11132270 bytes. 02:13:00 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 02:13:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:13:00 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 02:13:00 INFO - Return code: 0 02:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:00 INFO - https://queue.taskcluster.net/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:13:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:13:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:13:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/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 02:13:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fScOmPmgRNCS4B4gUrSpQw/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 02:13:01 INFO - Downloaded 54892176 bytes. 02:13:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:13:01 INFO - mkdir: /builds/slave/test-pgo/properties 02:13:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:13:01 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:13:01 INFO - Contents: 02:13:01 INFO - build_url:https://queue.taskcluster.net/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:13:01 INFO - Running post-action listener: _resource_record_post_action 02:13:01 INFO - Running post-action listener: set_extra_try_arguments 02:13:01 INFO - ##### 02:13:01 INFO - ##### Running populate-webroot step. 02:13:01 INFO - ##### 02:13:01 INFO - Running pre-action listener: _resource_record_pre_action 02:13:01 INFO - Running main action method: populate_webroot 02:13:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:13:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:13:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:13:01 INFO - '--tppagecycles', 02:13:01 INFO - '7'], 02:13:01 INFO - 'tests': ['tsvgm']}}, 02:13:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:13:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:13:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:13:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:13:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:13:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:13:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:01 INFO - 'talos_options': ['--e10s'], 02:13:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:01 INFO - 'tests': ['damp', 'tps']}, 02:13:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:01 INFO - 'talos_options': ['--e10s'], 02:13:01 INFO - 'tests': ['damp', 'tps']}, 02:13:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:13:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:13:01 INFO - 'other': {'tests': ['a11yr', 02:13:01 INFO - 'ts_paint', 02:13:01 INFO - 'tpaint', 02:13:01 INFO - 'sessionrestore', 02:13:01 INFO - 'sessionrestore_no_auto_restore']}, 02:13:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:13:01 INFO - 'tests': ['a11yr', 02:13:01 INFO - 'ts_paint', 02:13:01 INFO - 'tpaint', 02:13:01 INFO - 'sessionrestore', 02:13:01 INFO - 'sessionrestore_no_auto_restore']}, 02:13:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:13:01 INFO - 'tests': ['a11yr', 02:13:01 INFO - 'ts_paint', 02:13:01 INFO - 'tpaint', 02:13:01 INFO - 'sessionrestore', 02:13:01 INFO - 'sessionrestore_no_auto_restore']}, 02:13:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:13:01 INFO - 'tests': ['a11yr', 02:13:01 INFO - 'ts_paint', 02:13:01 INFO - 'tpaint', 02:13:01 INFO - 'sessionrestore', 02:13:01 INFO - 'sessionrestore_no_auto_restore']}, 02:13:01 INFO - 'other_l64': {'tests': ['a11yr', 02:13:01 INFO - 'ts_paint', 02:13:01 INFO - 'tpaint', 02:13:01 INFO - 'sessionrestore', 02:13:01 INFO - 'sessionrestore_no_auto_restore']}, 02:13:01 INFO - 'other_nol64': {'tests': ['a11yr', 02:13:01 INFO - 'ts_paint', 02:13:01 INFO - 'tpaint', 02:13:01 INFO - 'sessionrestore', 02:13:01 INFO - 'sessionrestore_no_auto_restore']}, 02:13:01 INFO - 'svgr': {'tests': ['tsvgx', 02:13:01 INFO - 'tsvgr_opacity', 02:13:01 INFO - 'tart', 02:13:01 INFO - 'tscrollx', 02:13:01 INFO - 'cart']}, 02:13:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:13:01 INFO - 'tests': ['tsvgx', 02:13:01 INFO - 'tsvgr_opacity', 02:13:01 INFO - 'tart', 02:13:01 INFO - 'tscrollx', 02:13:01 INFO - 'cart']}, 02:13:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:01 INFO - 'tests': ['tp5o']}, 02:13:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:01 INFO - 'talos_options': ['--e10s'], 02:13:01 INFO - 'tests': ['tp5o']}, 02:13:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:01 INFO - 'talos_options': ['--xperf_path', 02:13:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:01 INFO - 'tests': ['tp5n']}, 02:13:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:01 INFO - 'talos_options': ['--e10s', 02:13:01 INFO - '--xperf_path', 02:13:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:01 INFO - 'tests': ['tp5n']}}, 02:13:01 INFO - 'talos.zip': {'path': '', 02:13:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:13:01 INFO - Running post-action listener: _resource_record_post_action 02:13:01 INFO - ##### 02:13:01 INFO - ##### Running create-virtualenv step. 02:13:01 INFO - ##### 02:13:01 INFO - Running pre-action listener: _resource_record_pre_action 02:13:01 INFO - Running main action method: create_virtualenv 02:13:01 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:13:01 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 02:13:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:13:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:13:02 INFO - Using real prefix '/usr' 02:13:02 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:13:02 INFO - Installing distribute.............................................................................................................................................................................................done. 02:13:04 INFO - Installing pip.................done. 02:13:04 INFO - Return code: 0 02:13:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:04 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 0x7fd205a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2636630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7840>, '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 0x26346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634b60>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', '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 02:13:04 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 02:13:04 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 02:13:04 INFO - Using env: {'DISPLAY': ':0', 02:13:04 INFO - 'HOME': '/home/cltbld', 02:13:04 INFO - 'LANG': 'en_US.UTF-8', 02:13:04 INFO - 'LANGUAGE': 'en_US:en', 02:13:04 INFO - 'LOGNAME': 'cltbld', 02:13:04 INFO - 'MAIL': '/var/mail/cltbld', 02:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:04 INFO - 'MOZ_NO_REMOTE': '1', 02:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:04 INFO - 'NO_EM_RESTART': '1', 02:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:13:04 INFO - 'PWD': '/builds/slave/test-pgo', 02:13:04 INFO - 'SHELL': '/bin/bash', 02:13:04 INFO - 'SHLVL': '1', 02:13:04 INFO - 'TERM': 'linux', 02:13:04 INFO - 'TMOUT': '86400', 02:13:04 INFO - 'USER': 'cltbld', 02:13:04 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', 02:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:04 INFO - '_': '/tools/buildbot/bin/python'} 02:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:04 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 02:13:04 INFO - Cleaning up... 02:13:04 INFO - Return code: 0 02:13:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:04 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 0x7fd205a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2636630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7840>, '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 0x26346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634b60>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', '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 02:13:04 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 02:13:04 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 02:13:04 INFO - Using env: {'DISPLAY': ':0', 02:13:04 INFO - 'HOME': '/home/cltbld', 02:13:04 INFO - 'LANG': 'en_US.UTF-8', 02:13:04 INFO - 'LANGUAGE': 'en_US:en', 02:13:04 INFO - 'LOGNAME': 'cltbld', 02:13:04 INFO - 'MAIL': '/var/mail/cltbld', 02:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:04 INFO - 'MOZ_NO_REMOTE': '1', 02:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:04 INFO - 'NO_EM_RESTART': '1', 02:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:13:04 INFO - 'PWD': '/builds/slave/test-pgo', 02:13:04 INFO - 'SHELL': '/bin/bash', 02:13:04 INFO - 'SHLVL': '1', 02:13:04 INFO - 'TERM': 'linux', 02:13:04 INFO - 'TMOUT': '86400', 02:13:04 INFO - 'USER': 'cltbld', 02:13:04 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', 02:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:04 INFO - '_': '/tools/buildbot/bin/python'} 02:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:04 INFO - Downloading/unpacking psutil>=0.7.1 02:13:04 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 02:13:04 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 02:13:04 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 02:13:04 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 02:13:04 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 02:13:04 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 02:13:06 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 02:13:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:13:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:13:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:06 INFO - Installing collected packages: psutil 02:13:06 INFO - Running setup.py install for psutil 02:13:06 INFO - building 'psutil._psutil_linux' extension 02:13:06 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 02:13: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:13:07 INFO - building 'psutil._psutil_posix' extension 02:13:07 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 02:13:07 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 02:13:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:07 INFO - Successfully installed psutil 02:13:07 INFO - Cleaning up... 02:13:07 INFO - Return code: 0 02:13:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fd205a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2636630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7840>, '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 0x26346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634b60>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', '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 02:13:07 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 02:13:07 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 02:13:07 INFO - Using env: {'DISPLAY': ':0', 02:13:07 INFO - 'HOME': '/home/cltbld', 02:13:07 INFO - 'LANG': 'en_US.UTF-8', 02:13:07 INFO - 'LANGUAGE': 'en_US:en', 02:13:07 INFO - 'LOGNAME': 'cltbld', 02:13:07 INFO - 'MAIL': '/var/mail/cltbld', 02:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:07 INFO - 'MOZ_NO_REMOTE': '1', 02:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:07 INFO - 'NO_EM_RESTART': '1', 02:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:13:07 INFO - 'PWD': '/builds/slave/test-pgo', 02:13:07 INFO - 'SHELL': '/bin/bash', 02:13:07 INFO - 'SHLVL': '1', 02:13:07 INFO - 'TERM': 'linux', 02:13:07 INFO - 'TMOUT': '86400', 02:13:07 INFO - 'USER': 'cltbld', 02:13:07 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', 02:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:07 INFO - '_': '/tools/buildbot/bin/python'} 02:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:13:07 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 02:13:07 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 02:13:07 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 02:13:07 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 02:13:07 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 02:13:07 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 02:13:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:13:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:13:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:13:09 INFO - Installing collected packages: mozsystemmonitor 02:13:09 INFO - Running setup.py install for mozsystemmonitor 02:13:09 INFO - Successfully installed mozsystemmonitor 02:13:09 INFO - Cleaning up... 02:13:09 INFO - Return code: 0 02:13:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:13:09 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')]} 02:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:09 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')]} 02:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:09 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 0x7fd205a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2636630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7840>, '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 0x26346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634b60>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', '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 02:13:09 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 02:13:09 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 02:13:09 INFO - Using env: {'DISPLAY': ':0', 02:13:09 INFO - 'HOME': '/home/cltbld', 02:13:09 INFO - 'LANG': 'en_US.UTF-8', 02:13:09 INFO - 'LANGUAGE': 'en_US:en', 02:13:09 INFO - 'LOGNAME': 'cltbld', 02:13:09 INFO - 'MAIL': '/var/mail/cltbld', 02:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:09 INFO - 'MOZ_NO_REMOTE': '1', 02:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:09 INFO - 'NO_EM_RESTART': '1', 02:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:13:09 INFO - 'PWD': '/builds/slave/test-pgo', 02:13:09 INFO - 'SHELL': '/bin/bash', 02:13:09 INFO - 'SHLVL': '1', 02:13:09 INFO - 'TERM': 'linux', 02:13:09 INFO - 'TMOUT': '86400', 02:13:09 INFO - 'USER': 'cltbld', 02:13:09 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', 02:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:09 INFO - '_': '/tools/buildbot/bin/python'} 02:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:09 INFO - Downloading/unpacking blobuploader==1.2.4 02:13:09 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 02:13:09 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 02:13:09 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 02:13:09 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 02:13:09 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 02:13:09 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 02:13:11 INFO - Downloading blobuploader-1.2.4.tar.gz 02:13:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:13:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:13:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:13:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:13:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:11 INFO - Downloading docopt-0.6.1.tar.gz 02:13:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:13:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:13:12 INFO - Installing collected packages: blobuploader, requests, docopt 02:13:12 INFO - Running setup.py install for blobuploader 02:13:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:13:12 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:13:12 INFO - Running setup.py install for requests 02:13:12 INFO - Running setup.py install for docopt 02:13:12 INFO - Successfully installed blobuploader requests docopt 02:13:12 INFO - Cleaning up... 02:13:12 INFO - Return code: 0 02:13:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:12 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 0x7fd205a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2636630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7840>, '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 0x26346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634b60>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', '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 02:13:12 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 02:13:12 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 02:13:12 INFO - Using env: {'DISPLAY': ':0', 02:13:12 INFO - 'HOME': '/home/cltbld', 02:13:12 INFO - 'LANG': 'en_US.UTF-8', 02:13:12 INFO - 'LANGUAGE': 'en_US:en', 02:13:12 INFO - 'LOGNAME': 'cltbld', 02:13:12 INFO - 'MAIL': '/var/mail/cltbld', 02:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:12 INFO - 'MOZ_NO_REMOTE': '1', 02:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:12 INFO - 'NO_EM_RESTART': '1', 02:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:13:12 INFO - 'PWD': '/builds/slave/test-pgo', 02:13:12 INFO - 'SHELL': '/bin/bash', 02:13:12 INFO - 'SHLVL': '1', 02:13:12 INFO - 'TERM': 'linux', 02:13:12 INFO - 'TMOUT': '86400', 02:13:12 INFO - 'USER': 'cltbld', 02:13:12 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', 02:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:12 INFO - '_': '/tools/buildbot/bin/python'} 02:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:13:12 INFO - Running setup.py (path:/tmp/pip-S_2UaQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:13:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:13:12 INFO - Running setup.py (path:/tmp/pip-lHMrei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:13:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:13:12 INFO - Running setup.py (path:/tmp/pip-02ar2l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:13:13 INFO - Running setup.py (path:/tmp/pip-WSZbFs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:13:13 INFO - Running setup.py (path:/tmp/pip-shJZO_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:13:13 INFO - Running setup.py (path:/tmp/pip-FkBG_9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:13:13 INFO - Running setup.py (path:/tmp/pip-3aCnRk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:13:13 INFO - Running setup.py (path:/tmp/pip-8Nbxlm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:13:13 INFO - Running setup.py (path:/tmp/pip-RVpTBR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:13:13 INFO - Running setup.py (path:/tmp/pip-KhFxlU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:13:13 INFO - Running setup.py (path:/tmp/pip-Ah6moP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:13:13 INFO - Running setup.py (path:/tmp/pip-66cNuq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:13:13 INFO - Running setup.py (path:/tmp/pip-RB7GhZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:13:13 INFO - Running setup.py (path:/tmp/pip-Nlnun9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:13:13 INFO - Running setup.py (path:/tmp/pip-lhDjEs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:13:13 INFO - Running setup.py (path:/tmp/pip-yvq6aP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:13:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:13:13 INFO - Running setup.py (path:/tmp/pip-xgUSdr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:13:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:13:14 INFO - Running setup.py install for manifestparser 02:13:14 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:13:14 INFO - Running setup.py install for mozcrash 02:13:14 INFO - Running setup.py install for mozdebug 02:13:14 INFO - Running setup.py install for mozdevice 02:13:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:13:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:13:14 INFO - Running setup.py install for mozfile 02:13:14 INFO - Running setup.py install for mozhttpd 02:13:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:13:14 INFO - Running setup.py install for mozinfo 02:13:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:13:14 INFO - Running setup.py install for mozInstall 02:13:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:13:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:13:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:13:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:13:14 INFO - Running setup.py install for mozleak 02:13:14 INFO - Running setup.py install for mozlog 02:13:15 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:13:15 INFO - Running setup.py install for moznetwork 02:13:15 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:13:15 INFO - Running setup.py install for mozprocess 02:13:15 INFO - Running setup.py install for mozprofile 02:13:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:13:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:13:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:13:15 INFO - Running setup.py install for mozrunner 02:13:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:13:15 INFO - Running setup.py install for mozscreenshot 02:13:15 INFO - Running setup.py install for moztest 02:13:15 INFO - Running setup.py install for mozversion 02:13:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:13:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:13:15 INFO - Cleaning up... 02:13:15 INFO - Return code: 0 02:13:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fd205a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2636630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7840>, '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 0x26346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634b60>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', '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 02:13:15 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 02:13:15 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 02:13:15 INFO - Using env: {'DISPLAY': ':0', 02:13:15 INFO - 'HOME': '/home/cltbld', 02:13:15 INFO - 'LANG': 'en_US.UTF-8', 02:13:15 INFO - 'LANGUAGE': 'en_US:en', 02:13:15 INFO - 'LOGNAME': 'cltbld', 02:13:15 INFO - 'MAIL': '/var/mail/cltbld', 02:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:15 INFO - 'MOZ_NO_REMOTE': '1', 02:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:15 INFO - 'NO_EM_RESTART': '1', 02:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:13:15 INFO - 'PWD': '/builds/slave/test-pgo', 02:13:15 INFO - 'SHELL': '/bin/bash', 02:13:15 INFO - 'SHLVL': '1', 02:13:15 INFO - 'TERM': 'linux', 02:13:15 INFO - 'TMOUT': '86400', 02:13:15 INFO - 'USER': 'cltbld', 02:13:15 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', 02:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:15 INFO - '_': '/tools/buildbot/bin/python'} 02:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:13:16 INFO - Running setup.py (path:/tmp/pip-nHCX_g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:13:16 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)) 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:13:16 INFO - Running setup.py (path:/tmp/pip-d4OB6e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:13:16 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)) 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:13:16 INFO - Running setup.py (path:/tmp/pip-tELkus-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:13:16 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)) 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:13:16 INFO - Running setup.py (path:/tmp/pip-gP1Kfd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:13:16 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)) 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:13:16 INFO - Running setup.py (path:/tmp/pip-0ceBB3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:13:16 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)) 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:13:16 INFO - Running setup.py (path:/tmp/pip-AQZoRZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:13:16 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)) 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:13:16 INFO - Running setup.py (path:/tmp/pip-9nhB4_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:13:16 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)) 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:13:16 INFO - Running setup.py (path:/tmp/pip-kjkx9O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:13:16 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)) 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:13:16 INFO - Running setup.py (path:/tmp/pip-V6Q1QC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:13:16 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)) 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:13:16 INFO - Running setup.py (path:/tmp/pip-zStqZW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:13:16 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)) 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:13:16 INFO - Running setup.py (path:/tmp/pip-I7RiBf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:13:16 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)) 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:13:16 INFO - Running setup.py (path:/tmp/pip-mqRFir-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:13:16 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)) 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:13:16 INFO - Running setup.py (path:/tmp/pip-ZIYuNc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:13:16 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)) 02:13:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:13:16 INFO - Running setup.py (path:/tmp/pip-sjB7T_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:13:17 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)) 02:13:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:13:17 INFO - Running setup.py (path:/tmp/pip-hvYTGk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:13:17 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)) 02:13:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:13:17 INFO - Running setup.py (path:/tmp/pip-QY9sD1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:13:17 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)) 02:13:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:13:17 INFO - Running setup.py (path:/tmp/pip-pyM9TH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:13:17 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)) 02:13:17 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)) 02:13:17 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)) 02:13:17 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)) 02:13:17 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)) 02:13:17 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)) 02:13:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:18 INFO - Downloading blessings-1.5.1.tar.gz 02:13:18 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 02:13:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:13:19 INFO - Installing collected packages: blessings 02:13:19 INFO - Running setup.py install for blessings 02:13:19 INFO - Successfully installed blessings 02:13:19 INFO - Cleaning up... 02:13:19 INFO - Return code: 0 02:13:19 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:13:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:13:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:13:19 INFO - Reading from file tmpfile_stdout 02:13:19 INFO - Current package versions: 02:13:19 INFO - argparse == 1.2.1 02:13:19 INFO - blessings == 1.5.1 02:13:19 INFO - blobuploader == 1.2.4 02:13:19 INFO - docopt == 0.6.1 02:13:19 INFO - manifestparser == 1.1 02:13:19 INFO - mozInstall == 1.12 02:13:19 INFO - mozcrash == 0.16 02:13:19 INFO - mozdebug == 0.1 02:13:19 INFO - mozdevice == 0.47 02:13:19 INFO - mozfile == 1.2 02:13:19 INFO - mozhttpd == 0.7 02:13:19 INFO - mozinfo == 0.9 02:13:19 INFO - mozleak == 0.1 02:13:19 INFO - mozlog == 3.1 02:13:19 INFO - moznetwork == 0.27 02:13:19 INFO - mozprocess == 0.22 02:13:19 INFO - mozprofile == 0.28 02:13:19 INFO - mozrunner == 6.11 02:13:19 INFO - mozscreenshot == 0.1 02:13:19 INFO - mozsystemmonitor == 0.0 02:13:19 INFO - moztest == 0.7 02:13:19 INFO - mozversion == 1.4 02:13:19 INFO - psutil == 3.1.1 02:13:19 INFO - requests == 1.2.3 02:13:19 INFO - wsgiref == 0.1.2 02:13:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:13:19 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')]} 02:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:19 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')]} 02:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:19 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 0x7fd205a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2636630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7840>, '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 0x26346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634b60>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', '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 02:13:19 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 02:13:19 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 02:13:19 INFO - Using env: {'DISPLAY': ':0', 02:13:19 INFO - 'HOME': '/home/cltbld', 02:13:19 INFO - 'LANG': 'en_US.UTF-8', 02:13:19 INFO - 'LANGUAGE': 'en_US:en', 02:13:19 INFO - 'LOGNAME': 'cltbld', 02:13:19 INFO - 'MAIL': '/var/mail/cltbld', 02:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:19 INFO - 'MOZ_NO_REMOTE': '1', 02:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:19 INFO - 'NO_EM_RESTART': '1', 02:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:13:19 INFO - 'PWD': '/builds/slave/test-pgo', 02:13:19 INFO - 'SHELL': '/bin/bash', 02:13:19 INFO - 'SHLVL': '1', 02:13:19 INFO - 'TERM': 'linux', 02:13:19 INFO - 'TMOUT': '86400', 02:13:19 INFO - 'USER': 'cltbld', 02:13:19 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', 02:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:19 INFO - '_': '/tools/buildbot/bin/python'} 02:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:19 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)) 02:13:19 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)) 02:13:19 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)) 02:13:19 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)) 02:13:19 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)) 02:13:19 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)) 02:13:19 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)) 02:13:19 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)) 02:13:19 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)) 02:13:19 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)) 02:13:19 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)) 02:13:19 INFO - Cleaning up... 02:13:19 INFO - Return code: 0 02:13:19 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:13:19 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')]} 02:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:19 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')]} 02:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:19 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 0x7fd205a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2636630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7840>, '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 0x26346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634b60>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', '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 02:13:19 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 02:13:19 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 02:13:19 INFO - Using env: {'DISPLAY': ':0', 02:13:19 INFO - 'HOME': '/home/cltbld', 02:13:19 INFO - 'LANG': 'en_US.UTF-8', 02:13:19 INFO - 'LANGUAGE': 'en_US:en', 02:13:19 INFO - 'LOGNAME': 'cltbld', 02:13:19 INFO - 'MAIL': '/var/mail/cltbld', 02:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:19 INFO - 'MOZ_NO_REMOTE': '1', 02:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:19 INFO - 'NO_EM_RESTART': '1', 02:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:13:19 INFO - 'PWD': '/builds/slave/test-pgo', 02:13:19 INFO - 'SHELL': '/bin/bash', 02:13:19 INFO - 'SHLVL': '1', 02:13:19 INFO - 'TERM': 'linux', 02:13:19 INFO - 'TMOUT': '86400', 02:13:19 INFO - 'USER': 'cltbld', 02:13:19 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', 02:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:19 INFO - '_': '/tools/buildbot/bin/python'} 02:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:19 INFO - Downloading/unpacking jsonschema 02:13:19 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 02:13:19 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 02:13:19 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 02:13:19 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 02:13:19 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 02:13:19 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 02:13:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:13:21 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 02:13:21 INFO - Downloading/unpacking functools32 (from jsonschema) 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13:21 INFO - Downloading functools32-3.2.3-2.tar.gz 02:13:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:13:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:13:21 INFO - warning: no files found matching '*.txt' 02:13:21 INFO - no previously-included directories found matching 'build' 02:13:21 INFO - no previously-included directories found matching 'dist' 02:13:21 INFO - no previously-included directories found matching '.git*' 02:13:21 INFO - Installing collected packages: jsonschema, functools32 02:13:21 INFO - Running setup.py install for functools32 02:13:21 INFO - warning: no files found matching '*.txt' 02:13:21 INFO - no previously-included directories found matching 'build' 02:13:21 INFO - no previously-included directories found matching 'dist' 02:13:21 INFO - no previously-included directories found matching '.git*' 02:13:21 INFO - Successfully installed jsonschema functools32 02:13:21 INFO - Cleaning up... 02:13:21 INFO - Return code: 0 02:13:21 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:13: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')]} 02:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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 0x7fd205a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2636630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c7840>, '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 0x26346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634b60>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', '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 02:13: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 02:13: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 02:13:21 INFO - Using env: {'DISPLAY': ':0', 02:13:21 INFO - 'HOME': '/home/cltbld', 02:13:21 INFO - 'LANG': 'en_US.UTF-8', 02:13:21 INFO - 'LANGUAGE': 'en_US:en', 02:13:21 INFO - 'LOGNAME': 'cltbld', 02:13:21 INFO - 'MAIL': '/var/mail/cltbld', 02:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:21 INFO - 'MOZ_NO_REMOTE': '1', 02:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:21 INFO - 'NO_EM_RESTART': '1', 02:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:13:21 INFO - 'PWD': '/builds/slave/test-pgo', 02:13:21 INFO - 'SHELL': '/bin/bash', 02:13:21 INFO - 'SHLVL': '1', 02:13:21 INFO - 'TERM': 'linux', 02:13:21 INFO - 'TMOUT': '86400', 02:13:21 INFO - 'USER': 'cltbld', 02:13:21 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', 02:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:21 INFO - '_': '/tools/buildbot/bin/python'} 02:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:22 INFO - Downloading/unpacking flake8 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:13:23 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 02:13:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:13:24 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 02:13:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:13:24 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 02:13:24 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 02:13:24 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 02:13:24 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 02:13:24 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 02:13:24 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 02:13:24 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 02:13:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:13:24 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 02:13:24 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 02:13:24 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 02:13:24 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 02:13:24 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 02:13:24 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 02:13:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:13:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:13:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:13:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:13:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:13:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:13:24 INFO - no previously-included directories found matching 'docs/_build' 02:13:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:13:24 INFO - Running setup.py install for pep8 02:13:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:13:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:13:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:13:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:13:24 INFO - no previously-included directories found matching 'docs/_build' 02:13:24 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:13:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:13:24 INFO - Cleaning up... 02:13:24 INFO - Return code: 0 02:13:24 INFO - Running post-action listener: _resource_record_post_action 02:13:24 INFO - Running post-action listener: _start_resource_monitoring 02:13:24 INFO - Starting resource monitoring. 02:13:24 INFO - ##### 02:13:24 INFO - ##### Running install step. 02:13:24 INFO - ##### 02:13:24 INFO - Running pre-action listener: _resource_record_pre_action 02:13:24 INFO - Running main action method: install 02:13:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:13:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:13:24 INFO - Reading from file tmpfile_stdout 02:13:24 INFO - Detecting whether we're running mozinstall >=1.0... 02:13:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:13:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:13:25 INFO - Reading from file tmpfile_stdout 02:13:25 INFO - Output received: 02:13:25 INFO - Usage: mozinstall [options] installer 02:13:25 INFO - Options: 02:13:25 INFO - -h, --help show this help message and exit 02:13:25 INFO - -d DEST, --destination=DEST 02:13:25 INFO - Directory to install application into. [default: 02:13:25 INFO - "/builds/slave/test-pgo"] 02:13:25 INFO - --app=APP Application being installed. [default: firefox] 02:13:25 INFO - mkdir: /builds/slave/test-pgo/build/application 02:13:25 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'] 02:13:25 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 02:13:40 INFO - Reading from file tmpfile_stdout 02:13:40 INFO - Output received: 02:13:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:13:40 INFO - Running post-action listener: _resource_record_post_action 02:13:40 INFO - ##### 02:13:40 INFO - ##### Running run-tests step. 02:13:40 INFO - ##### 02:13:40 INFO - Running pre-action listener: _resource_record_pre_action 02:13:40 INFO - Running main action method: run_tests 02:13:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:13:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:13:40 INFO - Python 2.7.3 02:13:40 INFO - Return code: 0 02:13:40 INFO - grabbing minidump binary from tooltool 02:13: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')]} 02:13: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 0x26c7840>, '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 0x26346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:13: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 02:13: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 02:13:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:13:40 INFO - Return code: 0 02:13:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:13:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:13:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:13:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:13:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:13:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:13:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:13:41 INFO - Return code: 0 02:13:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 02:13:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 02:13:41 INFO - Using env: {'DISPLAY': ':0', 02:13:41 INFO - 'HOME': '/home/cltbld', 02:13:41 INFO - 'LANG': 'en_US.UTF-8', 02:13:41 INFO - 'LANGUAGE': 'en_US:en', 02:13:41 INFO - 'LOGNAME': 'cltbld', 02:13:41 INFO - 'MAIL': '/var/mail/cltbld', 02:13:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:13:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:41 INFO - 'MOZ_NO_REMOTE': '1', 02:13:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:41 INFO - 'NO_EM_RESTART': '1', 02:13:41 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:13:41 INFO - 'PWD': '/builds/slave/test-pgo', 02:13:41 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:13:41 INFO - 'SHELL': '/bin/bash', 02:13:41 INFO - 'SHLVL': '1', 02:13:41 INFO - 'TERM': 'linux', 02:13:41 INFO - 'TMOUT': '86400', 02:13:41 INFO - 'USER': 'cltbld', 02:13:41 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004', 02:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:41 INFO - '_': '/tools/buildbot/bin/python'} 02:13:41 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 02:13:42 INFO - mozversion application_buildid: 20151228233005 02:13:42 INFO - mozversion application_changeset: 83cb1c2445fa081a67d379d975557afd56bf4979 02:13:42 INFO - mozversion application_display_name: Nightly 02:13:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:13:42 INFO - mozversion application_name: Firefox 02:13:42 INFO - mozversion application_remotingname: firefox 02:13:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:13:42 INFO - mozversion application_vendor: Mozilla 02:13:42 INFO - mozversion application_version: 46.0a1 02:13:42 INFO - mozversion platform_buildid: 20151228233005 02:13:42 INFO - mozversion platform_changeset: 83cb1c2445fa081a67d379d975557afd56bf4979 02:13:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:13:42 INFO - mozversion platform_version: 46.0a1 02:13:42 INFO - using testdate: 1451384022 02:13:42 INFO - actual date: 1451384022 02:13:42 INFO - starting webserver on 'localhost:60612' 02:13:42 INFO - SUITE-START | Running 3 tests 02:13:42 INFO - TEST-START | dromaeo_css 02:13:42 INFO - operating with platform_type : linux_ 02:13:42 INFO - Initialising browser for dromaeo_css test... 02:13:42 INFO - TEST-INFO | started process 15876 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq_jn4H/profile http://localhost:60612/getInfo.html) 02:13:45 INFO - PROCESS | 15876 | __metrics Screen width/height:1600/1200 02:13:45 INFO - PROCESS | 15876 | colorDepth:24 02:13:45 INFO - PROCESS | 15876 | Browser inner width/height: 1024/697 02:13:45 INFO - PROCESS | 15876 | __metrics 02:13:45 INFO - PROCESS | 15876 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:13:46 INFO - PROCESS | 15876 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:13:47 INFO - TEST-INFO | 15876: exit 0 02:13:47 INFO - Browser initialized. 02:13:47 INFO - Running cycle 1/1 for dromaeo_css test... 02:13:47 INFO - TEST-INFO | started process 15968 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq_jn4H/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:58 INFO - PROCESS | 15968 | RSS: Main: 148787200 02:13:58 INFO - PROCESS | 15968 | 02:14:50 INFO - PROCESS | 15968 | 1451384090487 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] 02:16:58 INFO - PROCESS | 15968 | Cycle 1(1): loaded http://localhost:60612/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60612/tests/dromaeo/cssquery-ext.html) 02:16:59 INFO - PROCESS | 15968 | RSS: Main: 268902400 02:16:59 INFO - PROCESS | 15968 | 02:20:02 INFO - PROCESS | 15968 | Cycle 1(1): loaded http://localhost:60612/tests/dromaeo/cssquery-ext.html (next: http://localhost:60612/tests/dromaeo/cssquery-jquery.html) 02:20:02 INFO - PROCESS | 15968 | RSS: Main: 229339136 02:20:02 INFO - PROCESS | 15968 | 02:23:04 INFO - PROCESS | 15968 | Cycle 1(1): loaded http://localhost:60612/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60612/tests/dromaeo/cssquery-mootools.html) 02:23:05 INFO - PROCESS | 15968 | RSS: Main: 222392320 02:23:05 INFO - PROCESS | 15968 | 02:26:07 INFO - PROCESS | 15968 | Cycle 1(1): loaded http://localhost:60612/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60612/tests/dromaeo/cssquery-prototype.html) 02:26:07 INFO - PROCESS | 15968 | RSS: Main: 209219584 02:26:07 INFO - PROCESS | 15968 | 02:29:10 INFO - PROCESS | 15968 | Cycle 1(1): loaded http://localhost:60612/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60612/tests/dromaeo/cssquery-yui.html) 02:29:11 INFO - PROCESS | 15968 | RSS: Main: 216633344 02:29:11 INFO - PROCESS | 15968 | 02:32:13 INFO - PROCESS | 15968 | Cycle 1(1): loaded http://localhost:60612/tests/dromaeo/cssquery-yui.html (next: http://localhost:60612/tests/dromaeo/cssquery-dojo.html) 02:32:13 INFO - PROCESS | 15968 | RSS: Main: 267583488 02:32:13 INFO - PROCESS | 15968 | 02:32:13 INFO - PROCESS | 15968 | __start_tp_report 02:32:13 INFO - PROCESS | 15968 | _x_x_mozilla_page_load 02:32:13 INFO - PROCESS | 15968 | _x_x_mozilla_page_load_details 02:32:13 INFO - PROCESS | 15968 | |i|pagename|runs| 02:32:13 INFO - PROCESS | 15968 | |0;dojo.html;3104.2084268511535;3145.7168854803062;3188.8360748326854;3193.217661672889;3210.7752457327983;5084.796608135679;5180.326557547513;5232.7122008289525;5263.76313065912;5291.576673866091;5136.768845401956;5190.9740451297785;5199.4800519947985;5213.530782229599;5220.712860792655;4673.602743766767;4691.460482044575;4763.404574428197;4847.806087756486;4870.512948705136;4767.690100143497;4826.0830442215865;4843.927341089887;4891.902161956758;4919.212925931852;4647.976760116211;4687.507811679776;4749.4775574686755;4759.833405830814;4761.381020467352;4762.333273341735;4763.69036012658;4783.976080119577;4822.734749588772;4823.662343635947;4695.9668872847915;4758.524147585248;4768.690035147704;4768.831636249141;4802.831900883452;4976.552110310054;5027.321311622957;5088.211327244283;5100.693958362473;5101.591872650179;5653.208550802891;5653.575981801381;5666.291713535808;5667.291588551431;5667.716614169275;5640.689762063085;5668.121441176624;5669.121286200645;5671.517920976722;5675;5145.742712864379;5233.764480598345;5250.8687282817855;5285.867853303621;5347.224652425377;5725.570582206351;5735.311762588516;5739.938111449395;5741.368449470555;5781.53747700183;5451.454854514596;5527.419620939824;5540.335159780852;5540.473655002768;5547.472990065938;5600.691961942132;5657.43425657431;5690.118031705092;5697.4302569742695;5751.22358481608;5570;5571.526420254243;5572.247746554163;5576.7211639417865;5582.91625625616;5498.642588231752;5616.2698849150165;5624.353199382042;5644.85887852807;5684.63049901755;4276.764777937181;4332.870013899588;4345.239583073013;4352.499462561783;4384.956150438518;3874.96125038746;3887.378019516864;3890.922181556353;3893.279743247508;3918.392649139388;5067.011932673094;5099.133147364957;5115.462876397999;5178.119719647669;5178.482151784867;5651.321841378978;5660.575456840754;5661.603687741901;5662.66024038559;5710.543156547466;5217.34783152106;5229.895402092013;5234.607404444682;5238.319018527567;5280.049591073644;4779.0680817241;4848.490908454632;4875.414950205998;4884.072026314989;4894.975525122351;5864.765409383577;5865.970670146708;5867.765289388462;5870.119482077637;5874.412558744177;5632.662040277596;5638.041532939328;5641.9435805641415;5649;5686.374498805211;5636.577256705681;5673;5727.971360143172;5781.508571771446;5851.268591426072;5526.115821468546;5548.916766248429;5554.389017208023;5558.638688485235;5599.132134519156;5602.859928501657;5605;5605.495505404533;5606.943930560806;5620.4098569649595;5366.141417373202;5460.34475862899;5468.890622187613;5478.726063696879;5507.862303442446;5370.9731451342495;5394.298741163623;5406.080966235828;5426.8371948841595;5468.671879687232;5356.089464791073;5360.517553420211;5363.865903352447;5368.865778355416;5370.221317908803;5414.29614150158;5428.4842939920645;5491.6979566122645;5492.203630473638;5493.09363954943;5300.7084610345255;5366.758495867617;5394.2448057272795;5396.1905714143195;5415.891682166413 02:32:13 INFO - PROCESS | 15968 | |1;ext.html;546.0583186505369;580.1848402993794;585.8886811505813;590.5777369181036;606.6784604159791;28081.578776318347;35555;36082;36138;36159.45760813583;38628.420573691415;38971;39014.804925975404;39089.218215635745;39118.60881391185;7427.554346739186;8385.287250583708;8526;8531.146885311451;8537.18896704812;7586.051743532059;10012;10241;10249.692509224735;10264.127549158331;10024.047715467055;10061.295709300352;10119.190464762838;10122.59509619618;10144.644937427192;7675.078990521118;7860.528368297921;9914.55384507699;10043;10077.24420668449;10040.347377420518;10242.641507547274;10259;10265.692029239135;10313.587456501731;38666.42000369997;39441.21117577661;39550.61572844937;39563;39725;2878.8848446062134;2951.919344725668;3181.904542863718;3433.7081348085444;3493.004493719278;29525.704742952512;29670.258243543867;29787;29944.550831737542;30244.8487757562;3888.727789054767;3994.7003974701724;4029.15387768566;4055.9188816223805;4089.3048181809163;203172;204757;205385;261928;261950;50750.238746418836;51929.48070519322;56336;57919.4208057914;57944;61208.69395652993;62427;62682;62724.372756271856;62799;14023.158610483404;14068.296585170701;14078;14134.222617755917;14232.21722805235;10839.83740243897;10900.727481812859;10913.563457461612;10914.181436392302;10918.617848375268;18695.15871785773;18783.24867005332;18797.81202187988;18807.90596047011;18811.247550097843;7120.857582848417;7480.551166930001;7498.4001279897475;7512.173660897297;7513.887291690629;944.5560586524323;945.3382632157517;971;1032.5869652139054;1126.7295848996346;27977;28038.43923121567;28466.573001404995;28694.42611147807;28877.56683649747;1027.0807627173788;1135.9545618175346;1141;1165.0213820390911;1174.9177557571059;14860.92569537167;14913.644430003162;14967.925160374347;15093.622659433382;15120.395184192728;330798;335320;335958;336090;336695;51272.23091653628;51530.48469515257;51635.48364516382;51669;51823.481765182616;1304.9934750326188;1313.1923866821835;1317.2952470428274;1324.9403776830065;1330.1287656584952;24215.273541793773;27190.456190876466;27339.86330068337;28835;28854.42291154207;41955.58044419639;42381.36427953521;42384.576154238064;42396.78801605972;42430.36354454624;238458;243442;243644;244126;244225;27216;27888.58167127535;30395;30949.845250773604;31010.379792404477;36076.4588531167;36415;36845.63154368529;37307.440388393654;37468.62531374651;30773.384532309676;32848.671513284564;35571.288574228885;35604.82197588996;35769.28461430809;34791.130221743646;35331;35361.29277414386;35663;35671.46492802558;33841.66158338385;34397.484037738956;34472.82763586166;34791.304173916884;34794.304113918086;31149.844250778602;31398.686013139577;31761.841190793897;31848;32200.19499512531;23230.53538929178;23260.418489537897;23436.765632343457;25027.870401383567;25270.74729252684 02:32:13 INFO - PROCESS | 15968 | |2;jquery.html;349.92921659721253;351.90322661268146;355.56976058968644;356.4919989015652;357.36567592523267;13994.510192143278;14298.499552515665;16214.108224047674;16761.580960475992;17646.82353176466;16406.015639061665;16422.589435264123;16430;16545.66908661826;16546.751798723028;5142.794288228466;5443.673379597217;5446.2647542581835;5448.863778405532;5454.754536045887;3932.547757007952;4064.390341448777;4066.9796651016704;5331.093714068617;5841.269841269841;5962.8807423851495;5978;6005.489533389646;6009.729562169713;6021.729022194012;5816.098504731774;5973.820785376424;5981.342052374235;5990.1314309425325;5991.2510936132985;5228.764705588258;5250.396204436501;5277.419483856773;5282.603804714623;5285.101532739443;20449.5910081799;20605.38183854487;20880.269190578256;20901;20930.267440639505;2103.442587714257;2139.3047259640525;2182.8253739700785;2498.7376325485743;2589.8705064746687;12642.810357844639;12918.772716592002;12961.935190323988;13262;13340.666483337896;1843.2075405760284;1895.535593779519;1900.106949733623;1909.961800763977;1921.3083290015584;57087.429125709044;60026.699866500385;60049.699751500964;60124.69937650284;60311;9603.807923841485;9628.807423851624;9968.900310996942;9969;9993.550290236957;12981.156224845356;13049.28228947398;13067.085304028817;13068.346582670829;13069.738605227842;6734.114447954581;7094.53885497441;7119.89320160198;7407.185209626937;7507.061617297838;7150.821229469201;7200.495965282485;7217.386522145676;7246.384057355079;7260.128784545888;5916.083007133901;6001.4298641628975;6013.879722405615;6048.9697551512845;6052;1657.395050806447;1718.149515989593;1721.8622510199154;1740.4343588333588;1772.512559046247;902.4810733827944;941.7268991992246;993.4039576254189;1026.43033116621;1045.513836066233;15364.769528457082;16450.259738311564;17886;18168.545786355447;18563.535911602317;909.7498187998353;930.8464103422995;942.8302905476943;945.9621615135318;971.5530855806267;10244.897551024544;10389.220808439397;10422.478876056166;10543.630972916064;10566.101881340019;361125;368202;369958;549974;556256;78267;80887.19112808914;81084.18915810884;81950.59024704958;82161;893.7542175901679;893.9687110951086;894.6689724801735;957.8467445208734;1010.782681723433;15369.692606148039;15629.609259768142;15848.28682709304;16073.437429689904;16147.515574532783;32243.35513289768;32964.835175823966;33758.324833503684;34749.47875781916;35323.116922077155;38150.80924595359;38770.224595508495;40036.399454008795;40978.38532421956;42273;9106.408083474553;9254.074592540692;9786.951065244628;9802.460864652227;9826.312158148861;16862;16956.406525771537;17009.829901700825;17218;17600.64798703993;14467.421303147756;14697.70604587881;14850.40598376053;14921.925390372979;14998.550043498712;10217;13760;14206.502772402917;14817.110973341634;14894;12068.215565988183;12433.254004759381;14100.36548355347;14380.209088500233;14775.039622424509;9239.630414783333;9338.066193380879;9346.878374595091;9352.906470935475;9368.34421590482;13631.727365452834;13665.453381864614;13785.379657915619;14006.299685015505;14465.855341446451 02:32:13 INFO - PROCESS | 15968 | |3;mootools.html;1307.3332600373806;1399.0975820595716;1432.133559196686;1535.1710076558659;1732.0473739443312;6006.579539432241;6425.614463132215;6499.3175716549795;6513.609183448991;6530.934690653092;6351.3966173213585;6468.288488266287;6493.448056915168;6502.08970744095;6510.707018184181;1820.872538922276;1856.6750818606758;2041.9591608167827;2056.085042156241;2086.7182930304366;2142.442964829148;2146.710194123789;2147.044565168501;2148.2481131603968;2150.5483848391855;2008.5079155606898;2052.9794702052936;2068.0590331399176;2068.152057656361;2069.8033686799804;2052.784457631942;2086.926957556486;2087.9895600522054;2108.57828434313;2111.271611294101;2101.117530637136;2146.61360955028;2151.95696086079;2164.751053628837;2169.5986242545177;6665.166854143232;6703.698333575001;6717.16035495563;6722.193336799566;6728.293529179415;4171.186618609372;4205.095904380542;4232.682548808821;4234.047339348653;4235.470566179228;2787.4982503149427;2815.85920703964;2832.065418411919;2833.3483298841384;2950.395168990352;866.4151697604156;869.9217070463625;872.533194740817;877.2630989968393;915.890093188815;8677;8680.262177714902;8681.869771953488;8689.82620347596;8712.172343627346;3644.890653280406;3654.1230104774663;3679.8712045078296;3692.2430901665093;3716.7026637868908;7657.655405506765;7667.616619169019;7671.156172820985;7673.654685539164;7681.692732290646;4142.937855932163;4150.709450338508;4151.086760912594;4152.231837110084;4152.709310348247;3798.1074447504816;3805.5243094613174;3834.9616503835164;3844.231153769257;3844.6347596978244;3045.0712532677744;3070.063630592646;3228.5157226416227;3272.574565306495;3278.541004259406;1019.3934608907837;1028.0644613401769;1037.662759603132;1038.7351225437617;1041.0266400915168;1059.359087751899;1061.7080302916759;1109.0960866893618;1220.5666988219054;1341.2019848190312;6305.779297724557;6323.494120470351;6356.269029061625;6381.904271435932;6385.265694445198;1076.079951641351;1088.450332582041;1096.6107032003683;1097.067492631257;1102.6802227354137;5034.244863270539;5147.433782283946;5148.716820574904;5149.716765577929;5151.150060240094;7620.466567340233;7777.338926191337;7824.960875195701;7854.450188486865;7879.960600197077;7807.570583617956;7810.882836757453;7871.960640196762;7879.881801772978;7888.605569721491;6343.397377249154;6384.138141350951;6390.45681117101;6395.808125756234;6396.200474940632;5925.348211696623;6069.453749162597;6071;6072.90890636632;6083.908741368795;7048.859022819617;7094.396976257076;7173.282671732785;7207.351338379571;7252.709891604488;7164.820879478055;7233.095863017123;7299.598522081336;7330.45021623391;7338.119425668954;6071.150038994632;6124.663143527148;6126.693665316806;6135.785247516315;6135.969320153371;5836;5913.349531551612;5916.083007133901;6187.257529096537;6529.9020514691365;5950.672713000653;6045.969770151121;6068.150458935665;6113.358097399709;6130.049842274455;5832.795852145155;5842.766289348378;5874.618149820248;5905.498032667271;5924.11138329254;5942.910856337072;5956.583039187215;5973.940260597338;6000.819975400745;6007.249093863267;5416.7020813855615;5541.307336582927;5563.693996830213;5571.275734154534;5583.497485226349;5610.803621873215;5661.094224923992;5674.687892165971;5676.517496012885;5679.261695979496 02:32:13 INFO - PROCESS | 15968 | |4;prototype.html;321.9500977348509;328.31873861736887;328.99328056148187;330.11693719300865;337.8918746001279;5864.3256025557075;6009.09863520471;6046.395360463957;6068.69656517174;6071.392860713932;5801.738921748521;5905.704714764266;5906.763729450817;5971.432713892184;6003.759849606011;4648.74431906245;4660.324252983315;4665.393498845162;4667.579917807397;4673.929891051637;4435.135148646015;4498.842540511083;4507.57178068083;4517.141743068806;4672.789724462407;4500.39244701966;4593.908121837561;4612.930806037912;4615.030843522864;4619.861404157864;4628.09752098341;4634.073185362941;4635.304704294349;4643.16423043852;4666.673332866701;4093.3246014407887;4094.549599544048;4095.508538975312;4102.938455923164;4105.609967053155;5618;5718.742656580423;5722.113072473773;5729.914051289234;5734.397888221718;5358.46415358461;5384.569234461273;5387.622866399353;5389.83830485086;5395.217693434469;6033.42682445167;6332.778352757631;6351.047342898556;6361.904571431386;6364.936350636481;4387.978060109711;4422.336649502568;4504.8873778155485;4518.2319005769095;4519.457665080178;6608.603483790988;6631.668416579152;6641;6642.800715978528;6645.136132302818;4611.308303754464;4611.930821037688;4615.284630882219;4617.792199351037;4617.907641847211;4439.600435960779;4599;4604.815807367668;4661.533846615312;4668.929966050512;5331.466853314638;5334.306540149756;5336.332958380202;5337;5339.252504649352;6433;6438.227412710505;6440.871182576322;6441.710123044474;6445.677716114269;1599.4801689450976;1619.5222409389257;1619.7894273744337;1620.2789758557328;1622.1889055472263;1004.7739258666742;1019.4902548725637;1022.9846552301722;1068.9091427228618;1079.9460026998618;5896.351401345849;5927.911081333784;6053.7578496860515;6054.697265136726;6062.42406971337;6591.077249185118;6591.802245932629;6602.801915942529;6618.172728408949;6623.602583844889;5881;6042.516598672096;6048.092786082123;6049.606775559574;6057.969710151421;3550.680438760524;3566.4828599852876;3578.0339308386588;3581.3732596795458;3588.6411358863907;6894.931050689529;6896.517243792987;6904.240533541307;6905.136857892763;6906.205786334535;6589.18989137932;6773.559718618274;6783.389494945479;6789.185297764201;6790.219124800612;6855.211650660238;6870.896936545956;6877.449804015667;6878.484113691393;6880.415164711056;6604.5046621502615;6607.867842643216;6614;6615.4046135848;6616.4045235929;6328.0824280478155;6512.6092434454085;6521.673916304071;6527.5757075789925;6547.247066587213;6848.794536163923;6856.24581296067;6860.176778786378;6864.828379290558;6871.106756121672;4493.550644935481;4495.662825288051;4497.100579883971;4498.955010449985;4505.63954883615;6560;6603.702833372414;6605.801825945229;6621;6633.469322454289;6241.21984751906;6390.4248617624635;6405.455536279468;6428.453581445629;6450.677466126769;6352.68236588178;6352.888244557276;6358.109864618865;6358.459530939922;6362.0774987627465;6199.225096862892;6316.589421687576;6324.114623952558;6341.365863413622;6342.746290148342;6461.8061458156335;6470.126532917996;6475.514336424692;6479.676016199265;6481.773137940149;6278.780242691484;6279.937200627935;6281.026440901667;6283.874322513616;6287.245530536182 02:32:13 INFO - PROCESS | 15968 | |5;yui.html;741.2476336518434;748.4648476339416;792.3581898662088;836.3936146293937;847.635516727807;13234.404451799668;13340.533081342168;13368.26474543902;13410.396532156052;13424.261665608388;12658.873411265884;12685.61943141705;12740.936295318534;14112.788308175386;14718.705625887476;690.440742998173;829.4857188543111;837.4682076881194;841.4026041510535;844.0377969115214;695.0373732380639;839.8488272111017;842.8651415773478;844.0420123160196;845.8900342955408;866.7313132928781;878.3675753457501;878.4026861734018;878.6748902905902;878.6924576398274;724.9782506524813;725.9818504537376;868.513632365874;872.0973792125152;877.644553955649;644.6969924135649;646.86415852671;647.5693663713624;647.841278886671;648.1412128929188;14141.222232777192;14217.502387416494;14244.07413518118;14252.501162459264;14287;11637.709057273636;11814;12084;12252.142350035501;12312.81530777039;9996.100350968447;10388.844167337496;10427.68716938493;10526;10729.892701072968;3582.1940063485767;3639.7816131032223;3649.6532829381167;3690.0774806298427;3757.455169000507;44923.55076449226;44943.32585011228;44944.775276123735;45290.32064519068;45304.54695453069;9699.369540979813;9947.077338575908;9977.650782222587;10048.598056077675;10494.055535001733;17371.392001279895;17465.21406536709;17477.91261043712;17487.912560437115;17506.64986700259;7047.612381318974;7290;7300.4159667226495;7379.704811807467;7399.112106547141;4328.8268469260875;4370.672199585044;4406.977965110218;4468.039371535136;4548.5906268436;3037.5139977603917;3066.708662677042;3067.785255032171;3074.6003019607306;3076.769242306791;510.5277618203147;513.4788189987166;517.1570340345213;517.5006119095091;524.6878107526015;605.3129697793037;630;634.9904751428733;644.3170239546096;660.8480049588526;7682.96158519215;8362.372822038371;8517.872231916526;8540.572971351408;8552.700655477029;432.55446889703654;562.3673367461606;624.4848000399688;635.6503922842418;659.7822718502882;3798.525184351956;3833.21419109082;3931.980340098281;3941.5219292765214;4040.9797951010055;49125.2631210525;49347;49420.505794942306;49594.50405495899;49992.50007499951;49721.502784972414;51518;51794.74102629463;52016.21975670368;52359.47640523546;43281.32108770727;43502.34746478742;44022.339664905056;44230.55769442329;44684.10631787346;7924.6830126796585;8203.753887383149;8379.622916968872;8388.328933685412;8481.872771908304;34238.82880585681;34487.31025379529;37332.62667373291;38939;39344.60655393409;43912;46298.53701463077;47994.28008579804;48673.75663121662;49142.508574913794;10508.842367364343;11447.484863181344;11648.301101933912;11740.41297935117;12096.213746106476;10711.571537138427;10906.890931090587;10913.672589822318;10931.617393391192;11011.724706882393;10545.261831672016;10651.467426628793;10746.73133171677;11414.086873050303;11697.356645384585;11674.76650467003;11897.242983715358;12054.156209065632;12080.879191208327;12223;10385.273030887765;10418.635347762793;10631.362118272928;10775.568977240822;10795.6221532246;9846.852297215404;10069.19446444268;10237.436940968319;10476.738081548023;10530.36817790935;8944.807784335548;9072.591733371883;9124.771880703036;9368.67209647659;9378.390404623678 02:32:13 INFO - PROCESS | 15968 | __end_tp_report 02:32:13 INFO - PROCESS | 15968 | __start_cc_report 02:32:13 INFO - PROCESS | 15968 | _x_x_mozilla_cycle_collect,1018 02:32:13 INFO - PROCESS | 15968 | __end_cc_report 02:32:13 INFO - PROCESS | 15968 | __startTimestamp1451385133705__endTimestamp 02:32:13 INFO - PROCESS | 15968 | 02:32:13 INFO - PROCESS | 15968 | ------- Summary: start ------- 02:32:13 INFO - PROCESS | 15968 | Number of tests: 6 02:32:13 INFO - PROCESS | 15968 | 02:32:13 INFO - PROCESS | 15968 | [#0] dojo.html Cycles:165 Average:5207.55 Median:5370.22 stddev:572.09 (10.7%) stddev-sans-first:549.54 02:32:13 INFO - PROCESS | 15968 | Values: 3104.2 3145.7 3188.8 3193.2 3210.8 5084.8 5180.3 5232.7 5263.8 5291.6 5136.8 5191.0 5199.5 5213.5 5220.7 4673.6 4691.5 4763.4 4847.8 4870.5 4767.7 4826.1 4843.9 4891.9 4919.2 4648.0 4687.5 4749.5 4759.8 4761.4 4762.3 4763.7 4784.0 4822.7 4823.7 4696.0 4758.5 4768.7 4768.8 4802.8 4976.6 5027.3 5088.2 5100.7 5101.6 5653.2 5653.6 5666.3 5667.3 5667.7 5640.7 5668.1 5669.1 5671.5 5675.0 5145.7 5233.8 5250.9 5285.9 5347.2 5725.6 5735.3 5739.9 5741.4 5781.5 5451.5 5527.4 5540.3 5540.5 5547.5 5600.7 5657.4 5690.1 5697.4 5751.2 5570.0 5571.5 5572.2 5576.7 5582.9 5498.6 5616.3 5624.4 5644.9 5684.6 4276.8 4332.9 4345.2 4352.5 4385.0 3875.0 3887.4 3890.9 3893.3 3918.4 5067.0 5099.1 5115.5 5178.1 5178.5 5651.3 5660.6 5661.6 5662.7 5710.5 5217.3 5229.9 5234.6 5238.3 5280.0 4779.1 4848.5 4875.4 4884.1 4895.0 5864.8 5866.0 5867.8 5870.1 5874.4 5632.7 5638.0 5641.9 5649.0 5686.4 5636.6 5673.0 5728.0 5781.5 5851.3 5526.1 5548.9 5554.4 5558.6 5599.1 5602.9 5605.0 5605.5 5606.9 5620.4 5366.1 5460.3 5468.9 5478.7 5507.9 5371.0 5394.3 5406.1 5426.8 5468.7 5356.1 5360.5 5363.9 5368.9 5370.2 5414.3 5428.5 5491.7 5492.2 5493.1 5300.7 5366.8 5394.2 5396.2 5415.9 02:32:13 INFO - PROCESS | 15968 | 02:32:13 INFO - PROCESS | 15968 | [#1] ext.html Cycles:180 Average:43486.22 Median:17514.95 stddev:71405.51 (407.7%) stddev-sans-first:71533.03 02:32:13 INFO - PROCESS | 15968 | Values: 546.1 580.2 585.9 590.6 606.7 28081.6 35555.0 36082.0 36138.0 36159.5 38628.4 38971.0 39014.8 39089.2 39118.6 7427.6 8385.3 8526.0 8531.1 8537.2 7586.1 10012.0 10241.0 10249.7 10264.1 10024.0 10061.3 10119.2 10122.6 10144.6 7675.1 7860.5 9914.6 10043.0 10077.2 10040.3 10242.6 10259.0 10265.7 10313.6 38666.4 39441.2 39550.6 39563.0 39725.0 2878.9 2951.9 3181.9 3433.7 3493.0 29525.7 29670.3 29787.0 29944.6 30244.8 3888.7 3994.7 4029.2 4055.9 4089.3 203172.0 204757.0 205385.0 261928.0 261950.0 50750.2 51929.5 56336.0 57919.4 57944.0 61208.7 62427.0 62682.0 62724.4 62799.0 14023.2 14068.3 14078.0 14134.2 14232.2 10839.8 10900.7 10913.6 10914.2 10918.6 18695.2 18783.2 18797.8 18807.9 18811.2 7120.9 7480.6 7498.4 7512.2 7513.9 944.6 945.3 971.0 1032.6 1126.7 27977.0 28038.4 28466.6 28694.4 28877.6 1027.1 1136.0 1141.0 1165.0 1174.9 14860.9 14913.6 14967.9 15093.6 15120.4 330798.0 335320.0 335958.0 336090.0 336695.0 51272.2 51530.5 51635.5 51669.0 51823.5 1305.0 1313.2 1317.3 1324.9 1330.1 24215.3 27190.5 27339.9 28835.0 28854.4 41955.6 42381.4 42384.6 42396.8 42430.4 238458.0 243442.0 243644.0 244126.0 244225.0 27216.0 27888.6 30395.0 30949.8 31010.4 36076.5 36415.0 36845.6 37307.4 37468.6 30773.4 32848.7 35571.3 35604.8 35769.3 34791.1 35331.0 35361.3 35663.0 35671.5 33841.7 34397.5 34472.8 34791.3 34794.3 31149.8 31398.7 31761.8 31848.0 32200.2 23230.5 23260.4 23436.8 25027.9 25270.7 02:32:13 INFO - PROCESS | 15968 | 02:32:13 INFO - PROCESS | 15968 | [#2] jquery.html Cycles:180 Average:26010.98 Median:356.03 stddev:73810.58 (20731.5%) stddev-sans-first:73992.49 02:32:13 INFO - PROCESS | 15968 | Values: 349.9 351.9 355.6 356.5 357.4 13994.5 14298.5 16214.1 16761.6 17646.8 16406.0 16422.6 16430.0 16545.7 16546.8 5142.8 5443.7 5446.3 5448.9 5454.8 3932.5 4064.4 4067.0 5331.1 5841.3 5962.9 5978.0 6005.5 6009.7 6021.7 5816.1 5973.8 5981.3 5990.1 5991.3 5228.8 5250.4 5277.4 5282.6 5285.1 20449.6 20605.4 20880.3 20901.0 20930.3 2103.4 2139.3 2182.8 2498.7 2589.9 12642.8 12918.8 12961.9 13262.0 13340.7 1843.2 1895.5 1900.1 1910.0 1921.3 57087.4 60026.7 60049.7 60124.7 60311.0 9603.8 9628.8 9968.9 9969.0 9993.6 12981.2 13049.3 13067.1 13068.3 13069.7 6734.1 7094.5 7119.9 7407.2 7507.1 7150.8 7200.5 7217.4 7246.4 7260.1 5916.1 6001.4 6013.9 6049.0 6052.0 1657.4 1718.1 1721.9 1740.4 1772.5 902.5 941.7 993.4 1026.4 1045.5 15364.8 16450.3 17886.0 18168.5 18563.5 909.7 930.8 942.8 946.0 971.6 10244.9 10389.2 10422.5 10543.6 10566.1 361125.0 368202.0 369958.0 549974.0 556256.0 78267.0 80887.2 81084.2 81950.6 82161.0 893.8 894.0 894.7 957.8 1010.8 15369.7 15629.6 15848.3 16073.4 16147.5 32243.4 32964.8 33758.3 34749.5 35323.1 38150.8 38770.2 40036.4 40978.4 42273.0 9106.4 9254.1 9787.0 9802.5 9826.3 16862.0 16956.4 17009.8 17218.0 17600.6 14467.4 14697.7 14850.4 14921.9 14998.6 10217.0 13760.0 14206.5 14817.1 14894.0 12068.2 12433.3 14100.4 14380.2 14775.0 9239.6 9338.1 9346.9 9352.9 9368.3 13631.7 13665.5 13785.4 14006.3 14465.9 02:32:13 INFO - PROCESS | 15968 | 02:32:13 INFO - PROCESS | 15968 | [#3] mootools.html Cycles:180 Average:4698.67 Median:5834.40 stddev:2312.17 (39.6%) stddev-sans-first:2304.60 02:32:13 INFO - PROCESS | 15968 | Values: 1307.3 1399.1 1432.1 1535.2 1732.0 6006.6 6425.6 6499.3 6513.6 6530.9 6351.4 6468.3 6493.4 6502.1 6510.7 1820.9 1856.7 2042.0 2056.1 2086.7 2142.4 2146.7 2147.0 2148.2 2150.5 2008.5 2053.0 2068.1 2068.2 2069.8 2052.8 2086.9 2088.0 2108.6 2111.3 2101.1 2146.6 2152.0 2164.8 2169.6 6665.2 6703.7 6717.2 6722.2 6728.3 4171.2 4205.1 4232.7 4234.0 4235.5 2787.5 2815.9 2832.1 2833.3 2950.4 866.4 869.9 872.5 877.3 915.9 8677.0 8680.3 8681.9 8689.8 8712.2 3644.9 3654.1 3679.9 3692.2 3716.7 7657.7 7667.6 7671.2 7673.7 7681.7 4142.9 4150.7 4151.1 4152.2 4152.7 3798.1 3805.5 3835.0 3844.2 3844.6 3045.1 3070.1 3228.5 3272.6 3278.5 1019.4 1028.1 1037.7 1038.7 1041.0 1059.4 1061.7 1109.1 1220.6 1341.2 6305.8 6323.5 6356.3 6381.9 6385.3 1076.1 1088.5 1096.6 1097.1 1102.7 5034.2 5147.4 5148.7 5149.7 5151.2 7620.5 7777.3 7825.0 7854.5 7880.0 7807.6 7810.9 7872.0 7879.9 7888.6 6343.4 6384.1 6390.5 6395.8 6396.2 5925.3 6069.5 6071.0 6072.9 6083.9 7048.9 7094.4 7173.3 7207.4 7252.7 7164.8 7233.1 7299.6 7330.5 7338.1 6071.2 6124.7 6126.7 6135.8 6136.0 5836.0 5913.3 5916.1 6187.3 6529.9 5950.7 6046.0 6068.2 6113.4 6130.0 5832.8 5842.8 5874.6 5905.5 5924.1 5942.9 5956.6 5973.9 6000.8 6007.2 5416.7 5541.3 5563.7 5571.3 5583.5 5610.8 5661.1 5674.7 5676.5 5679.3 02:32:13 INFO - PROCESS | 15968 | 02:32:13 INFO - PROCESS | 15968 | [#4] prototype.html Cycles:180 Average:5346.51 Median:6037.97 stddev:1611.40 (26.7%) stddev-sans-first:1571.17 02:32:13 INFO - PROCESS | 15968 | Values: 322.0 328.3 329.0 330.1 337.9 5864.3 6009.1 6046.4 6068.7 6071.4 5801.7 5905.7 5906.8 5971.4 6003.8 4648.7 4660.3 4665.4 4667.6 4673.9 4435.1 4498.8 4507.6 4517.1 4672.8 4500.4 4593.9 4612.9 4615.0 4619.9 4628.1 4634.1 4635.3 4643.2 4666.7 4093.3 4094.5 4095.5 4102.9 4105.6 5618.0 5718.7 5722.1 5729.9 5734.4 5358.5 5384.6 5387.6 5389.8 5395.2 6033.4 6332.8 6351.0 6361.9 6364.9 4388.0 4422.3 4504.9 4518.2 4519.5 6608.6 6631.7 6641.0 6642.8 6645.1 4611.3 4611.9 4615.3 4617.8 4617.9 4439.6 4599.0 4604.8 4661.5 4668.9 5331.5 5334.3 5336.3 5337.0 5339.3 6433.0 6438.2 6440.9 6441.7 6445.7 1599.5 1619.5 1619.8 1620.3 1622.2 1004.8 1019.5 1023.0 1068.9 1079.9 5896.4 5927.9 6053.8 6054.7 6062.4 6591.1 6591.8 6602.8 6618.2 6623.6 5881.0 6042.5 6048.1 6049.6 6058.0 3550.7 3566.5 3578.0 3581.4 3588.6 6894.9 6896.5 6904.2 6905.1 6906.2 6589.2 6773.6 6783.4 6789.2 6790.2 6855.2 6870.9 6877.4 6878.5 6880.4 6604.5 6607.9 6614.0 6615.4 6616.4 6328.1 6512.6 6521.7 6527.6 6547.2 6848.8 6856.2 6860.2 6864.8 6871.1 4493.6 4495.7 4497.1 4499.0 4505.6 6560.0 6603.7 6605.8 6621.0 6633.5 6241.2 6390.4 6405.5 6428.5 6450.7 6352.7 6352.9 6358.1 6358.5 6362.1 6199.2 6316.6 6324.1 6341.4 6342.7 6461.8 6470.1 6475.5 6479.7 6481.8 6278.8 6279.9 6281.0 6283.9 6287.2 02:32:13 INFO - PROCESS | 15968 | 02:32:13 INFO - PROCESS | 15968 | [#5] yui.html Cycles:180 Average:13494.55 Median:44803.83 stddev:15313.82 (34.2%) stddev-sans-first:15326.83 02:32:13 INFO - PROCESS | 15968 | Values: 741.2 748.5 792.4 836.4 847.6 13234.4 13340.5 13368.3 13410.4 13424.3 12658.9 12685.6 12740.9 14112.8 14718.7 690.4 829.5 837.5 841.4 844.0 695.0 839.8 842.9 844.0 845.9 866.7 878.4 878.4 878.7 878.7 725.0 726.0 868.5 872.1 877.6 644.7 646.9 647.6 647.8 648.1 14141.2 14217.5 14244.1 14252.5 14287.0 11637.7 11814.0 12084.0 12252.1 12312.8 9996.1 10388.8 10427.7 10526.0 10729.9 3582.2 3639.8 3649.7 3690.1 3757.5 44923.6 44943.3 44944.8 45290.3 45304.5 9699.4 9947.1 9977.7 10048.6 10494.1 17371.4 17465.2 17477.9 17487.9 17506.6 7047.6 7290.0 7300.4 7379.7 7399.1 4328.8 4370.7 4407.0 4468.0 4548.6 3037.5 3066.7 3067.8 3074.6 3076.8 510.5 513.5 517.2 517.5 524.7 605.3 630.0 635.0 644.3 660.8 7683.0 8362.4 8517.9 8540.6 8552.7 432.6 562.4 624.5 635.7 659.8 3798.5 3833.2 3932.0 3941.5 4041.0 49125.3 49347.0 49420.5 49594.5 49992.5 49721.5 51518.0 51794.7 52016.2 52359.5 43281.3 43502.3 44022.3 44230.6 44684.1 7924.7 8203.8 8379.6 8388.3 8481.9 34238.8 34487.3 37332.6 38939.0 39344.6 43912.0 46298.5 47994.3 48673.8 49142.5 10508.8 11447.5 11648.3 11740.4 12096.2 10711.6 10906.9 10913.7 10931.6 11011.7 10545.3 10651.5 10746.7 11414.1 11697.4 11674.8 11897.2 12054.2 12080.9 12223.0 10385.3 10418.6 10631.4 10775.6 10795.6 9846.9 10069.2 10237.4 10476.7 10530.4 8944.8 9072.6 9124.8 9368.7 9378.4 02:32:13 INFO - PROCESS | 15968 | -------- Summary: end -------- 02:32:13 INFO - PROCESS | 15968 | 02:32:14 INFO - TEST-INFO | 15968: exit 0 02:32:14 INFO - TEST-OK | dromaeo_css | took 1112368ms 02:32:14 INFO - TEST-START | kraken 02:32:14 INFO - operating with platform_type : linux_ 02:32:14 INFO - Initialising browser for kraken test... 02:32:14 INFO - TEST-INFO | started process 16171 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxp9zCv/profile http://localhost:60612/getInfo.html) 02:32:17 INFO - PROCESS | 16171 | __metrics Screen width/height:1600/1200 02:32:17 INFO - PROCESS | 16171 | colorDepth:24 02:32:17 INFO - PROCESS | 16171 | Browser inner width/height: 1024/697 02:32:17 INFO - PROCESS | 16171 | __metrics 02:32:18 INFO - PROCESS | 16171 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:32:18 INFO - PROCESS | 16171 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:32:19 INFO - TEST-INFO | 16171: exit 0 02:32:19 INFO - Browser initialized. 02:32:19 INFO - Running cycle 1/1 for kraken test... 02:32:19 INFO - TEST-INFO | started process 16252 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxp9zCv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:30 INFO - PROCESS | 16252 | RSS: Main: 149225472 02:32:30 INFO - PROCESS | 16252 | 02:32:33 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60612/tests/kraken/driver.html?testName=audio-beat-detection) 02:32:34 INFO - PROCESS | 16252 | RSS: Main: 184049664 02:32:34 INFO - PROCESS | 16252 | 02:32:36 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60612/tests/kraken/driver.html?testName=audio-dft) 02:32:37 INFO - PROCESS | 16252 | RSS: Main: 175218688 02:32:37 INFO - PROCESS | 16252 | 02:32:40 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60612/tests/kraken/driver.html?testName=audio-fft) 02:32:40 INFO - PROCESS | 16252 | RSS: Main: 161046528 02:32:40 INFO - PROCESS | 16252 | 02:32:42 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60612/tests/kraken/driver.html?testName=audio-oscillator) 02:32:43 INFO - PROCESS | 16252 | RSS: Main: 162877440 02:32:43 INFO - PROCESS | 16252 | 02:32:45 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60612/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:32:45 INFO - PROCESS | 16252 | RSS: Main: 163885056 02:32:45 INFO - PROCESS | 16252 | 02:32:48 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60612/tests/kraken/driver.html?testName=imaging-darkroom) 02:32:49 INFO - PROCESS | 16252 | RSS: Main: 164691968 02:32:49 INFO - PROCESS | 16252 | 02:32:52 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60612/tests/kraken/driver.html?testName=imaging-desaturate) 02:32:53 INFO - PROCESS | 16252 | RSS: Main: 165543936 02:32:53 INFO - PROCESS | 16252 | 02:32:56 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60612/tests/kraken/driver.html?testName=json-parse-financial) 02:32:56 INFO - PROCESS | 16252 | RSS: Main: 165052416 02:32:56 INFO - PROCESS | 16252 | 02:32:58 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60612/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:32:58 INFO - PROCESS | 16252 | RSS: Main: 175640576 02:32:58 INFO - PROCESS | 16252 | 02:33:00 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60612/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:33:01 INFO - PROCESS | 16252 | RSS: Main: 174235648 02:33:01 INFO - PROCESS | 16252 | 02:33:03 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60612/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:33:03 INFO - PROCESS | 16252 | RSS: Main: 180666368 02:33:03 INFO - PROCESS | 16252 | 02:33:06 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:33:06 INFO - PROCESS | 16252 | RSS: Main: 190070784 02:33:06 INFO - PROCESS | 16252 | 02:33:09 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:33:09 INFO - PROCESS | 16252 | RSS: Main: 187580416 02:33:09 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | Cycle 1(1): loaded http://localhost:60612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60612/tests/kraken/driver.html?testName=ai-astar) 02:33:11 INFO - PROCESS | 16252 | RSS: Main: 245915648 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | __start_tp_report 02:33:11 INFO - PROCESS | 16252 | _x_x_mozilla_page_load 02:33:11 INFO - PROCESS | 16252 | _x_x_mozilla_page_load_details 02:33:11 INFO - PROCESS | 16252 | |i|pagename|runs| 02:33:11 INFO - PROCESS | 16252 | |0;ai-astar;109;110;104;110;111;112;101;109;111;101 02:33:11 INFO - PROCESS | 16252 | |1;audio-beat-detection;169;127;149;159;123;147;146;126;163;123 02:33:11 INFO - PROCESS | 16252 | |2;audio-dft;160;160;160;162;160;161;160;159;160;160 02:33:11 INFO - PROCESS | 16252 | |3;audio-fft;73;71;78;93;73;74;71;100;94;71 02:33:11 INFO - PROCESS | 16252 | |4;audio-oscillator;97;96;142;96;96;97;144;96;96;140 02:33:11 INFO - PROCESS | 16252 | |5;imaging-gaussian-blur;109;110;110;110;109;109;109;110;109;109 02:33:11 INFO - PROCESS | 16252 | |6;imaging-darkroom;146;145;146;146;146;145;145;145;145;145 02:33:11 INFO - PROCESS | 16252 | |7;imaging-desaturate;95;95;95;96;96;95;95;96;95;95 02:33:11 INFO - PROCESS | 16252 | |8;json-parse-financial;58;56;55;56;55;57;55;68;53;54 02:33:11 INFO - PROCESS | 16252 | |9;json-stringify-tinderbox;67;69;69;67;68;68;68;69;68;68 02:33:11 INFO - PROCESS | 16252 | |10;stanford-crypto-aes;83;91;85;85;86;86;88;88;86;86 02:33:11 INFO - PROCESS | 16252 | |11;stanford-crypto-ccm;114;121;124;119;121;119;134;132;115;114 02:33:11 INFO - PROCESS | 16252 | |12;stanford-crypto-pbkdf2;140;154;151;153;164;148;151;150;150;140 02:33:11 INFO - PROCESS | 16252 | |13;stanford-crypto-sha256-iterative;67;67;68;67;66;66;67;68;69;67 02:33:11 INFO - PROCESS | 16252 | __end_tp_report 02:33:11 INFO - PROCESS | 16252 | __start_cc_report 02:33:11 INFO - PROCESS | 16252 | _x_x_mozilla_cycle_collect,938 02:33:11 INFO - PROCESS | 16252 | __end_cc_report 02:33:11 INFO - PROCESS | 16252 | __startTimestamp1451385191914__endTimestamp 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | ------- Summary: start ------- 02:33:11 INFO - PROCESS | 16252 | Number of tests: 14 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#0] ai-astar Cycles:10 Average:107.80 Median:110.00 stddev:4.18 (3.8%) stddev-sans-first:4.42 02:33:11 INFO - PROCESS | 16252 | Values: 109.0 110.0 104.0 110.0 111.0 112.0 101.0 109.0 111.0 101.0 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:148.00 stddev:17.44 (11.8%) stddev-sans-first:15.80 02:33:11 INFO - PROCESS | 16252 | Values: 169.0 127.0 149.0 159.0 123.0 147.0 146.0 126.0 163.0 123.0 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 02:33:11 INFO - PROCESS | 16252 | Values: 160.0 160.0 160.0 162.0 160.0 161.0 160.0 159.0 160.0 160.0 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#3] audio-fft Cycles:10 Average:79.80 Median:73.50 stddev:11.28 (15.3%) stddev-sans-first:11.70 02:33:11 INFO - PROCESS | 16252 | Values: 73.0 71.0 78.0 93.0 73.0 74.0 71.0 100.0 94.0 71.0 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:22.11 (23.0%) stddev-sans-first:22.94 02:33:11 INFO - PROCESS | 16252 | Values: 97.0 96.0 142.0 96.0 96.0 97.0 144.0 96.0 96.0 140.0 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:33:11 INFO - PROCESS | 16252 | Values: 109.0 110.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:33:11 INFO - PROCESS | 16252 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:33:11 INFO - PROCESS | 16252 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:4.22 (7.5%) stddev-sans-first:4.45 02:33:11 INFO - PROCESS | 16252 | Values: 58.0 56.0 55.0 56.0 55.0 57.0 55.0 68.0 53.0 54.0 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 02:33:11 INFO - PROCESS | 16252 | Values: 67.0 69.0 69.0 67.0 68.0 68.0 68.0 69.0 68.0 68.0 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:2.17 (2.5%) stddev-sans-first:1.92 02:33:11 INFO - PROCESS | 16252 | Values: 83.0 91.0 85.0 85.0 86.0 86.0 88.0 88.0 86.0 86.0 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:121.00 stddev:6.99 (5.8%) stddev-sans-first:6.90 02:33:11 INFO - PROCESS | 16252 | Values: 114.0 121.0 124.0 119.0 121.0 119.0 134.0 132.0 115.0 114.0 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:151.00 stddev:6.89 (4.6%) stddev-sans-first:6.26 02:33:11 INFO - PROCESS | 16252 | Values: 140.0 154.0 151.0 153.0 164.0 148.0 151.0 150.0 150.0 140.0 02:33:11 INFO - PROCESS | 16252 | 02:33:11 INFO - PROCESS | 16252 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 02:33:11 INFO - PROCESS | 16252 | Values: 67.0 67.0 68.0 67.0 66.0 66.0 67.0 68.0 69.0 67.0 02:33:11 INFO - PROCESS | 16252 | -------- Summary: end -------- 02:33:11 INFO - PROCESS | 16252 | 02:33:12 INFO - TEST-INFO | 16252: exit 0 02:33:12 INFO - TEST-OK | kraken | took 58311ms 02:33:12 INFO - TEST-START | v8_7 02:33:12 INFO - operating with platform_type : linux_ 02:33:12 INFO - Initialising browser for v8_7 test... 02:33:12 INFO - TEST-INFO | started process 16499 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgiEglA/profile http://localhost:60612/getInfo.html) 02:33:16 INFO - PROCESS | 16499 | __metrics Screen width/height:1600/1200 02:33:16 INFO - PROCESS | 16499 | colorDepth:24 02:33:16 INFO - PROCESS | 16499 | Browser inner width/height: 1024/697 02:33:16 INFO - PROCESS | 16499 | __metrics 02:33:16 INFO - PROCESS | 16499 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:33:16 INFO - PROCESS | 16499 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:33:17 INFO - TEST-INFO | 16499: exit 0 02:33:17 INFO - Browser initialized. 02:33:17 INFO - Running cycle 1/1 for v8_7 test... 02:33:17 INFO - TEST-INFO | started process 16583 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgiEglA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:29 INFO - PROCESS | 16583 | RSS: Main: 148148224 02:33:29 INFO - PROCESS | 16583 | 02:33:50 INFO - PROCESS | 16583 | Cycle 1(1): loaded http://localhost:60612/tests/v8_7/run.html (next: http://localhost:60612/tests/v8_7/run.html) 02:33:50 INFO - PROCESS | 16583 | RSS: Main: 574349312 02:33:50 INFO - PROCESS | 16583 | 02:33:50 INFO - PROCESS | 16583 | __start_tp_report 02:33:50 INFO - PROCESS | 16583 | _x_x_mozilla_page_load 02:33:50 INFO - PROCESS | 16583 | _x_x_mozilla_page_load_details 02:33:50 INFO - PROCESS | 16583 | |i|pagename|runs| 02:33:50 INFO - PROCESS | 16583 | |0;Richards;166.05778811026238 02:33:50 INFO - PROCESS | 16583 | |1;DeltaBlue;191.93857965451056 02:33:50 INFO - PROCESS | 16583 | |2;Encrypt;282.6455624646693 02:33:50 INFO - PROCESS | 16583 | |3;Decrypt;5191.709844559586 02:33:50 INFO - PROCESS | 16583 | |4;RayTrace;1112.3470522803113 02:33:50 INFO - PROCESS | 16583 | |5;Earley;789.8894154818325 02:33:50 INFO - PROCESS | 16583 | |6;Boyer;12625 02:33:50 INFO - PROCESS | 16583 | |7;RegExp;25948.71794871795 02:33:50 INFO - PROCESS | 16583 | |8;Splay;635.3240152477764 02:33:50 INFO - PROCESS | 16583 | |9;NavierStokes;4830.917874396136 02:33:50 INFO - PROCESS | 16583 | __end_tp_report 02:33:50 INFO - PROCESS | 16583 | __startTimestamp1451385230857__endTimestamp 02:33:50 INFO - PROCESS | 16583 | 02:33:50 INFO - PROCESS | 16583 | ------- Summary: start ------- 02:33:50 INFO - PROCESS | 16583 | Number of tests: 10 02:33:50 INFO - PROCESS | 16583 | 02:33:50 INFO - PROCESS | 16583 | [#0] Richards Cycles:1 Average:166.06 Median:166.06 stddev:0.00 (0.0%) 02:33:50 INFO - PROCESS | 16583 | Values: 166.1 02:33:50 INFO - PROCESS | 16583 | 02:33:50 INFO - PROCESS | 16583 | [#1] DeltaBlue Cycles:1 Average:191.94 Median:191.94 stddev:0.00 (0.0%) 02:33:50 INFO - PROCESS | 16583 | Values: 191.9 02:33:50 INFO - PROCESS | 16583 | 02:33:50 INFO - PROCESS | 16583 | [#2] Encrypt Cycles:1 Average:282.65 Median:282.65 stddev:0.00 (0.0%) 02:33:50 INFO - PROCESS | 16583 | Values: 282.6 02:33:50 INFO - PROCESS | 16583 | 02:33:50 INFO - PROCESS | 16583 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 02:33:50 INFO - PROCESS | 16583 | Values: 5191.7 02:33:50 INFO - PROCESS | 16583 | 02:33:50 INFO - PROCESS | 16583 | [#4] RayTrace Cycles:1 Average:1112.35 Median:1112.35 stddev:0.00 (0.0%) 02:33:50 INFO - PROCESS | 16583 | Values: 1112.3 02:33:50 INFO - PROCESS | 16583 | 02:33:50 INFO - PROCESS | 16583 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 02:33:50 INFO - PROCESS | 16583 | Values: 789.9 02:33:50 INFO - PROCESS | 16583 | 02:33:50 INFO - PROCESS | 16583 | [#6] Boyer Cycles:1 Average:12625.00 Median:12625.00 stddev:0.00 (0.0%) 02:33:50 INFO - PROCESS | 16583 | Values: 12625.0 02:33:50 INFO - PROCESS | 16583 | 02:33:50 INFO - PROCESS | 16583 | [#7] RegExp Cycles:1 Average:25948.72 Median:25948.72 stddev:0.00 (0.0%) 02:33:50 INFO - PROCESS | 16583 | Values: 25948.7 02:33:50 INFO - PROCESS | 16583 | 02:33:50 INFO - PROCESS | 16583 | [#8] Splay Cycles:1 Average:635.32 Median:635.32 stddev:0.00 (0.0%) 02:33:50 INFO - PROCESS | 16583 | Values: 635.3 02:33:50 INFO - PROCESS | 16583 | 02:33:50 INFO - PROCESS | 16583 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 02:33:50 INFO - PROCESS | 16583 | Values: 4830.9 02:33:50 INFO - PROCESS | 16583 | -------- Summary: end -------- 02:33:50 INFO - PROCESS | 16583 | 02:33:51 INFO - TEST-INFO | 16583: exit 0 02:33:51 INFO - TEST-OK | v8_7 | took 38928ms 02:33:51 INFO - SUITE-END | took 1209s 02:33:51 INFO - Completed test suite (00:20:09) 02:33:51 INFO - Working with test: dromaeo_css 02:33:51 INFO - Generating results file: dromaeo_css 02:33:51 INFO - Working with test: kraken 02:33:51 INFO - Generating results file: kraken 02:33:51 INFO - javascript benchmark 02:33:51 INFO - Working with test: v8_7 02:33:51 INFO - Generating results file: v8_7 02:33:51 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:33:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 02:33:51 INFO - process_Request line: dromaeo_css 6785.10 graph.html#tests=[[72,64,35]] 02:33:51 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:33:52 INFO - process_Request line: kraken 1500.90 graph.html#tests=[[232,64,35]] 02:33:52 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:33:52 INFO - process_Request line: v8_7 20791.03 graph.html#tests=[[230,64,35]] 02:33:52 INFO - RETURN: dromaeo_css: 6785.10 02:33:52 INFO - RETURN: kraken: 1500.90 02:33:52 INFO - RETURN: v8_7: 20791.03 02:33:52 INFO - javascript benchmark 02:33:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3104.2084268511535, 3145.7168854803062, 3188.8360748326854, 3193.217661672889, 3210.7752457327983, 5084.796608135679, 5180.326557547513, 5232.7122008289525, 5263.76313065912, 5291.576673866091, 5136.768845401956, 5190.9740451297785, 5199.4800519947985, 5213.530782229599, 5220.712860792655, 4673.602743766767, 4691.460482044575, 4763.404574428197, 4847.806087756486, 4870.512948705136, 4767.690100143497, 4826.0830442215865, 4843.927341089887, 4891.902161956758, 4919.212925931852, 4647.976760116211, 4687.507811679776, 4749.4775574686755, 4759.833405830814, 4761.381020467352, 4762.333273341735, 4763.69036012658, 4783.976080119577, 4822.734749588772, 4823.662343635947, 4695.9668872847915, 4758.524147585248, 4768.690035147704, 4768.831636249141, 4802.831900883452, 4976.552110310054, 5027.321311622957, 5088.211327244283, 5100.693958362473, 5101.591872650179, 5653.208550802891, 5653.575981801381, 5666.291713535808, 5667.291588551431, 5667.716614169275, 5640.689762063085, 5668.121441176624, 5669.121286200645, 5671.517920976722, 5675.0, 5145.742712864379, 5233.764480598345, 5250.8687282817855, 5285.867853303621, 5347.224652425377, 5725.570582206351, 5735.311762588516, 5739.938111449395, 5741.368449470555, 5781.53747700183, 5451.454854514596, 5527.419620939824, 5540.335159780852, 5540.473655002768, 5547.472990065938, 5600.691961942132, 5657.43425657431, 5690.118031705092, 5697.4302569742695, 5751.22358481608, 5570.0, 5571.526420254243, 5572.247746554163, 5576.7211639417865, 5582.91625625616, 5498.642588231752, 5616.2698849150165, 5624.353199382042, 5644.85887852807, 5684.63049901755, 4276.764777937181, 4332.870013899588, 4345.239583073013, 4352.499462561783, 4384.956150438518, 3874.96125038746, 3887.378019516864, 3890.922181556353, 3893.279743247508, 3918.392649139388, 5067.011932673094, 5099.133147364957, 5115.462876397999, 5178.119719647669, 5178.482151784867, 5651.321841378978, 5660.575456840754, 5661.603687741901, 5662.66024038559, 5710.543156547466, 5217.34783152106, 5229.895402092013, 5234.607404444682, 5238.319018527567, 5280.049591073644, 4779.0680817241, 4848.490908454632, 4875.414950205998, 4884.072026314989, 4894.975525122351, 5864.765409383577, 5865.970670146708, 5867.765289388462, 5870.119482077637, 5874.412558744177, 5632.662040277596, 5638.041532939328, 5641.9435805641415, 5649.0, 5686.374498805211, 5636.577256705681, 5673.0, 5727.971360143172, 5781.508571771446, 5851.268591426072, 5526.115821468546, 5548.916766248429, 5554.389017208023, 5558.638688485235, 5599.132134519156, 5602.859928501657, 5605.0, 5605.495505404533, 5606.943930560806, 5620.4098569649595, 5366.141417373202, 5460.34475862899, 5468.890622187613, 5478.726063696879, 5507.862303442446, 5370.9731451342495, 5394.298741163623, 5406.080966235828, 5426.8371948841595, 5468.671879687232, 5356.089464791073, 5360.517553420211, 5363.865903352447, 5368.865778355416, 5370.221317908803, 5414.29614150158, 5428.4842939920645, 5491.6979566122645, 5492.203630473638, 5493.09363954943, 5300.7084610345255, 5366.758495867617, 5394.2448057272795, 5396.1905714143195, 5415.891682166413], "unit": "score", "name": "dojo.html", "value": 5171.068175064857}, {"lowerIsBetter": false, "replicates": [546.0583186505369, 580.1848402993794, 585.8886811505813, 590.5777369181036, 606.6784604159791, 28081.578776318347, 35555.0, 36082.0, 36138.0, 36159.45760813583, 38628.420573691415, 38971.0, 39014.804925975404, 39089.218215635745, 39118.60881391185, 7427.554346739186, 8385.287250583708, 8526.0, 8531.146885311451, 8537.18896704812, 7586.051743532059, 10012.0, 10241.0, 10249.692509224735, 10264.127549158331, 10024.047715467055, 10061.295709300352, 10119.190464762838, 10122.59509619618, 10144.644937427192, 7675.078990521118, 7860.528368297921, 9914.55384507699, 10043.0, 10077.24420668449, 10040.347377420518, 10242.641507547274, 10259.0, 10265.692029239135, 10313.587456501731, 38666.42000369997, 39441.21117577661, 39550.61572844937, 39563.0, 39725.0, 2878.8848446062134, 2951.919344725668, 3181.904542863718, 3433.7081348085444, 3493.004493719278, 29525.704742952512, 29670.258243543867, 29787.0, 29944.550831737542, 30244.8487757562, 3888.727789054767, 3994.7003974701724, 4029.15387768566, 4055.9188816223805, 4089.3048181809163, 203172.0, 204757.0, 205385.0, 261928.0, 261950.0, 50750.238746418836, 51929.48070519322, 56336.0, 57919.4208057914, 57944.0, 61208.69395652993, 62427.0, 62682.0, 62724.372756271856, 62799.0, 14023.158610483404, 14068.296585170701, 14078.0, 14134.222617755917, 14232.21722805235, 10839.83740243897, 10900.727481812859, 10913.563457461612, 10914.181436392302, 10918.617848375268, 18695.15871785773, 18783.24867005332, 18797.81202187988, 18807.90596047011, 18811.247550097843, 7120.857582848417, 7480.551166930001, 7498.4001279897475, 7512.173660897297, 7513.887291690629, 944.5560586524323, 945.3382632157517, 971.0, 1032.5869652139054, 1126.7295848996346, 27977.0, 28038.43923121567, 28466.573001404995, 28694.42611147807, 28877.56683649747, 1027.0807627173788, 1135.9545618175346, 1141.0, 1165.0213820390911, 1174.9177557571059, 14860.92569537167, 14913.644430003162, 14967.925160374347, 15093.622659433382, 15120.395184192728, 330798.0, 335320.0, 335958.0, 336090.0, 336695.0, 51272.23091653628, 51530.48469515257, 51635.48364516382, 51669.0, 51823.481765182616, 1304.9934750326188, 1313.1923866821835, 1317.2952470428274, 1324.9403776830065, 1330.1287656584952, 24215.273541793773, 27190.456190876466, 27339.86330068337, 28835.0, 28854.42291154207, 41955.58044419639, 42381.36427953521, 42384.576154238064, 42396.78801605972, 42430.36354454624, 238458.0, 243442.0, 243644.0, 244126.0, 244225.0, 27216.0, 27888.58167127535, 30395.0, 30949.845250773604, 31010.379792404477, 36076.4588531167, 36415.0, 36845.63154368529, 37307.440388393654, 37468.62531374651, 30773.384532309676, 32848.671513284564, 35571.288574228885, 35604.82197588996, 35769.28461430809, 34791.130221743646, 35331.0, 35361.29277414386, 35663.0, 35671.46492802558, 33841.66158338385, 34397.484037738956, 34472.82763586166, 34791.304173916884, 34794.304113918086, 31149.844250778602, 31398.686013139577, 31761.841190793897, 31848.0, 32200.19499512531, 23230.53538929178, 23260.418489537897, 23436.765632343457, 25027.870401383567, 25270.74729252684], "unit": "score", "name": "ext.html", "value": 18007.278020822276}, {"lowerIsBetter": false, "replicates": [349.92921659721253, 351.90322661268146, 355.56976058968644, 356.4919989015652, 357.36567592523267, 13994.510192143278, 14298.499552515665, 16214.108224047674, 16761.580960475992, 17646.82353176466, 16406.015639061665, 16422.589435264123, 16430.0, 16545.66908661826, 16546.751798723028, 5142.794288228466, 5443.673379597217, 5446.2647542581835, 5448.863778405532, 5454.754536045887, 3932.547757007952, 4064.390341448777, 4066.9796651016704, 5331.093714068617, 5841.269841269841, 5962.8807423851495, 5978.0, 6005.489533389646, 6009.729562169713, 6021.729022194012, 5816.098504731774, 5973.820785376424, 5981.342052374235, 5990.1314309425325, 5991.2510936132985, 5228.764705588258, 5250.396204436501, 5277.419483856773, 5282.603804714623, 5285.101532739443, 20449.5910081799, 20605.38183854487, 20880.269190578256, 20901.0, 20930.267440639505, 2103.442587714257, 2139.3047259640525, 2182.8253739700785, 2498.7376325485743, 2589.8705064746687, 12642.810357844639, 12918.772716592002, 12961.935190323988, 13262.0, 13340.666483337896, 1843.2075405760284, 1895.535593779519, 1900.106949733623, 1909.961800763977, 1921.3083290015584, 57087.429125709044, 60026.699866500385, 60049.699751500964, 60124.69937650284, 60311.0, 9603.807923841485, 9628.807423851624, 9968.900310996942, 9969.0, 9993.550290236957, 12981.156224845356, 13049.28228947398, 13067.085304028817, 13068.346582670829, 13069.738605227842, 6734.114447954581, 7094.53885497441, 7119.89320160198, 7407.185209626937, 7507.061617297838, 7150.821229469201, 7200.495965282485, 7217.386522145676, 7246.384057355079, 7260.128784545888, 5916.083007133901, 6001.4298641628975, 6013.879722405615, 6048.9697551512845, 6052.0, 1657.395050806447, 1718.149515989593, 1721.8622510199154, 1740.4343588333588, 1772.512559046247, 902.4810733827944, 941.7268991992246, 993.4039576254189, 1026.43033116621, 1045.513836066233, 15364.769528457082, 16450.259738311564, 17886.0, 18168.545786355447, 18563.535911602317, 909.7498187998353, 930.8464103422995, 942.8302905476943, 945.9621615135318, 971.5530855806267, 10244.897551024544, 10389.220808439397, 10422.478876056166, 10543.630972916064, 10566.101881340019, 361125.0, 368202.0, 369958.0, 549974.0, 556256.0, 78267.0, 80887.19112808914, 81084.18915810884, 81950.59024704958, 82161.0, 893.7542175901679, 893.9687110951086, 894.6689724801735, 957.8467445208734, 1010.782681723433, 15369.692606148039, 15629.609259768142, 15848.28682709304, 16073.437429689904, 16147.515574532783, 32243.35513289768, 32964.835175823966, 33758.324833503684, 34749.47875781916, 35323.116922077155, 38150.80924595359, 38770.224595508495, 40036.399454008795, 40978.38532421956, 42273.0, 9106.408083474553, 9254.074592540692, 9786.951065244628, 9802.460864652227, 9826.312158148861, 16862.0, 16956.406525771537, 17009.829901700825, 17218.0, 17600.64798703993, 14467.421303147756, 14697.70604587881, 14850.40598376053, 14921.925390372979, 14998.550043498712, 10217.0, 13760.0, 14206.502772402917, 14817.110973341634, 14894.0, 12068.215565988183, 12433.254004759381, 14100.36548355347, 14380.209088500233, 14775.039622424509, 9239.630414783333, 9338.066193380879, 9346.878374595091, 9352.906470935475, 9368.34421590482, 13631.727365452834, 13665.453381864614, 13785.379657915619, 14006.299685015505, 14465.855341446451], "unit": "score", "name": "jquery.html", "value": 8888.011943422332}, {"lowerIsBetter": false, "replicates": [1307.3332600373806, 1399.0975820595716, 1432.133559196686, 1535.1710076558659, 1732.0473739443312, 6006.579539432241, 6425.614463132215, 6499.3175716549795, 6513.609183448991, 6530.934690653092, 6351.3966173213585, 6468.288488266287, 6493.448056915168, 6502.08970744095, 6510.707018184181, 1820.872538922276, 1856.6750818606758, 2041.9591608167827, 2056.085042156241, 2086.7182930304366, 2142.442964829148, 2146.710194123789, 2147.044565168501, 2148.2481131603968, 2150.5483848391855, 2008.5079155606898, 2052.9794702052936, 2068.0590331399176, 2068.152057656361, 2069.8033686799804, 2052.784457631942, 2086.926957556486, 2087.9895600522054, 2108.57828434313, 2111.271611294101, 2101.117530637136, 2146.61360955028, 2151.95696086079, 2164.751053628837, 2169.5986242545177, 6665.166854143232, 6703.698333575001, 6717.16035495563, 6722.193336799566, 6728.293529179415, 4171.186618609372, 4205.095904380542, 4232.682548808821, 4234.047339348653, 4235.470566179228, 2787.4982503149427, 2815.85920703964, 2832.065418411919, 2833.3483298841384, 2950.395168990352, 866.4151697604156, 869.9217070463625, 872.533194740817, 877.2630989968393, 915.890093188815, 8677.0, 8680.262177714902, 8681.869771953488, 8689.82620347596, 8712.172343627346, 3644.890653280406, 3654.1230104774663, 3679.8712045078296, 3692.2430901665093, 3716.7026637868908, 7657.655405506765, 7667.616619169019, 7671.156172820985, 7673.654685539164, 7681.692732290646, 4142.937855932163, 4150.709450338508, 4151.086760912594, 4152.231837110084, 4152.709310348247, 3798.1074447504816, 3805.5243094613174, 3834.9616503835164, 3844.231153769257, 3844.6347596978244, 3045.0712532677744, 3070.063630592646, 3228.5157226416227, 3272.574565306495, 3278.541004259406, 1019.3934608907837, 1028.0644613401769, 1037.662759603132, 1038.7351225437617, 1041.0266400915168, 1059.359087751899, 1061.7080302916759, 1109.0960866893618, 1220.5666988219054, 1341.2019848190312, 6305.779297724557, 6323.494120470351, 6356.269029061625, 6381.904271435932, 6385.265694445198, 1076.079951641351, 1088.450332582041, 1096.6107032003683, 1097.067492631257, 1102.6802227354137, 5034.244863270539, 5147.433782283946, 5148.716820574904, 5149.716765577929, 5151.150060240094, 7620.466567340233, 7777.338926191337, 7824.960875195701, 7854.450188486865, 7879.960600197077, 7807.570583617956, 7810.882836757453, 7871.960640196762, 7879.881801772978, 7888.605569721491, 6343.397377249154, 6384.138141350951, 6390.45681117101, 6395.808125756234, 6396.200474940632, 5925.348211696623, 6069.453749162597, 6071.0, 6072.90890636632, 6083.908741368795, 7048.859022819617, 7094.396976257076, 7173.282671732785, 7207.351338379571, 7252.709891604488, 7164.820879478055, 7233.095863017123, 7299.598522081336, 7330.45021623391, 7338.119425668954, 6071.150038994632, 6124.663143527148, 6126.693665316806, 6135.785247516315, 6135.969320153371, 5836.0, 5913.349531551612, 5916.083007133901, 6187.257529096537, 6529.9020514691365, 5950.672713000653, 6045.969770151121, 6068.150458935665, 6113.358097399709, 6130.049842274455, 5832.795852145155, 5842.766289348378, 5874.618149820248, 5905.498032667271, 5924.11138329254, 5942.910856337072, 5956.583039187215, 5973.940260597338, 6000.819975400745, 6007.249093863267, 5416.7020813855615, 5541.307336582927, 5563.693996830213, 5571.275734154534, 5583.497485226349, 5610.803621873215, 5661.094224923992, 5674.687892165971, 5676.517496012885, 5679.261695979496], "unit": "score", "name": "mootools.html", "value": 3939.074223097143}, {"lowerIsBetter": false, "replicates": [321.9500977348509, 328.31873861736887, 328.99328056148187, 330.11693719300865, 337.8918746001279, 5864.3256025557075, 6009.09863520471, 6046.395360463957, 6068.69656517174, 6071.392860713932, 5801.738921748521, 5905.704714764266, 5906.763729450817, 5971.432713892184, 6003.759849606011, 4648.74431906245, 4660.324252983315, 4665.393498845162, 4667.579917807397, 4673.929891051637, 4435.135148646015, 4498.842540511083, 4507.57178068083, 4517.141743068806, 4672.789724462407, 4500.39244701966, 4593.908121837561, 4612.930806037912, 4615.030843522864, 4619.861404157864, 4628.09752098341, 4634.073185362941, 4635.304704294349, 4643.16423043852, 4666.673332866701, 4093.3246014407887, 4094.549599544048, 4095.508538975312, 4102.938455923164, 4105.609967053155, 5618.0, 5718.742656580423, 5722.113072473773, 5729.914051289234, 5734.397888221718, 5358.46415358461, 5384.569234461273, 5387.622866399353, 5389.83830485086, 5395.217693434469, 6033.42682445167, 6332.778352757631, 6351.047342898556, 6361.904571431386, 6364.936350636481, 4387.978060109711, 4422.336649502568, 4504.8873778155485, 4518.2319005769095, 4519.457665080178, 6608.603483790988, 6631.668416579152, 6641.0, 6642.800715978528, 6645.136132302818, 4611.308303754464, 4611.930821037688, 4615.284630882219, 4617.792199351037, 4617.907641847211, 4439.600435960779, 4599.0, 4604.815807367668, 4661.533846615312, 4668.929966050512, 5331.466853314638, 5334.306540149756, 5336.332958380202, 5337.0, 5339.252504649352, 6433.0, 6438.227412710505, 6440.871182576322, 6441.710123044474, 6445.677716114269, 1599.4801689450976, 1619.5222409389257, 1619.7894273744337, 1620.2789758557328, 1622.1889055472263, 1004.7739258666742, 1019.4902548725637, 1022.9846552301722, 1068.9091427228618, 1079.9460026998618, 5896.351401345849, 5927.911081333784, 6053.7578496860515, 6054.697265136726, 6062.42406971337, 6591.077249185118, 6591.802245932629, 6602.801915942529, 6618.172728408949, 6623.602583844889, 5881.0, 6042.516598672096, 6048.092786082123, 6049.606775559574, 6057.969710151421, 3550.680438760524, 3566.4828599852876, 3578.0339308386588, 3581.3732596795458, 3588.6411358863907, 6894.931050689529, 6896.517243792987, 6904.240533541307, 6905.136857892763, 6906.205786334535, 6589.18989137932, 6773.559718618274, 6783.389494945479, 6789.185297764201, 6790.219124800612, 6855.211650660238, 6870.896936545956, 6877.449804015667, 6878.484113691393, 6880.415164711056, 6604.5046621502615, 6607.867842643216, 6614.0, 6615.4046135848, 6616.4045235929, 6328.0824280478155, 6512.6092434454085, 6521.673916304071, 6527.5757075789925, 6547.247066587213, 6848.794536163923, 6856.24581296067, 6860.176778786378, 6864.828379290558, 6871.106756121672, 4493.550644935481, 4495.662825288051, 4497.100579883971, 4498.955010449985, 4505.63954883615, 6560.0, 6603.702833372414, 6605.801825945229, 6621.0, 6633.469322454289, 6241.21984751906, 6390.4248617624635, 6405.455536279468, 6428.453581445629, 6450.677466126769, 6352.68236588178, 6352.888244557276, 6358.109864618865, 6358.459530939922, 6362.0774987627465, 6199.225096862892, 6316.589421687576, 6324.114623952558, 6341.365863413622, 6342.746290148342, 6461.8061458156335, 6470.126532917996, 6475.514336424692, 6479.676016199265, 6481.773137940149, 6278.780242691484, 6279.937200627935, 6281.026440901667, 6283.874322513616, 6287.245530536182], "unit": "score", "name": "prototype.html", "value": 4815.638154110658}, {"lowerIsBetter": false, "replicates": [741.2476336518434, 748.4648476339416, 792.3581898662088, 836.3936146293937, 847.635516727807, 13234.404451799668, 13340.533081342168, 13368.26474543902, 13410.396532156052, 13424.261665608388, 12658.873411265884, 12685.61943141705, 12740.936295318534, 14112.788308175386, 14718.705625887476, 690.440742998173, 829.4857188543111, 837.4682076881194, 841.4026041510535, 844.0377969115214, 695.0373732380639, 839.8488272111017, 842.8651415773478, 844.0420123160196, 845.8900342955408, 866.7313132928781, 878.3675753457501, 878.4026861734018, 878.6748902905902, 878.6924576398274, 724.9782506524813, 725.9818504537376, 868.513632365874, 872.0973792125152, 877.644553955649, 644.6969924135649, 646.86415852671, 647.5693663713624, 647.841278886671, 648.1412128929188, 14141.222232777192, 14217.502387416494, 14244.07413518118, 14252.501162459264, 14287.0, 11637.709057273636, 11814.0, 12084.0, 12252.142350035501, 12312.81530777039, 9996.100350968447, 10388.844167337496, 10427.68716938493, 10526.0, 10729.892701072968, 3582.1940063485767, 3639.7816131032223, 3649.6532829381167, 3690.0774806298427, 3757.455169000507, 44923.55076449226, 44943.32585011228, 44944.775276123735, 45290.32064519068, 45304.54695453069, 9699.369540979813, 9947.077338575908, 9977.650782222587, 10048.598056077675, 10494.055535001733, 17371.392001279895, 17465.21406536709, 17477.91261043712, 17487.912560437115, 17506.64986700259, 7047.612381318974, 7290.0, 7300.4159667226495, 7379.704811807467, 7399.112106547141, 4328.8268469260875, 4370.672199585044, 4406.977965110218, 4468.039371535136, 4548.5906268436, 3037.5139977603917, 3066.708662677042, 3067.785255032171, 3074.6003019607306, 3076.769242306791, 510.5277618203147, 513.4788189987166, 517.1570340345213, 517.5006119095091, 524.6878107526015, 605.3129697793037, 630.0, 634.9904751428733, 644.3170239546096, 660.8480049588526, 7682.96158519215, 8362.372822038371, 8517.872231916526, 8540.572971351408, 8552.700655477029, 432.55446889703654, 562.3673367461606, 624.4848000399688, 635.6503922842418, 659.7822718502882, 3798.525184351956, 3833.21419109082, 3931.980340098281, 3941.5219292765214, 4040.9797951010055, 49125.2631210525, 49347.0, 49420.505794942306, 49594.50405495899, 49992.50007499951, 49721.502784972414, 51518.0, 51794.74102629463, 52016.21975670368, 52359.47640523546, 43281.32108770727, 43502.34746478742, 44022.339664905056, 44230.55769442329, 44684.10631787346, 7924.6830126796585, 8203.753887383149, 8379.622916968872, 8388.328933685412, 8481.872771908304, 34238.82880585681, 34487.31025379529, 37332.62667373291, 38939.0, 39344.60655393409, 43912.0, 46298.53701463077, 47994.28008579804, 48673.75663121662, 49142.508574913794, 10508.842367364343, 11447.484863181344, 11648.301101933912, 11740.41297935117, 12096.213746106476, 10711.571537138427, 10906.890931090587, 10913.672589822318, 10931.617393391192, 11011.724706882393, 10545.261831672016, 10651.467426628793, 10746.73133171677, 11414.086873050303, 11697.356645384585, 11674.76650467003, 11897.242983715358, 12054.156209065632, 12080.879191208327, 12223.0, 10385.273030887765, 10418.635347762793, 10631.362118272928, 10775.568977240822, 10795.6221532246, 9846.852297215404, 10069.19446444268, 10237.436940968319, 10476.738081548023, 10530.36817790935, 8944.807784335548, 9072.591733371883, 9124.771880703036, 9368.67209647659, 9378.390404623678], "unit": "score", "name": "yui.html", "value": 6214.610222963539}], "name": "dromaeo_css", "value": 6785.101520188016}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 110.0, 111.0, 112.0, 101.0, 109.0, 111.0, 101.0], "unit": "score", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [169.0, 127.0, 149.0, 159.0, 123.0, 147.0, 146.0, 126.0, 163.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 162.0, 160.0, 161.0, 160.0, 159.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.2}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 78.0, 93.0, 73.0, 74.0, 71.0, 100.0, 94.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 142.0, 96.0, 96.0, 97.0, 144.0, 96.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 55.0, 56.0, 55.0, 57.0, 55.0, 68.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 67.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 85.0, 85.0, 86.0, 86.0, 88.0, 88.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [114.0, 121.0, 124.0, 119.0, 121.0, 119.0, 134.0, 132.0, 115.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [140.0, 154.0, 151.0, 153.0, 164.0, 148.0, 151.0, 150.0, 150.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 66.0, 66.0, 67.0, 68.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1500.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.05778811026238], "unit": "score", "name": "Richards", "value": 212.58864400000002}, {"lowerIsBetter": false, "replicates": [191.93857965451056], "unit": "score", "name": "DeltaBlue", "value": 344.4747799999999}, {"lowerIsBetter": false, "replicates": [282.6455624646693], "unit": "score", "name": "Encrypt", "value": 941.7483780000005}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1112.3470522803113], "unit": "score", "name": "RayTrace", "value": 665.2501110000002}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12625.0], "unit": "score", "name": "Boyer", "value": 52.78914851485148}, {"lowerIsBetter": false, "replicates": [25948.71794871795], "unit": "score", "name": "RegExp", "value": 35.107129446640336}, {"lowerIsBetter": false, "replicates": [635.3240152477764], "unit": "score", "name": "Splay", "value": 128.26683399999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20791.02742747055}]} 02:33:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20791.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1500.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6785.10"}}} 02:33:52 INFO - Return code: 0 02:33:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:33:52 INFO - # TBPL SUCCESS # 02:33:52 INFO - Running post-action listener: _resource_record_post_action 02:33:52 INFO - Running post-run listener: _resource_record_post_run 02:33:53 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 24576; Write bytes: 550600704; Read time: 116; Write time: 710252 02:33:53 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 241471488; Read time: 0; Write time: 422788 02:33:53 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 24576; Write bytes: 308858880; Read time: 116; Write time: 287428 02:33:53 INFO - Running post-run listener: _upload_blobber_files 02:33:53 INFO - Blob upload gear active. 02:33:53 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:33:53 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 02:33:53 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:33:53 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:33:53 INFO - (blobuploader) - INFO - Open directory for files ... 02:33:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:33:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:33:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:54 INFO - (blobuploader) - INFO - Done attempting. 02:33:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:33:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:33:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:55 INFO - (blobuploader) - INFO - Done attempting. 02:33:55 INFO - (blobuploader) - INFO - Iteration through files over. 02:33:55 INFO - Return code: 0 02:33:55 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:33:55 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:33:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc926c85e8a70400537f34ca924400f9815b50f4603670a9fe388b390f2ebc728efdc341c531d13cd1d9d57e9828e7dbc341f5fb252e80de6642236ace0532f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d001210c48318d5f7754a3e90a4640022b15a30b60b9a412a952325ba7657eb609a4faa7a1bb817d1bddc554af0888a3f1d288491dfa58c05d860e0e5f8da66"} 02:33:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:33:55 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:33:55 INFO - Contents: 02:33:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc926c85e8a70400537f34ca924400f9815b50f4603670a9fe388b390f2ebc728efdc341c531d13cd1d9d57e9828e7dbc341f5fb252e80de6642236ace0532f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d001210c48318d5f7754a3e90a4640022b15a30b60b9a412a952325ba7657eb609a4faa7a1bb817d1bddc554af0888a3f1d288491dfa58c05d860e0e5f8da66"} 02:33:55 INFO - Copying logs to upload dir... 02:33:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.172422 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-29 02:33:54.873248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 02:33:54.876945) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc926c85e8a70400537f34ca924400f9815b50f4603670a9fe388b390f2ebc728efdc341c531d13cd1d9d57e9828e7dbc341f5fb252e80de6642236ace0532f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d001210c48318d5f7754a3e90a4640022b15a30b60b9a412a952325ba7657eb609a4faa7a1bb817d1bddc554af0888a3f1d288491dfa58c05d860e0e5f8da66"} build_url:https://queue.taskcluster.net/v1/task/fScOmPmgRNCS4B4gUrSpQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011599 build_url: 'https://queue.taskcluster.net/v1/task/fScOmPmgRNCS4B4gUrSpQw/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/Fx-Team/sha512/fc926c85e8a70400537f34ca924400f9815b50f4603670a9fe388b390f2ebc728efdc341c531d13cd1d9d57e9828e7dbc341f5fb252e80de6642236ace0532f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d001210c48318d5f7754a3e90a4640022b15a30b60b9a412a952325ba7657eb609a4faa7a1bb817d1bddc554af0888a3f1d288491dfa58c05d860e0e5f8da66"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 02:33:54.902534) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 02:33:54.902885) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1451383908.159567-1077151004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 02:33:54.985548) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 02:33:54.985869) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 02:33:54.986175) ========= ========= Total master_lag: 0.22 =========