builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1453823722.77 results: success (0) buildid: 20160126053007 builduid: 5a7e216100bb4b948905f8c5e947acba revision: 8f84d08f4d8be041911ef3bc9a166f5c8f174a28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:22.773568) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:22.774070) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:22.774469) ========= 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=4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005995 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:22.799299) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:22.799621) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:22.813126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:22.813459) ========= 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=4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:22.863657) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:22.863969) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:22.864411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:22.864736) ========= 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=4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-26 07:55:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 85.6M=0s 2016-01-26 07:55:23 (85.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124248 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:23.001402) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:23.001745) ========= 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=4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021734 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:23.051054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:23.051437) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8f84d08f4d8be041911ef3bc9a166f5c8f174a28 --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 8f84d08f4d8be041911ef3bc9a166f5c8f174a28 --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=4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-26 07:55:23,338 truncating revision to first 12 chars 2016-01-26 07:55:23,338 Setting DEBUG logging. 2016-01-26 07:55:23,338 attempt 1/10 2016-01-26 07:55:23,338 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8f84d08f4d8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-26 07:55:23,581 unpacking tar archive at: fx-team-8f84d08f4d8b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.519350 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:23.584543) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:23.584931) ========= echo 8f84d08f4d8be041911ef3bc9a166f5c8f174a28 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8f84d08f4d8be041911ef3bc9a166f5c8f174a28'] 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=4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8f84d08f4d8be041911ef3bc9a166f5c8f174a28 program finished with exit code 0 elapsedTime=0.003681 script_repo_revision: '8f84d08f4d8be041911ef3bc9a166f5c8f174a28' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:23.633775) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:23.634129) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-26 07:55:23.644487) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-26 07:55:23.644804) ========= /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=4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:55:24 INFO - MultiFileLogger online at 20160126 07:55:24 in /builds/slave/test-pgo 07:55:24 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 07:55:24 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:55:24 INFO - {'append_to_log': False, 07:55:24 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:55:24 INFO - 'blob_upload_branch': 'Fx-Team', 07:55:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:55:24 INFO - 'branch': 'Fx-Team', 07:55:24 INFO - 'buildbot_json_path': 'buildprops.json', 07:55:24 INFO - 'config_files': ('talos/linux_config.py',), 07:55:24 INFO - 'default_actions': ('clobber', 07:55:24 INFO - 'read-buildbot-config', 07:55:24 INFO - 'download-and-extract', 07:55:24 INFO - 'populate-webroot', 07:55:24 INFO - 'create-virtualenv', 07:55:24 INFO - 'install', 07:55:24 INFO - 'run-tests'), 07:55:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:55:24 INFO - 'download_minidump_stackwalk': True, 07:55:24 INFO - 'download_symbols': 'ondemand', 07:55:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:55:24 INFO - 'tooltool.py': '/tools/tooltool.py', 07:55:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:55:24 INFO - '/tools/misc-python/virtualenv.py')}, 07:55:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:55:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:55:24 INFO - 'installer_path': 'installer.exe', 07:55:24 INFO - 'log_level': 'info', 07:55:24 INFO - 'log_name': 'talos', 07:55:24 INFO - 'log_to_console': True, 07:55:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:55:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:55:24 INFO - 'opt_config_files': (), 07:55:24 INFO - 'pip_index': False, 07:55:24 INFO - 'sps_profile': False, 07:55:24 INFO - 'sps_profile_interval': 0, 07:55:24 INFO - 'suite': 'dromaeojs', 07:55:24 INFO - 'system_bits': '32', 07:55:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:55:24 INFO - 'title': 'talos-linux64-ix-030', 07:55:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:55:24 INFO - 'use_talos_json': True, 07:55:24 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:55:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:55:24 INFO - 'work_dir': 'build'} 07:55:24 INFO - ##### 07:55:24 INFO - ##### Running clobber step. 07:55:24 INFO - ##### 07:55:24 INFO - Running pre-action listener: _resource_record_pre_action 07:55:24 INFO - Running main action method: clobber 07:55:24 INFO - rmtree: /builds/slave/test-pgo/build 07:55:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:55:24 INFO - Running post-action listener: _resource_record_post_action 07:55:24 INFO - ##### 07:55:24 INFO - ##### Running read-buildbot-config step. 07:55:24 INFO - ##### 07:55:24 INFO - Running pre-action listener: _resource_record_pre_action 07:55:24 INFO - Running main action method: read_buildbot_config 07:55:24 INFO - Using buildbot properties: 07:55:24 INFO - { 07:55:24 INFO - "project": "", 07:55:24 INFO - "product": "firefox", 07:55:24 INFO - "script_repo_revision": "production", 07:55:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:55:24 INFO - "repository": "", 07:55:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 07:55:24 INFO - "buildid": "20160126053007", 07:55:24 INFO - "pgo_build": "True", 07:55:24 INFO - "basedir": "/builds/slave/test-pgo", 07:55:24 INFO - "buildnumber": 604, 07:55:24 INFO - "slavename": "talos-linux64-ix-030", 07:55:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:55:24 INFO - "platform": "ubuntu64_hw", 07:55:24 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:55:24 INFO - "branch": "fx-team", 07:55:24 INFO - "repo_path": "integration/fx-team", 07:55:24 INFO - "revision": "8f84d08f4d8be041911ef3bc9a166f5c8f174a28", 07:55:24 INFO - "stage_platform": "linux64-pgo", 07:55:24 INFO - "builduid": "5a7e216100bb4b948905f8c5e947acba", 07:55:24 INFO - "slavebuilddir": "test" 07:55:24 INFO - } 07:55:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 07:55:24 INFO - Running post-action listener: _resource_record_post_action 07:55:24 INFO - ##### 07:55:24 INFO - ##### Running download-and-extract step. 07:55:24 INFO - ##### 07:55:24 INFO - Running pre-action listener: _resource_record_pre_action 07:55:24 INFO - Running main action method: download_and_extract 07:55:24 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:24 INFO - https://queue.taskcluster.net/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:55:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/test_packages.json 07:55:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/test_packages.json 07:55:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:55:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:55:26 INFO - Downloaded 1448 bytes. 07:55:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:55:26 INFO - Using the following test package requirements: 07:55:26 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:55:26 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:55:26 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:55:26 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:26 INFO - u'jsshell-linux-x86_64.zip'], 07:55:26 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:55:26 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:55:26 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:55:26 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:55:26 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:55:26 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:55:26 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:55:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:26 INFO - https://queue.taskcluster.net/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:55:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:55:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:55:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:55:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:55:30 INFO - Downloaded 22503073 bytes. 07:55:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:55:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:55:31 INFO - Return code: 0 07:55:31 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:31 INFO - https://queue.taskcluster.net/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:55:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:55:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:55:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:55:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:55:35 INFO - Downloaded 22503073 bytes. 07:55:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:55:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:55:36 INFO - Return code: 0 07:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:36 INFO - https://queue.taskcluster.net/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 07:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 07:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 07:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:55:37 INFO - Downloaded 10706572 bytes. 07:55:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:55:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 07:55:38 INFO - Return code: 0 07:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:38 INFO - https://queue.taskcluster.net/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:55:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:55:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:55:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:55:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:55:39 INFO - Downloaded 55974486 bytes. 07:55:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:55:39 INFO - mkdir: /builds/slave/test-pgo/properties 07:55:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:55:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:55:39 INFO - Contents: 07:55:39 INFO - build_url:https://queue.taskcluster.net/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:55:39 INFO - Running post-action listener: _resource_record_post_action 07:55:39 INFO - Running post-action listener: set_extra_try_arguments 07:55:39 INFO - ##### 07:55:39 INFO - ##### Running populate-webroot step. 07:55:39 INFO - ##### 07:55:39 INFO - Running pre-action listener: _resource_record_pre_action 07:55:39 INFO - Running main action method: populate_webroot 07:55:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:55:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:55:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:55:39 INFO - '--tppagecycles', 07:55:39 INFO - '7'], 07:55:39 INFO - 'tests': ['tsvgm']}}, 07:55:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:55:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:55:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:55:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:55:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:55:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:55:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:55:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'talos_options': ['--e10s'], 07:55:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:55:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'tests': ['damp', 'tps']}, 07:55:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'talos_options': ['--e10s'], 07:55:39 INFO - 'tests': ['damp', 'tps']}, 07:55:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:55:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:55:39 INFO - 'other': {'tests': ['a11yr', 07:55:39 INFO - 'ts_paint', 07:55:39 INFO - 'tpaint', 07:55:39 INFO - 'sessionrestore', 07:55:39 INFO - 'sessionrestore_no_auto_restore']}, 07:55:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:55:39 INFO - 'tests': ['a11yr', 07:55:39 INFO - 'ts_paint', 07:55:39 INFO - 'tpaint', 07:55:39 INFO - 'sessionrestore', 07:55:39 INFO - 'sessionrestore_no_auto_restore']}, 07:55:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:55:39 INFO - 'tests': ['a11yr', 07:55:39 INFO - 'ts_paint', 07:55:39 INFO - 'tpaint', 07:55:39 INFO - 'sessionrestore', 07:55:39 INFO - 'sessionrestore_no_auto_restore']}, 07:55:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:55:39 INFO - 'tests': ['a11yr', 07:55:39 INFO - 'ts_paint', 07:55:39 INFO - 'tpaint', 07:55:39 INFO - 'sessionrestore', 07:55:39 INFO - 'sessionrestore_no_auto_restore']}, 07:55:39 INFO - 'other_l64': {'tests': ['a11yr', 07:55:39 INFO - 'ts_paint', 07:55:39 INFO - 'tpaint', 07:55:39 INFO - 'sessionrestore', 07:55:39 INFO - 'sessionrestore_no_auto_restore']}, 07:55:39 INFO - 'other_nol64': {'tests': ['a11yr', 07:55:39 INFO - 'ts_paint', 07:55:39 INFO - 'tpaint', 07:55:39 INFO - 'sessionrestore', 07:55:39 INFO - 'sessionrestore_no_auto_restore']}, 07:55:39 INFO - 'svgr': {'tests': ['tsvgx', 07:55:39 INFO - 'tsvgr_opacity', 07:55:39 INFO - 'tart', 07:55:39 INFO - 'tscrollx', 07:55:39 INFO - 'cart']}, 07:55:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:55:39 INFO - 'tests': ['tsvgx', 07:55:39 INFO - 'tsvgr_opacity', 07:55:39 INFO - 'tart', 07:55:39 INFO - 'tscrollx', 07:55:39 INFO - 'cart']}, 07:55:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'tests': ['tp5o']}, 07:55:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'talos_options': ['--e10s'], 07:55:39 INFO - 'tests': ['tp5o']}, 07:55:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'talos_options': ['--xperf_path', 07:55:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:55:39 INFO - 'tests': ['tp5n']}, 07:55:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'talos_options': ['--e10s', 07:55:39 INFO - '--xperf_path', 07:55:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:55:39 INFO - 'tests': ['tp5n']}}, 07:55:39 INFO - 'talos.zip': {'path': '', 07:55:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:55:39 INFO - Running post-action listener: _resource_record_post_action 07:55:39 INFO - ##### 07:55:39 INFO - ##### Running create-virtualenv step. 07:55:39 INFO - ##### 07:55:39 INFO - Running pre-action listener: _resource_record_pre_action 07:55:39 INFO - Running main action method: create_virtualenv 07:55:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:55:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 07:55:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:55:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:55:39 INFO - Using real prefix '/usr' 07:55:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:55:40 INFO - Installing distribute.............................................................................................................................................................................................done. 07:55:42 INFO - Installing pip.................done. 07:55:42 INFO - Return code: 0 07:55:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f7037044f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2445630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d6840>, '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 0x24436b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2443b60>, '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': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:55:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:55:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:55:42 INFO - Using env: {'DISPLAY': ':0', 07:55:42 INFO - 'HOME': '/home/cltbld', 07:55:42 INFO - 'LANG': 'en_US.UTF-8', 07:55:42 INFO - 'LANGUAGE': 'en_US:en', 07:55:42 INFO - 'LOGNAME': 'cltbld', 07:55:42 INFO - 'MAIL': '/var/mail/cltbld', 07:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:42 INFO - 'MOZ_NO_REMOTE': '1', 07:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:42 INFO - 'NO_EM_RESTART': '1', 07:55:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:42 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:42 INFO - 'SHELL': '/bin/bash', 07:55:42 INFO - 'SHLVL': '1', 07:55:42 INFO - 'TERM': 'linux', 07:55:42 INFO - 'TMOUT': '86400', 07:55:42 INFO - 'USER': 'cltbld', 07:55:42 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 07:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:42 INFO - '_': '/tools/buildbot/bin/python'} 07:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:55:42 INFO - Cleaning up... 07:55:42 INFO - Return code: 0 07:55:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f7037044f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2445630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d6840>, '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 0x24436b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2443b60>, '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': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:55:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:55:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:55:42 INFO - Using env: {'DISPLAY': ':0', 07:55:42 INFO - 'HOME': '/home/cltbld', 07:55:42 INFO - 'LANG': 'en_US.UTF-8', 07:55:42 INFO - 'LANGUAGE': 'en_US:en', 07:55:42 INFO - 'LOGNAME': 'cltbld', 07:55:42 INFO - 'MAIL': '/var/mail/cltbld', 07:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:42 INFO - 'MOZ_NO_REMOTE': '1', 07:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:42 INFO - 'NO_EM_RESTART': '1', 07:55:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:42 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:42 INFO - 'SHELL': '/bin/bash', 07:55:42 INFO - 'SHLVL': '1', 07:55:42 INFO - 'TERM': 'linux', 07:55:42 INFO - 'TMOUT': '86400', 07:55:42 INFO - 'USER': 'cltbld', 07:55:42 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 07:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:42 INFO - '_': '/tools/buildbot/bin/python'} 07:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:42 INFO - Downloading/unpacking psutil>=0.7.1 07:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:55:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:44 INFO - Installing collected packages: psutil 07:55:44 INFO - Running setup.py install for psutil 07:55:44 INFO - building 'psutil._psutil_linux' extension 07:55:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:55:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:55:44 INFO - building 'psutil._psutil_posix' extension 07:55:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:55:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:55:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:44 INFO - Successfully installed psutil 07:55:44 INFO - Cleaning up... 07:55:45 INFO - Return code: 0 07:55:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f7037044f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2445630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d6840>, '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 0x24436b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2443b60>, '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': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:55:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:55:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:55:45 INFO - Using env: {'DISPLAY': ':0', 07:55:45 INFO - 'HOME': '/home/cltbld', 07:55:45 INFO - 'LANG': 'en_US.UTF-8', 07:55:45 INFO - 'LANGUAGE': 'en_US:en', 07:55:45 INFO - 'LOGNAME': 'cltbld', 07:55:45 INFO - 'MAIL': '/var/mail/cltbld', 07:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:45 INFO - 'MOZ_NO_REMOTE': '1', 07:55:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:45 INFO - 'NO_EM_RESTART': '1', 07:55:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:45 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:45 INFO - 'SHELL': '/bin/bash', 07:55:45 INFO - 'SHLVL': '1', 07:55:45 INFO - 'TERM': 'linux', 07:55:45 INFO - 'TMOUT': '86400', 07:55:45 INFO - 'USER': 'cltbld', 07:55:45 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 07:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:45 INFO - '_': '/tools/buildbot/bin/python'} 07:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:55:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:55:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:55:47 INFO - Installing collected packages: mozsystemmonitor 07:55:47 INFO - Running setup.py install for mozsystemmonitor 07:55:47 INFO - Successfully installed mozsystemmonitor 07:55:47 INFO - Cleaning up... 07:55:47 INFO - Return code: 0 07:55:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f7037044f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2445630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d6840>, '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 0x24436b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2443b60>, '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': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:55:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:55:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:55:47 INFO - Using env: {'DISPLAY': ':0', 07:55:47 INFO - 'HOME': '/home/cltbld', 07:55:47 INFO - 'LANG': 'en_US.UTF-8', 07:55:47 INFO - 'LANGUAGE': 'en_US:en', 07:55:47 INFO - 'LOGNAME': 'cltbld', 07:55:47 INFO - 'MAIL': '/var/mail/cltbld', 07:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:47 INFO - 'MOZ_NO_REMOTE': '1', 07:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:47 INFO - 'NO_EM_RESTART': '1', 07:55:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:47 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:47 INFO - 'SHELL': '/bin/bash', 07:55:47 INFO - 'SHLVL': '1', 07:55:47 INFO - 'TERM': 'linux', 07:55:47 INFO - 'TMOUT': '86400', 07:55:47 INFO - 'USER': 'cltbld', 07:55:47 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 07:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:47 INFO - '_': '/tools/buildbot/bin/python'} 07:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:47 INFO - Downloading/unpacking blobuploader==1.2.4 07:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:55:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:55:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:55:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:49 INFO - Downloading docopt-0.6.1.tar.gz 07:55:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:55:49 INFO - Installing collected packages: blobuploader, requests, docopt 07:55:49 INFO - Running setup.py install for blobuploader 07:55:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:55:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:55:50 INFO - Running setup.py install for requests 07:55:50 INFO - Running setup.py install for docopt 07:55:50 INFO - Successfully installed blobuploader requests docopt 07:55:50 INFO - Cleaning up... 07:55:50 INFO - Return code: 0 07:55:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f7037044f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2445630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d6840>, '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 0x24436b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2443b60>, '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': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:55:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:55:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:55:50 INFO - Using env: {'DISPLAY': ':0', 07:55:50 INFO - 'HOME': '/home/cltbld', 07:55:50 INFO - 'LANG': 'en_US.UTF-8', 07:55:50 INFO - 'LANGUAGE': 'en_US:en', 07:55:50 INFO - 'LOGNAME': 'cltbld', 07:55:50 INFO - 'MAIL': '/var/mail/cltbld', 07:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:50 INFO - 'MOZ_NO_REMOTE': '1', 07:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:50 INFO - 'NO_EM_RESTART': '1', 07:55:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:50 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:50 INFO - 'SHELL': '/bin/bash', 07:55:50 INFO - 'SHLVL': '1', 07:55:50 INFO - 'TERM': 'linux', 07:55:50 INFO - 'TMOUT': '86400', 07:55:50 INFO - 'USER': 'cltbld', 07:55:50 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 07:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:50 INFO - '_': '/tools/buildbot/bin/python'} 07:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:55:50 INFO - Running setup.py (path:/tmp/pip-xLNCUp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:55:50 INFO - Running setup.py (path:/tmp/pip-vJBeA3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:55:50 INFO - Running setup.py (path:/tmp/pip-5dtlCA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:55:50 INFO - Running setup.py (path:/tmp/pip-vPnJTa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:55:51 INFO - Running setup.py (path:/tmp/pip-w_TNwR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:55:51 INFO - Running setup.py (path:/tmp/pip-Nt3v5d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:55:51 INFO - Running setup.py (path:/tmp/pip-rEGRDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:55:51 INFO - Running setup.py (path:/tmp/pip-JBqfbb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:55:51 INFO - Running setup.py (path:/tmp/pip-vGI5Pp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:55:51 INFO - Running setup.py (path:/tmp/pip-LIBliZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:55:51 INFO - Running setup.py (path:/tmp/pip-Ph8CfD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:55:51 INFO - Running setup.py (path:/tmp/pip-eGxgZ0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:55:51 INFO - Running setup.py (path:/tmp/pip-tz9hCj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:55:51 INFO - Running setup.py (path:/tmp/pip-0SHj2x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:55:51 INFO - Running setup.py (path:/tmp/pip-0QFkMb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:55:51 INFO - Running setup.py (path:/tmp/pip-FLSgXP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:55:51 INFO - Running setup.py (path:/tmp/pip-uc87tD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:55:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:55:51 INFO - Running setup.py install for manifestparser 07:55:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:55:52 INFO - Running setup.py install for mozcrash 07:55:52 INFO - Running setup.py install for mozdebug 07:55:52 INFO - Running setup.py install for mozdevice 07:55:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:55:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:55:52 INFO - Running setup.py install for mozfile 07:55:52 INFO - Running setup.py install for mozhttpd 07:55:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:55:52 INFO - Running setup.py install for mozinfo 07:55:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:55:52 INFO - Running setup.py install for mozInstall 07:55:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:55:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:55:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:55:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:55:52 INFO - Running setup.py install for mozleak 07:55:52 INFO - Running setup.py install for mozlog 07:55:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:55:52 INFO - Running setup.py install for moznetwork 07:55:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:55:53 INFO - Running setup.py install for mozprocess 07:55:53 INFO - Running setup.py install for mozprofile 07:55:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:55:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:55:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:55:53 INFO - Running setup.py install for mozrunner 07:55:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:55:53 INFO - Running setup.py install for mozscreenshot 07:55:53 INFO - Running setup.py install for moztest 07:55:53 INFO - Running setup.py install for mozversion 07:55:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:55:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:55:53 INFO - Cleaning up... 07:55:53 INFO - Return code: 0 07:55:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f7037044f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2445630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d6840>, '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 0x24436b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2443b60>, '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': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:55:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:55:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:55:53 INFO - Using env: {'DISPLAY': ':0', 07:55:53 INFO - 'HOME': '/home/cltbld', 07:55:53 INFO - 'LANG': 'en_US.UTF-8', 07:55:53 INFO - 'LANGUAGE': 'en_US:en', 07:55:53 INFO - 'LOGNAME': 'cltbld', 07:55:53 INFO - 'MAIL': '/var/mail/cltbld', 07:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:53 INFO - 'MOZ_NO_REMOTE': '1', 07:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:53 INFO - 'NO_EM_RESTART': '1', 07:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:53 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:53 INFO - 'SHELL': '/bin/bash', 07:55:53 INFO - 'SHLVL': '1', 07:55:53 INFO - 'TERM': 'linux', 07:55:53 INFO - 'TMOUT': '86400', 07:55:53 INFO - 'USER': 'cltbld', 07:55:53 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 07:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:53 INFO - '_': '/tools/buildbot/bin/python'} 07:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:55:53 INFO - Running setup.py (path:/tmp/pip-E2HgIn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:55:54 INFO - Running setup.py (path:/tmp/pip-VupULw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:55:54 INFO - Running setup.py (path:/tmp/pip-a1qalf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:55:54 INFO - Running setup.py (path:/tmp/pip-pIpJES-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:55:54 INFO - Running setup.py (path:/tmp/pip-wShihM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:55:54 INFO - Running setup.py (path:/tmp/pip-0Nqa66-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:55:54 INFO - Running setup.py (path:/tmp/pip-frC_BI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:55:54 INFO - Running setup.py (path:/tmp/pip-OrgX6x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:55:54 INFO - Running setup.py (path:/tmp/pip-glZEBj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:55:54 INFO - Running setup.py (path:/tmp/pip-CcVDCN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:55:54 INFO - Running setup.py (path:/tmp/pip-NKp4i2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:55:54 INFO - Running setup.py (path:/tmp/pip-xiCvPV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:55:54 INFO - Running setup.py (path:/tmp/pip-mvV_E6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:55:54 INFO - Running setup.py (path:/tmp/pip-PFAUqm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 07:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:55:54 INFO - Running setup.py (path:/tmp/pip-1YVAYO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 07:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:55:55 INFO - Running setup.py (path:/tmp/pip-H7B4kq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 07:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:55:55 INFO - Running setup.py (path:/tmp/pip-Oyfq_k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 07:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:55:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:56 INFO - Downloading blessings-1.6.tar.gz 07:55:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:55:57 INFO - Installing collected packages: blessings 07:55:57 INFO - Running setup.py install for blessings 07:55:57 INFO - Successfully installed blessings 07:55:57 INFO - Cleaning up... 07:55:57 INFO - Return code: 0 07:55:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:55:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:55:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:55:57 INFO - Reading from file tmpfile_stdout 07:55:57 INFO - Current package versions: 07:55:57 INFO - argparse == 1.2.1 07:55:57 INFO - blessings == 1.6 07:55:57 INFO - blobuploader == 1.2.4 07:55:57 INFO - docopt == 0.6.1 07:55:57 INFO - manifestparser == 1.1 07:55:57 INFO - mozInstall == 1.12 07:55:57 INFO - mozcrash == 0.16 07:55:57 INFO - mozdebug == 0.1 07:55:57 INFO - mozdevice == 0.48 07:55:57 INFO - mozfile == 1.2 07:55:57 INFO - mozhttpd == 0.7 07:55:57 INFO - mozinfo == 0.9 07:55:57 INFO - mozleak == 0.1 07:55:57 INFO - mozlog == 3.1 07:55:57 INFO - moznetwork == 0.27 07:55:57 INFO - mozprocess == 0.22 07:55:57 INFO - mozprofile == 0.28 07:55:57 INFO - mozrunner == 6.11 07:55:57 INFO - mozscreenshot == 0.1 07:55:57 INFO - mozsystemmonitor == 0.0 07:55:57 INFO - moztest == 0.7 07:55:57 INFO - mozversion == 1.4 07:55:57 INFO - psutil == 3.1.1 07:55:57 INFO - requests == 1.2.3 07:55:57 INFO - wsgiref == 0.1.2 07:55:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f7037044f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2445630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d6840>, '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 0x24436b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2443b60>, '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': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:55:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 07:55:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:55:57 INFO - Using env: {'DISPLAY': ':0', 07:55:57 INFO - 'HOME': '/home/cltbld', 07:55:57 INFO - 'LANG': 'en_US.UTF-8', 07:55:57 INFO - 'LANGUAGE': 'en_US:en', 07:55:57 INFO - 'LOGNAME': 'cltbld', 07:55:57 INFO - 'MAIL': '/var/mail/cltbld', 07:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:57 INFO - 'MOZ_NO_REMOTE': '1', 07:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:57 INFO - 'NO_EM_RESTART': '1', 07:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:57 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:57 INFO - 'SHELL': '/bin/bash', 07:55:57 INFO - 'SHLVL': '1', 07:55:57 INFO - 'TERM': 'linux', 07:55:57 INFO - 'TMOUT': '86400', 07:55:57 INFO - 'USER': 'cltbld', 07:55:57 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 07:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:57 INFO - '_': '/tools/buildbot/bin/python'} 07:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 07:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 07:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 07:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 07:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 07:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 07:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 07:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:55:57 INFO - Cleaning up... 07:55:57 INFO - Return code: 0 07:55:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f7037044f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2445630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d6840>, '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 0x24436b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2443b60>, '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': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:55:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:55:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:55:57 INFO - Using env: {'DISPLAY': ':0', 07:55:57 INFO - 'HOME': '/home/cltbld', 07:55:57 INFO - 'LANG': 'en_US.UTF-8', 07:55:57 INFO - 'LANGUAGE': 'en_US:en', 07:55:57 INFO - 'LOGNAME': 'cltbld', 07:55:57 INFO - 'MAIL': '/var/mail/cltbld', 07:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:57 INFO - 'MOZ_NO_REMOTE': '1', 07:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:57 INFO - 'NO_EM_RESTART': '1', 07:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:57 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:57 INFO - 'SHELL': '/bin/bash', 07:55:57 INFO - 'SHLVL': '1', 07:55:57 INFO - 'TERM': 'linux', 07:55:57 INFO - 'TMOUT': '86400', 07:55:57 INFO - 'USER': 'cltbld', 07:55:57 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 07:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:57 INFO - '_': '/tools/buildbot/bin/python'} 07:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:57 INFO - Downloading/unpacking jsonschema 07:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:55:59 INFO - Downloading/unpacking functools32 (from jsonschema) 07:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:59 INFO - Downloading functools32-3.2.3-2.tar.gz 07:55:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:55:59 INFO - warning: no files found matching '*.txt' 07:55:59 INFO - no previously-included directories found matching 'build' 07:55:59 INFO - no previously-included directories found matching 'dist' 07:55:59 INFO - no previously-included directories found matching '.git*' 07:55:59 INFO - Installing collected packages: jsonschema, functools32 07:55:59 INFO - Running setup.py install for functools32 07:55:59 INFO - warning: no files found matching '*.txt' 07:55:59 INFO - no previously-included directories found matching 'build' 07:55:59 INFO - no previously-included directories found matching 'dist' 07:55:59 INFO - no previously-included directories found matching '.git*' 07:56:00 INFO - Successfully installed jsonschema functools32 07:56:00 INFO - Cleaning up... 07:56:00 INFO - Return code: 0 07:56:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:56: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')]} 07:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f7037044f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2445630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d6840>, '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 0x24436b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2443b60>, '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': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:56:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:56:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:56:00 INFO - Using env: {'DISPLAY': ':0', 07:56:00 INFO - 'HOME': '/home/cltbld', 07:56:00 INFO - 'LANG': 'en_US.UTF-8', 07:56:00 INFO - 'LANGUAGE': 'en_US:en', 07:56:00 INFO - 'LOGNAME': 'cltbld', 07:56:00 INFO - 'MAIL': '/var/mail/cltbld', 07:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:00 INFO - 'MOZ_NO_REMOTE': '1', 07:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:00 INFO - 'NO_EM_RESTART': '1', 07:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:00 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:00 INFO - 'SHELL': '/bin/bash', 07:56:00 INFO - 'SHLVL': '1', 07:56:00 INFO - 'TERM': 'linux', 07:56:00 INFO - 'TMOUT': '86400', 07:56:00 INFO - 'USER': 'cltbld', 07:56:00 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 07:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:00 INFO - '_': '/tools/buildbot/bin/python'} 07:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:00 INFO - Downloading/unpacking flake8 07:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:56:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:56:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:56:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:02 INFO - no previously-included directories found matching 'docs/_build' 07:56:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:56:02 INFO - Running setup.py install for pep8 07:56:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:02 INFO - no previously-included directories found matching 'docs/_build' 07:56:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:56:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:56:02 INFO - Cleaning up... 07:56:02 INFO - Return code: 0 07:56:02 INFO - Running post-action listener: _resource_record_post_action 07:56:02 INFO - Running post-action listener: _start_resource_monitoring 07:56:02 INFO - Starting resource monitoring. 07:56:02 INFO - ##### 07:56:02 INFO - ##### Running install step. 07:56:02 INFO - ##### 07:56:02 INFO - Running pre-action listener: _resource_record_pre_action 07:56:02 INFO - Running main action method: install 07:56:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:56:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:56:03 INFO - Reading from file tmpfile_stdout 07:56:03 INFO - Detecting whether we're running mozinstall >=1.0... 07:56:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:56:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:56:03 INFO - Reading from file tmpfile_stdout 07:56:03 INFO - Output received: 07:56:03 INFO - Usage: mozinstall [options] installer 07:56:03 INFO - Options: 07:56:03 INFO - -h, --help show this help message and exit 07:56:03 INFO - -d DEST, --destination=DEST 07:56:03 INFO - Directory to install application into. [default: 07:56:03 INFO - "/builds/slave/test-pgo"] 07:56:03 INFO - --app=APP Application being installed. [default: firefox] 07:56:03 INFO - mkdir: /builds/slave/test-pgo/build/application 07:56:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:56:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:56:19 INFO - Reading from file tmpfile_stdout 07:56:19 INFO - Output received: 07:56:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:56:19 INFO - Running post-action listener: _resource_record_post_action 07:56:19 INFO - ##### 07:56:19 INFO - ##### Running run-tests step. 07:56:19 INFO - ##### 07:56:19 INFO - Running pre-action listener: _resource_record_pre_action 07:56:19 INFO - Running main action method: run_tests 07:56:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:56:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:56:19 INFO - Python 2.7.3 07:56:19 INFO - Return code: 0 07:56:19 INFO - grabbing minidump binary from tooltool 07:56: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')]} 07:56:19 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 0x24d6840>, '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 0x24436b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2443b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:56:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 07:56:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:56:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:56:19 INFO - Return code: 0 07:56:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:56:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:56:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:56:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:56:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:56:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:56:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:56:20 INFO - Return code: 0 07:56:20 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/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 07:56:20 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/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 07:56:20 INFO - Using env: {'DISPLAY': ':0', 07:56:20 INFO - 'HOME': '/home/cltbld', 07:56:20 INFO - 'LANG': 'en_US.UTF-8', 07:56:20 INFO - 'LANGUAGE': 'en_US:en', 07:56:20 INFO - 'LOGNAME': 'cltbld', 07:56:20 INFO - 'MAIL': '/var/mail/cltbld', 07:56:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:56:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:20 INFO - 'MOZ_NO_REMOTE': '1', 07:56:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:20 INFO - 'NO_EM_RESTART': '1', 07:56:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:20 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:56:20 INFO - 'SHELL': '/bin/bash', 07:56:20 INFO - 'SHLVL': '1', 07:56:20 INFO - 'TERM': 'linux', 07:56:20 INFO - 'TMOUT': '86400', 07:56:20 INFO - 'USER': 'cltbld', 07:56:20 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813', 07:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:20 INFO - '_': '/tools/buildbot/bin/python'} 07:56:20 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/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:56:20 INFO - mozversion application_buildid: 20160126053007 07:56:20 INFO - mozversion application_changeset: 8f84d08f4d8be041911ef3bc9a166f5c8f174a28 07:56:20 INFO - mozversion application_display_name: Nightly 07:56:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:56:20 INFO - mozversion application_name: Firefox 07:56:20 INFO - mozversion application_remotingname: firefox 07:56:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:56:20 INFO - mozversion application_vendor: Mozilla 07:56:20 INFO - mozversion application_version: 47.0a1 07:56:20 INFO - mozversion platform_buildid: 20160126053007 07:56:20 INFO - mozversion platform_changeset: 8f84d08f4d8be041911ef3bc9a166f5c8f174a28 07:56:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:56:20 INFO - mozversion platform_version: 47.0a1 07:56:20 INFO - using testdate: 1453823780 07:56:20 INFO - actual date: 1453823780 07:56:20 INFO - starting webserver on 'localhost:48743' 07:56:20 INFO - SUITE-START | Running 3 tests 07:56:20 INFO - TEST-START | dromaeo_css 07:56:20 INFO - operating with platform_type : linux_ 07:56:20 INFO - Initialising browser for dromaeo_css test... 07:56:20 INFO - TEST-INFO | started process 3991 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3S8Asn/profile http://localhost:48743/getInfo.html) 07:56:24 INFO - PROCESS | 3991 | __metrics Screen width/height:1600/1200 07:56:24 INFO - PROCESS | 3991 | colorDepth:24 07:56:24 INFO - PROCESS | 3991 | Browser inner width/height: 1024/697 07:56:24 INFO - PROCESS | 3991 | __metrics 07:56:24 INFO - PROCESS | 3991 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:56:24 INFO - PROCESS | 3991 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:56:25 INFO - TEST-INFO | 3991: exit 0 07:56:25 INFO - Browser initialized. 07:56:25 INFO - Running cycle 1/1 for dromaeo_css test... 07:56:25 INFO - TEST-INFO | started process 4083 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3S8Asn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:37 INFO - PROCESS | 4083 | RSS: Main: 148164608 07:56:37 INFO - PROCESS | 4083 | 07:57:28 INFO - PROCESS | 4083 | 1453823848818 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] 07:59:36 INFO - PROCESS | 4083 | Cycle 1(1): loaded http://localhost:48743/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48743/tests/dromaeo/cssquery-ext.html) 07:59:38 INFO - PROCESS | 4083 | RSS: Main: 266792960 07:59:38 INFO - PROCESS | 4083 | 08:02:40 INFO - PROCESS | 4083 | Cycle 1(1): loaded http://localhost:48743/tests/dromaeo/cssquery-ext.html (next: http://localhost:48743/tests/dromaeo/cssquery-jquery.html) 08:02:41 INFO - PROCESS | 4083 | RSS: Main: 224333824 08:02:41 INFO - PROCESS | 4083 | 08:05:43 INFO - PROCESS | 4083 | Cycle 1(1): loaded http://localhost:48743/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48743/tests/dromaeo/cssquery-mootools.html) 08:05:43 INFO - PROCESS | 4083 | RSS: Main: 239173632 08:05:43 INFO - PROCESS | 4083 | 08:08:45 INFO - PROCESS | 4083 | Cycle 1(1): loaded http://localhost:48743/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48743/tests/dromaeo/cssquery-prototype.html) 08:08:46 INFO - PROCESS | 4083 | RSS: Main: 210128896 08:08:46 INFO - PROCESS | 4083 | 08:11:48 INFO - PROCESS | 4083 | Cycle 1(1): loaded http://localhost:48743/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48743/tests/dromaeo/cssquery-yui.html) 08:11:49 INFO - PROCESS | 4083 | RSS: Main: 211480576 08:11:49 INFO - PROCESS | 4083 | 08:14:52 INFO - PROCESS | 4083 | Cycle 1(1): loaded http://localhost:48743/tests/dromaeo/cssquery-yui.html (next: http://localhost:48743/tests/dromaeo/cssquery-dojo.html) 08:14:52 INFO - PROCESS | 4083 | RSS: Main: 378273792 08:14:52 INFO - PROCESS | 4083 | 08:14:52 INFO - PROCESS | 4083 | __start_tp_report 08:14:52 INFO - PROCESS | 4083 | _x_x_mozilla_page_load 08:14:52 INFO - PROCESS | 4083 | _x_x_mozilla_page_load_details 08:14:52 INFO - PROCESS | 4083 | |i|pagename|runs| 08:14:52 INFO - PROCESS | 4083 | |0;dojo.html;3083.1983684242095;3143.6070491188602;3161.225499752561;3165.9683403165964;3212.1166679163234;5038.82364117255;5087.03346364191;5092.618053645978;5106.106431374508;5116.079105760961;5079.466656001122;5107.438181799999;5154.74226288685;5163.122269214233;5165.147750621143;4386.188555117314;4578.404807375036;4612.169809434292;4648.418947631546;4793.209120495114;4631.258998560231;4682.180618391768;4701.059788042388;4730.810767569293;4785.808567657289;4665.93001104982;4710.081534100852;4713.764311784397;4734.597559207455;4750.097481478508;4669.229577119805;4689.413823272091;4693.108309421199;4706.152892479352;4736.763161841928;4551.977240113778;4663.207254766698;4666.556677115668;4669.579737823612;4717.858464246078;4972.428170760372;5009.073321435546;5010.398752149729;5019.949800502021;5028.321176641143;5505;5531.806386776443;5533.541536539663;5542.86142846428;5575.330960284751;5400.054990376669;5454.53636440903;5477.589180811455;5565.41563135873;5588.748506317225;5057.8229761958155;5129.666571672867;5136.5890728741615;5146.845594632205;5161.81933632321;5601.663900166003;5649.548036157097;5661.34894487131;5664.461876121762;5665;5300.946990530122;5361.571074314045;5368;5452.372977107604;5467.234587157801;5487;5512.614117011771;5515.889682206333;5518.862028449321;5579.721013949367;5428.6471379361;5431.076716958127;5450.727463626803;5453.700046497402;5463.344398672185;5356.598255130881;5455.154451060012;5455.5908306877145;5461.371942226615;5463.989162005042;4252.553481884358;4280.036991676848;4293.162833247487;4318.827246910088;4333.696641235147;3831.3678243090135;3865.7487263328358;3867.323218436762;3881.4177873319227;3895.2988462077096;4932.90134197314;5005.474425185376;5103.055934652101;5124.590032797368;5169.767360468788;5443.292371991695;5481.698506582096;5503.834884953458;5527.309086364205;5529.612927095145;5041.596672266283;5041.924371134436;5055.570276526537;5059.392872855281;5084;4599.747013914267;4665.720056796536;4667.066586682677;4673.112108699336;4675.29870519418;5618.550515958796;5634.070378387521;5644.689542075225;5657.151427285858;5698.629589076697;5495.945040549544;5500.22996780443;5502.422245664147;5505.9724701376235;5508.55931525469;5508.421615730451;5586.720663966867;5595.5523558116065;5632.098864181875;5668.149777533403;5383.327084114486;5458.263134476795;5506;5509.559235261089;5560.443955604407;5474.479924407175;5491.423400543045;5528.19841123043;5530.115181570929;5532.197831314517;5366.758495867617;5387.111126664056;5405.5135037846785;5457.5633949283165;5460.453954604666;5352.705601191972;5368.785248590013;5395.190721391823;5405.567554595545;5455.945440545703;5253.50091741284;5305.708186049805;5315.04329220744;5317.548008419328;5361.651492652965;5352.41123476425;5380;5381.596380271417;5388.811391601275;5406.026915155153;5261.184516399964;5297.735113244399;5299.9470005301;5317.627766056339;5355.758990845344 08:14:52 INFO - PROCESS | 4083 | |1;ext.html;527.7756953294846;551.8438870566163;582.132622392635;584.2346526050871;589.575505635942;28178.154655360348;35428.11429714259;35982.82008589953;35992;36128.277434451295;41643.58356416435;42271.15457690844;42293.36559951596;42313.78843105788;42314.88425578724;8435.999999999985;8692.56537173142;8714.738557843244;8728.825423491526;8730.257928076122;8424.53665048422;8572.742817715478;8593.097724738875;8600.096989816073;8602.698905538307;8588.914110858874;8665.870011949826;8675.392722509427;8675.522846243453;8677.045524992278;8512.233898949093;8560.657573697044;8568.100349463279;8582.356323275779;8594.097619749962;8439.240468357815;8604.8709269361;8613.526256055915;8619.569021548898;8620.870686939637;38225.61774382276;38231;38660.613393865984;38715.41926871071;38728.225435491135;3136.686331366845;3144.339688665383;3150.039238032399;3305.5537502437346;3501.38725723;29039.709602903913;29171.270718232;29380.706192938225;29487;30214.093577192718;3926.332523471017;3995.6403923647013;4007.6793856491704;4017.678585713136;4087.6321131098343;255406;255410;256343;256687;256736;50546.241806372935;51362;52394.21408678873;52575.737121314145;52581;59367;59839;60103.69948150231;60104;60151;14484.420623175165;14745.262736863115;14822.851771482363;14829.555113346616;14843;10872.945635271773;11114.499847506882;11121.610743624096;11157.553697851996;11700.88299117015;18739.90630046841;18905.14926828296;19014.42956711301;19119.80880191208;19149.329773457863;7339.449541284425;7513.2111128331835;7573.962130189314;7641.7707468776025;7696.153423123452;903.3405613901889;948.691675205561;959.510649568725;959.8128364968903;1083.8211695070383;24327.27018189457;24921.5015699685;25054.4989100217;25358.619620705704;26206.86896565505;1063.9308444951207;1068.471106802138;1070.6680928912062;1102.030213412192;1145.7021174494691;13785;14088.295585220698;14144;14256.287185640676;14320.283985800877;323243;324285;326063;328239;328812;50151.74924125356;50463;50482.74758626183;50497;50535;1333.8532761396239;1350.2506109109343;1351.0880155894731;1355.0514639752016;1374.1205628397834;25457.23628291154;26403.339916502242;26443.471130576894;26496.205113846616;26512.469750604494;47512.7624361876;48428.273575895684;48498.51501485081;48534.27198592095;48548.2717759241;246937;275790;276789;276903;279689;28882.27794305159;28911.855440723502;28924.27689307784;28986.27534311659;29347.70652293535;38515.6148438512;40189.79905100573;40214.1957160861;42344;43106.56893431026;35269;35523;35902;36093.63906360903;37213.44179837251;34677.306453870275;35832.46251306285;35956.101097472776;36091.639083608825;36601.81699091594;32196.03411897647;34389.48415773815;35729.28541429105;35823.64176358203;35828;27070.593941091294;28901.20405071369;31364.686353136178;31772.523412149298;31805.5229171558;24107.63838542388;24129;24194.100233550987;24409.26772196837;24627.753722462545 08:14:52 INFO - PROCESS | 4083 | |2;jquery.html;346.667199488491;359.82188816535813;361.9022863826765;362.9038304849215;365.48101695592254;13531.323433828318;13778.242196679179;15563.377464901405;16436.58908527286;17653.64692706147;14337.569872903803;15014.624634384147;15366.308516116773;15646.687066258697;15662.530124096267;5085.186370180762;5278.604104692145;5279.973600131994;5280.445553216915;5286.259923610698;3943.093088589626;4074.5314288856716;5157.742112894359;5237.502437268454;5529.142982837647;5631.042722737145;5695.060315048012;5696.3733989261145;5699.202111704365;5700.543956483492;4965.081459929925;5094.745262736848;5098.847034588968;5128.512791284822;5138.254953031808;4818.566329030404;4954.554090131869;5093.79624815007;5104.61715371345;5156.226566015128;12902.80645790314;13065.934670326587;15935.681286374323;19774;19872.403827885042;1979.1489659446431;2061.36097809678;2104.8631838930573;2173.3805865328304;2360.5396947595227;10184.847227291597;12438.56465023729;12650.557230496888;13060.085793994424;13080.738385232242;1813.7551430556837;1841.235887106849;1872.1575291118916;1890.395073576456;1890.4328701389666;56113.43886561123;56576.43423565794;57112.42887571113;57803.13295300532;58033;9558.713238602853;9735.65925192629;10005.299629025898;10006.349587276804;10076.34503757268;12919.160254583421;12999.805002924964;13001.219926804233;13039.087263891626;13042.217466952014;7330.523515971445;7420.9628951855975;7478.962605186939;7579.772606821804;7612.885806712904;7034.6130962796515;7428.220036896156;7432.033835601337;7470.962645186848;7485.850282994418;4309.892252693708;4336.2845130553105;4340;4373.125374925028;4420.557944205554;1645.3007471824426;1714.2371644618274;1717.0593487945196;1799.3702204228416;1814.5735752098246;901.085398320705;903.9819203616022;908.5684299957468;930.3766476460787;958.5973890965811;13318.400671969785;15118.168500732345;15292.235388230543;15435.15106669144;15751.291191896393;884.3014018925106;905.1627244798535;918.0727465260136;926.4858003807817;1029.629333439961;9187.173154416001;9488.098630630078;9504.097110774464;9540.666076687283;9613.471259080818;369310;376356;377049;533495;539035;46578.767106164254;68869.65565172142;71926.64036679783;74014.62992685109;74367;1096.550414330121;1131.219458573598;1138.6754774889116;1148.190525679394;1148.4831825678477;14065.789013164605;14683.779743304072;14715.705685886436;14987.601983682558;15118.168500732565;30213.244668883453;31374.529382059744;32960.1759956003;33434;33519.49720754142;37563;37861.62138378581;38198;38243.23513529769;39768.2046359077;7409.962950185214;7650.196729343339;7704.38364930793;7742.5354478729205;7799.883001754864;10298.845517317097;10819.783604328028;10994;11340.829887551528;11662.70843228926;7497.887531687138;7610.9238907610215;7615.7334493292465;7689.461737678309;7807;7795;8002.279794818494;8237.176282371714;8268.503889766633;8281.627326770431;6622;7822.804429889298;7998.800029999296;8116.959415202886;8125.674973001013;10450.477476126316;10678.46607669629;10694.304870183412;10728.356298622108;10798;10805.729856753644;10851.945740271563;10905.727356816144;10935.070519005974;11055.391953442639 08:14:52 INFO - PROCESS | 4083 | |3;mootools.html;1280.3662187217328;1507.3669058995222;1527.8930474866756;1691.4840973503085;1814.7277908313752;6832.350926661966;7108.964455177724;7229.168645605757;7245.8913116303165;7262.092238470192;7342.669579868905;7508.849823003537;7511.323980841723;7517.887231691529;7529.0965084189975;2041.867278626892;2081.989590052048;2087.2068613926685;2274.94312642184;2302.896369663369;2042.132093860111;2293.7247530296386;2338.53229354129;2344.906203751848;2346.894389752457;2284.2119468783326;2300;2310.757370476101;2317.2005658047947;2362.01976179886;2283.8743869087193;2307.919222827193;2311.3874823171873;2322.245270287155;2329.359426157812;2278.794908458247;2282.030137191687;2283.5432913417385;2285.931422057341;2301.217586020761;7759.495632783907;7806.219378062206;7809.336206422461;7820.804479887991;7824.4131690122895;4668.649851261135;4758.3576217210575;4789.832355867528;4792.305115758196;4805.327254184417;3094.087244262948;3135.1535085527007;3160.3995240904155;3169.5879535660215;3189.936201275985;1049.6168898352046;1055.3667799320347;1059.210887888528;1092;1901.8858868467798;10632.521536530874;10766.24636275461;10785.83821242682;10789.136869050535;10792.514336854782;4276.850310239127;4418.823247070145;4423.601875831127;4424.867253982386;4460.665450091256;8786.692465763668;8795.076516965755;8805.075467075865;8822.691205807765;8838.690645827364;4869.878253043631;4893.559579637849;4897.436794768647;4899.559039686445;4905.533974272438;4455.576720211575;4500.392447019676;4508.954910450919;4513.029698614748;4521.186186486464;3274.410606090879;3327.351166522505;3508.315878403687;3592.0481072515804;3624.130208749881;1121.1367247219757;1129.4183495499824;1130.8360287758394;1133.951095236919;1136.5681041204289;1260.6533203368963;1274.6749578857518;1297.695041665208;1355.4307190979614;1356.4438580182275;7224.1692205396;7348.853022939511;7410.296021877913;7411.407087432993;7415.740449084256;1094.9671509854718;1106.2311693373028;1106.645873320546;1109.6309379474878;1124.8931351521592;5865.237519122486;5940.108983652487;5958.136070269787;5959.553033522503;5972.761089556369;8961;8998.415103018282;8999.32505062123;9055.275577953747;9374.67188648394;9214;9231.307651926132;9264.212541934012;9324.95337523308;9339.112784285482;7145.356567989392;7228.783136505913;7332.193458719643;7349.338559529668;7399.113226127303;7304.160021597584;7413.369863561657;7422.072240969879;7423.183449820407;7435.144958329645;8208.548529830678;8440;8595.957020214859;8615.22462978335;8749.256313213447;8695.913040869511;8782.736517904474;8927.285817134743;8941.821163576562;8942.105789421006;7108.289171082851;7161.749338773118;7195.604241766544;7224.530405523624;7236.095488063992;6594.142761440982;6767.560108592926;7001.5799052055;7619.733309334147;7704.30661240491;6744.831379215559;6832.248452670103;6832.282610325844;6973;6983.755568555076;6579.868402631825;6610.603363797995;6700.430463410665;6772.322767723385;6892.758753443605;6854.520183587101;6897.41371983387;6901.344372284625;6908.171019477695;6909.861802764017;6212.937870621236;6232.065190221503;6366.108744775827;6381.8723625528155;6390.169277993831;6454.548181627241;6457.870842583216;6506.544541882212;6512.804615861532;6524.869502610016 08:14:52 INFO - PROCESS | 4083 | |4;prototype.html;336.78445794691385;337.8142021887961;341.9538362321089;346.398997738923;348.19740498151765;5906.320773111093;5927.288725352958;5961.046232602774;5979.1928089707935;5980;5600.4959553640165;5693.316801983758;5754.906567752124;5832.912506312408;5833.095870140135;4536.047430039695;4544.681872268926;4560.498345182027;4575.725456472623;4584.083183363324;4371.30059190528;4590.036092420596;4591.517890621487;4596.908061838762;4598.402207712993;4406.25093734066;4452.3544086107495;4514.932276015862;4519.096180763844;4530.4789949155775;4477.171723231213;4534.342520334533;4536.092781443725;4546.749928753918;4551.931721024187;4046.291898917678;4046.291898917678;4049.230646177217;4049.311617025113;4052.858149964737;5465.617406781527;5570.470805273492;5575.024370735146;5575.080111781551;5588.692621905793;5307.814226502092;5308.203769434577;5309.601779866525;5319.308489896289;5321.920171197435;6186.536009799238;6218.751249949996;6221.5333849961435;6221.911165546011;6222.43998040174;4426.712263702849;4467.195904737146;4475.283954567253;4478.820847166109;4484.080763443486;6308.747650093991;6455.677216139175;6470.320616335312;6483.610983340967;6485.767704136199;4576.679632425698;4597.402337696078;4597.448306203277;4598.678092533491;4604.930926036112;4649.372334734768;4650.9767451162525;4651.883702907455;4653.837115700934;4656.813727450932;5281.102212623863;5295.947040529545;5303.708296043755;5304.575633949275;5313.628046036741;6105.725242364104;6254.8123556293385;6270.905936410957;6286.622802631857;6312.936870631327;1573.3470609697076;1591.6180116772123;1595.0828273742413;1597.161490217645;1601.1273855748645;1072.8176210044312;1077.9946100269449;1086.2939089591828;1099.8350247462783;1101.5483651702764;5931.525477961753;5932.466078052996;5934.317553481319;5936.762529498858;5938.6436813791315;6478.449331806755;6484.546081774325;6485.416312531895;6486.643234622046;6487.35126487357;5701.515371193412;5777.768889244468;5848.590598658138;5927.673977931169;5934.495567876779;3466.2720828625766;3484.564429446319;3495.615482296945;3508.122969257686;3509.0876372143425;6481.5138864584405;6622.9006564901565;6739.494537909676;6748.156480439945;6761.763338283136;6494.675266236669;6725.293844146392;6729.192496900306;6742.865142697118;6747.966260168668;6697.564658297195;6719.126513553207;6726.327367263332;6730.7307707692125;6774.864502709918;6318.968405157945;6480.805575832733;6493.707783149864;6494.3505649436565;6498;6406.647634380154;6413.454856337264;6420.036994450869;6502.219733631994;6516.804495864942;6751.966240168767;6757.189137303359;6763.830904227237;6768.695408706719;6769.796906092628;4368.781560922005;4482.75344856036;4483.506814250495;4492.079123779683;4509.233430316788;6424.775132870514;6462.095306656977;6464.676766161579;6478.4169424752;6483.546151769331;6278.4035516625845;6304.306526282014;6310.558260921875;6312.053192021233;6317.96841015792;6092.116643086816;6295.874082518416;6300.117983482408;6300.464460520907;6308.463780578702;6217.937820621736;6231.53263505248;6233.2208473940755;6235;6240.687965601793;6303.873922521616;6364.809055728336;6373.107764912823;6373.3945275198785;6375.107484952017;6087.543434242538;6199.442050215503;6210.689465526796;6227.377262273736;6229.750809967732 08:14:52 INFO - PROCESS | 4083 | |5;yui.html;795.1611050341887;825.9587020648968;834.5326617094428;842.8061545844456;848.9448185867918;12997.545085921995;13188.538401155962;13191.07662463628;13195.208287502744;13239.139455935381;12348.259104453738;12543;12592.307423091726;12603.747925041494;13090.34548272585;666.0542030316961;799.148906414668;804.5896592737716;804.951702897825;806.3549160671469;663.5255792108642;814.0597609760736;815.1848151848152;816.090059583566;820.1552401026922;863.2230992107122;869.2958703450225;873.855813790727;874.3267683883406;874.4927941793744;702.4591064880065;705.1608585782902;850.698002209213;863.0290922711949;864.3215076165211;630.713025573363;630.908518264849;631.4695655649276;633.2843886408375;633.297040285283;13237.536686216032;13293.268870212134;13308.733825323536;13320.733585328238;13322.600321990356;12135.393230338535;12186;12355.938220308932;12486.493452422206;12641.241525508407;10251.79496410075;10481.633142839964;10553.41956192409;10619.94690026545;10649.148068154529;3546.982265088658;3619.6380361963593;3624.2932628137523;3658.817059147032;3704.111013356775;43204.351934721;43230;43367.349489757995;43414.782926085485;43504.782476087734;9827.459489728133;9928.702138935843;10020.949895250476;10173.84739228912;10211.846822297672;18212.817871821113;18215.27138914455;18216.089195540437;18247.908760456114;18302.450926472226;7174.964125179446;7227.9638601806655;7249.166345870292;7308.890366644505;7355.485116041933;4150.771707556113;4191.843276227672;4308.547602501755;4312.547182545787;4336.544662810359;3091.8454077296046;3126.5622812806228;3149.2284390324517;3151.2121969507625;3157.636871759731;547.2010864138402;549.7498638119646;557.9972100139473;561.3936948096047;564.136870588001;620.7485968182893;625.8122563231012;677.6002158726375;688.2601203706037;697.9267176946449;7222.602756848424;7599.810004749926;7639.121501027453;7703.6918523259565;7797.532148071134;569.2514343638186;633.4647223096476;666.6866572710818;702.360851625029;712.6757325416922;3341.933161336808;3381.5096810962273;3553.573571171424;3598.1544337080763;3689.317476266899;49483;49751.50248497541;49981.25028124581;50136.74931625318;50188.24717629238;51469.742651286506;51734.22398664023;51740.74129629328;52369.47630523646;52975;41697.79151104225;42034.78982605129;42367.36448953268;42597.78701106537;43051.56948430538;8169.5506747129475;8280.917190828255;8282.213189746964;8361.331093512383;8368.665253389796;33555.328893422484;33583.992480225636;33722.3255534883;33735.83132084422;34034.65965340315;41874.162516750104;42153.57846421497;42241.57758422376;42282.57717422787;43547.56452435435;10396.948015259875;10757.838632420677;11128.88871111311;11234.3259404436;11417.972382485616;11650.592229271935;11703.76592468163;11842.171048026556;12109;12166.39168041612;10218.182545396201;10236.744081397726;11037.613683521038;11054.834177487504;11102.222844400814;10850.396054401497;10903.127749780157;10920.18098642589;11375.089992800722;11541.942290288494;7968.521888686697;9277.350585458953;10128.79742405133;10479.738006549593;10761.408122553335;9719.805603887742;9752.512374381111;9803.950980245054;9826.5086745661;9840.11438970496;8027.799305017188;8382.37132215074;8895.377323587287;9150.63397464094;9442.622295108118 08:14:52 INFO - PROCESS | 4083 | __end_tp_report 08:14:52 INFO - PROCESS | 4083 | __start_cc_report 08:14:52 INFO - PROCESS | 4083 | _x_x_mozilla_cycle_collect,976 08:14:52 INFO - PROCESS | 4083 | __end_cc_report 08:14:52 INFO - PROCESS | 4083 | __startTimestamp1453824892452__endTimestamp 08:14:52 INFO - PROCESS | 4083 | 08:14:52 INFO - PROCESS | 4083 | ------- Summary: start ------- 08:14:52 INFO - PROCESS | 4083 | Number of tests: 6 08:14:52 INFO - PROCESS | 4083 | 08:14:52 INFO - PROCESS | 4083 | [#0] dojo.html Cycles:165 Average:5101.97 Median:5317.55 stddev:547.37 (10.3%) stddev-sans-first:525.64 08:14:52 INFO - PROCESS | 4083 | Values: 3083.2 3143.6 3161.2 3166.0 3212.1 5038.8 5087.0 5092.6 5106.1 5116.1 5079.5 5107.4 5154.7 5163.1 5165.1 4386.2 4578.4 4612.2 4648.4 4793.2 4631.3 4682.2 4701.1 4730.8 4785.8 4665.9 4710.1 4713.8 4734.6 4750.1 4669.2 4689.4 4693.1 4706.2 4736.8 4552.0 4663.2 4666.6 4669.6 4717.9 4972.4 5009.1 5010.4 5019.9 5028.3 5505.0 5531.8 5533.5 5542.9 5575.3 5400.1 5454.5 5477.6 5565.4 5588.7 5057.8 5129.7 5136.6 5146.8 5161.8 5601.7 5649.5 5661.3 5664.5 5665.0 5300.9 5361.6 5368.0 5452.4 5467.2 5487.0 5512.6 5515.9 5518.9 5579.7 5428.6 5431.1 5450.7 5453.7 5463.3 5356.6 5455.2 5455.6 5461.4 5464.0 4252.6 4280.0 4293.2 4318.8 4333.7 3831.4 3865.7 3867.3 3881.4 3895.3 4932.9 5005.5 5103.1 5124.6 5169.8 5443.3 5481.7 5503.8 5527.3 5529.6 5041.6 5041.9 5055.6 5059.4 5084.0 4599.7 4665.7 4667.1 4673.1 4675.3 5618.6 5634.1 5644.7 5657.2 5698.6 5495.9 5500.2 5502.4 5506.0 5508.6 5508.4 5586.7 5595.6 5632.1 5668.1 5383.3 5458.3 5506.0 5509.6 5560.4 5474.5 5491.4 5528.2 5530.1 5532.2 5366.8 5387.1 5405.5 5457.6 5460.5 5352.7 5368.8 5395.2 5405.6 5455.9 5253.5 5305.7 5315.0 5317.5 5361.7 5352.4 5380.0 5381.6 5388.8 5406.0 5261.2 5297.7 5299.9 5317.6 5355.8 08:14:52 INFO - PROCESS | 4083 | 08:14:52 INFO - PROCESS | 4083 | [#1] ext.html Cycles:180 Average:44770.96 Median:35830.23 stddev:74834.35 (208.9%) stddev-sans-first:74970.55 08:14:52 INFO - PROCESS | 4083 | Values: 527.8 551.8 582.1 584.2 589.6 28178.2 35428.1 35982.8 35992.0 36128.3 41643.6 42271.2 42293.4 42313.8 42314.9 8436.0 8692.6 8714.7 8728.8 8730.3 8424.5 8572.7 8593.1 8600.1 8602.7 8588.9 8665.9 8675.4 8675.5 8677.0 8512.2 8560.7 8568.1 8582.4 8594.1 8439.2 8604.9 8613.5 8619.6 8620.9 38225.6 38231.0 38660.6 38715.4 38728.2 3136.7 3144.3 3150.0 3305.6 3501.4 29039.7 29171.3 29380.7 29487.0 30214.1 3926.3 3995.6 4007.7 4017.7 4087.6 255406.0 255410.0 256343.0 256687.0 256736.0 50546.2 51362.0 52394.2 52575.7 52581.0 59367.0 59839.0 60103.7 60104.0 60151.0 14484.4 14745.3 14822.9 14829.6 14843.0 10872.9 11114.5 11121.6 11157.6 11700.9 18739.9 18905.1 19014.4 19119.8 19149.3 7339.4 7513.2 7574.0 7641.8 7696.2 903.3 948.7 959.5 959.8 1083.8 24327.3 24921.5 25054.5 25358.6 26206.9 1063.9 1068.5 1070.7 1102.0 1145.7 13785.0 14088.3 14144.0 14256.3 14320.3 323243.0 324285.0 326063.0 328239.0 328812.0 50151.7 50463.0 50482.7 50497.0 50535.0 1333.9 1350.3 1351.1 1355.1 1374.1 25457.2 26403.3 26443.5 26496.2 26512.5 47512.8 48428.3 48498.5 48534.3 48548.3 246937.0 275790.0 276789.0 276903.0 279689.0 28882.3 28911.9 28924.3 28986.3 29347.7 38515.6 40189.8 40214.2 42344.0 43106.6 35269.0 35523.0 35902.0 36093.6 37213.4 34677.3 35832.5 35956.1 36091.6 36601.8 32196.0 34389.5 35729.3 35823.6 35828.0 27070.6 28901.2 31364.7 31772.5 31805.5 24107.6 24129.0 24194.1 24409.3 24627.8 08:14:52 INFO - PROCESS | 4083 | 08:14:52 INFO - PROCESS | 4083 | [#2] jquery.html Cycles:180 Average:24251.89 Median:21093.16 stddev:73017.79 (346.2%) stddev-sans-first:73200.56 08:14:52 INFO - PROCESS | 4083 | Values: 346.7 359.8 361.9 362.9 365.5 13531.3 13778.2 15563.4 16436.6 17653.6 14337.6 15014.6 15366.3 15646.7 15662.5 5085.2 5278.6 5280.0 5280.4 5286.3 3943.1 4074.5 5157.7 5237.5 5529.1 5631.0 5695.1 5696.4 5699.2 5700.5 4965.1 5094.7 5098.8 5128.5 5138.3 4818.6 4954.6 5093.8 5104.6 5156.2 12902.8 13065.9 15935.7 19774.0 19872.4 1979.1 2061.4 2104.9 2173.4 2360.5 10184.8 12438.6 12650.6 13060.1 13080.7 1813.8 1841.2 1872.2 1890.4 1890.4 56113.4 56576.4 57112.4 57803.1 58033.0 9558.7 9735.7 10005.3 10006.3 10076.3 12919.2 12999.8 13001.2 13039.1 13042.2 7330.5 7421.0 7479.0 7579.8 7612.9 7034.6 7428.2 7432.0 7471.0 7485.9 4309.9 4336.3 4340.0 4373.1 4420.6 1645.3 1714.2 1717.1 1799.4 1814.6 901.1 904.0 908.6 930.4 958.6 13318.4 15118.2 15292.2 15435.2 15751.3 884.3 905.2 918.1 926.5 1029.6 9187.2 9488.1 9504.1 9540.7 9613.5 369310.0 376356.0 377049.0 533495.0 539035.0 46578.8 68869.7 71926.6 74014.6 74367.0 1096.6 1131.2 1138.7 1148.2 1148.5 14065.8 14683.8 14715.7 14987.6 15118.2 30213.2 31374.5 32960.2 33434.0 33519.5 37563.0 37861.6 38198.0 38243.2 39768.2 7410.0 7650.2 7704.4 7742.5 7799.9 10298.8 10819.8 10994.0 11340.8 11662.7 7497.9 7610.9 7615.7 7689.5 7807.0 7795.0 8002.3 8237.2 8268.5 8281.6 6622.0 7822.8 7998.8 8117.0 8125.7 10450.5 10678.5 10694.3 10728.4 10798.0 10805.7 10851.9 10905.7 10935.1 11055.4 08:14:52 INFO - PROCESS | 4083 | 08:14:52 INFO - PROCESS | 4083 | [#3] mootools.html Cycles:180 Average:5449.36 Median:6222.50 stddev:2776.53 (44.6%) stddev-sans-first:2766.63 08:14:52 INFO - PROCESS | 4083 | Values: 1280.4 1507.4 1527.9 1691.5 1814.7 6832.4 7109.0 7229.2 7245.9 7262.1 7342.7 7508.8 7511.3 7517.9 7529.1 2041.9 2082.0 2087.2 2274.9 2302.9 2042.1 2293.7 2338.5 2344.9 2346.9 2284.2 2300.0 2310.8 2317.2 2362.0 2283.9 2307.9 2311.4 2322.2 2329.4 2278.8 2282.0 2283.5 2285.9 2301.2 7759.5 7806.2 7809.3 7820.8 7824.4 4668.6 4758.4 4789.8 4792.3 4805.3 3094.1 3135.2 3160.4 3169.6 3189.9 1049.6 1055.4 1059.2 1092.0 1901.9 10632.5 10766.2 10785.8 10789.1 10792.5 4276.9 4418.8 4423.6 4424.9 4460.7 8786.7 8795.1 8805.1 8822.7 8838.7 4869.9 4893.6 4897.4 4899.6 4905.5 4455.6 4500.4 4509.0 4513.0 4521.2 3274.4 3327.4 3508.3 3592.0 3624.1 1121.1 1129.4 1130.8 1134.0 1136.6 1260.7 1274.7 1297.7 1355.4 1356.4 7224.2 7348.9 7410.3 7411.4 7415.7 1095.0 1106.2 1106.6 1109.6 1124.9 5865.2 5940.1 5958.1 5959.6 5972.8 8961.0 8998.4 8999.3 9055.3 9374.7 9214.0 9231.3 9264.2 9325.0 9339.1 7145.4 7228.8 7332.2 7349.3 7399.1 7304.2 7413.4 7422.1 7423.2 7435.1 8208.5 8440.0 8596.0 8615.2 8749.3 8695.9 8782.7 8927.3 8941.8 8942.1 7108.3 7161.7 7195.6 7224.5 7236.1 6594.1 6767.6 7001.6 7619.7 7704.3 6744.8 6832.2 6832.3 6973.0 6983.8 6579.9 6610.6 6700.4 6772.3 6892.8 6854.5 6897.4 6901.3 6908.2 6909.9 6212.9 6232.1 6366.1 6381.9 6390.2 6454.5 6457.9 6506.5 6512.8 6524.9 08:14:52 INFO - PROCESS | 4083 | 08:14:52 INFO - PROCESS | 4083 | [#4] prototype.html Cycles:180 Average:5262.66 Median:5929.60 stddev:1569.11 (26.5%) stddev-sans-first:1529.33 08:14:52 INFO - PROCESS | 4083 | Values: 336.8 337.8 342.0 346.4 348.2 5906.3 5927.3 5961.0 5979.2 5980.0 5600.5 5693.3 5754.9 5832.9 5833.1 4536.0 4544.7 4560.5 4575.7 4584.1 4371.3 4590.0 4591.5 4596.9 4598.4 4406.3 4452.4 4514.9 4519.1 4530.5 4477.2 4534.3 4536.1 4546.7 4551.9 4046.3 4046.3 4049.2 4049.3 4052.9 5465.6 5570.5 5575.0 5575.1 5588.7 5307.8 5308.2 5309.6 5319.3 5321.9 6186.5 6218.8 6221.5 6221.9 6222.4 4426.7 4467.2 4475.3 4478.8 4484.1 6308.7 6455.7 6470.3 6483.6 6485.8 4576.7 4597.4 4597.4 4598.7 4604.9 4649.4 4651.0 4651.9 4653.8 4656.8 5281.1 5295.9 5303.7 5304.6 5313.6 6105.7 6254.8 6270.9 6286.6 6312.9 1573.3 1591.6 1595.1 1597.2 1601.1 1072.8 1078.0 1086.3 1099.8 1101.5 5931.5 5932.5 5934.3 5936.8 5938.6 6478.4 6484.5 6485.4 6486.6 6487.4 5701.5 5777.8 5848.6 5927.7 5934.5 3466.3 3484.6 3495.6 3508.1 3509.1 6481.5 6622.9 6739.5 6748.2 6761.8 6494.7 6725.3 6729.2 6742.9 6748.0 6697.6 6719.1 6726.3 6730.7 6774.9 6319.0 6480.8 6493.7 6494.4 6498.0 6406.6 6413.5 6420.0 6502.2 6516.8 6752.0 6757.2 6763.8 6768.7 6769.8 4368.8 4482.8 4483.5 4492.1 4509.2 6424.8 6462.1 6464.7 6478.4 6483.5 6278.4 6304.3 6310.6 6312.1 6318.0 6092.1 6295.9 6300.1 6300.5 6308.5 6217.9 6231.5 6233.2 6235.0 6240.7 6303.9 6364.8 6373.1 6373.4 6375.1 6087.5 6199.4 6210.7 6227.4 6229.8 08:14:52 INFO - PROCESS | 4083 | 08:14:52 INFO - PROCESS | 4083 | [#5] yui.html Cycles:180 Average:13092.21 Median:23783.27 stddev:14812.14 (62.3%) stddev-sans-first:14824.91 08:14:52 INFO - PROCESS | 4083 | Values: 795.2 826.0 834.5 842.8 848.9 12997.5 13188.5 13191.1 13195.2 13239.1 12348.3 12543.0 12592.3 12603.7 13090.3 666.1 799.1 804.6 805.0 806.4 663.5 814.1 815.2 816.1 820.2 863.2 869.3 873.9 874.3 874.5 702.5 705.2 850.7 863.0 864.3 630.7 630.9 631.5 633.3 633.3 13237.5 13293.3 13308.7 13320.7 13322.6 12135.4 12186.0 12355.9 12486.5 12641.2 10251.8 10481.6 10553.4 10619.9 10649.1 3547.0 3619.6 3624.3 3658.8 3704.1 43204.4 43230.0 43367.3 43414.8 43504.8 9827.5 9928.7 10020.9 10173.8 10211.8 18212.8 18215.3 18216.1 18247.9 18302.5 7175.0 7228.0 7249.2 7308.9 7355.5 4150.8 4191.8 4308.5 4312.5 4336.5 3091.8 3126.6 3149.2 3151.2 3157.6 547.2 549.7 558.0 561.4 564.1 620.7 625.8 677.6 688.3 697.9 7222.6 7599.8 7639.1 7703.7 7797.5 569.3 633.5 666.7 702.4 712.7 3341.9 3381.5 3553.6 3598.2 3689.3 49483.0 49751.5 49981.3 50136.7 50188.2 51469.7 51734.2 51740.7 52369.5 52975.0 41697.8 42034.8 42367.4 42597.8 43051.6 8169.6 8280.9 8282.2 8361.3 8368.7 33555.3 33584.0 33722.3 33735.8 34034.7 41874.2 42153.6 42241.6 42282.6 43547.6 10396.9 10757.8 11128.9 11234.3 11418.0 11650.6 11703.8 11842.2 12109.0 12166.4 10218.2 10236.7 11037.6 11054.8 11102.2 10850.4 10903.1 10920.2 11375.1 11541.9 7968.5 9277.4 10128.8 10479.7 10761.4 9719.8 9752.5 9804.0 9826.5 9840.1 8027.8 8382.4 8895.4 9150.6 9442.6 08:14:52 INFO - PROCESS | 4083 | -------- Summary: end -------- 08:14:52 INFO - PROCESS | 4083 | 08:14:53 INFO - TEST-INFO | 4083: exit 0 08:14:53 INFO - TEST-OK | dromaeo_css | took 1112483ms 08:14:53 INFO - TEST-START | kraken 08:14:53 INFO - operating with platform_type : linux_ 08:14:53 INFO - Initialising browser for kraken test... 08:14:53 INFO - TEST-INFO | started process 4280 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEHXEM5/profile http://localhost:48743/getInfo.html) 08:14:56 INFO - PROCESS | 4280 | __metrics Screen width/height:1600/1200 08:14:56 INFO - PROCESS | 4280 | colorDepth:24 08:14:56 INFO - PROCESS | 4280 | Browser inner width/height: 1024/697 08:14:56 INFO - PROCESS | 4280 | __metrics 08:14:57 INFO - PROCESS | 4280 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:14:57 INFO - PROCESS | 4280 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:14:58 INFO - TEST-INFO | 4280: exit 0 08:14:58 INFO - Browser initialized. 08:14:58 INFO - Running cycle 1/1 for kraken test... 08:14:58 INFO - TEST-INFO | started process 4362 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEHXEM5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:09 INFO - PROCESS | 4362 | RSS: Main: 148365312 08:15:09 INFO - PROCESS | 4362 | 08:15:12 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48743/tests/kraken/driver.html?testName=audio-beat-detection) 08:15:12 INFO - PROCESS | 4362 | RSS: Main: 186228736 08:15:12 INFO - PROCESS | 4362 | 08:15:15 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48743/tests/kraken/driver.html?testName=audio-dft) 08:15:16 INFO - PROCESS | 4362 | RSS: Main: 176525312 08:15:16 INFO - PROCESS | 4362 | 08:15:19 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48743/tests/kraken/driver.html?testName=audio-fft) 08:15:19 INFO - PROCESS | 4362 | RSS: Main: 162922496 08:15:19 INFO - PROCESS | 4362 | 08:15:21 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48743/tests/kraken/driver.html?testName=audio-oscillator) 08:15:22 INFO - PROCESS | 4362 | RSS: Main: 166367232 08:15:22 INFO - PROCESS | 4362 | 08:15:24 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48743/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:15:24 INFO - PROCESS | 4362 | RSS: Main: 166764544 08:15:24 INFO - PROCESS | 4362 | 08:15:27 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48743/tests/kraken/driver.html?testName=imaging-darkroom) 08:15:28 INFO - PROCESS | 4362 | RSS: Main: 167596032 08:15:28 INFO - PROCESS | 4362 | 08:15:31 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48743/tests/kraken/driver.html?testName=imaging-desaturate) 08:15:32 INFO - PROCESS | 4362 | RSS: Main: 168706048 08:15:32 INFO - PROCESS | 4362 | 08:15:35 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48743/tests/kraken/driver.html?testName=json-parse-financial) 08:15:35 INFO - PROCESS | 4362 | RSS: Main: 166502400 08:15:35 INFO - PROCESS | 4362 | 08:15:37 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48743/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:15:37 INFO - PROCESS | 4362 | RSS: Main: 178651136 08:15:37 INFO - PROCESS | 4362 | 08:15:39 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48743/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:15:40 INFO - PROCESS | 4362 | RSS: Main: 177975296 08:15:40 INFO - PROCESS | 4362 | 08:15:42 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48743/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:15:42 INFO - PROCESS | 4362 | RSS: Main: 188702720 08:15:42 INFO - PROCESS | 4362 | 08:15:45 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:15:45 INFO - PROCESS | 4362 | RSS: Main: 197824512 08:15:45 INFO - PROCESS | 4362 | 08:15:48 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:15:48 INFO - PROCESS | 4362 | RSS: Main: 195538944 08:15:48 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:48743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48743/tests/kraken/driver.html?testName=ai-astar) 08:15:50 INFO - PROCESS | 4362 | RSS: Main: 255512576 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | __start_tp_report 08:15:50 INFO - PROCESS | 4362 | _x_x_mozilla_page_load 08:15:50 INFO - PROCESS | 4362 | _x_x_mozilla_page_load_details 08:15:50 INFO - PROCESS | 4362 | |i|pagename|runs| 08:15:50 INFO - PROCESS | 4362 | |0;ai-astar;110;111;106;110;109;110;110;110;104;110 08:15:50 INFO - PROCESS | 4362 | |1;audio-beat-detection;156;127;148;168;128;158;148;132;168;131 08:15:50 INFO - PROCESS | 4362 | |2;audio-dft;161;161;163;162;161;162;161;159;162;164 08:15:50 INFO - PROCESS | 4362 | |3;audio-fft;76;73;106;99;73;73;75;106;95;74 08:15:50 INFO - PROCESS | 4362 | |4;audio-oscillator;96;97;140;96;96;96;140;96;96;138 08:15:50 INFO - PROCESS | 4362 | |5;imaging-gaussian-blur;118;115;114;116;114;115;116;114;115;115 08:15:50 INFO - PROCESS | 4362 | |6;imaging-darkroom;145;145;146;145;145;145;145;145;145;145 08:15:50 INFO - PROCESS | 4362 | |7;imaging-desaturate;97;96;96;96;96;96;96;96;96;96 08:15:50 INFO - PROCESS | 4362 | |8;json-parse-financial;56;54;54;54;58;54;55;56;60;52 08:15:50 INFO - PROCESS | 4362 | |9;json-stringify-tinderbox;65;66;66;69;68;67;66;66;66;67 08:15:50 INFO - PROCESS | 4362 | |10;stanford-crypto-aes;81;82;84;84;83;90;83;83;82;84 08:15:50 INFO - PROCESS | 4362 | |11;stanford-crypto-ccm;114;113;122;113;121;113;113;117;113;114 08:15:50 INFO - PROCESS | 4362 | |12;stanford-crypto-pbkdf2;147;136;145;146;145;136;148;143;149;139 08:15:50 INFO - PROCESS | 4362 | |13;stanford-crypto-sha256-iterative;68;72;70;69;69;69;68;71;71;67 08:15:50 INFO - PROCESS | 4362 | __end_tp_report 08:15:50 INFO - PROCESS | 4362 | __start_cc_report 08:15:50 INFO - PROCESS | 4362 | _x_x_mozilla_cycle_collect,933 08:15:50 INFO - PROCESS | 4362 | __end_cc_report 08:15:50 INFO - PROCESS | 4362 | __startTimestamp1453824950920__endTimestamp 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | ------- Summary: start ------- 08:15:50 INFO - PROCESS | 4362 | Number of tests: 14 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.21 (2.0%) stddev-sans-first:2.32 08:15:50 INFO - PROCESS | 4362 | Values: 110.0 111.0 106.0 110.0 109.0 110.0 110.0 110.0 104.0 110.0 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:152.00 stddev:16.07 (10.6%) stddev-sans-first:16.67 08:15:50 INFO - PROCESS | 4362 | Values: 156.0 127.0 148.0 168.0 128.0 158.0 148.0 132.0 168.0 131.0 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.41 08:15:50 INFO - PROCESS | 4362 | Values: 161.0 161.0 163.0 162.0 161.0 162.0 161.0 159.0 162.0 164.0 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#3] audio-fft Cycles:10 Average:85.00 Median:74.50 stddev:14.58 (19.6%) stddev-sans-first:15.09 08:15:50 INFO - PROCESS | 4362 | Values: 76.0 73.0 106.0 99.0 73.0 73.0 75.0 106.0 95.0 74.0 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:96.00 stddev:20.87 (21.7%) stddev-sans-first:21.59 08:15:50 INFO - PROCESS | 4362 | Values: 96.0 97.0 140.0 96.0 96.0 96.0 140.0 96.0 96.0 138.0 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.23 (1.1%) stddev-sans-first:0.78 08:15:50 INFO - PROCESS | 4362 | Values: 118.0 115.0 114.0 116.0 114.0 115.0 116.0 114.0 115.0 115.0 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:15:50 INFO - PROCESS | 4362 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 08:15:50 INFO - PROCESS | 4362 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:2.31 (4.2%) stddev-sans-first:2.44 08:15:50 INFO - PROCESS | 4362 | Values: 56.0 54.0 54.0 54.0 58.0 54.0 55.0 56.0 60.0 52.0 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.50 stddev:1.17 (1.8%) stddev-sans-first:1.09 08:15:50 INFO - PROCESS | 4362 | Values: 65.0 66.0 66.0 69.0 68.0 67.0 66.0 66.0 66.0 67.0 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.50 stddev:2.46 (2.9%) stddev-sans-first:2.42 08:15:50 INFO - PROCESS | 4362 | Values: 81.0 82.0 84.0 84.0 83.0 90.0 83.0 83.0 82.0 84.0 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#11] stanford-crypto-ccm Cycles:10 Average:115.30 Median:114.00 stddev:3.50 (3.1%) stddev-sans-first:3.68 08:15:50 INFO - PROCESS | 4362 | Values: 114.0 113.0 122.0 113.0 121.0 113.0 113.0 117.0 113.0 114.0 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.40 Median:145.50 stddev:4.79 (3.3%) stddev-sans-first:4.90 08:15:50 INFO - PROCESS | 4362 | Values: 147.0 136.0 145.0 146.0 145.0 136.0 148.0 143.0 149.0 139.0 08:15:50 INFO - PROCESS | 4362 | 08:15:50 INFO - PROCESS | 4362 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.58 (2.3%) stddev-sans-first:1.59 08:15:50 INFO - PROCESS | 4362 | Values: 68.0 72.0 70.0 69.0 69.0 69.0 68.0 71.0 71.0 67.0 08:15:50 INFO - PROCESS | 4362 | -------- Summary: end -------- 08:15:50 INFO - PROCESS | 4362 | 08:15:51 INFO - TEST-INFO | 4362: exit 0 08:15:51 INFO - TEST-OK | kraken | took 58693ms 08:15:51 INFO - TEST-START | v8_7 08:15:51 INFO - operating with platform_type : linux_ 08:15:51 INFO - Initialising browser for v8_7 test... 08:15:51 INFO - TEST-INFO | started process 4611 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzYLGK3/profile http://localhost:48743/getInfo.html) 08:15:55 INFO - PROCESS | 4611 | __metrics Screen width/height:1600/1200 08:15:55 INFO - PROCESS | 4611 | colorDepth:24 08:15:55 INFO - PROCESS | 4611 | Browser inner width/height: 1024/697 08:15:55 INFO - PROCESS | 4611 | __metrics 08:15:55 INFO - PROCESS | 4611 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:15:56 INFO - PROCESS | 4611 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:56 INFO - TEST-INFO | 4611: exit 0 08:15:56 INFO - Browser initialized. 08:15:56 INFO - Running cycle 1/1 for v8_7 test... 08:15:56 INFO - TEST-INFO | started process 4694 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzYLGK3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:08 INFO - PROCESS | 4694 | RSS: Main: 147820544 08:16:08 INFO - PROCESS | 4694 | 08:16:31 INFO - PROCESS | 4694 | Cycle 1(1): loaded http://localhost:48743/tests/v8_7/run.html (next: http://localhost:48743/tests/v8_7/run.html) 08:16:31 INFO - PROCESS | 4694 | RSS: Main: 556670976 08:16:31 INFO - PROCESS | 4694 | 08:16:31 INFO - PROCESS | 4694 | __start_tp_report 08:16:31 INFO - PROCESS | 4694 | _x_x_mozilla_page_load 08:16:31 INFO - PROCESS | 4694 | _x_x_mozilla_page_load_details 08:16:31 INFO - PROCESS | 4694 | |i|pagename|runs| 08:16:31 INFO - PROCESS | 4694 | |0;Richards;167.95431642593215 08:16:31 INFO - PROCESS | 4694 | |1;DeltaBlue;190.47619047619048 08:16:31 INFO - PROCESS | 4694 | |2;Encrypt;273.972602739726 08:16:31 INFO - PROCESS | 4694 | |3;Decrypt;5164.948453608247 08:16:31 INFO - PROCESS | 4694 | |4;RayTrace;1966.6011787819255 08:16:31 INFO - PROCESS | 4694 | |5;Earley;775.7951900698216 08:16:31 INFO - PROCESS | 4694 | |6;Boyer;12144.578313253012 08:16:31 INFO - PROCESS | 4694 | |7;RegExp;42770.833333333336 08:16:31 INFO - PROCESS | 4694 | |8;Splay;557.5858250276855 08:16:31 INFO - PROCESS | 4694 | |9;NavierStokes;4840.579710144928 08:16:31 INFO - PROCESS | 4694 | __end_tp_report 08:16:31 INFO - PROCESS | 4694 | __startTimestamp1453824991329__endTimestamp 08:16:31 INFO - PROCESS | 4694 | 08:16:31 INFO - PROCESS | 4694 | ------- Summary: start ------- 08:16:31 INFO - PROCESS | 4694 | Number of tests: 10 08:16:31 INFO - PROCESS | 4694 | 08:16:31 INFO - PROCESS | 4694 | [#0] Richards Cycles:1 Average:167.95 Median:167.95 stddev:0.00 (0.0%) 08:16:31 INFO - PROCESS | 4694 | Values: 168.0 08:16:31 INFO - PROCESS | 4694 | 08:16:31 INFO - PROCESS | 4694 | [#1] DeltaBlue Cycles:1 Average:190.48 Median:190.48 stddev:0.00 (0.0%) 08:16:31 INFO - PROCESS | 4694 | Values: 190.5 08:16:31 INFO - PROCESS | 4694 | 08:16:31 INFO - PROCESS | 4694 | [#2] Encrypt Cycles:1 Average:273.97 Median:273.97 stddev:0.00 (0.0%) 08:16:31 INFO - PROCESS | 4694 | Values: 274.0 08:16:31 INFO - PROCESS | 4694 | 08:16:31 INFO - PROCESS | 4694 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 08:16:31 INFO - PROCESS | 4694 | Values: 5164.9 08:16:31 INFO - PROCESS | 4694 | 08:16:31 INFO - PROCESS | 4694 | [#4] RayTrace Cycles:1 Average:1966.60 Median:1966.60 stddev:0.00 (0.0%) 08:16:31 INFO - PROCESS | 4694 | Values: 1966.6 08:16:31 INFO - PROCESS | 4694 | 08:16:31 INFO - PROCESS | 4694 | [#5] Earley Cycles:1 Average:775.80 Median:775.80 stddev:0.00 (0.0%) 08:16:31 INFO - PROCESS | 4694 | Values: 775.8 08:16:31 INFO - PROCESS | 4694 | 08:16:31 INFO - PROCESS | 4694 | [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 08:16:31 INFO - PROCESS | 4694 | Values: 12144.6 08:16:31 INFO - PROCESS | 4694 | 08:16:31 INFO - PROCESS | 4694 | [#7] RegExp Cycles:1 Average:42770.83 Median:42770.83 stddev:0.00 (0.0%) 08:16:31 INFO - PROCESS | 4694 | Values: 42770.8 08:16:31 INFO - PROCESS | 4694 | 08:16:31 INFO - PROCESS | 4694 | [#8] Splay Cycles:1 Average:557.59 Median:557.59 stddev:0.00 (0.0%) 08:16:31 INFO - PROCESS | 4694 | Values: 557.6 08:16:31 INFO - PROCESS | 4694 | 08:16:31 INFO - PROCESS | 4694 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 08:16:31 INFO - PROCESS | 4694 | Values: 4840.6 08:16:31 INFO - PROCESS | 4694 | -------- Summary: end -------- 08:16:31 INFO - PROCESS | 4694 | 08:16:32 INFO - TEST-INFO | 4694: exit 0 08:16:32 INFO - TEST-OK | v8_7 | took 40412ms 08:16:32 INFO - SUITE-END | took 1211s 08:16:32 INFO - Completed test suite (00:20:11) 08:16:32 INFO - Working with test: dromaeo_css 08:16:32 INFO - Generating results file: dromaeo_css 08:16:32 INFO - Working with test: kraken 08:16:32 INFO - Generating results file: kraken 08:16:32 INFO - javascript benchmark 08:16:32 INFO - Working with test: v8_7 08:16:32 INFO - Generating results file: v8_7 08:16:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:16:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:16:32 INFO - process_Request line: dromaeo_css 6750.39 graph.html#tests=[[72,64,35]] 08:16:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:16:32 INFO - process_Request line: kraken 1501.10 graph.html#tests=[[232,64,35]] 08:16:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:16:32 INFO - process_Request line: v8_7 19118.54 graph.html#tests=[[230,64,35]] 08:16:32 INFO - RETURN: dromaeo_css: 6750.39 08:16:32 INFO - RETURN: kraken: 1501.10 08:16:32 INFO - RETURN: v8_7: 19118.54 08:16:32 INFO - javascript benchmark 08:16:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3083.1983684242095, 3143.6070491188602, 3161.225499752561, 3165.9683403165964, 3212.1166679163234, 5038.82364117255, 5087.03346364191, 5092.618053645978, 5106.106431374508, 5116.079105760961, 5079.466656001122, 5107.438181799999, 5154.74226288685, 5163.122269214233, 5165.147750621143, 4386.188555117314, 4578.404807375036, 4612.169809434292, 4648.418947631546, 4793.209120495114, 4631.258998560231, 4682.180618391768, 4701.059788042388, 4730.810767569293, 4785.808567657289, 4665.93001104982, 4710.081534100852, 4713.764311784397, 4734.597559207455, 4750.097481478508, 4669.229577119805, 4689.413823272091, 4693.108309421199, 4706.152892479352, 4736.763161841928, 4551.977240113778, 4663.207254766698, 4666.556677115668, 4669.579737823612, 4717.858464246078, 4972.428170760372, 5009.073321435546, 5010.398752149729, 5019.949800502021, 5028.321176641143, 5505.0, 5531.806386776443, 5533.541536539663, 5542.86142846428, 5575.330960284751, 5400.054990376669, 5454.53636440903, 5477.589180811455, 5565.41563135873, 5588.748506317225, 5057.8229761958155, 5129.666571672867, 5136.5890728741615, 5146.845594632205, 5161.81933632321, 5601.663900166003, 5649.548036157097, 5661.34894487131, 5664.461876121762, 5665.0, 5300.946990530122, 5361.571074314045, 5368.0, 5452.372977107604, 5467.234587157801, 5487.0, 5512.614117011771, 5515.889682206333, 5518.862028449321, 5579.721013949367, 5428.6471379361, 5431.076716958127, 5450.727463626803, 5453.700046497402, 5463.344398672185, 5356.598255130881, 5455.154451060012, 5455.5908306877145, 5461.371942226615, 5463.989162005042, 4252.553481884358, 4280.036991676848, 4293.162833247487, 4318.827246910088, 4333.696641235147, 3831.3678243090135, 3865.7487263328358, 3867.323218436762, 3881.4177873319227, 3895.2988462077096, 4932.90134197314, 5005.474425185376, 5103.055934652101, 5124.590032797368, 5169.767360468788, 5443.292371991695, 5481.698506582096, 5503.834884953458, 5527.309086364205, 5529.612927095145, 5041.596672266283, 5041.924371134436, 5055.570276526537, 5059.392872855281, 5084.0, 4599.747013914267, 4665.720056796536, 4667.066586682677, 4673.112108699336, 4675.29870519418, 5618.550515958796, 5634.070378387521, 5644.689542075225, 5657.151427285858, 5698.629589076697, 5495.945040549544, 5500.22996780443, 5502.422245664147, 5505.9724701376235, 5508.55931525469, 5508.421615730451, 5586.720663966867, 5595.5523558116065, 5632.098864181875, 5668.149777533403, 5383.327084114486, 5458.263134476795, 5506.0, 5509.559235261089, 5560.443955604407, 5474.479924407175, 5491.423400543045, 5528.19841123043, 5530.115181570929, 5532.197831314517, 5366.758495867617, 5387.111126664056, 5405.5135037846785, 5457.5633949283165, 5460.453954604666, 5352.705601191972, 5368.785248590013, 5395.190721391823, 5405.567554595545, 5455.945440545703, 5253.50091741284, 5305.708186049805, 5315.04329220744, 5317.548008419328, 5361.651492652965, 5352.41123476425, 5380.0, 5381.596380271417, 5388.811391601275, 5406.026915155153, 5261.184516399964, 5297.735113244399, 5299.9470005301, 5317.627766056339, 5355.758990845344], "unit": "score", "name": "dojo.html", "value": 5068.112594751462}, {"lowerIsBetter": false, "replicates": [527.7756953294846, 551.8438870566163, 582.132622392635, 584.2346526050871, 589.575505635942, 28178.154655360348, 35428.11429714259, 35982.82008589953, 35992.0, 36128.277434451295, 41643.58356416435, 42271.15457690844, 42293.36559951596, 42313.78843105788, 42314.88425578724, 8435.999999999985, 8692.56537173142, 8714.738557843244, 8728.825423491526, 8730.257928076122, 8424.53665048422, 8572.742817715478, 8593.097724738875, 8600.096989816073, 8602.698905538307, 8588.914110858874, 8665.870011949826, 8675.392722509427, 8675.522846243453, 8677.045524992278, 8512.233898949093, 8560.657573697044, 8568.100349463279, 8582.356323275779, 8594.097619749962, 8439.240468357815, 8604.8709269361, 8613.526256055915, 8619.569021548898, 8620.870686939637, 38225.61774382276, 38231.0, 38660.613393865984, 38715.41926871071, 38728.225435491135, 3136.686331366845, 3144.339688665383, 3150.039238032399, 3305.5537502437346, 3501.38725723, 29039.709602903913, 29171.270718232, 29380.706192938225, 29487.0, 30214.093577192718, 3926.332523471017, 3995.6403923647013, 4007.6793856491704, 4017.678585713136, 4087.6321131098343, 255406.0, 255410.0, 256343.0, 256687.0, 256736.0, 50546.241806372935, 51362.0, 52394.21408678873, 52575.737121314145, 52581.0, 59367.0, 59839.0, 60103.69948150231, 60104.0, 60151.0, 14484.420623175165, 14745.262736863115, 14822.851771482363, 14829.555113346616, 14843.0, 10872.945635271773, 11114.499847506882, 11121.610743624096, 11157.553697851996, 11700.88299117015, 18739.90630046841, 18905.14926828296, 19014.42956711301, 19119.80880191208, 19149.329773457863, 7339.449541284425, 7513.2111128331835, 7573.962130189314, 7641.7707468776025, 7696.153423123452, 903.3405613901889, 948.691675205561, 959.510649568725, 959.8128364968903, 1083.8211695070383, 24327.27018189457, 24921.5015699685, 25054.4989100217, 25358.619620705704, 26206.86896565505, 1063.9308444951207, 1068.471106802138, 1070.6680928912062, 1102.030213412192, 1145.7021174494691, 13785.0, 14088.295585220698, 14144.0, 14256.287185640676, 14320.283985800877, 323243.0, 324285.0, 326063.0, 328239.0, 328812.0, 50151.74924125356, 50463.0, 50482.74758626183, 50497.0, 50535.0, 1333.8532761396239, 1350.2506109109343, 1351.0880155894731, 1355.0514639752016, 1374.1205628397834, 25457.23628291154, 26403.339916502242, 26443.471130576894, 26496.205113846616, 26512.469750604494, 47512.7624361876, 48428.273575895684, 48498.51501485081, 48534.27198592095, 48548.2717759241, 246937.0, 275790.0, 276789.0, 276903.0, 279689.0, 28882.27794305159, 28911.855440723502, 28924.27689307784, 28986.27534311659, 29347.70652293535, 38515.6148438512, 40189.79905100573, 40214.1957160861, 42344.0, 43106.56893431026, 35269.0, 35523.0, 35902.0, 36093.63906360903, 37213.44179837251, 34677.306453870275, 35832.46251306285, 35956.101097472776, 36091.639083608825, 36601.81699091594, 32196.03411897647, 34389.48415773815, 35729.28541429105, 35823.64176358203, 35828.0, 27070.593941091294, 28901.20405071369, 31364.686353136178, 31772.523412149298, 31805.5229171558, 24107.63838542388, 24129.0, 24194.100233550987, 24409.26772196837, 24627.753722462545], "unit": "score", "name": "ext.html", "value": 17879.69923133153}, {"lowerIsBetter": false, "replicates": [346.667199488491, 359.82188816535813, 361.9022863826765, 362.9038304849215, 365.48101695592254, 13531.323433828318, 13778.242196679179, 15563.377464901405, 16436.58908527286, 17653.64692706147, 14337.569872903803, 15014.624634384147, 15366.308516116773, 15646.687066258697, 15662.530124096267, 5085.186370180762, 5278.604104692145, 5279.973600131994, 5280.445553216915, 5286.259923610698, 3943.093088589626, 4074.5314288856716, 5157.742112894359, 5237.502437268454, 5529.142982837647, 5631.042722737145, 5695.060315048012, 5696.3733989261145, 5699.202111704365, 5700.543956483492, 4965.081459929925, 5094.745262736848, 5098.847034588968, 5128.512791284822, 5138.254953031808, 4818.566329030404, 4954.554090131869, 5093.79624815007, 5104.61715371345, 5156.226566015128, 12902.80645790314, 13065.934670326587, 15935.681286374323, 19774.0, 19872.403827885042, 1979.1489659446431, 2061.36097809678, 2104.8631838930573, 2173.3805865328304, 2360.5396947595227, 10184.847227291597, 12438.56465023729, 12650.557230496888, 13060.085793994424, 13080.738385232242, 1813.7551430556837, 1841.235887106849, 1872.1575291118916, 1890.395073576456, 1890.4328701389666, 56113.43886561123, 56576.43423565794, 57112.42887571113, 57803.13295300532, 58033.0, 9558.713238602853, 9735.65925192629, 10005.299629025898, 10006.349587276804, 10076.34503757268, 12919.160254583421, 12999.805002924964, 13001.219926804233, 13039.087263891626, 13042.217466952014, 7330.523515971445, 7420.9628951855975, 7478.962605186939, 7579.772606821804, 7612.885806712904, 7034.6130962796515, 7428.220036896156, 7432.033835601337, 7470.962645186848, 7485.850282994418, 4309.892252693708, 4336.2845130553105, 4340.0, 4373.125374925028, 4420.557944205554, 1645.3007471824426, 1714.2371644618274, 1717.0593487945196, 1799.3702204228416, 1814.5735752098246, 901.085398320705, 903.9819203616022, 908.5684299957468, 930.3766476460787, 958.5973890965811, 13318.400671969785, 15118.168500732345, 15292.235388230543, 15435.15106669144, 15751.291191896393, 884.3014018925106, 905.1627244798535, 918.0727465260136, 926.4858003807817, 1029.629333439961, 9187.173154416001, 9488.098630630078, 9504.097110774464, 9540.666076687283, 9613.471259080818, 369310.0, 376356.0, 377049.0, 533495.0, 539035.0, 46578.767106164254, 68869.65565172142, 71926.64036679783, 74014.62992685109, 74367.0, 1096.550414330121, 1131.219458573598, 1138.6754774889116, 1148.190525679394, 1148.4831825678477, 14065.789013164605, 14683.779743304072, 14715.705685886436, 14987.601983682558, 15118.168500732565, 30213.244668883453, 31374.529382059744, 32960.1759956003, 33434.0, 33519.49720754142, 37563.0, 37861.62138378581, 38198.0, 38243.23513529769, 39768.2046359077, 7409.962950185214, 7650.196729343339, 7704.38364930793, 7742.5354478729205, 7799.883001754864, 10298.845517317097, 10819.783604328028, 10994.0, 11340.829887551528, 11662.70843228926, 7497.887531687138, 7610.9238907610215, 7615.7334493292465, 7689.461737678309, 7807.0, 7795.0, 8002.279794818494, 8237.176282371714, 8268.503889766633, 8281.627326770431, 6622.0, 7822.804429889298, 7998.800029999296, 8116.959415202886, 8125.674973001013, 10450.477476126316, 10678.46607669629, 10694.304870183412, 10728.356298622108, 10798.0, 10805.729856753644, 10851.945740271563, 10905.727356816144, 10935.070519005974, 11055.391953442639], "unit": "score", "name": "jquery.html", "value": 7953.625970784074}, {"lowerIsBetter": false, "replicates": [1280.3662187217328, 1507.3669058995222, 1527.8930474866756, 1691.4840973503085, 1814.7277908313752, 6832.350926661966, 7108.964455177724, 7229.168645605757, 7245.8913116303165, 7262.092238470192, 7342.669579868905, 7508.849823003537, 7511.323980841723, 7517.887231691529, 7529.0965084189975, 2041.867278626892, 2081.989590052048, 2087.2068613926685, 2274.94312642184, 2302.896369663369, 2042.132093860111, 2293.7247530296386, 2338.53229354129, 2344.906203751848, 2346.894389752457, 2284.2119468783326, 2300.0, 2310.757370476101, 2317.2005658047947, 2362.01976179886, 2283.8743869087193, 2307.919222827193, 2311.3874823171873, 2322.245270287155, 2329.359426157812, 2278.794908458247, 2282.030137191687, 2283.5432913417385, 2285.931422057341, 2301.217586020761, 7759.495632783907, 7806.219378062206, 7809.336206422461, 7820.804479887991, 7824.4131690122895, 4668.649851261135, 4758.3576217210575, 4789.832355867528, 4792.305115758196, 4805.327254184417, 3094.087244262948, 3135.1535085527007, 3160.3995240904155, 3169.5879535660215, 3189.936201275985, 1049.6168898352046, 1055.3667799320347, 1059.210887888528, 1092.0, 1901.8858868467798, 10632.521536530874, 10766.24636275461, 10785.83821242682, 10789.136869050535, 10792.514336854782, 4276.850310239127, 4418.823247070145, 4423.601875831127, 4424.867253982386, 4460.665450091256, 8786.692465763668, 8795.076516965755, 8805.075467075865, 8822.691205807765, 8838.690645827364, 4869.878253043631, 4893.559579637849, 4897.436794768647, 4899.559039686445, 4905.533974272438, 4455.576720211575, 4500.392447019676, 4508.954910450919, 4513.029698614748, 4521.186186486464, 3274.410606090879, 3327.351166522505, 3508.315878403687, 3592.0481072515804, 3624.130208749881, 1121.1367247219757, 1129.4183495499824, 1130.8360287758394, 1133.951095236919, 1136.5681041204289, 1260.6533203368963, 1274.6749578857518, 1297.695041665208, 1355.4307190979614, 1356.4438580182275, 7224.1692205396, 7348.853022939511, 7410.296021877913, 7411.407087432993, 7415.740449084256, 1094.9671509854718, 1106.2311693373028, 1106.645873320546, 1109.6309379474878, 1124.8931351521592, 5865.237519122486, 5940.108983652487, 5958.136070269787, 5959.553033522503, 5972.761089556369, 8961.0, 8998.415103018282, 8999.32505062123, 9055.275577953747, 9374.67188648394, 9214.0, 9231.307651926132, 9264.212541934012, 9324.95337523308, 9339.112784285482, 7145.356567989392, 7228.783136505913, 7332.193458719643, 7349.338559529668, 7399.113226127303, 7304.160021597584, 7413.369863561657, 7422.072240969879, 7423.183449820407, 7435.144958329645, 8208.548529830678, 8440.0, 8595.957020214859, 8615.22462978335, 8749.256313213447, 8695.913040869511, 8782.736517904474, 8927.285817134743, 8941.821163576562, 8942.105789421006, 7108.289171082851, 7161.749338773118, 7195.604241766544, 7224.530405523624, 7236.095488063992, 6594.142761440982, 6767.560108592926, 7001.5799052055, 7619.733309334147, 7704.30661240491, 6744.831379215559, 6832.248452670103, 6832.282610325844, 6973.0, 6983.755568555076, 6579.868402631825, 6610.603363797995, 6700.430463410665, 6772.322767723385, 6892.758753443605, 6854.520183587101, 6897.41371983387, 6901.344372284625, 6908.171019477695, 6909.861802764017, 6212.937870621236, 6232.065190221503, 6366.108744775827, 6381.8723625528155, 6390.169277993831, 6454.548181627241, 6457.870842583216, 6506.544541882212, 6512.804615861532, 6524.869502610016], "unit": "score", "name": "mootools.html", "value": 4518.108963005019}, {"lowerIsBetter": false, "replicates": [336.78445794691385, 337.8142021887961, 341.9538362321089, 346.398997738923, 348.19740498151765, 5906.320773111093, 5927.288725352958, 5961.046232602774, 5979.1928089707935, 5980.0, 5600.4959553640165, 5693.316801983758, 5754.906567752124, 5832.912506312408, 5833.095870140135, 4536.047430039695, 4544.681872268926, 4560.498345182027, 4575.725456472623, 4584.083183363324, 4371.30059190528, 4590.036092420596, 4591.517890621487, 4596.908061838762, 4598.402207712993, 4406.25093734066, 4452.3544086107495, 4514.932276015862, 4519.096180763844, 4530.4789949155775, 4477.171723231213, 4534.342520334533, 4536.092781443725, 4546.749928753918, 4551.931721024187, 4046.291898917678, 4046.291898917678, 4049.230646177217, 4049.311617025113, 4052.858149964737, 5465.617406781527, 5570.470805273492, 5575.024370735146, 5575.080111781551, 5588.692621905793, 5307.814226502092, 5308.203769434577, 5309.601779866525, 5319.308489896289, 5321.920171197435, 6186.536009799238, 6218.751249949996, 6221.5333849961435, 6221.911165546011, 6222.43998040174, 4426.712263702849, 4467.195904737146, 4475.283954567253, 4478.820847166109, 4484.080763443486, 6308.747650093991, 6455.677216139175, 6470.320616335312, 6483.610983340967, 6485.767704136199, 4576.679632425698, 4597.402337696078, 4597.448306203277, 4598.678092533491, 4604.930926036112, 4649.372334734768, 4650.9767451162525, 4651.883702907455, 4653.837115700934, 4656.813727450932, 5281.102212623863, 5295.947040529545, 5303.708296043755, 5304.575633949275, 5313.628046036741, 6105.725242364104, 6254.8123556293385, 6270.905936410957, 6286.622802631857, 6312.936870631327, 1573.3470609697076, 1591.6180116772123, 1595.0828273742413, 1597.161490217645, 1601.1273855748645, 1072.8176210044312, 1077.9946100269449, 1086.2939089591828, 1099.8350247462783, 1101.5483651702764, 5931.525477961753, 5932.466078052996, 5934.317553481319, 5936.762529498858, 5938.6436813791315, 6478.449331806755, 6484.546081774325, 6485.416312531895, 6486.643234622046, 6487.35126487357, 5701.515371193412, 5777.768889244468, 5848.590598658138, 5927.673977931169, 5934.495567876779, 3466.2720828625766, 3484.564429446319, 3495.615482296945, 3508.122969257686, 3509.0876372143425, 6481.5138864584405, 6622.9006564901565, 6739.494537909676, 6748.156480439945, 6761.763338283136, 6494.675266236669, 6725.293844146392, 6729.192496900306, 6742.865142697118, 6747.966260168668, 6697.564658297195, 6719.126513553207, 6726.327367263332, 6730.7307707692125, 6774.864502709918, 6318.968405157945, 6480.805575832733, 6493.707783149864, 6494.3505649436565, 6498.0, 6406.647634380154, 6413.454856337264, 6420.036994450869, 6502.219733631994, 6516.804495864942, 6751.966240168767, 6757.189137303359, 6763.830904227237, 6768.695408706719, 6769.796906092628, 4368.781560922005, 4482.75344856036, 4483.506814250495, 4492.079123779683, 4509.233430316788, 6424.775132870514, 6462.095306656977, 6464.676766161579, 6478.4169424752, 6483.546151769331, 6278.4035516625845, 6304.306526282014, 6310.558260921875, 6312.053192021233, 6317.96841015792, 6092.116643086816, 6295.874082518416, 6300.117983482408, 6300.464460520907, 6308.463780578702, 6217.937820621736, 6231.53263505248, 6233.2208473940755, 6235.0, 6240.687965601793, 6303.873922521616, 6364.809055728336, 6373.107764912823, 6373.3945275198785, 6375.107484952017, 6087.543434242538, 6199.442050215503, 6210.689465526796, 6227.377262273736, 6229.750809967732], "unit": "score", "name": "prototype.html", "value": 4755.853666699418}, {"lowerIsBetter": false, "replicates": [795.1611050341887, 825.9587020648968, 834.5326617094428, 842.8061545844456, 848.9448185867918, 12997.545085921995, 13188.538401155962, 13191.07662463628, 13195.208287502744, 13239.139455935381, 12348.259104453738, 12543.0, 12592.307423091726, 12603.747925041494, 13090.34548272585, 666.0542030316961, 799.148906414668, 804.5896592737716, 804.951702897825, 806.3549160671469, 663.5255792108642, 814.0597609760736, 815.1848151848152, 816.090059583566, 820.1552401026922, 863.2230992107122, 869.2958703450225, 873.855813790727, 874.3267683883406, 874.4927941793744, 702.4591064880065, 705.1608585782902, 850.698002209213, 863.0290922711949, 864.3215076165211, 630.713025573363, 630.908518264849, 631.4695655649276, 633.2843886408375, 633.297040285283, 13237.536686216032, 13293.268870212134, 13308.733825323536, 13320.733585328238, 13322.600321990356, 12135.393230338535, 12186.0, 12355.938220308932, 12486.493452422206, 12641.241525508407, 10251.79496410075, 10481.633142839964, 10553.41956192409, 10619.94690026545, 10649.148068154529, 3546.982265088658, 3619.6380361963593, 3624.2932628137523, 3658.817059147032, 3704.111013356775, 43204.351934721, 43230.0, 43367.349489757995, 43414.782926085485, 43504.782476087734, 9827.459489728133, 9928.702138935843, 10020.949895250476, 10173.84739228912, 10211.846822297672, 18212.817871821113, 18215.27138914455, 18216.089195540437, 18247.908760456114, 18302.450926472226, 7174.964125179446, 7227.9638601806655, 7249.166345870292, 7308.890366644505, 7355.485116041933, 4150.771707556113, 4191.843276227672, 4308.547602501755, 4312.547182545787, 4336.544662810359, 3091.8454077296046, 3126.5622812806228, 3149.2284390324517, 3151.2121969507625, 3157.636871759731, 547.2010864138402, 549.7498638119646, 557.9972100139473, 561.3936948096047, 564.136870588001, 620.7485968182893, 625.8122563231012, 677.6002158726375, 688.2601203706037, 697.9267176946449, 7222.602756848424, 7599.810004749926, 7639.121501027453, 7703.6918523259565, 7797.532148071134, 569.2514343638186, 633.4647223096476, 666.6866572710818, 702.360851625029, 712.6757325416922, 3341.933161336808, 3381.5096810962273, 3553.573571171424, 3598.1544337080763, 3689.317476266899, 49483.0, 49751.50248497541, 49981.25028124581, 50136.74931625318, 50188.24717629238, 51469.742651286506, 51734.22398664023, 51740.74129629328, 52369.47630523646, 52975.0, 41697.79151104225, 42034.78982605129, 42367.36448953268, 42597.78701106537, 43051.56948430538, 8169.5506747129475, 8280.917190828255, 8282.213189746964, 8361.331093512383, 8368.665253389796, 33555.328893422484, 33583.992480225636, 33722.3255534883, 33735.83132084422, 34034.65965340315, 41874.162516750104, 42153.57846421497, 42241.57758422376, 42282.57717422787, 43547.56452435435, 10396.948015259875, 10757.838632420677, 11128.88871111311, 11234.3259404436, 11417.972382485616, 11650.592229271935, 11703.76592468163, 11842.171048026556, 12109.0, 12166.39168041612, 10218.182545396201, 10236.744081397726, 11037.613683521038, 11054.834177487504, 11102.222844400814, 10850.396054401497, 10903.127749780157, 10920.18098642589, 11375.089992800722, 11541.942290288494, 7968.521888686697, 9277.350585458953, 10128.79742405133, 10479.738006549593, 10761.408122553335, 9719.805603887742, 9752.512374381111, 9803.950980245054, 9826.5086745661, 9840.11438970496, 8027.799305017188, 8382.37132215074, 8895.377323587287, 9150.63397464094, 9442.622295108118], "unit": "score", "name": "yui.html", "value": 6109.122931438104}], "name": "dromaeo_css", "value": 6750.388900376118}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 110.0, 109.0, 110.0, 110.0, 110.0, 104.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 148.0, 168.0, 128.0, 158.0, 148.0, 132.0, 168.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 162.0, 161.0, 162.0, 161.0, 159.0, 162.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 106.0, 99.0, 73.0, 73.0, 75.0, 106.0, 95.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 140.0, 96.0, 96.0, 96.0, 140.0, 96.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 114.0, 116.0, 114.0, 115.0, 116.0, 114.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 54.0, 54.0, 58.0, 54.0, 55.0, 56.0, 60.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 69.0, 68.0, 67.0, 66.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 84.0, 84.0, 83.0, 90.0, 83.0, 83.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [114.0, 113.0, 122.0, 113.0, 121.0, 113.0, 113.0, 117.0, 113.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.3}, {"lowerIsBetter": true, "replicates": [147.0, 136.0, 145.0, 146.0, 145.0, 136.0, 148.0, 143.0, 149.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.4}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 70.0, 69.0, 69.0, 69.0, 68.0, 71.0, 71.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1501.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.95431642593215], "unit": "score", "name": "Richards", "value": 210.18810800000006}, {"lowerIsBetter": false, "replicates": [190.47619047619048], "unit": "score", "name": "DeltaBlue", "value": 347.1194999999999}, {"lowerIsBetter": false, "replicates": [273.972602739726], "unit": "score", "name": "Encrypt", "value": 971.56065}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1966.6011787819255], "unit": "score", "name": "RayTrace", "value": 376.2781228771229}, {"lowerIsBetter": false, "replicates": [775.7951900698216], "unit": "score", "name": "Earley", "value": 859.0708069999997}, {"lowerIsBetter": false, "replicates": [12144.578313253012], "unit": "score", "name": "Boyer", "value": 54.87740972222223}, {"lowerIsBetter": false, "replicates": [42770.833333333336], "unit": "score", "name": "RegExp", "value": 21.29921091086215}, {"lowerIsBetter": false, "replicates": [557.5858250276855], "unit": "score", "name": "Splay", "value": 146.1496981132076}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19118.53876777123}]} 08:16:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19118.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1501.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6750.39"}}} 08:16:32 INFO - Return code: 0 08:16:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:16:32 INFO - # TBPL SUCCESS # 08:16:32 INFO - Running post-action listener: _resource_record_post_action 08:16:32 INFO - Running post-run listener: _resource_record_post_run 08:16:33 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 538984448; Read time: 0; Write time: 438100 08:16:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235753472; Read time: 0; Write time: 247592 08:16:33 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 302632960; Read time: 0; Write time: 190508 08:16:33 INFO - Running post-run listener: _upload_blobber_files 08:16:33 INFO - Blob upload gear active. 08:16:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:16:33 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:16:33 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'] 08:16:33 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 08:16:34 INFO - (blobuploader) - INFO - Open directory for files ... 08:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:16:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:35 INFO - (blobuploader) - INFO - Done attempting. 08:16:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:16:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:16:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:36 INFO - (blobuploader) - INFO - Done attempting. 08:16:36 INFO - (blobuploader) - INFO - Iteration through files over. 08:16:36 INFO - Return code: 0 08:16:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:16:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:16:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa73253664590b1bcf02d88532c6ceec8beaa13661bbea9514e6a09a22a55b89ddee0438a7e897e65e61af68598481d562695004b272c0382e06e72ec0aa7759", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c423607049384c7b042a13e2f980484658a1a01a3b1e73c0c0874948ec845e56ddc315642944a0c0dd794606bb910a16d96304655d2f3499efd273ba842a215"} 08:16:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:16:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:16:36 INFO - Contents: 08:16:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa73253664590b1bcf02d88532c6ceec8beaa13661bbea9514e6a09a22a55b89ddee0438a7e897e65e61af68598481d562695004b272c0382e06e72ec0aa7759", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c423607049384c7b042a13e2f980484658a1a01a3b1e73c0c0874948ec845e56ddc315642944a0c0dd794606bb910a16d96304655d2f3499efd273ba842a215"} 08:16:36 INFO - Running post-run listener: copy_logs_to_upload_dir 08:16:36 INFO - Copying logs to upload dir... 08:16:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:16:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.524544 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-26 08:16:36.200256) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-26 08:16:36.204133) ========= 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=4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813 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/fa73253664590b1bcf02d88532c6ceec8beaa13661bbea9514e6a09a22a55b89ddee0438a7e897e65e61af68598481d562695004b272c0382e06e72ec0aa7759", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c423607049384c7b042a13e2f980484658a1a01a3b1e73c0c0874948ec845e56ddc315642944a0c0dd794606bb910a16d96304655d2f3499efd273ba842a215"} build_url:https://queue.taskcluster.net/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011592 build_url: 'https://queue.taskcluster.net/v1/task/YM8oFQeVTPi5mwOY6p4ZcQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa73253664590b1bcf02d88532c6ceec8beaa13661bbea9514e6a09a22a55b89ddee0438a7e897e65e61af68598481d562695004b272c0382e06e72ec0aa7759", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c423607049384c7b042a13e2f980484658a1a01a3b1e73c0c0874948ec845e56ddc315642944a0c0dd794606bb910a16d96304655d2f3499efd273ba842a215"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-26 08:16:36.234384) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 08:16:36.234897) ========= 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=4ac8d263c7293b36a1be1aed000001be-1453823686.728286-1796266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 08:16:36.319053) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-26 08:16:36.319668) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-26 08:16:36.320046) ========= ========= Total master_lag: 0.29 =========