builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1448513377.64 results: success (0) buildid: 20151125173013 builduid: 9d7d418d3d7147fcbfae11b3b5c9147e revision: 3398aa796199edb475ec2ddfce72daa67e61ed33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:37.643141) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:37.643642) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:37.644005) ========= 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=6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006453 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:37.693292) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:37.693820) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:37.754834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:37.755240) ========= 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=6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004640 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:37.805851) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:37.806230) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:37.806640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:37.806978) ========= 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=6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 20:49:38-- 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% 223M=0s 2015-11-25 20:49:38 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137798 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:37.957718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:37.958058) ========= 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=6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022107 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:38.008514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 20:49:38.009190) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 3398aa796199edb475ec2ddfce72daa67e61ed33 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 3398aa796199edb475ec2ddfce72daa67e61ed33 --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=6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 20:49:38,483 truncating revision to first 12 chars 2015-11-25 20:49:38,483 Setting DEBUG logging. 2015-11-25 20:49:38,483 attempt 1/10 2015-11-25 20:49:38,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/3398aa796199?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 20:49:39,753 unpacking tar archive at: b2g-inbound-3398aa796199/testing/mozharness/ program finished with exit code 0 elapsedTime=1.592084 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 20:49:39.618251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:39.618706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:39.628680) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:39.629195) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 20:49:39.629887) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-25 20:49:39.630460) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:49:40 INFO - MultiFileLogger online at 20151125 20:49:40 in /builds/slave/test-pgo 20:49:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 20:49:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:49:40 INFO - {'append_to_log': False, 20:49:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:49:40 INFO - 'blob_upload_branch': 'B2G-Inbound', 20:49:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:49:40 INFO - 'branch': 'B2G-Inbound', 20:49:40 INFO - 'buildbot_json_path': 'buildprops.json', 20:49:40 INFO - 'config_files': ('talos/linux_config.py',), 20:49:40 INFO - 'default_actions': ('clobber', 20:49:40 INFO - 'read-buildbot-config', 20:49:40 INFO - 'download-and-extract', 20:49:40 INFO - 'populate-webroot', 20:49:40 INFO - 'create-virtualenv', 20:49:40 INFO - 'install', 20:49:40 INFO - 'run-tests'), 20:49:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:49:40 INFO - 'download_minidump_stackwalk': True, 20:49:40 INFO - 'download_symbols': 'ondemand', 20:49:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:49:40 INFO - 'tooltool.py': '/tools/tooltool.py', 20:49:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:49:40 INFO - '/tools/misc-python/virtualenv.py')}, 20:49:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:49:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:49:40 INFO - 'installer_path': 'installer.exe', 20:49:40 INFO - 'log_level': 'info', 20:49:40 INFO - 'log_name': 'talos', 20:49:40 INFO - 'log_to_console': True, 20:49:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:49:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:49:40 INFO - 'opt_config_files': (), 20:49:40 INFO - 'pip_index': False, 20:49:40 INFO - 'sps_profile': False, 20:49:40 INFO - 'sps_profile_interval': 0, 20:49:40 INFO - 'suite': 'dromaeojs', 20:49:40 INFO - 'system_bits': '64', 20:49:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:49:40 INFO - 'title': 'talos-linux64-ix-017', 20:49:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:49:40 INFO - 'use_talos_json': True, 20:49:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:49:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:49:40 INFO - 'work_dir': 'build'} 20:49:40 INFO - ##### 20:49:40 INFO - ##### Running clobber step. 20:49:40 INFO - ##### 20:49:40 INFO - Running pre-action listener: _resource_record_pre_action 20:49:40 INFO - Running main action method: clobber 20:49:40 INFO - rmtree: /builds/slave/test-pgo/build 20:49:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:49:40 INFO - Running post-action listener: _resource_record_post_action 20:49:40 INFO - ##### 20:49:40 INFO - ##### Running read-buildbot-config step. 20:49:40 INFO - ##### 20:49:40 INFO - Running pre-action listener: _resource_record_pre_action 20:49:40 INFO - Running main action method: read_buildbot_config 20:49:40 INFO - Using buildbot properties: 20:49:40 INFO - { 20:49:40 INFO - "properties": { 20:49:40 INFO - "buildnumber": 1008, 20:49:40 INFO - "product": "firefox", 20:49:40 INFO - "script_repo_revision": "production", 20:49:40 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 20:49:40 INFO - "repository": "", 20:49:40 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 20:49:40 INFO - "buildid": "20151125173013", 20:49:40 INFO - "slavename": "talos-linux64-ix-017", 20:49:40 INFO - "pgo_build": "True", 20:49:40 INFO - "basedir": "/builds/slave/test-pgo", 20:49:40 INFO - "project": "", 20:49:40 INFO - "platform": "ubuntu64_hw", 20:49:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:49:40 INFO - "slavebuilddir": "test", 20:49:40 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 20:49:40 INFO - "branch": "b2g-inbound", 20:49:40 INFO - "repo_path": "integration/b2g-inbound", 20:49:40 INFO - "stage_platform": "linux64-pgo", 20:49:40 INFO - "builduid": "9d7d418d3d7147fcbfae11b3b5c9147e", 20:49:40 INFO - "revision": "3398aa796199edb475ec2ddfce72daa67e61ed33" 20:49:40 INFO - }, 20:49:40 INFO - "sourcestamp": { 20:49:40 INFO - "repository": "", 20:49:40 INFO - "hasPatch": false, 20:49:40 INFO - "project": "", 20:49:40 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 20:49:40 INFO - "changes": [ 20:49:40 INFO - { 20:49:40 INFO - "category": null, 20:49:40 INFO - "files": [ 20:49:40 INFO - { 20:49:40 INFO - "url": null, 20:49:40 INFO - "name": "https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 20:49:40 INFO - } 20:49:40 INFO - ], 20:49:40 INFO - "repository": "", 20:49:40 INFO - "rev": "3398aa796199edb475ec2ddfce72daa67e61ed33", 20:49:40 INFO - "who": "sendchange", 20:49:40 INFO - "when": 1448513321, 20:49:40 INFO - "number": 6708874, 20:49:40 INFO - "comments": "", 20:49:40 INFO - "project": "", 20:49:40 INFO - "at": "Wed 25 Nov 2015 20:48:41", 20:49:40 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 20:49:40 INFO - "revlink": "", 20:49:40 INFO - "properties": [ 20:49:40 INFO - [ 20:49:40 INFO - "buildid", 20:49:40 INFO - "20151125173013", 20:49:40 INFO - "Change" 20:49:40 INFO - ], 20:49:40 INFO - [ 20:49:40 INFO - "builduid", 20:49:40 INFO - "9d7d418d3d7147fcbfae11b3b5c9147e", 20:49:40 INFO - "Change" 20:49:40 INFO - ], 20:49:40 INFO - [ 20:49:40 INFO - "pgo_build", 20:49:40 INFO - "True", 20:49:40 INFO - "Change" 20:49:40 INFO - ] 20:49:40 INFO - ], 20:49:40 INFO - "revision": "3398aa796199edb475ec2ddfce72daa67e61ed33" 20:49:40 INFO - } 20:49:40 INFO - ], 20:49:40 INFO - "revision": "3398aa796199edb475ec2ddfce72daa67e61ed33" 20:49:40 INFO - } 20:49:40 INFO - } 20:49:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 20:49:40 INFO - Running post-action listener: _resource_record_post_action 20:49:40 INFO - ##### 20:49:40 INFO - ##### Running download-and-extract step. 20:49:40 INFO - ##### 20:49:40 INFO - Running pre-action listener: _resource_record_pre_action 20:49:40 INFO - Running main action method: download_and_extract 20:49:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:49:40 INFO - https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:49:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/test_packages.json 20:49:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/test_packages.json 20:49:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:49:41 INFO - Downloaded 1302 bytes. 20:49:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:49:41 INFO - Using the following test package requirements: 20:49:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:49:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:49:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:49:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:49:41 INFO - u'jsshell-linux-x86_64.zip'], 20:49:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:49:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:49:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:49:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:49:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:49:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:49:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:49:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:49:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:49:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:49:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:49:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:49:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:49:41 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')]} 20:49:41 INFO - https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:49:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:49:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:49:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:49:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:49:42 INFO - Downloaded 22753639 bytes. 20:49:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 20:49:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:49:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:49:44 INFO - Return code: 0 20:49:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:49:44 INFO - https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:49:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:49:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:49:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:49:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:49:46 INFO - Downloaded 22753639 bytes. 20:49:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 20:49:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:49:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:49:47 INFO - Return code: 0 20:49: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')]} 20:49:47 INFO - https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:49:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:49:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:49:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:49:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:49:48 INFO - Downloaded 11131717 bytes. 20:49:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 20:49:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:49:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 20:49:48 INFO - Return code: 0 20:49:48 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')]} 20:49:48 INFO - https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:49:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:49:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:49:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:49:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:49:50 INFO - Downloaded 58370898 bytes. 20:49:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:49:50 INFO - mkdir: /builds/slave/test-pgo/properties 20:49:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:49:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:49:50 INFO - Contents: 20:49:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:49:50 INFO - Running post-action listener: _resource_record_post_action 20:49:50 INFO - Running post-action listener: set_extra_try_arguments 20:49:50 INFO - ##### 20:49:50 INFO - ##### Running populate-webroot step. 20:49:50 INFO - ##### 20:49:50 INFO - Running pre-action listener: _resource_record_pre_action 20:49:50 INFO - Running main action method: populate_webroot 20:49:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:49:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:49:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 20:49:50 INFO - '../fennec_ids.txt'], 20:49:50 INFO - 'tests': ['tcheck2']}, 20:49:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:49:50 INFO - '--tppagecycles', 20:49:50 INFO - '7'], 20:49:50 INFO - 'tests': ['tsvgm']}}, 20:49:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:49:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:49:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:49:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:49:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:49:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:49:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:49:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:50 INFO - 'talos_options': ['--e10s'], 20:49:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:49:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:50 INFO - 'tests': ['damp', 'tps']}, 20:49:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:50 INFO - 'talos_options': ['--e10s'], 20:49:50 INFO - 'tests': ['damp', 'tps']}, 20:49:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:49:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:49:50 INFO - 'other': {'tests': ['a11yr', 20:49:50 INFO - 'ts_paint', 20:49:50 INFO - 'tpaint', 20:49:50 INFO - 'sessionrestore', 20:49:50 INFO - 'sessionrestore_no_auto_restore']}, 20:49:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:49:50 INFO - 'tests': ['a11yr', 20:49:50 INFO - 'ts_paint', 20:49:50 INFO - 'tpaint', 20:49:50 INFO - 'sessionrestore', 20:49:50 INFO - 'sessionrestore_no_auto_restore']}, 20:49:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:49:50 INFO - 'tests': ['a11yr', 20:49:50 INFO - 'ts_paint', 20:49:50 INFO - 'tpaint', 20:49:50 INFO - 'sessionrestore', 20:49:50 INFO - 'sessionrestore_no_auto_restore']}, 20:49:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:49:50 INFO - 'tests': ['a11yr', 20:49:50 INFO - 'ts_paint', 20:49:50 INFO - 'tpaint', 20:49:50 INFO - 'sessionrestore', 20:49:50 INFO - 'sessionrestore_no_auto_restore']}, 20:49:50 INFO - 'other_l64': {'tests': ['a11yr', 20:49:50 INFO - 'ts_paint', 20:49:50 INFO - 'tpaint', 20:49:50 INFO - 'sessionrestore', 20:49:50 INFO - 'sessionrestore_no_auto_restore']}, 20:49:50 INFO - 'other_nol64': {'tests': ['a11yr', 20:49:50 INFO - 'ts_paint', 20:49:50 INFO - 'tpaint', 20:49:50 INFO - 'sessionrestore', 20:49:50 INFO - 'sessionrestore_no_auto_restore']}, 20:49:50 INFO - 'svgr': {'tests': ['tsvgx', 20:49:50 INFO - 'tsvgr_opacity', 20:49:50 INFO - 'tart', 20:49:50 INFO - 'tscrollx', 20:49:50 INFO - 'cart']}, 20:49:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:49:50 INFO - 'tests': ['tsvgx', 20:49:50 INFO - 'tsvgr_opacity', 20:49:50 INFO - 'tart', 20:49:50 INFO - 'tscrollx', 20:49:50 INFO - 'cart']}, 20:49:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:50 INFO - 'tests': ['tp5o']}, 20:49:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:50 INFO - 'talos_options': ['--e10s'], 20:49:50 INFO - 'tests': ['tp5o']}, 20:49:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:50 INFO - 'talos_options': ['--xperf_path', 20:49:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:49:50 INFO - 'tests': ['tp5n']}, 20:49:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:50 INFO - 'talos_options': ['--e10s', 20:49:50 INFO - '--xperf_path', 20:49:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:49:50 INFO - 'tests': ['tp5n']}}, 20:49:50 INFO - 'talos.zip': {'path': '', 20:49:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:49:50 INFO - Running post-action listener: _resource_record_post_action 20:49:50 INFO - ##### 20:49:50 INFO - ##### Running create-virtualenv step. 20:49:50 INFO - ##### 20:49:50 INFO - Running pre-action listener: _resource_record_pre_action 20:49:50 INFO - Running main action method: create_virtualenv 20:49:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:49:50 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 20:49:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:49:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:49:50 INFO - Using real prefix '/usr' 20:49:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:49:50 INFO - Installing distribute.............................................................................................................................................................................................done. 20:49:52 INFO - Installing pip.................done. 20:49:52 INFO - Return code: 0 20:49:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf097d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf98640>, '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 0xf99540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf999d0>, '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': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', '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 20:49:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:49:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:49:52 INFO - Using env: {'DISPLAY': ':0', 20:49:52 INFO - 'HOME': '/home/cltbld', 20:49:52 INFO - 'LANG': 'en_US.UTF-8', 20:49:52 INFO - 'LANGUAGE': 'en_US:en', 20:49:52 INFO - 'LOGNAME': 'cltbld', 20:49:52 INFO - 'MAIL': '/var/mail/cltbld', 20:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:52 INFO - 'MOZ_NO_REMOTE': '1', 20:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:49:52 INFO - 'NO_EM_RESTART': '1', 20:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:49:52 INFO - 'PWD': '/builds/slave/test-pgo', 20:49:52 INFO - 'SHELL': '/bin/bash', 20:49:52 INFO - 'SHLVL': '1', 20:49:52 INFO - 'TERM': 'linux', 20:49:52 INFO - 'TMOUT': '86400', 20:49:52 INFO - 'USER': 'cltbld', 20:49:52 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', 20:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:52 INFO - '_': '/tools/buildbot/bin/python'} 20:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:53 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 20:49:53 INFO - Cleaning up... 20:49:53 INFO - Return code: 0 20:49:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:49: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')]} 20:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49: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')]} 20:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xcdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf097d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf98640>, '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 0xf99540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf999d0>, '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': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', '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 20:49:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:49:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:49:53 INFO - Using env: {'DISPLAY': ':0', 20:49:53 INFO - 'HOME': '/home/cltbld', 20:49:53 INFO - 'LANG': 'en_US.UTF-8', 20:49:53 INFO - 'LANGUAGE': 'en_US:en', 20:49:53 INFO - 'LOGNAME': 'cltbld', 20:49:53 INFO - 'MAIL': '/var/mail/cltbld', 20:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:53 INFO - 'MOZ_NO_REMOTE': '1', 20:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:49:53 INFO - 'NO_EM_RESTART': '1', 20:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:49:53 INFO - 'PWD': '/builds/slave/test-pgo', 20:49:53 INFO - 'SHELL': '/bin/bash', 20:49:53 INFO - 'SHLVL': '1', 20:49:53 INFO - 'TERM': 'linux', 20:49:53 INFO - 'TMOUT': '86400', 20:49:53 INFO - 'USER': 'cltbld', 20:49:53 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', 20:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:53 INFO - '_': '/tools/buildbot/bin/python'} 20:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:53 INFO - Downloading/unpacking psutil>=0.7.1 20:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:49:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:49:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:49:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:49:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:49:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:49:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:49:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:49:55 INFO - Installing collected packages: psutil 20:49:55 INFO - Running setup.py install for psutil 20:49:55 INFO - building 'psutil._psutil_linux' extension 20:49:55 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 20:49:55 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 20:49:55 INFO - building 'psutil._psutil_posix' extension 20:49:55 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 20:49:55 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 20:49:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:49:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:49:55 INFO - Successfully installed psutil 20:49:55 INFO - Cleaning up... 20:49:55 INFO - Return code: 0 20:49:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf097d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf98640>, '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 0xf99540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf999d0>, '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': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', '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 20:49:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 20:49:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:49:55 INFO - Using env: {'DISPLAY': ':0', 20:49:55 INFO - 'HOME': '/home/cltbld', 20:49:55 INFO - 'LANG': 'en_US.UTF-8', 20:49:55 INFO - 'LANGUAGE': 'en_US:en', 20:49:55 INFO - 'LOGNAME': 'cltbld', 20:49:55 INFO - 'MAIL': '/var/mail/cltbld', 20:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:55 INFO - 'MOZ_NO_REMOTE': '1', 20:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:49:55 INFO - 'NO_EM_RESTART': '1', 20:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:49:55 INFO - 'PWD': '/builds/slave/test-pgo', 20:49:55 INFO - 'SHELL': '/bin/bash', 20:49:55 INFO - 'SHLVL': '1', 20:49:55 INFO - 'TERM': 'linux', 20:49:55 INFO - 'TMOUT': '86400', 20:49:55 INFO - 'USER': 'cltbld', 20:49:55 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', 20:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:55 INFO - '_': '/tools/buildbot/bin/python'} 20:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:49:56 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 20:49:56 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 20:49:56 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 20:49:56 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 20:49:56 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 20:49:56 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 20:49:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:49:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:49:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:49:57 INFO - Installing collected packages: mozsystemmonitor 20:49:57 INFO - Running setup.py install for mozsystemmonitor 20:49:57 INFO - Successfully installed mozsystemmonitor 20:49:57 INFO - Cleaning up... 20:49:57 INFO - Return code: 0 20:49:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf097d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf98640>, '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 0xf99540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf999d0>, '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': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', '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 20:49:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 20:49:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:49:57 INFO - Using env: {'DISPLAY': ':0', 20:49:57 INFO - 'HOME': '/home/cltbld', 20:49:57 INFO - 'LANG': 'en_US.UTF-8', 20:49:57 INFO - 'LANGUAGE': 'en_US:en', 20:49:57 INFO - 'LOGNAME': 'cltbld', 20:49:57 INFO - 'MAIL': '/var/mail/cltbld', 20:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:57 INFO - 'MOZ_NO_REMOTE': '1', 20:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:49:57 INFO - 'NO_EM_RESTART': '1', 20:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:49:57 INFO - 'PWD': '/builds/slave/test-pgo', 20:49:57 INFO - 'SHELL': '/bin/bash', 20:49:57 INFO - 'SHLVL': '1', 20:49:57 INFO - 'TERM': 'linux', 20:49:57 INFO - 'TMOUT': '86400', 20:49:57 INFO - 'USER': 'cltbld', 20:49:57 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', 20:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:57 INFO - '_': '/tools/buildbot/bin/python'} 20:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:58 INFO - Downloading/unpacking blobuploader==1.2.4 20:49:58 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 20:49:58 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 20:49:58 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 20:49:58 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 20:49:58 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 20:49:58 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 20:49:59 INFO - Downloading blobuploader-1.2.4.tar.gz 20:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:49:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:49:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:49: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 20:49: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 20:49: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 20:49: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 20:49: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 20:49: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 20:50:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:50:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:50:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:50: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 20:50: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 20:50: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 20:50: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 20:50: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 20:50: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 20:50:00 INFO - Downloading docopt-0.6.1.tar.gz 20:50:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:50:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:50:00 INFO - Installing collected packages: blobuploader, requests, docopt 20:50:00 INFO - Running setup.py install for blobuploader 20:50:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:50:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:50:00 INFO - Running setup.py install for requests 20:50:00 INFO - Running setup.py install for docopt 20:50:00 INFO - Successfully installed blobuploader requests docopt 20:50:00 INFO - Cleaning up... 20:50:01 INFO - Return code: 0 20:50:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:50:01 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')]} 20:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:50:01 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')]} 20:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:50:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf097d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf98640>, '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 0xf99540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf999d0>, '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': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', '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 20:50:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 20:50:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:50:01 INFO - Using env: {'DISPLAY': ':0', 20:50:01 INFO - 'HOME': '/home/cltbld', 20:50:01 INFO - 'LANG': 'en_US.UTF-8', 20:50:01 INFO - 'LANGUAGE': 'en_US:en', 20:50:01 INFO - 'LOGNAME': 'cltbld', 20:50:01 INFO - 'MAIL': '/var/mail/cltbld', 20:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:50:01 INFO - 'MOZ_NO_REMOTE': '1', 20:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:50:01 INFO - 'NO_EM_RESTART': '1', 20:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:50:01 INFO - 'PWD': '/builds/slave/test-pgo', 20:50:01 INFO - 'SHELL': '/bin/bash', 20:50:01 INFO - 'SHLVL': '1', 20:50:01 INFO - 'TERM': 'linux', 20:50:01 INFO - 'TMOUT': '86400', 20:50:01 INFO - 'USER': 'cltbld', 20:50:01 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', 20:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:50:01 INFO - '_': '/tools/buildbot/bin/python'} 20:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:50:01 INFO - Running setup.py (path:/tmp/pip-1mhIr8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:50:01 INFO - Running setup.py (path:/tmp/pip-otJU2b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:50:01 INFO - Running setup.py (path:/tmp/pip-Czdmow-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:50:01 INFO - Running setup.py (path:/tmp/pip-sb9hDn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:50:01 INFO - Running setup.py (path:/tmp/pip-QjlU0r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:50:01 INFO - Running setup.py (path:/tmp/pip-AdhRhA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:50:01 INFO - Running setup.py (path:/tmp/pip-j15BEU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:50:01 INFO - Running setup.py (path:/tmp/pip-ShsYwx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:50:01 INFO - Running setup.py (path:/tmp/pip-dHFF8T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:50:01 INFO - Running setup.py (path:/tmp/pip-MoMqBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:50:01 INFO - Running setup.py (path:/tmp/pip-yV1Lu9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:50:02 INFO - Running setup.py (path:/tmp/pip-VTuTJp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:50:02 INFO - Running setup.py (path:/tmp/pip-3czwrz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:50:02 INFO - Running setup.py (path:/tmp/pip-1Id064-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:50:02 INFO - Running setup.py (path:/tmp/pip-DJtVJZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:50:02 INFO - Running setup.py (path:/tmp/pip-wudKfz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:50:02 INFO - Running setup.py (path:/tmp/pip-F9JtEz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:50:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:50:02 INFO - Running setup.py install for manifestparser 20:50:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:50:02 INFO - Running setup.py install for mozcrash 20:50:02 INFO - Running setup.py install for mozdebug 20:50:02 INFO - Running setup.py install for mozdevice 20:50:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:50:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:50:02 INFO - Running setup.py install for mozfile 20:50:02 INFO - Running setup.py install for mozhttpd 20:50:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:50:03 INFO - Running setup.py install for mozinfo 20:50:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:50:03 INFO - Running setup.py install for mozInstall 20:50:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:50:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:50:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:50:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:50:03 INFO - Running setup.py install for mozleak 20:50:03 INFO - Running setup.py install for mozlog 20:50:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:50:03 INFO - Running setup.py install for moznetwork 20:50:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:50:03 INFO - Running setup.py install for mozprocess 20:50:03 INFO - Running setup.py install for mozprofile 20:50:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:50:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:50:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:50:03 INFO - Running setup.py install for mozrunner 20:50:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:50:03 INFO - Running setup.py install for mozscreenshot 20:50:04 INFO - Running setup.py install for moztest 20:50:04 INFO - Running setup.py install for mozversion 20:50:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:50:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:50:04 INFO - Cleaning up... 20:50:04 INFO - Return code: 0 20:50:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:50:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0xcdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf097d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf98640>, '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 0xf99540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf999d0>, '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': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', '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 20:50:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 20:50:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:50:04 INFO - Using env: {'DISPLAY': ':0', 20:50:04 INFO - 'HOME': '/home/cltbld', 20:50:04 INFO - 'LANG': 'en_US.UTF-8', 20:50:04 INFO - 'LANGUAGE': 'en_US:en', 20:50:04 INFO - 'LOGNAME': 'cltbld', 20:50:04 INFO - 'MAIL': '/var/mail/cltbld', 20:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:50:04 INFO - 'MOZ_NO_REMOTE': '1', 20:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:50:04 INFO - 'NO_EM_RESTART': '1', 20:50:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:50:04 INFO - 'PWD': '/builds/slave/test-pgo', 20:50:04 INFO - 'SHELL': '/bin/bash', 20:50:04 INFO - 'SHLVL': '1', 20:50:04 INFO - 'TERM': 'linux', 20:50:04 INFO - 'TMOUT': '86400', 20:50:04 INFO - 'USER': 'cltbld', 20:50:04 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', 20:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:50:04 INFO - '_': '/tools/buildbot/bin/python'} 20:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:50:04 INFO - Running setup.py (path:/tmp/pip-5nr3nQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:50:04 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)) 20:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:50:04 INFO - Running setup.py (path:/tmp/pip-vn3pKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:50:04 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)) 20:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:50:04 INFO - Running setup.py (path:/tmp/pip-lYn0lL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:50:04 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)) 20:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:50:04 INFO - Running setup.py (path:/tmp/pip-zp0jxy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:50:04 INFO - Running setup.py (path:/tmp/pip-Y3CEt4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:50:04 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)) 20:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:50:04 INFO - Running setup.py (path:/tmp/pip-9br6OQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:50:04 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)) 20:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:50:04 INFO - Running setup.py (path:/tmp/pip-sBgA28-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:50:04 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)) 20:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:50:04 INFO - Running setup.py (path:/tmp/pip-fC_GuS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:50:05 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)) 20:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:50:05 INFO - Running setup.py (path:/tmp/pip-wtw4ja-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:50:05 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)) 20:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:50:05 INFO - Running setup.py (path:/tmp/pip-UYdFdv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:50:05 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)) 20:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:50:05 INFO - Running setup.py (path:/tmp/pip-pRZaDs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:50:05 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)) 20:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:50:05 INFO - Running setup.py (path:/tmp/pip-pqTGPF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:50:05 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)) 20:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:50:05 INFO - Running setup.py (path:/tmp/pip-6QY4ZC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 20:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:50:05 INFO - Running setup.py (path:/tmp/pip-wUrQz_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:50:05 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)) 20:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:50:05 INFO - Running setup.py (path:/tmp/pip-EFPnXk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:50:05 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)) 20:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:50:05 INFO - Running setup.py (path:/tmp/pip-pesEsK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:50:05 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)) 20:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:50:05 INFO - Running setup.py (path:/tmp/pip-GC2yHT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:50:05 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)) 20:50:05 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)) 20:50:05 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)) 20:50:05 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)) 20:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:50:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:50:05 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 20:50:05 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 20:50:05 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 20:50:05 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 20:50:05 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 20:50:05 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 20:50:07 INFO - Downloading blessings-1.5.1.tar.gz 20:50:07 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 20:50:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:50:07 INFO - Installing collected packages: blessings 20:50:07 INFO - Running setup.py install for blessings 20:50:07 INFO - Successfully installed blessings 20:50:07 INFO - Cleaning up... 20:50:07 INFO - Return code: 0 20:50:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:50:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:50:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:50:08 INFO - Reading from file tmpfile_stdout 20:50:08 INFO - Current package versions: 20:50:08 INFO - argparse == 1.2.1 20:50:08 INFO - blessings == 1.5.1 20:50:08 INFO - blobuploader == 1.2.4 20:50:08 INFO - docopt == 0.6.1 20:50:08 INFO - manifestparser == 1.1 20:50:08 INFO - mozInstall == 1.12 20:50:08 INFO - mozcrash == 0.16 20:50:08 INFO - mozdebug == 0.1 20:50:08 INFO - mozdevice == 0.47 20:50:08 INFO - mozfile == 1.2 20:50:08 INFO - mozhttpd == 0.7 20:50:08 INFO - mozinfo == 0.9 20:50:08 INFO - mozleak == 0.1 20:50:08 INFO - mozlog == 3.1 20:50:08 INFO - moznetwork == 0.27 20:50:08 INFO - mozprocess == 0.22 20:50:08 INFO - mozprofile == 0.27 20:50:08 INFO - mozrunner == 6.11 20:50:08 INFO - mozscreenshot == 0.1 20:50:08 INFO - mozsystemmonitor == 0.0 20:50:08 INFO - moztest == 0.7 20:50:08 INFO - mozversion == 1.4 20:50:08 INFO - psutil == 3.1.1 20:50:08 INFO - requests == 1.2.3 20:50:08 INFO - wsgiref == 0.1.2 20:50:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:50:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0xcdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf097d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf98640>, '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 0xf99540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf999d0>, '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': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', '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 20:50:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 20:50:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -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 20:50:08 INFO - Using env: {'DISPLAY': ':0', 20:50:08 INFO - 'HOME': '/home/cltbld', 20:50:08 INFO - 'LANG': 'en_US.UTF-8', 20:50:08 INFO - 'LANGUAGE': 'en_US:en', 20:50:08 INFO - 'LOGNAME': 'cltbld', 20:50:08 INFO - 'MAIL': '/var/mail/cltbld', 20:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:50:08 INFO - 'MOZ_NO_REMOTE': '1', 20:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:50:08 INFO - 'NO_EM_RESTART': '1', 20:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:50:08 INFO - 'PWD': '/builds/slave/test-pgo', 20:50:08 INFO - 'SHELL': '/bin/bash', 20:50:08 INFO - 'SHLVL': '1', 20:50:08 INFO - 'TERM': 'linux', 20:50:08 INFO - 'TMOUT': '86400', 20:50:08 INFO - 'USER': 'cltbld', 20:50:08 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', 20:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:50:08 INFO - '_': '/tools/buildbot/bin/python'} 20:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:50:08 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 1)) 20:50:08 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 2)) 20:50:08 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 3)) 20:50:08 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 4)) 20:50:08 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 5)) 20:50:08 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 6)) 20:50:08 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 7)) 20:50:08 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 8)) 20:50:08 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 20:50:08 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 3)) 20:50:08 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 20:50:08 INFO - Cleaning up... 20:50:08 INFO - Return code: 0 20:50:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:50:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf097d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf98640>, '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 0xf99540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf999d0>, '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': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', '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 20:50:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 20:50:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:50:08 INFO - Using env: {'DISPLAY': ':0', 20:50:08 INFO - 'HOME': '/home/cltbld', 20:50:08 INFO - 'LANG': 'en_US.UTF-8', 20:50:08 INFO - 'LANGUAGE': 'en_US:en', 20:50:08 INFO - 'LOGNAME': 'cltbld', 20:50:08 INFO - 'MAIL': '/var/mail/cltbld', 20:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:50:08 INFO - 'MOZ_NO_REMOTE': '1', 20:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:50:08 INFO - 'NO_EM_RESTART': '1', 20:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:50:08 INFO - 'PWD': '/builds/slave/test-pgo', 20:50:08 INFO - 'SHELL': '/bin/bash', 20:50:08 INFO - 'SHLVL': '1', 20:50:08 INFO - 'TERM': 'linux', 20:50:08 INFO - 'TMOUT': '86400', 20:50:08 INFO - 'USER': 'cltbld', 20:50:08 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', 20:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:50:08 INFO - '_': '/tools/buildbot/bin/python'} 20:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:50:08 INFO - Downloading/unpacking jsonschema 20:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:50:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:50:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:50:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:50:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 20:50:10 INFO - Downloading/unpacking functools32 (from jsonschema) 20:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:50:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:50:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:50:10 INFO - Downloading functools32-3.2.3-2.tar.gz 20:50:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:50:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:50:10 INFO - warning: no files found matching '*.txt' 20:50:10 INFO - no previously-included directories found matching 'build' 20:50:10 INFO - no previously-included directories found matching 'dist' 20:50:10 INFO - no previously-included directories found matching '.git*' 20:50:10 INFO - Installing collected packages: jsonschema, functools32 20:50:10 INFO - Running setup.py install for functools32 20:50:10 INFO - warning: no files found matching '*.txt' 20:50:10 INFO - no previously-included directories found matching 'build' 20:50:10 INFO - no previously-included directories found matching 'dist' 20:50:10 INFO - no previously-included directories found matching '.git*' 20:50:10 INFO - Successfully installed jsonschema functools32 20:50:10 INFO - Cleaning up... 20:50:11 INFO - Return code: 0 20:50:11 INFO - Running post-action listener: _resource_record_post_action 20:50:11 INFO - Running post-action listener: _start_resource_monitoring 20:50:11 INFO - Starting resource monitoring. 20:50:11 INFO - ##### 20:50:11 INFO - ##### Running install step. 20:50:11 INFO - ##### 20:50:11 INFO - Running pre-action listener: _resource_record_pre_action 20:50:11 INFO - Running main action method: install 20:50:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:50:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:50:11 INFO - Reading from file tmpfile_stdout 20:50:11 INFO - Detecting whether we're running mozinstall >=1.0... 20:50:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:50:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:50:11 INFO - Reading from file tmpfile_stdout 20:50:11 INFO - Output received: 20:50:11 INFO - Usage: mozinstall [options] installer 20:50:11 INFO - Options: 20:50:11 INFO - -h, --help show this help message and exit 20:50:11 INFO - -d DEST, --destination=DEST 20:50:11 INFO - Directory to install application into. [default: 20:50:11 INFO - "/builds/slave/test-pgo"] 20:50:11 INFO - --app=APP Application being installed. [default: firefox] 20:50:11 INFO - mkdir: /builds/slave/test-pgo/build/application 20:50:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 20:50:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 20:50:25 INFO - Reading from file tmpfile_stdout 20:50:25 INFO - Output received: 20:50:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:50:25 INFO - Running post-action listener: _resource_record_post_action 20:50:25 INFO - ##### 20:50:25 INFO - ##### Running run-tests step. 20:50:25 INFO - ##### 20:50:25 INFO - Running pre-action listener: _resource_record_pre_action 20:50:25 INFO - Running main action method: run_tests 20:50:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:50:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:50:25 INFO - Python 2.7.3 20:50:25 INFO - Return code: 0 20:50:25 INFO - grabbing minidump binary from tooltool 20:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:50:25 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 0xf98640>, '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 0xf99540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf999d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:50:25 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 20:50:25 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 20:50:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:50:26 INFO - Return code: 0 20:50:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:50:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:50:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:50:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:50:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:50:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 20:50:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 20:50:26 INFO - Using env: {'DISPLAY': ':0', 20:50:26 INFO - 'HOME': '/home/cltbld', 20:50:26 INFO - 'LANG': 'en_US.UTF-8', 20:50:26 INFO - 'LANGUAGE': 'en_US:en', 20:50:26 INFO - 'LOGNAME': 'cltbld', 20:50:26 INFO - 'MAIL': '/var/mail/cltbld', 20:50:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:50:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:50:26 INFO - 'MOZ_NO_REMOTE': '1', 20:50:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:50:26 INFO - 'NO_EM_RESTART': '1', 20:50:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:50:26 INFO - 'PWD': '/builds/slave/test-pgo', 20:50:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:50:26 INFO - 'SHELL': '/bin/bash', 20:50:26 INFO - 'SHLVL': '1', 20:50:26 INFO - 'TERM': 'linux', 20:50:26 INFO - 'TMOUT': '86400', 20:50:26 INFO - 'USER': 'cltbld', 20:50:26 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026', 20:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:50:26 INFO - '_': '/tools/buildbot/bin/python'} 20:50:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 20:50:26 INFO - mozversion INFO | application_buildid: 20151125173013 20:50:26 INFO - mozversion INFO | application_changeset: 3398aa796199edb475ec2ddfce72daa67e61ed33 20:50:26 INFO - mozversion INFO | application_display_name: Nightly 20:50:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:50:26 INFO - mozversion INFO | application_name: Firefox 20:50:26 INFO - mozversion INFO | application_remotingname: firefox 20:50:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 20:50:26 INFO - mozversion INFO | application_vendor: Mozilla 20:50:26 INFO - mozversion INFO | application_version: 45.0a1 20:50:26 INFO - mozversion INFO | platform_buildid: 20151125173013 20:50:26 INFO - mozversion INFO | platform_changeset: 3398aa796199edb475ec2ddfce72daa67e61ed33 20:50:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 20:50:26 INFO - mozversion INFO | platform_version: 45.0a1 20:50:26 INFO - 2015-11-25 20:50:26,208 DEBUG : using testdate: 1448513426 20:50:26 INFO - 2015-11-25 20:50:26,208 DEBUG : actual date: 1448513426 20:50:26 INFO - 2015-11-25 20:50:26,222 INFO : starting webserver on 'localhost:47441' 20:50:26 INFO - 2015-11-25 20:50:26,223 INFO : Starting test suite talos-linux64-ix-017 20:50:26 INFO - 2015-11-25 20:50:26,223 INFO : Starting test dromaeo_css 20:50:26 INFO - 2015-11-25 20:50:26,223 DEBUG : operating with platform_type : linux_ 20:50:26 INFO - 2015-11-25 20:50:26,223 INFO : Initialising browser for dromaeo_css test... 20:50:26 INFO - 2015-11-25 20:50:26,236 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9j8utD/profile http://localhost:47441/getInfo.html 20:50:29 INFO - 2015-11-25 20:50:29,524 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:50:29 INFO - 2015-11-25 20:50:29,525 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:50:29 INFO - 2015-11-25 20:50:29,525 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:50:29 INFO - 2015-11-25 20:50:29,525 DEBUG : BROWSER_OUTPUT: __metrics 20:50:29 INFO - 2015-11-25 20:50:29,589 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:50:30 INFO - 2015-11-25 20:50:30,755 INFO : Browser initialized. 20:50:30 INFO - 2015-11-25 20:50:30,755 INFO : Running cycle 1/1 for dromaeo_css test... 20:50:30 INFO - 2015-11-25 20:50:30,756 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9j8utD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:50:42 INFO - 2015-11-25 20:50:42,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 139255808 20:50:42 INFO - 2015-11-25 20:50:42,477 DEBUG : BROWSER_OUTPUT: 20:51:33 INFO - 2015-11-25 20:51:33,172 DEBUG : BROWSER_OUTPUT: 1448513493171 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] 20:53:43 INFO - 2015-11-25 20:53:43,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47441/tests/dromaeo/cssquery-ext.html) 20:53:44 INFO - 2015-11-25 20:53:44,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 271290368 20:53:44 INFO - 2015-11-25 20:53:44,246 DEBUG : BROWSER_OUTPUT: 20:56:46 INFO - 2015-11-25 20:56:46,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/dromaeo/cssquery-ext.html (next: http://localhost:47441/tests/dromaeo/cssquery-jquery.html) 20:56:47 INFO - 2015-11-25 20:56:47,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 222179328 20:56:47 INFO - 2015-11-25 20:56:47,193 DEBUG : BROWSER_OUTPUT: 20:59:49 INFO - 2015-11-25 20:59:49,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47441/tests/dromaeo/cssquery-mootools.html) 20:59:49 INFO - 2015-11-25 20:59:49,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 217489408 20:59:49 INFO - 2015-11-25 20:59:49,764 DEBUG : BROWSER_OUTPUT: 21:02:51 INFO - 2015-11-25 21:02:51,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47441/tests/dromaeo/cssquery-prototype.html) 21:02:52 INFO - 2015-11-25 21:02:52,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 200589312 21:02:52 INFO - 2015-11-25 21:02:52,189 DEBUG : BROWSER_OUTPUT: 21:05:54 INFO - 2015-11-25 21:05:54,628 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47441/tests/dromaeo/cssquery-yui.html) 21:05:55 INFO - 2015-11-25 21:05:55,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 203829248 21:05:55 INFO - 2015-11-25 21:05:55,215 DEBUG : BROWSER_OUTPUT: 21:08:57 INFO - 2015-11-25 21:08:57,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/dromaeo/cssquery-yui.html (next: http://localhost:47441/tests/dromaeo/cssquery-dojo.html) 21:08:57 INFO - 2015-11-25 21:08:57,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 255344640 21:08:57 INFO - 2015-11-25 21:08:57,925 DEBUG : BROWSER_OUTPUT: 21:08:57 INFO - 2015-11-25 21:08:57,926 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:08:57 INFO - 2015-11-25 21:08:57,927 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:08:57 INFO - 2015-11-25 21:08:57,927 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:08:57 INFO - 2015-11-25 21:08:57,927 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:08:57 INFO - 2015-11-25 21:08:57,928 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3194.1056504178828;3236.288016636342;3273.886878461323;3281.9835900820494;3297.0932993426804;5295.549878260353;5398.136298192295;5424.755885985131;5435.0488664483755;5475.78096876125;5436.864078398042;5501.284832971708;5540.6398584092;5591.049521581331;5598.832035038945;4801.687890287138;5007.626586379815;5033.496650334955;5051.797928082872;5161.4838516148275;5175.715335656538;5180.481951804827;5223;5238.52853243208;5247.449017853128;4931.235658472942;4996.800127994876;5034;5055.140626093536;5108;5039.3196918415915;5069.645124841262;5076.543111120017;5080.745962701887;5140.228965655144;4946.604271658259;5036.924446133275;5042.218456139268;5048.040872234264;5060.5951523878;5192.480751924815;5223.190405487156;5282.075636763551;5282.286891269668;5312;5999.460048595647;6022.036474164157;6030.155778191057;6041.24484439445;6041.577089603729;5825.388334224887;5998.970005149947;6045.244344456943;6092.147099406086;6092.268927728656;5578.804741834017;5633.8591535211945;5680.119581464838;5684.204211410406;5688.232088668018;6106.6336019838955;6141.385861413913;6145.016797312409;6150.969245153746;6152.692365381802;5781.855453613609;5936.317323507766;5949.375315591887;5950.375210602824;5951.107333899863;5894.32215295238;5949.6430214187285;5959.702014899238;6001.819945401645;6059.091136329498;5916.645001299936;5926.2295901532525;5929.347771745104;5931.051031834886;5991.970040149771;5761.3950535194035;5866.618669786536;5914.704264786744;5924.466797988115;5932.377100404482;4543.136804007228;4574.245249533789;4616.28447590624;4646.86059418218;4649.697769644962;4077.062275676611;4077.082656402286;4090.5909409058854;4124.628783409507;4127.814248358831;5513.8345849624575;5664.971675141598;5666.744996475169;5669.06460434032;5672.404397538282;5938.2280303560265;5943.732532035982;5986.281646202397;6084.526061292044;6087.8976843944765;5597.244372009808;5631.211630371751;5641.984442800335;5644.209810626516;5657.57568182388;5193.818216362409;5195.792168313301;5203;5205.037068142406;5249.317588713443;6037.969810150833;6057.545684073712;6097.882086415594;6133.591519773218;6141.025769126933;6067.150598916067;6074.179985701874;6079.848003799941;6085.817425477243;6088.6042407243385;6172.166757487861;6225.62646241227;6269.905951410824;6284.3087260402235;6288.748450061947;5739.110437882135;5806.622569532967;5857.736401861841;5927.31835838884;5972.671503067199;6004.219451471281;6059.363766804422;6081.969590152021;6082.452579267887;6083.270007599116;5912.793052243151;5930.970345148246;5931.436513531207;5931.911021334769;5931.9406805931385;5676.2337084493065;5750.453706897838;5761.4238576143725;5816.534677225896;5886.911696324644;5744.827655170351;5782.942170578241;5792.7103644818435;5795.217645617956;5804.332501762351;5929.288485381781;5936.821895343147;5942.257217847769;5943.138244954544;5999.280086389661;5644.774209031757;5721.685307308138;5754.482096611325;5769.134629805562;5811.186433899342 21:08:57 INFO - 2015-11-25 21:08:57,930 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.5218564220413;593.545937357921;602.6083046020086;606.0364021206282;608.8538750699834;27358.863205683967;28020.57969130462;28026.299342516395;28152.43695126099;39956.60043399565;42044.36933446001;42290.78854605723;42576.78711606438;42600.14799704004;42691.57308426923;8583.828323433512;8730;8745.08176641453;8749.256313213353;8750.21248087672;7649.04386951631;7879.093904201033;8544.18830211129;10119.696409107739;10284.537195826168;10042.04600562949;10119.342242754197;10120.443375614339;10124.493775311243;10126.544305506233;7464.2535746425465;10006.449645269508;10085.394876307446;10095.646652367132;10102.747431314203;7478.588677622729;10462.372257664489;10761.300515466548;10761.354318740823;10766.730831729192;39475.407868881986;39688.60311396907;39758.60241397607;39862;39911.8004409979;3048.9542656860167;3141.0733833519166;3272.1655977725527;3305.3058857639685;3492.580890293156;29248.561271580944;30019.249518761986;30400;30452.238694032603;30547.847260763778;3583.4803953426867;3626.4016437287814;3759.793211373373;3760.8375184269153;3913.236918800835;271787;274872;275389;276444;276635.6168219166;57361.13958290629;58610.413895860496;59401.702991484766;59747;65662.67168664126;60928.08607870885;61069.08396374058;61138;61145.38854611397;61166;15041;15048.774268385983;15053.774193387108;15146;15176.468823591122;11503.827442588368;11535;11541.307521548733;11547.711307217218;11548.480318385693;19973.700394494095;20015.699764503544;20050.498737531678;20461.181552737722;20518.487037824172;7921.722739704082;8254.669813207525;8291.383180279787;8303.667853285922;8319.916800832036;952.9904700953041;976.3702411944256;986.6102889358663;1016.7813920007234;1122.0182340452104;27416.314592135357;27874;27899.884004639993;28463.857680711462;28747.28131796722;1019.7501612105082;1060.2843080920502;1138.9976820397997;1147.6901236666054;1148.3856136966683;14684.41262349494;14797.704045919021;14915.552533424014;15156.090634561962;15175.468858589897;382140;387831;389392;389794;390744;54329.456705432436;54865.72567137139;54901;55097.17354239689;55131;1334.099482849073;1341.805438211454;1351.4796803230827;1352.0738294268458;1354.5191457032809;26515.33711657224;28556.286092847844;28613.42773144567;31190.37619247557;32666.673333267314;50314.49685503098;50873;51009;51075.74462127666;51132;299855;302783;303523;303689;303802;36314;36944.38195225597;41857.39568647386;41992.160156797305;42497;40225;40748.38877416782;41069.58930410777;41420.58579414288;44970.3254451177;37480.81259593685;37567.81216093902;40872.59127408688;41303.58696413117;42187.3671894928;35337.82331088328;36274.63725362712;36510.817445913664;36641.45037824488;39557.40663890102;35862.64137358593;36417.81791091028;36642.26715465729;36865.07837304089;36912.26175476529;31104.533431998992;31919;33595.83202084072;33701.15747106342;33836.830815845766;22708.902621180045;23207.76792232056;23312.417189570395;23320.76679233254;26449.603255951562 21:08:57 INFO - 2015-11-25 21:08:57,933 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.23877044968094;354.5302474221656;354.66129845997074;356.60060731980184;361.88419705694173;13951;14288.928555357235;16390.098544580043;16435.34258629655;16896.070716110626;13860.514881979132;13876.93061534691;13889.708198147293;14226.217558034305;14235.572932812007;5252.868678283055;5272.525472707455;5386.569074474052;5426.75579598919;5432.864178395532;3951.6641085507767;3998.980005099985;4036.576159503254;5389.6496727712765;5765.394633563478;5939.762409503614;5941.70291485424;5945.851353716149;5965.821025369246;5973.701314934257;5801.7099145042575;5902.966980778347;5914.58597898143;5945.672987985659;5946.910796338037;5214.687118772886;5219.451957544441;5220.26916231724;5228.2680424740565;5230.712310822903;20890.47773805667;20913.37259882206;20950.0572474239;20963.056662450075;21220.36338909835;2256.1539422716482;2328.1036800831635;2344.777246161612;2360.9611770820784;2370.620700687899;13415.597532074053;13430.194188348632;13439.66400839977;13442.857357124656;13491.392887320095;1756.4203812741891;1824.5712257619582;1835.4585397307826;1865.9346922857771;1885.1516817432073;54736.17895731567;55164.72417637926;58088.41911580873;61454.38545614531;62456.68771656113;9817.607295708234;9971.850422243671;9993.200543956465;10004.249681273934;10036.698899033041;12910.160839545399;12911.35443227835;13051.412686429134;13071.281079540526;13071.477140914258;7140.571565706075;7404.55572665631;7439.51643143194;7513.549187048795;7616.0860696716745;7154.427645788429;7161.5345002575705;7181.102362204724;7190.280971902768;7326.047613810277;4323.63249123828;4370.601407549617;4413.801378937891;4416.712913660602;4465.531119232499;1695.2540882011876;1726.2490816494865;1731.7402389641402;1745.3542189390007;1793.3006127610242;881.9945262400868;886.7916039730658;939.4691999020531;1012.4735137728487;1036.9325993810378;16825.15874206285;17022.404215852384;17149.657006859794;17175.656486870193;17379.47861564155;890.4167770110588;904.4754042655244;923.6536298887917;933.659214386744;1012.8885822559513;9734.561944712363;9842.961995120098;9870.654527091518;9894.950525247328;10038.849417258747;510447;519262;526177;527883;530689;79086;79533;81482;81725;83335.16664833395;1097.8188598881254;1098.3355070182583;1108.467935391017;1110.3559935237543;1110.7278716714295;15239.695206096038;15318.310676019828;15428.614284642525;15466.458673946358;15730.213489325717;32992;33687.32625347529;33864.15339616529;34310.313793723486;34595.82702086574;47294;47625;47895.281570777166;48471.27293090677;50285.74857125691;9128.269738421042;9598.66404675833;9599.280053995839;9606.51967401641;9615.615375384907;11070.889291106985;13960.58118256454;14766.704665906407;16972.49082527526;17723.82276177222;11125.888741112809;12633.305168215837;13777;14648.85351146475;14823.555293341216;2796.1751283371045;6833.794986150423;7706.959560459266;14255.572332830032;15469.845301547291;14918.179500127164;15192.696146076796;15228.771568426704;15618.496244354326;15906.125163115677;9474.147326740627;9614.086661767122;9647.1317581418;9707.077827606367;9946.950265248628;14309.499167529086;14475.203863787592;15112.168830714416;15370.385184592491;15423.460178893685 21:08:57 INFO - 2015-11-25 21:08:57,935 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1142.4344949250112;1648.7939007624047;1694.1359906447708;1712.0669235266778;1722.2594284457682;6406.839829004271;7166.713331466742;7304.707811687539;7317.12194536655;7325.706971721132;7134;7243.0584024076925;7297.489175757699;7300.342969132777;7302.671379787909;1895.2797936784002;1928.633559623667;2183.912643494258;2201.8678879267213;2233.352327824929;2213.9557208855813;2218.3566765638025;2220.5114874727533;2221.2114699281765;2221.7889300516426;2163.805257526822;2220.888955552224;2222.944426389337;2223.455253462904;2225.410266279437;1908.7518622579046;1949.278766856265;2136.829053675702;2223.5108276179217;2226.109556177526;2173.3588591365583;2198.2416066457045;2217.9778202218095;2225.143319821864;2249.5725812095648;7289.088863892013;7348.154962179311;7353.7058517659225;7367.557946523172;7367.852642947111;4473.396091527635;4589.380433641449;4593.655475839292;4594.862154135348;4595.012072404449;2970.2574356410896;3061.0204734484973;3130.733887619555;3169.904902852918;3182.299894023311;1011.5043628621996;1045.2735348932495;1062.6227689170387;1083.7182332593504;1097.226455348977;9872.950635246778;9998.45008524531;10007.349522281029;10025.59897604095;10031.047050530187;4009.278329900646;4128.896777580585;4145.66834653227;4146.834126634961;4149.854755083557;8398.874016889751;8419.536925469036;8426.662933482714;8435.620397082146;8443.28232100266;4531.84138555149;4545.795439205243;4552.157850797613;4561.429821272341;4562.315652652062;4134.627883490501;4146.481689788777;4148.23257697327;4150.086980864205;4151.564085771011;3450.240946991658;3503.8773642922374;3514.61339252682;3535.9292814144087;3551.5027896094566;1136.2216881436243;1156.9247998880046;1160.083534008141;1160.5067846165346;1165.3066425476827;923.3029063057348;940.1961323068814;952.8094381123665;968.1286841842398;971.2909576009553;6797.864042719118;6828.863422731518;6857.588544687334;6860.279670634612;6871.896921546181;480.48348025872326;481.8530348243749;485.55571651938084;487.7171240680397;493.50156342094743;5408.540274076748;5411.702356370359;5443.564514838803;5457.508824205841;5466.316710411199;8472.237498625153;8849.823003539894;8861.955690221637;8897.243734282658;8900.243479304203;8598.82802343962;8641.611127499278;8663.220310171988;8670.826583468295;8678;6782.321767823277;6938.167419909643;6949.2008419031445;6956.304369563104;6963.6866341014775;6545.050967609765;6610.702518386588;6618.106555614931;6621.205455345389;6627.867442651216;7618.8095297618;7698.461107722405;7708.768736937901;7824.061112666516;7830.412719046209;7795.41534384912;8080.71717489885;8092.71675491355;8192.795180120307;8210.507369557607;6320.494360451245;6356.968215158895;6381.936180638134;6402.103705481143;6478.611283323015;6883.690233939385;6934.479914006369;6943.895841562482;6964.930350696631;6965.407940325129;6564.901526477011;6580.341965803382;6595.505337099641;6671.566348187353;6759.053732477359;6243.063540468966;6328.46208072319;6496.512761542808;6534.215894092739;6615;6355.491560675227;6419.518536109717;6424.357564243538;6432.485401167989;6432.9678351607945;5917.37867523921;5958.1658567801405;5968.701564921824;5968.731407086779;5977.46202841729;5983.551233657406;6016.939830601813;6018.307894592178;6025.276966764016;6026.035834266497 21:08:57 INFO - 2015-11-25 21:08:57,936 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.53005551783366;318.68131868131866;325.9445894197986;326.32450826788545;328.24012411267927;5873.588848780587;5946.5242780577555;5966.940330596693;5971.432713892184;5997.88004239915;5860.794872179475;5889.1755154278435;5894.410558944114;5896.056630939051;5896.145058966447;4369.060651959828;4435.534268901767;4438.911221775563;4560.8859778505475;4562.5665561771575;4523.457185137788;4540.9772951135365;4549.294859296798;4551.203539380612;4561.452625684922;4471.306947423154;4472.888177795565;4477.059817438342;4480.395146655209;4510.97744511277;4297;4386.40783494229;4391.055922976575;4464.196444639963;4469.4860091089295;3923.509561304837;3929.98035009826;3942.921141577181;3943.0536671198706;3950.7036972227197;5603.439656034405;5605.971970140164;5626.2967129108865;5628.887422251532;5639.238702775155;5147.510986456281;5183.481651834824;5185.274061631375;5186.222066689989;5195.922061169085;6240.843978900519;6250.187475628185;6252.218472690914;6253.405926436982;6258.780942666985;4387.736735795863;4389.934150987738;4391.3193455014525;4396.384506169139;4403.9559604404185;6470.450011749007;6480.611163330215;6481.4166724994975;6485.578437401554;6492.3183065777885;4394.077243778842;4476.6418686505;4482.036362182146;4502.257127573914;4503.076869241863;4519.502854685982;4521.660875434355;4525.705829121097;4531.909361812811;4533.5013148553635;5234.298852872832;5234.633575649668;5242.397124330751;5242.50196231365;5244.947550524522;6299.5275354348605;6304.621722696653;6304.747810087637;6307.4954003679595;6307.873842523216;1584.2395650087792;1585.484717466828;1615.4830454254761;1617.1186703246758;1618.247514905551;1046.9685909422728;1068.834330678746;1071.3518321415431;1081.259337353915;1083.2200815412891;6116.327204007555;6119.602225855394;6121.816345509642;6122.908156377658;6125.693715314216;6508.153939987866;6509.641969691617;6510.121133646897;6525.249596296487;6546.345365463416;6013.6993150342305;6069.089636554552;6110.388961103854;6115.113308570232;6120.969395152996;3514.648535146516;3539.50446937429;3546.858125674996;3548.4854696068924;3552.5381700378784;6648.235452922976;6680.565763225375;6689.632070236184;6698.5980841149685;6715.764948226789;6522.576032557963;6635.407502199438;6638.535302528777;6640;6646.401823835781;6678.630880669548;6693.129893113962;6696.363845434676;6704.161979752531;6708.463322934153;6485.77299794505;6491.545591808528;6492.35076492347;6494.6752662367635;6497.18785151856;6333.714982825876;6439.839004024937;6442.2591401989375;6445.2587952386075;6446.161998940108;6692.163479565054;6716.059751634677;6723.966380168068;6725.4619630430425;6726.327367263235;4476.306172543261;4484.573965473275;4485.820567177277;4489.8653040407535;4492.842750503717;6440.806775796734;6460.095586617783;6476.676166191766;6496.415322620986;6497.285298617054;6201.542745890601;6264.718087685974;6290.811275661737;6309.242890853127;6316.463100636313;6272.968635156795;6282.780102696383;6283.49732021428;6283.497320214463;6284.24589049317;6163.445289923929;6164.7842325518395;6189.690515474118;6189.938100618936;6192.504599632109;5933.970330148321;6135.14108024868;6265.655388953652;6414.5189110815945;6417.454516366161;6247.3440288769025;6248.187735594343;6251.218597675291;6253.437190652863;6253.687315634291 21:08:57 INFO - 2015-11-25 21:08:57,937 DEBUG : BROWSER_OUTPUT: |5;yui.html;648.9578177418467;667.2926697700435;713.2653367031958;823.5676269958275;834.6577903059747;13546.729065418685;13654.38555265013;13774.793378099312;13780.379882905256;13800.585982420518;12741.426635801388;12938.870611293883;12974;12983;12995.350232488385;826.6734639817283;840.4663038970267;841.6086519768306;842.1578421578422;842.3303473738392;838.174398217755;841.9831603367929;842.2756429470681;842.6166094427051;843.5487014447272;864.7362554420899;870.3211495033884;870.7779516223354;872.6901949807822;872.7687162901805;872.9214370706667;873.1181506678237;873.8645509945968;875.3172525430143;878.8066625342415;614.8862460444788;626.7555653295218;634.8761991411676;635.5582869905418;635.7615894039735;13725.862741372559;13877.791833122512;13890.513832015831;13919.443222271097;13931.30343482832;11673.29960202382;12052.758944821055;12182.573609923611;12298.385080745928;12680.492780288778;10289.434081125535;10310.793784124351;10340.121089707383;10345.275830691855;10376.844347334796;3490.6683865032783;3510.7542472026967;3553.626869178725;3653.2876089162623;3665.5234819473562;40165.59834401648;40399;43926.78036609828;45447.772761136315;49142.75428622834;9760.316777825627;9837.11465968052;9851.50742462874;9908.752281193028;9921.751956201007;17079.829201707824;17139.400120995706;17154.656906861794;17162.485125446256;17163.485095446908;6858.622775747282;7037.472189585699;7071.186813516409;7212.170600380919;7251.601161936144;4053.8986525336513;4192.727472714264;4208.8271780232435;4248.978755106266;4303;3066.126154046086;3107.0368185862453;3111.191090316489;3111.377724455118;3111.5643809866638;535.7856857257051;550.7411516587198;552.0670067585767;553.4797290546873;565.2510423688547;494.8614387971374;609.6403122157948;615.7044618583105;637.6046850952347;639.792067578039;9276.953615232016;9335.813283734287;9491.905080949102;9513.571889265;9757.316987810786;561.5170952980434;658.6180015590945;669.6651674162919;685.1914740606132;690.6650274616807;4088.2436749201493;4279.251131052053;4330.718503297276;4335.523092459827;4353.064091220403;58838;59253.703731481066;59459.40540594625;59581.10628340578;59708.10437843436;53039.942120100946;53854.73072634612;54067.72966135144;54145.45854541483;54252.45747542553;41938.58061419408;46104;46558;46606.76696616495;46658.76670616625;8894.42186257891;8936.106389361272;8946.37375383717;8973.865392019256;9099.772505687411;36164.4575331365;36185.63814361823;36930.26139477249;36987.44518832166;37033;36584;37404;39608.801955990035;44569;44746.77626611846;11134.498947547218;11202.079660561047;11407.942960285145;11479.655610331703;11589.072874170215;12438.564650237198;12893.41979610901;12994.870051299366;13010.154339967872;13419.261940593362;11524.654260372203;11728.765424691288;11797;12164.756704865677;12297.077719170918;11760.235584686969;11938.22401543897;12019.09856760764;12151.149419540547;12398;11606.477708503306;11729.237599556001;11930.880691192977;12159.392030398622;12394.938025309815;10209.50781656069;10217.1826253901;10237.795244095225;10638.468076596295;10707.411092389993;9729.513524323896;9890.505474726378;10047.296689231684;10048.598056077675;10358.792824143626 21:08:57 INFO - 2015-11-25 21:08:57,937 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:08:57 INFO - 2015-11-25 21:08:57,937 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:08:57 INFO - 2015-11-25 21:08:57,937 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,982 21:08:57 INFO - 2015-11-25 21:08:57,938 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:08:57 INFO - 2015-11-25 21:08:57,938 DEBUG : BROWSER_OUTPUT: __startTimestamp1448514537925__endTimestamp 21:08:57 INFO - 2015-11-25 21:08:57,938 DEBUG : BROWSER_OUTPUT: 21:08:57 INFO - 2015-11-25 21:08:57,938 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:08:57 INFO - 2015-11-25 21:08:57,938 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:08:57 INFO - 2015-11-25 21:08:57,938 DEBUG : BROWSER_OUTPUT: 21:08:57 INFO - 2015-11-25 21:08:57,938 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5547.49 Median:5761.40 stddev:634.34 (11.0%) stddev-sans-first:608.83 21:08:57 INFO - 2015-11-25 21:08:57,940 DEBUG : BROWSER_OUTPUT: Values: 3194.1 3236.3 3273.9 3282.0 3297.1 5295.5 5398.1 5424.8 5435.0 5475.8 5436.9 5501.3 5540.6 5591.0 5598.8 4801.7 5007.6 5033.5 5051.8 5161.5 5175.7 5180.5 5223.0 5238.5 5247.4 4931.2 4996.8 5034.0 5055.1 5108.0 5039.3 5069.6 5076.5 5080.7 5140.2 4946.6 5036.9 5042.2 5048.0 5060.6 5192.5 5223.2 5282.1 5282.3 5312.0 5999.5 6022.0 6030.2 6041.2 6041.6 5825.4 5999.0 6045.2 6092.1 6092.3 5578.8 5633.9 5680.1 5684.2 5688.2 6106.6 6141.4 6145.0 6151.0 6152.7 5781.9 5936.3 5949.4 5950.4 5951.1 5894.3 5949.6 5959.7 6001.8 6059.1 5916.6 5926.2 5929.3 5931.1 5992.0 5761.4 5866.6 5914.7 5924.5 5932.4 4543.1 4574.2 4616.3 4646.9 4649.7 4077.1 4077.1 4090.6 4124.6 4127.8 5513.8 5665.0 5666.7 5669.1 5672.4 5938.2 5943.7 5986.3 6084.5 6087.9 5597.2 5631.2 5642.0 5644.2 5657.6 5193.8 5195.8 5203.0 5205.0 5249.3 6038.0 6057.5 6097.9 6133.6 6141.0 6067.2 6074.2 6079.8 6085.8 6088.6 6172.2 6225.6 6269.9 6284.3 6288.7 5739.1 5806.6 5857.7 5927.3 5972.7 6004.2 6059.4 6082.0 6082.5 6083.3 5912.8 5931.0 5931.4 5931.9 5931.9 5676.2 5750.5 5761.4 5816.5 5886.9 5744.8 5782.9 5792.7 5795.2 5804.3 5929.3 5936.8 5942.3 5943.1 5999.3 5644.8 5721.7 5754.5 5769.1 5811.2 21:08:57 INFO - 2015-11-25 21:08:57,940 DEBUG : BROWSER_OUTPUT: 21:08:57 INFO - 2015-11-25 21:08:57,940 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49244.51 Median:19415.20 stddev:85417.50 (440.0%) stddev-sans-first:85578.91 21:08:57 INFO - 2015-11-25 21:08:57,940 DEBUG : BROWSER_OUTPUT: Values: 562.5 593.5 602.6 606.0 608.9 27358.9 28020.6 28026.3 28152.4 39956.6 42044.4 42290.8 42576.8 42600.1 42691.6 8583.8 8730.0 8745.1 8749.3 8750.2 7649.0 7879.1 8544.2 10119.7 10284.5 10042.0 10119.3 10120.4 10124.5 10126.5 7464.3 10006.4 10085.4 10095.6 10102.7 7478.6 10462.4 10761.3 10761.4 10766.7 39475.4 39688.6 39758.6 39862.0 39911.8 3049.0 3141.1 3272.2 3305.3 3492.6 29248.6 30019.2 30400.0 30452.2 30547.8 3583.5 3626.4 3759.8 3760.8 3913.2 271787.0 274872.0 275389.0 276444.0 276635.6 57361.1 58610.4 59401.7 59747.0 65662.7 60928.1 61069.1 61138.0 61145.4 61166.0 15041.0 15048.8 15053.8 15146.0 15176.5 11503.8 11535.0 11541.3 11547.7 11548.5 19973.7 20015.7 20050.5 20461.2 20518.5 7921.7 8254.7 8291.4 8303.7 8319.9 953.0 976.4 986.6 1016.8 1122.0 27416.3 27874.0 27899.9 28463.9 28747.3 1019.8 1060.3 1139.0 1147.7 1148.4 14684.4 14797.7 14915.6 15156.1 15175.5 382140.0 387831.0 389392.0 389794.0 390744.0 54329.5 54865.7 54901.0 55097.2 55131.0 1334.1 1341.8 1351.5 1352.1 1354.5 26515.3 28556.3 28613.4 31190.4 32666.7 50314.5 50873.0 51009.0 51075.7 51132.0 299855.0 302783.0 303523.0 303689.0 303802.0 36314.0 36944.4 41857.4 41992.2 42497.0 40225.0 40748.4 41069.6 41420.6 44970.3 37480.8 37567.8 40872.6 41303.6 42187.4 35337.8 36274.6 36510.8 36641.5 39557.4 35862.6 36417.8 36642.3 36865.1 36912.3 31104.5 31919.0 33595.8 33701.2 33836.8 22708.9 23207.8 23312.4 23320.8 26449.6 21:08:57 INFO - 2015-11-25 21:08:57,940 DEBUG : BROWSER_OUTPUT: 21:08:57 INFO - 2015-11-25 21:08:57,940 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28235.76 Median:354.60 stddev:85490.96 (24109.4%) stddev-sans-first:85705.14 21:08:57 INFO - 2015-11-25 21:08:57,940 DEBUG : BROWSER_OUTPUT: Values: 353.2 354.5 354.7 356.6 361.9 13951.0 14288.9 16390.1 16435.3 16896.1 13860.5 13876.9 13889.7 14226.2 14235.6 5252.9 5272.5 5386.6 5426.8 5432.9 3951.7 3999.0 4036.6 5389.6 5765.4 5939.8 5941.7 5945.9 5965.8 5973.7 5801.7 5903.0 5914.6 5945.7 5946.9 5214.7 5219.5 5220.3 5228.3 5230.7 20890.5 20913.4 20950.1 20963.1 21220.4 2256.2 2328.1 2344.8 2361.0 2370.6 13415.6 13430.2 13439.7 13442.9 13491.4 1756.4 1824.6 1835.5 1865.9 1885.2 54736.2 55164.7 58088.4 61454.4 62456.7 9817.6 9971.9 9993.2 10004.2 10036.7 12910.2 12911.4 13051.4 13071.3 13071.5 7140.6 7404.6 7439.5 7513.5 7616.1 7154.4 7161.5 7181.1 7190.3 7326.0 4323.6 4370.6 4413.8 4416.7 4465.5 1695.3 1726.2 1731.7 1745.4 1793.3 882.0 886.8 939.5 1012.5 1036.9 16825.2 17022.4 17149.7 17175.7 17379.5 890.4 904.5 923.7 933.7 1012.9 9734.6 9843.0 9870.7 9895.0 10038.8 510447.0 519262.0 526177.0 527883.0 530689.0 79086.0 79533.0 81482.0 81725.0 83335.2 1097.8 1098.3 1108.5 1110.4 1110.7 15239.7 15318.3 15428.6 15466.5 15730.2 32992.0 33687.3 33864.2 34310.3 34595.8 47294.0 47625.0 47895.3 48471.3 50285.7 9128.3 9598.7 9599.3 9606.5 9615.6 11070.9 13960.6 14766.7 16972.5 17723.8 11125.9 12633.3 13777.0 14648.9 14823.6 2796.2 6833.8 7707.0 14255.6 15469.8 14918.2 15192.7 15228.8 15618.5 15906.1 9474.1 9614.1 9647.1 9707.1 9947.0 14309.5 14475.2 15112.2 15370.4 15423.5 21:08:57 INFO - 2015-11-25 21:08:57,941 DEBUG : BROWSER_OUTPUT: 21:08:57 INFO - 2015-11-25 21:08:57,941 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5111.69 Median:6021.79 stddev:2627.10 (43.6%) stddev-sans-first:2617.53 21:08:57 INFO - 2015-11-25 21:08:57,942 DEBUG : BROWSER_OUTPUT: Values: 1142.4 1648.8 1694.1 1712.1 1722.3 6406.8 7166.7 7304.7 7317.1 7325.7 7134.0 7243.1 7297.5 7300.3 7302.7 1895.3 1928.6 2183.9 2201.9 2233.4 2214.0 2218.4 2220.5 2221.2 2221.8 2163.8 2220.9 2222.9 2223.5 2225.4 1908.8 1949.3 2136.8 2223.5 2226.1 2173.4 2198.2 2218.0 2225.1 2249.6 7289.1 7348.2 7353.7 7367.6 7367.9 4473.4 4589.4 4593.7 4594.9 4595.0 2970.3 3061.0 3130.7 3169.9 3182.3 1011.5 1045.3 1062.6 1083.7 1097.2 9873.0 9998.5 10007.3 10025.6 10031.0 4009.3 4128.9 4145.7 4146.8 4149.9 8398.9 8419.5 8426.7 8435.6 8443.3 4531.8 4545.8 4552.2 4561.4 4562.3 4134.6 4146.5 4148.2 4150.1 4151.6 3450.2 3503.9 3514.6 3535.9 3551.5 1136.2 1156.9 1160.1 1160.5 1165.3 923.3 940.2 952.8 968.1 971.3 6797.9 6828.9 6857.6 6860.3 6871.9 480.5 481.9 485.6 487.7 493.5 5408.5 5411.7 5443.6 5457.5 5466.3 8472.2 8849.8 8862.0 8897.2 8900.2 8598.8 8641.6 8663.2 8670.8 8678.0 6782.3 6938.2 6949.2 6956.3 6963.7 6545.1 6610.7 6618.1 6621.2 6627.9 7618.8 7698.5 7708.8 7824.1 7830.4 7795.4 8080.7 8092.7 8192.8 8210.5 6320.5 6357.0 6381.9 6402.1 6478.6 6883.7 6934.5 6943.9 6964.9 6965.4 6564.9 6580.3 6595.5 6671.6 6759.1 6243.1 6328.5 6496.5 6534.2 6615.0 6355.5 6419.5 6424.4 6432.5 6433.0 5917.4 5958.2 5968.7 5968.7 5977.5 5983.6 6016.9 6018.3 6025.3 6026.0 21:08:57 INFO - 2015-11-25 21:08:57,942 DEBUG : BROWSER_OUTPUT: 21:08:57 INFO - 2015-11-25 21:08:57,942 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5256.30 Median:6005.79 stddev:1584.43 (26.4%) stddev-sans-first:1544.90 21:08:57 INFO - 2015-11-25 21:08:57,942 DEBUG : BROWSER_OUTPUT: Values: 317.5 318.7 325.9 326.3 328.2 5873.6 5946.5 5966.9 5971.4 5997.9 5860.8 5889.2 5894.4 5896.1 5896.1 4369.1 4435.5 4438.9 4560.9 4562.6 4523.5 4541.0 4549.3 4551.2 4561.5 4471.3 4472.9 4477.1 4480.4 4511.0 4297.0 4386.4 4391.1 4464.2 4469.5 3923.5 3930.0 3942.9 3943.1 3950.7 5603.4 5606.0 5626.3 5628.9 5639.2 5147.5 5183.5 5185.3 5186.2 5195.9 6240.8 6250.2 6252.2 6253.4 6258.8 4387.7 4389.9 4391.3 4396.4 4404.0 6470.5 6480.6 6481.4 6485.6 6492.3 4394.1 4476.6 4482.0 4502.3 4503.1 4519.5 4521.7 4525.7 4531.9 4533.5 5234.3 5234.6 5242.4 5242.5 5244.9 6299.5 6304.6 6304.7 6307.5 6307.9 1584.2 1585.5 1615.5 1617.1 1618.2 1047.0 1068.8 1071.4 1081.3 1083.2 6116.3 6119.6 6121.8 6122.9 6125.7 6508.2 6509.6 6510.1 6525.2 6546.3 6013.7 6069.1 6110.4 6115.1 6121.0 3514.6 3539.5 3546.9 3548.5 3552.5 6648.2 6680.6 6689.6 6698.6 6715.8 6522.6 6635.4 6638.5 6640.0 6646.4 6678.6 6693.1 6696.4 6704.2 6708.5 6485.8 6491.5 6492.4 6494.7 6497.2 6333.7 6439.8 6442.3 6445.3 6446.2 6692.2 6716.1 6724.0 6725.5 6726.3 4476.3 4484.6 4485.8 4489.9 4492.8 6440.8 6460.1 6476.7 6496.4 6497.3 6201.5 6264.7 6290.8 6309.2 6316.5 6273.0 6282.8 6283.5 6283.5 6284.2 6163.4 6164.8 6189.7 6189.9 6192.5 5934.0 6135.1 6265.7 6414.5 6417.5 6247.3 6248.2 6251.2 6253.4 6253.7 21:08:57 INFO - 2015-11-25 21:08:57,942 DEBUG : BROWSER_OUTPUT: 21:08:57 INFO - 2015-11-25 21:08:57,942 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13828.31 Median:4316.86 stddev:15829.74 (366.7%) stddev-sans-first:15843.21 21:08:57 INFO - 2015-11-25 21:08:57,943 DEBUG : BROWSER_OUTPUT: Values: 649.0 667.3 713.3 823.6 834.7 13546.7 13654.4 13774.8 13780.4 13800.6 12741.4 12938.9 12974.0 12983.0 12995.4 826.7 840.5 841.6 842.2 842.3 838.2 842.0 842.3 842.6 843.5 864.7 870.3 870.8 872.7 872.8 872.9 873.1 873.9 875.3 878.8 614.9 626.8 634.9 635.6 635.8 13725.9 13877.8 13890.5 13919.4 13931.3 11673.3 12052.8 12182.6 12298.4 12680.5 10289.4 10310.8 10340.1 10345.3 10376.8 3490.7 3510.8 3553.6 3653.3 3665.5 40165.6 40399.0 43926.8 45447.8 49142.8 9760.3 9837.1 9851.5 9908.8 9921.8 17079.8 17139.4 17154.7 17162.5 17163.5 6858.6 7037.5 7071.2 7212.2 7251.6 4053.9 4192.7 4208.8 4249.0 4303.0 3066.1 3107.0 3111.2 3111.4 3111.6 535.8 550.7 552.1 553.5 565.3 494.9 609.6 615.7 637.6 639.8 9277.0 9335.8 9491.9 9513.6 9757.3 561.5 658.6 669.7 685.2 690.7 4088.2 4279.3 4330.7 4335.5 4353.1 58838.0 59253.7 59459.4 59581.1 59708.1 53039.9 53854.7 54067.7 54145.5 54252.5 41938.6 46104.0 46558.0 46606.8 46658.8 8894.4 8936.1 8946.4 8973.9 9099.8 36164.5 36185.6 36930.3 36987.4 37033.0 36584.0 37404.0 39608.8 44569.0 44746.8 11134.5 11202.1 11407.9 11479.7 11589.1 12438.6 12893.4 12994.9 13010.2 13419.3 11524.7 11728.8 11797.0 12164.8 12297.1 11760.2 11938.2 12019.1 12151.1 12398.0 11606.5 11729.2 11930.9 12159.4 12394.9 10209.5 10217.2 10237.8 10638.5 10707.4 9729.5 9890.5 10047.3 10048.6 10358.8 21:08:57 INFO - 2015-11-25 21:08:57,943 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:08:57 INFO - 2015-11-25 21:08:57,943 DEBUG : BROWSER_OUTPUT: 21:08:58 INFO - 2015-11-25 21:08:58,645 INFO : Browser exited with error code: 0 21:08:58 INFO - 2015-11-25 21:08:58,666 INFO : Completed test dromaeo_css (00:18:32) 21:08:58 INFO - 2015-11-25 21:08:58,666 INFO : Starting test kraken 21:08:58 INFO - 2015-11-25 21:08:58,666 DEBUG : operating with platform_type : linux_ 21:08:58 INFO - 2015-11-25 21:08:58,667 INFO : Initialising browser for kraken test... 21:08:58 INFO - 2015-11-25 21:08:58,673 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCmUHM9/profile http://localhost:47441/getInfo.html 21:09:02 INFO - 2015-11-25 21:09:02,165 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:09:02 INFO - 2015-11-25 21:09:02,165 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:09:02 INFO - 2015-11-25 21:09:02,165 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:09:02 INFO - 2015-11-25 21:09:02,165 DEBUG : BROWSER_OUTPUT: __metrics 21:09:02 INFO - 2015-11-25 21:09:02,322 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:09:03 INFO - 2015-11-25 21:09:03,393 INFO : Browser initialized. 21:09:03 INFO - 2015-11-25 21:09:03,394 INFO : Running cycle 1/1 for kraken test... 21:09:03 INFO - 2015-11-25 21:09:03,394 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCmUHM9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:09:15 INFO - 2015-11-25 21:09:15,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 139210752 21:09:15 INFO - 2015-11-25 21:09:15,075 DEBUG : BROWSER_OUTPUT: 21:09:17 INFO - 2015-11-25 21:09:17,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47441/tests/kraken/driver.html?testName=audio-beat-detection) 21:09:18 INFO - 2015-11-25 21:09:18,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 178499584 21:09:18 INFO - 2015-11-25 21:09:18,100 DEBUG : BROWSER_OUTPUT: 21:09:20 INFO - 2015-11-25 21:09:20,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47441/tests/kraken/driver.html?testName=audio-dft) 21:09:21 INFO - 2015-11-25 21:09:21,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 166379520 21:09:21 INFO - 2015-11-25 21:09:21,215 DEBUG : BROWSER_OUTPUT: 21:09:24 INFO - 2015-11-25 21:09:24,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47441/tests/kraken/driver.html?testName=audio-fft) 21:09:24 INFO - 2015-11-25 21:09:24,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 149852160 21:09:24 INFO - 2015-11-25 21:09:24,645 DEBUG : BROWSER_OUTPUT: 21:09:26 INFO - 2015-11-25 21:09:26,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47441/tests/kraken/driver.html?testName=audio-oscillator) 21:09:27 INFO - 2015-11-25 21:09:27,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 153141248 21:09:27 INFO - 2015-11-25 21:09:27,188 DEBUG : BROWSER_OUTPUT: 21:09:29 INFO - 2015-11-25 21:09:29,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47441/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:09:29 INFO - 2015-11-25 21:09:29,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 153620480 21:09:29 INFO - 2015-11-25 21:09:29,911 DEBUG : BROWSER_OUTPUT: 21:09:32 INFO - 2015-11-25 21:09:32,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47441/tests/kraken/driver.html?testName=imaging-darkroom) 21:09:33 INFO - 2015-11-25 21:09:33,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 154169344 21:09:33 INFO - 2015-11-25 21:09:33,387 DEBUG : BROWSER_OUTPUT: 21:09:36 INFO - 2015-11-25 21:09:36,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47441/tests/kraken/driver.html?testName=imaging-desaturate) 21:09:37 INFO - 2015-11-25 21:09:37,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 156332032 21:09:37 INFO - 2015-11-25 21:09:37,346 DEBUG : BROWSER_OUTPUT: 21:09:40 INFO - 2015-11-25 21:09:40,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47441/tests/kraken/driver.html?testName=json-parse-financial) 21:09:40 INFO - 2015-11-25 21:09:40,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 154353664 21:09:40 INFO - 2015-11-25 21:09:40,703 DEBUG : BROWSER_OUTPUT: 21:09:42 INFO - 2015-11-25 21:09:42,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47441/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:09:42 INFO - 2015-11-25 21:09:42,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 168054784 21:09:42 INFO - 2015-11-25 21:09:42,797 DEBUG : BROWSER_OUTPUT: 21:09:44 INFO - 2015-11-25 21:09:44,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47441/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:09:45 INFO - 2015-11-25 21:09:45,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 165892096 21:09:45 INFO - 2015-11-25 21:09:45,205 DEBUG : BROWSER_OUTPUT: 21:09:47 INFO - 2015-11-25 21:09:47,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47441/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:09:47 INFO - 2015-11-25 21:09:47,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 171368448 21:09:47 INFO - 2015-11-25 21:09:47,777 DEBUG : BROWSER_OUTPUT: 21:09:50 INFO - 2015-11-25 21:09:50,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:09:50 INFO - 2015-11-25 21:09:50,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 181514240 21:09:50 INFO - 2015-11-25 21:09:50,760 DEBUG : BROWSER_OUTPUT: 21:09:53 INFO - 2015-11-25 21:09:53,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:09:53 INFO - 2015-11-25 21:09:53,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 181325824 21:09:53 INFO - 2015-11-25 21:09:53,886 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47441/tests/kraken/driver.html?testName=ai-astar) 21:09:55 INFO - 2015-11-25 21:09:55,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 240123904 21:09:55 INFO - 2015-11-25 21:09:55,841 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,844 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:09:55 INFO - 2015-11-25 21:09:55,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:09:55 INFO - 2015-11-25 21:09:55,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:09:55 INFO - 2015-11-25 21:09:55,845 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:09:55 INFO - 2015-11-25 21:09:55,845 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;102;110;109;110;99;108;109;98 21:09:55 INFO - 2015-11-25 21:09:55,845 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;122;147;158;128;153;152;124;165;122 21:09:55 INFO - 2015-11-25 21:09:55,845 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;162;160;163;162;160;161;161;161 21:09:55 INFO - 2015-11-25 21:09:55,846 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;70;84;98;71;73;71;100;93;71 21:09:55 INFO - 2015-11-25 21:09:55,846 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;138;93;94;94;132;93;93;131 21:09:55 INFO - 2015-11-25 21:09:55,846 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;110;110;110;110 21:09:55 INFO - 2015-11-25 21:09:55,846 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;145;146;145;146;145;146;145;144 21:09:55 INFO - 2015-11-25 21:09:55,846 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;97;96;95;95;95 21:09:55 INFO - 2015-11-25 21:09:55,847 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;56;56;57;57;57;58;59;56;54 21:09:55 INFO - 2015-11-25 21:09:55,847 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;69;69;71;71;71;71;69;70;72 21:09:55 INFO - 2015-11-25 21:09:55,847 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;82;84;85;91;84;85;84;86;88 21:09:55 INFO - 2015-11-25 21:09:55,847 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;116;126;114;118;117;126;128;114;121 21:09:55 INFO - 2015-11-25 21:09:55,847 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;161;150;150;148;139;149;147;148;138 21:09:55 INFO - 2015-11-25 21:09:55,848 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;66;64;66;68;67;73;67;65 21:09:55 INFO - 2015-11-25 21:09:55,848 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:09:55 INFO - 2015-11-25 21:09:55,848 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:09:55 INFO - 2015-11-25 21:09:55,848 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,922 21:09:55 INFO - 2015-11-25 21:09:55,848 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:09:55 INFO - 2015-11-25 21:09:55,849 DEBUG : BROWSER_OUTPUT: __startTimestamp1448514595843__endTimestamp 21:09:55 INFO - 2015-11-25 21:09:55,849 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,850 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:09:55 INFO - 2015-11-25 21:09:55,850 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:09:55 INFO - 2015-11-25 21:09:55,850 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,850 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.30 Median:110.00 stddev:4.74 (4.3%) stddev-sans-first:4.99 21:09:55 INFO - 2015-11-25 21:09:55,850 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 102.0 110.0 109.0 110.0 99.0 108.0 109.0 98.0 21:09:55 INFO - 2015-11-25 21:09:55,851 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,851 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.40 Median:152.50 stddev:16.57 (10.9%) stddev-sans-first:17.12 21:09:55 INFO - 2015-11-25 21:09:55,851 DEBUG : BROWSER_OUTPUT: Values: 153.0 122.0 147.0 158.0 128.0 153.0 152.0 124.0 165.0 122.0 21:09:55 INFO - 2015-11-25 21:09:55,851 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,851 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 21:09:55 INFO - 2015-11-25 21:09:55,851 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 162.0 160.0 163.0 162.0 160.0 161.0 161.0 161.0 21:09:55 INFO - 2015-11-25 21:09:55,851 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,851 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:72.50 stddev:12.31 (17.0%) stddev-sans-first:12.69 21:09:55 INFO - 2015-11-25 21:09:55,852 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 84.0 98.0 71.0 73.0 71.0 100.0 93.0 71.0 21:09:55 INFO - 2015-11-25 21:09:55,852 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,852 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:93.00 stddev:19.52 (21.0%) stddev-sans-first:20.26 21:09:55 INFO - 2015-11-25 21:09:55,852 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 138.0 93.0 94.0 94.0 132.0 93.0 93.0 131.0 21:09:55 INFO - 2015-11-25 21:09:55,852 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,852 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 21:09:55 INFO - 2015-11-25 21:09:55,852 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 110.0 110.0 21:09:55 INFO - 2015-11-25 21:09:55,852 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,852 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:0.88 21:09:55 INFO - 2015-11-25 21:09:55,852 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 144.0 21:09:55 INFO - 2015-11-25 21:09:55,852 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,852 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 21:09:55 INFO - 2015-11-25 21:09:55,853 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 97.0 96.0 95.0 95.0 95.0 21:09:55 INFO - 2015-11-25 21:09:55,853 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,853 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:1.40 (2.5%) stddev-sans-first:1.41 21:09:55 INFO - 2015-11-25 21:09:55,853 DEBUG : BROWSER_OUTPUT: Values: 58.0 56.0 56.0 57.0 57.0 57.0 58.0 59.0 56.0 54.0 21:09:55 INFO - 2015-11-25 21:09:55,853 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,853 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:71.00 stddev:1.06 (1.5%) stddev-sans-first:1.12 21:09:55 INFO - 2015-11-25 21:09:55,853 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 71.0 71.0 71.0 71.0 69.0 70.0 72.0 21:09:55 INFO - 2015-11-25 21:09:55,853 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,853 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.00 stddev:2.54 (3.0%) stddev-sans-first:2.65 21:09:55 INFO - 2015-11-25 21:09:55,854 DEBUG : BROWSER_OUTPUT: Values: 84.0 82.0 84.0 85.0 91.0 84.0 85.0 84.0 86.0 88.0 21:09:55 INFO - 2015-11-25 21:09:55,854 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,854 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:123.50 stddev:5.73 (4.6%) stddev-sans-first:5.45 21:09:55 INFO - 2015-11-25 21:09:55,854 DEBUG : BROWSER_OUTPUT: Values: 128.0 116.0 126.0 114.0 118.0 117.0 126.0 128.0 114.0 121.0 21:09:55 INFO - 2015-11-25 21:09:55,854 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,854 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:148.50 stddev:7.04 (4.7%) stddev-sans-first:6.70 21:09:55 INFO - 2015-11-25 21:09:55,854 DEBUG : BROWSER_OUTPUT: Values: 138.0 161.0 150.0 150.0 148.0 139.0 149.0 147.0 148.0 138.0 21:09:55 INFO - 2015-11-25 21:09:55,854 DEBUG : BROWSER_OUTPUT: 21:09:55 INFO - 2015-11-25 21:09:55,854 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:2.44 (3.6%) stddev-sans-first:2.57 21:09:55 INFO - 2015-11-25 21:09:55,854 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 66.0 64.0 66.0 68.0 67.0 73.0 67.0 65.0 21:09:55 INFO - 2015-11-25 21:09:55,854 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:09:55 INFO - 2015-11-25 21:09:55,854 DEBUG : BROWSER_OUTPUT: 21:09:56 INFO - 2015-11-25 21:09:56,617 INFO : Browser exited with error code: 0 21:09:56 INFO - 2015-11-25 21:09:56,668 INFO : Completed test kraken (00:00:58) 21:09:56 INFO - 2015-11-25 21:09:56,668 INFO : Starting test v8_7 21:09:56 INFO - 2015-11-25 21:09:56,668 DEBUG : operating with platform_type : linux_ 21:09:56 INFO - 2015-11-25 21:09:56,669 INFO : Initialising browser for v8_7 test... 21:09:56 INFO - 2015-11-25 21:09:56,675 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgyjmTU/profile http://localhost:47441/getInfo.html 21:10:00 INFO - 2015-11-25 21:10:00,206 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:10:00 INFO - 2015-11-25 21:10:00,206 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:10:00 INFO - 2015-11-25 21:10:00,206 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:10:00 INFO - 2015-11-25 21:10:00,206 DEBUG : BROWSER_OUTPUT: __metrics 21:10:00 INFO - 2015-11-25 21:10:00,329 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:10:01 INFO - 2015-11-25 21:10:01,445 INFO : Browser initialized. 21:10:01 INFO - 2015-11-25 21:10:01,446 INFO : Running cycle 1/1 for v8_7 test... 21:10:01 INFO - 2015-11-25 21:10:01,446 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgyjmTU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:10:13 INFO - 2015-11-25 21:10:13,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 139100160 21:10:13 INFO - 2015-11-25 21:10:13,168 DEBUG : BROWSER_OUTPUT: 21:10:34 INFO - 2015-11-25 21:10:34,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47441/tests/v8_7/run.html (next: http://localhost:47441/tests/v8_7/run.html) 21:10:34 INFO - 2015-11-25 21:10:34,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 565211136 21:10:34 INFO - 2015-11-25 21:10:34,791 DEBUG : BROWSER_OUTPUT: 21:10:34 INFO - 2015-11-25 21:10:34,792 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:10:34 INFO - 2015-11-25 21:10:34,793 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:10:34 INFO - 2015-11-25 21:10:34,793 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:10:34 INFO - 2015-11-25 21:10:34,793 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:10:34 INFO - 2015-11-25 21:10:34,793 DEBUG : BROWSER_OUTPUT: |0;Richards;166.03021749958492 21:10:34 INFO - 2015-11-25 21:10:34,793 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.72292096865027 21:10:34 INFO - 2015-11-25 21:10:34,793 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.7254735651682 21:10:34 INFO - 2015-11-25 21:10:34,793 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 21:10:34 INFO - 2015-11-25 21:10:34,794 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1084.5986984815618 21:10:34 INFO - 2015-11-25 21:10:34,794 DEBUG : BROWSER_OUTPUT: |5;Earley;768.6395080707148 21:10:34 INFO - 2015-11-25 21:10:34,794 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 21:10:34 INFO - 2015-11-25 21:10:34,794 DEBUG : BROWSER_OUTPUT: |7;RegExp;26051.28205128205 21:10:34 INFO - 2015-11-25 21:10:34,794 DEBUG : BROWSER_OUTPUT: |8;Splay;592.0663114268798 21:10:34 INFO - 2015-11-25 21:10:34,794 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 21:10:34 INFO - 2015-11-25 21:10:34,794 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:10:34 INFO - 2015-11-25 21:10:34,794 DEBUG : BROWSER_OUTPUT: __startTimestamp1448514634791__endTimestamp 21:10:34 INFO - 2015-11-25 21:10:34,794 DEBUG : BROWSER_OUTPUT: 21:10:34 INFO - 2015-11-25 21:10:34,795 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:10:34 INFO - 2015-11-25 21:10:34,795 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:10:34 INFO - 2015-11-25 21:10:34,795 DEBUG : BROWSER_OUTPUT: 21:10:34 INFO - 2015-11-25 21:10:34,795 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.03 Median:166.03 stddev:0.00 (0.0%) 21:10:34 INFO - 2015-11-25 21:10:34,795 DEBUG : BROWSER_OUTPUT: Values: 166.0 21:10:34 INFO - 2015-11-25 21:10:34,795 DEBUG : BROWSER_OUTPUT: 21:10:34 INFO - 2015-11-25 21:10:34,795 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.72 Median:187.72 stddev:0.00 (0.0%) 21:10:34 INFO - 2015-11-25 21:10:34,795 DEBUG : BROWSER_OUTPUT: Values: 187.7 21:10:34 INFO - 2015-11-25 21:10:34,795 DEBUG : BROWSER_OUTPUT: 21:10:34 INFO - 2015-11-25 21:10:34,795 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.73 Median:282.73 stddev:0.00 (0.0%) 21:10:34 INFO - 2015-11-25 21:10:34,795 DEBUG : BROWSER_OUTPUT: Values: 282.7 21:10:34 INFO - 2015-11-25 21:10:34,796 DEBUG : BROWSER_OUTPUT: 21:10:34 INFO - 2015-11-25 21:10:34,796 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 21:10:34 INFO - 2015-11-25 21:10:34,796 DEBUG : BROWSER_OUTPUT: Values: 5186.5 21:10:34 INFO - 2015-11-25 21:10:34,796 DEBUG : BROWSER_OUTPUT: 21:10:34 INFO - 2015-11-25 21:10:34,796 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1084.60 Median:1084.60 stddev:0.00 (0.0%) 21:10:34 INFO - 2015-11-25 21:10:34,796 DEBUG : BROWSER_OUTPUT: Values: 1084.6 21:10:34 INFO - 2015-11-25 21:10:34,796 DEBUG : BROWSER_OUTPUT: 21:10:34 INFO - 2015-11-25 21:10:34,796 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:768.64 Median:768.64 stddev:0.00 (0.0%) 21:10:34 INFO - 2015-11-25 21:10:34,796 DEBUG : BROWSER_OUTPUT: Values: 768.6 21:10:34 INFO - 2015-11-25 21:10:34,796 DEBUG : BROWSER_OUTPUT: 21:10:34 INFO - 2015-11-25 21:10:34,796 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 21:10:34 INFO - 2015-11-25 21:10:34,797 DEBUG : BROWSER_OUTPUT: Values: 12195.1 21:10:34 INFO - 2015-11-25 21:10:34,797 DEBUG : BROWSER_OUTPUT: 21:10:34 INFO - 2015-11-25 21:10:34,797 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26051.28 Median:26051.28 stddev:0.00 (0.0%) 21:10:34 INFO - 2015-11-25 21:10:34,797 DEBUG : BROWSER_OUTPUT: Values: 26051.3 21:10:34 INFO - 2015-11-25 21:10:34,797 DEBUG : BROWSER_OUTPUT: 21:10:34 INFO - 2015-11-25 21:10:34,797 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:592.07 Median:592.07 stddev:0.00 (0.0%) 21:10:34 INFO - 2015-11-25 21:10:34,797 DEBUG : BROWSER_OUTPUT: Values: 592.1 21:10:34 INFO - 2015-11-25 21:10:34,797 DEBUG : BROWSER_OUTPUT: 21:10:34 INFO - 2015-11-25 21:10:34,797 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 21:10:34 INFO - 2015-11-25 21:10:34,797 DEBUG : BROWSER_OUTPUT: Values: 4835.7 21:10:34 INFO - 2015-11-25 21:10:34,797 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:10:34 INFO - 2015-11-25 21:10:34,797 DEBUG : BROWSER_OUTPUT: 21:10:35 INFO - 2015-11-25 21:10:35,589 INFO : Browser exited with error code: 0 21:10:35 INFO - 2015-11-25 21:10:35,606 INFO : Completed test v8_7 (00:00:38) 21:10:35 INFO - 2015-11-25 21:10:35,825 INFO : Completed test suite (00:20:09) 21:10:35 INFO - 2015-11-25 21:10:35,825 DEBUG : Working with test: dromaeo_css 21:10:35 INFO - 2015-11-25 21:10:35,825 DEBUG : Generating results file: dromaeo_css 21:10:35 INFO - 2015-11-25 21:10:35,826 DEBUG : Working with test: kraken 21:10:35 INFO - 2015-11-25 21:10:35,826 DEBUG : Generating results file: kraken 21:10:35 INFO - 2015-11-25 21:10:35,827 INFO : javascript benchmark 21:10:35 INFO - 2015-11-25 21:10:35,827 DEBUG : Working with test: v8_7 21:10:35 INFO - 2015-11-25 21:10:35,827 DEBUG : Generating results file: v8_7 21:10:35 INFO - 2015-11-25 21:10:35,827 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:10:35 INFO - 2015-11-25 21:10:35,887 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 21:10:35 INFO - 2015-11-25 21:10:35,887 DEBUG : process_Request line: dromaeo_css 6972.99 graph.html#tests=[[72,201,35]] 21:10:35 INFO - 2015-11-25 21:10:35,887 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:10:35 INFO - 2015-11-25 21:10:35,932 DEBUG : process_Request line: kraken 1493.40 graph.html#tests=[[232,201,35]] 21:10:35 INFO - 2015-11-25 21:10:35,932 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:10:36 INFO - 2015-11-25 21:10:36,039 DEBUG : process_Request line: v8_7 21159.07 graph.html#tests=[[230,201,35]] 21:10:36 INFO - 2015-11-25 21:10:36,041 INFO : javascript benchmark 21:10:36 INFO - 2015-11-25 21:10:36,045 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3194.1056504178828, 3236.288016636342, 3273.886878461323, 3281.9835900820494, 3297.0932993426804, 5295.549878260353, 5398.136298192295, 5424.755885985131, 5435.0488664483755, 5475.78096876125, 5436.864078398042, 5501.284832971708, 5540.6398584092, 5591.049521581331, 5598.832035038945, 4801.687890287138, 5007.626586379815, 5033.496650334955, 5051.797928082872, 5161.4838516148275, 5175.715335656538, 5180.481951804827, 5223.0, 5238.52853243208, 5247.449017853128, 4931.235658472942, 4996.800127994876, 5034.0, 5055.140626093536, 5108.0, 5039.3196918415915, 5069.645124841262, 5076.543111120017, 5080.745962701887, 5140.228965655144, 4946.604271658259, 5036.924446133275, 5042.218456139268, 5048.040872234264, 5060.5951523878, 5192.480751924815, 5223.190405487156, 5282.075636763551, 5282.286891269668, 5312.0, 5999.460048595647, 6022.036474164157, 6030.155778191057, 6041.24484439445, 6041.577089603729, 5825.388334224887, 5998.970005149947, 6045.244344456943, 6092.147099406086, 6092.268927728656, 5578.804741834017, 5633.8591535211945, 5680.119581464838, 5684.204211410406, 5688.232088668018, 6106.6336019838955, 6141.385861413913, 6145.016797312409, 6150.969245153746, 6152.692365381802, 5781.855453613609, 5936.317323507766, 5949.375315591887, 5950.375210602824, 5951.107333899863, 5894.32215295238, 5949.6430214187285, 5959.702014899238, 6001.819945401645, 6059.091136329498, 5916.645001299936, 5926.2295901532525, 5929.347771745104, 5931.051031834886, 5991.970040149771, 5761.3950535194035, 5866.618669786536, 5914.704264786744, 5924.466797988115, 5932.377100404482, 4543.136804007228, 4574.245249533789, 4616.28447590624, 4646.86059418218, 4649.697769644962, 4077.062275676611, 4077.082656402286, 4090.5909409058854, 4124.628783409507, 4127.814248358831, 5513.8345849624575, 5664.971675141598, 5666.744996475169, 5669.06460434032, 5672.404397538282, 5938.2280303560265, 5943.732532035982, 5986.281646202397, 6084.526061292044, 6087.8976843944765, 5597.244372009808, 5631.211630371751, 5641.984442800335, 5644.209810626516, 5657.57568182388, 5193.818216362409, 5195.792168313301, 5203.0, 5205.037068142406, 5249.317588713443, 6037.969810150833, 6057.545684073712, 6097.882086415594, 6133.591519773218, 6141.025769126933, 6067.150598916067, 6074.179985701874, 6079.848003799941, 6085.817425477243, 6088.6042407243385, 6172.166757487861, 6225.62646241227, 6269.905951410824, 6284.3087260402235, 6288.748450061947, 5739.110437882135, 5806.622569532967, 5857.736401861841, 5927.31835838884, 5972.671503067199, 6004.219451471281, 6059.363766804422, 6081.969590152021, 6082.452579267887, 6083.270007599116, 5912.793052243151, 5930.970345148246, 5931.436513531207, 5931.911021334769, 5931.9406805931385, 5676.2337084493065, 5750.453706897838, 5761.4238576143725, 5816.534677225896, 5886.911696324644, 5744.827655170351, 5782.942170578241, 5792.7103644818435, 5795.217645617956, 5804.332501762351, 5929.288485381781, 5936.821895343147, 5942.257217847769, 5943.138244954544, 5999.280086389661, 5644.774209031757, 5721.685307308138, 5754.482096611325, 5769.134629805562, 5811.186433899342], "unit": "ms", "name": "dojo.html", "value": 5504.809169100713}, {"lowerIsBetter": false, "replicates": [562.5218564220413, 593.545937357921, 602.6083046020086, 606.0364021206282, 608.8538750699834, 27358.863205683967, 28020.57969130462, 28026.299342516395, 28152.43695126099, 39956.60043399565, 42044.36933446001, 42290.78854605723, 42576.78711606438, 42600.14799704004, 42691.57308426923, 8583.828323433512, 8730.0, 8745.08176641453, 8749.256313213353, 8750.21248087672, 7649.04386951631, 7879.093904201033, 8544.18830211129, 10119.696409107739, 10284.537195826168, 10042.04600562949, 10119.342242754197, 10120.443375614339, 10124.493775311243, 10126.544305506233, 7464.2535746425465, 10006.449645269508, 10085.394876307446, 10095.646652367132, 10102.747431314203, 7478.588677622729, 10462.372257664489, 10761.300515466548, 10761.354318740823, 10766.730831729192, 39475.407868881986, 39688.60311396907, 39758.60241397607, 39862.0, 39911.8004409979, 3048.9542656860167, 3141.0733833519166, 3272.1655977725527, 3305.3058857639685, 3492.580890293156, 29248.561271580944, 30019.249518761986, 30400.0, 30452.238694032603, 30547.847260763778, 3583.4803953426867, 3626.4016437287814, 3759.793211373373, 3760.8375184269153, 3913.236918800835, 271787.0, 274872.0, 275389.0, 276444.0, 276635.6168219166, 57361.13958290629, 58610.413895860496, 59401.702991484766, 59747.0, 65662.67168664126, 60928.08607870885, 61069.08396374058, 61138.0, 61145.38854611397, 61166.0, 15041.0, 15048.774268385983, 15053.774193387108, 15146.0, 15176.468823591122, 11503.827442588368, 11535.0, 11541.307521548733, 11547.711307217218, 11548.480318385693, 19973.700394494095, 20015.699764503544, 20050.498737531678, 20461.181552737722, 20518.487037824172, 7921.722739704082, 8254.669813207525, 8291.383180279787, 8303.667853285922, 8319.916800832036, 952.9904700953041, 976.3702411944256, 986.6102889358663, 1016.7813920007234, 1122.0182340452104, 27416.314592135357, 27874.0, 27899.884004639993, 28463.857680711462, 28747.28131796722, 1019.7501612105082, 1060.2843080920502, 1138.9976820397997, 1147.6901236666054, 1148.3856136966683, 14684.41262349494, 14797.704045919021, 14915.552533424014, 15156.090634561962, 15175.468858589897, 382140.0, 387831.0, 389392.0, 389794.0, 390744.0, 54329.456705432436, 54865.72567137139, 54901.0, 55097.17354239689, 55131.0, 1334.099482849073, 1341.805438211454, 1351.4796803230827, 1352.0738294268458, 1354.5191457032809, 26515.33711657224, 28556.286092847844, 28613.42773144567, 31190.37619247557, 32666.673333267314, 50314.49685503098, 50873.0, 51009.0, 51075.74462127666, 51132.0, 299855.0, 302783.0, 303523.0, 303689.0, 303802.0, 36314.0, 36944.38195225597, 41857.39568647386, 41992.160156797305, 42497.0, 40225.0, 40748.38877416782, 41069.58930410777, 41420.58579414288, 44970.3254451177, 37480.81259593685, 37567.81216093902, 40872.59127408688, 41303.58696413117, 42187.3671894928, 35337.82331088328, 36274.63725362712, 36510.817445913664, 36641.45037824488, 39557.40663890102, 35862.64137358593, 36417.81791091028, 36642.26715465729, 36865.07837304089, 36912.26175476529, 31104.533431998992, 31919.0, 33595.83202084072, 33701.15747106342, 33836.830815845766, 22708.902621180045, 23207.76792232056, 23312.417189570395, 23320.76679233254, 26449.603255951562], "unit": "ms", "name": "ext.html", "value": 18979.73038729949}, {"lowerIsBetter": false, "replicates": [353.23877044968094, 354.5302474221656, 354.66129845997074, 356.60060731980184, 361.88419705694173, 13951.0, 14288.928555357235, 16390.098544580043, 16435.34258629655, 16896.070716110626, 13860.514881979132, 13876.93061534691, 13889.708198147293, 14226.217558034305, 14235.572932812007, 5252.868678283055, 5272.525472707455, 5386.569074474052, 5426.75579598919, 5432.864178395532, 3951.6641085507767, 3998.980005099985, 4036.576159503254, 5389.6496727712765, 5765.394633563478, 5939.762409503614, 5941.70291485424, 5945.851353716149, 5965.821025369246, 5973.701314934257, 5801.7099145042575, 5902.966980778347, 5914.58597898143, 5945.672987985659, 5946.910796338037, 5214.687118772886, 5219.451957544441, 5220.26916231724, 5228.2680424740565, 5230.712310822903, 20890.47773805667, 20913.37259882206, 20950.0572474239, 20963.056662450075, 21220.36338909835, 2256.1539422716482, 2328.1036800831635, 2344.777246161612, 2360.9611770820784, 2370.620700687899, 13415.597532074053, 13430.194188348632, 13439.66400839977, 13442.857357124656, 13491.392887320095, 1756.4203812741891, 1824.5712257619582, 1835.4585397307826, 1865.9346922857771, 1885.1516817432073, 54736.17895731567, 55164.72417637926, 58088.41911580873, 61454.38545614531, 62456.68771656113, 9817.607295708234, 9971.850422243671, 9993.200543956465, 10004.249681273934, 10036.698899033041, 12910.160839545399, 12911.35443227835, 13051.412686429134, 13071.281079540526, 13071.477140914258, 7140.571565706075, 7404.55572665631, 7439.51643143194, 7513.549187048795, 7616.0860696716745, 7154.427645788429, 7161.5345002575705, 7181.102362204724, 7190.280971902768, 7326.047613810277, 4323.63249123828, 4370.601407549617, 4413.801378937891, 4416.712913660602, 4465.531119232499, 1695.2540882011876, 1726.2490816494865, 1731.7402389641402, 1745.3542189390007, 1793.3006127610242, 881.9945262400868, 886.7916039730658, 939.4691999020531, 1012.4735137728487, 1036.9325993810378, 16825.15874206285, 17022.404215852384, 17149.657006859794, 17175.656486870193, 17379.47861564155, 890.4167770110588, 904.4754042655244, 923.6536298887917, 933.659214386744, 1012.8885822559513, 9734.561944712363, 9842.961995120098, 9870.654527091518, 9894.950525247328, 10038.849417258747, 510447.0, 519262.0, 526177.0, 527883.0, 530689.0, 79086.0, 79533.0, 81482.0, 81725.0, 83335.16664833395, 1097.8188598881254, 1098.3355070182583, 1108.467935391017, 1110.3559935237543, 1110.7278716714295, 15239.695206096038, 15318.310676019828, 15428.614284642525, 15466.458673946358, 15730.213489325717, 32992.0, 33687.32625347529, 33864.15339616529, 34310.313793723486, 34595.82702086574, 47294.0, 47625.0, 47895.281570777166, 48471.27293090677, 50285.74857125691, 9128.269738421042, 9598.66404675833, 9599.280053995839, 9606.51967401641, 9615.615375384907, 11070.889291106985, 13960.58118256454, 14766.704665906407, 16972.49082527526, 17723.82276177222, 11125.888741112809, 12633.305168215837, 13777.0, 14648.85351146475, 14823.555293341216, 2796.1751283371045, 6833.794986150423, 7706.959560459266, 14255.572332830032, 15469.845301547291, 14918.179500127164, 15192.696146076796, 15228.771568426704, 15618.496244354326, 15906.125163115677, 9474.147326740627, 9614.086661767122, 9647.1317581418, 9707.077827606367, 9946.950265248628, 14309.499167529086, 14475.203863787592, 15112.168830714416, 15370.385184592491, 15423.460178893685], "unit": "ms", "name": "jquery.html", "value": 8783.398888828964}, {"lowerIsBetter": false, "replicates": [1142.4344949250112, 1648.7939007624047, 1694.1359906447708, 1712.0669235266778, 1722.2594284457682, 6406.839829004271, 7166.713331466742, 7304.707811687539, 7317.12194536655, 7325.706971721132, 7134.0, 7243.0584024076925, 7297.489175757699, 7300.342969132777, 7302.671379787909, 1895.2797936784002, 1928.633559623667, 2183.912643494258, 2201.8678879267213, 2233.352327824929, 2213.9557208855813, 2218.3566765638025, 2220.5114874727533, 2221.2114699281765, 2221.7889300516426, 2163.805257526822, 2220.888955552224, 2222.944426389337, 2223.455253462904, 2225.410266279437, 1908.7518622579046, 1949.278766856265, 2136.829053675702, 2223.5108276179217, 2226.109556177526, 2173.3588591365583, 2198.2416066457045, 2217.9778202218095, 2225.143319821864, 2249.5725812095648, 7289.088863892013, 7348.154962179311, 7353.7058517659225, 7367.557946523172, 7367.852642947111, 4473.396091527635, 4589.380433641449, 4593.655475839292, 4594.862154135348, 4595.012072404449, 2970.2574356410896, 3061.0204734484973, 3130.733887619555, 3169.904902852918, 3182.299894023311, 1011.5043628621996, 1045.2735348932495, 1062.6227689170387, 1083.7182332593504, 1097.226455348977, 9872.950635246778, 9998.45008524531, 10007.349522281029, 10025.59897604095, 10031.047050530187, 4009.278329900646, 4128.896777580585, 4145.66834653227, 4146.834126634961, 4149.854755083557, 8398.874016889751, 8419.536925469036, 8426.662933482714, 8435.620397082146, 8443.28232100266, 4531.84138555149, 4545.795439205243, 4552.157850797613, 4561.429821272341, 4562.315652652062, 4134.627883490501, 4146.481689788777, 4148.23257697327, 4150.086980864205, 4151.564085771011, 3450.240946991658, 3503.8773642922374, 3514.61339252682, 3535.9292814144087, 3551.5027896094566, 1136.2216881436243, 1156.9247998880046, 1160.083534008141, 1160.5067846165346, 1165.3066425476827, 923.3029063057348, 940.1961323068814, 952.8094381123665, 968.1286841842398, 971.2909576009553, 6797.864042719118, 6828.863422731518, 6857.588544687334, 6860.279670634612, 6871.896921546181, 480.48348025872326, 481.8530348243749, 485.55571651938084, 487.7171240680397, 493.50156342094743, 5408.540274076748, 5411.702356370359, 5443.564514838803, 5457.508824205841, 5466.316710411199, 8472.237498625153, 8849.823003539894, 8861.955690221637, 8897.243734282658, 8900.243479304203, 8598.82802343962, 8641.611127499278, 8663.220310171988, 8670.826583468295, 8678.0, 6782.321767823277, 6938.167419909643, 6949.2008419031445, 6956.304369563104, 6963.6866341014775, 6545.050967609765, 6610.702518386588, 6618.106555614931, 6621.205455345389, 6627.867442651216, 7618.8095297618, 7698.461107722405, 7708.768736937901, 7824.061112666516, 7830.412719046209, 7795.41534384912, 8080.71717489885, 8092.71675491355, 8192.795180120307, 8210.507369557607, 6320.494360451245, 6356.968215158895, 6381.936180638134, 6402.103705481143, 6478.611283323015, 6883.690233939385, 6934.479914006369, 6943.895841562482, 6964.930350696631, 6965.407940325129, 6564.901526477011, 6580.341965803382, 6595.505337099641, 6671.566348187353, 6759.053732477359, 6243.063540468966, 6328.46208072319, 6496.512761542808, 6534.215894092739, 6615.0, 6355.491560675227, 6419.518536109717, 6424.357564243538, 6432.485401167989, 6432.9678351607945, 5917.37867523921, 5958.1658567801405, 5968.701564921824, 5968.731407086779, 5977.46202841729, 5983.551233657406, 6016.939830601813, 6018.307894592178, 6025.276966764016, 6026.035834266497], "unit": "ms", "name": "mootools.html", "value": 4154.48089003357}, {"lowerIsBetter": false, "replicates": [317.53005551783366, 318.68131868131866, 325.9445894197986, 326.32450826788545, 328.24012411267927, 5873.588848780587, 5946.5242780577555, 5966.940330596693, 5971.432713892184, 5997.88004239915, 5860.794872179475, 5889.1755154278435, 5894.410558944114, 5896.056630939051, 5896.145058966447, 4369.060651959828, 4435.534268901767, 4438.911221775563, 4560.8859778505475, 4562.5665561771575, 4523.457185137788, 4540.9772951135365, 4549.294859296798, 4551.203539380612, 4561.452625684922, 4471.306947423154, 4472.888177795565, 4477.059817438342, 4480.395146655209, 4510.97744511277, 4297.0, 4386.40783494229, 4391.055922976575, 4464.196444639963, 4469.4860091089295, 3923.509561304837, 3929.98035009826, 3942.921141577181, 3943.0536671198706, 3950.7036972227197, 5603.439656034405, 5605.971970140164, 5626.2967129108865, 5628.887422251532, 5639.238702775155, 5147.510986456281, 5183.481651834824, 5185.274061631375, 5186.222066689989, 5195.922061169085, 6240.843978900519, 6250.187475628185, 6252.218472690914, 6253.405926436982, 6258.780942666985, 4387.736735795863, 4389.934150987738, 4391.3193455014525, 4396.384506169139, 4403.9559604404185, 6470.450011749007, 6480.611163330215, 6481.4166724994975, 6485.578437401554, 6492.3183065777885, 4394.077243778842, 4476.6418686505, 4482.036362182146, 4502.257127573914, 4503.076869241863, 4519.502854685982, 4521.660875434355, 4525.705829121097, 4531.909361812811, 4533.5013148553635, 5234.298852872832, 5234.633575649668, 5242.397124330751, 5242.50196231365, 5244.947550524522, 6299.5275354348605, 6304.621722696653, 6304.747810087637, 6307.4954003679595, 6307.873842523216, 1584.2395650087792, 1585.484717466828, 1615.4830454254761, 1617.1186703246758, 1618.247514905551, 1046.9685909422728, 1068.834330678746, 1071.3518321415431, 1081.259337353915, 1083.2200815412891, 6116.327204007555, 6119.602225855394, 6121.816345509642, 6122.908156377658, 6125.693715314216, 6508.153939987866, 6509.641969691617, 6510.121133646897, 6525.249596296487, 6546.345365463416, 6013.6993150342305, 6069.089636554552, 6110.388961103854, 6115.113308570232, 6120.969395152996, 3514.648535146516, 3539.50446937429, 3546.858125674996, 3548.4854696068924, 3552.5381700378784, 6648.235452922976, 6680.565763225375, 6689.632070236184, 6698.5980841149685, 6715.764948226789, 6522.576032557963, 6635.407502199438, 6638.535302528777, 6640.0, 6646.401823835781, 6678.630880669548, 6693.129893113962, 6696.363845434676, 6704.161979752531, 6708.463322934153, 6485.77299794505, 6491.545591808528, 6492.35076492347, 6494.6752662367635, 6497.18785151856, 6333.714982825876, 6439.839004024937, 6442.2591401989375, 6445.2587952386075, 6446.161998940108, 6692.163479565054, 6716.059751634677, 6723.966380168068, 6725.4619630430425, 6726.327367263235, 4476.306172543261, 4484.573965473275, 4485.820567177277, 4489.8653040407535, 4492.842750503717, 6440.806775796734, 6460.095586617783, 6476.676166191766, 6496.415322620986, 6497.285298617054, 6201.542745890601, 6264.718087685974, 6290.811275661737, 6309.242890853127, 6316.463100636313, 6272.968635156795, 6282.780102696383, 6283.49732021428, 6283.497320214463, 6284.24589049317, 6163.445289923929, 6164.7842325518395, 6189.690515474118, 6189.938100618936, 6192.504599632109, 5933.970330148321, 6135.14108024868, 6265.655388953652, 6414.5189110815945, 6417.454516366161, 6247.3440288769025, 6248.187735594343, 6251.218597675291, 6253.437190652863, 6253.687315634291], "unit": "ms", "name": "prototype.html", "value": 4738.326808084943}, {"lowerIsBetter": false, "replicates": [648.9578177418467, 667.2926697700435, 713.2653367031958, 823.5676269958275, 834.6577903059747, 13546.729065418685, 13654.38555265013, 13774.793378099312, 13780.379882905256, 13800.585982420518, 12741.426635801388, 12938.870611293883, 12974.0, 12983.0, 12995.350232488385, 826.6734639817283, 840.4663038970267, 841.6086519768306, 842.1578421578422, 842.3303473738392, 838.174398217755, 841.9831603367929, 842.2756429470681, 842.6166094427051, 843.5487014447272, 864.7362554420899, 870.3211495033884, 870.7779516223354, 872.6901949807822, 872.7687162901805, 872.9214370706667, 873.1181506678237, 873.8645509945968, 875.3172525430143, 878.8066625342415, 614.8862460444788, 626.7555653295218, 634.8761991411676, 635.5582869905418, 635.7615894039735, 13725.862741372559, 13877.791833122512, 13890.513832015831, 13919.443222271097, 13931.30343482832, 11673.29960202382, 12052.758944821055, 12182.573609923611, 12298.385080745928, 12680.492780288778, 10289.434081125535, 10310.793784124351, 10340.121089707383, 10345.275830691855, 10376.844347334796, 3490.6683865032783, 3510.7542472026967, 3553.626869178725, 3653.2876089162623, 3665.5234819473562, 40165.59834401648, 40399.0, 43926.78036609828, 45447.772761136315, 49142.75428622834, 9760.316777825627, 9837.11465968052, 9851.50742462874, 9908.752281193028, 9921.751956201007, 17079.829201707824, 17139.400120995706, 17154.656906861794, 17162.485125446256, 17163.485095446908, 6858.622775747282, 7037.472189585699, 7071.186813516409, 7212.170600380919, 7251.601161936144, 4053.8986525336513, 4192.727472714264, 4208.8271780232435, 4248.978755106266, 4303.0, 3066.126154046086, 3107.0368185862453, 3111.191090316489, 3111.377724455118, 3111.5643809866638, 535.7856857257051, 550.7411516587198, 552.0670067585767, 553.4797290546873, 565.2510423688547, 494.8614387971374, 609.6403122157948, 615.7044618583105, 637.6046850952347, 639.792067578039, 9276.953615232016, 9335.813283734287, 9491.905080949102, 9513.571889265, 9757.316987810786, 561.5170952980434, 658.6180015590945, 669.6651674162919, 685.1914740606132, 690.6650274616807, 4088.2436749201493, 4279.251131052053, 4330.718503297276, 4335.523092459827, 4353.064091220403, 58838.0, 59253.703731481066, 59459.40540594625, 59581.10628340578, 59708.10437843436, 53039.942120100946, 53854.73072634612, 54067.72966135144, 54145.45854541483, 54252.45747542553, 41938.58061419408, 46104.0, 46558.0, 46606.76696616495, 46658.76670616625, 8894.42186257891, 8936.106389361272, 8946.37375383717, 8973.865392019256, 9099.772505687411, 36164.4575331365, 36185.63814361823, 36930.26139477249, 36987.44518832166, 37033.0, 36584.0, 37404.0, 39608.801955990035, 44569.0, 44746.77626611846, 11134.498947547218, 11202.079660561047, 11407.942960285145, 11479.655610331703, 11589.072874170215, 12438.564650237198, 12893.41979610901, 12994.870051299366, 13010.154339967872, 13419.261940593362, 11524.654260372203, 11728.765424691288, 11797.0, 12164.756704865677, 12297.077719170918, 11760.235584686969, 11938.22401543897, 12019.09856760764, 12151.149419540547, 12398.0, 11606.477708503306, 11729.237599556001, 11930.880691192977, 12159.392030398622, 12394.938025309815, 10209.50781656069, 10217.1826253901, 10237.795244095225, 10638.468076596295, 10707.411092389993, 9729.513524323896, 9890.505474726378, 10047.296689231684, 10048.598056077675, 10358.792824143626], "unit": "ms", "name": "yui.html", "value": 6362.631407446194}], "name": "dromaeo_css", "value": 6972.993117314891}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 102.0, 110.0, 109.0, 110.0, 99.0, 108.0, 109.0, 98.0], "unit": "ms", "name": "ai-astar", "value": 106.3}, {"lowerIsBetter": true, "replicates": [153.0, 122.0, 147.0, 158.0, 128.0, 153.0, 152.0, 124.0, 165.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.4}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 162.0, 160.0, 163.0, 162.0, 160.0, 161.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 84.0, 98.0, 71.0, 73.0, 71.0, 100.0, 93.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 138.0, 93.0, 94.0, 94.0, 132.0, 93.0, 93.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 144.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 56.0, 57.0, 57.0, 57.0, 58.0, 59.0, 56.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 71.0, 71.0, 71.0, 71.0, 69.0, 70.0, 72.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.3}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 84.0, 85.0, 91.0, 84.0, 85.0, 84.0, 86.0, 88.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [128.0, 116.0, 126.0, 114.0, 118.0, 117.0, 126.0, 128.0, 114.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [138.0, 161.0, 150.0, 150.0, 148.0, 139.0, 149.0, 147.0, 148.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 66.0, 64.0, 66.0, 68.0, 67.0, 73.0, 67.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1493.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.03021749958492], "unit": "score", "name": "Richards", "value": 212.62394600000007}, {"lowerIsBetter": false, "replicates": [187.72292096865027], "unit": "score", "name": "DeltaBlue", "value": 352.210586}, {"lowerIsBetter": false, "replicates": [282.7254735651682], "unit": "score", "name": "Encrypt", "value": 941.4821969999996}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1084.5986984815618], "unit": "score", "name": "RayTrace", "value": 682.2698579999999}, {"lowerIsBetter": false, "replicates": [768.6395080707148], "unit": "score", "name": "Earley", "value": 867.068363}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [26051.28205128205], "unit": "score", "name": "RegExp", "value": 34.96891240157479}, {"lowerIsBetter": false, "replicates": [592.0663114268798], "unit": "score", "name": "Splay", "value": 137.63829900000002}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21159.069848004998}]} 21:10:36 INFO - RETURN: dromaeo_css: 6972.99 21:10:36 INFO - RETURN: kraken: 1493.40 21:10:36 INFO - RETURN: v8_7: 21159.07 21:10:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "21159.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1493.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6972.99"}}} 21:10:36 INFO - Return code: 0 21:10:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 21:10:36 INFO - # TBPL SUCCESS # 21:10:36 INFO - Running post-action listener: _resource_record_post_action 21:10:36 INFO - Running post-run listener: _resource_record_post_run 21:10:37 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 8192; Write bytes: 512299008; Read time: 64; Write time: 459448 21:10:37 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 239296512; Read time: 0; Write time: 279764 21:10:37 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 8192; Write bytes: 265351168; Read time: 64; Write time: 177344 21:10:37 INFO - Running post-run listener: _upload_blobber_files 21:10:37 INFO - Blob upload gear active. 21:10:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:10:37 INFO - Copying logs to upload dir... 21:10:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.220549 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-25 21:10:36.870335) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 21:10:36.873525) ========= 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=6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010111 build_url: 'https://queue.taskcluster.net/v1/task/Y67NcvHbRUOCISQo1GX04w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 21:10:36.925896) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 21:10:36.926393) ========= 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=6587686cb2da90a5f91b3170000001be-1448512227.418343-1322092026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004681 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 21:10:36.976344) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 21:10:36.976702) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 21:10:36.977056) ========= ========= Total master_lag: 0.25 =========