builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1448442984.16 results: success (0) buildid: 20151124233056 builduid: 730fb4cd09ce46dfafdfe50d220f6e3f revision: 9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.162018) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.162555) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.162873) ========= 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=d3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006543 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.227351) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.227662) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.313964) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.314283) ========= 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=d3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.036549 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.363875) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.364244) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.364623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.364935) ========= 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=d3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 01:16:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-11-25 01:16:24 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.272785 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.652949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.653697) ========= 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=d3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.071513 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.737116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:24.737496) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878 --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 9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878 --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=d3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 01:16:24,813 truncating revision to first 12 chars 2015-11-25 01:16:24,813 Setting DEBUG logging. 2015-11-25 01:16:24,813 attempt 1/10 2015-11-25 01:16:24,813 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/9145ebe2c0c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 01:16:25,077 unpacking tar archive at: b2g-inbound-9145ebe2c0c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575768 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:25.326039) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:25.326420) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:25.333920) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:25.334259) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 01:16:25.334704) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-11-25 01:16:25.335030) ========= /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=d3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:16:25 INFO - MultiFileLogger online at 20151125 01:16:25 in /builds/slave/test-pgo 01:16:25 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 01:16:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:16:25 INFO - {'append_to_log': False, 01:16:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:16:25 INFO - 'blob_upload_branch': 'B2G-Inbound', 01:16:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:16:25 INFO - 'branch': 'B2G-Inbound', 01:16:25 INFO - 'buildbot_json_path': 'buildprops.json', 01:16:25 INFO - 'config_files': ('talos/linux_config.py',), 01:16:25 INFO - 'default_actions': ('clobber', 01:16:25 INFO - 'read-buildbot-config', 01:16:25 INFO - 'download-and-extract', 01:16:25 INFO - 'populate-webroot', 01:16:25 INFO - 'create-virtualenv', 01:16:25 INFO - 'install', 01:16:25 INFO - 'run-tests'), 01:16:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:16:25 INFO - 'download_minidump_stackwalk': True, 01:16:25 INFO - 'download_symbols': 'ondemand', 01:16:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:16:25 INFO - 'tooltool.py': '/tools/tooltool.py', 01:16:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:16:25 INFO - '/tools/misc-python/virtualenv.py')}, 01:16:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:16:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:16:25 INFO - 'installer_path': 'installer.exe', 01:16:25 INFO - 'log_level': 'info', 01:16:25 INFO - 'log_name': 'talos', 01:16:25 INFO - 'log_to_console': True, 01:16:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:16:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:16:25 INFO - 'opt_config_files': (), 01:16:25 INFO - 'pip_index': False, 01:16:25 INFO - 'sps_profile': False, 01:16:25 INFO - 'sps_profile_interval': 0, 01:16:25 INFO - 'suite': 'dromaeojs', 01:16:25 INFO - 'system_bits': '64', 01:16:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:16:25 INFO - 'title': 'talos-linux64-ix-050', 01:16:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:16:25 INFO - 'use_talos_json': True, 01:16:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:16:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:16:25 INFO - 'work_dir': 'build'} 01:16:25 INFO - ##### 01:16:25 INFO - ##### Running clobber step. 01:16:25 INFO - ##### 01:16:25 INFO - Running pre-action listener: _resource_record_pre_action 01:16:25 INFO - Running main action method: clobber 01:16:25 INFO - rmtree: /builds/slave/test-pgo/build 01:16:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:16:30 INFO - Running post-action listener: _resource_record_post_action 01:16:30 INFO - ##### 01:16:30 INFO - ##### Running read-buildbot-config step. 01:16:30 INFO - ##### 01:16:30 INFO - Running pre-action listener: _resource_record_pre_action 01:16:30 INFO - Running main action method: read_buildbot_config 01:16:30 INFO - Using buildbot properties: 01:16:30 INFO - { 01:16:30 INFO - "properties": { 01:16:30 INFO - "buildnumber": 53, 01:16:30 INFO - "product": "firefox", 01:16:30 INFO - "script_repo_revision": "production", 01:16:30 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 01:16:30 INFO - "repository": "", 01:16:30 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 01:16:30 INFO - "buildid": "20151124233056", 01:16:30 INFO - "slavename": "talos-linux64-ix-050", 01:16:30 INFO - "pgo_build": "True", 01:16:30 INFO - "basedir": "/builds/slave/test-pgo", 01:16:30 INFO - "project": "", 01:16:30 INFO - "platform": "ubuntu64_hw", 01:16:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:16:30 INFO - "slavebuilddir": "test", 01:16:30 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 01:16:30 INFO - "branch": "b2g-inbound", 01:16:30 INFO - "repo_path": "integration/b2g-inbound", 01:16:30 INFO - "stage_platform": "linux64-pgo", 01:16:30 INFO - "builduid": "730fb4cd09ce46dfafdfe50d220f6e3f", 01:16:30 INFO - "revision": "9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878" 01:16:30 INFO - }, 01:16:30 INFO - "sourcestamp": { 01:16:30 INFO - "repository": "", 01:16:30 INFO - "hasPatch": false, 01:16:30 INFO - "project": "", 01:16:30 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 01:16:30 INFO - "changes": [ 01:16:30 INFO - { 01:16:30 INFO - "category": null, 01:16:30 INFO - "files": [ 01:16:30 INFO - { 01:16:30 INFO - "url": null, 01:16:30 INFO - "name": "https://queue.taskcluster.net/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 01:16:30 INFO - } 01:16:30 INFO - ], 01:16:30 INFO - "repository": "", 01:16:30 INFO - "rev": "9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878", 01:16:30 INFO - "who": "sendchange", 01:16:30 INFO - "when": 1448442901, 01:16:30 INFO - "number": 6704686, 01:16:30 INFO - "comments": "", 01:16:30 INFO - "project": "", 01:16:30 INFO - "at": "Wed 25 Nov 2015 01:15:01", 01:16:30 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 01:16:30 INFO - "revlink": "", 01:16:30 INFO - "properties": [ 01:16:30 INFO - [ 01:16:30 INFO - "buildid", 01:16:30 INFO - "20151124233056", 01:16:30 INFO - "Change" 01:16:30 INFO - ], 01:16:30 INFO - [ 01:16:30 INFO - "builduid", 01:16:30 INFO - "730fb4cd09ce46dfafdfe50d220f6e3f", 01:16:30 INFO - "Change" 01:16:30 INFO - ], 01:16:30 INFO - [ 01:16:30 INFO - "pgo_build", 01:16:30 INFO - "True", 01:16:30 INFO - "Change" 01:16:30 INFO - ] 01:16:30 INFO - ], 01:16:30 INFO - "revision": "9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878" 01:16:30 INFO - } 01:16:30 INFO - ], 01:16:30 INFO - "revision": "9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878" 01:16:30 INFO - } 01:16:30 INFO - } 01:16:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 01:16:30 INFO - Running post-action listener: _resource_record_post_action 01:16:30 INFO - ##### 01:16:30 INFO - ##### Running download-and-extract step. 01:16:30 INFO - ##### 01:16:30 INFO - Running pre-action listener: _resource_record_pre_action 01:16:30 INFO - Running main action method: download_and_extract 01:16:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:16:30 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')]} 01:16:30 INFO - https://queue.taskcluster.net/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:16:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/test_packages.json 01:16:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/test_packages.json 01:16:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:16:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:16:31 INFO - Downloaded 1302 bytes. 01:16:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:16:31 INFO - Using the following test package requirements: 01:16:31 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:16:31 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:16:31 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:31 INFO - u'jsshell-linux-x86_64.zip'], 01:16:31 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:16:31 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:16:31 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:16:31 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:16:31 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:16:31 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:16:31 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:16:31 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:31 INFO - https://queue.taskcluster.net/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:16:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:16:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:16:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/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 01:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/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 01:16:33 INFO - Downloaded 22530742 bytes. 01:16:33 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 01:16:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:16:33 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 01:16:34 INFO - Return code: 0 01:16:34 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 01:16:34 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')]} 01:16:34 INFO - https://queue.taskcluster.net/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:16:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:16:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:16:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/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 01:16:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/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 01:16:36 INFO - Downloaded 22530742 bytes. 01:16:36 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 01:16:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:16:36 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 01:16:37 INFO - Return code: 0 01:16:37 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')]} 01:16:37 INFO - https://queue.taskcluster.net/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:16:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:16:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:16:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/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 01:16:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/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 01:16:39 INFO - Downloaded 11131717 bytes. 01:16:39 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 01:16:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:16:39 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 01:16:39 INFO - Return code: 0 01:16:39 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')]} 01:16:39 INFO - https://queue.taskcluster.net/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:16:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:16:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:16:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/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 01:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/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 01:16:41 INFO - Downloaded 58376369 bytes. 01:16:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:16:41 INFO - mkdir: /builds/slave/test-pgo/properties 01:16:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:16:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:16:41 INFO - Contents: 01:16:41 INFO - build_url:https://queue.taskcluster.net/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:16:41 INFO - Running post-action listener: _resource_record_post_action 01:16:41 INFO - Running post-action listener: set_extra_try_arguments 01:16:41 INFO - ##### 01:16:41 INFO - ##### Running populate-webroot step. 01:16:41 INFO - ##### 01:16:41 INFO - Running pre-action listener: _resource_record_pre_action 01:16:41 INFO - Running main action method: populate_webroot 01:16:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:16:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:16:41 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:16:41 INFO - '../fennec_ids.txt'], 01:16:41 INFO - 'tests': ['tcheck2']}, 01:16:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:16:41 INFO - '--tppagecycles', 01:16:41 INFO - '7'], 01:16:41 INFO - 'tests': ['tsvgm']}}, 01:16:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:16:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:16:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:16:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:16:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:16:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:16:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:16:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:41 INFO - 'talos_options': ['--e10s'], 01:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:16:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:41 INFO - 'tests': ['damp', 'tps']}, 01:16:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:41 INFO - 'talos_options': ['--e10s'], 01:16:41 INFO - 'tests': ['damp', 'tps']}, 01:16:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:16:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:16:41 INFO - 'other': {'tests': ['a11yr', 01:16:41 INFO - 'ts_paint', 01:16:41 INFO - 'tpaint', 01:16:41 INFO - 'sessionrestore', 01:16:41 INFO - 'sessionrestore_no_auto_restore']}, 01:16:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:16:41 INFO - 'tests': ['a11yr', 01:16:41 INFO - 'ts_paint', 01:16:41 INFO - 'tpaint', 01:16:41 INFO - 'sessionrestore', 01:16:41 INFO - 'sessionrestore_no_auto_restore']}, 01:16:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:16:41 INFO - 'tests': ['a11yr', 01:16:41 INFO - 'ts_paint', 01:16:41 INFO - 'tpaint', 01:16:41 INFO - 'sessionrestore', 01:16:41 INFO - 'sessionrestore_no_auto_restore']}, 01:16:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:16:41 INFO - 'tests': ['a11yr', 01:16:41 INFO - 'ts_paint', 01:16:41 INFO - 'tpaint', 01:16:41 INFO - 'sessionrestore', 01:16:41 INFO - 'sessionrestore_no_auto_restore']}, 01:16:41 INFO - 'other_l64': {'tests': ['a11yr', 01:16:41 INFO - 'ts_paint', 01:16:41 INFO - 'tpaint', 01:16:41 INFO - 'sessionrestore', 01:16:41 INFO - 'sessionrestore_no_auto_restore']}, 01:16:41 INFO - 'other_nol64': {'tests': ['a11yr', 01:16:41 INFO - 'ts_paint', 01:16:41 INFO - 'tpaint', 01:16:41 INFO - 'sessionrestore', 01:16:41 INFO - 'sessionrestore_no_auto_restore']}, 01:16:41 INFO - 'svgr': {'tests': ['tsvgx', 01:16:41 INFO - 'tsvgr_opacity', 01:16:41 INFO - 'tart', 01:16:41 INFO - 'tscrollx', 01:16:41 INFO - 'cart']}, 01:16:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:16:41 INFO - 'tests': ['tsvgx', 01:16:41 INFO - 'tsvgr_opacity', 01:16:41 INFO - 'tart', 01:16:41 INFO - 'tscrollx', 01:16:41 INFO - 'cart']}, 01:16:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:41 INFO - 'tests': ['tp5o']}, 01:16:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:41 INFO - 'talos_options': ['--e10s'], 01:16:41 INFO - 'tests': ['tp5o']}, 01:16:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:41 INFO - 'talos_options': ['--xperf_path', 01:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:16:41 INFO - 'tests': ['tp5n']}, 01:16:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:41 INFO - 'talos_options': ['--e10s', 01:16:41 INFO - '--xperf_path', 01:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:16:41 INFO - 'tests': ['tp5n']}}, 01:16:41 INFO - 'talos.zip': {'path': '', 01:16:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:16:41 INFO - Running post-action listener: _resource_record_post_action 01:16:41 INFO - ##### 01:16:41 INFO - ##### Running create-virtualenv step. 01:16:41 INFO - ##### 01:16:41 INFO - Running pre-action listener: _resource_record_pre_action 01:16:41 INFO - Running main action method: create_virtualenv 01:16:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:16:41 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 01:16:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:16:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:16:41 INFO - Using real prefix '/usr' 01:16:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:16:42 INFO - Installing distribute.............................................................................................................................................................................................done. 01:16:44 INFO - Installing pip.................done. 01:16:44 INFO - Return code: 0 01:16:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:16: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')]} 01:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16: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')]} 01:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:44 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da640>, '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 0x24db540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24db9d0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', '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 01:16:44 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 01:16:44 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 01:16:44 INFO - Using env: {'DISPLAY': ':0', 01:16:44 INFO - 'HOME': '/home/cltbld', 01:16:44 INFO - 'LANG': 'en_US.UTF-8', 01:16:44 INFO - 'LANGUAGE': 'en_US:en', 01:16:44 INFO - 'LOGNAME': 'cltbld', 01:16:44 INFO - 'MAIL': '/var/mail/cltbld', 01:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:44 INFO - 'MOZ_NO_REMOTE': '1', 01:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:44 INFO - 'NO_EM_RESTART': '1', 01:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:16:44 INFO - 'PWD': '/builds/slave/test-pgo', 01:16:44 INFO - 'SHELL': '/bin/bash', 01:16:44 INFO - 'SHLVL': '1', 01:16:44 INFO - 'TERM': 'linux', 01:16:44 INFO - 'TMOUT': '86400', 01:16:44 INFO - 'USER': 'cltbld', 01:16:44 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', 01:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:44 INFO - '_': '/tools/buildbot/bin/python'} 01:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:44 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 01:16:44 INFO - Cleaning up... 01:16:44 INFO - Return code: 0 01:16:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:16: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')]} 01:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16: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')]} 01:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:44 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da640>, '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 0x24db540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24db9d0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', '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 01:16:44 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 01:16:44 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 01:16:44 INFO - Using env: {'DISPLAY': ':0', 01:16:44 INFO - 'HOME': '/home/cltbld', 01:16:44 INFO - 'LANG': 'en_US.UTF-8', 01:16:44 INFO - 'LANGUAGE': 'en_US:en', 01:16:44 INFO - 'LOGNAME': 'cltbld', 01:16:44 INFO - 'MAIL': '/var/mail/cltbld', 01:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:44 INFO - 'MOZ_NO_REMOTE': '1', 01:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:44 INFO - 'NO_EM_RESTART': '1', 01:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:16:44 INFO - 'PWD': '/builds/slave/test-pgo', 01:16:44 INFO - 'SHELL': '/bin/bash', 01:16:44 INFO - 'SHLVL': '1', 01:16:44 INFO - 'TERM': 'linux', 01:16:44 INFO - 'TMOUT': '86400', 01:16:44 INFO - 'USER': 'cltbld', 01:16:44 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', 01:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:44 INFO - '_': '/tools/buildbot/bin/python'} 01:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:45 INFO - Downloading/unpacking psutil>=0.7.1 01:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:46 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:16:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:16:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:16:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:16:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:16:46 INFO - Installing collected packages: psutil 01:16:46 INFO - Running setup.py install for psutil 01:16:46 INFO - building 'psutil._psutil_linux' extension 01:16:46 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 01:16:48 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 01:16:48 INFO - building 'psutil._psutil_posix' extension 01:16:48 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 01:16:48 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 01:16:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:16:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:16:48 INFO - Successfully installed psutil 01:16:48 INFO - Cleaning up... 01:16:48 INFO - Return code: 0 01:16:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:16: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')]} 01:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16: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')]} 01:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:48 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da640>, '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 0x24db540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24db9d0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', '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 01:16:48 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 01:16:48 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 01:16:48 INFO - Using env: {'DISPLAY': ':0', 01:16:48 INFO - 'HOME': '/home/cltbld', 01:16:48 INFO - 'LANG': 'en_US.UTF-8', 01:16:48 INFO - 'LANGUAGE': 'en_US:en', 01:16:48 INFO - 'LOGNAME': 'cltbld', 01:16:48 INFO - 'MAIL': '/var/mail/cltbld', 01:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:48 INFO - 'MOZ_NO_REMOTE': '1', 01:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:48 INFO - 'NO_EM_RESTART': '1', 01:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:16:48 INFO - 'PWD': '/builds/slave/test-pgo', 01:16:48 INFO - 'SHELL': '/bin/bash', 01:16:48 INFO - 'SHLVL': '1', 01:16:48 INFO - 'TERM': 'linux', 01:16:48 INFO - 'TMOUT': '86400', 01:16:48 INFO - 'USER': 'cltbld', 01:16:48 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', 01:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:48 INFO - '_': '/tools/buildbot/bin/python'} 01:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:16:48 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 01:16:48 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 01:16:48 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 01:16:48 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 01:16:48 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 01:16:48 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 01:16:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:16:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:16:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:16:50 INFO - Installing collected packages: mozsystemmonitor 01:16:50 INFO - Running setup.py install for mozsystemmonitor 01:16:50 INFO - Successfully installed mozsystemmonitor 01:16:50 INFO - Cleaning up... 01:16:50 INFO - Return code: 0 01:16:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:50 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da640>, '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 0x24db540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24db9d0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', '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 01:16:50 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 01:16:50 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 01:16:50 INFO - Using env: {'DISPLAY': ':0', 01:16:50 INFO - 'HOME': '/home/cltbld', 01:16:50 INFO - 'LANG': 'en_US.UTF-8', 01:16:50 INFO - 'LANGUAGE': 'en_US:en', 01:16:50 INFO - 'LOGNAME': 'cltbld', 01:16:50 INFO - 'MAIL': '/var/mail/cltbld', 01:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:50 INFO - 'MOZ_NO_REMOTE': '1', 01:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:50 INFO - 'NO_EM_RESTART': '1', 01:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:16:50 INFO - 'PWD': '/builds/slave/test-pgo', 01:16:50 INFO - 'SHELL': '/bin/bash', 01:16:50 INFO - 'SHLVL': '1', 01:16:50 INFO - 'TERM': 'linux', 01:16:50 INFO - 'TMOUT': '86400', 01:16:50 INFO - 'USER': 'cltbld', 01:16:50 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', 01:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:50 INFO - '_': '/tools/buildbot/bin/python'} 01:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:50 INFO - Downloading/unpacking blobuploader==1.2.4 01:16:50 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 01:16:50 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 01:16:50 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 01:16:50 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 01:16:50 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 01:16:50 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 01:16:52 INFO - Downloading blobuploader-1.2.4.tar.gz 01:16:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:16:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:16:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:16:52 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 01:16:52 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 01:16:52 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 01:16:52 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 01:16:52 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 01:16:52 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 01:16:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:16:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:16:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:16:52 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 01:16:52 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 01:16:52 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 01:16:52 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 01:16:52 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 01:16:52 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 01:16:53 INFO - Downloading docopt-0.6.1.tar.gz 01:16:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:16:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:16:53 INFO - Installing collected packages: blobuploader, requests, docopt 01:16:53 INFO - Running setup.py install for blobuploader 01:16:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:16:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:16:53 INFO - Running setup.py install for requests 01:16:53 INFO - Running setup.py install for docopt 01:16:53 INFO - Successfully installed blobuploader requests docopt 01:16:53 INFO - Cleaning up... 01:16:53 INFO - Return code: 0 01:16:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:16: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')]} 01:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16: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')]} 01:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:53 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da640>, '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 0x24db540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24db9d0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', '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 01:16:53 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 01:16:53 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 01:16:53 INFO - Using env: {'DISPLAY': ':0', 01:16:53 INFO - 'HOME': '/home/cltbld', 01:16:53 INFO - 'LANG': 'en_US.UTF-8', 01:16:53 INFO - 'LANGUAGE': 'en_US:en', 01:16:53 INFO - 'LOGNAME': 'cltbld', 01:16:53 INFO - 'MAIL': '/var/mail/cltbld', 01:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:53 INFO - 'MOZ_NO_REMOTE': '1', 01:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:53 INFO - 'NO_EM_RESTART': '1', 01:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:16:53 INFO - 'PWD': '/builds/slave/test-pgo', 01:16:53 INFO - 'SHELL': '/bin/bash', 01:16:53 INFO - 'SHLVL': '1', 01:16:53 INFO - 'TERM': 'linux', 01:16:53 INFO - 'TMOUT': '86400', 01:16:53 INFO - 'USER': 'cltbld', 01:16:53 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', 01:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:53 INFO - '_': '/tools/buildbot/bin/python'} 01:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:16:53 INFO - Running setup.py (path:/tmp/pip-GfHMxR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:16:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:16:53 INFO - Running setup.py (path:/tmp/pip-nWXUpV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:16:54 INFO - Running setup.py (path:/tmp/pip-KbpjAg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:16:54 INFO - Running setup.py (path:/tmp/pip-OZ48mp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:16:54 INFO - Running setup.py (path:/tmp/pip-0RGoBC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:16:54 INFO - Running setup.py (path:/tmp/pip-1MrX6u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:16:54 INFO - Running setup.py (path:/tmp/pip-6G0HU4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:16:54 INFO - Running setup.py (path:/tmp/pip-2d2Cws-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:16:54 INFO - Running setup.py (path:/tmp/pip-GrgW0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:16:54 INFO - Running setup.py (path:/tmp/pip-sOrD8V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:16:54 INFO - Running setup.py (path:/tmp/pip-9lW_JS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:16:54 INFO - Running setup.py (path:/tmp/pip-ZE9rDS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:16:54 INFO - Running setup.py (path:/tmp/pip-rhXSBk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:16:54 INFO - Running setup.py (path:/tmp/pip-HZfJv5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:16:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:16:54 INFO - Running setup.py (path:/tmp/pip-0MElHf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:16:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:16:55 INFO - Running setup.py (path:/tmp/pip-erHRcL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:16:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:16:55 INFO - Running setup.py (path:/tmp/pip-dDaYvk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:16:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:16:55 INFO - Running setup.py install for manifestparser 01:16:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:16:55 INFO - Running setup.py install for mozcrash 01:16:55 INFO - Running setup.py install for mozdebug 01:16:55 INFO - Running setup.py install for mozdevice 01:16:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:16:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:16:55 INFO - Running setup.py install for mozfile 01:16:55 INFO - Running setup.py install for mozhttpd 01:16:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:16:55 INFO - Running setup.py install for mozinfo 01:16:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:16:55 INFO - Running setup.py install for mozInstall 01:16:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:16:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:16:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:16:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:16:55 INFO - Running setup.py install for mozleak 01:16:56 INFO - Running setup.py install for mozlog 01:16:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:16:56 INFO - Running setup.py install for moznetwork 01:16:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:16:56 INFO - Running setup.py install for mozprocess 01:16:56 INFO - Running setup.py install for mozprofile 01:16:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:16:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:16:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:16:56 INFO - Running setup.py install for mozrunner 01:16:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:16:56 INFO - Running setup.py install for mozscreenshot 01:16:56 INFO - Running setup.py install for moztest 01:16:56 INFO - Running setup.py install for mozversion 01:16:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:16:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:16:56 INFO - Cleaning up... 01:16:56 INFO - Return code: 0 01:16:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:16:56 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')]} 01:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:56 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')]} 01:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:56 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da640>, '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 0x24db540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24db9d0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', '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 01:16:56 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 01:16:56 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 01:16:56 INFO - Using env: {'DISPLAY': ':0', 01:16:56 INFO - 'HOME': '/home/cltbld', 01:16:56 INFO - 'LANG': 'en_US.UTF-8', 01:16:56 INFO - 'LANGUAGE': 'en_US:en', 01:16:56 INFO - 'LOGNAME': 'cltbld', 01:16:56 INFO - 'MAIL': '/var/mail/cltbld', 01:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:56 INFO - 'MOZ_NO_REMOTE': '1', 01:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:56 INFO - 'NO_EM_RESTART': '1', 01:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:16:56 INFO - 'PWD': '/builds/slave/test-pgo', 01:16:56 INFO - 'SHELL': '/bin/bash', 01:16:56 INFO - 'SHLVL': '1', 01:16:56 INFO - 'TERM': 'linux', 01:16:56 INFO - 'TMOUT': '86400', 01:16:56 INFO - 'USER': 'cltbld', 01:16:56 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', 01:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:56 INFO - '_': '/tools/buildbot/bin/python'} 01:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:16:57 INFO - Running setup.py (path:/tmp/pip-_C7Kes-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:16:57 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)) 01:16:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:16:57 INFO - Running setup.py (path:/tmp/pip-867LZf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:16:57 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)) 01:16:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:16:57 INFO - Running setup.py (path:/tmp/pip-BDf6nl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:16:57 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)) 01:16:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:16:57 INFO - Running setup.py (path:/tmp/pip-guz02H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:16:57 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)) 01:16:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:16:57 INFO - Running setup.py (path:/tmp/pip-9SpYu6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:16:57 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)) 01:16:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:16:57 INFO - Running setup.py (path:/tmp/pip-3id9XL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:16:57 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)) 01:16:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:16:57 INFO - Running setup.py (path:/tmp/pip-Eu3Sey-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:16:57 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)) 01:16:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:16:57 INFO - Running setup.py (path:/tmp/pip-EFHQOi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:16:57 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)) 01:16:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:16:57 INFO - Running setup.py (path:/tmp/pip-KPYa46-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:16:57 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)) 01:16:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:16:57 INFO - Running setup.py (path:/tmp/pip-41UKhg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:16:57 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)) 01:16:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:16:57 INFO - Running setup.py (path:/tmp/pip-AW94ha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:16:57 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)) 01:16:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:16:57 INFO - Running setup.py (path:/tmp/pip-fIlNld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:16:57 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)) 01:16:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:16:57 INFO - Running setup.py (path:/tmp/pip-ngHyyS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:16:58 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)) 01:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:16:58 INFO - Running setup.py (path:/tmp/pip-d36kj1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:16:58 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)) 01:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:16:58 INFO - Running setup.py (path:/tmp/pip-obmiNB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:16:58 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)) 01:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:16:58 INFO - Running setup.py (path:/tmp/pip-8y3mYC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:16:58 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)) 01:16:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:16:58 INFO - Running setup.py (path:/tmp/pip-Y3TLeM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:16:58 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)) 01:16:58 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)) 01:16:58 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)) 01:16:58 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)) 01:16:58 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)) 01:16:58 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)) 01:16:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:16: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 01:16: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 01:16: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 01:16: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 01:16: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 01:16: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 01:17:00 INFO - Downloading blessings-1.5.1.tar.gz 01:17:00 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 01:17:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:17:00 INFO - Installing collected packages: blessings 01:17:00 INFO - Running setup.py install for blessings 01:17:00 INFO - Successfully installed blessings 01:17:00 INFO - Cleaning up... 01:17:00 INFO - Return code: 0 01:17:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:17:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:17:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:17:00 INFO - Reading from file tmpfile_stdout 01:17:00 INFO - Current package versions: 01:17:00 INFO - argparse == 1.2.1 01:17:00 INFO - blessings == 1.5.1 01:17:00 INFO - blobuploader == 1.2.4 01:17:00 INFO - docopt == 0.6.1 01:17:00 INFO - manifestparser == 1.1 01:17:00 INFO - mozInstall == 1.12 01:17:00 INFO - mozcrash == 0.16 01:17:00 INFO - mozdebug == 0.1 01:17:00 INFO - mozdevice == 0.47 01:17:00 INFO - mozfile == 1.2 01:17:00 INFO - mozhttpd == 0.7 01:17:00 INFO - mozinfo == 0.9 01:17:00 INFO - mozleak == 0.1 01:17:00 INFO - mozlog == 3.1 01:17:00 INFO - moznetwork == 0.27 01:17:00 INFO - mozprocess == 0.22 01:17:00 INFO - mozprofile == 0.27 01:17:00 INFO - mozrunner == 6.11 01:17:00 INFO - mozscreenshot == 0.1 01:17:00 INFO - mozsystemmonitor == 0.0 01:17:00 INFO - moztest == 0.7 01:17:00 INFO - mozversion == 1.4 01:17:00 INFO - psutil == 3.1.1 01:17:00 INFO - requests == 1.2.3 01:17:00 INFO - wsgiref == 0.1.2 01:17:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:00 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da640>, '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 0x24db540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24db9d0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', '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 01:17:00 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 01:17:00 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 01:17:00 INFO - Using env: {'DISPLAY': ':0', 01:17:00 INFO - 'HOME': '/home/cltbld', 01:17:00 INFO - 'LANG': 'en_US.UTF-8', 01:17:00 INFO - 'LANGUAGE': 'en_US:en', 01:17:00 INFO - 'LOGNAME': 'cltbld', 01:17:00 INFO - 'MAIL': '/var/mail/cltbld', 01:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:00 INFO - 'MOZ_NO_REMOTE': '1', 01:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:00 INFO - 'NO_EM_RESTART': '1', 01:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:17:00 INFO - 'PWD': '/builds/slave/test-pgo', 01:17:00 INFO - 'SHELL': '/bin/bash', 01:17:00 INFO - 'SHLVL': '1', 01:17:00 INFO - 'TERM': 'linux', 01:17:00 INFO - 'TMOUT': '86400', 01:17:00 INFO - 'USER': 'cltbld', 01:17:00 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', 01:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:00 INFO - '_': '/tools/buildbot/bin/python'} 01:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:00 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)) 01:17:00 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)) 01:17:00 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)) 01:17:00 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)) 01:17:00 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)) 01:17:00 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)) 01:17:00 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)) 01:17:00 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)) 01:17:00 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)) 01:17:00 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)) 01:17:00 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)) 01:17:00 INFO - Cleaning up... 01:17:00 INFO - Return code: 0 01:17:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:00 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da640>, '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 0x24db540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24db9d0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', '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 01:17:00 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 01:17:00 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 01:17:00 INFO - Using env: {'DISPLAY': ':0', 01:17:00 INFO - 'HOME': '/home/cltbld', 01:17:00 INFO - 'LANG': 'en_US.UTF-8', 01:17:00 INFO - 'LANGUAGE': 'en_US:en', 01:17:00 INFO - 'LOGNAME': 'cltbld', 01:17:00 INFO - 'MAIL': '/var/mail/cltbld', 01:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:00 INFO - 'MOZ_NO_REMOTE': '1', 01:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:00 INFO - 'NO_EM_RESTART': '1', 01:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:17:00 INFO - 'PWD': '/builds/slave/test-pgo', 01:17:00 INFO - 'SHELL': '/bin/bash', 01:17:00 INFO - 'SHLVL': '1', 01:17:00 INFO - 'TERM': 'linux', 01:17:00 INFO - 'TMOUT': '86400', 01:17:00 INFO - 'USER': 'cltbld', 01:17:00 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', 01:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:00 INFO - '_': '/tools/buildbot/bin/python'} 01:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:00 INFO - Downloading/unpacking jsonschema 01:17: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 01:17: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 01:17: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 01:17: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 01:17: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 01:17: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 01:17:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:17:02 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 01:17:02 INFO - Downloading/unpacking functools32 (from jsonschema) 01:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:02 INFO - Downloading functools32-3.2.3-2.tar.gz 01:17:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:17:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:17:02 INFO - warning: no files found matching '*.txt' 01:17:02 INFO - no previously-included directories found matching 'build' 01:17:02 INFO - no previously-included directories found matching 'dist' 01:17:02 INFO - no previously-included directories found matching '.git*' 01:17:02 INFO - Installing collected packages: jsonschema, functools32 01:17:02 INFO - Running setup.py install for functools32 01:17:03 INFO - warning: no files found matching '*.txt' 01:17:03 INFO - no previously-included directories found matching 'build' 01:17:03 INFO - no previously-included directories found matching 'dist' 01:17:03 INFO - no previously-included directories found matching '.git*' 01:17:03 INFO - Successfully installed jsonschema functools32 01:17:03 INFO - Cleaning up... 01:17:03 INFO - Return code: 0 01:17:03 INFO - Running post-action listener: _resource_record_post_action 01:17:03 INFO - Running post-action listener: _start_resource_monitoring 01:17:03 INFO - Starting resource monitoring. 01:17:03 INFO - ##### 01:17:03 INFO - ##### Running install step. 01:17:03 INFO - ##### 01:17:03 INFO - Running pre-action listener: _resource_record_pre_action 01:17:03 INFO - Running main action method: install 01:17:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:17:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:17:03 INFO - Reading from file tmpfile_stdout 01:17:03 INFO - Detecting whether we're running mozinstall >=1.0... 01:17:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:17:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:17:03 INFO - Reading from file tmpfile_stdout 01:17:03 INFO - Output received: 01:17:03 INFO - Usage: mozinstall [options] installer 01:17:03 INFO - Options: 01:17:03 INFO - -h, --help show this help message and exit 01:17:03 INFO - -d DEST, --destination=DEST 01:17:03 INFO - Directory to install application into. [default: 01:17:03 INFO - "/builds/slave/test-pgo"] 01:17:03 INFO - --app=APP Application being installed. [default: firefox] 01:17:03 INFO - mkdir: /builds/slave/test-pgo/build/application 01:17:03 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'] 01:17:03 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 01:17:18 INFO - Reading from file tmpfile_stdout 01:17:18 INFO - Output received: 01:17:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:17:18 INFO - Running post-action listener: _resource_record_post_action 01:17:18 INFO - ##### 01:17:18 INFO - ##### Running run-tests step. 01:17:18 INFO - ##### 01:17:18 INFO - Running pre-action listener: _resource_record_pre_action 01:17:18 INFO - Running main action method: run_tests 01:17:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:17:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:17:18 INFO - Python 2.7.3 01:17:18 INFO - Return code: 0 01:17:18 INFO - grabbing minidump binary from tooltool 01:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:18 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 0x24da640>, '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 0x24db540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24db9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:17:18 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 01:17:18 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 01:17:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:17:18 INFO - Return code: 0 01:17:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:17:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:17:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:17:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:17:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:17:18 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/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 01:17:18 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/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost 01:17:18 INFO - Using env: {'DISPLAY': ':0', 01:17:18 INFO - 'HOME': '/home/cltbld', 01:17:18 INFO - 'LANG': 'en_US.UTF-8', 01:17:18 INFO - 'LANGUAGE': 'en_US:en', 01:17:18 INFO - 'LOGNAME': 'cltbld', 01:17:18 INFO - 'MAIL': '/var/mail/cltbld', 01:17:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:17:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:18 INFO - 'MOZ_NO_REMOTE': '1', 01:17:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:18 INFO - 'NO_EM_RESTART': '1', 01:17:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:17:18 INFO - 'PWD': '/builds/slave/test-pgo', 01:17:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:17:18 INFO - 'SHELL': '/bin/bash', 01:17:18 INFO - 'SHLVL': '1', 01:17:18 INFO - 'TERM': 'linux', 01:17:18 INFO - 'TMOUT': '86400', 01:17:18 INFO - 'USER': 'cltbld', 01:17:18 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257', 01:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:18 INFO - '_': '/tools/buildbot/bin/python'} 01:17:18 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/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost'] with output_timeout 3600 01:17:18 INFO - mozversion INFO | application_buildid: 20151124233056 01:17:18 INFO - mozversion INFO | application_changeset: 9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878 01:17:18 INFO - mozversion INFO | application_display_name: Nightly 01:17:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:17:18 INFO - mozversion INFO | application_name: Firefox 01:17:18 INFO - mozversion INFO | application_remotingname: firefox 01:17:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 01:17:18 INFO - mozversion INFO | application_vendor: Mozilla 01:17:18 INFO - mozversion INFO | application_version: 45.0a1 01:17:18 INFO - mozversion INFO | platform_buildid: 20151124233056 01:17:18 INFO - mozversion INFO | platform_changeset: 9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878 01:17:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 01:17:18 INFO - mozversion INFO | platform_version: 45.0a1 01:17:18 INFO - 2015-11-25 01:17:18,449 DEBUG : using testdate: 1448443038 01:17:18 INFO - 2015-11-25 01:17:18,449 DEBUG : actual date: 1448443038 01:17:18 INFO - 2015-11-25 01:17:18,457 INFO : starting webserver on 'localhost:40511' 01:17:18 INFO - 2015-11-25 01:17:18,458 INFO : Starting test suite talos-linux64-ix-050 01:17:18 INFO - 2015-11-25 01:17:18,458 INFO : Starting test dromaeo_css 01:17:18 INFO - 2015-11-25 01:17:18,458 DEBUG : operating with platform_type : linux_ 01:17:18 INFO - 2015-11-25 01:17:18,459 INFO : Initialising browser for dromaeo_css test... 01:17:18 INFO - 2015-11-25 01:17:18,473 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAScpE6/profile http://localhost:40511/getInfo.html 01:17:24 INFO - 2015-11-25 01:17:24,654 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:17:24 INFO - 2015-11-25 01:17:24,654 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:17:24 INFO - 2015-11-25 01:17:24,654 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:17:24 INFO - 2015-11-25 01:17:24,654 DEBUG : BROWSER_OUTPUT: __metrics 01:17:24 INFO - 2015-11-25 01:17:24,751 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] 01:17:25 INFO - 2015-11-25 01:17:25,993 INFO : Browser initialized. 01:17:25 INFO - 2015-11-25 01:17:25,994 INFO : Running cycle 1/1 for dromaeo_css test... 01:17:25 INFO - 2015-11-25 01:17:25,994 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAScpE6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:17:37 INFO - 2015-11-25 01:17:37,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 139288576 01:17:37 INFO - 2015-11-25 01:17:37,700 DEBUG : BROWSER_OUTPUT: 01:18:28 INFO - 2015-11-25 01:18:28,463 DEBUG : BROWSER_OUTPUT: 1448443108462 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] 01:20:38 INFO - 2015-11-25 01:20:38,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40511/tests/dromaeo/cssquery-ext.html) 01:20:39 INFO - 2015-11-25 01:20:39,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 248954880 01:20:39 INFO - 2015-11-25 01:20:39,713 DEBUG : BROWSER_OUTPUT: 01:23:41 INFO - 2015-11-25 01:23:41,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/dromaeo/cssquery-ext.html (next: http://localhost:40511/tests/dromaeo/cssquery-jquery.html) 01:23:42 INFO - 2015-11-25 01:23:42,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 218398720 01:23:42 INFO - 2015-11-25 01:23:42,526 DEBUG : BROWSER_OUTPUT: 01:26:44 INFO - 2015-11-25 01:26:44,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40511/tests/dromaeo/cssquery-mootools.html) 01:26:45 INFO - 2015-11-25 01:26:45,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 213999616 01:26:45 INFO - 2015-11-25 01:26:45,010 DEBUG : BROWSER_OUTPUT: 01:29:46 INFO - 2015-11-25 01:29:46,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40511/tests/dromaeo/cssquery-prototype.html) 01:29:47 INFO - 2015-11-25 01:29:47,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 200474624 01:29:47 INFO - 2015-11-25 01:29:47,508 DEBUG : BROWSER_OUTPUT: 01:32:49 INFO - 2015-11-25 01:32:49,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40511/tests/dromaeo/cssquery-yui.html) 01:32:50 INFO - 2015-11-25 01:32:50,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 204247040 01:32:50 INFO - 2015-11-25 01:32:50,591 DEBUG : BROWSER_OUTPUT: 01:35:53 INFO - 2015-11-25 01:35:53,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/dromaeo/cssquery-yui.html (next: http://localhost:40511/tests/dromaeo/cssquery-dojo.html) 01:35:53 INFO - 2015-11-25 01:35:53,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 250040320 01:35:53 INFO - 2015-11-25 01:35:53,495 DEBUG : BROWSER_OUTPUT: 01:35:53 INFO - 2015-11-25 01:35:53,496 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:35:53 INFO - 2015-11-25 01:35:53,497 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:35:53 INFO - 2015-11-25 01:35:53,497 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:35:53 INFO - 2015-11-25 01:35:53,497 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:35:53 INFO - 2015-11-25 01:35:53,499 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3189.8245596492193;3238.1257060593657;3272.476403775396;3281.081297236773;3294.5222942673313;5320.388155362135;5435.718302009777;5445.156000819869;5446.455354464551;5459.099248623982;5367.2485851980755;5424.267723857278;5426.403095659484;5426.701531415771;5521.282233309674;4999.22512010638;5020.949790502084;5021.949780502203;5044.344235249412;5063.417706963691;4834.299026641135;4974.726390048546;4995.950040499603;5034.043531728959;5073.873153171164;4750.477447480757;4852;4893.951060489385;4898.436679781835;4919.803207871681;4970.726610036447;4971.627127965381;4981.775820088069;4985.102681517325;5028.396592408898;4799.712017278975;4945.060438516671;4960.379952505937;4970.577500912426;5031.396232452129;5183.326167598226;5228.241904923765;5277.340332458442;5286.524212820865;5317.627766056377;5922.378150294243;5922.58541902067;5935.376785437553;5941.584089113764;5941.910871336933;5699.401562835926;5898.8230353089475;5953.851153721148;5956.37458066901;5966.2840459144745;5432.972835135839;5485.917711234335;5516.14499752535;5532.612717109844;5547.362053363834;5973.701314934236;6001.579889407787;6002.6698531580305;6009.879802403927;6014.308354539196;5757.683327417032;5773.653580785166;5780.913286300624;5836.9124463133085;5871.55963302754;5729.25519682447;5908.320543137508;5911.261092363455;5975.880482390327;6034.818955431344;5757.740901659436;5782.797602083907;5788.710564471759;5798.362180160179;5807.332156801937;5797.623154494944;5804.303483581997;5806.042003069446;5812.970935145382;5816.447437493432;4390.758508282075;4514.706544074625;4523.32150177476;4531.592156705912;4557.498675145731;4049.0484736087583;4055.0673345130785;4065.1869626074904;4087.529934057562;4087.8569250076102;5676.4323567642905;5682.715864206773;5691.544676425876;5692.658440493584;5718.914216286759;5804.4195580442465;5920.141579470953;5925.881482370329;5927.2590926134235;5940.584159108821;5575.386707462176;5605.1031834907035;5614.242077319591;5617.606767526316;5674.9785038693435;5172.405173405106;5180.715060671624;5192.844214673566;5196.272521846869;5247.973760131251;5738.110592858114;5996.760129594767;5997.310309314397;6001.579889407787;6154.599951003171;5698.572607054404;5810.854728631818;5837.532997360286;5841.240638716939;5856.096235081643;6124.724387402666;6126.540509461719;6139.2325959255095;6141.170941922962;6151.6001459904965;5780.768769249183;5811.331696854747;5839.065749480063;5843.883122337615;5854.4730974212525;5706.115552089433;5746.913796293143;5775.364709881826;5794.420557944172;5951.256092988377;5655.971720141373;5717.77067930397;5718.228039214653;5737.454941780524;5854.209681692917;5644.576656750678;5684.7157642118555;5684.9431505684415;5700.629459085312;5704.914426283526;5541.058020136506;5656.151577263443;5668.37647858727;5671.064274394844;5787.102999035156;5791.884162316815;5796.1305804129715;5811.56413268998;5824.650520968586;5855.531557475477;5692.6299790513485;5700.401457846866;5700.629459085146;5721.742521586455;5724 01:35:53 INFO - 2015-11-25 01:35:53,502 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.5456003357266;593.3532449629903;605.3976293587881;611.2481647573483;619.0899377914465;39360.212795744104;40034.59965400342;40052;40052.39921401181;40126.19747605046;42802.57197428025;43595;43657;43663;43706;7675.846483070335;7793.454458187929;8795.252403545706;8982.685606003792;10153.543090560943;10354.06813386795;10461.84307235392;10485.37087774736;10488.79022419551;10495.527701253463;10525.21060920434;10571.841422378671;10593.788124237512;10617;10663.84004239937;7871.8425631487335;8064.354851611886;10643.254972151952;10823.080038196762;10841.783164336748;10325.070743633034;10366;10442.79114417715;10472.476376181161;10480.790384192349;39397.80301098476;39740.40389394161;39754.60245397538;39780;39810.40284395737;3160.0519844046694;3196.6643502432144;3220.130564747505;3238.6599407062154;3946.782926939017;29816.40367192666;29993.550096748568;30412.54381184284;30637.080887573185;31214.37571248585;3663.725220608465;3687.2994131115;3697.131174174067;3701.8952906710215;3755.1926335837925;275180;277900;280585;281025;282151;57583.71208143933;60679.69660151671;60907.39092609017;61034;61053.69473152695;53296.46703532915;70317;71168.2883171172;71767.64116179386;71789.64105179545;14901.92549037248;15113.244337783068;15123.621909452131;15165.165915874511;15231.466898658493;12024.218425802295;12101.213421127599;12152.392380380945;12152.878471215352;12156.574519891761;19813.20747170126;20120.89939550322;20182.697259541117;20204.292849750484;20221;7783.80540486481;7943.508399487658;8043.356531477468;8043.431530851428;8106.310963568045;880.5685214245102;947.8530827721714;983.5033308179324;1031.8297480915714;1034.2036631793476;28230.71769282322;28344.00795972131;28845;28850.567241491393;29015.85492072526;989.8218320702199;1018.5925629748012;1024.99487502562;1048.7378155461136;1145.541783286692;13979;14056.929715351358;14109.576712698636;14237.216953067473;14287.857121428653;246039;249377;249432;249965;249986.2515810705;51301.23048154281;52024;52147.73926130421;52151.47848521542;52173.478265216865;1341.1684755451488;1342.7650161221748;1365.9726805463836;1371.2252577293996;1377.1048818268005;25801.741982579933;26892.731072689807;27619.585706214824;31151.84424077865;31392.34992153824;48031;48526.272105919146;48585;48594.27108593303;48627.75686121688;260175;260512;260570;260829;262969;27658.44683106367;28064.158075257776;31329.373412531168;32347.35305293928;32354.35291294208;37536.2492750138;41546;41609.167816644105;42571.3614295792;42578.57421425746;34987;35736.821315893256;35763.82118089393;35801.28397432089;36215.27569448543;35967;36345.091372714836;36347.27305453929;36370.636293637785;36441.45337819882;35272.82363588166;35481.29037419289;35886.28227435489;36550.45174322334;36568.45147322739;29549.55675664824;32441;33676.49485257772;33694.8315258432;33778.8311058453;24191.274261772174;25605.487890242464;26446.603300950115;26534.60198097069;26850.59724104179 01:35:53 INFO - 2015-11-25 01:35:53,502 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.25745419710216;352.8094828792452;354.0599707775854;355.47922293839525;355.63192096180444;13932.721345573082;14090.185148317732;17148.742768858476;17437.825621743777;18122.99999999998;10859.565617375316;11105.167112466577;16174.83825161748;17461.825381746177;17484.47546573605;4883.145449546324;4987.501249875019;4997.125503036972;4999.9500004999845;5006.699598024112;3774;3872.1094148345896;4955.826546070888;5001.949980500185;5381.81163659272;5454;5480.616356855022;5484.7531861066345;5501.972490137544;5527.53015993641;5324.307839980797;5392.137258038734;5443.673379597237;5462.3445186577665;5472.1244600864065;5257.500537448975;5272.551833094191;5277.9472205278225;5278.392984806719;5284.894302113975;12973;20424.591508169753;20797.37607871766;20856.58286834255;20863.478413039644;2089.39407571804;2111.767705552388;2117.9576408471744;2118.4386137673373;2168.6530155175255;9465.763355916088;9495.90504094964;9561.330706850524;9716.951415242878;9720.07659272375;1810.2035104554086;1844.2715127524687;1850.481865077767;1860.0636885806991;1869.8223668751582;59701.40298597002;62294.68852655753;62608.68695656538;62621.99999999954;62812.68593657048;10231.232657550565;10304.742381440374;10321.329113607742;10353.948230258951;10381.273310868317;13462.394192261372;13484.730305393838;13487.123336983064;13487.393067311994;13489.527866524624;7569.1295501018085;7577;7602.42981776369;7652.273034061755;7668;7205.279472052753;7239.674214660353;7252.057232559839;7315.707371705073;7428.702851885864;4400.779961001937;4498.932516012263;4501.819927202941;4538.092381523708;4548.545145485491;1714.5199344183648;1783.4203883737837;1787.8122797106116;1804.305342443169;1844.5665268661853;837.9371547133867;907.0294784580435;940.6989763275823;950.273041123541;950.8668786369914;16222.51332460028;16584.253708583143;16622.25199866009;16943.83056169447;17057;844.8943882014748;874.4753148111082;889.5196593839254;928.3223247029706;943.3915124744639;8915.331350148765;9265.305102117369;9321.394109383004;9324.067593240621;9494.098060684224;481752;489264;499171;500846;513850;75774.48451030948;76343;76422.61788691022;77368;77494.61252693813;1109.9056580190775;1116.0513563470984;1125.926814757038;1127.616610352484;1127.8364637127734;14297.928510357382;14430.639234019234;14523.636909076935;14577.708445831237;14703.92648036753;31809.840950795096;32791.18022049468;34239.41009257298;35491.645083548836;35584;42993.355099674154;43075;43949;44460.77769611261;47374.763126184145;9409.952950235478;9560.904390956279;9655.517224138624;9655.758606034906;9788.510574471391;11509.366984815915;11510.36692981894;11585.82621260665;11707.063434925016;11715.238509496856;13588.93205533966;14051.156930584199;14066.929665351608;14364.35360408805;14482.203478808766;13490.460381584626;13759.10565813219;14011.929940350234;14152.929235353757;14177.22025288619;11227.7754444909;13376.933115334361;13977.231252281223;14471.638209044859;14928.477503287333;9286;9471.952640236756;9553.61785528571;9556.85664715016;9666;12766.808497872726;14411.92794036023;14439.422423102958;14716.77924831107;15098.773518397453 01:35:53 INFO - 2015-11-25 01:35:53,506 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1343.2746316988814;1724.2671864457611;1741.4862615528418;1768.5224989252902;1793.4888556761325;6896.103506544148;7536.510126841751;7766.495177813452;7770.0287464067;7777.572233527154;7563.281488258606;7722.111957124918;7736.149023607399;7737.845243095135;7749.186335434782;1934.5647229373349;1969.1926310212743;2207.6467765157577;2252.526969336437;2291.8510296830655;2285.4514916420108;2291.6104262275453;2295.644175152854;2298.069281940808;2306.538692261546;2212.258893270748;2278.1229226747655;2278.9544209115807;2280.4184932842104;2280.851744636602;1922.9615407691838;1960.2942940541393;2221.167062351626;2258.7402448718444;2263.162629826958;2272.4773302140434;2280.486890449652;2312.884355782221;2316.305108467453;2349.3774149850306;7670.731524396675;7744.922550774477;7758.922410775933;7763.573003484806;7774.222577742237;4630.490646028934;4703.176944034814;4724.858254252344;4733.384659994179;4736.8578942631775;3144.795588286754;3158.478850989584;3158.7473002159772;3205.7114859662743;3220.91947701307;966.7196513011219;981.9656312029116;983.9360441571275;994.9502524873727;1024.472396715692;10563.207759417997;10615.0446459819;10618.203634727426;10618.628348007782;10627.893721062768;4148.937765933453;4280.6789490788315;4314.201872653569;4322.394864718942;4334;8832.337574681796;9000.144986226298;9007.459552426744;9022.774430639156;9043.59303831329;4762.071396077731;4786.2581299898575;4796.448408433005;4813.181759100961;4814.277858321209;4316.978415107905;4365.454318210223;4373.562643735601;4377;4382.780860956939;3647.1429214135187;3665.5051568038507;3677.669009789132;3690.0590349460717;3720.720945929066;1223.6696092055095;1227.533537255855;1230.034422977958;1232.3961258983034;1236.7093732972744;1001.1340190734962;1276.5276847566274;1278.820965064873;1306.2358520265561;1317.3479127831592;6480.189976252968;7328.487005909642;7559.886601700979;7564.281393267631;7571.697132114764;580.6574121268471;587.4926687674576;590.4036922708095;611.272585623107;612.4763327355137;5672.659640421505;5761.8559536011935;5778.5377169826315;5796.275465566804;5859.44335288147;9004.36969412135;9291.07089291079;9299;9308.441493510276;9309.30180236485;9113.81772364549;9213.262938964866;9280.95359523198;9292.117248861347;9325.253979681609;7158.92841071593;7216.458765592602;7223.169335526377;7247.311505406978;7291.744788932362;6930;6981;6996.720131194898;7006.75476358325;7011.754588589375;8013.599320033858;8104.432689711899;8131.918680813353;8264.090949995616;8282.213189746964;8195.34437245007;8316.501009939422;8337.749867503984;8429.241368276884;8436.873446898424;6837.042814006142;6868.141482314711;6879.346462086094;6881.10545629065;6886.552374095668;7463.104427468521;7508.474406791473;7513.39892808585;7513.962430187814;7514.661840217313;6676.198856137295;6864.48516361265;7059.329363710439;7121.750738724119;7198.71205151788;6819.5908245505425;6856.897146542906;6871.656417179021;6951.8609627806145;7042.929570704227;6122.142899994094;6414.390632889868;6928.826779330356;7036.648167591702;7047.330503602149;6437.324080971431;6531.640759758259;6561.835954101186;6588.934110658832;6591.373819487141;6446.580972236977;6529.8694026120165;6617.43751781104;6619.702113404812;6621.271660117287 01:35:53 INFO - 2015-11-25 01:35:53,507 DEBUG : BROWSER_OUTPUT: |4;prototype.html;337.7146311366895;338.2018436489885;343.95012723155145;347.7426704238864;350.31688207994415;5947.256592925884;5975.910361344578;6003.609765365248;6007.158997740315;6008.309044459888;5868.853278668035;5909.379515150901;5922.58541902067;5923.466887980081;5935.821925342236;4597.816087356502;4599.218132917412;4602.424696912886;4608.262677971534;4631.722096674211;4542.136993971151;4597.356370108188;4625.190591646448;4633.2586786114225;4633.582977532022;4532.048269863332;4550.271956486963;4580.633549316047;4585.701929374597;4591.701539399945;4334.783260836977;4416.911661766747;4570.360149579045;4575.519570445105;4576.725396476206;3954.110325176841;3979.5423526294558;4007.83968641254;4010.4184893190322;4028.738132021409;5550.8057217997175;5592.552595792326;5601.691906945157;5607.130894711286;5611.607187496877;5050.39395272566;5172.6379153459275;5209.29674493946;5310.575153987672;5340.706261155635;6266.122742816009;6274.749010039593;6289.654069026202;6293.213348331458;6306.054091886208;4437.179121862434;4440.844570440019;4443.4445694288215;4446.488653804821;4450.4881938577155;6434.967825160844;6578.671066446706;6587;6598.769043083517;6624.470042396597;4468.3074123510905;4492.483364413134;4503.7522936238165;4504.909901801946;4506.211413002711;4525.140223357552;4546.636269098464;4552.863414097516;4557.749323787223;4560.749158796298;5286.81496147633;5287.471252874759;5289.761960711778;5296;5302.39022512416;6149.692515374213;6329;6357.96821015892;6361.968190159112;6362;1594.6093207164088;1599.8000249968754;1606.5019843848445;1606.694728001676;1607.172306262276;1061.9415932123807;1070.053003092269;1072.463768115942;1088.1349327284827;1091.5688303120223;6176.938230617726;6179.876402472015;6181.320054793969;6181.907271390933;6187.597806142587;6467.450266727286;6508.9023664645065;6512.6092434454085;6512.837179070466;6515.087887695727;6044;6116.510679145657;6163.537734669828;6164.969175154185;6179.876402471926;3509.5262139610827;3518.665726755954;3544.0608238816735;3546.131197856542;3549.893503194908;6755.020522024377;6758.189017317855;6772.2211945625895;6776.356246156706;6778.22050464193;6461.353864613595;6596;6662.633555154416;6680.331966803378;6685.39831415175;6599.307072757388;6779.593224406552;6791.796246112624;6812.965935170391;6826.180858296937;6488.805335839932;6535.150430444012;6545.181852268466;6551.541392102507;6551.574147680385;6344.746210151542;6482.319356467503;6485.481161506974;6500.967495162683;6503.934960650522;6804.55770374924;6806.65966701653;6812.965935170292;6813.523053386215;6814.2163651180745;4467.463904331501;4476.485204201558;4478.440194975628;4480.462344518679;4482.977585112054;6395.488360931207;6544.901826472512;6556.934430655632;6560.147180866456;6560.507961902781;6363.268224154282;6375.298717141018;6383.36166383358;6388.776392826228;6388.968055159695;6357.745690172342;6361.395667411589;6364.140840986408;6372.299047104722;6374.808755737336;6091.543134264859;6248.750049998131;6255.31191568918;6256.343083976299;6281.277653069956;6429.453496452854;6429.6142231466265;6431.035344698145;6439.903401448888;6441.613503189824;6275.246970363585;6284.748610055546;6286.497080233662;6288.496920246461;6289.591176573508 01:35:53 INFO - 2015-11-25 01:35:53,508 DEBUG : BROWSER_OUTPUT: |5;yui.html;744.6686224630039;850.2008112374372;851.8551846186148;864.4553931023456;884.2086332732201;13562.457501699933;13914;13927.582172534814;13956;13964.162150270991;13204.471821127167;13224.53714120006;13293.202407855511;13295.534656287033;14531.200783956878;825.7729124490768;847.7160151349275;852.9744107676748;853.2235665544356;854.0221446443818;853.0232883348563;858.2233079063426;859.4757198109148;859.4757198109148;860.2472836268265;887.7248053103526;894.0344428017726;894.4275663575316;894.4633220067972;894.6645008121955;886.4415418286503;887.662688178488;887.8135591525755;890.973270801877;893.3523195683143;649.3376755709197;652.0642877470844;655.1483072006421;655.639398330916;657.6678777217475;14251.714965700628;14305;14331.78502322466;14376.568702938928;14400.06399584034;12517.12380133391;12795.296258705768;12887.16233444823;12947.87052129476;13093.41079651418;9607.087326703951;9658;9961.203103751683;10059.39643621385;10139.898601014043;3626.6192049834917;3645.7994810285422;3668.137987572918;3733.104055026774;3751.3997760358484;41849.79075104605;42269.94325141896;45302.32046519305;45990.080198395844;49455.50544494545;10381.532831022621;10402.531886065146;10584.523696433525;10641.574337026432;10693.358398496115;18622.627547448974;18669.533261668566;18677.346292879683;18677.533061673566;18703;7441.181470038291;7821.569813660303;7937.603119843985;7960.880586791202;8262.586870656443;4251.277282861921;4262.083652014831;4282.48610166782;4322;4354.651627869763;3135.0908236611585;3142.0573827851554;3153.8265395403473;3160.352127813793;3160.383725173615;580.494969376645;587.49475451112;587.8412828536271;598.141666708275;600.639616230267;537.7338217582321;607.9361667024899;615.3538784276492;620.2587907450643;632.8987362022054;7599.848003039909;7625.618719064025;7754.457187996786;7982.960085199653;8116.107228204893;488.62131847817517;539.099703495164;572.8711040015963;582.8134996801068;631.2866460899246;3745.269672413853;3762.4168253920684;3902.590228026073;3944.2111577684577;3983;59022.704886475294;59716;59738.70130649406;59765.402345975985;59916.70041649851;52762.47237527652;52875.20687189695;52953.763698904;53743.46256537385;53940;41306;41475.1704965905;42743.57256427458;47981.76009120002;48101;8042.638081286474;8150.633221504928;8304.58477076156;8616.569171541523;8733.563321833755;34443;34519.30961380708;35135.47296790499;37104.25791484209;37196.07009824776;41822.37266440945;42074.1585168301;44568.33147502855;45302.54697452983;48497;10666.253362264568;10694.62568810088;11299.887001129884;11477.942610286895;11606.709832253924;11185.72035699114;11305.095592352427;11363.602273920373;11486.081113511067;11891.345975971059;10356.896431035895;10590.735231618963;10859.131269498263;10864.293820901616;11178.944105279747;10587.735306617396;10767.461626918466;11108.389038602954;11290.830637540608;11608.883911161118;10709.518071686949;10827.40449275266;10934.070603998749;10973;11301.886981130083;9278.396904201205;9432.622695092394;9556;9689.224862011164;9815.067568580973;8965.686200982935;9055.592498337723;9209.21721653667;9450.952745236506;9514.476703781358 01:35:53 INFO - 2015-11-25 01:35:53,509 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:35:53 INFO - 2015-11-25 01:35:53,509 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:35:53 INFO - 2015-11-25 01:35:53,509 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,898 01:35:53 INFO - 2015-11-25 01:35:53,509 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:35:53 INFO - 2015-11-25 01:35:53,509 DEBUG : BROWSER_OUTPUT: __startTimestamp1448444153495__endTimestamp 01:35:53 INFO - 2015-11-25 01:35:53,509 DEBUG : BROWSER_OUTPUT: 01:35:53 INFO - 2015-11-25 01:35:53,509 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:35:53 INFO - 2015-11-25 01:35:53,509 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:35:53 INFO - 2015-11-25 01:35:53,509 DEBUG : BROWSER_OUTPUT: 01:35:53 INFO - 2015-11-25 01:35:53,510 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5453.08 Median:5692.66 stddev:608.98 (10.7%) stddev-sans-first:584.40 01:35:53 INFO - 2015-11-25 01:35:53,510 DEBUG : BROWSER_OUTPUT: Values: 3189.8 3238.1 3272.5 3281.1 3294.5 5320.4 5435.7 5445.2 5446.5 5459.1 5367.2 5424.3 5426.4 5426.7 5521.3 4999.2 5020.9 5021.9 5044.3 5063.4 4834.3 4974.7 4996.0 5034.0 5073.9 4750.5 4852.0 4894.0 4898.4 4919.8 4970.7 4971.6 4981.8 4985.1 5028.4 4799.7 4945.1 4960.4 4970.6 5031.4 5183.3 5228.2 5277.3 5286.5 5317.6 5922.4 5922.6 5935.4 5941.6 5941.9 5699.4 5898.8 5953.9 5956.4 5966.3 5433.0 5485.9 5516.1 5532.6 5547.4 5973.7 6001.6 6002.7 6009.9 6014.3 5757.7 5773.7 5780.9 5836.9 5871.6 5729.3 5908.3 5911.3 5975.9 6034.8 5757.7 5782.8 5788.7 5798.4 5807.3 5797.6 5804.3 5806.0 5813.0 5816.4 4390.8 4514.7 4523.3 4531.6 4557.5 4049.0 4055.1 4065.2 4087.5 4087.9 5676.4 5682.7 5691.5 5692.7 5718.9 5804.4 5920.1 5925.9 5927.3 5940.6 5575.4 5605.1 5614.2 5617.6 5675.0 5172.4 5180.7 5192.8 5196.3 5248.0 5738.1 5996.8 5997.3 6001.6 6154.6 5698.6 5810.9 5837.5 5841.2 5856.1 6124.7 6126.5 6139.2 6141.2 6151.6 5780.8 5811.3 5839.1 5843.9 5854.5 5706.1 5746.9 5775.4 5794.4 5951.3 5656.0 5717.8 5718.2 5737.5 5854.2 5644.6 5684.7 5684.9 5700.6 5704.9 5541.1 5656.2 5668.4 5671.1 5787.1 5791.9 5796.1 5811.6 5824.7 5855.5 5692.6 5700.4 5700.6 5721.7 5724.0 01:35:53 INFO - 2015-11-25 01:35:53,510 DEBUG : BROWSER_OUTPUT: 01:35:53 INFO - 2015-11-25 01:35:53,510 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44353.93 Median:3208.40 stddev:68525.20 (2135.8%) stddev-sans-first:68638.53 01:35:53 INFO - 2015-11-25 01:35:53,511 DEBUG : BROWSER_OUTPUT: Values: 557.5 593.4 605.4 611.2 619.1 39360.2 40034.6 40052.0 40052.4 40126.2 42802.6 43595.0 43657.0 43663.0 43706.0 7675.8 7793.5 8795.3 8982.7 10153.5 10354.1 10461.8 10485.4 10488.8 10495.5 10525.2 10571.8 10593.8 10617.0 10663.8 7871.8 8064.4 10643.3 10823.1 10841.8 10325.1 10366.0 10442.8 10472.5 10480.8 39397.8 39740.4 39754.6 39780.0 39810.4 3160.1 3196.7 3220.1 3238.7 3946.8 29816.4 29993.6 30412.5 30637.1 31214.4 3663.7 3687.3 3697.1 3701.9 3755.2 275180.0 277900.0 280585.0 281025.0 282151.0 57583.7 60679.7 60907.4 61034.0 61053.7 53296.5 70317.0 71168.3 71767.6 71789.6 14901.9 15113.2 15123.6 15165.2 15231.5 12024.2 12101.2 12152.4 12152.9 12156.6 19813.2 20120.9 20182.7 20204.3 20221.0 7783.8 7943.5 8043.4 8043.4 8106.3 880.6 947.9 983.5 1031.8 1034.2 28230.7 28344.0 28845.0 28850.6 29015.9 989.8 1018.6 1025.0 1048.7 1145.5 13979.0 14056.9 14109.6 14237.2 14287.9 246039.0 249377.0 249432.0 249965.0 249986.3 51301.2 52024.0 52147.7 52151.5 52173.5 1341.2 1342.8 1366.0 1371.2 1377.1 25801.7 26892.7 27619.6 31151.8 31392.3 48031.0 48526.3 48585.0 48594.3 48627.8 260175.0 260512.0 260570.0 260829.0 262969.0 27658.4 28064.2 31329.4 32347.4 32354.4 37536.2 41546.0 41609.2 42571.4 42578.6 34987.0 35736.8 35763.8 35801.3 36215.3 35967.0 36345.1 36347.3 36370.6 36441.5 35272.8 35481.3 35886.3 36550.5 36568.5 29549.6 32441.0 33676.5 33694.8 33778.8 24191.3 25605.5 26446.6 26534.6 26850.6 01:35:53 INFO - 2015-11-25 01:35:53,511 DEBUG : BROWSER_OUTPUT: 01:35:53 INFO - 2015-11-25 01:35:53,512 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27184.78 Median:3823.05 stddev:81287.77 (2126.3%) stddev-sans-first:81490.83 01:35:53 INFO - 2015-11-25 01:35:53,512 DEBUG : BROWSER_OUTPUT: Values: 350.3 352.8 354.1 355.5 355.6 13932.7 14090.2 17148.7 17437.8 18123.0 10859.6 11105.2 16174.8 17461.8 17484.5 4883.1 4987.5 4997.1 5000.0 5006.7 3774.0 3872.1 4955.8 5001.9 5381.8 5454.0 5480.6 5484.8 5502.0 5527.5 5324.3 5392.1 5443.7 5462.3 5472.1 5257.5 5272.6 5277.9 5278.4 5284.9 12973.0 20424.6 20797.4 20856.6 20863.5 2089.4 2111.8 2118.0 2118.4 2168.7 9465.8 9495.9 9561.3 9717.0 9720.1 1810.2 1844.3 1850.5 1860.1 1869.8 59701.4 62294.7 62608.7 62622.0 62812.7 10231.2 10304.7 10321.3 10353.9 10381.3 13462.4 13484.7 13487.1 13487.4 13489.5 7569.1 7577.0 7602.4 7652.3 7668.0 7205.3 7239.7 7252.1 7315.7 7428.7 4400.8 4498.9 4501.8 4538.1 4548.5 1714.5 1783.4 1787.8 1804.3 1844.6 837.9 907.0 940.7 950.3 950.9 16222.5 16584.3 16622.3 16943.8 17057.0 844.9 874.5 889.5 928.3 943.4 8915.3 9265.3 9321.4 9324.1 9494.1 481752.0 489264.0 499171.0 500846.0 513850.0 75774.5 76343.0 76422.6 77368.0 77494.6 1109.9 1116.1 1125.9 1127.6 1127.8 14297.9 14430.6 14523.6 14577.7 14703.9 31809.8 32791.2 34239.4 35491.6 35584.0 42993.4 43075.0 43949.0 44460.8 47374.8 9410.0 9560.9 9655.5 9655.8 9788.5 11509.4 11510.4 11585.8 11707.1 11715.2 13588.9 14051.2 14066.9 14364.4 14482.2 13490.5 13759.1 14011.9 14152.9 14177.2 11227.8 13376.9 13977.2 14471.6 14928.5 9286.0 9472.0 9553.6 9556.9 9666.0 12766.8 14411.9 14439.4 14716.8 15098.8 01:35:53 INFO - 2015-11-25 01:35:53,512 DEBUG : BROWSER_OUTPUT: 01:35:53 INFO - 2015-11-25 01:35:53,512 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5411.07 Median:6505.03 stddev:2795.72 (43.0%) stddev-sans-first:2786.84 01:35:53 INFO - 2015-11-25 01:35:53,512 DEBUG : BROWSER_OUTPUT: Values: 1343.3 1724.3 1741.5 1768.5 1793.5 6896.1 7536.5 7766.5 7770.0 7777.6 7563.3 7722.1 7736.1 7737.8 7749.2 1934.6 1969.2 2207.6 2252.5 2291.9 2285.5 2291.6 2295.6 2298.1 2306.5 2212.3 2278.1 2279.0 2280.4 2280.9 1923.0 1960.3 2221.2 2258.7 2263.2 2272.5 2280.5 2312.9 2316.3 2349.4 7670.7 7744.9 7758.9 7763.6 7774.2 4630.5 4703.2 4724.9 4733.4 4736.9 3144.8 3158.5 3158.7 3205.7 3220.9 966.7 982.0 983.9 995.0 1024.5 10563.2 10615.0 10618.2 10618.6 10627.9 4148.9 4280.7 4314.2 4322.4 4334.0 8832.3 9000.1 9007.5 9022.8 9043.6 4762.1 4786.3 4796.4 4813.2 4814.3 4317.0 4365.5 4373.6 4377.0 4382.8 3647.1 3665.5 3677.7 3690.1 3720.7 1223.7 1227.5 1230.0 1232.4 1236.7 1001.1 1276.5 1278.8 1306.2 1317.3 6480.2 7328.5 7559.9 7564.3 7571.7 580.7 587.5 590.4 611.3 612.5 5672.7 5761.9 5778.5 5796.3 5859.4 9004.4 9291.1 9299.0 9308.4 9309.3 9113.8 9213.3 9281.0 9292.1 9325.3 7158.9 7216.5 7223.2 7247.3 7291.7 6930.0 6981.0 6996.7 7006.8 7011.8 8013.6 8104.4 8131.9 8264.1 8282.2 8195.3 8316.5 8337.7 8429.2 8436.9 6837.0 6868.1 6879.3 6881.1 6886.6 7463.1 7508.5 7513.4 7514.0 7514.7 6676.2 6864.5 7059.3 7121.8 7198.7 6819.6 6856.9 6871.7 6951.9 7042.9 6122.1 6414.4 6928.8 7036.6 7047.3 6437.3 6531.6 6561.8 6588.9 6591.4 6446.6 6529.9 6617.4 6619.7 6621.3 01:35:53 INFO - 2015-11-25 01:35:53,513 DEBUG : BROWSER_OUTPUT: 01:35:53 INFO - 2015-11-25 01:35:53,514 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5304.16 Median:6067.77 stddev:1596.80 (26.3%) stddev-sans-first:1557.17 01:35:53 INFO - 2015-11-25 01:35:53,514 DEBUG : BROWSER_OUTPUT: Values: 337.7 338.2 344.0 347.7 350.3 5947.3 5975.9 6003.6 6007.2 6008.3 5868.9 5909.4 5922.6 5923.5 5935.8 4597.8 4599.2 4602.4 4608.3 4631.7 4542.1 4597.4 4625.2 4633.3 4633.6 4532.0 4550.3 4580.6 4585.7 4591.7 4334.8 4416.9 4570.4 4575.5 4576.7 3954.1 3979.5 4007.8 4010.4 4028.7 5550.8 5592.6 5601.7 5607.1 5611.6 5050.4 5172.6 5209.3 5310.6 5340.7 6266.1 6274.7 6289.7 6293.2 6306.1 4437.2 4440.8 4443.4 4446.5 4450.5 6435.0 6578.7 6587.0 6598.8 6624.5 4468.3 4492.5 4503.8 4504.9 4506.2 4525.1 4546.6 4552.9 4557.7 4560.7 5286.8 5287.5 5289.8 5296.0 5302.4 6149.7 6329.0 6358.0 6362.0 6362.0 1594.6 1599.8 1606.5 1606.7 1607.2 1061.9 1070.1 1072.5 1088.1 1091.6 6176.9 6179.9 6181.3 6181.9 6187.6 6467.5 6508.9 6512.6 6512.8 6515.1 6044.0 6116.5 6163.5 6165.0 6179.9 3509.5 3518.7 3544.1 3546.1 3549.9 6755.0 6758.2 6772.2 6776.4 6778.2 6461.4 6596.0 6662.6 6680.3 6685.4 6599.3 6779.6 6791.8 6813.0 6826.2 6488.8 6535.2 6545.2 6551.5 6551.6 6344.7 6482.3 6485.5 6501.0 6503.9 6804.6 6806.7 6813.0 6813.5 6814.2 4467.5 4476.5 4478.4 4480.5 4483.0 6395.5 6544.9 6556.9 6560.1 6560.5 6363.3 6375.3 6383.4 6388.8 6389.0 6357.7 6361.4 6364.1 6372.3 6374.8 6091.5 6248.8 6255.3 6256.3 6281.3 6429.5 6429.6 6431.0 6439.9 6441.6 6275.2 6284.7 6286.5 6288.5 6289.6 01:35:53 INFO - 2015-11-25 01:35:53,515 DEBUG : BROWSER_OUTPUT: 01:35:53 INFO - 2015-11-25 01:35:53,515 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13776.42 Median:45302.43 stddev:16004.78 (35.3%) stddev-sans-first:16019.76 01:35:53 INFO - 2015-11-25 01:35:53,516 DEBUG : BROWSER_OUTPUT: Values: 744.7 850.2 851.9 864.5 884.2 13562.5 13914.0 13927.6 13956.0 13964.2 13204.5 13224.5 13293.2 13295.5 14531.2 825.8 847.7 853.0 853.2 854.0 853.0 858.2 859.5 859.5 860.2 887.7 894.0 894.4 894.5 894.7 886.4 887.7 887.8 891.0 893.4 649.3 652.1 655.1 655.6 657.7 14251.7 14305.0 14331.8 14376.6 14400.1 12517.1 12795.3 12887.2 12947.9 13093.4 9607.1 9658.0 9961.2 10059.4 10139.9 3626.6 3645.8 3668.1 3733.1 3751.4 41849.8 42269.9 45302.3 45990.1 49455.5 10381.5 10402.5 10584.5 10641.6 10693.4 18622.6 18669.5 18677.3 18677.5 18703.0 7441.2 7821.6 7937.6 7960.9 8262.6 4251.3 4262.1 4282.5 4322.0 4354.7 3135.1 3142.1 3153.8 3160.4 3160.4 580.5 587.5 587.8 598.1 600.6 537.7 607.9 615.4 620.3 632.9 7599.8 7625.6 7754.5 7983.0 8116.1 488.6 539.1 572.9 582.8 631.3 3745.3 3762.4 3902.6 3944.2 3983.0 59022.7 59716.0 59738.7 59765.4 59916.7 52762.5 52875.2 52953.8 53743.5 53940.0 41306.0 41475.2 42743.6 47981.8 48101.0 8042.6 8150.6 8304.6 8616.6 8733.6 34443.0 34519.3 35135.5 37104.3 37196.1 41822.4 42074.2 44568.3 45302.5 48497.0 10666.3 10694.6 11299.9 11477.9 11606.7 11185.7 11305.1 11363.6 11486.1 11891.3 10356.9 10590.7 10859.1 10864.3 11178.9 10587.7 10767.5 11108.4 11290.8 11608.9 10709.5 10827.4 10934.1 10973.0 11301.9 9278.4 9432.6 9556.0 9689.2 9815.1 8965.7 9055.6 9209.2 9451.0 9514.5 01:35:53 INFO - 2015-11-25 01:35:53,516 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:35:53 INFO - 2015-11-25 01:35:53,516 DEBUG : BROWSER_OUTPUT: 01:35:54 INFO - 2015-11-25 01:35:54,180 INFO : Browser exited with error code: 0 01:35:54 INFO - 2015-11-25 01:35:54,199 INFO : Completed test dromaeo_css (00:18:35) 01:35:54 INFO - 2015-11-25 01:35:54,199 INFO : Starting test kraken 01:35:54 INFO - 2015-11-25 01:35:54,199 DEBUG : operating with platform_type : linux_ 01:35:54 INFO - 2015-11-25 01:35:54,199 INFO : Initialising browser for kraken test... 01:35:54 INFO - 2015-11-25 01:35:54,205 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPL42S_/profile http://localhost:40511/getInfo.html 01:35:57 INFO - 2015-11-25 01:35:57,911 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:35:57 INFO - 2015-11-25 01:35:57,911 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:35:57 INFO - 2015-11-25 01:35:57,911 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:35:57 INFO - 2015-11-25 01:35:57,911 DEBUG : BROWSER_OUTPUT: __metrics 01:35:58 INFO - 2015-11-25 01:35:58,048 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] 01:35:59 INFO - 2015-11-25 01:35:59,126 INFO : Browser initialized. 01:35:59 INFO - 2015-11-25 01:35:59,126 INFO : Running cycle 1/1 for kraken test... 01:35:59 INFO - 2015-11-25 01:35:59,126 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPL42S_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:36:10 INFO - 2015-11-25 01:36:10,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 139243520 01:36:10 INFO - 2015-11-25 01:36:10,824 DEBUG : BROWSER_OUTPUT: 01:36:13 INFO - 2015-11-25 01:36:13,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40511/tests/kraken/driver.html?testName=audio-beat-detection) 01:36:13 INFO - 2015-11-25 01:36:13,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 177881088 01:36:13 INFO - 2015-11-25 01:36:13,872 DEBUG : BROWSER_OUTPUT: 01:36:16 INFO - 2015-11-25 01:36:16,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40511/tests/kraken/driver.html?testName=audio-dft) 01:36:17 INFO - 2015-11-25 01:36:17,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 165699584 01:36:17 INFO - 2015-11-25 01:36:17,023 DEBUG : BROWSER_OUTPUT: 01:36:19 INFO - 2015-11-25 01:36:19,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40511/tests/kraken/driver.html?testName=audio-fft) 01:36:20 INFO - 2015-11-25 01:36:20,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 149569536 01:36:20 INFO - 2015-11-25 01:36:20,475 DEBUG : BROWSER_OUTPUT: 01:36:22 INFO - 2015-11-25 01:36:22,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40511/tests/kraken/driver.html?testName=audio-oscillator) 01:36:23 INFO - 2015-11-25 01:36:23,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 151617536 01:36:23 INFO - 2015-11-25 01:36:23,021 DEBUG : BROWSER_OUTPUT: 01:36:25 INFO - 2015-11-25 01:36:25,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40511/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:36:25 INFO - 2015-11-25 01:36:25,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 153427968 01:36:25 INFO - 2015-11-25 01:36:25,802 DEBUG : BROWSER_OUTPUT: 01:36:28 INFO - 2015-11-25 01:36:28,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40511/tests/kraken/driver.html?testName=imaging-darkroom) 01:36:29 INFO - 2015-11-25 01:36:29,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 155131904 01:36:29 INFO - 2015-11-25 01:36:29,244 DEBUG : BROWSER_OUTPUT: 01:36:32 INFO - 2015-11-25 01:36:32,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40511/tests/kraken/driver.html?testName=imaging-desaturate) 01:36:33 INFO - 2015-11-25 01:36:33,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 155447296 01:36:33 INFO - 2015-11-25 01:36:33,201 DEBUG : BROWSER_OUTPUT: 01:36:35 INFO - 2015-11-25 01:36:35,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40511/tests/kraken/driver.html?testName=json-parse-financial) 01:36:36 INFO - 2015-11-25 01:36:36,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 154681344 01:36:36 INFO - 2015-11-25 01:36:36,565 DEBUG : BROWSER_OUTPUT: 01:36:38 INFO - 2015-11-25 01:36:38,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40511/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:36:38 INFO - 2015-11-25 01:36:38,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 165785600 01:36:38 INFO - 2015-11-25 01:36:38,677 DEBUG : BROWSER_OUTPUT: 01:36:40 INFO - 2015-11-25 01:36:40,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:36:41 INFO - 2015-11-25 01:36:41,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 165339136 01:36:41 INFO - 2015-11-25 01:36:41,085 DEBUG : BROWSER_OUTPUT: 01:36:43 INFO - 2015-11-25 01:36:43,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:36:43 INFO - 2015-11-25 01:36:43,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 170856448 01:36:43 INFO - 2015-11-25 01:36:43,704 DEBUG : BROWSER_OUTPUT: 01:36:46 INFO - 2015-11-25 01:36:46,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:36:46 INFO - 2015-11-25 01:36:46,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 178012160 01:36:46 INFO - 2015-11-25 01:36:46,954 DEBUG : BROWSER_OUTPUT: 01:36:49 INFO - 2015-11-25 01:36:49,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:36:50 INFO - 2015-11-25 01:36:50,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 175472640 01:36:50 INFO - 2015-11-25 01:36:50,064 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40511/tests/kraken/driver.html?testName=ai-astar) 01:36:51 INFO - 2015-11-25 01:36:51,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 233414656 01:36:51 INFO - 2015-11-25 01:36:51,956 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,956 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:36:51 INFO - 2015-11-25 01:36:51,956 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:36:51 INFO - 2015-11-25 01:36:51,956 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:36:51 INFO - 2015-11-25 01:36:51,956 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:36:51 INFO - 2015-11-25 01:36:51,956 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;108;103;109;113;109;101;109;109;101 01:36:51 INFO - 2015-11-25 01:36:51,956 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;124;147;161;127;156;146;124;163;127 01:36:51 INFO - 2015-11-25 01:36:51,956 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;160;161;160;161;162;161;161 01:36:51 INFO - 2015-11-25 01:36:51,957 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;80;98;71;72;70;104;98;72 01:36:51 INFO - 2015-11-25 01:36:51,957 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;148;92;95;93;137;93;95;140 01:36:51 INFO - 2015-11-25 01:36:51,957 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;109;109;110;109;109 01:36:51 INFO - 2015-11-25 01:36:51,957 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;146;145;145;146;146;145;149 01:36:51 INFO - 2015-11-25 01:36:51,957 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;96;97;96;96;96;95;96;96 01:36:51 INFO - 2015-11-25 01:36:51,957 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;57;57;57;58;57;59;62;55 01:36:51 INFO - 2015-11-25 01:36:51,957 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;71;71;72;70;70;69;70 01:36:51 INFO - 2015-11-25 01:36:51,958 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;85;84;85;84;84;85;86;85 01:36:51 INFO - 2015-11-25 01:36:51,958 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;128;114;115;121;115;122;123;116;115 01:36:51 INFO - 2015-11-25 01:36:51,958 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;148;149;153;148;140;150;148;146;139 01:36:51 INFO - 2015-11-25 01:36:51,958 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;67;66;68;66;66;67;65;66 01:36:51 INFO - 2015-11-25 01:36:51,958 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:36:51 INFO - 2015-11-25 01:36:51,959 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:36:51 INFO - 2015-11-25 01:36:51,959 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,934 01:36:51 INFO - 2015-11-25 01:36:51,959 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:36:51 INFO - 2015-11-25 01:36:51,959 DEBUG : BROWSER_OUTPUT: __startTimestamp1448444211950__endTimestamp 01:36:51 INFO - 2015-11-25 01:36:51,959 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,960 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:36:51 INFO - 2015-11-25 01:36:51,960 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:36:51 INFO - 2015-11-25 01:36:51,960 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,960 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.00 Median:109.00 stddev:3.97 (3.6%) stddev-sans-first:4.20 01:36:51 INFO - 2015-11-25 01:36:51,960 DEBUG : BROWSER_OUTPUT: Values: 108.0 108.0 103.0 109.0 113.0 109.0 101.0 109.0 109.0 101.0 01:36:51 INFO - 2015-11-25 01:36:51,960 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,960 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.40 Median:148.00 stddev:15.58 (10.5%) stddev-sans-first:16.34 01:36:51 INFO - 2015-11-25 01:36:51,960 DEBUG : BROWSER_OUTPUT: Values: 149.0 124.0 147.0 161.0 127.0 156.0 146.0 124.0 163.0 127.0 01:36:51 INFO - 2015-11-25 01:36:51,960 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,960 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 01:36:51 INFO - 2015-11-25 01:36:51,961 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 160.0 161.0 160.0 161.0 162.0 161.0 161.0 01:36:51 INFO - 2015-11-25 01:36:51,961 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,961 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:72.00 stddev:13.63 (18.9%) stddev-sans-first:13.99 01:36:51 INFO - 2015-11-25 01:36:51,961 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 80.0 98.0 71.0 72.0 70.0 104.0 98.0 72.0 01:36:51 INFO - 2015-11-25 01:36:51,961 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,962 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.00 Median:93.00 stddev:23.40 (25.2%) stddev-sans-first:24.19 01:36:51 INFO - 2015-11-25 01:36:51,962 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 148.0 92.0 95.0 93.0 137.0 93.0 95.0 140.0 01:36:51 INFO - 2015-11-25 01:36:51,962 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,962 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:36:51 INFO - 2015-11-25 01:36:51,962 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 01:36:51 INFO - 2015-11-25 01:36:51,962 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,962 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 01:36:51 INFO - 2015-11-25 01:36:51,963 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 149.0 01:36:51 INFO - 2015-11-25 01:36:51,963 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,963 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 01:36:51 INFO - 2015-11-25 01:36:51,963 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 96.0 97.0 96.0 96.0 96.0 95.0 96.0 96.0 01:36:51 INFO - 2015-11-25 01:36:51,963 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,963 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:1.81 (3.1%) stddev-sans-first:1.92 01:36:51 INFO - 2015-11-25 01:36:51,963 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 57.0 57.0 57.0 58.0 57.0 59.0 62.0 55.0 01:36:51 INFO - 2015-11-25 01:36:51,963 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,963 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:0.99 (1.4%) stddev-sans-first:0.97 01:36:51 INFO - 2015-11-25 01:36:51,963 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 71.0 71.0 72.0 70.0 70.0 69.0 70.0 01:36:51 INFO - 2015-11-25 01:36:51,963 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,963 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.00 stddev:1.16 (1.4%) stddev-sans-first:0.88 01:36:51 INFO - 2015-11-25 01:36:51,964 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 85.0 84.0 85.0 84.0 84.0 85.0 86.0 85.0 01:36:51 INFO - 2015-11-25 01:36:51,964 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,964 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:119.50 stddev:4.62 (3.9%) stddev-sans-first:4.89 01:36:51 INFO - 2015-11-25 01:36:51,964 DEBUG : BROWSER_OUTPUT: Values: 118.0 128.0 114.0 115.0 121.0 115.0 122.0 123.0 116.0 115.0 01:36:51 INFO - 2015-11-25 01:36:51,964 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,964 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:148.00 stddev:4.79 (3.2%) stddev-sans-first:4.55 01:36:51 INFO - 2015-11-25 01:36:51,964 DEBUG : BROWSER_OUTPUT: Values: 140.0 148.0 149.0 153.0 148.0 140.0 150.0 148.0 146.0 139.0 01:36:51 INFO - 2015-11-25 01:36:51,964 DEBUG : BROWSER_OUTPUT: 01:36:51 INFO - 2015-11-25 01:36:51,964 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 01:36:51 INFO - 2015-11-25 01:36:51,964 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 67.0 66.0 68.0 66.0 66.0 67.0 65.0 66.0 01:36:51 INFO - 2015-11-25 01:36:51,964 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:36:51 INFO - 2015-11-25 01:36:51,964 DEBUG : BROWSER_OUTPUT: 01:36:52 INFO - 2015-11-25 01:36:52,736 INFO : Browser exited with error code: 0 01:36:52 INFO - 2015-11-25 01:36:52,787 INFO : Completed test kraken (00:00:58) 01:36:52 INFO - 2015-11-25 01:36:52,787 INFO : Starting test v8_7 01:36:52 INFO - 2015-11-25 01:36:52,787 DEBUG : operating with platform_type : linux_ 01:36:52 INFO - 2015-11-25 01:36:52,787 INFO : Initialising browser for v8_7 test... 01:36:52 INFO - 2015-11-25 01:36:52,793 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplBt2QT/profile http://localhost:40511/getInfo.html 01:36:56 INFO - 2015-11-25 01:36:56,247 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:36:56 INFO - 2015-11-25 01:36:56,247 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:36:56 INFO - 2015-11-25 01:36:56,247 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:36:56 INFO - 2015-11-25 01:36:56,247 DEBUG : BROWSER_OUTPUT: __metrics 01:36:56 INFO - 2015-11-25 01:36:56,328 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] 01:36:57 INFO - 2015-11-25 01:36:57,514 INFO : Browser initialized. 01:36:57 INFO - 2015-11-25 01:36:57,514 INFO : Running cycle 1/1 for v8_7 test... 01:36:57 INFO - 2015-11-25 01:36:57,515 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplBt2QT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:37:09 INFO - 2015-11-25 01:37:09,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 139763712 01:37:09 INFO - 2015-11-25 01:37:09,272 DEBUG : BROWSER_OUTPUT: 01:37:30 INFO - 2015-11-25 01:37:30,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40511/tests/v8_7/run.html (next: http://localhost:40511/tests/v8_7/run.html) 01:37:30 INFO - 2015-11-25 01:37:30,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 611254272 01:37:30 INFO - 2015-11-25 01:37:30,922 DEBUG : BROWSER_OUTPUT: 01:37:30 INFO - 2015-11-25 01:37:30,922 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:37:30 INFO - 2015-11-25 01:37:30,922 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:37:30 INFO - 2015-11-25 01:37:30,922 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:37:30 INFO - 2015-11-25 01:37:30,922 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:37:30 INFO - 2015-11-25 01:37:30,922 DEBUG : BROWSER_OUTPUT: |0;Richards;164.7175094712568 01:37:30 INFO - 2015-11-25 01:37:30,923 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.21246844047388 01:37:30 INFO - 2015-11-25 01:37:30,923 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.36639274582035 01:37:30 INFO - 2015-11-25 01:37:30,923 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 01:37:30 INFO - 2015-11-25 01:37:30,923 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1116.0714285714287 01:37:30 INFO - 2015-11-25 01:37:30,923 DEBUG : BROWSER_OUTPUT: |5;Earley;785.5459544383347 01:37:30 INFO - 2015-11-25 01:37:30,924 DEBUG : BROWSER_OUTPUT: |6;Boyer;12243.90243902439 01:37:30 INFO - 2015-11-25 01:37:30,924 DEBUG : BROWSER_OUTPUT: |7;RegExp;25794.871794871793 01:37:30 INFO - 2015-11-25 01:37:30,924 DEBUG : BROWSER_OUTPUT: |8;Splay;623.0529595015577 01:37:30 INFO - 2015-11-25 01:37:30,924 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 01:37:30 INFO - 2015-11-25 01:37:30,924 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:37:30 INFO - 2015-11-25 01:37:30,924 DEBUG : BROWSER_OUTPUT: __startTimestamp1448444250921__endTimestamp 01:37:30 INFO - 2015-11-25 01:37:30,924 DEBUG : BROWSER_OUTPUT: 01:37:30 INFO - 2015-11-25 01:37:30,924 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:37:30 INFO - 2015-11-25 01:37:30,924 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:37:30 INFO - 2015-11-25 01:37:30,924 DEBUG : BROWSER_OUTPUT: 01:37:30 INFO - 2015-11-25 01:37:30,924 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.72 Median:164.72 stddev:0.00 (0.0%) 01:37:30 INFO - 2015-11-25 01:37:30,924 DEBUG : BROWSER_OUTPUT: Values: 164.7 01:37:30 INFO - 2015-11-25 01:37:30,925 DEBUG : BROWSER_OUTPUT: 01:37:30 INFO - 2015-11-25 01:37:30,926 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.21 Median:194.21 stddev:0.00 (0.0%) 01:37:30 INFO - 2015-11-25 01:37:30,926 DEBUG : BROWSER_OUTPUT: Values: 194.2 01:37:30 INFO - 2015-11-25 01:37:30,926 DEBUG : BROWSER_OUTPUT: 01:37:30 INFO - 2015-11-25 01:37:30,926 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.37 Median:283.37 stddev:0.00 (0.0%) 01:37:30 INFO - 2015-11-25 01:37:30,926 DEBUG : BROWSER_OUTPUT: Values: 283.4 01:37:30 INFO - 2015-11-25 01:37:30,926 DEBUG : BROWSER_OUTPUT: 01:37:30 INFO - 2015-11-25 01:37:30,926 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 01:37:30 INFO - 2015-11-25 01:37:30,926 DEBUG : BROWSER_OUTPUT: Values: 5133.3 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1116.07 Median:1116.07 stddev:0.00 (0.0%) 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: Values: 1116.1 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:785.55 Median:785.55 stddev:0.00 (0.0%) 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: Values: 785.5 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: Values: 12243.9 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25794.87 Median:25794.87 stddev:0.00 (0.0%) 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: Values: 25794.9 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: 01:37:30 INFO - 2015-11-25 01:37:30,927 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:623.05 Median:623.05 stddev:0.00 (0.0%) 01:37:30 INFO - 2015-11-25 01:37:30,928 DEBUG : BROWSER_OUTPUT: Values: 623.1 01:37:30 INFO - 2015-11-25 01:37:30,928 DEBUG : BROWSER_OUTPUT: 01:37:30 INFO - 2015-11-25 01:37:30,928 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 01:37:30 INFO - 2015-11-25 01:37:30,928 DEBUG : BROWSER_OUTPUT: Values: 4850.2 01:37:30 INFO - 2015-11-25 01:37:30,928 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:37:30 INFO - 2015-11-25 01:37:30,928 DEBUG : BROWSER_OUTPUT: 01:37:31 INFO - 2015-11-25 01:37:31,704 INFO : Browser exited with error code: 0 01:37:31 INFO - 2015-11-25 01:37:31,718 INFO : Completed test v8_7 (00:00:38) 01:37:31 INFO - 2015-11-25 01:37:31,946 INFO : Completed test suite (00:20:13) 01:37:31 INFO - 2015-11-25 01:37:31,947 DEBUG : Working with test: dromaeo_css 01:37:31 INFO - 2015-11-25 01:37:31,947 DEBUG : Generating results file: dromaeo_css 01:37:31 INFO - 2015-11-25 01:37:31,948 DEBUG : Working with test: kraken 01:37:31 INFO - 2015-11-25 01:37:31,948 DEBUG : Generating results file: kraken 01:37:31 INFO - 2015-11-25 01:37:31,948 INFO : javascript benchmark 01:37:31 INFO - 2015-11-25 01:37:31,948 DEBUG : Working with test: v8_7 01:37:31 INFO - 2015-11-25 01:37:31,948 DEBUG : Generating results file: v8_7 01:37:31 INFO - 2015-11-25 01:37:31,949 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:37:31 INFO - 2015-11-25 01:37:31,998 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 01:37:31 INFO - 2015-11-25 01:37:31,998 DEBUG : process_Request line: dromaeo_css 6981.64 graph.html#tests=[[72,201,35]] 01:37:31 INFO - 2015-11-25 01:37:31,998 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:37:32 INFO - 2015-11-25 01:37:32,028 DEBUG : process_Request line: kraken 1493.10 graph.html#tests=[[232,201,35]] 01:37:32 INFO - 2015-11-25 01:37:32,028 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:37:32 INFO - 2015-11-25 01:37:32,056 DEBUG : process_Request line: v8_7 20913.15 graph.html#tests=[[230,201,35]] 01:37:32 INFO - 2015-11-25 01:37:32,061 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3189.8245596492193, 3238.1257060593657, 3272.476403775396, 3281.081297236773, 3294.5222942673313, 5320.388155362135, 5435.718302009777, 5445.156000819869, 5446.455354464551, 5459.099248623982, 5367.2485851980755, 5424.267723857278, 5426.403095659484, 5426.701531415771, 5521.282233309674, 4999.22512010638, 5020.949790502084, 5021.949780502203, 5044.344235249412, 5063.417706963691, 4834.299026641135, 4974.726390048546, 4995.950040499603, 5034.043531728959, 5073.873153171164, 4750.477447480757, 4852.0, 4893.951060489385, 4898.436679781835, 4919.803207871681, 4970.726610036447, 4971.627127965381, 4981.775820088069, 4985.102681517325, 5028.396592408898, 4799.712017278975, 4945.060438516671, 4960.379952505937, 4970.577500912426, 5031.396232452129, 5183.326167598226, 5228.241904923765, 5277.340332458442, 5286.524212820865, 5317.627766056377, 5922.378150294243, 5922.58541902067, 5935.376785437553, 5941.584089113764, 5941.910871336933, 5699.401562835926, 5898.8230353089475, 5953.851153721148, 5956.37458066901, 5966.2840459144745, 5432.972835135839, 5485.917711234335, 5516.14499752535, 5532.612717109844, 5547.362053363834, 5973.701314934236, 6001.579889407787, 6002.6698531580305, 6009.879802403927, 6014.308354539196, 5757.683327417032, 5773.653580785166, 5780.913286300624, 5836.9124463133085, 5871.55963302754, 5729.25519682447, 5908.320543137508, 5911.261092363455, 5975.880482390327, 6034.818955431344, 5757.740901659436, 5782.797602083907, 5788.710564471759, 5798.362180160179, 5807.332156801937, 5797.623154494944, 5804.303483581997, 5806.042003069446, 5812.970935145382, 5816.447437493432, 4390.758508282075, 4514.706544074625, 4523.32150177476, 4531.592156705912, 4557.498675145731, 4049.0484736087583, 4055.0673345130785, 4065.1869626074904, 4087.529934057562, 4087.8569250076102, 5676.4323567642905, 5682.715864206773, 5691.544676425876, 5692.658440493584, 5718.914216286759, 5804.4195580442465, 5920.141579470953, 5925.881482370329, 5927.2590926134235, 5940.584159108821, 5575.386707462176, 5605.1031834907035, 5614.242077319591, 5617.606767526316, 5674.9785038693435, 5172.405173405106, 5180.715060671624, 5192.844214673566, 5196.272521846869, 5247.973760131251, 5738.110592858114, 5996.760129594767, 5997.310309314397, 6001.579889407787, 6154.599951003171, 5698.572607054404, 5810.854728631818, 5837.532997360286, 5841.240638716939, 5856.096235081643, 6124.724387402666, 6126.540509461719, 6139.2325959255095, 6141.170941922962, 6151.6001459904965, 5780.768769249183, 5811.331696854747, 5839.065749480063, 5843.883122337615, 5854.4730974212525, 5706.115552089433, 5746.913796293143, 5775.364709881826, 5794.420557944172, 5951.256092988377, 5655.971720141373, 5717.77067930397, 5718.228039214653, 5737.454941780524, 5854.209681692917, 5644.576656750678, 5684.7157642118555, 5684.9431505684415, 5700.629459085312, 5704.914426283526, 5541.058020136506, 5656.151577263443, 5668.37647858727, 5671.064274394844, 5787.102999035156, 5791.884162316815, 5796.1305804129715, 5811.56413268998, 5824.650520968586, 5855.531557475477, 5692.6299790513485, 5700.401457846866, 5700.629459085146, 5721.742521586455, 5724.0], "unit": "ms", "name": "dojo.html", "value": 5413.245517843827}, {"lowerIsBetter": false, "replicates": [557.5456003357266, 593.3532449629903, 605.3976293587881, 611.2481647573483, 619.0899377914465, 39360.212795744104, 40034.59965400342, 40052.0, 40052.39921401181, 40126.19747605046, 42802.57197428025, 43595.0, 43657.0, 43663.0, 43706.0, 7675.846483070335, 7793.454458187929, 8795.252403545706, 8982.685606003792, 10153.543090560943, 10354.06813386795, 10461.84307235392, 10485.37087774736, 10488.79022419551, 10495.527701253463, 10525.21060920434, 10571.841422378671, 10593.788124237512, 10617.0, 10663.84004239937, 7871.8425631487335, 8064.354851611886, 10643.254972151952, 10823.080038196762, 10841.783164336748, 10325.070743633034, 10366.0, 10442.79114417715, 10472.476376181161, 10480.790384192349, 39397.80301098476, 39740.40389394161, 39754.60245397538, 39780.0, 39810.40284395737, 3160.0519844046694, 3196.6643502432144, 3220.130564747505, 3238.6599407062154, 3946.782926939017, 29816.40367192666, 29993.550096748568, 30412.54381184284, 30637.080887573185, 31214.37571248585, 3663.725220608465, 3687.2994131115, 3697.131174174067, 3701.8952906710215, 3755.1926335837925, 275180.0, 277900.0, 280585.0, 281025.0, 282151.0, 57583.71208143933, 60679.69660151671, 60907.39092609017, 61034.0, 61053.69473152695, 53296.46703532915, 70317.0, 71168.2883171172, 71767.64116179386, 71789.64105179545, 14901.92549037248, 15113.244337783068, 15123.621909452131, 15165.165915874511, 15231.466898658493, 12024.218425802295, 12101.213421127599, 12152.392380380945, 12152.878471215352, 12156.574519891761, 19813.20747170126, 20120.89939550322, 20182.697259541117, 20204.292849750484, 20221.0, 7783.80540486481, 7943.508399487658, 8043.356531477468, 8043.431530851428, 8106.310963568045, 880.5685214245102, 947.8530827721714, 983.5033308179324, 1031.8297480915714, 1034.2036631793476, 28230.71769282322, 28344.00795972131, 28845.0, 28850.567241491393, 29015.85492072526, 989.8218320702199, 1018.5925629748012, 1024.99487502562, 1048.7378155461136, 1145.541783286692, 13979.0, 14056.929715351358, 14109.576712698636, 14237.216953067473, 14287.857121428653, 246039.0, 249377.0, 249432.0, 249965.0, 249986.2515810705, 51301.23048154281, 52024.0, 52147.73926130421, 52151.47848521542, 52173.478265216865, 1341.1684755451488, 1342.7650161221748, 1365.9726805463836, 1371.2252577293996, 1377.1048818268005, 25801.741982579933, 26892.731072689807, 27619.585706214824, 31151.84424077865, 31392.34992153824, 48031.0, 48526.272105919146, 48585.0, 48594.27108593303, 48627.75686121688, 260175.0, 260512.0, 260570.0, 260829.0, 262969.0, 27658.44683106367, 28064.158075257776, 31329.373412531168, 32347.35305293928, 32354.35291294208, 37536.2492750138, 41546.0, 41609.167816644105, 42571.3614295792, 42578.57421425746, 34987.0, 35736.821315893256, 35763.82118089393, 35801.28397432089, 36215.27569448543, 35967.0, 36345.091372714836, 36347.27305453929, 36370.636293637785, 36441.45337819882, 35272.82363588166, 35481.29037419289, 35886.28227435489, 36550.45174322334, 36568.45147322739, 29549.55675664824, 32441.0, 33676.49485257772, 33694.8315258432, 33778.8311058453, 24191.274261772174, 25605.487890242464, 26446.603300950115, 26534.60198097069, 26850.59724104179], "unit": "ms", "name": "ext.html", "value": 18734.270843833845}, {"lowerIsBetter": false, "replicates": [350.25745419710216, 352.8094828792452, 354.0599707775854, 355.47922293839525, 355.63192096180444, 13932.721345573082, 14090.185148317732, 17148.742768858476, 17437.825621743777, 18122.99999999998, 10859.565617375316, 11105.167112466577, 16174.83825161748, 17461.825381746177, 17484.47546573605, 4883.145449546324, 4987.501249875019, 4997.125503036972, 4999.9500004999845, 5006.699598024112, 3774.0, 3872.1094148345896, 4955.826546070888, 5001.949980500185, 5381.81163659272, 5454.0, 5480.616356855022, 5484.7531861066345, 5501.972490137544, 5527.53015993641, 5324.307839980797, 5392.137258038734, 5443.673379597237, 5462.3445186577665, 5472.1244600864065, 5257.500537448975, 5272.551833094191, 5277.9472205278225, 5278.392984806719, 5284.894302113975, 12973.0, 20424.591508169753, 20797.37607871766, 20856.58286834255, 20863.478413039644, 2089.39407571804, 2111.767705552388, 2117.9576408471744, 2118.4386137673373, 2168.6530155175255, 9465.763355916088, 9495.90504094964, 9561.330706850524, 9716.951415242878, 9720.07659272375, 1810.2035104554086, 1844.2715127524687, 1850.481865077767, 1860.0636885806991, 1869.8223668751582, 59701.40298597002, 62294.68852655753, 62608.68695656538, 62621.99999999954, 62812.68593657048, 10231.232657550565, 10304.742381440374, 10321.329113607742, 10353.948230258951, 10381.273310868317, 13462.394192261372, 13484.730305393838, 13487.123336983064, 13487.393067311994, 13489.527866524624, 7569.1295501018085, 7577.0, 7602.42981776369, 7652.273034061755, 7668.0, 7205.279472052753, 7239.674214660353, 7252.057232559839, 7315.707371705073, 7428.702851885864, 4400.779961001937, 4498.932516012263, 4501.819927202941, 4538.092381523708, 4548.545145485491, 1714.5199344183648, 1783.4203883737837, 1787.8122797106116, 1804.305342443169, 1844.5665268661853, 837.9371547133867, 907.0294784580435, 940.6989763275823, 950.273041123541, 950.8668786369914, 16222.51332460028, 16584.253708583143, 16622.25199866009, 16943.83056169447, 17057.0, 844.8943882014748, 874.4753148111082, 889.5196593839254, 928.3223247029706, 943.3915124744639, 8915.331350148765, 9265.305102117369, 9321.394109383004, 9324.067593240621, 9494.098060684224, 481752.0, 489264.0, 499171.0, 500846.0, 513850.0, 75774.48451030948, 76343.0, 76422.61788691022, 77368.0, 77494.61252693813, 1109.9056580190775, 1116.0513563470984, 1125.926814757038, 1127.616610352484, 1127.8364637127734, 14297.928510357382, 14430.639234019234, 14523.636909076935, 14577.708445831237, 14703.92648036753, 31809.840950795096, 32791.18022049468, 34239.41009257298, 35491.645083548836, 35584.0, 42993.355099674154, 43075.0, 43949.0, 44460.77769611261, 47374.763126184145, 9409.952950235478, 9560.904390956279, 9655.517224138624, 9655.758606034906, 9788.510574471391, 11509.366984815915, 11510.36692981894, 11585.82621260665, 11707.063434925016, 11715.238509496856, 13588.93205533966, 14051.156930584199, 14066.929665351608, 14364.35360408805, 14482.203478808766, 13490.460381584626, 13759.10565813219, 14011.929940350234, 14152.929235353757, 14177.22025288619, 11227.7754444909, 13376.933115334361, 13977.231252281223, 14471.638209044859, 14928.477503287333, 9286.0, 9471.952640236756, 9553.61785528571, 9556.85664715016, 9666.0, 12766.808497872726, 14411.92794036023, 14439.422423102958, 14716.77924831107, 15098.773518397453], "unit": "ms", "name": "jquery.html", "value": 8579.148902545438}, {"lowerIsBetter": false, "replicates": [1343.2746316988814, 1724.2671864457611, 1741.4862615528418, 1768.5224989252902, 1793.4888556761325, 6896.103506544148, 7536.510126841751, 7766.495177813452, 7770.0287464067, 7777.572233527154, 7563.281488258606, 7722.111957124918, 7736.149023607399, 7737.845243095135, 7749.186335434782, 1934.5647229373349, 1969.1926310212743, 2207.6467765157577, 2252.526969336437, 2291.8510296830655, 2285.4514916420108, 2291.6104262275453, 2295.644175152854, 2298.069281940808, 2306.538692261546, 2212.258893270748, 2278.1229226747655, 2278.9544209115807, 2280.4184932842104, 2280.851744636602, 1922.9615407691838, 1960.2942940541393, 2221.167062351626, 2258.7402448718444, 2263.162629826958, 2272.4773302140434, 2280.486890449652, 2312.884355782221, 2316.305108467453, 2349.3774149850306, 7670.731524396675, 7744.922550774477, 7758.922410775933, 7763.573003484806, 7774.222577742237, 4630.490646028934, 4703.176944034814, 4724.858254252344, 4733.384659994179, 4736.8578942631775, 3144.795588286754, 3158.478850989584, 3158.7473002159772, 3205.7114859662743, 3220.91947701307, 966.7196513011219, 981.9656312029116, 983.9360441571275, 994.9502524873727, 1024.472396715692, 10563.207759417997, 10615.0446459819, 10618.203634727426, 10618.628348007782, 10627.893721062768, 4148.937765933453, 4280.6789490788315, 4314.201872653569, 4322.394864718942, 4334.0, 8832.337574681796, 9000.144986226298, 9007.459552426744, 9022.774430639156, 9043.59303831329, 4762.071396077731, 4786.2581299898575, 4796.448408433005, 4813.181759100961, 4814.277858321209, 4316.978415107905, 4365.454318210223, 4373.562643735601, 4377.0, 4382.780860956939, 3647.1429214135187, 3665.5051568038507, 3677.669009789132, 3690.0590349460717, 3720.720945929066, 1223.6696092055095, 1227.533537255855, 1230.034422977958, 1232.3961258983034, 1236.7093732972744, 1001.1340190734962, 1276.5276847566274, 1278.820965064873, 1306.2358520265561, 1317.3479127831592, 6480.189976252968, 7328.487005909642, 7559.886601700979, 7564.281393267631, 7571.697132114764, 580.6574121268471, 587.4926687674576, 590.4036922708095, 611.272585623107, 612.4763327355137, 5672.659640421505, 5761.8559536011935, 5778.5377169826315, 5796.275465566804, 5859.44335288147, 9004.36969412135, 9291.07089291079, 9299.0, 9308.441493510276, 9309.30180236485, 9113.81772364549, 9213.262938964866, 9280.95359523198, 9292.117248861347, 9325.253979681609, 7158.92841071593, 7216.458765592602, 7223.169335526377, 7247.311505406978, 7291.744788932362, 6930.0, 6981.0, 6996.720131194898, 7006.75476358325, 7011.754588589375, 8013.599320033858, 8104.432689711899, 8131.918680813353, 8264.090949995616, 8282.213189746964, 8195.34437245007, 8316.501009939422, 8337.749867503984, 8429.241368276884, 8436.873446898424, 6837.042814006142, 6868.141482314711, 6879.346462086094, 6881.10545629065, 6886.552374095668, 7463.104427468521, 7508.474406791473, 7513.39892808585, 7513.962430187814, 7514.661840217313, 6676.198856137295, 6864.48516361265, 7059.329363710439, 7121.750738724119, 7198.71205151788, 6819.5908245505425, 6856.897146542906, 6871.656417179021, 6951.8609627806145, 7042.929570704227, 6122.142899994094, 6414.390632889868, 6928.826779330356, 7036.648167591702, 7047.330503602149, 6437.324080971431, 6531.640759758259, 6561.835954101186, 6588.934110658832, 6591.373819487141, 6446.580972236977, 6529.8694026120165, 6617.43751781104, 6619.702113404812, 6621.271660117287], "unit": "ms", "name": "mootools.html", "value": 4406.3326358008035}, {"lowerIsBetter": false, "replicates": [337.7146311366895, 338.2018436489885, 343.95012723155145, 347.7426704238864, 350.31688207994415, 5947.256592925884, 5975.910361344578, 6003.609765365248, 6007.158997740315, 6008.309044459888, 5868.853278668035, 5909.379515150901, 5922.58541902067, 5923.466887980081, 5935.821925342236, 4597.816087356502, 4599.218132917412, 4602.424696912886, 4608.262677971534, 4631.722096674211, 4542.136993971151, 4597.356370108188, 4625.190591646448, 4633.2586786114225, 4633.582977532022, 4532.048269863332, 4550.271956486963, 4580.633549316047, 4585.701929374597, 4591.701539399945, 4334.783260836977, 4416.911661766747, 4570.360149579045, 4575.519570445105, 4576.725396476206, 3954.110325176841, 3979.5423526294558, 4007.83968641254, 4010.4184893190322, 4028.738132021409, 5550.8057217997175, 5592.552595792326, 5601.691906945157, 5607.130894711286, 5611.607187496877, 5050.39395272566, 5172.6379153459275, 5209.29674493946, 5310.575153987672, 5340.706261155635, 6266.122742816009, 6274.749010039593, 6289.654069026202, 6293.213348331458, 6306.054091886208, 4437.179121862434, 4440.844570440019, 4443.4445694288215, 4446.488653804821, 4450.4881938577155, 6434.967825160844, 6578.671066446706, 6587.0, 6598.769043083517, 6624.470042396597, 4468.3074123510905, 4492.483364413134, 4503.7522936238165, 4504.909901801946, 4506.211413002711, 4525.140223357552, 4546.636269098464, 4552.863414097516, 4557.749323787223, 4560.749158796298, 5286.81496147633, 5287.471252874759, 5289.761960711778, 5296.0, 5302.39022512416, 6149.692515374213, 6329.0, 6357.96821015892, 6361.968190159112, 6362.0, 1594.6093207164088, 1599.8000249968754, 1606.5019843848445, 1606.694728001676, 1607.172306262276, 1061.9415932123807, 1070.053003092269, 1072.463768115942, 1088.1349327284827, 1091.5688303120223, 6176.938230617726, 6179.876402472015, 6181.320054793969, 6181.907271390933, 6187.597806142587, 6467.450266727286, 6508.9023664645065, 6512.6092434454085, 6512.837179070466, 6515.087887695727, 6044.0, 6116.510679145657, 6163.537734669828, 6164.969175154185, 6179.876402471926, 3509.5262139610827, 3518.665726755954, 3544.0608238816735, 3546.131197856542, 3549.893503194908, 6755.020522024377, 6758.189017317855, 6772.2211945625895, 6776.356246156706, 6778.22050464193, 6461.353864613595, 6596.0, 6662.633555154416, 6680.331966803378, 6685.39831415175, 6599.307072757388, 6779.593224406552, 6791.796246112624, 6812.965935170391, 6826.180858296937, 6488.805335839932, 6535.150430444012, 6545.181852268466, 6551.541392102507, 6551.574147680385, 6344.746210151542, 6482.319356467503, 6485.481161506974, 6500.967495162683, 6503.934960650522, 6804.55770374924, 6806.65966701653, 6812.965935170292, 6813.523053386215, 6814.2163651180745, 4467.463904331501, 4476.485204201558, 4478.440194975628, 4480.462344518679, 4482.977585112054, 6395.488360931207, 6544.901826472512, 6556.934430655632, 6560.147180866456, 6560.507961902781, 6363.268224154282, 6375.298717141018, 6383.36166383358, 6388.776392826228, 6388.968055159695, 6357.745690172342, 6361.395667411589, 6364.140840986408, 6372.299047104722, 6374.808755737336, 6091.543134264859, 6248.750049998131, 6255.31191568918, 6256.343083976299, 6281.277653069956, 6429.453496452854, 6429.6142231466265, 6431.035344698145, 6439.903401448888, 6441.613503189824, 6275.246970363585, 6284.748610055546, 6286.497080233662, 6288.496920246461, 6289.591176573508], "unit": "ms", "name": "prototype.html", "value": 4787.115122225061}, {"lowerIsBetter": false, "replicates": [744.6686224630039, 850.2008112374372, 851.8551846186148, 864.4553931023456, 884.2086332732201, 13562.457501699933, 13914.0, 13927.582172534814, 13956.0, 13964.162150270991, 13204.471821127167, 13224.53714120006, 13293.202407855511, 13295.534656287033, 14531.200783956878, 825.7729124490768, 847.7160151349275, 852.9744107676748, 853.2235665544356, 854.0221446443818, 853.0232883348563, 858.2233079063426, 859.4757198109148, 859.4757198109148, 860.2472836268265, 887.7248053103526, 894.0344428017726, 894.4275663575316, 894.4633220067972, 894.6645008121955, 886.4415418286503, 887.662688178488, 887.8135591525755, 890.973270801877, 893.3523195683143, 649.3376755709197, 652.0642877470844, 655.1483072006421, 655.639398330916, 657.6678777217475, 14251.714965700628, 14305.0, 14331.78502322466, 14376.568702938928, 14400.06399584034, 12517.12380133391, 12795.296258705768, 12887.16233444823, 12947.87052129476, 13093.41079651418, 9607.087326703951, 9658.0, 9961.203103751683, 10059.39643621385, 10139.898601014043, 3626.6192049834917, 3645.7994810285422, 3668.137987572918, 3733.104055026774, 3751.3997760358484, 41849.79075104605, 42269.94325141896, 45302.32046519305, 45990.080198395844, 49455.50544494545, 10381.532831022621, 10402.531886065146, 10584.523696433525, 10641.574337026432, 10693.358398496115, 18622.627547448974, 18669.533261668566, 18677.346292879683, 18677.533061673566, 18703.0, 7441.181470038291, 7821.569813660303, 7937.603119843985, 7960.880586791202, 8262.586870656443, 4251.277282861921, 4262.083652014831, 4282.48610166782, 4322.0, 4354.651627869763, 3135.0908236611585, 3142.0573827851554, 3153.8265395403473, 3160.352127813793, 3160.383725173615, 580.494969376645, 587.49475451112, 587.8412828536271, 598.141666708275, 600.639616230267, 537.7338217582321, 607.9361667024899, 615.3538784276492, 620.2587907450643, 632.8987362022054, 7599.848003039909, 7625.618719064025, 7754.457187996786, 7982.960085199653, 8116.107228204893, 488.62131847817517, 539.099703495164, 572.8711040015963, 582.8134996801068, 631.2866460899246, 3745.269672413853, 3762.4168253920684, 3902.590228026073, 3944.2111577684577, 3983.0, 59022.704886475294, 59716.0, 59738.70130649406, 59765.402345975985, 59916.70041649851, 52762.47237527652, 52875.20687189695, 52953.763698904, 53743.46256537385, 53940.0, 41306.0, 41475.1704965905, 42743.57256427458, 47981.76009120002, 48101.0, 8042.638081286474, 8150.633221504928, 8304.58477076156, 8616.569171541523, 8733.563321833755, 34443.0, 34519.30961380708, 35135.47296790499, 37104.25791484209, 37196.07009824776, 41822.37266440945, 42074.1585168301, 44568.33147502855, 45302.54697452983, 48497.0, 10666.253362264568, 10694.62568810088, 11299.887001129884, 11477.942610286895, 11606.709832253924, 11185.72035699114, 11305.095592352427, 11363.602273920373, 11486.081113511067, 11891.345975971059, 10356.896431035895, 10590.735231618963, 10859.131269498263, 10864.293820901616, 11178.944105279747, 10587.735306617396, 10767.461626918466, 11108.389038602954, 11290.830637540608, 11608.883911161118, 10709.518071686949, 10827.40449275266, 10934.070603998749, 10973.0, 11301.886981130083, 9278.396904201205, 9432.622695092394, 9556.0, 9689.224862011164, 9815.067568580973, 8965.686200982935, 9055.592498337723, 9209.21721653667, 9450.952745236506, 9514.476703781358], "unit": "ms", "name": "yui.html", "value": 6309.789785325139}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 108.0, 103.0, 109.0, 113.0, 109.0, 101.0, 109.0, 109.0, 101.0], "unit": "ms", "name": "ai-astar", "value": 107.0}, {"lowerIsBetter": true, "replicates": [149.0, 124.0, 147.0, 161.0, 127.0, 156.0, 146.0, 124.0, 163.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.4}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 161.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 80.0, 98.0, 71.0, 72.0, 70.0, 104.0, 98.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 148.0, 92.0, 95.0, 93.0, 137.0, 93.0, 95.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 57.0, 57.0, 57.0, 58.0, 57.0, 59.0, 62.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 71.0, 71.0, 72.0, 70.0, 70.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [118.0, 128.0, 114.0, 115.0, 121.0, 115.0, 122.0, 123.0, 116.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [140.0, 148.0, 149.0, 153.0, 148.0, 140.0, 150.0, 148.0, 146.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.1}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 67.0, 66.0, 68.0, 66.0, 66.0, 67.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.7175094712568], "unit": "score", "name": "Richards", "value": 214.31844199999998}, {"lowerIsBetter": false, "replicates": [194.21246844047388], "unit": "score", "name": "DeltaBlue", "value": 340.441582}, {"lowerIsBetter": false, "replicates": [283.36639274582035], "unit": "score", "name": "Encrypt", "value": 939.3527489999996}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1116.0714285714287], "unit": "score", "name": "RayTrace", "value": 663.0301440000001}, {"lowerIsBetter": false, "replicates": [785.5459544383347], "unit": "score", "name": "Earley", "value": 848.4073989999999}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [25794.871794871793], "unit": "score", "name": "RegExp", "value": 35.31651590457257}, {"lowerIsBetter": false, "replicates": [623.0529595015577], "unit": "score", "name": "Splay", "value": 130.793055}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7"}]} 01:37:32 INFO - RETURN: dromaeo_css: 6981.64 01:37:32 INFO - RETURN: kraken: 1493.10 01:37:32 INFO - RETURN: v8_7: 20913.15 01:37:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20913.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1493.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6981.64"}}} 01:37:32 INFO - Return code: 0 01:37:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:37:32 INFO - # TBPL SUCCESS # 01:37:32 INFO - Running post-action listener: _resource_record_post_action 01:37:32 INFO - Running post-run listener: _resource_record_post_run 01:37:33 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 10436608; Write bytes: 473403392; Read time: 2640; Write time: 400664 01:37:33 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 45056; Write bytes: 77754368; Read time: 12; Write time: 100544 01:37:33 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8654848; Write bytes: 395649024; Read time: 2592; Write time: 300120 01:37:33 INFO - Running post-run listener: _upload_blobber_files 01:37:33 INFO - Blob upload gear active. 01:37:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:37:33 INFO - Copying logs to upload dir... 01:37:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.932766 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-11-25 01:37:33.282409) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 01:37:33.285674) ========= 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=d3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009834 build_url: 'https://queue.taskcluster.net/v1/task/AUGOmeJ2Q2mi1xGI-0jUzw/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 01:37:33.339299) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:37:33.339680) ========= 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=d3f2be9b0713ec03b22325b2000001be-1448441398.748280-785150257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:37:33.391301) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 01:37:33.391661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 01:37:33.392009) ========= ========= Total master_lag: 0.22 =========